builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-051 starttime: 1461678433.29 results: success (0) buildid: 20160426044601 builduid: 492b86c5e1054d86bce01a3b6d55f5ad revision: 9ce31e9f90cb0e534611b0f617c5bbc232ffe748 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 06:47:13.293292) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 06:47:13.293954) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 2 secs) (at 2016-04-26 06:47:13.294413) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 2 secs) (at 2016-04-26 06:47:15.508532) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 06:47:15.509010) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1461678429.306690-184393022 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-26 06:47:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.7M=0s 2016-04-26 06:47:15 (46.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.146139 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 06:47:15.668426) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 06:47:15.668740) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1461678429.306690-184393022 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018078 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 06:47:15.717952) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-26 06:47:15.718322) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9ce31e9f90cb0e534611b0f617c5bbc232ffe748 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 9ce31e9f90cb0e534611b0f617c5bbc232ffe748 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1461678429.306690-184393022 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-26 06:47:15,917 truncating revision to first 12 chars 2016-04-26 06:47:15,917 Setting DEBUG logging. 2016-04-26 06:47:15,917 attempt 1/10 2016-04-26 06:47:15,917 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9ce31e9f90cb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-26 06:47:16,834 unpacking tar archive at: mozilla-central-9ce31e9f90cb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.203513 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-26 06:47:16.934544) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 06:47:16.934862) ========= script_repo_revision: 9ce31e9f90cb0e534611b0f617c5bbc232ffe748 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 06:47:16.935294) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 06:47:16.935556) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 06:47:16.943499) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 30 secs) (at 2016-04-26 06:47:16.943870) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1461678429.306690-184393022 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:47:17 INFO - MultiFileLogger online at 20160426 06:47:17 in /builds/slave/test 06:47:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 06:47:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:47:17 INFO - {'append_to_log': False, 06:47:17 INFO - 'base_work_dir': '/builds/slave/test', 06:47:17 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 06:47:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:47:17 INFO - 'branch': 'Firefox-Non-PGO', 06:47:17 INFO - 'buildbot_json_path': 'buildprops.json', 06:47:17 INFO - 'config_files': ('talos/linux_config.py',), 06:47:17 INFO - 'default_actions': ('clobber', 06:47:17 INFO - 'read-buildbot-config', 06:47:17 INFO - 'download-and-extract', 06:47:17 INFO - 'populate-webroot', 06:47:17 INFO - 'create-virtualenv', 06:47:17 INFO - 'install', 06:47:17 INFO - 'run-tests'), 06:47:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:47:17 INFO - 'download_minidump_stackwalk': True, 06:47:17 INFO - 'download_symbols': 'ondemand', 06:47:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:47:17 INFO - 'tooltool.py': '/tools/tooltool.py', 06:47:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:47:17 INFO - '/tools/misc-python/virtualenv.py')}, 06:47:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:47:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:47:17 INFO - 'installer_path': 'installer.exe', 06:47:17 INFO - 'log_level': 'info', 06:47:17 INFO - 'log_name': 'talos', 06:47:17 INFO - 'log_to_console': True, 06:47:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:47:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:47:17 INFO - 'opt_config_files': (), 06:47:17 INFO - 'pip_index': False, 06:47:17 INFO - 'sps_profile': False, 06:47:17 INFO - 'sps_profile_interval': 0, 06:47:17 INFO - 'suite': 'dromaeojs', 06:47:17 INFO - 'system_bits': '32', 06:47:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:47:17 INFO - 'title': 'talos-linux64-ix-051', 06:47:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:47:17 INFO - 'use_talos_json': True, 06:47:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:47:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:47:17 INFO - 'work_dir': 'build'} 06:47:17 INFO - ##### 06:47:17 INFO - ##### Running clobber step. 06:47:17 INFO - ##### 06:47:17 INFO - Running pre-action listener: _resource_record_pre_action 06:47:17 INFO - Running main action method: clobber 06:47:17 INFO - rmtree: /builds/slave/test/build 06:47:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:47:17 INFO - Running post-action listener: _resource_record_post_action 06:47:17 INFO - ##### 06:47:17 INFO - ##### Running read-buildbot-config step. 06:47:17 INFO - ##### 06:47:17 INFO - Running pre-action listener: _resource_record_pre_action 06:47:17 INFO - Running main action method: read_buildbot_config 06:47:17 INFO - Using buildbot properties: 06:47:17 INFO - { 06:47:17 INFO - "project": "", 06:47:17 INFO - "product": "firefox", 06:47:17 INFO - "script_repo_revision": "production", 06:47:17 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 06:47:17 INFO - "repository": "", 06:47:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 06:47:17 INFO - "buildid": "20160426044601", 06:47:17 INFO - "pgo_build": "False", 06:47:17 INFO - "basedir": "/builds/slave/test", 06:47:17 INFO - "buildnumber": 486, 06:47:17 INFO - "slavename": "talos-linux64-ix-051", 06:47:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:47:17 INFO - "platform": "ubuntu64_hw", 06:47:17 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 06:47:17 INFO - "branch": "mozilla-central", 06:47:17 INFO - "repo_path": "mozilla-central", 06:47:17 INFO - "revision": "9ce31e9f90cb0e534611b0f617c5bbc232ffe748", 06:47:17 INFO - "stage_platform": "linux64", 06:47:17 INFO - "builduid": "492b86c5e1054d86bce01a3b6d55f5ad", 06:47:17 INFO - "slavebuilddir": "test" 06:47:17 INFO - } 06:47:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/Dh-grJbYROamKTgWrzvbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 06:47:17 INFO - Running post-action listener: _resource_record_post_action 06:47:17 INFO - ##### 06:47:17 INFO - ##### Running download-and-extract step. 06:47:17 INFO - ##### 06:47:17 INFO - Running pre-action listener: _resource_record_pre_action 06:47:17 INFO - Running main action method: download_and_extract 06:47:17 INFO - mkdir: /builds/slave/test/build/tests 06:47:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:47:17 INFO - https://queue.taskcluster.net/v1/task/Dh-grJbYROamKTgWrzvbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:47:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dh-grJbYROamKTgWrzvbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:47:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dh-grJbYROamKTgWrzvbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:47:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dh-grJbYROamKTgWrzvbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:47:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dh-grJbYROamKTgWrzvbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:47:18 INFO - Downloaded 1361 bytes. 06:47:18 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:47:18 INFO - Using the following test package requirements: 06:47:18 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 06:47:18 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:47:18 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:47:18 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:47:18 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:47:18 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:47:18 INFO - u'jsshell-linux-x86_64.zip'], 06:47:18 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:47:18 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:47:18 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 06:47:18 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:47:18 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:47:18 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:47:18 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:47:18 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:47:18 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:47:18 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:47:18 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:47:18 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:47:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:47:18 INFO - https://queue.taskcluster.net/v1/task/Dh-grJbYROamKTgWrzvbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:47:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dh-grJbYROamKTgWrzvbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:47:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dh-grJbYROamKTgWrzvbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:47:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dh-grJbYROamKTgWrzvbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:47:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dh-grJbYROamKTgWrzvbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:47:19 INFO - Downloaded 22290757 bytes. 06:47:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:47:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:47:20 INFO - Return code: 0 06:47:20 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:47:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:47:20 INFO - https://queue.taskcluster.net/v1/task/Dh-grJbYROamKTgWrzvbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:47:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dh-grJbYROamKTgWrzvbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:47:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dh-grJbYROamKTgWrzvbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:47:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dh-grJbYROamKTgWrzvbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:47:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dh-grJbYROamKTgWrzvbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:47:22 INFO - Downloaded 22290757 bytes. 06:47:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:47:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:47:23 INFO - Return code: 0 06:47:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:47:23 INFO - https://queue.taskcluster.net/v1/task/Dh-grJbYROamKTgWrzvbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:47:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dh-grJbYROamKTgWrzvbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 06:47:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dh-grJbYROamKTgWrzvbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 06:47:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dh-grJbYROamKTgWrzvbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 06:47:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dh-grJbYROamKTgWrzvbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:47:24 INFO - Downloaded 10840145 bytes. 06:47:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:47:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 06:47:24 INFO - Return code: 0 06:47:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:47:24 INFO - https://queue.taskcluster.net/v1/task/Dh-grJbYROamKTgWrzvbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:47:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dh-grJbYROamKTgWrzvbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:47:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dh-grJbYROamKTgWrzvbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:47:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dh-grJbYROamKTgWrzvbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:47:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Dh-grJbYROamKTgWrzvbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:47:26 INFO - Downloaded 54812804 bytes. 06:47:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Dh-grJbYROamKTgWrzvbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:47:26 INFO - mkdir: /builds/slave/test/properties 06:47:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:47:26 INFO - Writing to file /builds/slave/test/properties/build_url 06:47:26 INFO - Contents: 06:47:26 INFO - build_url:https://queue.taskcluster.net/v1/task/Dh-grJbYROamKTgWrzvbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:47:26 INFO - Running post-action listener: _resource_record_post_action 06:47:26 INFO - Running post-action listener: set_extra_try_arguments 06:47:26 INFO - ##### 06:47:26 INFO - ##### Running populate-webroot step. 06:47:26 INFO - ##### 06:47:26 INFO - Running pre-action listener: _resource_record_pre_action 06:47:26 INFO - Running main action method: populate_webroot 06:47:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:47:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:47:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:47:26 INFO - '--tppagecycles', 06:47:26 INFO - '7'], 06:47:26 INFO - 'tests': ['tsvgm']}}, 06:47:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:47:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:47:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:47:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:47:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:47:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:47:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:26 INFO - 'talos_options': ['--disable-e10s'], 06:47:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:47:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:47:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:26 INFO - 'talos_options': ['--disable-e10s'], 06:47:26 INFO - 'tests': ['damp', 'tps']}, 06:47:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:26 INFO - 'tests': ['damp', 'tps']}, 06:47:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:47:26 INFO - 'tests': ['dromaeo_dom']}, 06:47:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:47:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:47:26 INFO - 'tests': ['a11yr', 06:47:26 INFO - 'ts_paint', 06:47:26 INFO - 'tpaint', 06:47:26 INFO - 'sessionrestore', 06:47:26 INFO - 'sessionrestore_no_auto_restore', 06:47:26 INFO - 'tabpaint']}, 06:47:26 INFO - 'other-e10s': {'tests': ['a11yr', 06:47:26 INFO - 'ts_paint', 06:47:26 INFO - 'tpaint', 06:47:26 INFO - 'sessionrestore', 06:47:26 INFO - 'sessionrestore_no_auto_restore', 06:47:26 INFO - 'tabpaint']}, 06:47:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:47:26 INFO - 'ts_paint', 06:47:26 INFO - 'tpaint', 06:47:26 INFO - 'sessionrestore', 06:47:26 INFO - 'sessionrestore_no_auto_restore', 06:47:26 INFO - 'tabpaint']}, 06:47:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:47:26 INFO - 'ts_paint', 06:47:26 INFO - 'tpaint', 06:47:26 INFO - 'sessionrestore', 06:47:26 INFO - 'sessionrestore_no_auto_restore', 06:47:26 INFO - 'tabpaint']}, 06:47:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:47:26 INFO - 'tests': ['a11yr', 06:47:26 INFO - 'ts_paint', 06:47:26 INFO - 'tpaint', 06:47:26 INFO - 'sessionrestore', 06:47:26 INFO - 'sessionrestore_no_auto_restore', 06:47:26 INFO - 'tabpaint']}, 06:47:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:47:26 INFO - 'tests': ['a11yr', 06:47:26 INFO - 'ts_paint', 06:47:26 INFO - 'tpaint', 06:47:26 INFO - 'sessionrestore', 06:47:26 INFO - 'sessionrestore_no_auto_restore', 06:47:26 INFO - 'tabpaint']}, 06:47:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:47:26 INFO - 'tests': ['tsvgx', 06:47:26 INFO - 'tsvgr_opacity', 06:47:26 INFO - 'tart', 06:47:26 INFO - 'tscrollx', 06:47:26 INFO - 'cart']}, 06:47:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:47:26 INFO - 'tsvgr_opacity', 06:47:26 INFO - 'tart', 06:47:26 INFO - 'tscrollx', 06:47:26 INFO - 'cart']}, 06:47:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:26 INFO - 'talos_options': ['--disable-e10s'], 06:47:26 INFO - 'tests': ['tp5o']}, 06:47:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:26 INFO - 'tests': ['tp5o']}, 06:47:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:26 INFO - 'talos_options': ['--disable-e10s', 06:47:26 INFO - '--xperf_path', 06:47:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:47:26 INFO - 'tests': ['tp5n']}, 06:47:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:26 INFO - 'talos_options': ['--xperf_path', 06:47:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:47:26 INFO - 'tests': ['tp5n']}}, 06:47:26 INFO - 'talos.zip': {'path': '', 06:47:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:47:26 INFO - Running post-action listener: _resource_record_post_action 06:47:26 INFO - ##### 06:47:26 INFO - ##### Running create-virtualenv step. 06:47:26 INFO - ##### 06:47:26 INFO - Running pre-action listener: _resource_record_pre_action 06:47:26 INFO - Running main action method: create_virtualenv 06:47:26 INFO - Creating virtualenv /builds/slave/test/build/venv 06:47:26 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:47:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:47:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:47:27 INFO - Using real prefix '/usr' 06:47:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:47:27 INFO - Installing distribute.............................................................................................................................................................................................done. 06:47:29 INFO - Installing pip.................done. 06:47:29 INFO - Return code: 0 06:47:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:47:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:47:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:47:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:47:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:47:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe50090df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf1f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfae410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfaf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfaf7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461678429.306690-184393022', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:47:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:47:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:47:29 INFO - Using env: {'DISPLAY': ':0', 06:47:29 INFO - 'HOME': '/home/cltbld', 06:47:29 INFO - 'LANG': 'en_US.UTF-8', 06:47:29 INFO - 'LANGUAGE': 'en_US:en', 06:47:29 INFO - 'LOGNAME': 'cltbld', 06:47:29 INFO - 'MAIL': '/var/mail/cltbld', 06:47:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:47:29 INFO - 'MOZ_NO_REMOTE': '1', 06:47:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:47:29 INFO - 'NO_EM_RESTART': '1', 06:47:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:47:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:47:29 INFO - 'PWD': '/builds/slave/test', 06:47:29 INFO - 'SHELL': '/bin/bash', 06:47:29 INFO - 'SHLVL': '1', 06:47:29 INFO - 'TERM': 'linux', 06:47:29 INFO - 'TMOUT': '86400', 06:47:29 INFO - 'USER': 'cltbld', 06:47:29 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461678429.306690-184393022', 06:47:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:47:29 INFO - '_': '/tools/buildbot/bin/python'} 06:47:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:47:29 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:47:29 INFO - Cleaning up... 06:47:29 INFO - Return code: 0 06:47:29 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:47:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:47:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:47:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:47:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:47:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe50090df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf1f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfae410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfaf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfaf7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461678429.306690-184393022', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:47:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 06:47:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 06:47:29 INFO - Using env: {'DISPLAY': ':0', 06:47:29 INFO - 'HOME': '/home/cltbld', 06:47:29 INFO - 'LANG': 'en_US.UTF-8', 06:47:29 INFO - 'LANGUAGE': 'en_US:en', 06:47:29 INFO - 'LOGNAME': 'cltbld', 06:47:29 INFO - 'MAIL': '/var/mail/cltbld', 06:47:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:47:29 INFO - 'MOZ_NO_REMOTE': '1', 06:47:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:47:29 INFO - 'NO_EM_RESTART': '1', 06:47:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:47:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:47:29 INFO - 'PWD': '/builds/slave/test', 06:47:29 INFO - 'SHELL': '/bin/bash', 06:47:29 INFO - 'SHLVL': '1', 06:47:29 INFO - 'TERM': 'linux', 06:47:29 INFO - 'TMOUT': '86400', 06:47:29 INFO - 'USER': 'cltbld', 06:47:29 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461678429.306690-184393022', 06:47:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:47:29 INFO - '_': '/tools/buildbot/bin/python'} 06:47:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:47:29 INFO - Downloading/unpacking psutil>=0.7.1 06:47:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:47:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:47:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:47:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:47:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:47:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:47:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:47:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:47:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:47:31 INFO - Installing collected packages: psutil 06:47:31 INFO - Running setup.py install for psutil 06:47:32 INFO - building 'psutil._psutil_linux' extension 06:47:32 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 06:47:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 06:47:32 INFO - building 'psutil._psutil_posix' extension 06:47:32 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 06:47:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 06:47:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:47:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:47:32 INFO - Successfully installed psutil 06:47:32 INFO - Cleaning up... 06:47:32 INFO - Return code: 0 06:47:32 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:47:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:47:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:47:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:47:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:47:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe50090df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf1f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfae410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfaf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfaf7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461678429.306690-184393022', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:47:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 06:47:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 06:47:32 INFO - Using env: {'DISPLAY': ':0', 06:47:32 INFO - 'HOME': '/home/cltbld', 06:47:32 INFO - 'LANG': 'en_US.UTF-8', 06:47:32 INFO - 'LANGUAGE': 'en_US:en', 06:47:32 INFO - 'LOGNAME': 'cltbld', 06:47:32 INFO - 'MAIL': '/var/mail/cltbld', 06:47:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:47:32 INFO - 'MOZ_NO_REMOTE': '1', 06:47:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:47:32 INFO - 'NO_EM_RESTART': '1', 06:47:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:47:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:47:32 INFO - 'PWD': '/builds/slave/test', 06:47:32 INFO - 'SHELL': '/bin/bash', 06:47:32 INFO - 'SHLVL': '1', 06:47:32 INFO - 'TERM': 'linux', 06:47:32 INFO - 'TMOUT': '86400', 06:47:32 INFO - 'USER': 'cltbld', 06:47:32 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461678429.306690-184393022', 06:47:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:47:32 INFO - '_': '/tools/buildbot/bin/python'} 06:47:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:47:32 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:47:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:47:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:47:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:47:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:47:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:47:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:47:34 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:47:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:47:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:47:34 INFO - Installing collected packages: mozsystemmonitor 06:47:34 INFO - Running setup.py install for mozsystemmonitor 06:47:34 INFO - Successfully installed mozsystemmonitor 06:47:34 INFO - Cleaning up... 06:47:34 INFO - Return code: 0 06:47:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:47:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:47:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:47:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:47:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:47:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe50090df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf1f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfae410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfaf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfaf7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461678429.306690-184393022', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:47:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:47:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:47:34 INFO - Using env: {'DISPLAY': ':0', 06:47:34 INFO - 'HOME': '/home/cltbld', 06:47:34 INFO - 'LANG': 'en_US.UTF-8', 06:47:34 INFO - 'LANGUAGE': 'en_US:en', 06:47:34 INFO - 'LOGNAME': 'cltbld', 06:47:34 INFO - 'MAIL': '/var/mail/cltbld', 06:47:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:47:34 INFO - 'MOZ_NO_REMOTE': '1', 06:47:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:47:34 INFO - 'NO_EM_RESTART': '1', 06:47:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:47:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:47:34 INFO - 'PWD': '/builds/slave/test', 06:47:34 INFO - 'SHELL': '/bin/bash', 06:47:34 INFO - 'SHLVL': '1', 06:47:34 INFO - 'TERM': 'linux', 06:47:34 INFO - 'TMOUT': '86400', 06:47:34 INFO - 'USER': 'cltbld', 06:47:34 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461678429.306690-184393022', 06:47:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:47:34 INFO - '_': '/tools/buildbot/bin/python'} 06:47:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:47:35 INFO - Downloading/unpacking blobuploader==1.2.4 06:47:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:47:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:47:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:47:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:47:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:47:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:47:36 INFO - Downloading blobuploader-1.2.4.tar.gz 06:47:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:47:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:47:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:47:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:47:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:47:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:47:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:47:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:47:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:47:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:47:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:47:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:47:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:47:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:47:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:47:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:47:37 INFO - Downloading docopt-0.6.1.tar.gz 06:47:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:47:37 INFO - Installing collected packages: blobuploader, requests, docopt 06:47:37 INFO - Running setup.py install for blobuploader 06:47:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:47:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:47:37 INFO - Running setup.py install for requests 06:47:38 INFO - Running setup.py install for docopt 06:47:38 INFO - Successfully installed blobuploader requests docopt 06:47:38 INFO - Cleaning up... 06:47:38 INFO - Return code: 0 06:47:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:47:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:47:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:47:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:47:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:47:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe50090df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf1f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfae410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfaf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfaf7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461678429.306690-184393022', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:47:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:47:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:47:38 INFO - Using env: {'DISPLAY': ':0', 06:47:38 INFO - 'HOME': '/home/cltbld', 06:47:38 INFO - 'LANG': 'en_US.UTF-8', 06:47:38 INFO - 'LANGUAGE': 'en_US:en', 06:47:38 INFO - 'LOGNAME': 'cltbld', 06:47:38 INFO - 'MAIL': '/var/mail/cltbld', 06:47:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:47:38 INFO - 'MOZ_NO_REMOTE': '1', 06:47:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:47:38 INFO - 'NO_EM_RESTART': '1', 06:47:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:47:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:47:38 INFO - 'PWD': '/builds/slave/test', 06:47:38 INFO - 'SHELL': '/bin/bash', 06:47:38 INFO - 'SHLVL': '1', 06:47:38 INFO - 'TERM': 'linux', 06:47:38 INFO - 'TMOUT': '86400', 06:47:38 INFO - 'USER': 'cltbld', 06:47:38 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461678429.306690-184393022', 06:47:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:47:38 INFO - '_': '/tools/buildbot/bin/python'} 06:47:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:47:38 INFO - Running setup.py (path:/tmp/pip-Ya3Drc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:47:38 INFO - Running setup.py (path:/tmp/pip-k5BDGm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:47:38 INFO - Running setup.py (path:/tmp/pip-8QSiot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:47:38 INFO - Running setup.py (path:/tmp/pip-KwEJvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:47:38 INFO - Running setup.py (path:/tmp/pip-Z8OMZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:47:38 INFO - Running setup.py (path:/tmp/pip-wjszw1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:47:38 INFO - Running setup.py (path:/tmp/pip-7mPKUM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:47:39 INFO - Running setup.py (path:/tmp/pip-7KxHzK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:47:39 INFO - Running setup.py (path:/tmp/pip-UTxoGe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:47:39 INFO - Running setup.py (path:/tmp/pip-4UEMkB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:47:39 INFO - Running setup.py (path:/tmp/pip-q1yy90-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:47:39 INFO - Running setup.py (path:/tmp/pip-DoRCAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:47:39 INFO - Running setup.py (path:/tmp/pip-fpgnoT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:47:39 INFO - Running setup.py (path:/tmp/pip-8IxK5b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:47:39 INFO - Running setup.py (path:/tmp/pip-wTeTft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:47:39 INFO - Running setup.py (path:/tmp/pip-5vjVog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:47:39 INFO - Running setup.py (path:/tmp/pip-44cMFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:47:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:47:39 INFO - Running setup.py install for manifestparser 06:47:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:47:39 INFO - Running setup.py install for mozcrash 06:47:39 INFO - Running setup.py install for mozdebug 06:47:40 INFO - Running setup.py install for mozdevice 06:47:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:47:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:47:40 INFO - Running setup.py install for mozfile 06:47:40 INFO - Running setup.py install for mozhttpd 06:47:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:47:40 INFO - Running setup.py install for mozinfo 06:47:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:47:40 INFO - Running setup.py install for mozInstall 06:47:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:47:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:47:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:47:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:47:40 INFO - Running setup.py install for mozleak 06:47:40 INFO - Running setup.py install for mozlog 06:47:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:47:40 INFO - Running setup.py install for moznetwork 06:47:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:47:40 INFO - Running setup.py install for mozprocess 06:47:40 INFO - Running setup.py install for mozprofile 06:47:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:47:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:47:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:47:41 INFO - Running setup.py install for mozrunner 06:47:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:47:41 INFO - Running setup.py install for mozscreenshot 06:47:41 INFO - Running setup.py install for moztest 06:47:41 INFO - Running setup.py install for mozversion 06:47:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:47:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:47:41 INFO - Cleaning up... 06:47:41 INFO - Return code: 0 06:47:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:47:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:47:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:47:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:47:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:47:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe50090df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf1f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfae410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfaf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfaf7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461678429.306690-184393022', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:47:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:47:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:47:41 INFO - Using env: {'DISPLAY': ':0', 06:47:41 INFO - 'HOME': '/home/cltbld', 06:47:41 INFO - 'LANG': 'en_US.UTF-8', 06:47:41 INFO - 'LANGUAGE': 'en_US:en', 06:47:41 INFO - 'LOGNAME': 'cltbld', 06:47:41 INFO - 'MAIL': '/var/mail/cltbld', 06:47:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:47:41 INFO - 'MOZ_NO_REMOTE': '1', 06:47:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:47:41 INFO - 'NO_EM_RESTART': '1', 06:47:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:47:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:47:41 INFO - 'PWD': '/builds/slave/test', 06:47:41 INFO - 'SHELL': '/bin/bash', 06:47:41 INFO - 'SHLVL': '1', 06:47:41 INFO - 'TERM': 'linux', 06:47:41 INFO - 'TMOUT': '86400', 06:47:41 INFO - 'USER': 'cltbld', 06:47:41 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461678429.306690-184393022', 06:47:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:47:41 INFO - '_': '/tools/buildbot/bin/python'} 06:47:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:47:41 INFO - Running setup.py (path:/tmp/pip-radB8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:47:41 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:47:41 INFO - Running setup.py (path:/tmp/pip-mEXVie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:47:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:47:41 INFO - Running setup.py (path:/tmp/pip-Szbk_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:47:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:47:41 INFO - Running setup.py (path:/tmp/pip-Hs2gRs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:47:42 INFO - Running setup.py (path:/tmp/pip-QHyy6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:47:42 INFO - Running setup.py (path:/tmp/pip-cqx2Ov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:47:42 INFO - Running setup.py (path:/tmp/pip-80v9Sg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:47:42 INFO - Running setup.py (path:/tmp/pip-lj57c3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:47:42 INFO - Running setup.py (path:/tmp/pip-Xyi113-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:47:42 INFO - Running setup.py (path:/tmp/pip-KkAyHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:47:42 INFO - Running setup.py (path:/tmp/pip-y0554q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:47:42 INFO - Running setup.py (path:/tmp/pip-ZblRS3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:47:42 INFO - Running setup.py (path:/tmp/pip-CSn1mJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:47:42 INFO - Running setup.py (path:/tmp/pip-EC84cD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:47:42 INFO - Running setup.py (path:/tmp/pip-wRgxEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:47:42 INFO - Running setup.py (path:/tmp/pip-dz9hhY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:47:42 INFO - Running setup.py (path:/tmp/pip-gumw2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:47:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:47:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:47:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:47:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:47:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:47:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:47:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:47:44 INFO - Downloading blessings-1.6.tar.gz 06:47:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:47:44 INFO - Installing collected packages: blessings 06:47:44 INFO - Running setup.py install for blessings 06:47:45 INFO - Successfully installed blessings 06:47:45 INFO - Cleaning up... 06:47:45 INFO - Return code: 0 06:47:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:47:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:47:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:47:45 INFO - Reading from file tmpfile_stdout 06:47:45 INFO - Current package versions: 06:47:45 INFO - argparse == 1.2.1 06:47:45 INFO - blessings == 1.6 06:47:45 INFO - blobuploader == 1.2.4 06:47:45 INFO - docopt == 0.6.1 06:47:45 INFO - manifestparser == 1.1 06:47:45 INFO - mozInstall == 1.12 06:47:45 INFO - mozcrash == 0.17 06:47:45 INFO - mozdebug == 0.1 06:47:45 INFO - mozdevice == 0.48 06:47:45 INFO - mozfile == 1.2 06:47:45 INFO - mozhttpd == 0.7 06:47:45 INFO - mozinfo == 0.9 06:47:45 INFO - mozleak == 0.1 06:47:45 INFO - mozlog == 3.1 06:47:45 INFO - moznetwork == 0.27 06:47:45 INFO - mozprocess == 0.22 06:47:45 INFO - mozprofile == 0.28 06:47:45 INFO - mozrunner == 6.11 06:47:45 INFO - mozscreenshot == 0.1 06:47:45 INFO - mozsystemmonitor == 0.0 06:47:45 INFO - moztest == 0.7 06:47:45 INFO - mozversion == 1.4 06:47:45 INFO - psutil == 3.1.1 06:47:45 INFO - requests == 1.2.3 06:47:45 INFO - wsgiref == 0.1.2 06:47:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:47:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:47:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:47:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:47:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:47:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe50090df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf1f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfae410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfaf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfaf7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461678429.306690-184393022', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:47:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:47:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:47:45 INFO - Using env: {'DISPLAY': ':0', 06:47:45 INFO - 'HOME': '/home/cltbld', 06:47:45 INFO - 'LANG': 'en_US.UTF-8', 06:47:45 INFO - 'LANGUAGE': 'en_US:en', 06:47:45 INFO - 'LOGNAME': 'cltbld', 06:47:45 INFO - 'MAIL': '/var/mail/cltbld', 06:47:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:47:45 INFO - 'MOZ_NO_REMOTE': '1', 06:47:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:47:45 INFO - 'NO_EM_RESTART': '1', 06:47:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:47:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:47:45 INFO - 'PWD': '/builds/slave/test', 06:47:45 INFO - 'SHELL': '/bin/bash', 06:47:45 INFO - 'SHLVL': '1', 06:47:45 INFO - 'TERM': 'linux', 06:47:45 INFO - 'TMOUT': '86400', 06:47:45 INFO - 'USER': 'cltbld', 06:47:45 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461678429.306690-184393022', 06:47:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:47:45 INFO - '_': '/tools/buildbot/bin/python'} 06:47:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:47:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:47:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:47:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:47:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:47:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:47:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:47:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:47:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:47:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:47:45 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:47:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:47:45 INFO - Cleaning up... 06:47:45 INFO - Return code: 0 06:47:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:47:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:47:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:47:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:47:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:47:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe50090df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf1f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfae410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfaf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfaf7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461678429.306690-184393022', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:47:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:47:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:47:45 INFO - Using env: {'DISPLAY': ':0', 06:47:45 INFO - 'HOME': '/home/cltbld', 06:47:45 INFO - 'LANG': 'en_US.UTF-8', 06:47:45 INFO - 'LANGUAGE': 'en_US:en', 06:47:45 INFO - 'LOGNAME': 'cltbld', 06:47:45 INFO - 'MAIL': '/var/mail/cltbld', 06:47:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:47:45 INFO - 'MOZ_NO_REMOTE': '1', 06:47:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:47:45 INFO - 'NO_EM_RESTART': '1', 06:47:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:47:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:47:45 INFO - 'PWD': '/builds/slave/test', 06:47:45 INFO - 'SHELL': '/bin/bash', 06:47:45 INFO - 'SHLVL': '1', 06:47:45 INFO - 'TERM': 'linux', 06:47:45 INFO - 'TMOUT': '86400', 06:47:45 INFO - 'USER': 'cltbld', 06:47:45 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461678429.306690-184393022', 06:47:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:47:45 INFO - '_': '/tools/buildbot/bin/python'} 06:47:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:47:45 INFO - Downloading/unpacking jsonschema 06:47:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:47:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:47:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:47:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:47:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:47:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:47:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:47:47 INFO - Downloading/unpacking functools32 (from jsonschema) 06:47:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:47:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:47:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:47:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:47:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:47:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:47:47 INFO - Downloading functools32-3.2.3-2.tar.gz 06:47:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:47:47 INFO - warning: no files found matching '*.txt' 06:47:47 INFO - no previously-included directories found matching 'build' 06:47:47 INFO - no previously-included directories found matching 'dist' 06:47:47 INFO - no previously-included directories found matching '.git*' 06:47:47 INFO - Installing collected packages: jsonschema, functools32 06:47:47 INFO - Running setup.py install for functools32 06:47:48 INFO - warning: no files found matching '*.txt' 06:47:48 INFO - no previously-included directories found matching 'build' 06:47:48 INFO - no previously-included directories found matching 'dist' 06:47:48 INFO - no previously-included directories found matching '.git*' 06:47:48 INFO - Successfully installed jsonschema functools32 06:47:48 INFO - Cleaning up... 06:47:48 INFO - Return code: 0 06:47:48 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:47:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:47:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:47:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:47:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:47:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe50090df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf1f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfae410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfaf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfaf7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461678429.306690-184393022', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:47:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 06:47:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 06:47:48 INFO - Using env: {'DISPLAY': ':0', 06:47:48 INFO - 'HOME': '/home/cltbld', 06:47:48 INFO - 'LANG': 'en_US.UTF-8', 06:47:48 INFO - 'LANGUAGE': 'en_US:en', 06:47:48 INFO - 'LOGNAME': 'cltbld', 06:47:48 INFO - 'MAIL': '/var/mail/cltbld', 06:47:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:47:48 INFO - 'MOZ_NO_REMOTE': '1', 06:47:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:47:48 INFO - 'NO_EM_RESTART': '1', 06:47:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:47:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:47:48 INFO - 'PWD': '/builds/slave/test', 06:47:48 INFO - 'SHELL': '/bin/bash', 06:47:48 INFO - 'SHLVL': '1', 06:47:48 INFO - 'TERM': 'linux', 06:47:48 INFO - 'TMOUT': '86400', 06:47:48 INFO - 'USER': 'cltbld', 06:47:48 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461678429.306690-184393022', 06:47:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:47:48 INFO - '_': '/tools/buildbot/bin/python'} 06:47:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:47:48 INFO - Downloading/unpacking flake8 06:47:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:47:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:47:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:47:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:47:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:47:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:47:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:47:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:47:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:47:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:47:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:47:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:47:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:47:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:47:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:47:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:47:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:47:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:47:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:47:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:47:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:47:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:47:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:47:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:47:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:47:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:47:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:47:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:47:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:47:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:47:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:47:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:47:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:47:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:47:50 INFO - no previously-included directories found matching 'docs/_build' 06:47:50 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:47:51 INFO - Running setup.py install for pep8 06:47:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:47:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:47:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:47:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:47:51 INFO - no previously-included directories found matching 'docs/_build' 06:47:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:47:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:47:51 INFO - Cleaning up... 06:47:51 INFO - Return code: 0 06:47:51 INFO - Running post-action listener: _resource_record_post_action 06:47:51 INFO - Running post-action listener: _start_resource_monitoring 06:47:51 INFO - Starting resource monitoring. 06:47:51 INFO - ##### 06:47:51 INFO - ##### Running install step. 06:47:51 INFO - ##### 06:47:51 INFO - Running pre-action listener: _resource_record_pre_action 06:47:51 INFO - Running main action method: install 06:47:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:47:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:47:51 INFO - Reading from file tmpfile_stdout 06:47:51 INFO - Detecting whether we're running mozinstall >=1.0... 06:47:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:47:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:47:51 INFO - Reading from file tmpfile_stdout 06:47:51 INFO - Output received: 06:47:51 INFO - Usage: mozinstall [options] installer 06:47:51 INFO - Options: 06:47:51 INFO - -h, --help show this help message and exit 06:47:51 INFO - -d DEST, --destination=DEST 06:47:51 INFO - Directory to install application into. [default: 06:47:51 INFO - "/builds/slave/test"] 06:47:51 INFO - --app=APP Application being installed. [default: firefox] 06:47:51 INFO - mkdir: /builds/slave/test/build/application 06:47:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:47:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:48:07 INFO - Reading from file tmpfile_stdout 06:48:07 INFO - Output received: 06:48:07 INFO - /builds/slave/test/build/application/firefox/firefox 06:48:07 INFO - Running post-action listener: _resource_record_post_action 06:48:07 INFO - ##### 06:48:07 INFO - ##### Running run-tests step. 06:48:07 INFO - ##### 06:48:07 INFO - Running pre-action listener: _resource_record_pre_action 06:48:07 INFO - Running main action method: run_tests 06:48:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:48:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:48:07 INFO - Python 2.7.3 06:48:07 INFO - Return code: 0 06:48:07 INFO - grabbing minidump binary from tooltool 06:48:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:48:07 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfae410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfaf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfaf7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:48:07 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:48:07 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 06:48:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:48:07 INFO - Return code: 0 06:48:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:48:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:48:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:48:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:48:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:48:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:48:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:48:08 INFO - Return code: 0 06:48:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Dh-grJbYROamKTgWrzvbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:48:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Dh-grJbYROamKTgWrzvbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:48:08 INFO - Using env: {'DISPLAY': ':0', 06:48:08 INFO - 'HOME': '/home/cltbld', 06:48:08 INFO - 'LANG': 'en_US.UTF-8', 06:48:08 INFO - 'LANGUAGE': 'en_US:en', 06:48:08 INFO - 'LOGNAME': 'cltbld', 06:48:08 INFO - 'MAIL': '/var/mail/cltbld', 06:48:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:48:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:48:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:08 INFO - 'MOZ_NO_REMOTE': '1', 06:48:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:48:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:48:08 INFO - 'NO_EM_RESTART': '1', 06:48:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:48:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:08 INFO - 'PWD': '/builds/slave/test', 06:48:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:48:08 INFO - 'SHELL': '/bin/bash', 06:48:08 INFO - 'SHLVL': '1', 06:48:08 INFO - 'TERM': 'linux', 06:48:08 INFO - 'TMOUT': '86400', 06:48:08 INFO - 'USER': 'cltbld', 06:48:08 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461678429.306690-184393022', 06:48:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:08 INFO - '_': '/tools/buildbot/bin/python'} 06:48:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Dh-grJbYROamKTgWrzvbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:48:08 INFO - mozversion application_buildid: 20160426044601 06:48:08 INFO - mozversion application_changeset: 9ce31e9f90cb0e534611b0f617c5bbc232ffe748 06:48:08 INFO - mozversion application_display_name: Nightly 06:48:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:48:08 INFO - mozversion application_name: Firefox 06:48:08 INFO - mozversion application_remotingname: firefox 06:48:08 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:48:08 INFO - mozversion application_vendor: Mozilla 06:48:08 INFO - mozversion application_version: 49.0a1 06:48:08 INFO - mozversion platform_buildid: 20160426044601 06:48:08 INFO - mozversion platform_changeset: 9ce31e9f90cb0e534611b0f617c5bbc232ffe748 06:48:08 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:48:08 INFO - mozversion platform_version: 49.0a1 06:48:08 INFO - using testdate: 1461678488 06:48:08 INFO - actual date: 1461678488 06:48:08 INFO - starting webserver on 'localhost:52481' 06:48:08 INFO - SUITE-START | Running 2 tests 06:48:08 INFO - TEST-START | dromaeo_css 06:48:08 INFO - operating with platform_type : linux_ 06:48:08 INFO - Initialising browser for dromaeo_css test... 06:48:08 INFO - TEST-INFO | started process 12572 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHD_wUu/profile http://localhost:52481/getInfo.html) 06:48:12 INFO - PROCESS | 12572 | __metrics Screen width/height:1600/1200 06:48:12 INFO - PROCESS | 12572 | colorDepth:24 06:48:12 INFO - PROCESS | 12572 | Browser inner width/height: 1024/697 06:48:12 INFO - PROCESS | 12572 | __metrics 06:48:13 ERROR - PROCESS | 12572 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:48:14 INFO - TEST-INFO | 12572: exit 0 06:48:14 INFO - Browser initialized. 06:48:14 INFO - Running cycle 1/1 for dromaeo_css test... 06:48:14 INFO - TEST-INFO | started process 12653 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHD_wUu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:48:26 INFO - PROCESS | 12653 | RSS: Main: 155860992 06:48:26 INFO - PROCESS | 12653 | 06:49:17 INFO - PROCESS | 12653 | 1461678557605 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 06:51:29 INFO - PROCESS | 12653 | Cycle 1(1): loaded http://localhost:52481/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52481/tests/dromaeo/cssquery-ext.html) 06:51:30 INFO - PROCESS | 12653 | RSS: Main: 269615104 06:51:30 INFO - PROCESS | 12653 | 06:54:32 INFO - PROCESS | 12653 | Cycle 1(1): loaded http://localhost:52481/tests/dromaeo/cssquery-ext.html (next: http://localhost:52481/tests/dromaeo/cssquery-jquery.html) 06:54:33 INFO - PROCESS | 12653 | RSS: Main: 244916224 06:54:33 INFO - PROCESS | 12653 | 06:57:35 INFO - PROCESS | 12653 | Cycle 1(1): loaded http://localhost:52481/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52481/tests/dromaeo/cssquery-mootools.html) 06:57:36 INFO - PROCESS | 12653 | RSS: Main: 235646976 06:57:36 INFO - PROCESS | 12653 | 07:00:38 INFO - PROCESS | 12653 | Cycle 1(1): loaded http://localhost:52481/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52481/tests/dromaeo/cssquery-prototype.html) 07:00:38 INFO - PROCESS | 12653 | RSS: Main: 230756352 07:00:38 INFO - PROCESS | 12653 | 07:03:41 INFO - PROCESS | 12653 | Cycle 1(1): loaded http://localhost:52481/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52481/tests/dromaeo/cssquery-yui.html) 07:03:42 INFO - PROCESS | 12653 | RSS: Main: 224960512 07:03:42 INFO - PROCESS | 12653 | 07:06:45 INFO - PROCESS | 12653 | Cycle 1(1): loaded http://localhost:52481/tests/dromaeo/cssquery-yui.html (next: http://localhost:52481/tests/dromaeo/cssquery-dojo.html) 07:06:45 INFO - PROCESS | 12653 | RSS: Main: 267816960 07:06:45 INFO - PROCESS | 12653 | 07:06:45 INFO - PROCESS | 12653 | __start_tp_report 07:06:45 INFO - PROCESS | 12653 | _x_x_mozilla_page_load 07:06:45 INFO - PROCESS | 12653 | _x_x_mozilla_page_load_details 07:06:45 INFO - PROCESS | 12653 | |i|pagename|runs| 07:06:45 INFO - PROCESS | 12653 | |0;dojo.html;2588.3787890906183;2612.7779138773203;2662.6405435266233;2672.799540034498;2686.3955609987756;4508.323751437286;4586.15156196104;4598.770061496924;4627.9305810412825;4638.536146385368;4598.632109431246;4631.120087183433;4692.2257827458425;4704.600108990731;4712.198926182548;4235.449391579091;4276.422682937802;4289.914201715964;4348.391225228471;4386.1008493258805;4299.054208074219;4351.521332653406;4358.106588149421;4361.869143925687;4408.4048653431855;4182.2890108681295;4183.6234738873645;4294.334378171388;4296.720713153651;4304.074623955865;4285.164392943378;4299.527052024275;4335.7181783184;4340.631046361063;4361.476622805284;4272.423222864935;4275.337322714984;4287.485501739811;4305.50486694031;4320.287152619814;4413.271810151321;4447.2439685253585;4510.706804057759;4528.388667529907;4593.862184134481;4990.575801056878;4994.925076123861;4996.475370086125;4996.650234483587;5033.521815427529;4997.850064498035;5002.549770520634;5010.549050585429;5020.472850350697;5041.697498150123;4513.368128462018;4566.45202575693;4660.72035677857;4665.930011049837;4677.391939047936;5104.157813960729;5119.641625086283;5128.692278463304;5133.717645529532;5154.304168937146;4905.484924082992;4918.532739389752;4921.729304888266;4926.950730492721;4966.1309270877455;4841.782119804618;4924.113659541317;4983.750812459362;5001.274815151783;5016.147254966664;4913.803447862117;4920.655554111249;4929.408470983433;4933.235348520985;4981.12830254704;4855.077535268288;4891.04624598207;4899.2896030075435;4904.975475122602;4946.629002824802;4158.355454904495;4221.852235171754;4222.535521092677;4256.808443619982;4337.240982828055;3714.461403096536;3720.8325625346924;3732.720045996561;3750.474933509311;3773;4308.1814455254025;4311.655067594585;4312.784360781949;4351.934720979125;4364;4788.497207793132;4928.063667903087;4986.301917731521;4988.127077761377;5016.924746128811;4239.660827133884;4262.062346283813;4264.957350426456;4308.849190278325;4314.115606300701;4477.686561940633;4482.260427029503;4487.506374298824;4490.797914093873;4529.456465224194;4576.542345765463;4656.4412270527755;4670.229412147026;4737.928931065968;4737.952620473889;4965.950340496549;4972.428170760264;4989.201727723546;4993.550580447777;5046.697198168122;4712.552307530779;4716.292556116473;4717.339572459789;4720.527947205252;4766.142094423037;4740.4785473597185;4863.416390033219;4889.584385327144;4932.728699921395;4934.037862616755;4957.231629097496;4960.925586116284;4981.651284410202;4987.2768448574025;5034.370703662043;4669.766511674471;4844.660873738804;4856.368672072608;4864.635152363516;4903.16646170159;4706.741129237787;4775.808967641256;4776.116418462596;4815.036992601424;4819;4698.929516057194;4727.598154156935;4734.834280800155;4742.549457801503;4793.2091204952185;4725.29120631908;4754.310624959292;4837.322774811459;4874.8537543873745;4884.389451318585;4567.520410356865;4685.039566888848;4752.691075080109;4753.168195565693;4826.372571565674 07:06:45 INFO - PROCESS | 12653 | |1;ext.html;569.9601027928044;599.9220101386819;621.835213668378;623.2863371439704;626.555145846449;26457.338566535822;27187.320316992085;27192.728072719266;27212.727872721265;27216.72783272169;34190;34805.30389392217;35180.2963940721;35196.648033519654;35763.2847343053;7513.924860751391;7714.6914123435;7721.112072111723;7735.922640773577;7736.806579835493;7059.823504412379;7484.663190156456;7653.119891212498;7661.502002369856;9139.543022848864;9606.471644059575;9784.510774461283;9784.902150978505;9787.070228328297;9795.069468400527;9529.523523823817;9654.90345096547;9661.999999999965;9664.130228279488;9677.564509597085;9548.37935534188;9689.806203875953;9691;9695.466749328783;9719.125278724949;32930;33292.83353583241;35463;35476.46785298223;35504.467432988524;3038.103759390985;3050.8627111780024;3179.0462861141564;3258.201740573551;3376.8142752148624;27874;28256.717432825615;28848.99028533991;29467;29634;3477.2523907360037;3492.388831954423;3532.9116772080647;3554;3605.693516051139;144503;144848.8605797605;145163.27418362946;145543;145717;51256.743716281926;51362.48637513577;51499.742501287255;51518;51614.74192629088;54067;54390.72804636031;54535.454645453035;54665.726671367185;54670;14343.85656143446;14769.483068092564;14781.778273325908;14785.556433307018;14789.186594737394;10653.57385704563;11293.661190164308;11325.773484530264;11346.716332091599;11357.261777984404;15592.610184745472;16193.514194574182;16288.104154271628;16314.265858036417;16316.34734610626;6026.3126324629175;6160.199174107337;6255.02725333352;6265.592736472115;6358.936410635927;862.5567014402404;869.4348673362239;938.3337830140676;973.9432715503616;987.1411871671692;26502.02801254781;26539.33651658724;26815.865920670272;27564.86217568899;27577.310567235978;814.9877751833727;948.7580666930027;964.4406244378243;979.8726165598426;1029.2692188546216;13049.28228947417;13489.662758431117;13652.49822519522;13821.516246931511;13895.861041389457;263023;267232;268067;268511;270629;40190.59809401927;40395.39406908899;40428.59571404307;40433.19133617311;40473;1048.3395460859763;1180.3803003423272;1182.6806762174165;1232.2729589542391;1257.251935098615;26641.46717065609;27752.861235693694;27932.30169245785;28773.42453150967;28775.5683664741;38062.23875522529;38310.80844595759;38583;38651.420228697156;38671.41992870053;212269;213160;213289;213380;214223;27528;32576;33353.66646333603;33428;33668.32663346768;35997.46003809893;36714.63285367112;36945.81527092455;36970.26059478742;37481.4377784328;31009.534856976712;31310.530342045342;31535.684643153276;32844;34900.65099349076;33813.49279760756;33823.3235335287;34018.14954626154;34186;35073.1231719209;33280;33944.490832638025;34262.82868585641;34287.65712342845;34479;29944.25139371533;30606.846965765028;30726.692733072385;30891.2277193063;30950.22624434407;23829.52340953206;24205.273841784776;24623.38441538976;24785.50428991446;24942.251732448054 07:06:45 INFO - PROCESS | 12653 | |2;jquery.html;376.8982374758816;376.9396896496561;380.42175892643183;383.7869982159902;390.5898806253433;15178.165200913945;15918.442854500096;16249.431269905555;16252.106134162615;16254.593635159126;14412.783808242884;16209;16329.101899395528;16361.427350042752;16371.017738935643;4866.343043689109;5076.568491678212;5117.462666420028;5117.7185254810975;5132.743362831862;3637.927241455169;5050.3434553508;5543.6396634218845;5846.912296315559;5861.648301101926;5782.797602083928;5794.159846822208;5814.796482123126;5817.214676018725;5817.534597232211;5690.4025077366905;5790.623609465413;5797.217375654317;5799.130130480419;5804.984127777643;3296.0606227225367;4846.903061938741;4922.114019476493;5104.846854594368;5116.386033675945;18292.634147316978;18384.264629414807;18450.077496125276;19796.901015494976;19848.007599620105;1868.4488076017608;1886.8018808056845;2079.792020797923;2105.505206276524;2212.6570381590877;12122.757544849053;12419.75160496785;12452.688682782913;12683.619491415273;13092.149010314395;1742.8431441170228;1758.9472315830546;1761.2954818072744;1790.301782304889;1791.7670702808682;57799;60614;60660.393396066356;60725.392746072415;61160;9030.232430243372;9035.50304733246;9427.62289508412;9690.903090969141;10156.746081347877;12934.288614126313;13016.852219383885;13033.370828646419;13045.804312935314;13061.673458163621;6927.203371612229;6930.218149476845;7320.341169294789;7480.812979675552;7508.812279692942;7144.499885007999;7160.176579693402;7231.855362892713;7281.344678978918;7319.890201646979;5907.054871220584;5984.73068711909;5999.5800293979;6016.819495415145;6050.57645964787;1621.4487074394763;1692.8222536633475;1694.872884533665;1698.2188193430914;1706.6074802795179;802.2418814220622;899.3434792601438;903.3847012897625;929.5584597316221;932.1424289653535;16176.624986876248;17186.140692965302;17216.225269862636;17401.129943502776;17742.733858992124;896.4442045931564;917.2936838634214;933.8179055084194;947.6020071569957;950.8858936927475;9524.761880953032;9586.849578050678;9728.270379721549;9879.851802222973;10010.498425236126;139880;296282;297984;300519;302443;63029;67629.66185169043;71082;72494;75049.62475187589;860.5568132411938;958.2908647600725;986.0878687214298;988.3723835364451;989.2580564576567;13566.38951247216;14562.563123106323;14593.562193134223;14648.560543183721;15155.469558565397;30339.393212136074;30639;32192.19519512031;33425.66574334226;33514;41134.794326028175;43835.34246986234;43973.12053758843;44127;44503.10993780171;7508.587027713528;7599;7648.961755191189;7829.846792132209;7882;10564.894351056391;11223.38271395081;11225.831612525983;11514.827277590675;11518.193726439069;9767.316287860065;9997.100260976547;10114.393136411838;10331.586736530455;10339.327943683636;9541.856872146784;9953.402795832273;10061.748456288651;10165;10213.438260895722;10250.282480226313;10314.329568578018;10315.587376504856;10322.225833062701;10636.14910807118;7262;7514.9624251878395;7539;7578.962105189439;7720;8587;9478.905210947802;9611.183049440875;9784.461854598065;9803.215742740422 07:06:45 INFO - PROCESS | 12653 | |3;mootools.html;1118.3792994887833;1434.0678558936693;1464.7509923313037;1602.1428535733378;1778.79543852457;6362.141110950026;7436.479446438745;7629.732959346424;7647.273509016649;7655.311022008012;7251.166115896674;7430.108386993568;7436.739714110007;7437.4421918356065;7440.069991251094;1839.2183322088126;2178.8692678439265;2193.6051510728144;2207.194374053467;2282.8858557072163;2289.919852805152;2309.1340747219792;2309.4919117794143;2310.0297874892585;2313.1672597864754;2192.6601376786625;2241.1707668162803;2242.372135801978;2243.798058174764;2244.517428752818;1849.657813304543;2112.588045331161;2175.695402643631;2176.4667656424117;2177.314146044007;2132.2004248406847;2148.0655914677163;2151.8924053797405;2154.05221702452;2154.741431028271;7469.1410487794055;7561.508501947411;7625.199354067854;7627.122880868716;7631.465797394185;4369.956300437018;4525.637948964075;4535.841245556423;4537.591616754475;4544.227481328182;2858.4997625415676;2874.956875646867;2958.6449626044796;2983.1796256029547;2996.071217922451;889.297455010541;914.419343716738;931.7624005878457;934.5280633280217;935.5415846235296;10558.102561282378;10627.84058239127;10632.096271816905;10633.36199828005;10639.414832184228;4188.790560471964;4359.128174365076;4424.11517696462;4440.622547083534;4450.198964186413;9119.863202051974;9163.16736652672;9169.541522923828;9173.541322933826;9188.540572971458;4030.8186131624147;4591.104734576792;4694.460137084279;4697.506761790031;4699.671023028423;3912.9608703912595;3950.7036972227197;3987.8803635890968;3991;3992.2414741199077;3511.5786105667485;3554.9822250889097;3583.8387272572795;3585;3650.653187947141;1187.703074231442;1206.0291465370285;1214.690253985228;1217.3487184356327;1230.0651504856373;687.9208890977502;785.6071964017991;824.8181718686322;827.1356432527903;870.0125357719035;5268.552173065333;5274.657147285414;5284.128118860345;5332.840014799563;5361.705106219118;398.8962869653853;399.41884557968086;404.5650925255362;408.1082834007703;408.7976451656449;3366.7206461544456;3390.5761779777526;3402.7107695845634;3421.6578342165585;3442.5868895732674;9278.95360523193;9290.256779457628;9696.95151524238;9795;9823.901760982299;9592.904070959341;9609.807803843883;9616.08647178517;9702.854457183148;9751.3661611995;7270.927290727025;7361.159710072482;7453.515521491086;7468.804991201382;7511.286427789242;5163.044836705071;5165.21756372246;5177.0940085484135;5201.245819356096;5274.7890084396195;8997.415168014059;9058.773530661787;9110.407823491452;9175.31185161129;9190.35667503295;8845;9155.542222888962;9175.403598766059;9179.495127768037;9206.217471514996;6270.278917924315;6496.447801936888;6503.869922601616;6794.8641027180165;6814.182298124257;6874.312568743286;6910.965445172742;6921.930780692129;6922.06552115458;6960.269171736894;6202.131701561695;6414.871702565829;6426.61440313564;6473.9676301620075;6481.254655714653;6361.840953976188;6392.9360706392345;6418.807435776934;6483.610983341015;6514.609123452608;6307.180066591313;6340.587861788969;6347;6362.300146983735;6369.267534233622;4374.715643483163;4424.7123936944;4460.3755474234285;4525.094981003746;4569.565891240327;4431.689781715249;4506.774661266858;4586.449626044896;4612.60792832613;4658.510856360033 07:06:45 INFO - PROCESS | 12653 | |4;prototype.html;304.5219006160328;307.2518417653015;309.82649716158943;310.0945239899495;310.4582503531338;4778.5460381263765;4781.928271075928;4832.758362081895;4836.105320515702;4852.199387101124;4671;4710.3405523226775;4720.1739695553315;4722.574968252857;4743.5256474352545;3577.910552236189;3640.8179591020476;3721.758085724433;3766.491523644314;3805.6194380562;3737.159139193673;3782.8865134046023;3784.6593806557403;3784.8486060557543;3802.6577608015273;3559.661832125944;3745;3745.0824547985644;3772.2078363543687;3773.0755964788664;3651.543557055368;3742.401215805458;3743.9142648632;3745.3969491203625;3752.887413377603;3310.2717402171484;3315.3037862049;3328.6671332866763;3328.900132996014;3332.166958260435;4570.817167313304;4579.893249105416;4604.401427814396;4606.861794146181;4607.239805432133;3965.524137103566;4213.157368526307;4243.97878010611;4277.914441711179;4296.8281268749215;4953.752312384367;4953.950460495421;4959.752012399402;4989.376327959005;5005.724685142316;3533.9293214135832;3552.8401221945073;3554.306910152521;3565.6790888820133;3571.964280357215;5030.773615187289;5161.948380516184;5183.248428977852;5197.766100525486;5213.2701421800975;3604.0269127335473;3639.763415378045;3641.6358364163902;3655.3603119453987;3657.122290650225;3678.1172518595345;3691.9446208306895;3694.2796154750104;3696.5748938872375;3700.4634328022285;4208.6633069354375;4225.345071513921;4225.767582782915;4230.661547076226;4235.110626768352;4830.4640063966;4968;4985.252212168204;4994.550490455877;5001.624878134155;1321.167664371459;1326.6285440076795;1329.3884812986134;1331.4407948661585;1332.9533466328633;845.4969293270494;882.4087861133056;882.5807741322949;908.56842999576;909.3043821476575;4662.347271382009;4665.580097791215;4667;4676.134915040729;4693.296005599119;5456.863578410572;5464.617476776667;5468.562514998791;5471.480209380103;5483.506484416422;4499.280115181621;4646.930296045562;4655.301704744248;4672.929906051412;4701.623870090384;2853.2866783304175;2898.130560831742;2898.5797059426263;2901.361700425945;2917.0373776653655;5097.209932460474;5105.846824595268;5112.616553758483;5130.692158470503;5136.717480538531;5036.924446133311;5269.209618557247;5327.016870552503;5331.173668081454;5534.4742249486235;4892.902141957141;4900.558949694545;4905.264210368473;4925.408950925912;4931.161702510653;5183.352080989876;5197.7661005254095;5205.791768329376;5215.634905556574;5234.869128271824;4798.640101992434;5092.287079808903;5117.2068329409;5117.667351622133;5121.462246464068;4830.106430310404;4882.658213924991;4933.407991041098;4951.207806750903;4970.850874473772;3752.399616061417;3777.2067865747404;3777.244551089848;3792.1657235408165;3799.271331544196;5044.949550504448;5148.3564554430695;5169.250458683545;5176.585873130216;5184.351956005499;4984.601231901512;5013.774380152975;5032.547070763502;5033.974830125972;5035.597152227886;4994.2508623706735;5010.098182327216;5019.52314530119;5028.572571331478;5047.082108798633;4734.19518681818;4743.644226682944;4913.533214344631;4977;4977.676451030671;4925.014997000542;4951.9752401237765;4952.9846381492425;4956.529129732669;4973.154563724103;4738.928916066331;4934.136526107988;4950.727709975986;4956.578690811321;4981.975090124526 07:06:45 INFO - PROCESS | 12653 | |5;yui.html;681.6864242448473;689.2177378675202;706.6713978000225;729.3435907683087;800.0719165767711;12183.878161218385;12229.143959922809;12399.628011159679;12463.252204867704;12469.314187719672;11957.103217258697;12021.579244726436;12031.278123312608;12035.578754743587;12038.097142714289;622.9875402491947;645.8901986662279;768.3852917665873;807.5477732469835;810.2950433123191;813.4875028731891;814.5031530766228;818.3207937411963;818.4352796570347;818.607068607069;854.478767951549;857.3526987124712;857.7169534053778;857.7812657772259;857.9742607721778;656.6946369937978;822.6380392627254;851.43379652531;855.0338117926765;856.9871451928163;623.0965100604097;624.7625902157197;625.1092193624067;625.1903784598956;625.4277336237337;12562.560310389092;12605.30670813105;12620.305883176421;12634.873651263462;12639.368031598384;11685.591004314892;12064.819027714591;12159.331236781973;12507.249565026037;12575.559855405108;9659.517024148834;9690.51547422626;9730.318877678565;9780.217582593375;9805.950970245103;3281.950770738441;3337.1156643489494;3367.4275373186615;3375.122468158272;3455.775374600643;42330.15339693189;42579;42629.78685106586;42657.14685706268;42735.78632106851;9604.183644390165;10024.248181386425;10416.479176041168;10596.682099537025;10670.946645266724;16723.83276167247;16961.49115526536;16993.40523081686;16999.49001529956;17003.31986720542;6692.330766923269;6728.764493242811;6814.522983391214;7025.121859767529;7235.565866048054;3909;3989.1423343981182;3999.900002499961;4024.899377515527;4074.3481043033566;2923.5760814682176;2985.4178435204926;2988.790784645054;2993.1020693791775;2994.386150839073;517.5549027836058;525.1833399064415;525.2961032216848;526.5761062344849;544.2516539757833;561.53673219594;582.472862059828;583.4880837992398;590.3624085987124;606.1120458528189;7915.485493442908;7987.041555013436;8315.126911674188;8369.246767790806;8406.579671016547;513.5224241455408;564.5398999815137;567.9829605111853;579.3858509979351;592.6088781404253;3630.3465376232;3660.4875317455576;3724.646158614927;3814.8474061037805;3826.674732647756;54554.45445545573;54628.18057729137;57063.14405283924;57094.7145264271;57255.42744572584;47685;48379.758101209976;48881.5111848877;49748.253776193385;50325;44992.55007449949;45118;45630.859228518886;46018;46884.296735549;7139;7276.599787011553;7388.076490438695;7586.924130758843;7620.3522700571075;31020.53469197919;31262;31350.843245783624;31552;32600.51099233466;38727;41769.37345939874;42181.367279490216;42398.788006061004;43279.350809738506;9747.951260243653;9841.85237221428;10367.688969330931;10374.792504150026;10389;7796.876330303027;10698.73253168677;11556.94221528887;11574.88425115738;11825.881741182822;10862.402567858844;10929.289596176222;10966.890331096587;10983.505742241778;11040.282381645167;10709.143268538654;10804.67585972422;11348.375839328915;11591.420428978687;11693.006094481723;10722.892771072502;10881.510332035235;11000.119990400908;11012.559497620005;11124.110071194124;9155.587998540215;9207.377866400797;9328;9545.236381089635;9832.065953734384;9112.29305565944;9560.474173920224;9643.228541716506;9669;9694.660686875926 07:06:45 INFO - PROCESS | 12653 | __end_tp_report 07:06:45 INFO - PROCESS | 12653 | __start_cc_report 07:06:45 INFO - PROCESS | 12653 | _x_x_mozilla_cycle_collect,1032 07:06:45 INFO - PROCESS | 12653 | __end_cc_report 07:06:45 INFO - PROCESS | 12653 | __startTimestamp1461679605629__endTimestamp 07:06:45 INFO - PROCESS | 12653 | 07:06:45 INFO - PROCESS | 12653 | ------- Summary: start ------- 07:06:45 INFO - PROCESS | 12653 | Number of tests: 6 07:06:45 INFO - PROCESS | 12653 | 07:06:45 INFO - PROCESS | 12653 | [#0] dojo.html Cycles:165 Average:4592.84 Median:4712.20 stddev:466.34 (9.9%) stddev-sans-first:440.46 07:06:45 INFO - PROCESS | 12653 | Values: 2588.4 2612.8 2662.6 2672.8 2686.4 4508.3 4586.2 4598.8 4627.9 4638.5 4598.6 4631.1 4692.2 4704.6 4712.2 4235.4 4276.4 4289.9 4348.4 4386.1 4299.1 4351.5 4358.1 4361.9 4408.4 4182.3 4183.6 4294.3 4296.7 4304.1 4285.2 4299.5 4335.7 4340.6 4361.5 4272.4 4275.3 4287.5 4305.5 4320.3 4413.3 4447.2 4510.7 4528.4 4593.9 4990.6 4994.9 4996.5 4996.7 5033.5 4997.9 5002.5 5010.5 5020.5 5041.7 4513.4 4566.5 4660.7 4665.9 4677.4 5104.2 5119.6 5128.7 5133.7 5154.3 4905.5 4918.5 4921.7 4927.0 4966.1 4841.8 4924.1 4983.8 5001.3 5016.1 4913.8 4920.7 4929.4 4933.2 4981.1 4855.1 4891.0 4899.3 4905.0 4946.6 4158.4 4221.9 4222.5 4256.8 4337.2 3714.5 3720.8 3732.7 3750.5 3773.0 4308.2 4311.7 4312.8 4351.9 4364.0 4788.5 4928.1 4986.3 4988.1 5016.9 4239.7 4262.1 4265.0 4308.8 4314.1 4477.7 4482.3 4487.5 4490.8 4529.5 4576.5 4656.4 4670.2 4737.9 4738.0 4966.0 4972.4 4989.2 4993.6 5046.7 4712.6 4716.3 4717.3 4720.5 4766.1 4740.5 4863.4 4889.6 4932.7 4934.0 4957.2 4960.9 4981.7 4987.3 5034.4 4669.8 4844.7 4856.4 4864.6 4903.2 4706.7 4775.8 4776.1 4815.0 4819.0 4698.9 4727.6 4734.8 4742.5 4793.2 4725.3 4754.3 4837.3 4874.9 4884.4 4567.5 4685.0 4752.7 4753.2 4826.4 07:06:45 INFO - PROCESS | 12653 | 07:06:45 INFO - PROCESS | 12653 | [#1] ext.html Cycles:180 Average:37011.19 Median:33981.32 stddev:55826.59 (164.3%) stddev-sans-first:55916.14 07:06:45 INFO - PROCESS | 12653 | Values: 570.0 599.9 621.8 623.3 626.6 26457.3 27187.3 27192.7 27212.7 27216.7 34190.0 34805.3 35180.3 35196.6 35763.3 7513.9 7714.7 7721.1 7735.9 7736.8 7059.8 7484.7 7653.1 7661.5 9139.5 9606.5 9784.5 9784.9 9787.1 9795.1 9529.5 9654.9 9662.0 9664.1 9677.6 9548.4 9689.8 9691.0 9695.5 9719.1 32930.0 33292.8 35463.0 35476.5 35504.5 3038.1 3050.9 3179.0 3258.2 3376.8 27874.0 28256.7 28849.0 29467.0 29634.0 3477.3 3492.4 3532.9 3554.0 3605.7 144503.0 144848.9 145163.3 145543.0 145717.0 51256.7 51362.5 51499.7 51518.0 51614.7 54067.0 54390.7 54535.5 54665.7 54670.0 14343.9 14769.5 14781.8 14785.6 14789.2 10653.6 11293.7 11325.8 11346.7 11357.3 15592.6 16193.5 16288.1 16314.3 16316.3 6026.3 6160.2 6255.0 6265.6 6358.9 862.6 869.4 938.3 973.9 987.1 26502.0 26539.3 26815.9 27564.9 27577.3 815.0 948.8 964.4 979.9 1029.3 13049.3 13489.7 13652.5 13821.5 13895.9 263023.0 267232.0 268067.0 268511.0 270629.0 40190.6 40395.4 40428.6 40433.2 40473.0 1048.3 1180.4 1182.7 1232.3 1257.3 26641.5 27752.9 27932.3 28773.4 28775.6 38062.2 38310.8 38583.0 38651.4 38671.4 212269.0 213160.0 213289.0 213380.0 214223.0 27528.0 32576.0 33353.7 33428.0 33668.3 35997.5 36714.6 36945.8 36970.3 37481.4 31009.5 31310.5 31535.7 32844.0 34900.7 33813.5 33823.3 34018.1 34186.0 35073.1 33280.0 33944.5 34262.8 34287.7 34479.0 29944.3 30606.8 30726.7 30891.2 30950.2 23829.5 24205.3 24623.4 24785.5 24942.3 07:06:45 INFO - PROCESS | 12653 | 07:06:45 INFO - PROCESS | 12653 | [#2] jquery.html Cycles:180 Average:20062.07 Median:4856.62 stddev:45881.53 (944.7%) stddev-sans-first:45986.43 07:06:45 INFO - PROCESS | 12653 | Values: 376.9 376.9 380.4 383.8 390.6 15178.2 15918.4 16249.4 16252.1 16254.6 14412.8 16209.0 16329.1 16361.4 16371.0 4866.3 5076.6 5117.5 5117.7 5132.7 3637.9 5050.3 5543.6 5846.9 5861.6 5782.8 5794.2 5814.8 5817.2 5817.5 5690.4 5790.6 5797.2 5799.1 5805.0 3296.1 4846.9 4922.1 5104.8 5116.4 18292.6 18384.3 18450.1 19796.9 19848.0 1868.4 1886.8 2079.8 2105.5 2212.7 12122.8 12419.8 12452.7 12683.6 13092.1 1742.8 1758.9 1761.3 1790.3 1791.8 57799.0 60614.0 60660.4 60725.4 61160.0 9030.2 9035.5 9427.6 9690.9 10156.7 12934.3 13016.9 13033.4 13045.8 13061.7 6927.2 6930.2 7320.3 7480.8 7508.8 7144.5 7160.2 7231.9 7281.3 7319.9 5907.1 5984.7 5999.6 6016.8 6050.6 1621.4 1692.8 1694.9 1698.2 1706.6 802.2 899.3 903.4 929.6 932.1 16176.6 17186.1 17216.2 17401.1 17742.7 896.4 917.3 933.8 947.6 950.9 9524.8 9586.8 9728.3 9879.9 10010.5 139880.0 296282.0 297984.0 300519.0 302443.0 63029.0 67629.7 71082.0 72494.0 75049.6 860.6 958.3 986.1 988.4 989.3 13566.4 14562.6 14593.6 14648.6 15155.5 30339.4 30639.0 32192.2 33425.7 33514.0 41134.8 43835.3 43973.1 44127.0 44503.1 7508.6 7599.0 7649.0 7829.8 7882.0 10564.9 11223.4 11225.8 11514.8 11518.2 9767.3 9997.1 10114.4 10331.6 10339.3 9541.9 9953.4 10061.7 10165.0 10213.4 10250.3 10314.3 10315.6 10322.2 10636.1 7262.0 7515.0 7539.0 7579.0 7720.0 8587.0 9478.9 9611.2 9784.5 9803.2 07:06:45 INFO - PROCESS | 12653 | 07:06:45 INFO - PROCESS | 12653 | [#3] mootools.html Cycles:180 Average:5061.64 Median:5164.13 stddev:2868.88 (55.6%) stddev-sans-first:2861.62 07:06:45 INFO - PROCESS | 12653 | Values: 1118.4 1434.1 1464.8 1602.1 1778.8 6362.1 7436.5 7629.7 7647.3 7655.3 7251.2 7430.1 7436.7 7437.4 7440.1 1839.2 2178.9 2193.6 2207.2 2282.9 2289.9 2309.1 2309.5 2310.0 2313.2 2192.7 2241.2 2242.4 2243.8 2244.5 1849.7 2112.6 2175.7 2176.5 2177.3 2132.2 2148.1 2151.9 2154.1 2154.7 7469.1 7561.5 7625.2 7627.1 7631.5 4370.0 4525.6 4535.8 4537.6 4544.2 2858.5 2875.0 2958.6 2983.2 2996.1 889.3 914.4 931.8 934.5 935.5 10558.1 10627.8 10632.1 10633.4 10639.4 4188.8 4359.1 4424.1 4440.6 4450.2 9119.9 9163.2 9169.5 9173.5 9188.5 4030.8 4591.1 4694.5 4697.5 4699.7 3913.0 3950.7 3987.9 3991.0 3992.2 3511.6 3555.0 3583.8 3585.0 3650.7 1187.7 1206.0 1214.7 1217.3 1230.1 687.9 785.6 824.8 827.1 870.0 5268.6 5274.7 5284.1 5332.8 5361.7 398.9 399.4 404.6 408.1 408.8 3366.7 3390.6 3402.7 3421.7 3442.6 9279.0 9290.3 9697.0 9795.0 9823.9 9592.9 9609.8 9616.1 9702.9 9751.4 7270.9 7361.2 7453.5 7468.8 7511.3 5163.0 5165.2 5177.1 5201.2 5274.8 8997.4 9058.8 9110.4 9175.3 9190.4 8845.0 9155.5 9175.4 9179.5 9206.2 6270.3 6496.4 6503.9 6794.9 6814.2 6874.3 6911.0 6921.9 6922.1 6960.3 6202.1 6414.9 6426.6 6474.0 6481.3 6361.8 6392.9 6418.8 6483.6 6514.6 6307.2 6340.6 6347.0 6362.3 6369.3 4374.7 4424.7 4460.4 4525.1 4569.6 4431.7 4506.8 4586.4 4612.6 4658.5 07:06:45 INFO - PROCESS | 12653 | 07:06:45 INFO - PROCESS | 12653 | [#4] prototype.html Cycles:180 Average:4198.92 Median:4741.23 stddev:1210.72 (25.5%) stddev-sans-first:1178.30 07:06:45 INFO - PROCESS | 12653 | Values: 304.5 307.3 309.8 310.1 310.5 4778.5 4781.9 4832.8 4836.1 4852.2 4671.0 4710.3 4720.2 4722.6 4743.5 3577.9 3640.8 3721.8 3766.5 3805.6 3737.2 3782.9 3784.7 3784.8 3802.7 3559.7 3745.0 3745.1 3772.2 3773.1 3651.5 3742.4 3743.9 3745.4 3752.9 3310.3 3315.3 3328.7 3328.9 3332.2 4570.8 4579.9 4604.4 4606.9 4607.2 3965.5 4213.2 4244.0 4277.9 4296.8 4953.8 4954.0 4959.8 4989.4 5005.7 3533.9 3552.8 3554.3 3565.7 3572.0 5030.8 5161.9 5183.2 5197.8 5213.3 3604.0 3639.8 3641.6 3655.4 3657.1 3678.1 3691.9 3694.3 3696.6 3700.5 4208.7 4225.3 4225.8 4230.7 4235.1 4830.5 4968.0 4985.3 4994.6 5001.6 1321.2 1326.6 1329.4 1331.4 1333.0 845.5 882.4 882.6 908.6 909.3 4662.3 4665.6 4667.0 4676.1 4693.3 5456.9 5464.6 5468.6 5471.5 5483.5 4499.3 4646.9 4655.3 4672.9 4701.6 2853.3 2898.1 2898.6 2901.4 2917.0 5097.2 5105.8 5112.6 5130.7 5136.7 5036.9 5269.2 5327.0 5331.2 5534.5 4892.9 4900.6 4905.3 4925.4 4931.2 5183.4 5197.8 5205.8 5215.6 5234.9 4798.6 5092.3 5117.2 5117.7 5121.5 4830.1 4882.7 4933.4 4951.2 4970.9 3752.4 3777.2 3777.2 3792.2 3799.3 5044.9 5148.4 5169.3 5176.6 5184.4 4984.6 5013.8 5032.5 5034.0 5035.6 4994.3 5010.1 5019.5 5028.6 5047.1 4734.2 4743.6 4913.5 4977.0 4977.7 4925.0 4952.0 4953.0 4956.5 4973.2 4738.9 4934.1 4950.7 4956.6 4982.0 07:06:45 INFO - PROCESS | 12653 | 07:06:45 INFO - PROCESS | 12653 | [#5] yui.html Cycles:180 Average:13013.92 Median:47284.65 stddev:15114.13 (32.0%) stddev-sans-first:15128.16 07:06:45 INFO - PROCESS | 12653 | Values: 681.7 689.2 706.7 729.3 800.1 12183.9 12229.1 12399.6 12463.3 12469.3 11957.1 12021.6 12031.3 12035.6 12038.1 623.0 645.9 768.4 807.5 810.3 813.5 814.5 818.3 818.4 818.6 854.5 857.4 857.7 857.8 858.0 656.7 822.6 851.4 855.0 857.0 623.1 624.8 625.1 625.2 625.4 12562.6 12605.3 12620.3 12634.9 12639.4 11685.6 12064.8 12159.3 12507.2 12575.6 9659.5 9690.5 9730.3 9780.2 9806.0 3282.0 3337.1 3367.4 3375.1 3455.8 42330.2 42579.0 42629.8 42657.1 42735.8 9604.2 10024.2 10416.5 10596.7 10670.9 16723.8 16961.5 16993.4 16999.5 17003.3 6692.3 6728.8 6814.5 7025.1 7235.6 3909.0 3989.1 3999.9 4024.9 4074.3 2923.6 2985.4 2988.8 2993.1 2994.4 517.6 525.2 525.3 526.6 544.3 561.5 582.5 583.5 590.4 606.1 7915.5 7987.0 8315.1 8369.2 8406.6 513.5 564.5 568.0 579.4 592.6 3630.3 3660.5 3724.6 3814.8 3826.7 54554.5 54628.2 57063.1 57094.7 57255.4 47685.0 48379.8 48881.5 49748.3 50325.0 44992.6 45118.0 45630.9 46018.0 46884.3 7139.0 7276.6 7388.1 7586.9 7620.4 31020.5 31262.0 31350.8 31552.0 32600.5 38727.0 41769.4 42181.4 42398.8 43279.4 9748.0 9841.9 10367.7 10374.8 10389.0 7796.9 10698.7 11556.9 11574.9 11825.9 10862.4 10929.3 10966.9 10983.5 11040.3 10709.1 10804.7 11348.4 11591.4 11693.0 10722.9 10881.5 11000.1 11012.6 11124.1 9155.6 9207.4 9328.0 9545.2 9832.1 9112.3 9560.5 9643.2 9669.0 9694.7 07:06:45 INFO - PROCESS | 12653 | -------- Summary: end -------- 07:06:45 INFO - PROCESS | 12653 | 07:06:46 INFO - TEST-INFO | 12653: exit 0 07:06:46 INFO - TEST-OK | dromaeo_css | took 1117898ms 07:06:46 INFO - TEST-START | kraken 07:06:46 INFO - operating with platform_type : linux_ 07:06:46 INFO - Initialising browser for kraken test... 07:06:46 INFO - TEST-INFO | started process 12832 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRcXSzu/profile http://localhost:52481/getInfo.html) 07:06:50 INFO - PROCESS | 12832 | __metrics Screen width/height:1600/1200 07:06:50 INFO - PROCESS | 12832 | colorDepth:24 07:06:50 INFO - PROCESS | 12832 | Browser inner width/height: 1024/697 07:06:50 INFO - PROCESS | 12832 | __metrics 07:06:51 ERROR - PROCESS | 12832 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:06:52 INFO - TEST-INFO | 12832: exit 0 07:06:52 INFO - Browser initialized. 07:06:52 INFO - Running cycle 1/1 for kraken test... 07:06:52 INFO - TEST-INFO | started process 12913 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRcXSzu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:07:04 INFO - PROCESS | 12913 | RSS: Main: 156319744 07:07:04 INFO - PROCESS | 12913 | 07:07:06 INFO - PROCESS | 12913 | Cycle 1(1): loaded http://localhost:52481/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52481/tests/kraken/driver.html?testName=audio-beat-detection) 07:07:07 INFO - PROCESS | 12913 | RSS: Main: 210829312 07:07:07 INFO - PROCESS | 12913 | 07:07:10 INFO - PROCESS | 12913 | Cycle 1(1): loaded http://localhost:52481/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52481/tests/kraken/driver.html?testName=audio-dft) 07:07:11 INFO - PROCESS | 12913 | RSS: Main: 196521984 07:07:11 INFO - PROCESS | 12913 | 07:07:14 INFO - PROCESS | 12913 | Cycle 1(1): loaded http://localhost:52481/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52481/tests/kraken/driver.html?testName=audio-fft) 07:07:15 INFO - PROCESS | 12913 | RSS: Main: 266883072 07:07:15 INFO - PROCESS | 12913 | 07:07:17 INFO - PROCESS | 12913 | Cycle 1(1): loaded http://localhost:52481/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52481/tests/kraken/driver.html?testName=audio-oscillator) 07:07:17 INFO - PROCESS | 12913 | RSS: Main: 175226880 07:07:17 INFO - PROCESS | 12913 | 07:07:20 INFO - PROCESS | 12913 | Cycle 1(1): loaded http://localhost:52481/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52481/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:07:20 INFO - PROCESS | 12913 | RSS: Main: 179556352 07:07:20 INFO - PROCESS | 12913 | 07:07:23 INFO - PROCESS | 12913 | Cycle 1(1): loaded http://localhost:52481/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52481/tests/kraken/driver.html?testName=imaging-darkroom) 07:07:24 INFO - PROCESS | 12913 | RSS: Main: 216244224 07:07:24 INFO - PROCESS | 12913 | 07:07:27 INFO - PROCESS | 12913 | Cycle 1(1): loaded http://localhost:52481/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52481/tests/kraken/driver.html?testName=imaging-desaturate) 07:07:28 INFO - PROCESS | 12913 | RSS: Main: 217038848 07:07:28 INFO - PROCESS | 12913 | 07:07:31 INFO - PROCESS | 12913 | Cycle 1(1): loaded http://localhost:52481/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52481/tests/kraken/driver.html?testName=json-parse-financial) 07:07:32 INFO - PROCESS | 12913 | RSS: Main: 216764416 07:07:32 INFO - PROCESS | 12913 | 07:07:33 INFO - PROCESS | 12913 | Cycle 1(1): loaded http://localhost:52481/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52481/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:07:34 INFO - PROCESS | 12913 | RSS: Main: 203812864 07:07:34 INFO - PROCESS | 12913 | 07:07:36 INFO - PROCESS | 12913 | Cycle 1(1): loaded http://localhost:52481/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52481/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:07:36 INFO - PROCESS | 12913 | RSS: Main: 204328960 07:07:36 INFO - PROCESS | 12913 | 07:07:39 INFO - PROCESS | 12913 | Cycle 1(1): loaded http://localhost:52481/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52481/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:07:39 INFO - PROCESS | 12913 | RSS: Main: 217452544 07:07:39 INFO - PROCESS | 12913 | 07:07:42 INFO - PROCESS | 12913 | Cycle 1(1): loaded http://localhost:52481/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52481/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:07:43 INFO - PROCESS | 12913 | RSS: Main: 224583680 07:07:43 INFO - PROCESS | 12913 | 07:07:46 INFO - PROCESS | 12913 | Cycle 1(1): loaded http://localhost:52481/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52481/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:07:47 INFO - PROCESS | 12913 | RSS: Main: 219938816 07:07:47 INFO - PROCESS | 12913 | 07:07:49 INFO - PROCESS | 12913 | Cycle 1(1): loaded http://localhost:52481/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52481/tests/kraken/driver.html?testName=ai-astar) 07:07:49 INFO - PROCESS | 12913 | RSS: Main: 283746304 07:07:49 INFO - PROCESS | 12913 | 07:07:49 INFO - PROCESS | 12913 | __start_tp_report 07:07:49 INFO - PROCESS | 12913 | _x_x_mozilla_page_load 07:07:49 INFO - PROCESS | 12913 | _x_x_mozilla_page_load_details 07:07:49 INFO - PROCESS | 12913 | |i|pagename|runs| 07:07:49 INFO - PROCESS | 12913 | |0;ai-astar;114;116;111;114;115;116;103;114;113;113 07:07:49 INFO - PROCESS | 12913 | |1;audio-beat-detection;158;130;160;189;139;152;169;144;189;132 07:07:49 INFO - PROCESS | 12913 | |2;audio-dft;162;161;163;162;162;161;162;160;162;164 07:07:49 INFO - PROCESS | 12913 | |3;audio-fft;75;74;105;112;75;73;74;116;112;74 07:07:49 INFO - PROCESS | 12913 | |4;audio-oscillator;94;94;152;95;94;94;141;95;93;146 07:07:49 INFO - PROCESS | 12913 | |5;imaging-gaussian-blur;117;117;117;117;116;117;117;118;116;118 07:07:49 INFO - PROCESS | 12913 | |6;imaging-darkroom;147;145;146;146;145;145;145;146;145;145 07:07:49 INFO - PROCESS | 12913 | |7;imaging-desaturate;95;95;95;94;95;95;95;95;95;95 07:07:49 INFO - PROCESS | 12913 | |8;json-parse-financial;65;65;65;66;67;66;66;85;62;63 07:07:49 INFO - PROCESS | 12913 | |9;json-stringify-tinderbox;65;65;65;65;65;65;66;65;65;65 07:07:49 INFO - PROCESS | 12913 | |10;stanford-crypto-aes;78;77;78;79;80;81;80;80;80;79 07:07:49 INFO - PROCESS | 12913 | |11;stanford-crypto-ccm;133;134;134;132;140;131;132;142;185;134 07:07:49 INFO - PROCESS | 12913 | |12;stanford-crypto-pbkdf2;223;216;217;220;216;216;218;220;214;214 07:07:49 INFO - PROCESS | 12913 | |13;stanford-crypto-sha256-iterative;76;76;74;75;74;76;76;75;75;74 07:07:49 INFO - PROCESS | 12913 | __end_tp_report 07:07:49 INFO - PROCESS | 12913 | __start_cc_report 07:07:49 INFO - PROCESS | 12913 | _x_x_mozilla_cycle_collect,1924 07:07:49 INFO - PROCESS | 12913 | __end_cc_report 07:07:49 INFO - PROCESS | 12913 | __startTimestamp1461679669304__endTimestamp 07:07:49 INFO - PROCESS | 12913 | 07:07:49 INFO - PROCESS | 12913 | ------- Summary: start ------- 07:07:49 INFO - PROCESS | 12913 | Number of tests: 14 07:07:49 INFO - PROCESS | 12913 | 07:07:49 INFO - PROCESS | 12913 | [#0] ai-astar Cycles:10 Average:112.90 Median:114.00 stddev:3.78 (3.3%) stddev-sans-first:3.99 07:07:49 INFO - PROCESS | 12913 | Values: 114.0 116.0 111.0 114.0 115.0 116.0 103.0 114.0 113.0 113.0 07:07:49 INFO - PROCESS | 12913 | 07:07:49 INFO - PROCESS | 12913 | [#1] audio-beat-detection Cycles:10 Average:156.20 Median:159.00 stddev:21.26 (13.4%) stddev-sans-first:22.54 07:07:49 INFO - PROCESS | 12913 | Values: 158.0 130.0 160.0 189.0 139.0 152.0 169.0 144.0 189.0 132.0 07:07:49 INFO - PROCESS | 12913 | 07:07:49 INFO - PROCESS | 12913 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:1.10 (0.7%) stddev-sans-first:1.17 07:07:49 INFO - PROCESS | 12913 | Values: 162.0 161.0 163.0 162.0 162.0 161.0 162.0 160.0 162.0 164.0 07:07:49 INFO - PROCESS | 12913 | 07:07:49 INFO - PROCESS | 12913 | [#3] audio-fft Cycles:10 Average:89.00 Median:74.00 stddev:19.34 (26.1%) stddev-sans-first:19.84 07:07:49 INFO - PROCESS | 12913 | Values: 75.0 74.0 105.0 112.0 75.0 73.0 74.0 116.0 112.0 74.0 07:07:49 INFO - PROCESS | 12913 | 07:07:49 INFO - PROCESS | 12913 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:94.00 stddev:25.35 (27.0%) stddev-sans-first:26.24 07:07:49 INFO - PROCESS | 12913 | Values: 94.0 94.0 152.0 95.0 94.0 94.0 141.0 95.0 93.0 146.0 07:07:49 INFO - PROCESS | 12913 | 07:07:49 INFO - PROCESS | 12913 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 07:07:49 INFO - PROCESS | 12913 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 117.0 118.0 116.0 118.0 07:07:49 INFO - PROCESS | 12913 | 07:07:49 INFO - PROCESS | 12913 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:0.71 (0.5%) stddev-sans-first:0.50 07:07:49 INFO - PROCESS | 12913 | Values: 147.0 145.0 146.0 146.0 145.0 145.0 145.0 146.0 145.0 145.0 07:07:49 INFO - PROCESS | 12913 | 07:07:49 INFO - PROCESS | 12913 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 07:07:49 INFO - PROCESS | 12913 | Values: 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 07:07:49 INFO - PROCESS | 12913 | 07:07:49 INFO - PROCESS | 12913 | [#8] json-parse-financial Cycles:10 Average:67.00 Median:66.00 stddev:6.50 (9.8%) stddev-sans-first:6.85 07:07:49 INFO - PROCESS | 12913 | Values: 65.0 65.0 65.0 66.0 67.0 66.0 66.0 85.0 62.0 63.0 07:07:49 INFO - PROCESS | 12913 | 07:07:49 INFO - PROCESS | 12913 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 07:07:49 INFO - PROCESS | 12913 | Values: 65.0 65.0 65.0 65.0 65.0 65.0 66.0 65.0 65.0 65.0 07:07:49 INFO - PROCESS | 12913 | 07:07:49 INFO - PROCESS | 12913 | [#10] stanford-crypto-aes Cycles:10 Average:79.20 Median:80.00 stddev:1.23 (1.5%) stddev-sans-first:1.22 07:07:49 INFO - PROCESS | 12913 | Values: 78.0 77.0 78.0 79.0 80.0 81.0 80.0 80.0 80.0 79.0 07:07:49 INFO - PROCESS | 12913 | 07:07:49 INFO - PROCESS | 12913 | [#11] stanford-crypto-ccm Cycles:10 Average:139.70 Median:134.00 stddev:16.31 (12.2%) stddev-sans-first:17.12 07:07:49 INFO - PROCESS | 12913 | Values: 133.0 134.0 134.0 132.0 140.0 131.0 132.0 142.0 185.0 134.0 07:07:49 INFO - PROCESS | 12913 | 07:07:49 INFO - PROCESS | 12913 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:217.40 Median:217.50 stddev:2.88 (1.3%) stddev-sans-first:2.22 07:07:49 INFO - PROCESS | 12913 | Values: 223.0 216.0 217.0 220.0 216.0 216.0 218.0 220.0 214.0 214.0 07:07:49 INFO - PROCESS | 12913 | 07:07:49 INFO - PROCESS | 12913 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.10 Median:75.50 stddev:0.88 (1.2%) stddev-sans-first:0.87 07:07:49 INFO - PROCESS | 12913 | Values: 76.0 76.0 74.0 75.0 74.0 76.0 76.0 75.0 75.0 74.0 07:07:49 INFO - PROCESS | 12913 | -------- Summary: end -------- 07:07:49 INFO - PROCESS | 12913 | 07:07:50 INFO - TEST-INFO | 12913: exit 0 07:07:50 INFO - TEST-OK | kraken | took 63849ms 07:07:50 INFO - SUITE-END | took 1181s 07:07:50 INFO - Completed test suite (00:19:41) 07:07:50 INFO - javascript benchmark 07:07:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2588.3787890906183, 2612.7779138773203, 2662.6405435266233, 2672.799540034498, 2686.3955609987756, 4508.323751437286, 4586.15156196104, 4598.770061496924, 4627.9305810412825, 4638.536146385368, 4598.632109431246, 4631.120087183433, 4692.2257827458425, 4704.600108990731, 4712.198926182548, 4235.449391579091, 4276.422682937802, 4289.914201715964, 4348.391225228471, 4386.1008493258805, 4299.054208074219, 4351.521332653406, 4358.106588149421, 4361.869143925687, 4408.4048653431855, 4182.2890108681295, 4183.6234738873645, 4294.334378171388, 4296.720713153651, 4304.074623955865, 4285.164392943378, 4299.527052024275, 4335.7181783184, 4340.631046361063, 4361.476622805284, 4272.423222864935, 4275.337322714984, 4287.485501739811, 4305.50486694031, 4320.287152619814, 4413.271810151321, 4447.2439685253585, 4510.706804057759, 4528.388667529907, 4593.862184134481, 4990.575801056878, 4994.925076123861, 4996.475370086125, 4996.650234483587, 5033.521815427529, 4997.850064498035, 5002.549770520634, 5010.549050585429, 5020.472850350697, 5041.697498150123, 4513.368128462018, 4566.45202575693, 4660.72035677857, 4665.930011049837, 4677.391939047936, 5104.157813960729, 5119.641625086283, 5128.692278463304, 5133.717645529532, 5154.304168937146, 4905.484924082992, 4918.532739389752, 4921.729304888266, 4926.950730492721, 4966.1309270877455, 4841.782119804618, 4924.113659541317, 4983.750812459362, 5001.274815151783, 5016.147254966664, 4913.803447862117, 4920.655554111249, 4929.408470983433, 4933.235348520985, 4981.12830254704, 4855.077535268288, 4891.04624598207, 4899.2896030075435, 4904.975475122602, 4946.629002824802, 4158.355454904495, 4221.852235171754, 4222.535521092677, 4256.808443619982, 4337.240982828055, 3714.461403096536, 3720.8325625346924, 3732.720045996561, 3750.474933509311, 3773.0, 4308.1814455254025, 4311.655067594585, 4312.784360781949, 4351.934720979125, 4364.0, 4788.497207793132, 4928.063667903087, 4986.301917731521, 4988.127077761377, 5016.924746128811, 4239.660827133884, 4262.062346283813, 4264.957350426456, 4308.849190278325, 4314.115606300701, 4477.686561940633, 4482.260427029503, 4487.506374298824, 4490.797914093873, 4529.456465224194, 4576.542345765463, 4656.4412270527755, 4670.229412147026, 4737.928931065968, 4737.952620473889, 4965.950340496549, 4972.428170760264, 4989.201727723546, 4993.550580447777, 5046.697198168122, 4712.552307530779, 4716.292556116473, 4717.339572459789, 4720.527947205252, 4766.142094423037, 4740.4785473597185, 4863.416390033219, 4889.584385327144, 4932.728699921395, 4934.037862616755, 4957.231629097496, 4960.925586116284, 4981.651284410202, 4987.2768448574025, 5034.370703662043, 4669.766511674471, 4844.660873738804, 4856.368672072608, 4864.635152363516, 4903.16646170159, 4706.741129237787, 4775.808967641256, 4776.116418462596, 4815.036992601424, 4819.0, 4698.929516057194, 4727.598154156935, 4734.834280800155, 4742.549457801503, 4793.2091204952185, 4725.29120631908, 4754.310624959292, 4837.322774811459, 4874.8537543873745, 4884.389451318585, 4567.520410356865, 4685.039566888848, 4752.691075080109, 4753.168195565693, 4826.372571565674], "value": 4564.228916017436, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.9601027928044, 599.9220101386819, 621.835213668378, 623.2863371439704, 626.555145846449, 26457.338566535822, 27187.320316992085, 27192.728072719266, 27212.727872721265, 27216.72783272169, 34190.0, 34805.30389392217, 35180.2963940721, 35196.648033519654, 35763.2847343053, 7513.924860751391, 7714.6914123435, 7721.112072111723, 7735.922640773577, 7736.806579835493, 7059.823504412379, 7484.663190156456, 7653.119891212498, 7661.502002369856, 9139.543022848864, 9606.471644059575, 9784.510774461283, 9784.902150978505, 9787.070228328297, 9795.069468400527, 9529.523523823817, 9654.90345096547, 9661.999999999965, 9664.130228279488, 9677.564509597085, 9548.37935534188, 9689.806203875953, 9691.0, 9695.466749328783, 9719.125278724949, 32930.0, 33292.83353583241, 35463.0, 35476.46785298223, 35504.467432988524, 3038.103759390985, 3050.8627111780024, 3179.0462861141564, 3258.201740573551, 3376.8142752148624, 27874.0, 28256.717432825615, 28848.99028533991, 29467.0, 29634.0, 3477.2523907360037, 3492.388831954423, 3532.9116772080647, 3554.0, 3605.693516051139, 144503.0, 144848.8605797605, 145163.27418362946, 145543.0, 145717.0, 51256.743716281926, 51362.48637513577, 51499.742501287255, 51518.0, 51614.74192629088, 54067.0, 54390.72804636031, 54535.454645453035, 54665.726671367185, 54670.0, 14343.85656143446, 14769.483068092564, 14781.778273325908, 14785.556433307018, 14789.186594737394, 10653.57385704563, 11293.661190164308, 11325.773484530264, 11346.716332091599, 11357.261777984404, 15592.610184745472, 16193.514194574182, 16288.104154271628, 16314.265858036417, 16316.34734610626, 6026.3126324629175, 6160.199174107337, 6255.02725333352, 6265.592736472115, 6358.936410635927, 862.5567014402404, 869.4348673362239, 938.3337830140676, 973.9432715503616, 987.1411871671692, 26502.02801254781, 26539.33651658724, 26815.865920670272, 27564.86217568899, 27577.310567235978, 814.9877751833727, 948.7580666930027, 964.4406244378243, 979.8726165598426, 1029.2692188546216, 13049.28228947417, 13489.662758431117, 13652.49822519522, 13821.516246931511, 13895.861041389457, 263023.0, 267232.0, 268067.0, 268511.0, 270629.0, 40190.59809401927, 40395.39406908899, 40428.59571404307, 40433.19133617311, 40473.0, 1048.3395460859763, 1180.3803003423272, 1182.6806762174165, 1232.2729589542391, 1257.251935098615, 26641.46717065609, 27752.861235693694, 27932.30169245785, 28773.42453150967, 28775.5683664741, 38062.23875522529, 38310.80844595759, 38583.0, 38651.420228697156, 38671.41992870053, 212269.0, 213160.0, 213289.0, 213380.0, 214223.0, 27528.0, 32576.0, 33353.66646333603, 33428.0, 33668.32663346768, 35997.46003809893, 36714.63285367112, 36945.81527092455, 36970.26059478742, 37481.4377784328, 31009.534856976712, 31310.530342045342, 31535.684643153276, 32844.0, 34900.65099349076, 33813.49279760756, 33823.3235335287, 34018.14954626154, 34186.0, 35073.1231719209, 33280.0, 33944.490832638025, 34262.82868585641, 34287.65712342845, 34479.0, 29944.25139371533, 30606.846965765028, 30726.692733072385, 30891.2277193063, 30950.22624434407, 23829.52340953206, 24205.273841784776, 24623.38441538976, 24785.50428991446, 24942.251732448054], "value": 16543.750165816815, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.8982374758816, 376.9396896496561, 380.42175892643183, 383.7869982159902, 390.5898806253433, 15178.165200913945, 15918.442854500096, 16249.431269905555, 16252.106134162615, 16254.593635159126, 14412.783808242884, 16209.0, 16329.101899395528, 16361.427350042752, 16371.017738935643, 4866.343043689109, 5076.568491678212, 5117.462666420028, 5117.7185254810975, 5132.743362831862, 3637.927241455169, 5050.3434553508, 5543.6396634218845, 5846.912296315559, 5861.648301101926, 5782.797602083928, 5794.159846822208, 5814.796482123126, 5817.214676018725, 5817.534597232211, 5690.4025077366905, 5790.623609465413, 5797.217375654317, 5799.130130480419, 5804.984127777643, 3296.0606227225367, 4846.903061938741, 4922.114019476493, 5104.846854594368, 5116.386033675945, 18292.634147316978, 18384.264629414807, 18450.077496125276, 19796.901015494976, 19848.007599620105, 1868.4488076017608, 1886.8018808056845, 2079.792020797923, 2105.505206276524, 2212.6570381590877, 12122.757544849053, 12419.75160496785, 12452.688682782913, 12683.619491415273, 13092.149010314395, 1742.8431441170228, 1758.9472315830546, 1761.2954818072744, 1790.301782304889, 1791.7670702808682, 57799.0, 60614.0, 60660.393396066356, 60725.392746072415, 61160.0, 9030.232430243372, 9035.50304733246, 9427.62289508412, 9690.903090969141, 10156.746081347877, 12934.288614126313, 13016.852219383885, 13033.370828646419, 13045.804312935314, 13061.673458163621, 6927.203371612229, 6930.218149476845, 7320.341169294789, 7480.812979675552, 7508.812279692942, 7144.499885007999, 7160.176579693402, 7231.855362892713, 7281.344678978918, 7319.890201646979, 5907.054871220584, 5984.73068711909, 5999.5800293979, 6016.819495415145, 6050.57645964787, 1621.4487074394763, 1692.8222536633475, 1694.872884533665, 1698.2188193430914, 1706.6074802795179, 802.2418814220622, 899.3434792601438, 903.3847012897625, 929.5584597316221, 932.1424289653535, 16176.624986876248, 17186.140692965302, 17216.225269862636, 17401.129943502776, 17742.733858992124, 896.4442045931564, 917.2936838634214, 933.8179055084194, 947.6020071569957, 950.8858936927475, 9524.761880953032, 9586.849578050678, 9728.270379721549, 9879.851802222973, 10010.498425236126, 139880.0, 296282.0, 297984.0, 300519.0, 302443.0, 63029.0, 67629.66185169043, 71082.0, 72494.0, 75049.62475187589, 860.5568132411938, 958.2908647600725, 986.0878687214298, 988.3723835364451, 989.2580564576567, 13566.38951247216, 14562.563123106323, 14593.562193134223, 14648.560543183721, 15155.469558565397, 30339.393212136074, 30639.0, 32192.19519512031, 33425.66574334226, 33514.0, 41134.794326028175, 43835.34246986234, 43973.12053758843, 44127.0, 44503.10993780171, 7508.587027713528, 7599.0, 7648.961755191189, 7829.846792132209, 7882.0, 10564.894351056391, 11223.38271395081, 11225.831612525983, 11514.827277590675, 11518.193726439069, 9767.316287860065, 9997.100260976547, 10114.393136411838, 10331.586736530455, 10339.327943683636, 9541.856872146784, 9953.402795832273, 10061.748456288651, 10165.0, 10213.438260895722, 10250.282480226313, 10314.329568578018, 10315.587376504856, 10322.225833062701, 10636.14910807118, 7262.0, 7514.9624251878395, 7539.0, 7578.962105189439, 7720.0, 8587.0, 9478.905210947802, 9611.183049440875, 9784.461854598065, 9803.215742740422], "value": 8063.3225638430395, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1118.3792994887833, 1434.0678558936693, 1464.7509923313037, 1602.1428535733378, 1778.79543852457, 6362.141110950026, 7436.479446438745, 7629.732959346424, 7647.273509016649, 7655.311022008012, 7251.166115896674, 7430.108386993568, 7436.739714110007, 7437.4421918356065, 7440.069991251094, 1839.2183322088126, 2178.8692678439265, 2193.6051510728144, 2207.194374053467, 2282.8858557072163, 2289.919852805152, 2309.1340747219792, 2309.4919117794143, 2310.0297874892585, 2313.1672597864754, 2192.6601376786625, 2241.1707668162803, 2242.372135801978, 2243.798058174764, 2244.517428752818, 1849.657813304543, 2112.588045331161, 2175.695402643631, 2176.4667656424117, 2177.314146044007, 2132.2004248406847, 2148.0655914677163, 2151.8924053797405, 2154.05221702452, 2154.741431028271, 7469.1410487794055, 7561.508501947411, 7625.199354067854, 7627.122880868716, 7631.465797394185, 4369.956300437018, 4525.637948964075, 4535.841245556423, 4537.591616754475, 4544.227481328182, 2858.4997625415676, 2874.956875646867, 2958.6449626044796, 2983.1796256029547, 2996.071217922451, 889.297455010541, 914.419343716738, 931.7624005878457, 934.5280633280217, 935.5415846235296, 10558.102561282378, 10627.84058239127, 10632.096271816905, 10633.36199828005, 10639.414832184228, 4188.790560471964, 4359.128174365076, 4424.11517696462, 4440.622547083534, 4450.198964186413, 9119.863202051974, 9163.16736652672, 9169.541522923828, 9173.541322933826, 9188.540572971458, 4030.8186131624147, 4591.104734576792, 4694.460137084279, 4697.506761790031, 4699.671023028423, 3912.9608703912595, 3950.7036972227197, 3987.8803635890968, 3991.0, 3992.2414741199077, 3511.5786105667485, 3554.9822250889097, 3583.8387272572795, 3585.0, 3650.653187947141, 1187.703074231442, 1206.0291465370285, 1214.690253985228, 1217.3487184356327, 1230.0651504856373, 687.9208890977502, 785.6071964017991, 824.8181718686322, 827.1356432527903, 870.0125357719035, 5268.552173065333, 5274.657147285414, 5284.128118860345, 5332.840014799563, 5361.705106219118, 398.8962869653853, 399.41884557968086, 404.5650925255362, 408.1082834007703, 408.7976451656449, 3366.7206461544456, 3390.5761779777526, 3402.7107695845634, 3421.6578342165585, 3442.5868895732674, 9278.95360523193, 9290.256779457628, 9696.95151524238, 9795.0, 9823.901760982299, 9592.904070959341, 9609.807803843883, 9616.08647178517, 9702.854457183148, 9751.3661611995, 7270.927290727025, 7361.159710072482, 7453.515521491086, 7468.804991201382, 7511.286427789242, 5163.044836705071, 5165.21756372246, 5177.0940085484135, 5201.245819356096, 5274.7890084396195, 8997.415168014059, 9058.773530661787, 9110.407823491452, 9175.31185161129, 9190.35667503295, 8845.0, 9155.542222888962, 9175.403598766059, 9179.495127768037, 9206.217471514996, 6270.278917924315, 6496.447801936888, 6503.869922601616, 6794.8641027180165, 6814.182298124257, 6874.312568743286, 6910.965445172742, 6921.930780692129, 6922.06552115458, 6960.269171736894, 6202.131701561695, 6414.871702565829, 6426.61440313564, 6473.9676301620075, 6481.254655714653, 6361.840953976188, 6392.9360706392345, 6418.807435776934, 6483.610983341015, 6514.609123452608, 6307.180066591313, 6340.587861788969, 6347.0, 6362.300146983735, 6369.267534233622, 4374.715643483163, 4424.7123936944, 4460.3755474234285, 4525.094981003746, 4569.565891240327, 4431.689781715249, 4506.774661266858, 4586.449626044896, 4612.60792832613, 4658.510856360033], "value": 4009.321727339092, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.5219006160328, 307.2518417653015, 309.82649716158943, 310.0945239899495, 310.4582503531338, 4778.5460381263765, 4781.928271075928, 4832.758362081895, 4836.105320515702, 4852.199387101124, 4671.0, 4710.3405523226775, 4720.1739695553315, 4722.574968252857, 4743.5256474352545, 3577.910552236189, 3640.8179591020476, 3721.758085724433, 3766.491523644314, 3805.6194380562, 3737.159139193673, 3782.8865134046023, 3784.6593806557403, 3784.8486060557543, 3802.6577608015273, 3559.661832125944, 3745.0, 3745.0824547985644, 3772.2078363543687, 3773.0755964788664, 3651.543557055368, 3742.401215805458, 3743.9142648632, 3745.3969491203625, 3752.887413377603, 3310.2717402171484, 3315.3037862049, 3328.6671332866763, 3328.900132996014, 3332.166958260435, 4570.817167313304, 4579.893249105416, 4604.401427814396, 4606.861794146181, 4607.239805432133, 3965.524137103566, 4213.157368526307, 4243.97878010611, 4277.914441711179, 4296.8281268749215, 4953.752312384367, 4953.950460495421, 4959.752012399402, 4989.376327959005, 5005.724685142316, 3533.9293214135832, 3552.8401221945073, 3554.306910152521, 3565.6790888820133, 3571.964280357215, 5030.773615187289, 5161.948380516184, 5183.248428977852, 5197.766100525486, 5213.2701421800975, 3604.0269127335473, 3639.763415378045, 3641.6358364163902, 3655.3603119453987, 3657.122290650225, 3678.1172518595345, 3691.9446208306895, 3694.2796154750104, 3696.5748938872375, 3700.4634328022285, 4208.6633069354375, 4225.345071513921, 4225.767582782915, 4230.661547076226, 4235.110626768352, 4830.4640063966, 4968.0, 4985.252212168204, 4994.550490455877, 5001.624878134155, 1321.167664371459, 1326.6285440076795, 1329.3884812986134, 1331.4407948661585, 1332.9533466328633, 845.4969293270494, 882.4087861133056, 882.5807741322949, 908.56842999576, 909.3043821476575, 4662.347271382009, 4665.580097791215, 4667.0, 4676.134915040729, 4693.296005599119, 5456.863578410572, 5464.617476776667, 5468.562514998791, 5471.480209380103, 5483.506484416422, 4499.280115181621, 4646.930296045562, 4655.301704744248, 4672.929906051412, 4701.623870090384, 2853.2866783304175, 2898.130560831742, 2898.5797059426263, 2901.361700425945, 2917.0373776653655, 5097.209932460474, 5105.846824595268, 5112.616553758483, 5130.692158470503, 5136.717480538531, 5036.924446133311, 5269.209618557247, 5327.016870552503, 5331.173668081454, 5534.4742249486235, 4892.902141957141, 4900.558949694545, 4905.264210368473, 4925.408950925912, 4931.161702510653, 5183.352080989876, 5197.7661005254095, 5205.791768329376, 5215.634905556574, 5234.869128271824, 4798.640101992434, 5092.287079808903, 5117.2068329409, 5117.667351622133, 5121.462246464068, 4830.106430310404, 4882.658213924991, 4933.407991041098, 4951.207806750903, 4970.850874473772, 3752.399616061417, 3777.2067865747404, 3777.244551089848, 3792.1657235408165, 3799.271331544196, 5044.949550504448, 5148.3564554430695, 5169.250458683545, 5176.585873130216, 5184.351956005499, 4984.601231901512, 5013.774380152975, 5032.547070763502, 5033.974830125972, 5035.597152227886, 4994.2508623706735, 5010.098182327216, 5019.52314530119, 5028.572571331478, 5047.082108798633, 4734.19518681818, 4743.644226682944, 4913.533214344631, 4977.0, 4977.676451030671, 4925.014997000542, 4951.9752401237765, 4952.9846381492425, 4956.529129732669, 4973.154563724103, 4738.928916066331, 4934.136526107988, 4950.727709975986, 4956.578690811321, 4981.975090124526], "value": 3820.2795916658397, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [681.6864242448473, 689.2177378675202, 706.6713978000225, 729.3435907683087, 800.0719165767711, 12183.878161218385, 12229.143959922809, 12399.628011159679, 12463.252204867704, 12469.314187719672, 11957.103217258697, 12021.579244726436, 12031.278123312608, 12035.578754743587, 12038.097142714289, 622.9875402491947, 645.8901986662279, 768.3852917665873, 807.5477732469835, 810.2950433123191, 813.4875028731891, 814.5031530766228, 818.3207937411963, 818.4352796570347, 818.607068607069, 854.478767951549, 857.3526987124712, 857.7169534053778, 857.7812657772259, 857.9742607721778, 656.6946369937978, 822.6380392627254, 851.43379652531, 855.0338117926765, 856.9871451928163, 623.0965100604097, 624.7625902157197, 625.1092193624067, 625.1903784598956, 625.4277336237337, 12562.560310389092, 12605.30670813105, 12620.305883176421, 12634.873651263462, 12639.368031598384, 11685.591004314892, 12064.819027714591, 12159.331236781973, 12507.249565026037, 12575.559855405108, 9659.517024148834, 9690.51547422626, 9730.318877678565, 9780.217582593375, 9805.950970245103, 3281.950770738441, 3337.1156643489494, 3367.4275373186615, 3375.122468158272, 3455.775374600643, 42330.15339693189, 42579.0, 42629.78685106586, 42657.14685706268, 42735.78632106851, 9604.183644390165, 10024.248181386425, 10416.479176041168, 10596.682099537025, 10670.946645266724, 16723.83276167247, 16961.49115526536, 16993.40523081686, 16999.49001529956, 17003.31986720542, 6692.330766923269, 6728.764493242811, 6814.522983391214, 7025.121859767529, 7235.565866048054, 3909.0, 3989.1423343981182, 3999.900002499961, 4024.899377515527, 4074.3481043033566, 2923.5760814682176, 2985.4178435204926, 2988.790784645054, 2993.1020693791775, 2994.386150839073, 517.5549027836058, 525.1833399064415, 525.2961032216848, 526.5761062344849, 544.2516539757833, 561.53673219594, 582.472862059828, 583.4880837992398, 590.3624085987124, 606.1120458528189, 7915.485493442908, 7987.041555013436, 8315.126911674188, 8369.246767790806, 8406.579671016547, 513.5224241455408, 564.5398999815137, 567.9829605111853, 579.3858509979351, 592.6088781404253, 3630.3465376232, 3660.4875317455576, 3724.646158614927, 3814.8474061037805, 3826.674732647756, 54554.45445545573, 54628.18057729137, 57063.14405283924, 57094.7145264271, 57255.42744572584, 47685.0, 48379.758101209976, 48881.5111848877, 49748.253776193385, 50325.0, 44992.55007449949, 45118.0, 45630.859228518886, 46018.0, 46884.296735549, 7139.0, 7276.599787011553, 7388.076490438695, 7586.924130758843, 7620.3522700571075, 31020.53469197919, 31262.0, 31350.843245783624, 31552.0, 32600.51099233466, 38727.0, 41769.37345939874, 42181.367279490216, 42398.788006061004, 43279.350809738506, 9747.951260243653, 9841.85237221428, 10367.688969330931, 10374.792504150026, 10389.0, 7796.876330303027, 10698.73253168677, 11556.94221528887, 11574.88425115738, 11825.881741182822, 10862.402567858844, 10929.289596176222, 10966.890331096587, 10983.505742241778, 11040.282381645167, 10709.143268538654, 10804.67585972422, 11348.375839328915, 11591.420428978687, 11693.006094481723, 10722.892771072502, 10881.510332035235, 11000.119990400908, 11012.559497620005, 11124.110071194124, 9155.587998540215, 9207.377866400797, 9328.0, 9545.236381089635, 9832.065953734384, 9112.29305565944, 9560.474173920224, 9643.228541716506, 9669.0, 9694.660686875926], "value": 5942.960140251682, "unit": "score"}], "name": "dromaeo_css", "value": 6174.788726124515, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 116.0, 111.0, 114.0, 115.0, 116.0, 103.0, 114.0, 113.0, 113.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 130.0, 160.0, 189.0, 139.0, 152.0, 169.0, 144.0, 189.0, 132.0], "value": 156.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 163.0, 162.0, 162.0, 161.0, 162.0, 160.0, 162.0, 164.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 105.0, 112.0, 75.0, 73.0, 74.0, 116.0, 112.0, 74.0], "value": 89.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 152.0, 95.0, 94.0, 94.0, 141.0, 95.0, 93.0, 146.0], "value": 109.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 118.0, 116.0, 118.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 145.0, 146.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 66.0, 67.0, 66.0, 66.0, 85.0, 62.0, 63.0], "value": 67.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 66.0, 65.0, 65.0, 65.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 78.0, 79.0, 80.0, 81.0, 80.0, 80.0, 80.0, 79.0], "value": 79.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 134.0, 134.0, 132.0, 140.0, 131.0, 132.0, 142.0, 185.0, 134.0], "value": 139.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [223.0, 216.0, 217.0, 220.0, 216.0, 216.0, 218.0, 220.0, 214.0, 214.0], "value": 217.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 74.0, 75.0, 74.0, 76.0, 76.0, 75.0, 75.0, 74.0], "value": 75.1, "unit": "score"}], "name": "kraken", "value": 1630.6999999999998, "alertThreshold": 2.0}]} 07:07:50 INFO - Return code: 0 07:07:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:07:50 ERROR - # TBPL SUCCESS # 07:07:50 INFO - Running post-action listener: _resource_record_post_action 07:07:50 INFO - Running post-run listener: _resource_record_post_run 07:07:51 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 519528448; Read time: 8; Write time: 421204 07:07:51 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 241401856; Read time: 0; Write time: 265416 07:07:51 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 278126592; Read time: 8; Write time: 155788 07:07:51 INFO - Running post-run listener: _upload_blobber_files 07:07:51 INFO - Blob upload gear active. 07:07:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:07:51 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:07:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:07:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:07:52 INFO - (blobuploader) - INFO - Open directory for files ... 07:07:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:07:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:07:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:07:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:07:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:07:52 INFO - (blobuploader) - INFO - Done attempting. 07:07:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:07:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:07:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:07:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:07:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:07:53 INFO - (blobuploader) - INFO - Done attempting. 07:07:53 INFO - (blobuploader) - INFO - Iteration through files over. 07:07:53 INFO - Return code: 0 07:07:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:07:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:07:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0ecd3c557b6b30b8ac7b800edeaa064ca2a2c5a58141c2ef364c49a5e4b82e1cb32eb4ccc2f171235e340b7c222463aabda8cb1a85693e16b41404dda6991484", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/feeab7c1201cacbd5ea82f2e90e58638a6b2d53873f2975d5d8f16132ebe143b9ed4018517780ec55fb198fc7c47dfe9395fa6017c9e2048ce9bc117b1c22468"} 07:07:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:07:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:07:53 INFO - Contents: 07:07:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0ecd3c557b6b30b8ac7b800edeaa064ca2a2c5a58141c2ef364c49a5e4b82e1cb32eb4ccc2f171235e340b7c222463aabda8cb1a85693e16b41404dda6991484", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/feeab7c1201cacbd5ea82f2e90e58638a6b2d53873f2975d5d8f16132ebe143b9ed4018517780ec55fb198fc7c47dfe9395fa6017c9e2048ce9bc117b1c22468"} 07:07:53 INFO - Running post-run listener: copy_logs_to_upload_dir 07:07:53 INFO - Copying logs to upload dir... 07:07:53 INFO - mkdir: /builds/slave/test/build/upload/logs 07:07:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.526491 ========= master_lag: 54.30 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 30 secs) (at 2016-04-26 07:08:47.767202) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-04-26 07:08:47.770385) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1461678429.306690-184393022 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0ecd3c557b6b30b8ac7b800edeaa064ca2a2c5a58141c2ef364c49a5e4b82e1cb32eb4ccc2f171235e340b7c222463aabda8cb1a85693e16b41404dda6991484", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/feeab7c1201cacbd5ea82f2e90e58638a6b2d53873f2975d5d8f16132ebe143b9ed4018517780ec55fb198fc7c47dfe9395fa6017c9e2048ce9bc117b1c22468"} build_url:https://queue.taskcluster.net/v1/task/Dh-grJbYROamKTgWrzvbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011344 build_url: 'https://queue.taskcluster.net/v1/task/Dh-grJbYROamKTgWrzvbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0ecd3c557b6b30b8ac7b800edeaa064ca2a2c5a58141c2ef364c49a5e4b82e1cb32eb4ccc2f171235e340b7c222463aabda8cb1a85693e16b41404dda6991484", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/feeab7c1201cacbd5ea82f2e90e58638a6b2d53873f2975d5d8f16132ebe143b9ed4018517780ec55fb198fc7c47dfe9395fa6017c9e2048ce9bc117b1c22468"}' ========= master_lag: 1.26 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-04-26 07:08:49.041407) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 07:08:49.041737) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1461678429.306690-184393022 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004504 ========= master_lag: 0.43 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 07:08:49.480452) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-26 07:08:49.480767) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-26 07:08:49.481710) ========= ========= Total master_lag: 56.05 =========