builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-037 starttime: 1467730840.12 results: success (0) buildid: 20160705051322 builduid: 82e7e35386c54f4c86a7fa367438f1d7 revision: 1c9185a7df828f0065c20d34b7eda15aa2628883 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 08:00:40.116486) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 08:00:40.116971) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 08:00:40.117265) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 08:00:40.132913) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 08:00:40.133445) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1467730839.977496-2122453807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-05 08:00:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 70.3M=0s 2016-07-05 08:00:40 (70.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.127992 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 08:00:40.278752) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 08:00:40.279383) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1467730839.977496-2122453807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017258 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 08:00:40.332152) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 08:00:40.332780) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 1c9185a7df828f0065c20d34b7eda15aa2628883 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 1c9185a7df828f0065c20d34b7eda15aa2628883 --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=56c518bb7cbc29fb3c9463e2000001c4-1467730839.977496-2122453807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-05 08:00:40,926 truncating revision to first 12 chars 2016-07-05 08:00:40,926 Setting DEBUG logging. 2016-07-05 08:00:40,926 attempt 1/10 2016-07-05 08:00:40,927 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/1c9185a7df82?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-05 08:00:41,299 unpacking tar archive at: mozilla-beta-1c9185a7df82/testing/mozharness/ program finished with exit code 0 elapsedTime=0.703035 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 08:00:41.050554) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 08:00:41.050905) ========= script_repo_revision: 1c9185a7df828f0065c20d34b7eda15aa2628883 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 08:00:41.051355) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 08:00:41.051641) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 08:00:41.063099) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 21 secs) (at 2016-07-05 08:00:41.063523) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=56c518bb7cbc29fb3c9463e2000001c4-1467730839.977496-2122453807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:00:41 INFO - MultiFileLogger online at 20160705 08:00:41 in /builds/slave/test 08:00:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 08:00:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:00:41 INFO - {'append_to_log': False, 08:00:41 INFO - 'base_work_dir': '/builds/slave/test', 08:00:41 INFO - 'blob_upload_branch': 'Mozilla-Beta', 08:00:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:00:41 INFO - 'branch': 'Mozilla-Beta', 08:00:41 INFO - 'buildbot_json_path': 'buildprops.json', 08:00:41 INFO - 'config_files': ('talos/linux_config.py',), 08:00:41 INFO - 'default_actions': ('clobber', 08:00:41 INFO - 'read-buildbot-config', 08:00:41 INFO - 'download-and-extract', 08:00:41 INFO - 'populate-webroot', 08:00:41 INFO - 'create-virtualenv', 08:00:41 INFO - 'install', 08:00:41 INFO - 'run-tests'), 08:00:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:00:41 INFO - 'download_minidump_stackwalk': True, 08:00:41 INFO - 'download_symbols': 'ondemand', 08:00:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:00:41 INFO - 'tooltool.py': '/tools/tooltool.py', 08:00:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:00:41 INFO - '/tools/misc-python/virtualenv.py')}, 08:00:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:00:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:00:41 INFO - 'installer_path': 'installer.exe', 08:00:41 INFO - 'log_level': 'info', 08:00:41 INFO - 'log_name': 'talos', 08:00:41 INFO - 'log_to_console': True, 08:00:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:00:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:00:41 INFO - 'opt_config_files': (), 08:00:41 INFO - 'pip_index': False, 08:00:41 INFO - 'sps_profile': False, 08:00:41 INFO - 'sps_profile_interval': 0, 08:00:41 INFO - 'suite': 'dromaeojs', 08:00:41 INFO - 'system_bits': '32', 08:00:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:00:41 INFO - 'title': 'talos-linux64-ix-037', 08:00:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:00:41 INFO - 'use_talos_json': True, 08:00:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:00:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:00:41 INFO - 'work_dir': 'build'} 08:00:41 INFO - ##### 08:00:41 INFO - ##### Running clobber step. 08:00:41 INFO - ##### 08:00:41 INFO - Running pre-action listener: _resource_record_pre_action 08:00:41 INFO - Running main action method: clobber 08:00:41 INFO - rmtree: /builds/slave/test/build 08:00:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:00:42 INFO - Running post-action listener: _resource_record_post_action 08:00:42 INFO - ##### 08:00:42 INFO - ##### Running read-buildbot-config step. 08:00:42 INFO - ##### 08:00:42 INFO - Running pre-action listener: _resource_record_pre_action 08:00:42 INFO - Running main action method: read_buildbot_config 08:00:42 INFO - Using buildbot properties: 08:00:42 INFO - { 08:00:42 INFO - "project": "", 08:00:42 INFO - "product": "firefox", 08:00:42 INFO - "script_repo_revision": "production", 08:00:42 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 08:00:42 INFO - "repository": "", 08:00:42 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 08:00:42 INFO - "buildid": "20160705051322", 08:00:42 INFO - "pgo_build": "True", 08:00:42 INFO - "basedir": "/builds/slave/test", 08:00:42 INFO - "buildnumber": 153, 08:00:42 INFO - "slavename": "talos-linux64-ix-037", 08:00:42 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:00:42 INFO - "platform": "ubuntu64_hw", 08:00:42 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 08:00:42 INFO - "branch": "mozilla-beta", 08:00:42 INFO - "repo_path": "releases/mozilla-beta", 08:00:42 INFO - "revision": "1c9185a7df828f0065c20d34b7eda15aa2628883", 08:00:42 INFO - "stage_platform": "linux64-pgo", 08:00:42 INFO - "builduid": "82e7e35386c54f4c86a7fa367438f1d7", 08:00:42 INFO - "slavebuilddir": "test" 08:00:42 INFO - } 08:00:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/CEdvWcnOT521k4-Ht_ZcnA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 08:00:42 INFO - Running post-action listener: _resource_record_post_action 08:00:42 INFO - ##### 08:00:42 INFO - ##### Running download-and-extract step. 08:00:42 INFO - ##### 08:00:42 INFO - Running pre-action listener: _resource_record_pre_action 08:00:42 INFO - Running main action method: download_and_extract 08:00:42 INFO - mkdir: /builds/slave/test/build/tests 08:00:42 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')]} 08:00:42 INFO - https://queue.taskcluster.net/v1/task/CEdvWcnOT521k4-Ht_ZcnA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:00:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CEdvWcnOT521k4-Ht_ZcnA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 08:00:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CEdvWcnOT521k4-Ht_ZcnA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 08:00:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CEdvWcnOT521k4-Ht_ZcnA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 08:00:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CEdvWcnOT521k4-Ht_ZcnA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:00:42 INFO - Downloaded 1327 bytes. 08:00:42 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 08:00:42 INFO - Using the following test package requirements: 08:00:42 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 08:00:42 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:00:42 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 08:00:42 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:00:42 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 08:00:42 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:00:42 INFO - u'jsshell-linux-x86_64.zip'], 08:00:42 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:00:42 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 08:00:42 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 08:00:42 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:00:42 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 08:00:42 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:00:42 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 08:00:42 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:00:42 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 08:00:42 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:00:42 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 08:00:42 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:00:42 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')]} 08:00:42 INFO - https://queue.taskcluster.net/v1/task/CEdvWcnOT521k4-Ht_ZcnA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:00:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CEdvWcnOT521k4-Ht_ZcnA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 08:00:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CEdvWcnOT521k4-Ht_ZcnA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 08:00:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CEdvWcnOT521k4-Ht_ZcnA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 08:00:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CEdvWcnOT521k4-Ht_ZcnA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:00:44 INFO - Downloaded 24235664 bytes. 08:00:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:00:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:00:45 INFO - Return code: 0 08:00:45 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:00: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')]} 08:00:45 INFO - https://queue.taskcluster.net/v1/task/CEdvWcnOT521k4-Ht_ZcnA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:00:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CEdvWcnOT521k4-Ht_ZcnA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 08:00:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CEdvWcnOT521k4-Ht_ZcnA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 08:00:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CEdvWcnOT521k4-Ht_ZcnA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 08:00:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CEdvWcnOT521k4-Ht_ZcnA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:00:46 INFO - Downloaded 24235664 bytes. 08:00:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:00:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:00:48 INFO - Return code: 0 08:00: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')]} 08:00:48 INFO - https://queue.taskcluster.net/v1/task/CEdvWcnOT521k4-Ht_ZcnA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:00:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CEdvWcnOT521k4-Ht_ZcnA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 08:00:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CEdvWcnOT521k4-Ht_ZcnA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 08:00:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CEdvWcnOT521k4-Ht_ZcnA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 08:00:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CEdvWcnOT521k4-Ht_ZcnA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:00:49 INFO - Downloaded 10840145 bytes. 08:00:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:00:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:00:49 INFO - Return code: 0 08:00:49 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')]} 08:00:49 INFO - https://queue.taskcluster.net/v1/task/CEdvWcnOT521k4-Ht_ZcnA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:00:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CEdvWcnOT521k4-Ht_ZcnA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 08:00:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CEdvWcnOT521k4-Ht_ZcnA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 08:00:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CEdvWcnOT521k4-Ht_ZcnA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 08:00:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CEdvWcnOT521k4-Ht_ZcnA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:00:50 INFO - Downloaded 56034414 bytes. 08:00:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CEdvWcnOT521k4-Ht_ZcnA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 08:00:50 INFO - mkdir: /builds/slave/test/properties 08:00:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:00:50 INFO - Writing to file /builds/slave/test/properties/build_url 08:00:50 INFO - Contents: 08:00:50 INFO - build_url:https://queue.taskcluster.net/v1/task/CEdvWcnOT521k4-Ht_ZcnA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 08:00:51 INFO - Running post-action listener: _resource_record_post_action 08:00:51 INFO - Running post-action listener: set_extra_try_arguments 08:00:51 INFO - ##### 08:00:51 INFO - ##### Running populate-webroot step. 08:00:51 INFO - ##### 08:00:51 INFO - Running pre-action listener: _resource_record_pre_action 08:00:51 INFO - Running main action method: populate_webroot 08:00:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:00:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:00:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:00:51 INFO - '--tppagecycles', 08:00:51 INFO - '7'], 08:00:51 INFO - 'tests': ['tsvgm']}}, 08:00:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:00:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:00:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:00:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:00:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:00:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:00:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:51 INFO - 'talos_options': ['--disable-e10s'], 08:00:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:00:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:00:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:51 INFO - 'talos_options': ['--disable-e10s'], 08:00:51 INFO - 'tests': ['damp', 'tps']}, 08:00:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:51 INFO - 'tests': ['damp', 'tps']}, 08:00:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:00:51 INFO - 'tests': ['dromaeo_dom']}, 08:00:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:00:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:00:51 INFO - 'tests': ['a11yr', 08:00:51 INFO - 'ts_paint', 08:00:51 INFO - 'tpaint', 08:00:51 INFO - 'sessionrestore', 08:00:51 INFO - 'sessionrestore_no_auto_restore', 08:00:51 INFO - 'tabpaint']}, 08:00:51 INFO - 'other-e10s': {'tests': ['a11yr', 08:00:51 INFO - 'ts_paint', 08:00:51 INFO - 'tpaint', 08:00:51 INFO - 'sessionrestore', 08:00:51 INFO - 'sessionrestore_no_auto_restore', 08:00:51 INFO - 'tabpaint']}, 08:00:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:00:51 INFO - 'ts_paint', 08:00:51 INFO - 'tpaint', 08:00:51 INFO - 'sessionrestore', 08:00:51 INFO - 'sessionrestore_no_auto_restore', 08:00:51 INFO - 'tabpaint']}, 08:00:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:00:51 INFO - 'ts_paint', 08:00:51 INFO - 'tpaint', 08:00:51 INFO - 'sessionrestore', 08:00:51 INFO - 'sessionrestore_no_auto_restore', 08:00:51 INFO - 'tabpaint']}, 08:00:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:00:51 INFO - 'tests': ['a11yr', 08:00:51 INFO - 'ts_paint', 08:00:51 INFO - 'tpaint', 08:00:51 INFO - 'sessionrestore', 08:00:51 INFO - 'sessionrestore_no_auto_restore', 08:00:51 INFO - 'tabpaint']}, 08:00:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:00:51 INFO - 'tests': ['a11yr', 08:00:51 INFO - 'ts_paint', 08:00:51 INFO - 'tpaint', 08:00:51 INFO - 'sessionrestore', 08:00:51 INFO - 'sessionrestore_no_auto_restore', 08:00:51 INFO - 'tabpaint']}, 08:00:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:00:51 INFO - 'tests': ['tsvgx', 08:00:51 INFO - 'tsvgr_opacity', 08:00:51 INFO - 'tart', 08:00:51 INFO - 'tscrollx', 08:00:51 INFO - 'cart']}, 08:00:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:00:51 INFO - 'tsvgr_opacity', 08:00:51 INFO - 'tart', 08:00:51 INFO - 'tscrollx', 08:00:51 INFO - 'cart']}, 08:00:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:51 INFO - 'talos_options': ['--disable-e10s'], 08:00:51 INFO - 'tests': ['tp5o']}, 08:00:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:51 INFO - 'tests': ['tp5o']}, 08:00:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:51 INFO - 'talos_options': ['--disable-e10s', 08:00:51 INFO - '--xperf_path', 08:00:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:00:51 INFO - 'tests': ['tp5n']}, 08:00:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:51 INFO - 'talos_options': ['--xperf_path', 08:00:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:00:51 INFO - 'tests': ['tp5n']}}, 08:00:51 INFO - 'talos.zip': {'path': '', 08:00:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:00:51 INFO - Running post-action listener: _resource_record_post_action 08:00:51 INFO - ##### 08:00:51 INFO - ##### Running create-virtualenv step. 08:00:51 INFO - ##### 08:00:51 INFO - Running pre-action listener: _resource_record_pre_action 08:00:51 INFO - Running main action method: create_virtualenv 08:00:51 INFO - Creating virtualenv /builds/slave/test/build/venv 08:00:51 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 08:00:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:00:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:00:51 INFO - Using real prefix '/usr' 08:00:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:00:52 INFO - Installing distribute.............................................................................................................................................................................................done. 08:00:53 INFO - Installing pip.................done. 08:00:54 INFO - Return code: 0 08:00:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:00:54 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')]} 08:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:54 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')]} 08:00:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:54 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 0x7ff940347f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4c410>, '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 0x1c4d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4d7a0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1467730839.977496-2122453807', '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 08:00:54 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 08:00:54 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 08:00:54 INFO - Using env: {'DISPLAY': ':0', 08:00:54 INFO - 'HOME': '/home/cltbld', 08:00:54 INFO - 'LANG': 'en_US.UTF-8', 08:00:54 INFO - 'LANGUAGE': 'en_US:en', 08:00:54 INFO - 'LOGNAME': 'cltbld', 08:00:54 INFO - 'MAIL': '/var/mail/cltbld', 08:00:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:54 INFO - 'MOZ_NO_REMOTE': '1', 08:00:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:54 INFO - 'NO_EM_RESTART': '1', 08:00:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:54 INFO - 'PWD': '/builds/slave/test', 08:00:54 INFO - 'SHELL': '/bin/bash', 08:00:54 INFO - 'SHLVL': '1', 08:00:54 INFO - 'TERM': 'linux', 08:00:54 INFO - 'TMOUT': '86400', 08:00:54 INFO - 'USER': 'cltbld', 08:00:54 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1467730839.977496-2122453807', 08:00:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:54 INFO - '_': '/tools/buildbot/bin/python'} 08:00:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:54 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 08:00:54 INFO - Cleaning up... 08:00:54 INFO - Return code: 0 08:00:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:00:54 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')]} 08:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:54 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')]} 08:00:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:54 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 0x7ff940347f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4c410>, '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 0x1c4d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4d7a0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1467730839.977496-2122453807', '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 08:00:54 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 08:00:54 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 08:00:54 INFO - Using env: {'DISPLAY': ':0', 08:00:54 INFO - 'HOME': '/home/cltbld', 08:00:54 INFO - 'LANG': 'en_US.UTF-8', 08:00:54 INFO - 'LANGUAGE': 'en_US:en', 08:00:54 INFO - 'LOGNAME': 'cltbld', 08:00:54 INFO - 'MAIL': '/var/mail/cltbld', 08:00:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:54 INFO - 'MOZ_NO_REMOTE': '1', 08:00:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:54 INFO - 'NO_EM_RESTART': '1', 08:00:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:54 INFO - 'PWD': '/builds/slave/test', 08:00:54 INFO - 'SHELL': '/bin/bash', 08:00:54 INFO - 'SHLVL': '1', 08:00:54 INFO - 'TERM': 'linux', 08:00:54 INFO - 'TMOUT': '86400', 08:00:54 INFO - 'USER': 'cltbld', 08:00:54 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1467730839.977496-2122453807', 08:00:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:54 INFO - '_': '/tools/buildbot/bin/python'} 08:00:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:54 INFO - Downloading/unpacking psutil>=0.7.1 08:00:54 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 08:00:54 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 08:00:54 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 08:00:54 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 08:00:54 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 08:00:54 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 08:00:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:00:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:00:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:00:56 INFO - Installing collected packages: psutil 08:00:56 INFO - Running setup.py install for psutil 08:00:56 INFO - building 'psutil._psutil_linux' extension 08:00:56 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 08:00:56 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 08:00:56 INFO - building 'psutil._psutil_posix' extension 08:00:56 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 08:00:56 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 08:00:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:00:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:00:56 INFO - Successfully installed psutil 08:00:56 INFO - Cleaning up... 08:00:57 INFO - Return code: 0 08:00:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:00:57 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')]} 08:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:57 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')]} 08:00:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:57 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 0x7ff940347f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4c410>, '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 0x1c4d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4d7a0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1467730839.977496-2122453807', '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 08:00:57 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 08:00:57 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 08:00:57 INFO - Using env: {'DISPLAY': ':0', 08:00:57 INFO - 'HOME': '/home/cltbld', 08:00:57 INFO - 'LANG': 'en_US.UTF-8', 08:00:57 INFO - 'LANGUAGE': 'en_US:en', 08:00:57 INFO - 'LOGNAME': 'cltbld', 08:00:57 INFO - 'MAIL': '/var/mail/cltbld', 08:00:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:57 INFO - 'MOZ_NO_REMOTE': '1', 08:00:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:57 INFO - 'NO_EM_RESTART': '1', 08:00:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:57 INFO - 'PWD': '/builds/slave/test', 08:00:57 INFO - 'SHELL': '/bin/bash', 08:00:57 INFO - 'SHLVL': '1', 08:00:57 INFO - 'TERM': 'linux', 08:00:57 INFO - 'TMOUT': '86400', 08:00:57 INFO - 'USER': 'cltbld', 08:00:57 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1467730839.977496-2122453807', 08:00:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:57 INFO - '_': '/tools/buildbot/bin/python'} 08:00:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:00:57 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 08:00:57 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 08:00:57 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 08:00:57 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 08:00:57 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 08:00:57 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 08:00:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:00:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:00:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:00:59 INFO - Installing collected packages: mozsystemmonitor 08:00:59 INFO - Running setup.py install for mozsystemmonitor 08:00:59 INFO - Successfully installed mozsystemmonitor 08:00:59 INFO - Cleaning up... 08:00:59 INFO - Return code: 0 08:00:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:00:59 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')]} 08:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:59 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')]} 08:00:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:59 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 0x7ff940347f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4c410>, '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 0x1c4d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4d7a0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1467730839.977496-2122453807', '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 08:00:59 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 08:00:59 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 08:00:59 INFO - Using env: {'DISPLAY': ':0', 08:00:59 INFO - 'HOME': '/home/cltbld', 08:00:59 INFO - 'LANG': 'en_US.UTF-8', 08:00:59 INFO - 'LANGUAGE': 'en_US:en', 08:00:59 INFO - 'LOGNAME': 'cltbld', 08:00:59 INFO - 'MAIL': '/var/mail/cltbld', 08:00:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:59 INFO - 'MOZ_NO_REMOTE': '1', 08:00:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:59 INFO - 'NO_EM_RESTART': '1', 08:00:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:59 INFO - 'PWD': '/builds/slave/test', 08:00:59 INFO - 'SHELL': '/bin/bash', 08:00:59 INFO - 'SHLVL': '1', 08:00:59 INFO - 'TERM': 'linux', 08:00:59 INFO - 'TMOUT': '86400', 08:00:59 INFO - 'USER': 'cltbld', 08:00:59 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1467730839.977496-2122453807', 08:00:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:59 INFO - '_': '/tools/buildbot/bin/python'} 08:00:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:59 INFO - Downloading/unpacking blobuploader==1.2.4 08:00:59 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 08:00:59 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 08:00:59 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 08:00:59 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 08:00:59 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 08:00:59 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 08:01:01 INFO - Downloading blobuploader-1.2.4.tar.gz 08:01:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:01:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:01:01 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 08:01:01 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 08:01:01 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 08:01:01 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 08:01:01 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 08:01:01 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 08:01:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:01:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:01:01 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 08:01:01 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 08:01:01 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 08:01:01 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 08:01:01 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 08:01:01 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 08:01:02 INFO - Downloading docopt-0.6.1.tar.gz 08:01:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:01:02 INFO - Installing collected packages: blobuploader, requests, docopt 08:01:02 INFO - Running setup.py install for blobuploader 08:01:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:01:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:01:02 INFO - Running setup.py install for requests 08:01:02 INFO - Running setup.py install for docopt 08:01:02 INFO - Successfully installed blobuploader requests docopt 08:01:02 INFO - Cleaning up... 08:01:02 INFO - Return code: 0 08:01:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:01:02 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')]} 08:01:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:01:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:02 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')]} 08:01:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:01:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:02 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 0x7ff940347f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4c410>, '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 0x1c4d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4d7a0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1467730839.977496-2122453807', '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 08:01:02 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 08:01:02 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 08:01:02 INFO - Using env: {'DISPLAY': ':0', 08:01:02 INFO - 'HOME': '/home/cltbld', 08:01:02 INFO - 'LANG': 'en_US.UTF-8', 08:01:02 INFO - 'LANGUAGE': 'en_US:en', 08:01:02 INFO - 'LOGNAME': 'cltbld', 08:01:02 INFO - 'MAIL': '/var/mail/cltbld', 08:01:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:02 INFO - 'MOZ_NO_REMOTE': '1', 08:01:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:01:02 INFO - 'NO_EM_RESTART': '1', 08:01:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:01:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:01:02 INFO - 'PWD': '/builds/slave/test', 08:01:02 INFO - 'SHELL': '/bin/bash', 08:01:02 INFO - 'SHLVL': '1', 08:01:02 INFO - 'TERM': 'linux', 08:01:02 INFO - 'TMOUT': '86400', 08:01:02 INFO - 'USER': 'cltbld', 08:01:02 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1467730839.977496-2122453807', 08:01:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:02 INFO - '_': '/tools/buildbot/bin/python'} 08:01:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:01:03 INFO - Running setup.py (path:/tmp/pip-utZLke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:01:03 INFO - Running setup.py (path:/tmp/pip-pA3Bv3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:01:03 INFO - Running setup.py (path:/tmp/pip-0j93SK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:01:03 INFO - Running setup.py (path:/tmp/pip-M8yEbX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:01:03 INFO - Running setup.py (path:/tmp/pip-ETiYdN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:01:03 INFO - Running setup.py (path:/tmp/pip-Bk9gGq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:01:03 INFO - Running setup.py (path:/tmp/pip-BYwZv4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:01:03 INFO - Running setup.py (path:/tmp/pip-BBVTXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:01:03 INFO - Running setup.py (path:/tmp/pip-_TiSJH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:01:03 INFO - Running setup.py (path:/tmp/pip-GeQ_sT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:01:03 INFO - Running setup.py (path:/tmp/pip-RLgSus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:01:03 INFO - Running setup.py (path:/tmp/pip-JJgmvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:01:03 INFO - Running setup.py (path:/tmp/pip-g4U9bL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:01:03 INFO - Running setup.py (path:/tmp/pip-bxWeMb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:01:04 INFO - Running setup.py (path:/tmp/pip-HVmlvf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:01:04 INFO - Running setup.py (path:/tmp/pip-P_PgTt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:01:04 INFO - Running setup.py (path:/tmp/pip-IVDuw_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:01:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:01:04 INFO - Running setup.py install for manifestparser 08:01:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:01:04 INFO - Running setup.py install for mozcrash 08:01:04 INFO - Running setup.py install for mozdebug 08:01:04 INFO - Running setup.py install for mozdevice 08:01:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:01:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:01:04 INFO - Running setup.py install for mozfile 08:01:04 INFO - Running setup.py install for mozhttpd 08:01:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:01:04 INFO - Running setup.py install for mozinfo 08:01:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:01:04 INFO - Running setup.py install for mozInstall 08:01:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:01:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:01:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:01:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:01:05 INFO - Running setup.py install for mozleak 08:01:05 INFO - Running setup.py install for mozlog 08:01:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:01:05 INFO - Running setup.py install for moznetwork 08:01:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:01:05 INFO - Running setup.py install for mozprocess 08:01:05 INFO - Running setup.py install for mozprofile 08:01:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:01:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:01:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:01:05 INFO - Running setup.py install for mozrunner 08:01:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:01:05 INFO - Running setup.py install for mozscreenshot 08:01:05 INFO - Running setup.py install for moztest 08:01:05 INFO - Running setup.py install for mozversion 08:01:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:01:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:01:05 INFO - Cleaning up... 08:01:06 INFO - Return code: 0 08:01:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:01:06 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')]} 08:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:01:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:06 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')]} 08:01:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:01:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:06 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 0x7ff940347f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4c410>, '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 0x1c4d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4d7a0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1467730839.977496-2122453807', '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 08:01:06 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 08:01:06 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 08:01:06 INFO - Using env: {'DISPLAY': ':0', 08:01:06 INFO - 'HOME': '/home/cltbld', 08:01:06 INFO - 'LANG': 'en_US.UTF-8', 08:01:06 INFO - 'LANGUAGE': 'en_US:en', 08:01:06 INFO - 'LOGNAME': 'cltbld', 08:01:06 INFO - 'MAIL': '/var/mail/cltbld', 08:01:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:06 INFO - 'MOZ_NO_REMOTE': '1', 08:01:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:01:06 INFO - 'NO_EM_RESTART': '1', 08:01:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:01:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:01:06 INFO - 'PWD': '/builds/slave/test', 08:01:06 INFO - 'SHELL': '/bin/bash', 08:01:06 INFO - 'SHLVL': '1', 08:01:06 INFO - 'TERM': 'linux', 08:01:06 INFO - 'TMOUT': '86400', 08:01:06 INFO - 'USER': 'cltbld', 08:01:06 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1467730839.977496-2122453807', 08:01:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:06 INFO - '_': '/tools/buildbot/bin/python'} 08:01:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:01:06 INFO - Running setup.py (path:/tmp/pip-81KaSP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:01:06 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)) 08:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:01:06 INFO - Running setup.py (path:/tmp/pip-wZcjOJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:01:06 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)) 08:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:01:06 INFO - Running setup.py (path:/tmp/pip-bBoIlT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:01:06 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)) 08:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:01:06 INFO - Running setup.py (path:/tmp/pip-zz6XZv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:01:06 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)) 08:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:01:06 INFO - Running setup.py (path:/tmp/pip-cWKVvZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:01:06 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)) 08:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:01:06 INFO - Running setup.py (path:/tmp/pip-to33gF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:01:06 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)) 08:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:01:06 INFO - Running setup.py (path:/tmp/pip-V_uaqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:01:06 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)) 08:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:01:06 INFO - Running setup.py (path:/tmp/pip-CQ44wi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:01:06 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)) 08:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:01:06 INFO - Running setup.py (path:/tmp/pip-3aX51R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:01:06 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)) 08:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:01:06 INFO - Running setup.py (path:/tmp/pip-CwyaDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:01:06 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)) 08:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:01:06 INFO - Running setup.py (path:/tmp/pip-JsZFh9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:01:07 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)) 08:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:01:07 INFO - Running setup.py (path:/tmp/pip-4Xp315-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:01:07 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)) 08:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:01:07 INFO - Running setup.py (path:/tmp/pip-NXagBt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:01:07 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)) 08:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:01:07 INFO - Running setup.py (path:/tmp/pip-eYSDpv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:01:07 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)) 08:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:01:07 INFO - Running setup.py (path:/tmp/pip-RNLwXg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:01:07 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)) 08:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:01:07 INFO - Running setup.py (path:/tmp/pip-0jCO7x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:01:07 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)) 08:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:01:07 INFO - Running setup.py (path:/tmp/pip-q7dnJR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:01:07 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)) 08:01:07 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)) 08:01:07 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)) 08:01:07 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)) 08:01:07 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)) 08:01:07 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)) 08:01:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:01:07 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 08:01:07 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 08:01:07 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 08:01:07 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 08:01:07 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 08:01:07 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 08:01:09 INFO - Downloading blessings-1.6.tar.gz 08:01:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:01:09 INFO - Installing collected packages: blessings 08:01:09 INFO - Running setup.py install for blessings 08:01:09 INFO - Successfully installed blessings 08:01:09 INFO - Cleaning up... 08:01:09 INFO - Return code: 0 08:01:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:01:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:01:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:01:09 INFO - Reading from file tmpfile_stdout 08:01:09 INFO - Current package versions: 08:01:09 INFO - argparse == 1.2.1 08:01:09 INFO - blessings == 1.6 08:01:09 INFO - blobuploader == 1.2.4 08:01:09 INFO - docopt == 0.6.1 08:01:09 INFO - manifestparser == 1.1 08:01:09 INFO - mozInstall == 1.12 08:01:09 INFO - mozcrash == 0.17 08:01:09 INFO - mozdebug == 0.1 08:01:09 INFO - mozdevice == 0.48 08:01:09 INFO - mozfile == 1.2 08:01:09 INFO - mozhttpd == 0.7 08:01:09 INFO - mozinfo == 0.9 08:01:09 INFO - mozleak == 0.1 08:01:09 INFO - mozlog == 3.1 08:01:09 INFO - moznetwork == 0.27 08:01:09 INFO - mozprocess == 0.22 08:01:09 INFO - mozprofile == 0.28 08:01:09 INFO - mozrunner == 6.11 08:01:09 INFO - mozscreenshot == 0.1 08:01:09 INFO - mozsystemmonitor == 0.0 08:01:09 INFO - moztest == 0.7 08:01:09 INFO - mozversion == 1.4 08:01:09 INFO - psutil == 3.1.1 08:01:09 INFO - requests == 1.2.3 08:01:09 INFO - wsgiref == 0.1.2 08:01:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:01:09 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')]} 08:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:01:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:09 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')]} 08:01:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:01:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:09 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 0x7ff940347f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4c410>, '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 0x1c4d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4d7a0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1467730839.977496-2122453807', '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 08:01:09 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 08:01:09 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 08:01:09 INFO - Using env: {'DISPLAY': ':0', 08:01:09 INFO - 'HOME': '/home/cltbld', 08:01:09 INFO - 'LANG': 'en_US.UTF-8', 08:01:09 INFO - 'LANGUAGE': 'en_US:en', 08:01:09 INFO - 'LOGNAME': 'cltbld', 08:01:09 INFO - 'MAIL': '/var/mail/cltbld', 08:01:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:09 INFO - 'MOZ_NO_REMOTE': '1', 08:01:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:01:09 INFO - 'NO_EM_RESTART': '1', 08:01:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:01:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:01:09 INFO - 'PWD': '/builds/slave/test', 08:01:09 INFO - 'SHELL': '/bin/bash', 08:01:09 INFO - 'SHLVL': '1', 08:01:09 INFO - 'TERM': 'linux', 08:01:09 INFO - 'TMOUT': '86400', 08:01:09 INFO - 'USER': 'cltbld', 08:01:09 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1467730839.977496-2122453807', 08:01:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:09 INFO - '_': '/tools/buildbot/bin/python'} 08:01:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:01:10 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)) 08:01:10 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)) 08:01:10 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)) 08:01:10 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)) 08:01:10 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)) 08:01:10 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)) 08:01:10 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)) 08:01:10 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)) 08:01:10 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)) 08:01:10 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)) 08:01:10 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)) 08:01:10 INFO - Cleaning up... 08:01:10 INFO - Return code: 0 08:01:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:01:10 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')]} 08:01:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:01:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:10 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')]} 08:01:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:01:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:10 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 0x7ff940347f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4c410>, '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 0x1c4d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4d7a0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1467730839.977496-2122453807', '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 08:01:10 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 08:01:10 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 08:01:10 INFO - Using env: {'DISPLAY': ':0', 08:01:10 INFO - 'HOME': '/home/cltbld', 08:01:10 INFO - 'LANG': 'en_US.UTF-8', 08:01:10 INFO - 'LANGUAGE': 'en_US:en', 08:01:10 INFO - 'LOGNAME': 'cltbld', 08:01:10 INFO - 'MAIL': '/var/mail/cltbld', 08:01:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:10 INFO - 'MOZ_NO_REMOTE': '1', 08:01:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:01:10 INFO - 'NO_EM_RESTART': '1', 08:01:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:01:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:01:10 INFO - 'PWD': '/builds/slave/test', 08:01:10 INFO - 'SHELL': '/bin/bash', 08:01:10 INFO - 'SHLVL': '1', 08:01:10 INFO - 'TERM': 'linux', 08:01:10 INFO - 'TMOUT': '86400', 08:01:10 INFO - 'USER': 'cltbld', 08:01:10 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1467730839.977496-2122453807', 08:01:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:10 INFO - '_': '/tools/buildbot/bin/python'} 08:01:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:01:10 INFO - Downloading/unpacking jsonschema 08:01:10 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 08:01:10 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 08:01:10 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 08:01:10 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 08:01:10 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 08:01:10 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 08:01:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:01:12 INFO - Downloading/unpacking functools32 (from jsonschema) 08:01:12 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 08:01:12 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 08:01:12 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 08:01:12 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 08:01:12 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 08:01:12 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 08:01:12 INFO - Downloading functools32-3.2.3-2.tar.gz 08:01:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:01:12 INFO - warning: no files found matching '*.txt' 08:01:12 INFO - no previously-included directories found matching 'build' 08:01:12 INFO - no previously-included directories found matching 'dist' 08:01:12 INFO - no previously-included directories found matching '.git*' 08:01:12 INFO - Installing collected packages: jsonschema, functools32 08:01:12 INFO - Running setup.py install for functools32 08:01:12 INFO - warning: no files found matching '*.txt' 08:01:12 INFO - no previously-included directories found matching 'build' 08:01:12 INFO - no previously-included directories found matching 'dist' 08:01:12 INFO - no previously-included directories found matching '.git*' 08:01:12 INFO - Successfully installed jsonschema functools32 08:01:12 INFO - Cleaning up... 08:01:12 INFO - Return code: 0 08:01:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:01:12 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')]} 08:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:01:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:12 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')]} 08:01:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:01:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:12 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 0x7ff940347f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4c410>, '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 0x1c4d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4d7a0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1467730839.977496-2122453807', '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 08:01:12 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 08:01:12 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 08:01:12 INFO - Using env: {'DISPLAY': ':0', 08:01:12 INFO - 'HOME': '/home/cltbld', 08:01:12 INFO - 'LANG': 'en_US.UTF-8', 08:01:12 INFO - 'LANGUAGE': 'en_US:en', 08:01:12 INFO - 'LOGNAME': 'cltbld', 08:01:12 INFO - 'MAIL': '/var/mail/cltbld', 08:01:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:12 INFO - 'MOZ_NO_REMOTE': '1', 08:01:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:01:12 INFO - 'NO_EM_RESTART': '1', 08:01:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:01:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:01:12 INFO - 'PWD': '/builds/slave/test', 08:01:12 INFO - 'SHELL': '/bin/bash', 08:01:12 INFO - 'SHLVL': '1', 08:01:12 INFO - 'TERM': 'linux', 08:01:12 INFO - 'TMOUT': '86400', 08:01:12 INFO - 'USER': 'cltbld', 08:01:12 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1467730839.977496-2122453807', 08:01:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:12 INFO - '_': '/tools/buildbot/bin/python'} 08:01:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:01:12 INFO - Downloading/unpacking flake8 08:01:12 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 08:01:12 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 08:01:12 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 08:01:12 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 08:01:12 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 08:01:12 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 08:01:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:01:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:01:14 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 08:01:14 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 08:01:14 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 08:01:14 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 08:01:14 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 08:01:14 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 08:01:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:01:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:01:14 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 08:01:14 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 08:01:14 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 08:01:14 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 08:01:14 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 08:01:14 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 08:01:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:01:15 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 08:01:15 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 08:01:15 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 08:01:15 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 08:01:15 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 08:01:15 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 08:01:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:01:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:01:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:01:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:01:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:01:15 INFO - no previously-included directories found matching 'docs/_build' 08:01:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:01:15 INFO - Running setup.py install for pep8 08:01:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:01:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:01:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:01:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:01:15 INFO - no previously-included directories found matching 'docs/_build' 08:01:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:01:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:01:15 INFO - Cleaning up... 08:01:15 INFO - Return code: 0 08:01:15 INFO - Running post-action listener: _resource_record_post_action 08:01:15 INFO - Running post-action listener: _start_resource_monitoring 08:01:15 INFO - Starting resource monitoring. 08:01:15 INFO - ##### 08:01:15 INFO - ##### Running install step. 08:01:15 INFO - ##### 08:01:15 INFO - Running pre-action listener: _resource_record_pre_action 08:01:15 INFO - Running main action method: install 08:01:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:01:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:01:15 INFO - Reading from file tmpfile_stdout 08:01:15 INFO - Detecting whether we're running mozinstall >=1.0... 08:01:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:01:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:01:16 INFO - Reading from file tmpfile_stdout 08:01:16 INFO - Output received: 08:01:16 INFO - Usage: mozinstall [options] installer 08:01:16 INFO - Options: 08:01:16 INFO - -h, --help show this help message and exit 08:01:16 INFO - -d DEST, --destination=DEST 08:01:16 INFO - Directory to install application into. [default: 08:01:16 INFO - "/builds/slave/test"] 08:01:16 INFO - --app=APP Application being installed. [default: firefox] 08:01:16 INFO - mkdir: /builds/slave/test/build/application 08:01:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:01:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:01:29 INFO - Reading from file tmpfile_stdout 08:01:29 INFO - Output received: 08:01:29 INFO - /builds/slave/test/build/application/firefox/firefox 08:01:29 INFO - Running post-action listener: _resource_record_post_action 08:01:29 INFO - ##### 08:01:29 INFO - ##### Running run-tests step. 08:01:29 INFO - ##### 08:01:29 INFO - Running pre-action listener: _resource_record_pre_action 08:01:29 INFO - Running main action method: run_tests 08:01:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:01:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:01:29 INFO - Python 2.7.3 08:01:29 INFO - Return code: 0 08:01:29 INFO - grabbing minidump binary from tooltool 08:01: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')]} 08:01:29 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 0x1c4c410>, '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 0x1c4d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4d7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:01:29 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 08:01:29 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 08:01:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:01:29 INFO - Return code: 0 08:01:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:01:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:01:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:01:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:01:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:01:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:01:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:01:30 INFO - Return code: 0 08:01:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CEdvWcnOT521k4-Ht_ZcnA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 08:01:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CEdvWcnOT521k4-Ht_ZcnA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --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 08:01:30 INFO - Using env: {'DISPLAY': ':0', 08:01:30 INFO - 'HOME': '/home/cltbld', 08:01:30 INFO - 'LANG': 'en_US.UTF-8', 08:01:30 INFO - 'LANGUAGE': 'en_US:en', 08:01:30 INFO - 'LOGNAME': 'cltbld', 08:01:30 INFO - 'MAIL': '/var/mail/cltbld', 08:01:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:01:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:01:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:30 INFO - 'MOZ_NO_REMOTE': '1', 08:01:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:01:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:01:30 INFO - 'NO_EM_RESTART': '1', 08:01:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:01:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:01:30 INFO - 'PWD': '/builds/slave/test', 08:01:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:01:30 INFO - 'SHELL': '/bin/bash', 08:01:30 INFO - 'SHLVL': '1', 08:01:30 INFO - 'TERM': 'linux', 08:01:30 INFO - 'TMOUT': '86400', 08:01:30 INFO - 'USER': 'cltbld', 08:01:30 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1467730839.977496-2122453807', 08:01:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:30 INFO - '_': '/tools/buildbot/bin/python'} 08:01:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CEdvWcnOT521k4-Ht_ZcnA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 08:01:30 INFO - mozversion application_buildid: 20160705051322 08:01:30 INFO - mozversion application_changeset: 1c9185a7df828f0065c20d34b7eda15aa2628883 08:01:30 INFO - mozversion application_display_name: Firefox 08:01:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:01:30 INFO - mozversion application_name: Firefox 08:01:30 INFO - mozversion application_remotingname: firefox 08:01:30 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:01:30 INFO - mozversion application_vendor: Mozilla 08:01:30 INFO - mozversion application_version: 48.0 08:01:30 INFO - mozversion platform_buildid: 20160705051322 08:01:30 INFO - mozversion platform_changeset: 1c9185a7df828f0065c20d34b7eda15aa2628883 08:01:30 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:01:30 INFO - mozversion platform_version: 48.0 08:01:30 INFO - using testdate: 1467730890 08:01:30 INFO - actual date: 1467730890 08:01:30 INFO - starting webserver on 'localhost:53630' 08:01:30 INFO - SUITE-START | Running 2 tests 08:01:30 INFO - TEST-START | dromaeo_css 08:01:30 INFO - operating with platform_type : linux_ 08:01:30 INFO - Initialising browser for dromaeo_css test... 08:01:30 INFO - TEST-INFO | started process 32186 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXcC_UB/profile http://localhost:53630/getInfo.html) 08:01:34 INFO - PROCESS | 32186 | __metrics Screen width/height:1600/1200 08:01:34 INFO - PROCESS | 32186 | colorDepth:24 08:01:34 INFO - PROCESS | 32186 | Browser inner width/height: 1024/697 08:01:34 INFO - PROCESS | 32186 | __metrics 08:01:35 ERROR - PROCESS | 32186 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:01:35 INFO - TEST-INFO | 32186: exit 0 08:01:35 INFO - Browser initialized. 08:01:35 INFO - Running cycle 1/1 for dromaeo_css test... 08:01:35 INFO - TEST-INFO | started process 32274 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXcC_UB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:01:47 INFO - PROCESS | 32274 | RSS: Main: 139145216 08:01:47 INFO - PROCESS | 32274 | 08:02:39 INFO - PROCESS | 32274 | 1467730959042 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] 08:04:45 INFO - PROCESS | 32274 | Cycle 1(1): loaded http://localhost:53630/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53630/tests/dromaeo/cssquery-ext.html) 08:04:46 INFO - PROCESS | 32274 | RSS: Main: 249425920 08:04:46 INFO - PROCESS | 32274 | 08:07:48 INFO - PROCESS | 32274 | Cycle 1(1): loaded http://localhost:53630/tests/dromaeo/cssquery-ext.html (next: http://localhost:53630/tests/dromaeo/cssquery-jquery.html) 08:07:49 INFO - PROCESS | 32274 | RSS: Main: 220827648 08:07:49 INFO - PROCESS | 32274 | 08:10:51 INFO - PROCESS | 32274 | Cycle 1(1): loaded http://localhost:53630/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53630/tests/dromaeo/cssquery-mootools.html) 08:10:51 INFO - PROCESS | 32274 | RSS: Main: 216502272 08:10:51 INFO - PROCESS | 32274 | 08:13:53 INFO - PROCESS | 32274 | Cycle 1(1): loaded http://localhost:53630/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53630/tests/dromaeo/cssquery-prototype.html) 08:13:54 INFO - PROCESS | 32274 | RSS: Main: 217333760 08:13:54 INFO - PROCESS | 32274 | 08:16:56 INFO - PROCESS | 32274 | Cycle 1(1): loaded http://localhost:53630/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53630/tests/dromaeo/cssquery-yui.html) 08:16:57 INFO - PROCESS | 32274 | RSS: Main: 209887232 08:16:57 INFO - PROCESS | 32274 | 08:19:59 INFO - PROCESS | 32274 | Cycle 1(1): loaded http://localhost:53630/tests/dromaeo/cssquery-yui.html (next: http://localhost:53630/tests/dromaeo/cssquery-dojo.html) 08:19:59 INFO - PROCESS | 32274 | RSS: Main: 257114112 08:19:59 INFO - PROCESS | 32274 | 08:19:59 INFO - PROCESS | 32274 | __start_tp_report 08:19:59 INFO - PROCESS | 32274 | _x_x_mozilla_page_load 08:19:59 INFO - PROCESS | 32274 | _x_x_mozilla_page_load_details 08:19:59 INFO - PROCESS | 32274 | |i|pagename|runs| 08:19:59 INFO - PROCESS | 32274 | |0;dojo.html;3235.854386552605;3272.869085236592;3276.524903888936;3293.901182964512;3310.3379324135162;5302.681839089652;5308.8407347779585;5316.175992721125;5329.413764485904;5344.973275133619;5311.601629877755;5318.6011049171275;5337.786488540453;5343.118385466403;5348.358197016363;4786.688865223767;4871.829485967992;4881.926771098437;4884.731339776311;4941.135301322272;4855.368802055746;4955.256711493269;4961.677490963094;4985;5002.449730529639;4981.626378021645;5025.824096156635;5031.396232452093;5035.899282014376;5059.620528460362;4794.400699912511;4967.776450059756;4993.275974983625;4997.350344455198;5026.673266237701;4850.248211527183;4906.8773280668265;4907.901841963177;4914.680545764514;4944.011197760462;5316.787328506855;5330.173823057394;5361.3030306060355;5371.81198658049;5424.701641409721;5696.800611978602;5745.368009518949;5799.420057994167;5821.243238379026;5825.1844741736195;5832.125181222808;5853.648781073107;5854.385289544579;5875.647461152302;5880.235569375996;5440.700761458118;5473.890522189534;5479.863003424906;5481.342238931314;5486.6982315973;5822.970885145547;5824.592278540546;5900.085486749561;5945.4649081582;6017.608855424383;5645;5661.490465858093;5664.830055098354;5674.659520428788;5700.25896633435;5664.85837854057;5708.086706127;5710.457506536873;5715.971420142956;5716.028275193227;5575.135853942646;5624.803131890364;5654.434556544395;5695.487406133385;5706.4864162225595;5632.436756324335;5643.040683083886;5644.520215781622;5646.717664116778;5693.146028095736;4346.174226896879;4360.127974405132;4361.563843615677;4374.212641724456;4388.990532177617;3921.156951255494;3968.1666849961252;3969.543502497192;3971.6624086952356;3993.7004724645767;5509.842932984038;5541.612087153861;5545.085060964896;5559.63862348946;5562.749676264578;5811.302643682785;5841.591088623755;5848.970755146197;5852.970735146382;5885.705714714247;5352.518273355417;5470.398256191816;5517.117261238182;5529.640573362719;5532.30846144232;4787.664863459594;4797.616190704735;4804.735739534359;4806.086843499724;4833.178359678863;5880.176775251382;5940.198073260054;5953.702314884238;5961.225040744675;5966.0454327307425;5682.374938756733;5753.741081651419;5759.337676167294;5766.913496297475;5776.624519406225;6087.482563981934;6092.603980741238;6113.5414843886;6120.204373431426;6121.051237058263;5506;5561.63849349791;5712.143178523089;5737.340205876378;5755.913661295001;5718.285214348207;5718.370979192202;5726.74229659658;5739.167820666064;5756.769729210952;5564.860878478071;5569.805056822992;5573.21974923503;5574.888502230014;5576.1356989666665;5526.751296191762;5539.279893613965;5567.47109024642;5574.554035677217;5677;5459.235707001102;5471.452854714496;5473.096939005179;5484.506394424521;5532.557395408438;5550.916736248879;5556.611037227517;5578.693171875586;5578.804741834017;5579.16312553104;5341.4925582069645;5530.695811730394;5552.805651802168;5601.663900166003;5619.943800562106 08:19:59 INFO - PROCESS | 32274 | |1;ext.html;653.0889409274063;679.7043286170516;683.8769021576117;742.6398196874514;764.6559048428202;31885.362292754133;32290.35419291616;32408.67591324086;40325;41195;42904.785476072655;43324.566754332525;43362.78318608402;43400.3489947651;43432.782836085855;8731.519766412828;8929.062448442884;8953.776155596097;8961.865572016424;8974.46153230805;8235.79410514739;8476.364272679542;8673.349498787584;10544.420056896868;10823.945880270587;10522.736931576695;10583.78832423351;10600.310979786289;10615.84076238857;10616.522256498476;10424.530896109693;10478.58085676572;10500.842487362695;10510.527026283835;10512.21158413122;10279.074883260542;10395.636152734618;10400.323978941344;10403.791924161551;10404.479776011169;38154.23691526182;38650.42024369637;42420;42498.57501424977;42554.57445425537;3543.2382037861985;3688.7417880748358;4163.666906647461;4289.2922667759785;4384.539623339535;33562.1609459763;33647.83176084128;33880;34759.65240347589;35501.82249088764;4273.786310684453;4313.202057619351;4317.438732964726;4331.068820203672;4354.934675979863;356748;357247;357830;359785;359818;39316.80341598274;40082;61820.381796181464;61840.83557075481;62320.06519902205;37617.24765504729;37625;37645.43531847024;37760.43359349557;37785.43321850174;16496.42262520806;16514.84396092286;16541.172941353125;16542.83457165437;16667.083310418042;12819.551315704091;13782.793258101137;13828.308584570932;13871.23708196059;13873;9207.079292070739;9440.96149423563;9484.715458536255;9510.524473776284;9521.381110227812;3565.964340356615;3629.2741451709235;3676.485292059114;3694.224212915318;3757.699384049324;1066.3388699006666;1131.0781712903956;1151.8963293303643;1203.867574566797;1226.791445454275;33457.49813752795;33512.1621959453;33696.83151584226;33761;33844.98465046052;1189.0309397840733;1220.8290839282508;1226.533917111492;1291.9741605168033;1316.605018494448;17505.38731144404;17584.38454654081;17676.469705908843;17760.733588996176;17798.110094495223;495002;497735;502323;503230;503962;61766.38233617696;62404.68797655983;62435;62543.6872815633;62560.687196564635;1326.1380102932978;1365.3105181883086;1458.6207586027708;1508.1629695519093;1509.803725515676;30198.54702179513;31967.520487193175;33515.32969340551;34051.31897362089;34110.48834267537;48343.758281209775;48600.75699621479;48734;48741;48755.268670970676;330039;330746;330797;332369;672790;30310.393792124476;30334.393312134074;30662;30664;30968.69031309658;44025.55974440215;45644.77177614091;46851.297230540884;48152.759236203594;49420.258696118864;39791.60208397879;40871;41091.589084109975;41384.793076034424;41708.1658366837;37884.81057594695;38853.611463885;38926.2214755709;39140;39714.60285397225;41248.38127428031;43871;44387.33418998653;44791.55208447874;45069;33482.83258583691;36085.45871811977;36954.260914781014;37114.62885371112;37367;28630;28762.280942976595;29352.706472935;29400.852995734884;29431.411371772017 08:19:59 INFO - PROCESS | 32274 | |2;jquery.html;426.7501896395626;431.11190946649896;434.300775751041;442.612713875359;447.46304434678393;18784.530386740338;19313;19561.804381956175;20142.194312227493;20473.590528189427;20002.499937501532;20150.59698806023;20834.479138021557;20878.478038049056;20891.58216835666;5828.88342233154;5894.3810899855325;6063.939360606381;6067.514598832105;6072.514198864103;4199.286121359376;5946.345901950782;6044.2746870375395;6257.092721555395;6539.247986481568;6536.509761767863;6545.509086818483;6546.770863019795;6556.573822701533;6560.1143845580955;6487.7729279475225;7351.191368949411;7630.8473830523635;7669.73155939545;7677.577733224671;4760.166970780134;4890.608751299887;6343.302236754;7458.8881166782;7467.925320746832;26037.73962260391;26707.19878403651;26776.73223267762;26829.73170268292;27312.590311145348;2505.3736565858535;2698.5142674318613;2934.7065293470696;3015.7135072168107;3345.531625572422;15869.761953570705;15933.442329518411;16386.508404747878;17051.744223836653;17189.05460199701;2240.3950933247934;2289.507755832504;2296.471811483368;2311.110222564308;2371.9288421347387;91088.5445572768;92566.07433925642;93489.53255233681;93791;97901;17957;18527.53681157955;19160;19200.231990720495;19280.22879084821;34571.481427778606;34595.65404345975;34886.65113348885;35124.473132903026;35164;8135.633896474555;8428.115047920002;8540.487570745776;8624.137586241326;8625.568721563897;8881.644734210688;8901.688440904538;8926.330525210635;8996.59515321799;9123.589438475285;4593.058423023273;5055.811884207208;5105.9744701276995;5145.253938179018;5161.122609156378;1763.3740022292159;1807.5661841158028;1916.0802814648769;1991.445270192728;2063.484128967758;1019.5666841592293;1080.4111759091313;1102.2780079048237;1108.1578000719512;1139.9829002564968;18248.087595620167;18634.627307454048;18702.625947480974;19888.3039093631;20296.49258768513;1078.8327809189432;1091.2906610703108;1101.9559217631365;1113.7828123516;1131.6378758797107;10471.633492827867;11063.889361106447;11097.223194376478;11106.722331941766;11213.94393028046;537838;583524;586608;599370;619694;98458;100969;101048.49475752574;101056.49471752594;101141.49429252806;1116.508736156105;1121.786860496503;1169.8128299472044;1175.330061864746;1197.4012993503247;17084.74372884383;17322;17416.30334786594;17583.648327033643;18265.634687306447;41541.169176615695;41699;42580.36129457998;42956;42980;57696.71151644215;57716.4228357711;58120;58215;58383.4161658378;9197.586108624993;9264.490453025148;9306.162445379949;9400.858987115062;9475.715728528156;10348.689539313833;13147;13206.27365494907;13600.795988059988;13607.183568985893;11326.716832079264;11366.545338186379;11369.772604548029;11522;11937.94031029874;11259.718507037389;11297.943510282395;11310.321380717183;11498.885011150116;11771.705707357385;11800;11959.880401196224;12184.268943863397;12341;12435;8769.342299327704;8821.823563528822;8984.550772461482;9104.226140778108;9170.495622740547;9319.30105242096;11753.118516111497;11766.058715302584;11786.41067946582;11906.642800715992 08:19:59 INFO - PROCESS | 32274 | |3;mootools.html;1403.354456949803;1529.6864142850714;1537.3850459816072;1725.9654806903861;1859.4142845003823;7904.8419031619405;8005.4396192266495;8032.477888937215;8033.959830200848;8041.638126284317;7890.289873911347;8084.393670474723;8099.392545559077;8099.838003239932;8103.473274237171;2323.2217207235553;2343.5664402085667;2346.741858395575;2347.248880358286;2348.7416384197722;2314.282572402552;2350.9882450587725;2351.459164392191;2359.4691194481275;2362.8818559072065;2292.885355732207;2299;2305.5158416732506;2355.4464700795297;2356.2695564375013;2254.6054440473017;2254.797068263856;2258.0741895822716;2260.2541161416775;2285.165914441234;2322.082777302956;2330.9883450582806;2335.0309621507054;2336.778006089419;2353.9529209415714;7925.643346049384;8079.111297757242;8308.086110527836;8324.62539185738;8355.456895301786;4906.901861962777;4998.175301075355;5001.44984051754;5006.199008158714;5006.3241462402475;3347.163209197701;3352.1619595101224;3383.5770528683915;3473.9826300868585;3474.8957531274104;1142.3774043146504;1145.736480609456;1171.6953592066125;1186.6024881664653;1239.0211732731132;11194.160437967104;11202.999999999918;11243.437828108643;11262.943685281603;11270.549178032868;4240.830366785356;4272.700910936204;4317.417148684887;4321.438213032286;4399.472063352354;8997.19025287714;9011.684591039282;9026.86459703105;9039.774005649911;9058.637654493747;5017.523335283142;5032.0690672225755;5032.647714659939;5033.924491132636;5041.470645582161;4129.8967525812095;4520.909581808345;4613.0773845230415;4614.74618895964;4653.813847446064;3748.437734339871;3761.5110035695184;3772.434134879735;3817.7136714746507;3846.9038274043373;1143.9199256051998;1145.1983611472003;1165.4697112813649;1168.4975460551875;1169.1465230381868;712.8503014366937;791.6121100660635;906.5829718329642;922.4050487435701;924.8726445422649;5300.231466437345;5512.724363781795;5555.000099982042;5581.553475722014;5591.412901645269;443.6450839328524;445.5811537155064;449.4606472233333;469.93890794196534;474.9192637251675;3415.043787739437;3553.875614353537;3564.821758912044;3565.16218688608;3574.160072382988;9956.402615843073;10048.69853904384;10210.489475526194;10210.846837297446;10217.18262538995;9957.253206009578;10087.899121008695;10092.293539452168;10093.192544596415;10098.747531311776;7825.765227043198;7842.64708088126;7940.1265860755275;7943.165967573437;7975.322097621767;5301.920471193012;5470.72646367672;5505.532029777513;5603.047481928001;5627.8593035174445;8765.649374024968;8777.166169213915;8941.329400294873;9055.909440905507;9314.95342523283;9024.503652298923;9042.50266235337;9066.410683305565;9081.409708368936;9134.725958221265;6735.966320168368;6780.355866192901;7007.859842803014;7346.485745997729;7500.474966752275;7684.231576842271;7717;7755.418343624138;7756.961215193888;7764.650590723544;6826.351496607815;6956.860862782817;6977.930220697728;7090.184628767552;7101.183363913216;6683.131192944886;6826.761063362758;6850.657467126524;6852.897206541807;7006.649667516705;6389.329120442287;6573.244076931022;6598.076269322395;6758.8648227036165;6780.966095169492;4634.65240107;4641.234196357564;4694.812207511662;4720.504347043511;4763.595094417014;4513.54864513546;4604.562566556172;4715.693479923794;4761.714297142183;4818.036392721399 08:19:59 INFO - PROCESS | 32274 | |4;prototype.html;354.3285474026718;354.7967124158973;357.16601734948887;358.3102527634304;359.5361983041876;6186.072089186624;6212.254529456472;6224.564280500361;6229.595076320042;6248.656323902189;6105.87788244236;6180.598261113036;6186.474149697281;6200.78297259596;6211.720472578733;4504.121696269229;4643.698159619614;4651.232546629802;4654.906901861961;4682.2274324736545;4796.688215266014;4797.9520204797855;4798.256270278095;4798.83204087857;4809.855704328876;4728.503507131753;4763.404574428197;4766.809327626891;4768.998510312821;4771.689840160396;4500.459944806611;4623.468301145378;4703.741294228816;4751.16854550454;4765.0946320199055;4155.625993660585;4163.958360416387;4177.725793632941;4178.227027999799;4178.6657067434535;5824.534037277008;5828.41715828418;5909.409059094056;5932.9703351483395;5938.079597662369;5543.556515478752;5558.833235002957;5559.082751346023;5560.304961879765;5566.638168519034;6456.225252969673;6516.446102081329;6526.934730652728;6527.836804079889;6535.509836762214;4609.377734005933;4654;4699.624030077585;4700.4594471635855;4707.340972263886;6758.695858686322;6801.625910574917;6804.55770374924;6809.114815074058;6813.11429514165;4802.111609352281;4809.95190048102;4814.638902082288;4820.180569303227;4823.3729615149805;4877.341558889504;4878.048780487842;4886.486918873467;4888.560029597354;4888.731119788375;5553.694546799884;5560.666360018412;5562.805301814417;5563.582731295169;5579.888402231933;6238.875222495525;6426.325235850262;6555.836104097436;6558.344165583499;6559.639219842955;1634.7547867819922;1640.868730501557;1645.695546323934;1646.0370683150252;1651.7604947282578;1084.5661735305941;1100.5542755184163;1109.9334039957628;1112.7440688641657;1119.322809700136;6195.380461953859;6282.905756413657;6352.396522330371;6377.936220637827;6379.457746091634;6707.765228216989;6713.932860671331;6737.831554211086;6813.659317034228;6817.386435220854;6449.226092868886;6458.192725909262;6459.580127291711;6461.19235095613;6463.579867308704;3639.1084184375;3677.1542545214215;3683.889483315505;3687.317846198408;3688.870889518854;7032.296770322927;7157.785266442015;7175.569465832067;7186.317299856505;7206.747763828241;6906.102206713095;6940.548864323803;6944.965275173592;6947;6982.825429364205;7139;7141.321574450419;7141.428685705131;7147.070880785464;7147.64261786919;6775.356341147583;6788.287229840796;6790.388865002174;6796.320367963164;6797.898031529432;6579.901301480578;6697.09589205451;6697.631630260383;6701.664916754045;6731.091302674076;7125.928740712527;7149.034880291094;7168.713251469882;7176.892346614701;7178.497505174588;4678.906421871611;4688.179568575418;4690.460597031385;4698.036902435061;4699.412573428322;6783.491238157257;6785.558938668971;6788.76239331621;6793.864122717617;6794.796156115324;6377.266614339411;6557.803265902031;6600.372964568358;6606.4384527315715;6609.339066093545;6491.805245842632;6523.086767852409;6525.543211975116;6556.573822701509;6558.8360290991195;6404.359564043744;6407.775727849689;6411.871762564816;6413.839654008687;6416.101745755504;6531.248906375828;6584.275729669828;6589.439897608757;6595.670216489252;6600.867982640224;6315.747370105328;6429.260635027032;6443.96778016107;6462.644554549357;6478.125453063776 08:19:59 INFO - PROCESS | 32274 | |5;yui.html;835.5488036460312;839.7102999465183;876.9605367758451;895.9830592277763;917.8118485710435;13374.732505349888;13619.659508512292;13650.38573264203;13662.180269183857;13665.521706740266;12505.749885002295;12560.937195314033;12573.748525029494;12603;12604.550476695184;727.8944553039806;853.2576658307281;875.5578432891397;878.3412440669498;883.1345281624012;872.3718922375879;874.0996773323487;880.4057261348596;880.4057261348596;880.4629176202511;936.5223735894708;937.1097457415483;937.2314701944408;937.6530683647026;939.8308304505186;787.322902304018;922.4419226368051;942.0908822985783;948.1798244518511;951.3673407184215;681.7273090763684;682.7132604306154;682.7371461987121;682.737146198717;683.5454422808826;12247.265164090182;12281.324527151002;12298.631041068693;12305.938470307681;12307.138500304982;14123.505677301246;14764.187969661665;14799.556013319618;14906.627334316621;15402.768958465633;10966;11094.057005154571;11263.54945802167;11303;11359.716007099805;3871.8838434847;3878.650921417058;3911.3937339712106;3915.5888631693833;3946.3291240488898;59197.40802592005;59335.10997335;59831.70084149595;60133;60228.397716022715;10382.169426446017;10428.739281517872;10956.56173753041;11189.097853364947;11226;19473.610527789366;19519.121639526256;19530.70703939442;19533.902330488258;19552.31566895152;8236.876446853303;8286.46138001028;8300.958495207486;8582;8984.101589840964;4493.955060449419;4612.169809434334;4636.165490211727;4676.205045142334;4764.523547645208;3465;3511.8595256189465;3513.4554144107706;3517.9296414071573;3518.3666939950544;543.2964311216983;626.2328647406981;650.2424675253371;665.1054331923555;667.7929841749074;755.9584222867795;762.4700832921177;789.4158322841056;801.943863929531;823.2343920154194;8600.483970961637;8879.467231966102;8918.241949434241;8958.328125390492;9096.081288802821;756.9924300757032;768.0859776865512;780.5784876166806;780.6174974262684;787.8739401695701;4048.4332193492933;4286.978565107154;4395.714278571946;4427.623651989553;4519.07358991406;62038;72615.27384726191;72914;72935.2706472939;73195.63402182955;60583.69708151431;62849;63103;63142;63509.68245158745;55046.72476637591;55595.44404555984;56972.430275697545;57391.71304143452;58874.82250354969;9641.710748677551;9665.371750836173;9683.612655493984;9789.559469824018;9812.656557020755;40472.1905561893;41547;41755;42149.789251054775;42400.78799605982;50532;51619.483805161464;53664.195037073696;54396;54423.18365224446;12045.156839021534;12399.101687572746;12421.378931053592;12611.87388126107;12727;12116.575919842764;12369.319687417279;12374.938125309316;12669.683257918627;13305.534306299232;12081.214721043105;12261.938690306491;12410.937945310216;12414.441350139447;12442.937785311016;12300.692482688004;12325.506979721069;12327.876721232673;12336.198147120409;12377.34353716239;11431.542738290374;11433.656990290305;12171.817422738843;12435.129540932048;12579.182353147016;10469.428949278581;10706.571737130738;10865.945670271598;10919.328684129343;11401.016188348;10659.680209593724;10686.946565267124;10891.78216435651;10988;11315.773684526099 08:19:59 INFO - PROCESS | 32274 | __end_tp_report 08:19:59 INFO - PROCESS | 32274 | __start_cc_report 08:19:59 INFO - PROCESS | 32274 | _x_x_mozilla_cycle_collect,849 08:19:59 INFO - PROCESS | 32274 | __end_cc_report 08:19:59 INFO - PROCESS | 32274 | __startTimestamp1467731999711__endTimestamp 08:19:59 INFO - PROCESS | 32274 | 08:19:59 INFO - PROCESS | 32274 | ------- Summary: start ------- 08:19:59 INFO - PROCESS | 32274 | Number of tests: 6 08:19:59 INFO - PROCESS | 32274 | 08:19:59 INFO - PROCESS | 32274 | [#0] dojo.html Cycles:165 Average:5351.90 Median:5545.09 stddev:588.82 (10.6%) stddev-sans-first:566.74 08:19:59 INFO - PROCESS | 32274 | Values: 3235.9 3272.9 3276.5 3293.9 3310.3 5302.7 5308.8 5316.2 5329.4 5345.0 5311.6 5318.6 5337.8 5343.1 5348.4 4786.7 4871.8 4881.9 4884.7 4941.1 4855.4 4955.3 4961.7 4985.0 5002.4 4981.6 5025.8 5031.4 5035.9 5059.6 4794.4 4967.8 4993.3 4997.4 5026.7 4850.2 4906.9 4907.9 4914.7 4944.0 5316.8 5330.2 5361.3 5371.8 5424.7 5696.8 5745.4 5799.4 5821.2 5825.2 5832.1 5853.6 5854.4 5875.6 5880.2 5440.7 5473.9 5479.9 5481.3 5486.7 5823.0 5824.6 5900.1 5945.5 6017.6 5645.0 5661.5 5664.8 5674.7 5700.3 5664.9 5708.1 5710.5 5716.0 5716.0 5575.1 5624.8 5654.4 5695.5 5706.5 5632.4 5643.0 5644.5 5646.7 5693.1 4346.2 4360.1 4361.6 4374.2 4389.0 3921.2 3968.2 3969.5 3971.7 3993.7 5509.8 5541.6 5545.1 5559.6 5562.7 5811.3 5841.6 5849.0 5853.0 5885.7 5352.5 5470.4 5517.1 5529.6 5532.3 4787.7 4797.6 4804.7 4806.1 4833.2 5880.2 5940.2 5953.7 5961.2 5966.0 5682.4 5753.7 5759.3 5766.9 5776.6 6087.5 6092.6 6113.5 6120.2 6121.1 5506.0 5561.6 5712.1 5737.3 5755.9 5718.3 5718.4 5726.7 5739.2 5756.8 5564.9 5569.8 5573.2 5574.9 5576.1 5526.8 5539.3 5567.5 5574.6 5677.0 5459.2 5471.5 5473.1 5484.5 5532.6 5550.9 5556.6 5578.7 5578.8 5579.2 5341.5 5530.7 5552.8 5601.7 5619.9 08:19:59 INFO - PROCESS | 32274 | 08:19:59 INFO - PROCESS | 32274 | [#1] ext.html Cycles:180 Average:57507.92 Median:3691.48 stddev:114408.49 (3099.3%) stddev-sans-first:114649.80 08:19:59 INFO - PROCESS | 32274 | Values: 653.1 679.7 683.9 742.6 764.7 31885.4 32290.4 32408.7 40325.0 41195.0 42904.8 43324.6 43362.8 43400.3 43432.8 8731.5 8929.1 8953.8 8961.9 8974.5 8235.8 8476.4 8673.3 10544.4 10823.9 10522.7 10583.8 10600.3 10615.8 10616.5 10424.5 10478.6 10500.8 10510.5 10512.2 10279.1 10395.6 10400.3 10403.8 10404.5 38154.2 38650.4 42420.0 42498.6 42554.6 3543.2 3688.7 4163.7 4289.3 4384.5 33562.2 33647.8 33880.0 34759.7 35501.8 4273.8 4313.2 4317.4 4331.1 4354.9 356748.0 357247.0 357830.0 359785.0 359818.0 39316.8 40082.0 61820.4 61840.8 62320.1 37617.2 37625.0 37645.4 37760.4 37785.4 16496.4 16514.8 16541.2 16542.8 16667.1 12819.6 13782.8 13828.3 13871.2 13873.0 9207.1 9441.0 9484.7 9510.5 9521.4 3566.0 3629.3 3676.5 3694.2 3757.7 1066.3 1131.1 1151.9 1203.9 1226.8 33457.5 33512.2 33696.8 33761.0 33845.0 1189.0 1220.8 1226.5 1292.0 1316.6 17505.4 17584.4 17676.5 17760.7 17798.1 495002.0 497735.0 502323.0 503230.0 503962.0 61766.4 62404.7 62435.0 62543.7 62560.7 1326.1 1365.3 1458.6 1508.2 1509.8 30198.5 31967.5 33515.3 34051.3 34110.5 48343.8 48600.8 48734.0 48741.0 48755.3 330039.0 330746.0 330797.0 332369.0 672790.0 30310.4 30334.4 30662.0 30664.0 30968.7 44025.6 45644.8 46851.3 48152.8 49420.3 39791.6 40871.0 41091.6 41384.8 41708.2 37884.8 38853.6 38926.2 39140.0 39714.6 41248.4 43871.0 44387.3 44791.6 45069.0 33482.8 36085.5 36954.3 37114.6 37367.0 28630.0 28762.3 29352.7 29400.9 29431.4 08:19:59 INFO - PROCESS | 32274 | 08:19:59 INFO - PROCESS | 32274 | [#2] jquery.html Cycles:180 Average:33543.69 Median:26741.97 stddev:96362.54 (360.3%) stddev-sans-first:96600.78 08:19:59 INFO - PROCESS | 32274 | Values: 426.8 431.1 434.3 442.6 447.5 18784.5 19313.0 19561.8 20142.2 20473.6 20002.5 20150.6 20834.5 20878.5 20891.6 5828.9 5894.4 6063.9 6067.5 6072.5 4199.3 5946.3 6044.3 6257.1 6539.2 6536.5 6545.5 6546.8 6556.6 6560.1 6487.8 7351.2 7630.8 7669.7 7677.6 4760.2 4890.6 6343.3 7458.9 7467.9 26037.7 26707.2 26776.7 26829.7 27312.6 2505.4 2698.5 2934.7 3015.7 3345.5 15869.8 15933.4 16386.5 17051.7 17189.1 2240.4 2289.5 2296.5 2311.1 2371.9 91088.5 92566.1 93489.5 93791.0 97901.0 17957.0 18527.5 19160.0 19200.2 19280.2 34571.5 34595.7 34886.7 35124.5 35164.0 8135.6 8428.1 8540.5 8624.1 8625.6 8881.6 8901.7 8926.3 8996.6 9123.6 4593.1 5055.8 5106.0 5145.3 5161.1 1763.4 1807.6 1916.1 1991.4 2063.5 1019.6 1080.4 1102.3 1108.2 1140.0 18248.1 18634.6 18702.6 19888.3 20296.5 1078.8 1091.3 1102.0 1113.8 1131.6 10471.6 11063.9 11097.2 11106.7 11213.9 537838.0 583524.0 586608.0 599370.0 619694.0 98458.0 100969.0 101048.5 101056.5 101141.5 1116.5 1121.8 1169.8 1175.3 1197.4 17084.7 17322.0 17416.3 17583.6 18265.6 41541.2 41699.0 42580.4 42956.0 42980.0 57696.7 57716.4 58120.0 58215.0 58383.4 9197.6 9264.5 9306.2 9400.9 9475.7 10348.7 13147.0 13206.3 13600.8 13607.2 11326.7 11366.5 11369.8 11522.0 11937.9 11259.7 11297.9 11310.3 11498.9 11771.7 11800.0 11959.9 12184.3 12341.0 12435.0 8769.3 8821.8 8984.6 9104.2 9170.5 9319.3 11753.1 11766.1 11786.4 11906.6 08:19:59 INFO - PROCESS | 32274 | 08:19:59 INFO - PROCESS | 32274 | [#3] mootools.html Cycles:180 Average:5353.78 Median:4762.65 stddev:2971.91 (62.4%) stddev-sans-first:2965.42 08:19:59 INFO - PROCESS | 32274 | Values: 1403.4 1529.7 1537.4 1726.0 1859.4 7904.8 8005.4 8032.5 8034.0 8041.6 7890.3 8084.4 8099.4 8099.8 8103.5 2323.2 2343.6 2346.7 2347.2 2348.7 2314.3 2351.0 2351.5 2359.5 2362.9 2292.9 2299.0 2305.5 2355.4 2356.3 2254.6 2254.8 2258.1 2260.3 2285.2 2322.1 2331.0 2335.0 2336.8 2354.0 7925.6 8079.1 8308.1 8324.6 8355.5 4906.9 4998.2 5001.4 5006.2 5006.3 3347.2 3352.2 3383.6 3474.0 3474.9 1142.4 1145.7 1171.7 1186.6 1239.0 11194.2 11203.0 11243.4 11262.9 11270.5 4240.8 4272.7 4317.4 4321.4 4399.5 8997.2 9011.7 9026.9 9039.8 9058.6 5017.5 5032.1 5032.6 5033.9 5041.5 4129.9 4520.9 4613.1 4614.7 4653.8 3748.4 3761.5 3772.4 3817.7 3846.9 1143.9 1145.2 1165.5 1168.5 1169.1 712.9 791.6 906.6 922.4 924.9 5300.2 5512.7 5555.0 5581.6 5591.4 443.6 445.6 449.5 469.9 474.9 3415.0 3553.9 3564.8 3565.2 3574.2 9956.4 10048.7 10210.5 10210.8 10217.2 9957.3 10087.9 10092.3 10093.2 10098.7 7825.8 7842.6 7940.1 7943.2 7975.3 5301.9 5470.7 5505.5 5603.0 5627.9 8765.6 8777.2 8941.3 9055.9 9315.0 9024.5 9042.5 9066.4 9081.4 9134.7 6736.0 6780.4 7007.9 7346.5 7500.5 7684.2 7717.0 7755.4 7757.0 7764.7 6826.4 6956.9 6977.9 7090.2 7101.2 6683.1 6826.8 6850.7 6852.9 7006.6 6389.3 6573.2 6598.1 6758.9 6781.0 4634.7 4641.2 4694.8 4720.5 4763.6 4513.5 4604.6 4715.7 4761.7 4818.0 08:19:59 INFO - PROCESS | 32274 | 08:19:59 INFO - PROCESS | 32274 | [#4] prototype.html Cycles:180 Average:5520.75 Median:6243.77 stddev:1658.04 (26.6%) stddev-sans-first:1616.71 08:19:59 INFO - PROCESS | 32274 | Values: 354.3 354.8 357.2 358.3 359.5 6186.1 6212.3 6224.6 6229.6 6248.7 6105.9 6180.6 6186.5 6200.8 6211.7 4504.1 4643.7 4651.2 4654.9 4682.2 4796.7 4798.0 4798.3 4798.8 4809.9 4728.5 4763.4 4766.8 4769.0 4771.7 4500.5 4623.5 4703.7 4751.2 4765.1 4155.6 4164.0 4177.7 4178.2 4178.7 5824.5 5828.4 5909.4 5933.0 5938.1 5543.6 5558.8 5559.1 5560.3 5566.6 6456.2 6516.4 6526.9 6527.8 6535.5 4609.4 4654.0 4699.6 4700.5 4707.3 6758.7 6801.6 6804.6 6809.1 6813.1 4802.1 4810.0 4814.6 4820.2 4823.4 4877.3 4878.0 4886.5 4888.6 4888.7 5553.7 5560.7 5562.8 5563.6 5579.9 6238.9 6426.3 6555.8 6558.3 6559.6 1634.8 1640.9 1645.7 1646.0 1651.8 1084.6 1100.6 1109.9 1112.7 1119.3 6195.4 6282.9 6352.4 6377.9 6379.5 6707.8 6713.9 6737.8 6813.7 6817.4 6449.2 6458.2 6459.6 6461.2 6463.6 3639.1 3677.2 3683.9 3687.3 3688.9 7032.3 7157.8 7175.6 7186.3 7206.7 6906.1 6940.5 6945.0 6947.0 6982.8 7139.0 7141.3 7141.4 7147.1 7147.6 6775.4 6788.3 6790.4 6796.3 6797.9 6579.9 6697.1 6697.6 6701.7 6731.1 7125.9 7149.0 7168.7 7176.9 7178.5 4678.9 4688.2 4690.5 4698.0 4699.4 6783.5 6785.6 6788.8 6793.9 6794.8 6377.3 6557.8 6600.4 6606.4 6609.3 6491.8 6523.1 6525.5 6556.6 6558.8 6404.4 6407.8 6411.9 6413.8 6416.1 6531.2 6584.3 6589.4 6595.7 6600.9 6315.7 6429.3 6444.0 6462.6 6478.1 08:19:59 INFO - PROCESS | 32274 | 08:19:59 INFO - PROCESS | 32274 | [#5] yui.html Cycles:180 Average:15931.64 Median:4565.62 stddev:19633.93 (430.0%) stddev-sans-first:19656.28 08:19:59 INFO - PROCESS | 32274 | Values: 835.5 839.7 877.0 896.0 917.8 13374.7 13619.7 13650.4 13662.2 13665.5 12505.7 12560.9 12573.7 12603.0 12604.6 727.9 853.3 875.6 878.3 883.1 872.4 874.1 880.4 880.4 880.5 936.5 937.1 937.2 937.7 939.8 787.3 922.4 942.1 948.2 951.4 681.7 682.7 682.7 682.7 683.5 12247.3 12281.3 12298.6 12305.9 12307.1 14123.5 14764.2 14799.6 14906.6 15402.8 10966.0 11094.1 11263.5 11303.0 11359.7 3871.9 3878.7 3911.4 3915.6 3946.3 59197.4 59335.1 59831.7 60133.0 60228.4 10382.2 10428.7 10956.6 11189.1 11226.0 19473.6 19519.1 19530.7 19533.9 19552.3 8236.9 8286.5 8301.0 8582.0 8984.1 4494.0 4612.2 4636.2 4676.2 4764.5 3465.0 3511.9 3513.5 3517.9 3518.4 543.3 626.2 650.2 665.1 667.8 756.0 762.5 789.4 801.9 823.2 8600.5 8879.5 8918.2 8958.3 9096.1 757.0 768.1 780.6 780.6 787.9 4048.4 4287.0 4395.7 4427.6 4519.1 62038.0 72615.3 72914.0 72935.3 73195.6 60583.7 62849.0 63103.0 63142.0 63509.7 55046.7 55595.4 56972.4 57391.7 58874.8 9641.7 9665.4 9683.6 9789.6 9812.7 40472.2 41547.0 41755.0 42149.8 42400.8 50532.0 51619.5 53664.2 54396.0 54423.2 12045.2 12399.1 12421.4 12611.9 12727.0 12116.6 12369.3 12374.9 12669.7 13305.5 12081.2 12261.9 12410.9 12414.4 12442.9 12300.7 12325.5 12327.9 12336.2 12377.3 11431.5 11433.7 12171.8 12435.1 12579.2 10469.4 10706.6 10865.9 10919.3 11401.0 10659.7 10686.9 10891.8 10988.0 11315.8 08:19:59 INFO - PROCESS | 32274 | -------- Summary: end -------- 08:19:59 INFO - PROCESS | 32274 | 08:20:00 INFO - TEST-INFO | 32274: exit 0 08:20:00 INFO - TEST-OK | dromaeo_css | took 1109934ms 08:20:00 INFO - TEST-START | kraken 08:20:00 INFO - operating with platform_type : linux_ 08:20:00 INFO - Initialising browser for kraken test... 08:20:00 INFO - TEST-INFO | started process 32469 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpecUGdb/profile http://localhost:53630/getInfo.html) 08:20:03 INFO - PROCESS | 32469 | __metrics Screen width/height:1600/1200 08:20:03 INFO - PROCESS | 32469 | colorDepth:24 08:20:03 INFO - PROCESS | 32469 | Browser inner width/height: 1024/697 08:20:03 INFO - PROCESS | 32469 | __metrics 08:20:04 ERROR - PROCESS | 32469 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:20:05 INFO - TEST-INFO | 32469: exit 0 08:20:05 INFO - Browser initialized. 08:20:05 INFO - Running cycle 1/1 for kraken test... 08:20:05 INFO - TEST-INFO | started process 32559 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpecUGdb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:20:17 INFO - PROCESS | 32559 | RSS: Main: 139182080 08:20:17 INFO - PROCESS | 32559 | 08:20:19 INFO - PROCESS | 32559 | Cycle 1(1): loaded http://localhost:53630/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53630/tests/kraken/driver.html?testName=audio-beat-detection) 08:20:20 INFO - PROCESS | 32559 | RSS: Main: 197824512 08:20:20 INFO - PROCESS | 32559 | 08:20:23 INFO - PROCESS | 32559 | Cycle 1(1): loaded http://localhost:53630/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53630/tests/kraken/driver.html?testName=audio-dft) 08:20:23 INFO - PROCESS | 32559 | RSS: Main: 185413632 08:20:23 INFO - PROCESS | 32559 | 08:20:26 INFO - PROCESS | 32559 | Cycle 1(1): loaded http://localhost:53630/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53630/tests/kraken/driver.html?testName=audio-fft) 08:20:27 INFO - PROCESS | 32559 | RSS: Main: 274259968 08:20:27 INFO - PROCESS | 32559 | 08:20:29 INFO - PROCESS | 32559 | Cycle 1(1): loaded http://localhost:53630/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53630/tests/kraken/driver.html?testName=audio-oscillator) 08:20:29 INFO - PROCESS | 32559 | RSS: Main: 180916224 08:20:29 INFO - PROCESS | 32559 | 08:20:32 INFO - PROCESS | 32559 | Cycle 1(1): loaded http://localhost:53630/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53630/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:20:32 INFO - PROCESS | 32559 | RSS: Main: 179077120 08:20:32 INFO - PROCESS | 32559 | 08:20:35 INFO - PROCESS | 32559 | Cycle 1(1): loaded http://localhost:53630/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53630/tests/kraken/driver.html?testName=imaging-darkroom) 08:20:36 INFO - PROCESS | 32559 | RSS: Main: 213327872 08:20:36 INFO - PROCESS | 32559 | 08:20:39 INFO - PROCESS | 32559 | Cycle 1(1): loaded http://localhost:53630/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53630/tests/kraken/driver.html?testName=imaging-desaturate) 08:20:40 INFO - PROCESS | 32559 | RSS: Main: 213581824 08:20:40 INFO - PROCESS | 32559 | 08:20:42 INFO - PROCESS | 32559 | Cycle 1(1): loaded http://localhost:53630/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53630/tests/kraken/driver.html?testName=json-parse-financial) 08:20:43 INFO - PROCESS | 32559 | RSS: Main: 212803584 08:20:43 INFO - PROCESS | 32559 | 08:20:45 INFO - PROCESS | 32559 | Cycle 1(1): loaded http://localhost:53630/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53630/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:20:45 INFO - PROCESS | 32559 | RSS: Main: 192999424 08:20:45 INFO - PROCESS | 32559 | 08:20:47 INFO - PROCESS | 32559 | Cycle 1(1): loaded http://localhost:53630/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53630/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:20:47 INFO - PROCESS | 32559 | RSS: Main: 197455872 08:20:47 INFO - PROCESS | 32559 | 08:20:49 INFO - PROCESS | 32559 | Cycle 1(1): loaded http://localhost:53630/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53630/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:20:50 INFO - PROCESS | 32559 | RSS: Main: 209723392 08:20:50 INFO - PROCESS | 32559 | 08:20:52 INFO - PROCESS | 32559 | Cycle 1(1): loaded http://localhost:53630/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53630/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:20:53 INFO - PROCESS | 32559 | RSS: Main: 216797184 08:20:53 INFO - PROCESS | 32559 | 08:20:56 INFO - PROCESS | 32559 | Cycle 1(1): loaded http://localhost:53630/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53630/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:20:56 INFO - PROCESS | 32559 | RSS: Main: 212193280 08:20:56 INFO - PROCESS | 32559 | 08:20:58 INFO - PROCESS | 32559 | Cycle 1(1): loaded http://localhost:53630/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53630/tests/kraken/driver.html?testName=ai-astar) 08:20:58 INFO - PROCESS | 32559 | RSS: Main: 273653760 08:20:58 INFO - PROCESS | 32559 | 08:20:58 INFO - PROCESS | 32559 | __start_tp_report 08:20:58 INFO - PROCESS | 32559 | _x_x_mozilla_page_load 08:20:58 INFO - PROCESS | 32559 | _x_x_mozilla_page_load_details 08:20:58 INFO - PROCESS | 32559 | |i|pagename|runs| 08:20:58 INFO - PROCESS | 32559 | |0;ai-astar;110;111;110;113;111;110;106;109;110;112 08:20:58 INFO - PROCESS | 32559 | |1;audio-beat-detection;160;133;156;189;127;159;164;128;176;125 08:20:58 INFO - PROCESS | 32559 | |2;audio-dft;160;160;160;160;161;161;162;163;161;160 08:20:58 INFO - PROCESS | 32559 | |3;audio-fft;76;76;76;173;73;85;72;77;182;75 08:20:58 INFO - PROCESS | 32559 | |4;audio-oscillator;92;92;152;92;93;93;153;92;93;159 08:20:58 INFO - PROCESS | 32559 | |5;imaging-gaussian-blur;117;117;117;117;117;117;116;116;117;116 08:20:58 INFO - PROCESS | 32559 | |6;imaging-darkroom;145;145;145;144;145;145;145;145;145;145 08:20:58 INFO - PROCESS | 32559 | |7;imaging-desaturate;95;94;94;95;96;95;94;94;94;95 08:20:58 INFO - PROCESS | 32559 | |8;json-parse-financial;54;54;52;52;54;55;53;78;51;51 08:20:58 INFO - PROCESS | 32559 | |9;json-stringify-tinderbox;59;58;59;58;58;58;58;59;58;58 08:20:58 INFO - PROCESS | 32559 | |10;stanford-crypto-aes;72;78;72;71;73;72;75;73;75;72 08:20:58 INFO - PROCESS | 32559 | |11;stanford-crypto-ccm;122;111;112;109;118;117;109;112;133;127 08:20:58 INFO - PROCESS | 32559 | |12;stanford-crypto-pbkdf2;154;154;154;157;154;158;152;156;153;152 08:20:58 INFO - PROCESS | 32559 | |13;stanford-crypto-sha256-iterative;69;67;66;68;66;66;70;67;67;67 08:20:58 INFO - PROCESS | 32559 | __end_tp_report 08:20:58 INFO - PROCESS | 32559 | __start_cc_report 08:20:58 INFO - PROCESS | 32559 | _x_x_mozilla_cycle_collect,1581 08:20:58 INFO - PROCESS | 32559 | __end_cc_report 08:20:58 INFO - PROCESS | 32559 | __startTimestamp1467732058671__endTimestamp 08:20:58 INFO - PROCESS | 32559 | 08:20:58 INFO - PROCESS | 32559 | ------- Summary: start ------- 08:20:58 INFO - PROCESS | 32559 | Number of tests: 14 08:20:58 INFO - PROCESS | 32559 | 08:20:58 INFO - PROCESS | 32559 | [#0] ai-astar Cycles:10 Average:110.20 Median:110.50 stddev:1.87 (1.7%) stddev-sans-first:1.99 08:20:58 INFO - PROCESS | 32559 | Values: 110.0 111.0 110.0 113.0 111.0 110.0 106.0 109.0 110.0 112.0 08:20:58 INFO - PROCESS | 32559 | 08:20:58 INFO - PROCESS | 32559 | [#1] audio-beat-detection Cycles:10 Average:151.70 Median:159.50 stddev:22.38 (14.0%) stddev-sans-first:23.54 08:20:58 INFO - PROCESS | 32559 | Values: 160.0 133.0 156.0 189.0 127.0 159.0 164.0 128.0 176.0 125.0 08:20:58 INFO - PROCESS | 32559 | 08:20:58 INFO - PROCESS | 32559 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.03 (0.6%) stddev-sans-first:1.05 08:20:58 INFO - PROCESS | 32559 | Values: 160.0 160.0 160.0 160.0 161.0 161.0 162.0 163.0 161.0 160.0 08:20:58 INFO - PROCESS | 32559 | 08:20:58 INFO - PROCESS | 32559 | [#3] audio-fft Cycles:10 Average:96.50 Median:76.00 stddev:42.88 (56.4%) stddev-sans-first:44.84 08:20:58 INFO - PROCESS | 32559 | Values: 76.0 76.0 76.0 173.0 73.0 85.0 72.0 77.0 182.0 75.0 08:20:58 INFO - PROCESS | 32559 | 08:20:58 INFO - PROCESS | 32559 | [#4] audio-oscillator Cycles:10 Average:111.10 Median:92.00 stddev:30.12 (32.7%) stddev-sans-first:31.14 08:20:58 INFO - PROCESS | 32559 | Values: 92.0 92.0 152.0 92.0 93.0 93.0 153.0 92.0 93.0 159.0 08:20:58 INFO - PROCESS | 32559 | 08:20:58 INFO - PROCESS | 32559 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 08:20:58 INFO - PROCESS | 32559 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 117.0 116.0 08:20:58 INFO - PROCESS | 32559 | 08:20:58 INFO - PROCESS | 32559 | [#6] imaging-darkroom Cycles:10 Average:144.90 Median:145.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 08:20:58 INFO - PROCESS | 32559 | Values: 145.0 145.0 145.0 144.0 145.0 145.0 145.0 145.0 145.0 145.0 08:20:58 INFO - PROCESS | 32559 | 08:20:58 INFO - PROCESS | 32559 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 08:20:58 INFO - PROCESS | 32559 | Values: 95.0 94.0 94.0 95.0 96.0 95.0 94.0 94.0 94.0 95.0 08:20:58 INFO - PROCESS | 32559 | 08:20:58 INFO - PROCESS | 32559 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:54.00 stddev:8.06 (14.9%) stddev-sans-first:8.53 08:20:58 INFO - PROCESS | 32559 | Values: 54.0 54.0 52.0 52.0 54.0 55.0 53.0 78.0 51.0 51.0 08:20:58 INFO - PROCESS | 32559 | 08:20:58 INFO - PROCESS | 32559 | [#9] json-stringify-tinderbox Cycles:10 Average:58.30 Median:58.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 08:20:58 INFO - PROCESS | 32559 | Values: 59.0 58.0 59.0 58.0 58.0 58.0 58.0 59.0 58.0 58.0 08:20:58 INFO - PROCESS | 32559 | 08:20:58 INFO - PROCESS | 32559 | [#10] stanford-crypto-aes Cycles:10 Average:73.30 Median:73.00 stddev:2.11 (2.9%) stddev-sans-first:2.19 08:20:58 INFO - PROCESS | 32559 | Values: 72.0 78.0 72.0 71.0 73.0 72.0 75.0 73.0 75.0 72.0 08:20:58 INFO - PROCESS | 32559 | 08:20:58 INFO - PROCESS | 32559 | [#11] stanford-crypto-ccm Cycles:10 Average:117.00 Median:117.50 stddev:8.14 (6.9%) stddev-sans-first:8.43 08:20:58 INFO - PROCESS | 32559 | Values: 122.0 111.0 112.0 109.0 118.0 117.0 109.0 112.0 133.0 127.0 08:20:58 INFO - PROCESS | 32559 | 08:20:58 INFO - PROCESS | 32559 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.40 Median:154.00 stddev:2.01 (1.3%) stddev-sans-first:2.13 08:20:58 INFO - PROCESS | 32559 | Values: 154.0 154.0 154.0 157.0 154.0 158.0 152.0 156.0 153.0 152.0 08:20:58 INFO - PROCESS | 32559 | 08:20:58 INFO - PROCESS | 32559 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.00 stddev:1.34 (2.0%) stddev-sans-first:1.27 08:20:58 INFO - PROCESS | 32559 | Values: 69.0 67.0 66.0 68.0 66.0 66.0 70.0 67.0 67.0 67.0 08:20:58 INFO - PROCESS | 32559 | -------- Summary: end -------- 08:20:58 INFO - PROCESS | 32559 | 08:20:59 INFO - TEST-INFO | 32559: exit 0 08:20:59 INFO - TEST-OK | kraken | took 59239ms 08:20:59 INFO - SUITE-END | took 1169s 08:20:59 INFO - Completed test suite (00:19:29) 08:20:59 INFO - javascript benchmark 08:20:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3235.854386552605, 3272.869085236592, 3276.524903888936, 3293.901182964512, 3310.3379324135162, 5302.681839089652, 5308.8407347779585, 5316.175992721125, 5329.413764485904, 5344.973275133619, 5311.601629877755, 5318.6011049171275, 5337.786488540453, 5343.118385466403, 5348.358197016363, 4786.688865223767, 4871.829485967992, 4881.926771098437, 4884.731339776311, 4941.135301322272, 4855.368802055746, 4955.256711493269, 4961.677490963094, 4985.0, 5002.449730529639, 4981.626378021645, 5025.824096156635, 5031.396232452093, 5035.899282014376, 5059.620528460362, 4794.400699912511, 4967.776450059756, 4993.275974983625, 4997.350344455198, 5026.673266237701, 4850.248211527183, 4906.8773280668265, 4907.901841963177, 4914.680545764514, 4944.011197760462, 5316.787328506855, 5330.173823057394, 5361.3030306060355, 5371.81198658049, 5424.701641409721, 5696.800611978602, 5745.368009518949, 5799.420057994167, 5821.243238379026, 5825.1844741736195, 5832.125181222808, 5853.648781073107, 5854.385289544579, 5875.647461152302, 5880.235569375996, 5440.700761458118, 5473.890522189534, 5479.863003424906, 5481.342238931314, 5486.6982315973, 5822.970885145547, 5824.592278540546, 5900.085486749561, 5945.4649081582, 6017.608855424383, 5645.0, 5661.490465858093, 5664.830055098354, 5674.659520428788, 5700.25896633435, 5664.85837854057, 5708.086706127, 5710.457506536873, 5715.971420142956, 5716.028275193227, 5575.135853942646, 5624.803131890364, 5654.434556544395, 5695.487406133385, 5706.4864162225595, 5632.436756324335, 5643.040683083886, 5644.520215781622, 5646.717664116778, 5693.146028095736, 4346.174226896879, 4360.127974405132, 4361.563843615677, 4374.212641724456, 4388.990532177617, 3921.156951255494, 3968.1666849961252, 3969.543502497192, 3971.6624086952356, 3993.7004724645767, 5509.842932984038, 5541.612087153861, 5545.085060964896, 5559.63862348946, 5562.749676264578, 5811.302643682785, 5841.591088623755, 5848.970755146197, 5852.970735146382, 5885.705714714247, 5352.518273355417, 5470.398256191816, 5517.117261238182, 5529.640573362719, 5532.30846144232, 4787.664863459594, 4797.616190704735, 4804.735739534359, 4806.086843499724, 4833.178359678863, 5880.176775251382, 5940.198073260054, 5953.702314884238, 5961.225040744675, 5966.0454327307425, 5682.374938756733, 5753.741081651419, 5759.337676167294, 5766.913496297475, 5776.624519406225, 6087.482563981934, 6092.603980741238, 6113.5414843886, 6120.204373431426, 6121.051237058263, 5506.0, 5561.63849349791, 5712.143178523089, 5737.340205876378, 5755.913661295001, 5718.285214348207, 5718.370979192202, 5726.74229659658, 5739.167820666064, 5756.769729210952, 5564.860878478071, 5569.805056822992, 5573.21974923503, 5574.888502230014, 5576.1356989666665, 5526.751296191762, 5539.279893613965, 5567.47109024642, 5574.554035677217, 5677.0, 5459.235707001102, 5471.452854714496, 5473.096939005179, 5484.506394424521, 5532.557395408438, 5550.916736248879, 5556.611037227517, 5578.693171875586, 5578.804741834017, 5579.16312553104, 5341.4925582069645, 5530.695811730394, 5552.805651802168, 5601.663900166003, 5619.943800562106], "value": 5314.253395121369, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [653.0889409274063, 679.7043286170516, 683.8769021576117, 742.6398196874514, 764.6559048428202, 31885.362292754133, 32290.35419291616, 32408.67591324086, 40325.0, 41195.0, 42904.785476072655, 43324.566754332525, 43362.78318608402, 43400.3489947651, 43432.782836085855, 8731.519766412828, 8929.062448442884, 8953.776155596097, 8961.865572016424, 8974.46153230805, 8235.79410514739, 8476.364272679542, 8673.349498787584, 10544.420056896868, 10823.945880270587, 10522.736931576695, 10583.78832423351, 10600.310979786289, 10615.84076238857, 10616.522256498476, 10424.530896109693, 10478.58085676572, 10500.842487362695, 10510.527026283835, 10512.21158413122, 10279.074883260542, 10395.636152734618, 10400.323978941344, 10403.791924161551, 10404.479776011169, 38154.23691526182, 38650.42024369637, 42420.0, 42498.57501424977, 42554.57445425537, 3543.2382037861985, 3688.7417880748358, 4163.666906647461, 4289.2922667759785, 4384.539623339535, 33562.1609459763, 33647.83176084128, 33880.0, 34759.65240347589, 35501.82249088764, 4273.786310684453, 4313.202057619351, 4317.438732964726, 4331.068820203672, 4354.934675979863, 356748.0, 357247.0, 357830.0, 359785.0, 359818.0, 39316.80341598274, 40082.0, 61820.381796181464, 61840.83557075481, 62320.06519902205, 37617.24765504729, 37625.0, 37645.43531847024, 37760.43359349557, 37785.43321850174, 16496.42262520806, 16514.84396092286, 16541.172941353125, 16542.83457165437, 16667.083310418042, 12819.551315704091, 13782.793258101137, 13828.308584570932, 13871.23708196059, 13873.0, 9207.079292070739, 9440.96149423563, 9484.715458536255, 9510.524473776284, 9521.381110227812, 3565.964340356615, 3629.2741451709235, 3676.485292059114, 3694.224212915318, 3757.699384049324, 1066.3388699006666, 1131.0781712903956, 1151.8963293303643, 1203.867574566797, 1226.791445454275, 33457.49813752795, 33512.1621959453, 33696.83151584226, 33761.0, 33844.98465046052, 1189.0309397840733, 1220.8290839282508, 1226.533917111492, 1291.9741605168033, 1316.605018494448, 17505.38731144404, 17584.38454654081, 17676.469705908843, 17760.733588996176, 17798.110094495223, 495002.0, 497735.0, 502323.0, 503230.0, 503962.0, 61766.38233617696, 62404.68797655983, 62435.0, 62543.6872815633, 62560.687196564635, 1326.1380102932978, 1365.3105181883086, 1458.6207586027708, 1508.1629695519093, 1509.803725515676, 30198.54702179513, 31967.520487193175, 33515.32969340551, 34051.31897362089, 34110.48834267537, 48343.758281209775, 48600.75699621479, 48734.0, 48741.0, 48755.268670970676, 330039.0, 330746.0, 330797.0, 332369.0, 672790.0, 30310.393792124476, 30334.393312134074, 30662.0, 30664.0, 30968.69031309658, 44025.55974440215, 45644.77177614091, 46851.297230540884, 48152.759236203594, 49420.258696118864, 39791.60208397879, 40871.0, 41091.589084109975, 41384.793076034424, 41708.1658366837, 37884.81057594695, 38853.611463885, 38926.2214755709, 39140.0, 39714.60285397225, 41248.38127428031, 43871.0, 44387.33418998653, 44791.55208447874, 45069.0, 33482.83258583691, 36085.45871811977, 36954.260914781014, 37114.62885371112, 37367.0, 28630.0, 28762.280942976595, 29352.706472935, 29400.852995734884, 29431.411371772017], "value": 19653.728555423615, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [426.7501896395626, 431.11190946649896, 434.300775751041, 442.612713875359, 447.46304434678393, 18784.530386740338, 19313.0, 19561.804381956175, 20142.194312227493, 20473.590528189427, 20002.499937501532, 20150.59698806023, 20834.479138021557, 20878.478038049056, 20891.58216835666, 5828.88342233154, 5894.3810899855325, 6063.939360606381, 6067.514598832105, 6072.514198864103, 4199.286121359376, 5946.345901950782, 6044.2746870375395, 6257.092721555395, 6539.247986481568, 6536.509761767863, 6545.509086818483, 6546.770863019795, 6556.573822701533, 6560.1143845580955, 6487.7729279475225, 7351.191368949411, 7630.8473830523635, 7669.73155939545, 7677.577733224671, 4760.166970780134, 4890.608751299887, 6343.302236754, 7458.8881166782, 7467.925320746832, 26037.73962260391, 26707.19878403651, 26776.73223267762, 26829.73170268292, 27312.590311145348, 2505.3736565858535, 2698.5142674318613, 2934.7065293470696, 3015.7135072168107, 3345.531625572422, 15869.761953570705, 15933.442329518411, 16386.508404747878, 17051.744223836653, 17189.05460199701, 2240.3950933247934, 2289.507755832504, 2296.471811483368, 2311.110222564308, 2371.9288421347387, 91088.5445572768, 92566.07433925642, 93489.53255233681, 93791.0, 97901.0, 17957.0, 18527.53681157955, 19160.0, 19200.231990720495, 19280.22879084821, 34571.481427778606, 34595.65404345975, 34886.65113348885, 35124.473132903026, 35164.0, 8135.633896474555, 8428.115047920002, 8540.487570745776, 8624.137586241326, 8625.568721563897, 8881.644734210688, 8901.688440904538, 8926.330525210635, 8996.59515321799, 9123.589438475285, 4593.058423023273, 5055.811884207208, 5105.9744701276995, 5145.253938179018, 5161.122609156378, 1763.3740022292159, 1807.5661841158028, 1916.0802814648769, 1991.445270192728, 2063.484128967758, 1019.5666841592293, 1080.4111759091313, 1102.2780079048237, 1108.1578000719512, 1139.9829002564968, 18248.087595620167, 18634.627307454048, 18702.625947480974, 19888.3039093631, 20296.49258768513, 1078.8327809189432, 1091.2906610703108, 1101.9559217631365, 1113.7828123516, 1131.6378758797107, 10471.633492827867, 11063.889361106447, 11097.223194376478, 11106.722331941766, 11213.94393028046, 537838.0, 583524.0, 586608.0, 599370.0, 619694.0, 98458.0, 100969.0, 101048.49475752574, 101056.49471752594, 101141.49429252806, 1116.508736156105, 1121.786860496503, 1169.8128299472044, 1175.330061864746, 1197.4012993503247, 17084.74372884383, 17322.0, 17416.30334786594, 17583.648327033643, 18265.634687306447, 41541.169176615695, 41699.0, 42580.36129457998, 42956.0, 42980.0, 57696.71151644215, 57716.4228357711, 58120.0, 58215.0, 58383.4161658378, 9197.586108624993, 9264.490453025148, 9306.162445379949, 9400.858987115062, 9475.715728528156, 10348.689539313833, 13147.0, 13206.27365494907, 13600.795988059988, 13607.183568985893, 11326.716832079264, 11366.545338186379, 11369.772604548029, 11522.0, 11937.94031029874, 11259.718507037389, 11297.943510282395, 11310.321380717183, 11498.885011150116, 11771.705707357385, 11800.0, 11959.880401196224, 12184.268943863397, 12341.0, 12435.0, 8769.342299327704, 8821.823563528822, 8984.550772461482, 9104.226140778108, 9170.495622740547, 9319.30105242096, 11753.118516111497, 11766.058715302584, 11786.41067946582, 11906.642800715992], "value": 10350.684734002954, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1403.354456949803, 1529.6864142850714, 1537.3850459816072, 1725.9654806903861, 1859.4142845003823, 7904.8419031619405, 8005.4396192266495, 8032.477888937215, 8033.959830200848, 8041.638126284317, 7890.289873911347, 8084.393670474723, 8099.392545559077, 8099.838003239932, 8103.473274237171, 2323.2217207235553, 2343.5664402085667, 2346.741858395575, 2347.248880358286, 2348.7416384197722, 2314.282572402552, 2350.9882450587725, 2351.459164392191, 2359.4691194481275, 2362.8818559072065, 2292.885355732207, 2299.0, 2305.5158416732506, 2355.4464700795297, 2356.2695564375013, 2254.6054440473017, 2254.797068263856, 2258.0741895822716, 2260.2541161416775, 2285.165914441234, 2322.082777302956, 2330.9883450582806, 2335.0309621507054, 2336.778006089419, 2353.9529209415714, 7925.643346049384, 8079.111297757242, 8308.086110527836, 8324.62539185738, 8355.456895301786, 4906.901861962777, 4998.175301075355, 5001.44984051754, 5006.199008158714, 5006.3241462402475, 3347.163209197701, 3352.1619595101224, 3383.5770528683915, 3473.9826300868585, 3474.8957531274104, 1142.3774043146504, 1145.736480609456, 1171.6953592066125, 1186.6024881664653, 1239.0211732731132, 11194.160437967104, 11202.999999999918, 11243.437828108643, 11262.943685281603, 11270.549178032868, 4240.830366785356, 4272.700910936204, 4317.417148684887, 4321.438213032286, 4399.472063352354, 8997.19025287714, 9011.684591039282, 9026.86459703105, 9039.774005649911, 9058.637654493747, 5017.523335283142, 5032.0690672225755, 5032.647714659939, 5033.924491132636, 5041.470645582161, 4129.8967525812095, 4520.909581808345, 4613.0773845230415, 4614.74618895964, 4653.813847446064, 3748.437734339871, 3761.5110035695184, 3772.434134879735, 3817.7136714746507, 3846.9038274043373, 1143.9199256051998, 1145.1983611472003, 1165.4697112813649, 1168.4975460551875, 1169.1465230381868, 712.8503014366937, 791.6121100660635, 906.5829718329642, 922.4050487435701, 924.8726445422649, 5300.231466437345, 5512.724363781795, 5555.000099982042, 5581.553475722014, 5591.412901645269, 443.6450839328524, 445.5811537155064, 449.4606472233333, 469.93890794196534, 474.9192637251675, 3415.043787739437, 3553.875614353537, 3564.821758912044, 3565.16218688608, 3574.160072382988, 9956.402615843073, 10048.69853904384, 10210.489475526194, 10210.846837297446, 10217.18262538995, 9957.253206009578, 10087.899121008695, 10092.293539452168, 10093.192544596415, 10098.747531311776, 7825.765227043198, 7842.64708088126, 7940.1265860755275, 7943.165967573437, 7975.322097621767, 5301.920471193012, 5470.72646367672, 5505.532029777513, 5603.047481928001, 5627.8593035174445, 8765.649374024968, 8777.166169213915, 8941.329400294873, 9055.909440905507, 9314.95342523283, 9024.503652298923, 9042.50266235337, 9066.410683305565, 9081.409708368936, 9134.725958221265, 6735.966320168368, 6780.355866192901, 7007.859842803014, 7346.485745997729, 7500.474966752275, 7684.231576842271, 7717.0, 7755.418343624138, 7756.961215193888, 7764.650590723544, 6826.351496607815, 6956.860862782817, 6977.930220697728, 7090.184628767552, 7101.183363913216, 6683.131192944886, 6826.761063362758, 6850.657467126524, 6852.897206541807, 7006.649667516705, 6389.329120442287, 6573.244076931022, 6598.076269322395, 6758.8648227036165, 6780.966095169492, 4634.65240107, 4641.234196357564, 4694.812207511662, 4720.504347043511, 4763.595094417014, 4513.54864513546, 4604.562566556172, 4715.693479923794, 4761.714297142183, 4818.036392721399], "value": 4276.010850966745, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.3285474026718, 354.7967124158973, 357.16601734948887, 358.3102527634304, 359.5361983041876, 6186.072089186624, 6212.254529456472, 6224.564280500361, 6229.595076320042, 6248.656323902189, 6105.87788244236, 6180.598261113036, 6186.474149697281, 6200.78297259596, 6211.720472578733, 4504.121696269229, 4643.698159619614, 4651.232546629802, 4654.906901861961, 4682.2274324736545, 4796.688215266014, 4797.9520204797855, 4798.256270278095, 4798.83204087857, 4809.855704328876, 4728.503507131753, 4763.404574428197, 4766.809327626891, 4768.998510312821, 4771.689840160396, 4500.459944806611, 4623.468301145378, 4703.741294228816, 4751.16854550454, 4765.0946320199055, 4155.625993660585, 4163.958360416387, 4177.725793632941, 4178.227027999799, 4178.6657067434535, 5824.534037277008, 5828.41715828418, 5909.409059094056, 5932.9703351483395, 5938.079597662369, 5543.556515478752, 5558.833235002957, 5559.082751346023, 5560.304961879765, 5566.638168519034, 6456.225252969673, 6516.446102081329, 6526.934730652728, 6527.836804079889, 6535.509836762214, 4609.377734005933, 4654.0, 4699.624030077585, 4700.4594471635855, 4707.340972263886, 6758.695858686322, 6801.625910574917, 6804.55770374924, 6809.114815074058, 6813.11429514165, 4802.111609352281, 4809.95190048102, 4814.638902082288, 4820.180569303227, 4823.3729615149805, 4877.341558889504, 4878.048780487842, 4886.486918873467, 4888.560029597354, 4888.731119788375, 5553.694546799884, 5560.666360018412, 5562.805301814417, 5563.582731295169, 5579.888402231933, 6238.875222495525, 6426.325235850262, 6555.836104097436, 6558.344165583499, 6559.639219842955, 1634.7547867819922, 1640.868730501557, 1645.695546323934, 1646.0370683150252, 1651.7604947282578, 1084.5661735305941, 1100.5542755184163, 1109.9334039957628, 1112.7440688641657, 1119.322809700136, 6195.380461953859, 6282.905756413657, 6352.396522330371, 6377.936220637827, 6379.457746091634, 6707.765228216989, 6713.932860671331, 6737.831554211086, 6813.659317034228, 6817.386435220854, 6449.226092868886, 6458.192725909262, 6459.580127291711, 6461.19235095613, 6463.579867308704, 3639.1084184375, 3677.1542545214215, 3683.889483315505, 3687.317846198408, 3688.870889518854, 7032.296770322927, 7157.785266442015, 7175.569465832067, 7186.317299856505, 7206.747763828241, 6906.102206713095, 6940.548864323803, 6944.965275173592, 6947.0, 6982.825429364205, 7139.0, 7141.321574450419, 7141.428685705131, 7147.070880785464, 7147.64261786919, 6775.356341147583, 6788.287229840796, 6790.388865002174, 6796.320367963164, 6797.898031529432, 6579.901301480578, 6697.09589205451, 6697.631630260383, 6701.664916754045, 6731.091302674076, 7125.928740712527, 7149.034880291094, 7168.713251469882, 7176.892346614701, 7178.497505174588, 4678.906421871611, 4688.179568575418, 4690.460597031385, 4698.036902435061, 4699.412573428322, 6783.491238157257, 6785.558938668971, 6788.76239331621, 6793.864122717617, 6794.796156115324, 6377.266614339411, 6557.803265902031, 6600.372964568358, 6606.4384527315715, 6609.339066093545, 6491.805245842632, 6523.086767852409, 6525.543211975116, 6556.573822701509, 6558.8360290991195, 6404.359564043744, 6407.775727849689, 6411.871762564816, 6413.839654008687, 6416.101745755504, 6531.248906375828, 6584.275729669828, 6589.439897608757, 6595.670216489252, 6600.867982640224, 6315.747370105328, 6429.260635027032, 6443.96778016107, 6462.644554549357, 6478.125453063776], "value": 4981.208804289622, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [835.5488036460312, 839.7102999465183, 876.9605367758451, 895.9830592277763, 917.8118485710435, 13374.732505349888, 13619.659508512292, 13650.38573264203, 13662.180269183857, 13665.521706740266, 12505.749885002295, 12560.937195314033, 12573.748525029494, 12603.0, 12604.550476695184, 727.8944553039806, 853.2576658307281, 875.5578432891397, 878.3412440669498, 883.1345281624012, 872.3718922375879, 874.0996773323487, 880.4057261348596, 880.4057261348596, 880.4629176202511, 936.5223735894708, 937.1097457415483, 937.2314701944408, 937.6530683647026, 939.8308304505186, 787.322902304018, 922.4419226368051, 942.0908822985783, 948.1798244518511, 951.3673407184215, 681.7273090763684, 682.7132604306154, 682.7371461987121, 682.737146198717, 683.5454422808826, 12247.265164090182, 12281.324527151002, 12298.631041068693, 12305.938470307681, 12307.138500304982, 14123.505677301246, 14764.187969661665, 14799.556013319618, 14906.627334316621, 15402.768958465633, 10966.0, 11094.057005154571, 11263.54945802167, 11303.0, 11359.716007099805, 3871.8838434847, 3878.650921417058, 3911.3937339712106, 3915.5888631693833, 3946.3291240488898, 59197.40802592005, 59335.10997335, 59831.70084149595, 60133.0, 60228.397716022715, 10382.169426446017, 10428.739281517872, 10956.56173753041, 11189.097853364947, 11226.0, 19473.610527789366, 19519.121639526256, 19530.70703939442, 19533.902330488258, 19552.31566895152, 8236.876446853303, 8286.46138001028, 8300.958495207486, 8582.0, 8984.101589840964, 4493.955060449419, 4612.169809434334, 4636.165490211727, 4676.205045142334, 4764.523547645208, 3465.0, 3511.8595256189465, 3513.4554144107706, 3517.9296414071573, 3518.3666939950544, 543.2964311216983, 626.2328647406981, 650.2424675253371, 665.1054331923555, 667.7929841749074, 755.9584222867795, 762.4700832921177, 789.4158322841056, 801.943863929531, 823.2343920154194, 8600.483970961637, 8879.467231966102, 8918.241949434241, 8958.328125390492, 9096.081288802821, 756.9924300757032, 768.0859776865512, 780.5784876166806, 780.6174974262684, 787.8739401695701, 4048.4332193492933, 4286.978565107154, 4395.714278571946, 4427.623651989553, 4519.07358991406, 62038.0, 72615.27384726191, 72914.0, 72935.2706472939, 73195.63402182955, 60583.69708151431, 62849.0, 63103.0, 63142.0, 63509.68245158745, 55046.72476637591, 55595.44404555984, 56972.430275697545, 57391.71304143452, 58874.82250354969, 9641.710748677551, 9665.371750836173, 9683.612655493984, 9789.559469824018, 9812.656557020755, 40472.1905561893, 41547.0, 41755.0, 42149.789251054775, 42400.78799605982, 50532.0, 51619.483805161464, 53664.195037073696, 54396.0, 54423.18365224446, 12045.156839021534, 12399.101687572746, 12421.378931053592, 12611.87388126107, 12727.0, 12116.575919842764, 12369.319687417279, 12374.938125309316, 12669.683257918627, 13305.534306299232, 12081.214721043105, 12261.938690306491, 12410.937945310216, 12414.441350139447, 12442.937785311016, 12300.692482688004, 12325.506979721069, 12327.876721232673, 12336.198147120409, 12377.34353716239, 11431.542738290374, 11433.656990290305, 12171.817422738843, 12435.129540932048, 12579.182353147016, 10469.428949278581, 10706.571737130738, 10865.945670271598, 10919.328684129343, 11401.016188348, 10659.680209593724, 10686.946565267124, 10891.78216435651, 10988.0, 11315.773684526099], "value": 6983.070741236236, "unit": "score"}], "name": "dromaeo_css", "value": 7374.285350798764, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 110.0, 113.0, 111.0, 110.0, 106.0, 109.0, 110.0, 112.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 133.0, 156.0, 189.0, 127.0, 159.0, 164.0, 128.0, 176.0, 125.0], "value": 151.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 160.0, 161.0, 161.0, 162.0, 163.0, 161.0, 160.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 173.0, 73.0, 85.0, 72.0, 77.0, 182.0, 75.0], "value": 96.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 152.0, 92.0, 93.0, 93.0, 153.0, 92.0, 93.0, 159.0], "value": 111.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 144.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0], "value": 144.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 95.0, 96.0, 95.0, 94.0, 94.0, 94.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 52.0, 52.0, 54.0, 55.0, 53.0, 78.0, 51.0, 51.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 59.0, 58.0, 58.0, 58.0, 58.0, 59.0, 58.0, 58.0], "value": 58.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 78.0, 72.0, 71.0, 73.0, 72.0, 75.0, 73.0, 75.0, 72.0], "value": 73.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 111.0, 112.0, 109.0, 118.0, 117.0, 109.0, 112.0, 133.0, 127.0], "value": 117.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 154.0, 154.0, 157.0, 154.0, 158.0, 152.0, 156.0, 153.0, 152.0], "value": 154.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 66.0, 68.0, 66.0, 66.0, 70.0, 67.0, 67.0, 67.0], "value": 67.3, "unit": "score"}], "name": "kraken", "value": 1512.2, "alertThreshold": 2.0}]} 08:20:59 INFO - Return code: 0 08:20:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:20:59 ERROR - # TBPL SUCCESS # 08:20:59 INFO - Running post-action listener: _resource_record_post_action 08:20:59 INFO - Running post-run listener: _resource_record_post_run 08:21:01 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 477171712; Read time: 8; Write time: 313144 08:21:01 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 254717952; Read time: 0; Write time: 209180 08:21:01 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 4096; Write bytes: 222453760; Read time: 8; Write time: 103964 08:21:01 INFO - Running post-run listener: _upload_blobber_files 08:21:01 INFO - Blob upload gear active. 08:21:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:21:01 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 08:21:01 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:21:01 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:21:01 INFO - (blobuploader) - INFO - Open directory for files ... 08:21:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:21:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:21:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:21:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:21:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:21:02 INFO - (blobuploader) - INFO - Done attempting. 08:21:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:21:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:21:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:21:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:21:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:21:03 INFO - (blobuploader) - INFO - Done attempting. 08:21:03 INFO - (blobuploader) - INFO - Iteration through files over. 08:21:03 INFO - Return code: 0 08:21:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:21:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:21:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5322d77288b82412478b1fbed8cc39a06aabeee49c429e0ea6cb7bf19deddb10e6ef809a1363344881297bb3804ba5289631e606b7ff3edbefc2640b69923b5b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f851e487ed765bc4bb5c831a7224b1b7529825403802baf9aee858da46576b1c968633c10313dcf1c5be9fdc95f5e544d111d226d172456566ce47da69cd3fda"} 08:21:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:21:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:21:03 INFO - Contents: 08:21:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5322d77288b82412478b1fbed8cc39a06aabeee49c429e0ea6cb7bf19deddb10e6ef809a1363344881297bb3804ba5289631e606b7ff3edbefc2640b69923b5b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f851e487ed765bc4bb5c831a7224b1b7529825403802baf9aee858da46576b1c968633c10313dcf1c5be9fdc95f5e544d111d226d172456566ce47da69cd3fda"} 08:21:03 INFO - Running post-run listener: copy_logs_to_upload_dir 08:21:03 INFO - Copying logs to upload dir... 08:21:03 INFO - mkdir: /builds/slave/test/build/upload/logs 08:21:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1221.466791 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 21 secs) (at 2016-07-05 08:21:02.557548) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 08:21:02.560744) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1467730839.977496-2122453807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5322d77288b82412478b1fbed8cc39a06aabeee49c429e0ea6cb7bf19deddb10e6ef809a1363344881297bb3804ba5289631e606b7ff3edbefc2640b69923b5b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f851e487ed765bc4bb5c831a7224b1b7529825403802baf9aee858da46576b1c968633c10313dcf1c5be9fdc95f5e544d111d226d172456566ce47da69cd3fda"} build_url:https://queue.taskcluster.net/v1/task/CEdvWcnOT521k4-Ht_ZcnA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011337 build_url: 'https://queue.taskcluster.net/v1/task/CEdvWcnOT521k4-Ht_ZcnA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5322d77288b82412478b1fbed8cc39a06aabeee49c429e0ea6cb7bf19deddb10e6ef809a1363344881297bb3804ba5289631e606b7ff3edbefc2640b69923b5b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f851e487ed765bc4bb5c831a7224b1b7529825403802baf9aee858da46576b1c968633c10313dcf1c5be9fdc95f5e544d111d226d172456566ce47da69cd3fda"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 08:21:02.586713) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 08:21:02.587059) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1467730839.977496-2122453807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004400 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 08:21:02.671238) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 08:21:02.671811) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 08:21:02.672354) ========= ========= Total master_lag: 0.19 =========