builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-032 starttime: 1478033082.84 results: success (0) buildid: 20161101104104 builduid: a4c9b0296a074e9486905af10f3b78d8 revision: a0a503f568d86b61c0e2c8b17fcd31fdde98b4e1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-01 13:44:42.840993) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-01 13:44:42.841507) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-01 13:44:42.841794) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-01 13:44:42.857066) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-01 13:44:42.857492) ========= 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=745a4373a2a16df560f216e000000264-1478033082.411915-1410601440 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-01 13:44:43-- 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: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-11-01 13:44:43 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.090615 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-01 13:44:42.962370) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-01 13:44:42.962699) ========= 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=745a4373a2a16df560f216e000000264-1478033082.411915-1410601440 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015780 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-01 13:44:43.012571) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-01 13:44:43.012974) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev a0a503f568d86b61c0e2c8b17fcd31fdde98b4e1 --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 a0a503f568d86b61c0e2c8b17fcd31fdde98b4e1 --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=745a4373a2a16df560f216e000000264-1478033082.411915-1410601440 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-01 13:44:43,334 truncating revision to first 12 chars 2016-11-01 13:44:43,334 Setting DEBUG logging. 2016-11-01 13:44:43,334 attempt 1/10 2016-11-01 13:44:43,334 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/a0a503f568d8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-01 13:44:44,606 unpacking tar archive at: mozilla-beta-a0a503f568d8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.604230 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-01 13:44:44.631501) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-01 13:44:44.631913) ========= script_repo_revision: a0a503f568d86b61c0e2c8b17fcd31fdde98b4e1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-01 13:44:44.632356) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-01 13:44:44.632649) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-01 13:44:44.643780) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 56 secs) (at 2016-11-01 13:44:44.644187) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=745a4373a2a16df560f216e000000264-1478033082.411915-1410601440 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:44:45 INFO - MultiFileLogger online at 20161101 13:44:45 in /builds/slave/test 13:44:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 13:44:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:44:45 INFO - {'append_to_log': False, 13:44:45 INFO - 'base_work_dir': '/builds/slave/test', 13:44:45 INFO - 'blob_upload_branch': 'Mozilla-Beta', 13:44:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:44:45 INFO - 'branch': 'Mozilla-Beta', 13:44:45 INFO - 'buildbot_json_path': 'buildprops.json', 13:44:45 INFO - 'config_files': ('talos/linux_config.py',), 13:44:45 INFO - 'default_actions': ('clobber', 13:44:45 INFO - 'read-buildbot-config', 13:44:45 INFO - 'download-and-extract', 13:44:45 INFO - 'populate-webroot', 13:44:45 INFO - 'create-virtualenv', 13:44:45 INFO - 'install', 13:44:45 INFO - 'run-tests'), 13:44:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:44:45 INFO - 'download_minidump_stackwalk': True, 13:44:45 INFO - 'download_symbols': 'ondemand', 13:44:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:44:45 INFO - 'tooltool.py': '/tools/tooltool.py', 13:44:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:44:45 INFO - '/tools/misc-python/virtualenv.py')}, 13:44:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:44:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:44:45 INFO - 'installer_path': 'installer.exe', 13:44:45 INFO - 'log_level': 'info', 13:44:45 INFO - 'log_name': 'talos', 13:44:45 INFO - 'log_to_console': True, 13:44:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:44:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:44:45 INFO - 'opt_config_files': (), 13:44:45 INFO - 'pip_index': False, 13:44:45 INFO - 'sps_profile': False, 13:44:45 INFO - 'sps_profile_interval': 0, 13:44:45 INFO - 'suite': 'dromaeojs-e10s', 13:44:45 INFO - 'system_bits': '32', 13:44:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:44:45 INFO - 'title': 'talos-linux64-ix-032', 13:44:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:44:45 INFO - 'use_talos_json': True, 13:44:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:44:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:44:45 INFO - 'work_dir': 'build'} 13:44:45 INFO - [mozharness: 2016-11-01 20:44:45.054187Z] Running clobber step. 13:44:45 INFO - Running pre-action listener: _resource_record_pre_action 13:44:45 INFO - Running main action method: clobber 13:44:45 INFO - rmtree: /builds/slave/test/build 13:44:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:44:45 INFO - Running post-action listener: _resource_record_post_action 13:44:45 INFO - [mozharness: 2016-11-01 20:44:45.533537Z] Finished clobber step (success) 13:44:45 INFO - [mozharness: 2016-11-01 20:44:45.533637Z] Running read-buildbot-config step. 13:44:45 INFO - Running pre-action listener: _resource_record_pre_action 13:44:45 INFO - Running main action method: read_buildbot_config 13:44:45 INFO - Using buildbot properties: 13:44:45 INFO - { 13:44:45 INFO - "project": "", 13:44:45 INFO - "product": "firefox", 13:44:45 INFO - "script_repo_revision": "production", 13:44:45 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 13:44:45 INFO - "repository": "", 13:44:45 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 13:44:45 INFO - "buildid": "20161101104104", 13:44:45 INFO - "pgo_build": "True", 13:44:45 INFO - "basedir": "/builds/slave/test", 13:44:45 INFO - "buildnumber": 178, 13:44:45 INFO - "slavename": "talos-linux64-ix-032", 13:44:45 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:44:45 INFO - "platform": "ubuntu64_hw", 13:44:45 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 13:44:45 INFO - "branch": "mozilla-beta", 13:44:45 INFO - "repo_path": "releases/mozilla-beta", 13:44:45 INFO - "revision": "a0a503f568d86b61c0e2c8b17fcd31fdde98b4e1", 13:44:45 INFO - "stage_platform": "linux64-pgo", 13:44:45 INFO - "builduid": "a4c9b0296a074e9486905af10f3b78d8", 13:44:45 INFO - "slavebuilddir": "test" 13:44:45 INFO - } 13:44:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2. 13:44:45 INFO - Running post-action listener: _resource_record_post_action 13:44:45 INFO - [mozharness: 2016-11-01 20:44:45.536059Z] Finished read-buildbot-config step (success) 13:44:45 INFO - [mozharness: 2016-11-01 20:44:45.536148Z] Running download-and-extract step. 13:44:45 INFO - Running pre-action listener: _resource_record_pre_action 13:44:45 INFO - Running main action method: download_and_extract 13:44:45 INFO - mkdir: /builds/slave/test/build/tests 13:44: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')]} 13:44:45 INFO - https://queue.taskcluster.net/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:44:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 13:44:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 13:44:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 13:44:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 13:44:45 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 13:44:45 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 13:44:45 INFO - retry: Failed, sleeping 30 seconds before retrying 13:45:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #2 13:45:15 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 13:45:15 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 13:45:15 INFO - retry: Failed, sleeping 60 seconds before retrying 13:46:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #3 13:46:15 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 13:46:15 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 13:46:15 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json! 13:46:15 INFO - Caught exception: HTTP Error 404: Not Found 13:46:15 INFO - Caught exception: HTTP Error 404: Not Found 13:46:15 INFO - Caught exception: HTTP Error 404: Not Found 13:46:15 INFO - trying https://queue.taskcluster.net/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 13:46:15 INFO - Downloading https://queue.taskcluster.net/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 13:46:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 13:46:16 INFO - Downloaded 1327 bytes. 13:46:16 INFO - Reading from file /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 13:46:16 INFO - Using the following test package requirements: 13:46:16 INFO - {u'common': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 13:46:16 INFO - u'cppunittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 13:46:16 INFO - u'firefox-50.0.en-US.linux-x86_64.cppunittest.tests.zip'], 13:46:16 INFO - u'gtest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 13:46:16 INFO - u'firefox-50.0.en-US.linux-x86_64.gtest.tests.zip'], 13:46:16 INFO - u'jittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 13:46:16 INFO - u'jsshell-linux-x86_64.zip'], 13:46:16 INFO - u'mochitest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 13:46:16 INFO - u'firefox-50.0.en-US.linux-x86_64.mochitest.tests.zip'], 13:46:16 INFO - u'mozbase': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 13:46:16 INFO - u'reftest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 13:46:16 INFO - u'firefox-50.0.en-US.linux-x86_64.reftest.tests.zip'], 13:46:16 INFO - u'talos': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 13:46:16 INFO - u'firefox-50.0.en-US.linux-x86_64.talos.tests.zip'], 13:46:16 INFO - u'web-platform': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 13:46:16 INFO - u'firefox-50.0.en-US.linux-x86_64.web-platform.tests.zip'], 13:46:16 INFO - u'xpcshell': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 13:46:16 INFO - u'firefox-50.0.en-US.linux-x86_64.xpcshell.tests.zip']} 13:46:16 INFO - Downloading packages: [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:46:16 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')]} 13:46:16 INFO - https://queue.taskcluster.net/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:46:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 13:46:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 13:46:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 13:46:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:46:16 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 13:46:16 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 13:46:16 INFO - retry: Failed, sleeping 30 seconds before retrying 13:46:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #2 13:46:46 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 13:46:46 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 13:46:46 INFO - retry: Failed, sleeping 60 seconds before retrying 13:47:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #3 13:47:46 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 13:47:46 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 13:47:46 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip! 13:47:46 INFO - Caught exception: HTTP Error 404: Not Found 13:47:46 INFO - Caught exception: HTTP Error 404: Not Found 13:47:46 INFO - Caught exception: HTTP Error 404: Not Found 13:47:46 INFO - trying https://queue.taskcluster.net/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 13:47:46 INFO - Downloading https://queue.taskcluster.net/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 13:47:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:47:47 INFO - Downloaded 21788175 bytes. 13:47:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:47:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:47:48 INFO - Return code: 0 13:47:48 INFO - Downloading packages: [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:47:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:47:48 INFO - https://queue.taskcluster.net/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:47:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 13:47:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 13:47:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 13:47:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:47:48 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 13:47:48 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 13:47:48 INFO - retry: Failed, sleeping 30 seconds before retrying 13:48:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #2 13:48:18 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 13:48:18 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 13:48:18 INFO - retry: Failed, sleeping 60 seconds before retrying 13:49:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #3 13:49:18 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 13:49:18 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 13:49:18 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip! 13:49:18 INFO - Caught exception: HTTP Error 404: Not Found 13:49:18 INFO - Caught exception: HTTP Error 404: Not Found 13:49:18 INFO - Caught exception: HTTP Error 404: Not Found 13:49:18 INFO - trying https://queue.taskcluster.net/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 13:49:18 INFO - Downloading https://queue.taskcluster.net/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 13:49:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:49:19 INFO - Downloaded 21788175 bytes. 13:49:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:49:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:49:20 INFO - Return code: 0 13:49:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:49:20 INFO - https://queue.taskcluster.net/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:49:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 13:49:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 13:49:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 13:49:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:49:20 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 13:49:20 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 13:49:20 INFO - retry: Failed, sleeping 30 seconds before retrying 13:49:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 13:49:50 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 13:49:50 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 13:49:50 INFO - retry: Failed, sleeping 60 seconds before retrying 13:50:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #3 13:50:50 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 13:50:50 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 13:50:50 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip! 13:50:50 INFO - Caught exception: HTTP Error 404: Not Found 13:50:50 INFO - Caught exception: HTTP Error 404: Not Found 13:50:50 INFO - Caught exception: HTTP Error 404: Not Found 13:50:50 INFO - trying https://queue.taskcluster.net/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 13:50:50 INFO - Downloading https://queue.taskcluster.net/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 13:50:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:50:51 INFO - Downloaded 14413770 bytes. 13:50:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:50:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 13:50:51 INFO - Return code: 0 13:50:51 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')]} 13:50:51 INFO - https://queue.taskcluster.net/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:50:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 13:50:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 13:50:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 13:50:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:50:51 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 13:50:51 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 13:50:51 INFO - retry: Failed, sleeping 30 seconds before retrying 13:51:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #2 13:51:21 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 13:51:21 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 13:51:21 INFO - retry: Failed, sleeping 60 seconds before retrying 13:52:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #3 13:52:22 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 13:52:22 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 13:52:22 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2! 13:52:22 INFO - Caught exception: HTTP Error 404: Not Found 13:52:22 INFO - Caught exception: HTTP Error 404: Not Found 13:52:22 INFO - Caught exception: HTTP Error 404: Not Found 13:52:22 INFO - trying https://queue.taskcluster.net/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 13:52:22 INFO - Downloading https://queue.taskcluster.net/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 13:52:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:52:23 INFO - Downloaded 56808042 bytes. 13:52:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 13:52:23 INFO - mkdir: /builds/slave/test/properties 13:52:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:52:23 INFO - Writing to file /builds/slave/test/properties/build_url 13:52:23 INFO - Contents: 13:52:23 INFO - build_url:https://queue.taskcluster.net/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 13:52:24 INFO - Running post-action listener: _resource_record_post_action 13:52:24 INFO - Running post-action listener: set_extra_try_arguments 13:52:24 INFO - [mozharness: 2016-11-01 20:52:24.414734Z] Finished download-and-extract step (success) 13:52:24 INFO - [mozharness: 2016-11-01 20:52:24.414965Z] Running populate-webroot step. 13:52:24 INFO - Running pre-action listener: _resource_record_pre_action 13:52:24 INFO - Running main action method: populate_webroot 13:52:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:52:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:52:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:52:24 INFO - '--tppagecycles', 13:52:24 INFO - '7'], 13:52:24 INFO - 'tests': ['tsvgm']}}, 13:52:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:52:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:52:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:52:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:52:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:52:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:52:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:52:24 INFO - 'talos_options': ['--disable-e10s'], 13:52:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:52:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:52:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:52:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:52:24 INFO - 'talos_options': ['--disable-e10s'], 13:52:24 INFO - 'tests': ['damp', 'tps']}, 13:52:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:52:24 INFO - 'tests': ['damp', 'tps']}, 13:52:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:52:24 INFO - 'tests': ['dromaeo_dom']}, 13:52:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:52:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:52:24 INFO - 'tests': ['basic_compositor_video']}, 13:52:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:52:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:52:24 INFO - 'tests': ['a11yr', 13:52:24 INFO - 'ts_paint', 13:52:24 INFO - 'tpaint', 13:52:24 INFO - 'sessionrestore', 13:52:24 INFO - 'sessionrestore_no_auto_restore', 13:52:24 INFO - 'tabpaint']}, 13:52:24 INFO - 'other-e10s': {'tests': ['a11yr', 13:52:24 INFO - 'ts_paint', 13:52:24 INFO - 'tpaint', 13:52:24 INFO - 'sessionrestore', 13:52:24 INFO - 'sessionrestore_no_auto_restore', 13:52:24 INFO - 'tabpaint']}, 13:52:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:52:24 INFO - 'ts_paint', 13:52:24 INFO - 'tpaint', 13:52:24 INFO - 'sessionrestore', 13:52:24 INFO - 'sessionrestore_no_auto_restore', 13:52:24 INFO - 'tabpaint']}, 13:52:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:52:24 INFO - 'ts_paint', 13:52:24 INFO - 'tpaint', 13:52:24 INFO - 'sessionrestore', 13:52:24 INFO - 'sessionrestore_no_auto_restore', 13:52:24 INFO - 'tabpaint']}, 13:52:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:52:24 INFO - 'tests': ['a11yr', 13:52:24 INFO - 'ts_paint', 13:52:24 INFO - 'tpaint', 13:52:24 INFO - 'sessionrestore', 13:52:24 INFO - 'sessionrestore_no_auto_restore', 13:52:24 INFO - 'tabpaint']}, 13:52:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:52:24 INFO - 'tests': ['a11yr', 13:52:24 INFO - 'ts_paint', 13:52:24 INFO - 'tpaint', 13:52:24 INFO - 'sessionrestore', 13:52:24 INFO - 'sessionrestore_no_auto_restore', 13:52:24 INFO - 'tabpaint']}, 13:52:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:52:24 INFO - 'tests': ['tsvgx', 13:52:24 INFO - 'tsvgr_opacity', 13:52:24 INFO - 'tart', 13:52:24 INFO - 'tscrollx', 13:52:24 INFO - 'cart']}, 13:52:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:52:24 INFO - 'tsvgr_opacity', 13:52:24 INFO - 'tart', 13:52:24 INFO - 'tscrollx', 13:52:24 INFO - 'cart']}, 13:52:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:52:24 INFO - 'talos_options': ['--disable-e10s'], 13:52:24 INFO - 'tests': ['tp5o']}, 13:52:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:52:24 INFO - 'tests': ['tp5o']}, 13:52:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:52:24 INFO - 'talos_options': ['--disable-e10s', 13:52:24 INFO - '--xperf_path', 13:52:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:52:24 INFO - 'tests': ['tp5n']}, 13:52:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:52:24 INFO - 'talos_options': ['--xperf_path', 13:52:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:52:24 INFO - 'tests': ['tp5n']}}, 13:52:24 INFO - 'talos.zip': {'path': '', 13:52:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:52:24 INFO - Running post-action listener: _resource_record_post_action 13:52:24 INFO - [mozharness: 2016-11-01 20:52:24.434870Z] Finished populate-webroot step (success) 13:52:24 INFO - [mozharness: 2016-11-01 20:52:24.434959Z] Running create-virtualenv step. 13:52:24 INFO - Running pre-action listener: _resource_record_pre_action 13:52:24 INFO - Running main action method: create_virtualenv 13:52:24 INFO - Creating virtualenv /builds/slave/test/build/venv 13:52:24 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 13:52:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:52:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:52:24 INFO - Using real prefix '/usr' 13:52:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:52:25 INFO - Installing distribute.............................................................................................................................................................................................done. 13:52:27 INFO - Installing pip.................done. 13:52:27 INFO - Return code: 0 13:52:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:52:27 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')]} 13:52:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:27 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')]} 13:52:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:27 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 0x1dc8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff7400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2086570>, '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 0x2087470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2087900>, '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': '745a4373a2a16df560f216e000000264-1478033082.411915-1410601440', '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 13:52:27 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 13:52:27 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 13:52:27 INFO - Using env: {'DISPLAY': ':0', 13:52:27 INFO - 'HOME': '/home/cltbld', 13:52:27 INFO - 'LANG': 'en_US.UTF-8', 13:52:27 INFO - 'LANGUAGE': 'en_US:en', 13:52:27 INFO - 'LOGNAME': 'cltbld', 13:52:27 INFO - 'MAIL': '/var/mail/cltbld', 13:52:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:27 INFO - 'MOZ_NO_REMOTE': '1', 13:52:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:27 INFO - 'NO_EM_RESTART': '1', 13:52:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:27 INFO - 'PWD': '/builds/slave/test', 13:52:27 INFO - 'SHELL': '/bin/bash', 13:52:27 INFO - 'SHLVL': '1', 13:52:27 INFO - 'TERM': 'linux', 13:52:27 INFO - 'TMOUT': '86400', 13:52:27 INFO - 'USER': 'cltbld', 13:52:27 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1478033082.411915-1410601440', 13:52:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:27 INFO - '_': '/tools/buildbot/bin/python'} 13:52:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:27 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 13:52:27 INFO - Cleaning up... 13:52:27 INFO - Return code: 0 13:52:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:52:27 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')]} 13:52:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:27 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')]} 13:52:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:27 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff7400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2086570>, '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 0x2087470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2087900>, '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': '745a4373a2a16df560f216e000000264-1478033082.411915-1410601440', '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 13:52:27 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>=3.1.1'] in /builds/slave/test/build 13:52:27 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>=3.1.1 13:52:27 INFO - Using env: {'DISPLAY': ':0', 13:52:27 INFO - 'HOME': '/home/cltbld', 13:52:27 INFO - 'LANG': 'en_US.UTF-8', 13:52:27 INFO - 'LANGUAGE': 'en_US:en', 13:52:27 INFO - 'LOGNAME': 'cltbld', 13:52:27 INFO - 'MAIL': '/var/mail/cltbld', 13:52:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:27 INFO - 'MOZ_NO_REMOTE': '1', 13:52:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:27 INFO - 'NO_EM_RESTART': '1', 13:52:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:27 INFO - 'PWD': '/builds/slave/test', 13:52:27 INFO - 'SHELL': '/bin/bash', 13:52:27 INFO - 'SHLVL': '1', 13:52:27 INFO - 'TERM': 'linux', 13:52:27 INFO - 'TMOUT': '86400', 13:52:27 INFO - 'USER': 'cltbld', 13:52:27 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1478033082.411915-1410601440', 13:52:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:27 INFO - '_': '/tools/buildbot/bin/python'} 13:52:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:27 INFO - Downloading/unpacking psutil>=3.1.1 13:52:27 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 13:52:27 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 13:52:27 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 13:52:27 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 13:52:27 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 13:52:27 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 13:52:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:52:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:52:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:52:29 INFO - Installing collected packages: psutil 13:52:29 INFO - Running setup.py install for psutil 13:52:29 INFO - building 'psutil._psutil_linux' extension 13:52:29 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 13:52:29 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 13:52:29 INFO - building 'psutil._psutil_posix' extension 13:52:29 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 13:52:29 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 13:52:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:52:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:52:29 INFO - Successfully installed psutil 13:52:29 INFO - Cleaning up... 13:52:30 INFO - Return code: 0 13:52:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:52:30 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')]} 13:52:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:30 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')]} 13:52:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:30 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff7400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2086570>, '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 0x2087470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2087900>, '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': '745a4373a2a16df560f216e000000264-1478033082.411915-1410601440', '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 13:52:30 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.3'] in /builds/slave/test/build 13:52:30 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.3 13:52:30 INFO - Using env: {'DISPLAY': ':0', 13:52:30 INFO - 'HOME': '/home/cltbld', 13:52:30 INFO - 'LANG': 'en_US.UTF-8', 13:52:30 INFO - 'LANGUAGE': 'en_US:en', 13:52:30 INFO - 'LOGNAME': 'cltbld', 13:52:30 INFO - 'MAIL': '/var/mail/cltbld', 13:52:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:30 INFO - 'MOZ_NO_REMOTE': '1', 13:52:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:30 INFO - 'NO_EM_RESTART': '1', 13:52:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:30 INFO - 'PWD': '/builds/slave/test', 13:52:30 INFO - 'SHELL': '/bin/bash', 13:52:30 INFO - 'SHLVL': '1', 13:52:30 INFO - 'TERM': 'linux', 13:52:30 INFO - 'TMOUT': '86400', 13:52:30 INFO - 'USER': 'cltbld', 13:52:30 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1478033082.411915-1410601440', 13:52:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:30 INFO - '_': '/tools/buildbot/bin/python'} 13:52:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:52:30 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 13:52:30 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 13:52:30 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 13:52:30 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 13:52:30 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 13:52:30 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 13:52:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:52:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:52:32 INFO - Installing collected packages: mozsystemmonitor 13:52:32 INFO - Running setup.py install for mozsystemmonitor 13:52:32 INFO - Successfully installed mozsystemmonitor 13:52:32 INFO - Cleaning up... 13:52:32 INFO - Return code: 0 13:52:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:52:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:52:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:52:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff7400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2086570>, '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 0x2087470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2087900>, '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': '745a4373a2a16df560f216e000000264-1478033082.411915-1410601440', '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 13:52:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:52:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:52:32 INFO - Using env: {'DISPLAY': ':0', 13:52:32 INFO - 'HOME': '/home/cltbld', 13:52:32 INFO - 'LANG': 'en_US.UTF-8', 13:52:32 INFO - 'LANGUAGE': 'en_US:en', 13:52:32 INFO - 'LOGNAME': 'cltbld', 13:52:32 INFO - 'MAIL': '/var/mail/cltbld', 13:52:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:32 INFO - 'MOZ_NO_REMOTE': '1', 13:52:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:32 INFO - 'NO_EM_RESTART': '1', 13:52:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:32 INFO - 'PWD': '/builds/slave/test', 13:52:32 INFO - 'SHELL': '/bin/bash', 13:52:32 INFO - 'SHLVL': '1', 13:52:32 INFO - 'TERM': 'linux', 13:52:32 INFO - 'TMOUT': '86400', 13:52:32 INFO - 'USER': 'cltbld', 13:52:32 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1478033082.411915-1410601440', 13:52:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:32 INFO - '_': '/tools/buildbot/bin/python'} 13:52:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:32 INFO - Downloading/unpacking jsonschema==2.5.1 13:52:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:52:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:52:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:52:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:52:34 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 13:52:34 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 13:52:34 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 13:52:34 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 13:52:34 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 13:52:34 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 13:52:34 INFO - Downloading functools32-3.2.3-2.tar.gz 13:52:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:52:34 INFO - warning: no files found matching '*.txt' 13:52:34 INFO - no previously-included directories found matching 'build' 13:52:34 INFO - no previously-included directories found matching 'dist' 13:52:34 INFO - no previously-included directories found matching '.git*' 13:52:34 INFO - Installing collected packages: jsonschema, functools32 13:52:34 INFO - Running setup.py install for functools32 13:52:34 INFO - warning: no files found matching '*.txt' 13:52:34 INFO - no previously-included directories found matching 'build' 13:52:34 INFO - no previously-included directories found matching 'dist' 13:52:34 INFO - no previously-included directories found matching '.git*' 13:52:34 INFO - Successfully installed jsonschema functools32 13:52:34 INFO - Cleaning up... 13:52:35 INFO - Return code: 0 13:52:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:52:35 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')]} 13:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:35 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')]} 13:52:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:35 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff7400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2086570>, '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 0x2087470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2087900>, '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': '745a4373a2a16df560f216e000000264-1478033082.411915-1410601440', '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 13:52:35 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:52:35 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 functools32==3.2.3-2 13:52:35 INFO - Using env: {'DISPLAY': ':0', 13:52:35 INFO - 'HOME': '/home/cltbld', 13:52:35 INFO - 'LANG': 'en_US.UTF-8', 13:52:35 INFO - 'LANGUAGE': 'en_US:en', 13:52:35 INFO - 'LOGNAME': 'cltbld', 13:52:35 INFO - 'MAIL': '/var/mail/cltbld', 13:52:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:35 INFO - 'MOZ_NO_REMOTE': '1', 13:52:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:35 INFO - 'NO_EM_RESTART': '1', 13:52:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:35 INFO - 'PWD': '/builds/slave/test', 13:52:35 INFO - 'SHELL': '/bin/bash', 13:52:35 INFO - 'SHLVL': '1', 13:52:35 INFO - 'TERM': 'linux', 13:52:35 INFO - 'TMOUT': '86400', 13:52:35 INFO - 'USER': 'cltbld', 13:52:35 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1478033082.411915-1410601440', 13:52:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:35 INFO - '_': '/tools/buildbot/bin/python'} 13:52:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:52:35 INFO - Cleaning up... 13:52:35 INFO - Return code: 0 13:52:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:52:35 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')]} 13:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:35 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')]} 13:52:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:35 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 0x1dc8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff7400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2086570>, '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 0x2087470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2087900>, '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': '745a4373a2a16df560f216e000000264-1478033082.411915-1410601440', '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 13:52:35 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 13:52:35 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 13:52:35 INFO - Using env: {'DISPLAY': ':0', 13:52:35 INFO - 'HOME': '/home/cltbld', 13:52:35 INFO - 'LANG': 'en_US.UTF-8', 13:52:35 INFO - 'LANGUAGE': 'en_US:en', 13:52:35 INFO - 'LOGNAME': 'cltbld', 13:52:35 INFO - 'MAIL': '/var/mail/cltbld', 13:52:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:35 INFO - 'MOZ_NO_REMOTE': '1', 13:52:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:35 INFO - 'NO_EM_RESTART': '1', 13:52:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:35 INFO - 'PWD': '/builds/slave/test', 13:52:35 INFO - 'SHELL': '/bin/bash', 13:52:35 INFO - 'SHLVL': '1', 13:52:35 INFO - 'TERM': 'linux', 13:52:35 INFO - 'TMOUT': '86400', 13:52:35 INFO - 'USER': 'cltbld', 13:52:35 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1478033082.411915-1410601440', 13:52:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:35 INFO - '_': '/tools/buildbot/bin/python'} 13:52:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:35 INFO - Downloading/unpacking blobuploader==1.2.4 13:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:52:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:37 INFO - Downloading blobuploader-1.2.4.tar.gz 13:52:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:52:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:52:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:52:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:52:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:52:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:52:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:52:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:52:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:38 INFO - Downloading docopt-0.6.1.tar.gz 13:52:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:52:38 INFO - Installing collected packages: blobuploader, requests, docopt 13:52:38 INFO - Running setup.py install for blobuploader 13:52:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:52:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:52:38 INFO - Running setup.py install for requests 13:52:38 INFO - Running setup.py install for docopt 13:52:38 INFO - Successfully installed blobuploader requests docopt 13:52:38 INFO - Cleaning up... 13:52:38 INFO - Return code: 0 13:52:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:52:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:52:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:52:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff7400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2086570>, '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 0x2087470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2087900>, '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': '745a4373a2a16df560f216e000000264-1478033082.411915-1410601440', '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 13:52:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:52:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:52:38 INFO - Using env: {'DISPLAY': ':0', 13:52:38 INFO - 'HOME': '/home/cltbld', 13:52:38 INFO - 'LANG': 'en_US.UTF-8', 13:52:38 INFO - 'LANGUAGE': 'en_US:en', 13:52:38 INFO - 'LOGNAME': 'cltbld', 13:52:38 INFO - 'MAIL': '/var/mail/cltbld', 13:52:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:38 INFO - 'MOZ_NO_REMOTE': '1', 13:52:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:38 INFO - 'NO_EM_RESTART': '1', 13:52:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:38 INFO - 'PWD': '/builds/slave/test', 13:52:38 INFO - 'SHELL': '/bin/bash', 13:52:38 INFO - 'SHLVL': '1', 13:52:38 INFO - 'TERM': 'linux', 13:52:38 INFO - 'TMOUT': '86400', 13:52:38 INFO - 'USER': 'cltbld', 13:52:38 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1478033082.411915-1410601440', 13:52:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:38 INFO - '_': '/tools/buildbot/bin/python'} 13:52:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:52:38 INFO - Running setup.py (path:/tmp/pip-pB7bvJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:52:39 INFO - Running setup.py (path:/tmp/pip-LUNtl4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:52:39 INFO - Running setup.py (path:/tmp/pip-kCfYxw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:52:39 INFO - Running setup.py (path:/tmp/pip-U9N60o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:52:39 INFO - Running setup.py (path:/tmp/pip-0jC6qj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:52:39 INFO - Running setup.py (path:/tmp/pip-qyxkpM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:52:39 INFO - Running setup.py (path:/tmp/pip-7wfJFO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:52:39 INFO - Running setup.py (path:/tmp/pip-Nc6wux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:52:39 INFO - Running setup.py (path:/tmp/pip-pnE4_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:52:39 INFO - Running setup.py (path:/tmp/pip-x2mAD3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:52:39 INFO - Running setup.py (path:/tmp/pip-uITSzu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:52:39 INFO - Running setup.py (path:/tmp/pip-FnFaBy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:52:39 INFO - Running setup.py (path:/tmp/pip-zfFpMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:52:39 INFO - Running setup.py (path:/tmp/pip-bA4TOz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:52:39 INFO - Running setup.py (path:/tmp/pip-jplPGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:52:40 INFO - Running setup.py (path:/tmp/pip-VZSuuL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:52:40 INFO - Running setup.py (path:/tmp/pip-d6yr_n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:52:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:52:40 INFO - Running setup.py install for manifestparser 13:52:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:52:40 INFO - Running setup.py install for mozcrash 13:52:40 INFO - Running setup.py install for mozdebug 13:52:40 INFO - Running setup.py install for mozdevice 13:52:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:52:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:52:40 INFO - Running setup.py install for mozfile 13:52:40 INFO - Running setup.py install for mozhttpd 13:52:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:52:40 INFO - Running setup.py install for mozinfo 13:52:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:52:40 INFO - Running setup.py install for mozInstall 13:52:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:52:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:52:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:52:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:52:40 INFO - Running setup.py install for mozleak 13:52:41 INFO - Running setup.py install for mozlog 13:52:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:52:41 INFO - Running setup.py install for moznetwork 13:52:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:52:41 INFO - Running setup.py install for mozprocess 13:52:41 INFO - Running setup.py install for mozprofile 13:52:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:52:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:52:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:52:41 INFO - Running setup.py install for mozrunner 13:52:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:52:41 INFO - Running setup.py install for mozscreenshot 13:52:41 INFO - Running setup.py install for moztest 13:52:41 INFO - Running setup.py install for mozversion 13:52:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:52:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:52:41 INFO - Cleaning up... 13:52:41 INFO - Return code: 0 13:52:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:52:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:52:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:52:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff7400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2086570>, '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 0x2087470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2087900>, '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': '745a4373a2a16df560f216e000000264-1478033082.411915-1410601440', '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 13:52:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:52:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:52:41 INFO - Using env: {'DISPLAY': ':0', 13:52:41 INFO - 'HOME': '/home/cltbld', 13:52:41 INFO - 'LANG': 'en_US.UTF-8', 13:52:41 INFO - 'LANGUAGE': 'en_US:en', 13:52:41 INFO - 'LOGNAME': 'cltbld', 13:52:41 INFO - 'MAIL': '/var/mail/cltbld', 13:52:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:41 INFO - 'MOZ_NO_REMOTE': '1', 13:52:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:41 INFO - 'NO_EM_RESTART': '1', 13:52:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:41 INFO - 'PWD': '/builds/slave/test', 13:52:41 INFO - 'SHELL': '/bin/bash', 13:52:41 INFO - 'SHLVL': '1', 13:52:41 INFO - 'TERM': 'linux', 13:52:41 INFO - 'TMOUT': '86400', 13:52:41 INFO - 'USER': 'cltbld', 13:52:41 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1478033082.411915-1410601440', 13:52:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:41 INFO - '_': '/tools/buildbot/bin/python'} 13:52:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:52:42 INFO - Running setup.py (path:/tmp/pip-Xwei7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:52:42 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)) 13:52:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:52:42 INFO - Running setup.py (path:/tmp/pip-S6Rxl1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:52:42 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)) 13:52:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:52:42 INFO - Running setup.py (path:/tmp/pip-NDWBNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:52:42 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)) 13:52:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:52:42 INFO - Running setup.py (path:/tmp/pip-ISXSWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:52:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:52:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:52:42 INFO - Running setup.py (path:/tmp/pip-tJAHQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:52:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 13:52:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:52:42 INFO - Running setup.py (path:/tmp/pip-A2172x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:52:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 13:52:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:52:42 INFO - Running setup.py (path:/tmp/pip-LfEXe5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:52:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 13:52:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:52:42 INFO - Running setup.py (path:/tmp/pip-5QYfTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:52:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 13:52:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:52:42 INFO - Running setup.py (path:/tmp/pip-kKKjV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:52:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 13:52:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:52:42 INFO - Running setup.py (path:/tmp/pip-XGHDYw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:52:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 13:52:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:52:42 INFO - Running setup.py (path:/tmp/pip-NUevHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:52:43 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)) 13:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:52:43 INFO - Running setup.py (path:/tmp/pip-dboTlv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:52:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 13:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:52:43 INFO - Running setup.py (path:/tmp/pip-hjYW07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:52:43 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)) 13:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:52:43 INFO - Running setup.py (path:/tmp/pip-QeBVyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:52:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 13:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:52:43 INFO - Running setup.py (path:/tmp/pip-QSzSMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:52:43 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)) 13:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:52:43 INFO - Running setup.py (path:/tmp/pip-vDzyZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:52:43 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)) 13:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:52:43 INFO - Running setup.py (path:/tmp/pip-6vcJxj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:52:43 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)) 13:52:43 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)) 13:52:43 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)) 13:52:43 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)) 13:52:43 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)) 13:52:43 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)) 13:52:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:52:43 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 13:52:43 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 13:52:43 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 13:52:43 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 13:52:43 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 13:52:43 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 13:52:45 INFO - Downloading blessings-1.6.tar.gz 13:52:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:52:45 INFO - Installing collected packages: blessings 13:52:45 INFO - Running setup.py install for blessings 13:52:45 INFO - Successfully installed blessings 13:52:45 INFO - Cleaning up... 13:52:45 INFO - Return code: 0 13:52:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:52:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:52:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:52:46 INFO - Reading from file tmpfile_stdout 13:52:46 INFO - Current package versions: 13:52:46 INFO - argparse == 1.2.1 13:52:46 INFO - blessings == 1.6 13:52:46 INFO - blobuploader == 1.2.4 13:52:46 INFO - docopt == 0.6.1 13:52:46 INFO - functools32 == 3.2.3-2 13:52:46 INFO - jsonschema == 2.5.1 13:52:46 INFO - manifestparser == 1.1 13:52:46 INFO - mozInstall == 1.12 13:52:46 INFO - mozcrash == 0.17 13:52:46 INFO - mozdebug == 0.1 13:52:46 INFO - mozdevice == 0.48 13:52:46 INFO - mozfile == 1.2 13:52:46 INFO - mozhttpd == 0.7 13:52:46 INFO - mozinfo == 0.9 13:52:46 INFO - mozleak == 0.1 13:52:46 INFO - mozlog == 3.3 13:52:46 INFO - moznetwork == 0.27 13:52:46 INFO - mozprocess == 0.23 13:52:46 INFO - mozprofile == 0.28 13:52:46 INFO - mozrunner == 6.12 13:52:46 INFO - mozscreenshot == 0.1 13:52:46 INFO - mozsystemmonitor == 0.3 13:52:46 INFO - moztest == 0.7 13:52:46 INFO - mozversion == 1.4 13:52:46 INFO - psutil == 3.1.1 13:52:46 INFO - requests == 1.2.3 13:52:46 INFO - wsgiref == 0.1.2 13:52:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:52:46 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')]} 13:52:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:46 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')]} 13:52:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:46 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 0x1dc8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff7400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2086570>, '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 0x2087470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2087900>, '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': '745a4373a2a16df560f216e000000264-1478033082.411915-1410601440', '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 13:52:46 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 13:52:46 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 13:52:46 INFO - Using env: {'DISPLAY': ':0', 13:52:46 INFO - 'HOME': '/home/cltbld', 13:52:46 INFO - 'LANG': 'en_US.UTF-8', 13:52:46 INFO - 'LANGUAGE': 'en_US:en', 13:52:46 INFO - 'LOGNAME': 'cltbld', 13:52:46 INFO - 'MAIL': '/var/mail/cltbld', 13:52:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:46 INFO - 'MOZ_NO_REMOTE': '1', 13:52:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:46 INFO - 'NO_EM_RESTART': '1', 13:52:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:46 INFO - 'PWD': '/builds/slave/test', 13:52:46 INFO - 'SHELL': '/bin/bash', 13:52:46 INFO - 'SHLVL': '1', 13:52:46 INFO - 'TERM': 'linux', 13:52:46 INFO - 'TMOUT': '86400', 13:52:46 INFO - 'USER': 'cltbld', 13:52:46 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1478033082.411915-1410601440', 13:52:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:46 INFO - '_': '/tools/buildbot/bin/python'} 13:52:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:46 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)) 13:52:46 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)) 13:52:46 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)) 13:52:46 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)) 13:52:46 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)) 13:52:46 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)) 13:52:46 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)) 13:52:46 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)) 13:52:46 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)) 13:52:46 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)) 13:52:46 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)) 13:52:46 INFO - Cleaning up... 13:52:46 INFO - Return code: 0 13:52:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:52:46 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')]} 13:52:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:46 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')]} 13:52:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:46 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 0x1dc8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff7400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2086570>, '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 0x2087470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2087900>, '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': '745a4373a2a16df560f216e000000264-1478033082.411915-1410601440', '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 13:52:46 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 13:52:46 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 13:52:46 INFO - Using env: {'DISPLAY': ':0', 13:52:46 INFO - 'HOME': '/home/cltbld', 13:52:46 INFO - 'LANG': 'en_US.UTF-8', 13:52:46 INFO - 'LANGUAGE': 'en_US:en', 13:52:46 INFO - 'LOGNAME': 'cltbld', 13:52:46 INFO - 'MAIL': '/var/mail/cltbld', 13:52:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:46 INFO - 'MOZ_NO_REMOTE': '1', 13:52:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:46 INFO - 'NO_EM_RESTART': '1', 13:52:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:46 INFO - 'PWD': '/builds/slave/test', 13:52:46 INFO - 'SHELL': '/bin/bash', 13:52:46 INFO - 'SHLVL': '1', 13:52:46 INFO - 'TERM': 'linux', 13:52:46 INFO - 'TMOUT': '86400', 13:52:46 INFO - 'USER': 'cltbld', 13:52:46 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1478033082.411915-1410601440', 13:52:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:46 INFO - '_': '/tools/buildbot/bin/python'} 13:52:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:52:46 INFO - Cleaning up... 13:52:46 INFO - Return code: 0 13:52:46 INFO - Running post-action listener: _resource_record_post_action 13:52:46 INFO - Running post-action listener: _start_resource_monitoring 13:52:46 INFO - Starting resource monitoring. 13:52:46 INFO - [mozharness: 2016-11-01 20:52:46.535046Z] Finished create-virtualenv step (success) 13:52:46 INFO - [mozharness: 2016-11-01 20:52:46.535466Z] Running install step. 13:52:46 INFO - Running pre-action listener: _resource_record_pre_action 13:52:46 INFO - Running main action method: install 13:52:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:52:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:52:46 INFO - Reading from file tmpfile_stdout 13:52:46 INFO - Detecting whether we're running mozinstall >=1.0... 13:52:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:52:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:52:46 INFO - Reading from file tmpfile_stdout 13:52:46 INFO - Output received: 13:52:46 INFO - Usage: mozinstall [options] installer 13:52:46 INFO - Options: 13:52:46 INFO - -h, --help show this help message and exit 13:52:46 INFO - -d DEST, --destination=DEST 13:52:46 INFO - Directory to install application into. [default: 13:52:46 INFO - "/builds/slave/test"] 13:52:46 INFO - --app=APP Application being installed. [default: firefox] 13:52:46 INFO - mkdir: /builds/slave/test/build/application 13:52:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:52:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:53:00 INFO - Reading from file tmpfile_stdout 13:53:00 INFO - Output received: 13:53:00 INFO - /builds/slave/test/build/application/firefox/firefox 13:53:00 INFO - Running post-action listener: _resource_record_post_action 13:53:00 INFO - [mozharness: 2016-11-01 20:53:00.315498Z] Finished install step (success) 13:53:00 INFO - [mozharness: 2016-11-01 20:53:00.315776Z] Running run-tests step. 13:53:00 INFO - Running pre-action listener: _resource_record_pre_action 13:53:00 INFO - Running main action method: run_tests 13:53:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:53:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:53:00 INFO - Python 2.7.3 13:53:00 INFO - Return code: 0 13:53:00 INFO - grabbing minidump binary from tooltool 13:53:00 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')]} 13:53:00 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2086570>, '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 0x2087470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2087900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:53:00 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 13:53:00 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 13:53:00 INFO - Calling ['/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'] with output_timeout 600 13:53:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:53:00 INFO - Return code: 0 13:53:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:53:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:53:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:53:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:53:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:53:00 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 13:53:00 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 13:53:00 INFO - Using env: {'DISPLAY': ':0', 13:53:00 INFO - 'HOME': '/home/cltbld', 13:53:00 INFO - 'LANG': 'en_US.UTF-8', 13:53:00 INFO - 'LANGUAGE': 'en_US:en', 13:53:00 INFO - 'LOGNAME': 'cltbld', 13:53:00 INFO - 'MAIL': '/var/mail/cltbld', 13:53:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:53:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:53:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:53:00 INFO - 'MOZ_NO_REMOTE': '1', 13:53:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:53:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:53:00 INFO - 'NO_EM_RESTART': '1', 13:53:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:53:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:53:00 INFO - 'PWD': '/builds/slave/test', 13:53:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:53:00 INFO - 'SHELL': '/bin/bash', 13:53:00 INFO - 'SHLVL': '1', 13:53:00 INFO - 'TERM': 'linux', 13:53:00 INFO - 'TMOUT': '86400', 13:53:00 INFO - 'USER': 'cltbld', 13:53:00 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1478033082.411915-1410601440', 13:53:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:53:00 INFO - '_': '/tools/buildbot/bin/python'} 13:53:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 13:53:00 INFO - mozversion application_buildid: 20161101104104 13:53:00 INFO - mozversion application_changeset: a0a503f568d86b61c0e2c8b17fcd31fdde98b4e1 13:53:00 INFO - mozversion application_display_name: Firefox 13:53:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:53:00 INFO - mozversion application_name: Firefox 13:53:00 INFO - mozversion application_remotingname: firefox 13:53:00 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 13:53:00 INFO - mozversion application_vendor: Mozilla 13:53:00 INFO - mozversion application_version: 50.0 13:53:00 INFO - mozversion platform_buildid: 20161101104104 13:53:00 INFO - mozversion platform_changeset: a0a503f568d86b61c0e2c8b17fcd31fdde98b4e1 13:53:00 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 13:53:00 INFO - mozversion platform_version: 50.0 13:53:00 INFO - using testdate: 1478033580 13:53:00 INFO - actual date: 1478033580 13:53:00 INFO - starting webserver on 'localhost:32825' 13:53:00 INFO - SUITE-START | Running 2 tests 13:53:00 INFO - TEST-START | dromaeo_css 13:53:00 INFO - operating with platform_type : linux_ 13:53:00 INFO - Initialising browser for dromaeo_css test... 13:53:00 INFO - TEST-INFO | started process 6579 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVWxOql/profile http://localhost:32825/getInfo.html) 13:53:05 INFO - PROCESS | 6579 | __metrics Screen width/height:1600/1200 13:53:05 INFO - PROCESS | 6579 | colorDepth:24 13:53:05 INFO - PROCESS | 6579 | Browser inner width/height: 1024/697 13:53:05 INFO - PROCESS | 6579 | __metrics 13:53:06 ERROR - PROCESS | 6579 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 13:53:07 INFO - TEST-INFO | 6579: exit 0 13:53:07 INFO - Browser initialized. 13:53:07 INFO - Running cycle 1/1 for dromaeo_css test... 13:53:07 INFO - TEST-INFO | started process 6703 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVWxOql/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:53:19 INFO - PROCESS | 6703 | RSS: Main: 150827008 13:53:19 INFO - PROCESS | 6703 | 13:54:08 INFO - PROCESS | 6703 | 1478033648935 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] 13:56:17 INFO - PROCESS | 6703 | Cycle 1(1): loaded http://localhost:32825/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32825/tests/dromaeo/cssquery-ext.html) 13:56:18 INFO - PROCESS | 6703 | RSS: Main: 159084544 13:56:18 INFO - PROCESS | 6703 | 13:59:20 INFO - PROCESS | 6703 | Cycle 1(1): loaded http://localhost:32825/tests/dromaeo/cssquery-ext.html (next: http://localhost:32825/tests/dromaeo/cssquery-jquery.html) 13:59:21 INFO - PROCESS | 6703 | RSS: Main: 156135424 13:59:21 INFO - PROCESS | 6703 | 14:02:22 INFO - PROCESS | 6703 | Cycle 1(1): loaded http://localhost:32825/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32825/tests/dromaeo/cssquery-mootools.html) 14:02:23 INFO - PROCESS | 6703 | RSS: Main: 155963392 14:02:23 INFO - PROCESS | 6703 | 14:05:25 INFO - PROCESS | 6703 | Cycle 1(1): loaded http://localhost:32825/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32825/tests/dromaeo/cssquery-prototype.html) 14:05:25 INFO - PROCESS | 6703 | RSS: Main: 156520448 14:05:25 INFO - PROCESS | 6703 | 14:08:28 INFO - PROCESS | 6703 | Cycle 1(1): loaded http://localhost:32825/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32825/tests/dromaeo/cssquery-yui.html) 14:08:28 INFO - PROCESS | 6703 | RSS: Main: 157908992 14:08:28 INFO - PROCESS | 6703 | 14:11:31 INFO - PROCESS | 6703 | Cycle 1(1): loaded http://localhost:32825/tests/dromaeo/cssquery-yui.html (next: http://localhost:32825/tests/dromaeo/cssquery-dojo.html) 14:11:31 INFO - PROCESS | 6703 | RSS: Main: 157827072 14:11:31 INFO - PROCESS | 6703 | 14:11:31 INFO - PROCESS | 6703 | __start_tp_report 14:11:31 INFO - PROCESS | 6703 | _x_x_mozilla_page_load 14:11:31 INFO - PROCESS | 6703 | _x_x_mozilla_page_load_details 14:11:31 INFO - PROCESS | 6703 | |i|pagename|runs| 14:11:31 INFO - PROCESS | 6703 | |0;dojo.html;3288.4902840059785;3296.1265264704857;3301.2737197816473;3325.6840600142978;3331.0340001399595;5614.410486898878;5678.659280443171;5712.057510510771;5723.771049158034;5742.081266997281;5654.802081927123;5669.8582535436535;5678.318601767794;5686.545076393889;5691.686957217351;5178.352705911761;5192.8701782455555;5213.973930130344;5257.027449921777;5260.105782017047;5257.579393648518;5264.92102618461;5265.262863199156;5270.868228294285;5301.575873930095;5110.6422550421485;5172.793088276464;5247.39654939683;5250.6324557281005;5252.395974462947;5278;5321.255024296563;5321.760520776555;5323.361196656388;5359.517643412073;5187.377514698261;5235.712035838027;5262;5262.2632831403635;5267.631265811395;5503;5601.439856014406;5668.829935101953;5732.968065748164;5799.88400231993;6055.485283750886;6125.9680843641045;6131.526791107749;6138.081874382042;6154.230721159855;6148.169997050386;6156.78451254204;6158;6164.383561643845;6173.59871608344;5548.112302031655;5575.8606034849045;5733.799317023926;5733.856653583652;5755.165501002373;6092.69536523181;6170.938290617037;6171.722272497748;6172.382761723792;6175.413335733098;5859.853503662443;5909.23179986599;5913.674747888907;5917.260342457193;5944.4352786485215;5931.169636250928;5943.910841337383;6001.879962400728;6014.488768454643;6100.267967843887;6066.241719785027;6146.631202127886;6153.784617538365;6154.907676384858;6163.96918015407;6156.753729850845;6161.691915404212;6161.784337548164;6177.227846519185;6192.8761424771255;4504.977475112603;4641.489436162019;4699.530046995274;4702.200625893606;4709.058188362273;4092.7953602319767;4151.14901445203;4181.811818468115;4197.496300443966;4223.13425747721;5933.2880054393745;5957.970210149008;5968.22413086296;5970.0746384310505;6005.669688167192;5836.9124463133085;5984.042553191469;6196.349383314777;6216.160818289563;6232.3144454110015;5783.739731712083;5836.562257830595;5842.766289348463;5848.912266316009;5880.941190588125;5019.247112933089;5067.695938243717;5070.898582028412;5078.720670363092;5108.131617625013;6170.074488826622;6302.873942521124;6305.558610897193;6315.021171718299;6318.810435686937;6148.600340977822;6163.722632481638;6183.721732521957;6186.505079593711;6195.19462469876;6371.490280777434;6385.265694445198;6405.551611387345;6417.486601071996;6419.2296924369375;5930.199423077829;5966.224390829165;6009.669468179117;6074.088886667036;6078.149059131637;6137.62214577108;6139.430809034469;6145.231846019247;6160.568760186923;6168.784092556739;5964.075568286922;5989.850253743517;6051.0923361496125;6052.727627256696;6056.57603967718;5943.762249509971;6006.039033754579;6014.518838492822;6043.879122417439;6055.969720151371;5961.970190149022;5999.940000599938;6017.06735456005;6043.576949613484;6065.787697430569;6070;6081.939180608138;6130.264368275835;6136.693165341626;6152.692365381802;5762.135679648086;5819.301683797971;5906.379830117948;5964.701764911651;5998.7300571473515 14:11:31 INFO - PROCESS | 6703 | |1;ext.html;587.9176915231866;610.3042531514075;631.8546734251125;639.9808005759827;659.6404959297184;35072;47409.762951185236;48424.75787621057;48702.75648621761;51458.228126578135;48756.51243487564;49354.25968610465;49380.27169049075;49489.75255123728;49687.75156124214;9369.344145909788;9512.47681377524;9527.333086683935;9534.237261019136;9547.331686781929;9290.814183716322;9375.156235938764;9377.249820014416;9391.6712915048;9394;9350.111739384747;9427.575759090858;9436.575354109082;9446.574904129331;9450.432974021547;9331.813363732721;9382.90617093834;9384;9389.85915211269;9400.576974036185;9235.399699019543;9247.907520924771;9301.72094837156;9324.813503729954;9330.066993300683;46213.30680039802;46225.53774462246;46578.534214658095;46680.299795503095;46844.297335539995;4021.8190181441905;4024.2574405802593;4030.9395359069636;4147.232761939021;4573.954260457386;35108.824455877555;35416;35579.644203557895;35956.460653090224;36931.63068369309;4144.834206631731;4191.91616167675;4197.664186865043;4243.61807437329;4337.37108119321;385065;388700.0564997185;389073;389158;392437;39096;63152.36847631557;63397.36602634007;63547.682261588394;63579.36420635827;39760.80119599441;41579.376309355386;41832.16335673269;41834.37248441276;41896.79051604783;16309.83690163107;16460.67078658444;16472.752908706378;16475.6704865902;16479.176041197894;13473.932630336982;13530.864691352961;13564.593062208149;13642.386092625657;13652.385642646104;9369;9377.343585948918;9473.952630236805;9483.051694830461;9493.857592136124;3624.184558474375;3698.9642899987507;3711.146436319608;3737.4767532545466;3747.475353450465;1067.0929709746654;1071.287593750163;1128.7686024364984;1130.3726431830248;1162.05873242672;33490.66509334924;34518.82740586331;34800;34879.34331607444;35707.901322845966;1110.6612483192541;1177.5584155941522;1178.5874943769784;1209.8608660004213;1259.3010878962264;18257.087145642665;18278.967940579576;18445.26218951227;18518.16668249932;19317.4204773857;643590;645982;648625;649350;650700;66916.66541667261;67013.66493167503;67243.66378168175;67536.32463675398;67741.66129169421;1437.985620143806;1441.747694153519;1459.3943513441802;1468.1851572377434;1480.0083943757709;33377.332453351286;34306.65693343035;35290.29419411649;35430.8228458856;35436.11409714675;55910.72044639751;56325.155122672375;56515.15227271676;56637.71681141568;56724;568994;570224;571702;573731;575535;30857.074287771404;31248;31419.685803141678;31533.52699709552;31550;51850.22224666709;52102.65538050721;52321.21518177154;52424;53044.73477632587;44217.557824422634;45334;45481.54518454905;45738;46936;43079.7846010768;44761.55238447704;44797;45397.773011134734;46074.078518428774;43551.56448435475;43761.05227602305;44381.556184437744;44588.55411445844;44595.331070033324;38557.42163867488;39213.80393098016;39438.80280598579;39697.40453893136;39974.400383993685;30038.849805750833;30145;30195.69804301929;30313.328416814988;30639.387212256075 14:11:31 INFO - PROCESS | 6703 | |2;jquery.html;416.4232537934961;425.6552192723894;427.6514640567937;428.1073960791749;446.83913791035224;18920.1485933133;19743.99999999998;20445;20541;20563.794362056375;19441.708374374397;19544.41366758996;19951.10220040098;20117;20261.797382026176;5784.971075144618;5948.672822994734;5985.281766188064;5990.101484777275;5999.640021598696;5825.038868586678;5840.970795146019;5868.354481007086;7000.719971201172;7309.524880882752;7289.927100729004;7314.963425182867;7345.19202887682;7446.702131914717;7482.214367491417;7351.228121047293;7406.370458511033;7411.0736157980255;7446.888296675555;7482.176960534364;7368.3736882365065;7477.85044299111;7517.624118794039;7527.322540971284;7550.282723141348;27756.722432775816;28205.717942820513;28459.57310640342;28902.277443063882;29423.70576294231;2539.631753395766;2737.712540183272;2753.7383948524857;2774.916752497428;3168.6197656281165;16429.58926026859;16545.6690866182;16867.83132168687;17812.554686132822;17893.910530447265;2118.925837595677;2121.5650791587686;2137.038332750253;2139.326112274644;2238.854474459155;104084;104328;106024.46987765012;106029.46985265025;109116.45441772741;18817.588680848992;18858.622827543648;19084;19377.4186774397;19513.31703390403;35386.46920296198;35405.29189416197;35466.64533354685;35524.28951420957;35569.1107722309;10382.688519344432;10404.843927341097;10680.359178449318;10730;10951.616693415692;8882.15619516145;8951.194392504705;8988.10118988096;9102.635894564275;9159.496227707406;9361.251099911991;9590.712278631652;9672.516374181263;9724.319297649097;9919.40483570988;3332.3168750406594;3656.4880916671686;3807.3717836556657;3816.198598294334;3922.8626998054933;912.0514664748587;989.6931951095183;1014.5383850348074;1046.0177962760526;1071.0146665068155;19807.702884456456;22170;22251;22356.55286894253;22370.55258894813;1017.7862648843677;1059.0838924330399;1067.4609322292192;1082.5182793656747;1097.3799803111376;11098.61154859576;11600.88399115998;11847.703807404883;11892.286462812259;11925.582604608971;508825;550601;551683;565631;596954;92722.53638731898;93758.53120734489;101089;106190.46904765582;106774;1030.2633616963906;1061.5859814672283;1062.1821197677746;1063.8085144674033;1076.214363514623;15474.767878481607;17920.551986200448;18160.72758908644;18612.255509779457;18710.53223669419;43960.560394395645;44960.32559511675;45111.774441127585;45854.082918342116;46107.769461153825;63598.36401635924;64573.354266456736;65791;66829.33170668231;68340;8367.832643347221;8418.326533877398;8487.702930397407;8544.060153383247;8578.399512034348;7447.218042105717;11024;12101.213421127599;12948.09363344557;13179.60461186166;10754.569817207224;11827.881721183023;11978.46096925623;12046.337451440255;12283.201591896499;11853.78382934841;11887.465064071965;12038.097142714156;12098.939505302416;12186.329751863377;12094.153409261267;12301.630951071482;12317.322547259628;12594.622161334808;12875.420606072936;7663.578503182379;7804.6878124874365;7817.218278172365;7983.960080199562;8525.531095789544;11166.60417447819;11892.940535297268;11934.52261909514;12038.277703337828;12097.57658481949 14:11:31 INFO - PROCESS | 6703 | |3;mootools.html;1534.455268379725;1564.3038847712767;1731.4286285525777;1817;1835.752173456583;8187.18128187181;8793.824123517526;8891.288696904248;9497.905020949796;9503.477308748015;8965.103489651032;9261.861072083908;9262.397944133627;9263.675771348004;9282.211012063966;2386.4033991502083;2430.4895971845935;2431.5623187826186;2432.2460037388378;2437.5124975004983;2424.0788500369836;2425.3815277104313;2447.865367404792;2458.950820983588;2462.175171317611;2411.7588241175918;2433.245693834908;2437.1591800828687;2446.889889954947;2451.2646206138174;2377.4413012941945;2380.1788383007834;2387.832851700373;2392.1866565367773;2420.9394765131015;2293.977060229393;2308.5844547981355;2314.4908120213527;2324.7559006304264;2339.812814974798;9336.57985390659;9485.620575176985;9501.952490237574;9502.714918552454;9521.476318802463;5344.198370244456;5471.2887324647545;5476.288082549283;5479.643823151522;5481;3508.0703613542432;3531.6291789362263;3536.5579302587175;3547.8935631930826;3613.0786649404495;1226.2887525235342;1244.0918129765323;1253.0664654832208;1260.5273022616518;1294.3398866578113;13150.868491315156;13159.473621055145;13182.209067455984;13187.07690461668;13238.867611323956;4811.158047341702;4852.320675105488;4869.220924652039;5002.399712034579;5007.148784706608;11060.723481912855;11101.611443599435;11113.277636953571;11144.609938652271;11179.60871369498;5655.434456554394;5669.262995810518;5683.573731970118;5687.544996400361;5713.5714821388565;4642.837500687459;4990.351254336913;5088.821891233789;5110.565601923878;5213.530782229542;4134.884787572441;4162.79279009084;4196.244675958357;4244.617984381359;4271.295236285978;1296.6174978381212;1349.1500354776429;1360.2790521023874;1366.3168415792104;1366.9111507752164;957.3250858144991;1080.254624309224;1080.589376037101;1084.322298563398;1101.3116801998751;6371.649559274284;6405.29541750407;6586.077949087132;6630.469562434993;6648.5678430901835;498.6036101299476;509.6763555142511;1069.1767339148812;1085.3270971997413;1091.2743025887855;4403.295472724349;4576.97711511447;4587.17430862448;4601.44782626087;4648.093621743795;11272.436378181059;11462.942685286687;11587.362695051685;11766.88233117675;11831.763364732657;11594.594189203337;11661.24201926872;11680.766384672259;11689.415529223505;11695.298282103102;8224.712135075244;8235.176482351717;8301.252887240178;8390.32877369809;8411.915880841114;6273.404026617464;6341.048842673636;6354.841128971812;6383.744650213939;6384.265809431975;10283.07452329294;10664.360138391721;10707.625233116803;10791.40647264408;10833.67498975032;10786.892131078903;10808.919108089443;10846.891531084588;10883.782324353628;10886.61896833607;7736.1877002916135;8039.638216280398;8284.668613255402;8377.413581049268;8512.74461766148;9312.767180820263;9337.346385752931;9409.200217981548;9409.623615055321;9424.434533927986;8255.958720206361;8305.418620696493;8342.708005219789;8471.27994120482;8529;8152.470089444168;8254.876176857471;8306.70926517569;8338.082810890675;8454.83090338202;7258.165310989304;7389.482736208413;7429.702811887464;7508.324250817234;7544.0569928758905;5585.776568937197;5736.397678243724;5791.82624521265;5813.273340832396;5868.589198756217;5459.071957767269;5531.9723401382735;5542.8337149885565;5574.777008919597;5600.635958662674 14:11:31 INFO - PROCESS | 6703 | |4;prototype.html;353.09255214099767;359.25275427111603;363.06691802068696;365.4828417788829;372.2276276725793;5886.499647529965;5887.764489420423;5913.674747888865;5922.348541660419;5925.85185370366;5502.58730595205;5775.5957083004205;5779.168207578288;5803.158542011406;5821.079043915508;4547.408836851221;4551.180787458256;4560.0879824035155;4560.726356418617;4564.338170965208;4526.34368016639;4549.613282870943;4560.612347950429;4561.1105834362315;4565.908681826378;4489.191945449834;4538.546145385468;4540.8864778380475;4545.431821022372;4570.748608826513;4510.684252102355;4511.571400716926;4528.547145285478;4532.773361331921;4536.7504787236685;4012.3179059559943;4031.737937034083;4035.01142220155;4039.373897045933;4051.858184963512;5512.779488820443;5620.690862002588;5633.746481408347;5635.351934527541;5645.350784659776;5214.843554693365;5215.217717342391;5233.21501774733;5236.81671141512;5270.49930256625;6081.331053584102;6097.725602347905;6104.572679912408;6155.969220153871;6163.599366041193;4294.806733696991;4459;4461.107778444324;4462.642988560908;4488.685791994561;6099.512039036867;6301.180846489973;6307.306196318401;6330.4619107375465;6400.231972163324;4360.694751367374;4372.715773474778;4377.693561450732;4382.079763249753;4387.166438376698;4431.468223813163;4450.866474005785;4455.598996090367;4492.2587773017085;4501.144782491317;4994.9750251248515;5122.053619624593;5129.589632829365;5142.1772516397195;5144.61415393847;6033.879322413527;6082.65817660204;6083.726232319556;6095.908561371583;6171.228596425447;1538.4230913407473;1546.0569052877736;1553.4640549010574;1554.85228903254;1556.1363443288858;952.4047470331043;996.6461906023258;1000.8498725191134;1011.6610935336745;1018.7249442650443;5180.5235507880825;5234.450382709761;5252.2930047734635;5274.3670759509105;5281.313429254173;5483.588730845203;5494.423085575957;5511.944880551223;5521.585881058937;5527.296711203503;4881.243407271879;5232.964880369376;5247.396549396868;5263.868403289872;5288.286081379041;2957.5859379686863;2970.7326340629015;2977.1663934098488;2989.282572182704;2994.9550756738668;5652.321721393377;5657.349404818417;5663.309927784269;5677.716114194356;5718.656880587178;5209.71346575942;5561.443855614487;5605.271314729141;5606.943930560724;5616.550675945915;5724.597473618906;5760.337561180434;5763.878826638973;5786.913196302059;5806.593538452268;5198.844034678966;5448.591355648263;5515.779368825362;5528.9723551383595;5569.888602227852;5405.432429594994;5411.188321751769;5455.926747835797;5457.317835270591;5491.972540137273;6300.558960872695;6512.706928188148;6516.543841931019;6520.152380190545;6526.347365263436;4429.80065897029;4446.199684056901;4446.666500012448;4453.732776033448;4515.1195516873895;6208.192934918612;6212.378762123752;6310.242770867525;6347.936520634735;6415.743370265323;6144.723487443165;6153.138560601609;6154.1999540059505;6155.599886007395;6178.1350610913605;5921.259842519685;6155.81468578666;6180.320164781961;6180.845478862884;6207.379262073757;6016.669083200466;6053.273607167168;6077.4226448487325;6083.574149809471;6149.200603921461;6189.412005859436;6244.625322480666;6256.777759453976;6258.155149054819;6275.780347687809;5765.308163020464;5945.435183657545;6003.369646187088;6005.609635373861;6069.605475644069 14:11:31 INFO - PROCESS | 6703 | |5;yui.html;782.4288269563219;825.2366560931138;863.7711006583255;888.2893685051959;907.5416914458198;16495.83504164958;17657.205425755856;17753.91123044386;17804;17864.73202901956;15797.842021579781;15862.52412427629;15917.681646367066;16149.677006459893;16237.918810405961;875.5403413208053;885.5395194498857;891.5675897189858;892.335210268351;893.2898345815092;866.6749968761715;891.028778631295;894.2801045158644;896.9416987895765;902.1790170944441;936.1340759797195;942.3262367407302;944.3342443577261;946;946.5314669238736;928.4893308680232;937.5124935033779;938.4088024544561;940.0646356874885;941.3739862991102;691.9792406227821;692.8060143159923;692.9792106236821;693.7086423702058;694.4964900447186;16604.83395166045;16635.83364166355;16659.666806663798;16662.50012499627;16678.49964501067;14444.855551444456;14467.565973020826;14648.853511464962;15146;16116.59708507285;14500.129992200502;14556.344964476624;14574.927125364411;14833.406663733438;15040.323185456571;4139.151473947863;4161.188568229197;4240.512341080754;4367.890802729926;4801.039792041605;78640;80821.59589202017;81719.59140204321;82386.17613823844;85385.14614853835;12020.819687704692;12310.707375725598;12601.684957875943;12693.492260309484;12728;22857.085716571484;22873.19943801959;22936.541269174857;22983.425414364774;23011.769882300963;9069.77325566866;9146.81706365869;9182.449053056838;9210.447373157633;9289.16397524226;5105.412877519133;5117.360329958755;5159.638825282269;5165.586753059822;5197.97401013;3823.1397935464856;3934.075492259317;3942.40863870416;3947.388154836005;4240.660747140221;717.2218143314562;717.8026042838156;729.1068441159643;742.2392048150689;742.3801126059693;639.3734140542294;755.5466719967975;765.5215490318551;768.5696010234286;812.4881324765478;10620.734481638021;10803.513841877135;10982.670519884416;11101.83347249792;11154.163437742201;642.996785016072;752.1388010727686;760.232165512825;768.7501561992264;787.4015748031537;4908.214685650279;5032.169692000852;5164.457731938092;5223.425423203445;5229.163333866563;117426;122024.38987805005;122427;123200;123641;58656.120158197664;84142;99428;101497;108829;88792.5560372207;91769;91895;94785.99999999862;94852.52573737226;9778.804423911339;9828.336255163227;10092.646757363456;10109.786825580977;10202.28583999113;55769.44230557643;56537.434625653215;57681.13478297745;57825.13262301153;57853.421465784806;78721;79693;81523;81736;84511;13961.860381396056;14086.295685215493;14498.275086245856;14536.85463145355;14591.489297874523;14354.712905741619;14493.7825932609;15640.608984775017;15670.608234794221;15832.683346332778;14980.625484362978;15396.615084622974;15473.613159671098;16154.192290385668;16734.66530669404;14471.710565788415;14727.705445891237;15167.924160379127;15347.539573812803;15684.607884802972;13887;14662.486812961495;14820;15095.24523773785;15928.840711592737;11947.940260298643;12215.877841221474;12382.442790074649;12565.057620678668;12723.55467558631;12129.939350303192;12250.75498490043;12477.801943452365;12491.37543122822;12599.685007874876 14:11:31 INFO - PROCESS | 6703 | __end_tp_report 14:11:31 INFO - PROCESS | 6703 | __start_cc_report 14:11:31 INFO - PROCESS | 6703 | _x_x_mozilla_cycle_collect,365 14:11:31 INFO - PROCESS | 6703 | __end_cc_report 14:11:31 INFO - PROCESS | 6703 | __startTimestamp1478034691508__endTimestamp 14:11:31 INFO - PROCESS | 6703 | 14:11:31 INFO - PROCESS | 6703 | ------- Summary: start ------- 14:11:31 INFO - PROCESS | 6703 | Number of tests: 6 14:11:31 INFO - PROCESS | 6703 | 14:11:31 INFO - PROCESS | 6703 | [#0] dojo.html Cycles:165 Average:5690.64 Median:5943.91 stddev:651.29 (11.0%) stddev-sans-first:625.43 14:11:31 INFO - PROCESS | 6703 | Values: 3288.5 3296.1 3301.3 3325.7 3331.0 5614.4 5678.7 5712.1 5723.8 5742.1 5654.8 5669.9 5678.3 5686.5 5691.7 5178.4 5192.9 5214.0 5257.0 5260.1 5257.6 5264.9 5265.3 5270.9 5301.6 5110.6 5172.8 5247.4 5250.6 5252.4 5278.0 5321.3 5321.8 5323.4 5359.5 5187.4 5235.7 5262.0 5262.3 5267.6 5503.0 5601.4 5668.8 5733.0 5799.9 6055.5 6126.0 6131.5 6138.1 6154.2 6148.2 6156.8 6158.0 6164.4 6173.6 5548.1 5575.9 5733.8 5733.9 5755.2 6092.7 6170.9 6171.7 6172.4 6175.4 5859.9 5909.2 5913.7 5917.3 5944.4 5931.2 5943.9 6001.9 6014.5 6100.3 6066.2 6146.6 6153.8 6154.9 6164.0 6156.8 6161.7 6161.8 6177.2 6192.9 4505.0 4641.5 4699.5 4702.2 4709.1 4092.8 4151.1 4181.8 4197.5 4223.1 5933.3 5958.0 5968.2 5970.1 6005.7 5836.9 5984.0 6196.3 6216.2 6232.3 5783.7 5836.6 5842.8 5848.9 5880.9 5019.2 5067.7 5070.9 5078.7 5108.1 6170.1 6302.9 6305.6 6315.0 6318.8 6148.6 6163.7 6183.7 6186.5 6195.2 6371.5 6385.3 6405.6 6417.5 6419.2 5930.2 5966.2 6009.7 6074.1 6078.1 6137.6 6139.4 6145.2 6160.6 6168.8 5964.1 5989.9 6051.1 6052.7 6056.6 5943.8 6006.0 6014.5 6043.9 6056.0 5962.0 5999.9 6017.1 6043.6 6065.8 6070.0 6081.9 6130.3 6136.7 6152.7 5762.1 5819.3 5906.4 5964.7 5998.7 14:11:31 INFO - PROCESS | 6703 | 14:11:31 INFO - PROCESS | 6703 | [#1] ext.html Cycles:180 Average:69133.66 Median:44485.06 stddev:145977.96 (328.2%) stddev-sans-first:146296.74 14:11:31 INFO - PROCESS | 6703 | Values: 587.9 610.3 631.9 640.0 659.6 35072.0 47409.8 48424.8 48702.8 51458.2 48756.5 49354.3 49380.3 49489.8 49687.8 9369.3 9512.5 9527.3 9534.2 9547.3 9290.8 9375.2 9377.2 9391.7 9394.0 9350.1 9427.6 9436.6 9446.6 9450.4 9331.8 9382.9 9384.0 9389.9 9400.6 9235.4 9247.9 9301.7 9324.8 9330.1 46213.3 46225.5 46578.5 46680.3 46844.3 4021.8 4024.3 4030.9 4147.2 4574.0 35108.8 35416.0 35579.6 35956.5 36931.6 4144.8 4191.9 4197.7 4243.6 4337.4 385065.0 388700.1 389073.0 389158.0 392437.0 39096.0 63152.4 63397.4 63547.7 63579.4 39760.8 41579.4 41832.2 41834.4 41896.8 16309.8 16460.7 16472.8 16475.7 16479.2 13473.9 13530.9 13564.6 13642.4 13652.4 9369.0 9377.3 9474.0 9483.1 9493.9 3624.2 3699.0 3711.1 3737.5 3747.5 1067.1 1071.3 1128.8 1130.4 1162.1 33490.7 34518.8 34800.0 34879.3 35707.9 1110.7 1177.6 1178.6 1209.9 1259.3 18257.1 18279.0 18445.3 18518.2 19317.4 643590.0 645982.0 648625.0 649350.0 650700.0 66916.7 67013.7 67243.7 67536.3 67741.7 1438.0 1441.7 1459.4 1468.2 1480.0 33377.3 34306.7 35290.3 35430.8 35436.1 55910.7 56325.2 56515.2 56637.7 56724.0 568994.0 570224.0 571702.0 573731.0 575535.0 30857.1 31248.0 31419.7 31533.5 31550.0 51850.2 52102.7 52321.2 52424.0 53044.7 44217.6 45334.0 45481.5 45738.0 46936.0 43079.8 44761.6 44797.0 45397.8 46074.1 43551.6 43761.1 44381.6 44588.6 44595.3 38557.4 39213.8 39438.8 39697.4 39974.4 30038.8 30145.0 30195.7 30313.3 30639.4 14:11:31 INFO - PROCESS | 6703 | 14:11:31 INFO - PROCESS | 6703 | [#2] jquery.html Cycles:180 Average:33753.68 Median:2638.67 stddev:91701.69 (3475.3%) stddev-sans-first:91924.77 14:11:31 INFO - PROCESS | 6703 | Values: 416.4 425.7 427.7 428.1 446.8 18920.1 19744.0 20445.0 20541.0 20563.8 19441.7 19544.4 19951.1 20117.0 20261.8 5785.0 5948.7 5985.3 5990.1 5999.6 5825.0 5841.0 5868.4 7000.7 7309.5 7289.9 7315.0 7345.2 7446.7 7482.2 7351.2 7406.4 7411.1 7446.9 7482.2 7368.4 7477.9 7517.6 7527.3 7550.3 27756.7 28205.7 28459.6 28902.3 29423.7 2539.6 2737.7 2753.7 2774.9 3168.6 16429.6 16545.7 16867.8 17812.6 17893.9 2118.9 2121.6 2137.0 2139.3 2238.9 104084.0 104328.0 106024.5 106029.5 109116.5 18817.6 18858.6 19084.0 19377.4 19513.3 35386.5 35405.3 35466.6 35524.3 35569.1 10382.7 10404.8 10680.4 10730.0 10951.6 8882.2 8951.2 8988.1 9102.6 9159.5 9361.3 9590.7 9672.5 9724.3 9919.4 3332.3 3656.5 3807.4 3816.2 3922.9 912.1 989.7 1014.5 1046.0 1071.0 19807.7 22170.0 22251.0 22356.6 22370.6 1017.8 1059.1 1067.5 1082.5 1097.4 11098.6 11600.9 11847.7 11892.3 11925.6 508825.0 550601.0 551683.0 565631.0 596954.0 92722.5 93758.5 101089.0 106190.5 106774.0 1030.3 1061.6 1062.2 1063.8 1076.2 15474.8 17920.6 18160.7 18612.3 18710.5 43960.6 44960.3 45111.8 45854.1 46107.8 63598.4 64573.4 65791.0 66829.3 68340.0 8367.8 8418.3 8487.7 8544.1 8578.4 7447.2 11024.0 12101.2 12948.1 13179.6 10754.6 11827.9 11978.5 12046.3 12283.2 11853.8 11887.5 12038.1 12098.9 12186.3 12094.2 12301.6 12317.3 12594.6 12875.4 7663.6 7804.7 7817.2 7984.0 8525.5 11166.6 11892.9 11934.5 12038.3 12097.6 14:11:31 INFO - PROCESS | 6703 | 14:11:31 INFO - PROCESS | 6703 | [#3] mootools.html Cycles:180 Average:6179.30 Median:4622.14 stddev:3522.89 (76.2%) stddev-sans-first:3515.48 14:11:31 INFO - PROCESS | 6703 | Values: 1534.5 1564.3 1731.4 1817.0 1835.8 8187.2 8793.8 8891.3 9497.9 9503.5 8965.1 9261.9 9262.4 9263.7 9282.2 2386.4 2430.5 2431.6 2432.2 2437.5 2424.1 2425.4 2447.9 2459.0 2462.2 2411.8 2433.2 2437.2 2446.9 2451.3 2377.4 2380.2 2387.8 2392.2 2420.9 2294.0 2308.6 2314.5 2324.8 2339.8 9336.6 9485.6 9502.0 9502.7 9521.5 5344.2 5471.3 5476.3 5479.6 5481.0 3508.1 3531.6 3536.6 3547.9 3613.1 1226.3 1244.1 1253.1 1260.5 1294.3 13150.9 13159.5 13182.2 13187.1 13238.9 4811.2 4852.3 4869.2 5002.4 5007.1 11060.7 11101.6 11113.3 11144.6 11179.6 5655.4 5669.3 5683.6 5687.5 5713.6 4642.8 4990.4 5088.8 5110.6 5213.5 4134.9 4162.8 4196.2 4244.6 4271.3 1296.6 1349.2 1360.3 1366.3 1366.9 957.3 1080.3 1080.6 1084.3 1101.3 6371.6 6405.3 6586.1 6630.5 6648.6 498.6 509.7 1069.2 1085.3 1091.3 4403.3 4577.0 4587.2 4601.4 4648.1 11272.4 11462.9 11587.4 11766.9 11831.8 11594.6 11661.2 11680.8 11689.4 11695.3 8224.7 8235.2 8301.3 8390.3 8411.9 6273.4 6341.0 6354.8 6383.7 6384.3 10283.1 10664.4 10707.6 10791.4 10833.7 10786.9 10808.9 10846.9 10883.8 10886.6 7736.2 8039.6 8284.7 8377.4 8512.7 9312.8 9337.3 9409.2 9409.6 9424.4 8256.0 8305.4 8342.7 8471.3 8529.0 8152.5 8254.9 8306.7 8338.1 8454.8 7258.2 7389.5 7429.7 7508.3 7544.1 5585.8 5736.4 5791.8 5813.3 5868.6 5459.1 5532.0 5542.8 5574.8 5600.6 14:11:31 INFO - PROCESS | 6703 | 14:11:31 INFO - PROCESS | 6703 | [#4] prototype.html Cycles:180 Average:4973.73 Median:5487.78 stddev:1445.45 (26.3%) stddev-sans-first:1407.28 14:11:31 INFO - PROCESS | 6703 | Values: 353.1 359.3 363.1 365.5 372.2 5886.5 5887.8 5913.7 5922.3 5925.9 5502.6 5775.6 5779.2 5803.2 5821.1 4547.4 4551.2 4560.1 4560.7 4564.3 4526.3 4549.6 4560.6 4561.1 4565.9 4489.2 4538.5 4540.9 4545.4 4570.7 4510.7 4511.6 4528.5 4532.8 4536.8 4012.3 4031.7 4035.0 4039.4 4051.9 5512.8 5620.7 5633.7 5635.4 5645.4 5214.8 5215.2 5233.2 5236.8 5270.5 6081.3 6097.7 6104.6 6156.0 6163.6 4294.8 4459.0 4461.1 4462.6 4488.7 6099.5 6301.2 6307.3 6330.5 6400.2 4360.7 4372.7 4377.7 4382.1 4387.2 4431.5 4450.9 4455.6 4492.3 4501.1 4995.0 5122.1 5129.6 5142.2 5144.6 6033.9 6082.7 6083.7 6095.9 6171.2 1538.4 1546.1 1553.5 1554.9 1556.1 952.4 996.6 1000.8 1011.7 1018.7 5180.5 5234.5 5252.3 5274.4 5281.3 5483.6 5494.4 5511.9 5521.6 5527.3 4881.2 5233.0 5247.4 5263.9 5288.3 2957.6 2970.7 2977.2 2989.3 2995.0 5652.3 5657.3 5663.3 5677.7 5718.7 5209.7 5561.4 5605.3 5606.9 5616.6 5724.6 5760.3 5763.9 5786.9 5806.6 5198.8 5448.6 5515.8 5529.0 5569.9 5405.4 5411.2 5455.9 5457.3 5492.0 6300.6 6512.7 6516.5 6520.2 6526.3 4429.8 4446.2 4446.7 4453.7 4515.1 6208.2 6212.4 6310.2 6347.9 6415.7 6144.7 6153.1 6154.2 6155.6 6178.1 5921.3 6155.8 6180.3 6180.8 6207.4 6016.7 6053.3 6077.4 6083.6 6149.2 6189.4 6244.6 6256.8 6258.2 6275.8 5765.3 5945.4 6003.4 6005.6 6069.6 14:11:31 INFO - PROCESS | 6703 | 14:11:31 INFO - PROCESS | 6703 | [#5] yui.html Cycles:180 Average:22116.01 Median:4200.85 stddev:31105.61 (740.5%) stddev-sans-first:31151.62 14:11:31 INFO - PROCESS | 6703 | Values: 782.4 825.2 863.8 888.3 907.5 16495.8 17657.2 17753.9 17804.0 17864.7 15797.8 15862.5 15917.7 16149.7 16237.9 875.5 885.5 891.6 892.3 893.3 866.7 891.0 894.3 896.9 902.2 936.1 942.3 944.3 946.0 946.5 928.5 937.5 938.4 940.1 941.4 692.0 692.8 693.0 693.7 694.5 16604.8 16635.8 16659.7 16662.5 16678.5 14444.9 14467.6 14648.9 15146.0 16116.6 14500.1 14556.3 14574.9 14833.4 15040.3 4139.2 4161.2 4240.5 4367.9 4801.0 78640.0 80821.6 81719.6 82386.2 85385.1 12020.8 12310.7 12601.7 12693.5 12728.0 22857.1 22873.2 22936.5 22983.4 23011.8 9069.8 9146.8 9182.4 9210.4 9289.2 5105.4 5117.4 5159.6 5165.6 5198.0 3823.1 3934.1 3942.4 3947.4 4240.7 717.2 717.8 729.1 742.2 742.4 639.4 755.5 765.5 768.6 812.5 10620.7 10803.5 10982.7 11101.8 11154.2 643.0 752.1 760.2 768.8 787.4 4908.2 5032.2 5164.5 5223.4 5229.2 117426.0 122024.4 122427.0 123200.0 123641.0 58656.1 84142.0 99428.0 101497.0 108829.0 88792.6 91769.0 91895.0 94786.0 94852.5 9778.8 9828.3 10092.6 10109.8 10202.3 55769.4 56537.4 57681.1 57825.1 57853.4 78721.0 79693.0 81523.0 81736.0 84511.0 13961.9 14086.3 14498.3 14536.9 14591.5 14354.7 14493.8 15640.6 15670.6 15832.7 14980.6 15396.6 15473.6 16154.2 16734.7 14471.7 14727.7 15167.9 15347.5 15684.6 13887.0 14662.5 14820.0 15095.2 15928.8 11947.9 12215.9 12382.4 12565.1 12723.6 12129.9 12250.8 12477.8 12491.4 12599.7 14:11:31 INFO - PROCESS | 6703 | -------- Summary: end -------- 14:11:31 INFO - PROCESS | 6703 | 14:11:32 INFO - TEST-INFO | 6703: exit 0 14:11:32 INFO - TEST-OK | dromaeo_css | took 1111535ms 14:11:32 INFO - TEST-START | kraken 14:11:32 INFO - operating with platform_type : linux_ 14:11:32 INFO - Initialising browser for kraken test... 14:11:32 INFO - TEST-INFO | started process 6946 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1s2Av7/profile http://localhost:32825/getInfo.html) 14:11:37 INFO - PROCESS | 6946 | __metrics Screen width/height:1600/1200 14:11:37 INFO - PROCESS | 6946 | colorDepth:24 14:11:37 INFO - PROCESS | 6946 | Browser inner width/height: 1024/697 14:11:37 INFO - PROCESS | 6946 | __metrics 14:11:38 ERROR - PROCESS | 6946 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 14:11:38 INFO - TEST-INFO | 6946: exit 0 14:11:38 INFO - Browser initialized. 14:11:38 INFO - Running cycle 1/1 for kraken test... 14:11:38 INFO - TEST-INFO | started process 7073 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1s2Av7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:11:50 INFO - PROCESS | 7073 | RSS: Main: 150679552 14:11:50 INFO - PROCESS | 7073 | 14:11:53 INFO - PROCESS | 7073 | Cycle 1(1): loaded http://localhost:32825/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32825/tests/kraken/driver.html?testName=audio-beat-detection) 14:11:53 INFO - PROCESS | 7073 | RSS: Main: 157036544 14:11:53 INFO - PROCESS | 7073 | 14:11:56 INFO - PROCESS | 7073 | Cycle 1(1): loaded http://localhost:32825/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32825/tests/kraken/driver.html?testName=audio-dft) 14:11:57 INFO - PROCESS | 7073 | RSS: Main: 155258880 14:11:57 INFO - PROCESS | 7073 | 14:12:00 INFO - PROCESS | 7073 | Cycle 1(1): loaded http://localhost:32825/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32825/tests/kraken/driver.html?testName=audio-fft) 14:12:00 INFO - PROCESS | 7073 | RSS: Main: 156618752 14:12:00 INFO - PROCESS | 7073 | 14:12:02 INFO - PROCESS | 7073 | Cycle 1(1): loaded http://localhost:32825/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32825/tests/kraken/driver.html?testName=audio-oscillator) 14:12:03 INFO - PROCESS | 7073 | RSS: Main: 155734016 14:12:03 INFO - PROCESS | 7073 | 14:12:05 INFO - PROCESS | 7073 | Cycle 1(1): loaded http://localhost:32825/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32825/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:12:06 INFO - PROCESS | 7073 | RSS: Main: 156196864 14:12:06 INFO - PROCESS | 7073 | 14:12:09 INFO - PROCESS | 7073 | Cycle 1(1): loaded http://localhost:32825/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32825/tests/kraken/driver.html?testName=imaging-darkroom) 14:12:09 INFO - PROCESS | 7073 | RSS: Main: 156766208 14:12:09 INFO - PROCESS | 7073 | 14:12:13 INFO - PROCESS | 7073 | Cycle 1(1): loaded http://localhost:32825/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32825/tests/kraken/driver.html?testName=imaging-desaturate) 14:12:13 INFO - PROCESS | 7073 | RSS: Main: 157122560 14:12:13 INFO - PROCESS | 7073 | 14:12:16 INFO - PROCESS | 7073 | Cycle 1(1): loaded http://localhost:32825/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32825/tests/kraken/driver.html?testName=json-parse-financial) 14:12:17 INFO - PROCESS | 7073 | RSS: Main: 157171712 14:12:17 INFO - PROCESS | 7073 | 14:12:18 INFO - PROCESS | 7073 | Cycle 1(1): loaded http://localhost:32825/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32825/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:12:19 INFO - PROCESS | 7073 | RSS: Main: 156131328 14:12:19 INFO - PROCESS | 7073 | 14:12:21 INFO - PROCESS | 7073 | Cycle 1(1): loaded http://localhost:32825/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32825/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:12:21 INFO - PROCESS | 7073 | RSS: Main: 156651520 14:12:21 INFO - PROCESS | 7073 | 14:12:23 INFO - PROCESS | 7073 | Cycle 1(1): loaded http://localhost:32825/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32825/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:12:24 INFO - PROCESS | 7073 | RSS: Main: 156508160 14:12:24 INFO - PROCESS | 7073 | 14:12:27 INFO - PROCESS | 7073 | Cycle 1(1): loaded http://localhost:32825/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32825/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:12:27 INFO - PROCESS | 7073 | RSS: Main: 156676096 14:12:27 INFO - PROCESS | 7073 | 14:12:30 INFO - PROCESS | 7073 | Cycle 1(1): loaded http://localhost:32825/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32825/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:12:31 INFO - PROCESS | 7073 | RSS: Main: 157151232 14:12:31 INFO - PROCESS | 7073 | 14:12:32 INFO - PROCESS | 7073 | Cycle 1(1): loaded http://localhost:32825/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32825/tests/kraken/driver.html?testName=ai-astar) 14:12:32 INFO - PROCESS | 7073 | RSS: Main: 159010816 14:12:32 INFO - PROCESS | 7073 | 14:12:32 INFO - PROCESS | 7073 | __start_tp_report 14:12:32 INFO - PROCESS | 7073 | _x_x_mozilla_page_load 14:12:32 INFO - PROCESS | 7073 | _x_x_mozilla_page_load_details 14:12:32 INFO - PROCESS | 7073 | |i|pagename|runs| 14:12:32 INFO - PROCESS | 7073 | |0;ai-astar;101;111;105;111;111;112;112;110;112;110 14:12:32 INFO - PROCESS | 7073 | |1;audio-beat-detection;139;116;146;170;120;142;150;118;186;117 14:12:32 INFO - PROCESS | 7073 | |2;audio-dft;167;165;166;161;160;162;174;162;161;163 14:12:32 INFO - PROCESS | 7073 | |3;audio-fft;74;75;74;184;75;75;75;76;174;76 14:12:32 INFO - PROCESS | 7073 | |4;audio-oscillator;86;88;154;83;84;84;133;82;84;153 14:12:32 INFO - PROCESS | 7073 | |5;imaging-gaussian-blur;118;118;117;117;117;118;118;119;118;119 14:12:32 INFO - PROCESS | 7073 | |6;imaging-darkroom;147;147;147;148;148;147;147;148;148;147 14:12:32 INFO - PROCESS | 7073 | |7;imaging-desaturate;95;95;95;95;95;96;95;95;95;95 14:12:32 INFO - PROCESS | 7073 | |8;json-parse-financial;57;52;51;51;55;56;53;51;50;56 14:12:32 INFO - PROCESS | 7073 | |9;json-stringify-tinderbox;61;60;60;60;60;60;60;61;64;60 14:12:32 INFO - PROCESS | 7073 | |10;stanford-crypto-aes;72;74;80;72;74;73;73;74;78;73 14:12:32 INFO - PROCESS | 7073 | |11;stanford-crypto-ccm;133;127;134;117;130;131;126;120;162;129 14:12:32 INFO - PROCESS | 7073 | |12;stanford-crypto-pbkdf2;158;155;154;155;150;153;151;151;152;155 14:12:32 INFO - PROCESS | 7073 | |13;stanford-crypto-sha256-iterative;67;61;64;61;63;63;63;62;61;65 14:12:32 INFO - PROCESS | 7073 | __end_tp_report 14:12:32 INFO - PROCESS | 7073 | __start_cc_report 14:12:32 INFO - PROCESS | 7073 | _x_x_mozilla_cycle_collect,851 14:12:32 INFO - PROCESS | 7073 | __end_cc_report 14:12:32 INFO - PROCESS | 7073 | __startTimestamp1478034752902__endTimestamp 14:12:32 INFO - PROCESS | 7073 | 14:12:32 INFO - PROCESS | 7073 | ------- Summary: start ------- 14:12:32 INFO - PROCESS | 7073 | Number of tests: 14 14:12:32 INFO - PROCESS | 7073 | 14:12:32 INFO - PROCESS | 7073 | [#0] ai-astar Cycles:10 Average:109.50 Median:111.00 stddev:3.63 (3.3%) stddev-sans-first:2.19 14:12:32 INFO - PROCESS | 7073 | Values: 101.0 111.0 105.0 111.0 111.0 112.0 112.0 110.0 112.0 110.0 14:12:32 INFO - PROCESS | 7073 | 14:12:32 INFO - PROCESS | 7073 | [#1] audio-beat-detection Cycles:10 Average:140.40 Median:144.00 stddev:23.91 (16.6%) stddev-sans-first:25.35 14:12:32 INFO - PROCESS | 7073 | Values: 139.0 116.0 146.0 170.0 120.0 142.0 150.0 118.0 186.0 117.0 14:12:32 INFO - PROCESS | 7073 | 14:12:32 INFO - PROCESS | 7073 | [#2] audio-dft Cycles:10 Average:164.10 Median:164.00 stddev:4.18 (2.5%) stddev-sans-first:4.29 14:12:32 INFO - PROCESS | 7073 | Values: 167.0 165.0 166.0 161.0 160.0 162.0 174.0 162.0 161.0 163.0 14:12:32 INFO - PROCESS | 7073 | 14:12:32 INFO - PROCESS | 7073 | [#3] audio-fft Cycles:10 Average:95.80 Median:75.00 stddev:43.92 (58.6%) stddev-sans-first:45.87 14:12:32 INFO - PROCESS | 7073 | Values: 74.0 75.0 74.0 184.0 75.0 75.0 75.0 76.0 174.0 76.0 14:12:32 INFO - PROCESS | 7073 | 14:12:32 INFO - PROCESS | 7073 | [#4] audio-oscillator Cycles:10 Average:103.10 Median:84.00 stddev:30.62 (36.5%) stddev-sans-first:31.85 14:12:32 INFO - PROCESS | 7073 | Values: 86.0 88.0 154.0 83.0 84.0 84.0 133.0 82.0 84.0 153.0 14:12:32 INFO - PROCESS | 7073 | 14:12:32 INFO - PROCESS | 7073 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 14:12:32 INFO - PROCESS | 7073 | Values: 118.0 118.0 117.0 117.0 117.0 118.0 118.0 119.0 118.0 119.0 14:12:32 INFO - PROCESS | 7073 | 14:12:32 INFO - PROCESS | 7073 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 14:12:32 INFO - PROCESS | 7073 | Values: 147.0 147.0 147.0 148.0 148.0 147.0 147.0 148.0 148.0 147.0 14:12:32 INFO - PROCESS | 7073 | 14:12:32 INFO - PROCESS | 7073 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 14:12:32 INFO - PROCESS | 7073 | Values: 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 14:12:32 INFO - PROCESS | 7073 | 14:12:32 INFO - PROCESS | 7073 | [#8] json-parse-financial Cycles:10 Average:53.20 Median:54.00 stddev:2.57 (4.8%) stddev-sans-first:2.33 14:12:32 INFO - PROCESS | 7073 | Values: 57.0 52.0 51.0 51.0 55.0 56.0 53.0 51.0 50.0 56.0 14:12:32 INFO - PROCESS | 7073 | 14:12:32 INFO - PROCESS | 7073 | [#9] json-stringify-tinderbox Cycles:10 Average:60.60 Median:60.00 stddev:1.26 (2.1%) stddev-sans-first:1.33 14:12:32 INFO - PROCESS | 7073 | Values: 61.0 60.0 60.0 60.0 60.0 60.0 60.0 61.0 64.0 60.0 14:12:32 INFO - PROCESS | 7073 | 14:12:32 INFO - PROCESS | 7073 | [#10] stanford-crypto-aes Cycles:10 Average:74.30 Median:74.00 stddev:2.63 (3.5%) stddev-sans-first:2.65 14:12:32 INFO - PROCESS | 7073 | Values: 72.0 74.0 80.0 72.0 74.0 73.0 73.0 74.0 78.0 73.0 14:12:32 INFO - PROCESS | 7073 | 14:12:32 INFO - PROCESS | 7073 | [#11] stanford-crypto-ccm Cycles:10 Average:130.90 Median:130.50 stddev:12.19 (9.3%) stddev-sans-first:12.90 14:12:32 INFO - PROCESS | 7073 | Values: 133.0 127.0 134.0 117.0 130.0 131.0 126.0 120.0 162.0 129.0 14:12:32 INFO - PROCESS | 7073 | 14:12:32 INFO - PROCESS | 7073 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.40 Median:154.50 stddev:2.46 (1.6%) stddev-sans-first:1.96 14:12:32 INFO - PROCESS | 7073 | Values: 158.0 155.0 154.0 155.0 150.0 153.0 151.0 151.0 152.0 155.0 14:12:32 INFO - PROCESS | 7073 | 14:12:32 INFO - PROCESS | 7073 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:63.00 stddev:1.94 (3.1%) stddev-sans-first:1.42 14:12:32 INFO - PROCESS | 7073 | Values: 67.0 61.0 64.0 61.0 63.0 63.0 63.0 62.0 61.0 65.0 14:12:32 INFO - PROCESS | 7073 | -------- Summary: end -------- 14:12:32 INFO - PROCESS | 7073 | 14:12:33 INFO - TEST-INFO | 7073: exit 0 14:12:33 INFO - TEST-OK | kraken | took 61583ms 14:12:33 INFO - SUITE-END | took 1173s 14:12:34 INFO - Completed test suite (00:19:33) 14:12:34 INFO - javascript benchmark 14:12:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7856.219364432403, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3288.4902840059785, 3296.1265264704857, 3301.2737197816473, 3325.6840600142978, 3331.0340001399595, 5614.410486898878, 5678.659280443171, 5712.057510510771, 5723.771049158034, 5742.081266997281, 5654.802081927123, 5669.8582535436535, 5678.318601767794, 5686.545076393889, 5691.686957217351, 5178.352705911761, 5192.8701782455555, 5213.973930130344, 5257.027449921777, 5260.105782017047, 5257.579393648518, 5264.92102618461, 5265.262863199156, 5270.868228294285, 5301.575873930095, 5110.6422550421485, 5172.793088276464, 5247.39654939683, 5250.6324557281005, 5252.395974462947, 5278.0, 5321.255024296563, 5321.760520776555, 5323.361196656388, 5359.517643412073, 5187.377514698261, 5235.712035838027, 5262.0, 5262.2632831403635, 5267.631265811395, 5503.0, 5601.439856014406, 5668.829935101953, 5732.968065748164, 5799.88400231993, 6055.485283750886, 6125.9680843641045, 6131.526791107749, 6138.081874382042, 6154.230721159855, 6148.169997050386, 6156.78451254204, 6158.0, 6164.383561643845, 6173.59871608344, 5548.112302031655, 5575.8606034849045, 5733.799317023926, 5733.856653583652, 5755.165501002373, 6092.69536523181, 6170.938290617037, 6171.722272497748, 6172.382761723792, 6175.413335733098, 5859.853503662443, 5909.23179986599, 5913.674747888907, 5917.260342457193, 5944.4352786485215, 5931.169636250928, 5943.910841337383, 6001.879962400728, 6014.488768454643, 6100.267967843887, 6066.241719785027, 6146.631202127886, 6153.784617538365, 6154.907676384858, 6163.96918015407, 6156.753729850845, 6161.691915404212, 6161.784337548164, 6177.227846519185, 6192.8761424771255, 4504.977475112603, 4641.489436162019, 4699.530046995274, 4702.200625893606, 4709.058188362273, 4092.7953602319767, 4151.14901445203, 4181.811818468115, 4197.496300443966, 4223.13425747721, 5933.2880054393745, 5957.970210149008, 5968.22413086296, 5970.0746384310505, 6005.669688167192, 5836.9124463133085, 5984.042553191469, 6196.349383314777, 6216.160818289563, 6232.3144454110015, 5783.739731712083, 5836.562257830595, 5842.766289348463, 5848.912266316009, 5880.941190588125, 5019.247112933089, 5067.695938243717, 5070.898582028412, 5078.720670363092, 5108.131617625013, 6170.074488826622, 6302.873942521124, 6305.558610897193, 6315.021171718299, 6318.810435686937, 6148.600340977822, 6163.722632481638, 6183.721732521957, 6186.505079593711, 6195.19462469876, 6371.490280777434, 6385.265694445198, 6405.551611387345, 6417.486601071996, 6419.2296924369375, 5930.199423077829, 5966.224390829165, 6009.669468179117, 6074.088886667036, 6078.149059131637, 6137.62214577108, 6139.430809034469, 6145.231846019247, 6160.568760186923, 6168.784092556739, 5964.075568286922, 5989.850253743517, 6051.0923361496125, 6052.727627256696, 6056.57603967718, 5943.762249509971, 6006.039033754579, 6014.518838492822, 6043.879122417439, 6055.969720151371, 5961.970190149022, 5999.940000599938, 6017.06735456005, 6043.576949613484, 6065.787697430569, 6070.0, 6081.939180608138, 6130.264368275835, 6136.693165341626, 6152.692365381802, 5762.135679648086, 5819.301683797971, 5906.379830117948, 5964.701764911651, 5998.7300571473515], "value": 5646.254781593373, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.9176915231866, 610.3042531514075, 631.8546734251125, 639.9808005759827, 659.6404959297184, 35072.0, 47409.762951185236, 48424.75787621057, 48702.75648621761, 51458.228126578135, 48756.51243487564, 49354.25968610465, 49380.27169049075, 49489.75255123728, 49687.75156124214, 9369.344145909788, 9512.47681377524, 9527.333086683935, 9534.237261019136, 9547.331686781929, 9290.814183716322, 9375.156235938764, 9377.249820014416, 9391.6712915048, 9394.0, 9350.111739384747, 9427.575759090858, 9436.575354109082, 9446.574904129331, 9450.432974021547, 9331.813363732721, 9382.90617093834, 9384.0, 9389.85915211269, 9400.576974036185, 9235.399699019543, 9247.907520924771, 9301.72094837156, 9324.813503729954, 9330.066993300683, 46213.30680039802, 46225.53774462246, 46578.534214658095, 46680.299795503095, 46844.297335539995, 4021.8190181441905, 4024.2574405802593, 4030.9395359069636, 4147.232761939021, 4573.954260457386, 35108.824455877555, 35416.0, 35579.644203557895, 35956.460653090224, 36931.63068369309, 4144.834206631731, 4191.91616167675, 4197.664186865043, 4243.61807437329, 4337.37108119321, 385065.0, 388700.0564997185, 389073.0, 389158.0, 392437.0, 39096.0, 63152.36847631557, 63397.36602634007, 63547.682261588394, 63579.36420635827, 39760.80119599441, 41579.376309355386, 41832.16335673269, 41834.37248441276, 41896.79051604783, 16309.83690163107, 16460.67078658444, 16472.752908706378, 16475.6704865902, 16479.176041197894, 13473.932630336982, 13530.864691352961, 13564.593062208149, 13642.386092625657, 13652.385642646104, 9369.0, 9377.343585948918, 9473.952630236805, 9483.051694830461, 9493.857592136124, 3624.184558474375, 3698.9642899987507, 3711.146436319608, 3737.4767532545466, 3747.475353450465, 1067.0929709746654, 1071.287593750163, 1128.7686024364984, 1130.3726431830248, 1162.05873242672, 33490.66509334924, 34518.82740586331, 34800.0, 34879.34331607444, 35707.901322845966, 1110.6612483192541, 1177.5584155941522, 1178.5874943769784, 1209.8608660004213, 1259.3010878962264, 18257.087145642665, 18278.967940579576, 18445.26218951227, 18518.16668249932, 19317.4204773857, 643590.0, 645982.0, 648625.0, 649350.0, 650700.0, 66916.66541667261, 67013.66493167503, 67243.66378168175, 67536.32463675398, 67741.66129169421, 1437.985620143806, 1441.747694153519, 1459.3943513441802, 1468.1851572377434, 1480.0083943757709, 33377.332453351286, 34306.65693343035, 35290.29419411649, 35430.8228458856, 35436.11409714675, 55910.72044639751, 56325.155122672375, 56515.15227271676, 56637.71681141568, 56724.0, 568994.0, 570224.0, 571702.0, 573731.0, 575535.0, 30857.074287771404, 31248.0, 31419.685803141678, 31533.52699709552, 31550.0, 51850.22224666709, 52102.65538050721, 52321.21518177154, 52424.0, 53044.73477632587, 44217.557824422634, 45334.0, 45481.54518454905, 45738.0, 46936.0, 43079.7846010768, 44761.55238447704, 44797.0, 45397.773011134734, 46074.078518428774, 43551.56448435475, 43761.05227602305, 44381.556184437744, 44588.55411445844, 44595.331070033324, 38557.42163867488, 39213.80393098016, 39438.80280598579, 39697.40453893136, 39974.400383993685, 30038.849805750833, 30145.0, 30195.69804301929, 30313.328416814988, 30639.387212256075], "value": 20707.2172250241, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [416.4232537934961, 425.6552192723894, 427.6514640567937, 428.1073960791749, 446.83913791035224, 18920.1485933133, 19743.99999999998, 20445.0, 20541.0, 20563.794362056375, 19441.708374374397, 19544.41366758996, 19951.10220040098, 20117.0, 20261.797382026176, 5784.971075144618, 5948.672822994734, 5985.281766188064, 5990.101484777275, 5999.640021598696, 5825.038868586678, 5840.970795146019, 5868.354481007086, 7000.719971201172, 7309.524880882752, 7289.927100729004, 7314.963425182867, 7345.19202887682, 7446.702131914717, 7482.214367491417, 7351.228121047293, 7406.370458511033, 7411.0736157980255, 7446.888296675555, 7482.176960534364, 7368.3736882365065, 7477.85044299111, 7517.624118794039, 7527.322540971284, 7550.282723141348, 27756.722432775816, 28205.717942820513, 28459.57310640342, 28902.277443063882, 29423.70576294231, 2539.631753395766, 2737.712540183272, 2753.7383948524857, 2774.916752497428, 3168.6197656281165, 16429.58926026859, 16545.6690866182, 16867.83132168687, 17812.554686132822, 17893.910530447265, 2118.925837595677, 2121.5650791587686, 2137.038332750253, 2139.326112274644, 2238.854474459155, 104084.0, 104328.0, 106024.46987765012, 106029.46985265025, 109116.45441772741, 18817.588680848992, 18858.622827543648, 19084.0, 19377.4186774397, 19513.31703390403, 35386.46920296198, 35405.29189416197, 35466.64533354685, 35524.28951420957, 35569.1107722309, 10382.688519344432, 10404.843927341097, 10680.359178449318, 10730.0, 10951.616693415692, 8882.15619516145, 8951.194392504705, 8988.10118988096, 9102.635894564275, 9159.496227707406, 9361.251099911991, 9590.712278631652, 9672.516374181263, 9724.319297649097, 9919.40483570988, 3332.3168750406594, 3656.4880916671686, 3807.3717836556657, 3816.198598294334, 3922.8626998054933, 912.0514664748587, 989.6931951095183, 1014.5383850348074, 1046.0177962760526, 1071.0146665068155, 19807.702884456456, 22170.0, 22251.0, 22356.55286894253, 22370.55258894813, 1017.7862648843677, 1059.0838924330399, 1067.4609322292192, 1082.5182793656747, 1097.3799803111376, 11098.61154859576, 11600.88399115998, 11847.703807404883, 11892.286462812259, 11925.582604608971, 508825.0, 550601.0, 551683.0, 565631.0, 596954.0, 92722.53638731898, 93758.53120734489, 101089.0, 106190.46904765582, 106774.0, 1030.2633616963906, 1061.5859814672283, 1062.1821197677746, 1063.8085144674033, 1076.214363514623, 15474.767878481607, 17920.551986200448, 18160.72758908644, 18612.255509779457, 18710.53223669419, 43960.560394395645, 44960.32559511675, 45111.774441127585, 45854.082918342116, 46107.769461153825, 63598.36401635924, 64573.354266456736, 65791.0, 66829.33170668231, 68340.0, 8367.832643347221, 8418.326533877398, 8487.702930397407, 8544.060153383247, 8578.399512034348, 7447.218042105717, 11024.0, 12101.213421127599, 12948.09363344557, 13179.60461186166, 10754.569817207224, 11827.881721183023, 11978.46096925623, 12046.337451440255, 12283.201591896499, 11853.78382934841, 11887.465064071965, 12038.097142714156, 12098.939505302416, 12186.329751863377, 12094.153409261267, 12301.630951071482, 12317.322547259628, 12594.622161334808, 12875.420606072936, 7663.578503182379, 7804.6878124874365, 7817.218278172365, 7983.960080199562, 8525.531095789544, 11166.60417447819, 11892.940535297268, 11934.52261909514, 12038.277703337828, 12097.57658481949], "value": 10947.548341160526, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1534.455268379725, 1564.3038847712767, 1731.4286285525777, 1817.0, 1835.752173456583, 8187.18128187181, 8793.824123517526, 8891.288696904248, 9497.905020949796, 9503.477308748015, 8965.103489651032, 9261.861072083908, 9262.397944133627, 9263.675771348004, 9282.211012063966, 2386.4033991502083, 2430.4895971845935, 2431.5623187826186, 2432.2460037388378, 2437.5124975004983, 2424.0788500369836, 2425.3815277104313, 2447.865367404792, 2458.950820983588, 2462.175171317611, 2411.7588241175918, 2433.245693834908, 2437.1591800828687, 2446.889889954947, 2451.2646206138174, 2377.4413012941945, 2380.1788383007834, 2387.832851700373, 2392.1866565367773, 2420.9394765131015, 2293.977060229393, 2308.5844547981355, 2314.4908120213527, 2324.7559006304264, 2339.812814974798, 9336.57985390659, 9485.620575176985, 9501.952490237574, 9502.714918552454, 9521.476318802463, 5344.198370244456, 5471.2887324647545, 5476.288082549283, 5479.643823151522, 5481.0, 3508.0703613542432, 3531.6291789362263, 3536.5579302587175, 3547.8935631930826, 3613.0786649404495, 1226.2887525235342, 1244.0918129765323, 1253.0664654832208, 1260.5273022616518, 1294.3398866578113, 13150.868491315156, 13159.473621055145, 13182.209067455984, 13187.07690461668, 13238.867611323956, 4811.158047341702, 4852.320675105488, 4869.220924652039, 5002.399712034579, 5007.148784706608, 11060.723481912855, 11101.611443599435, 11113.277636953571, 11144.609938652271, 11179.60871369498, 5655.434456554394, 5669.262995810518, 5683.573731970118, 5687.544996400361, 5713.5714821388565, 4642.837500687459, 4990.351254336913, 5088.821891233789, 5110.565601923878, 5213.530782229542, 4134.884787572441, 4162.79279009084, 4196.244675958357, 4244.617984381359, 4271.295236285978, 1296.6174978381212, 1349.1500354776429, 1360.2790521023874, 1366.3168415792104, 1366.9111507752164, 957.3250858144991, 1080.254624309224, 1080.589376037101, 1084.322298563398, 1101.3116801998751, 6371.649559274284, 6405.29541750407, 6586.077949087132, 6630.469562434993, 6648.5678430901835, 498.6036101299476, 509.6763555142511, 1069.1767339148812, 1085.3270971997413, 1091.2743025887855, 4403.295472724349, 4576.97711511447, 4587.17430862448, 4601.44782626087, 4648.093621743795, 11272.436378181059, 11462.942685286687, 11587.362695051685, 11766.88233117675, 11831.763364732657, 11594.594189203337, 11661.24201926872, 11680.766384672259, 11689.415529223505, 11695.298282103102, 8224.712135075244, 8235.176482351717, 8301.252887240178, 8390.32877369809, 8411.915880841114, 6273.404026617464, 6341.048842673636, 6354.841128971812, 6383.744650213939, 6384.265809431975, 10283.07452329294, 10664.360138391721, 10707.625233116803, 10791.40647264408, 10833.67498975032, 10786.892131078903, 10808.919108089443, 10846.891531084588, 10883.782324353628, 10886.61896833607, 7736.1877002916135, 8039.638216280398, 8284.668613255402, 8377.413581049268, 8512.74461766148, 9312.767180820263, 9337.346385752931, 9409.200217981548, 9409.623615055321, 9424.434533927986, 8255.958720206361, 8305.418620696493, 8342.708005219789, 8471.27994120482, 8529.0, 8152.470089444168, 8254.876176857471, 8306.70926517569, 8338.082810890675, 8454.83090338202, 7258.165310989304, 7389.482736208413, 7429.702811887464, 7508.324250817234, 7544.0569928758905, 5585.776568937197, 5736.397678243724, 5791.82624521265, 5813.273340832396, 5868.589198756217, 5459.071957767269, 5531.9723401382735, 5542.8337149885565, 5574.777008919597, 5600.635958662674], "value": 4924.366248005994, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.09255214099767, 359.25275427111603, 363.06691802068696, 365.4828417788829, 372.2276276725793, 5886.499647529965, 5887.764489420423, 5913.674747888865, 5922.348541660419, 5925.85185370366, 5502.58730595205, 5775.5957083004205, 5779.168207578288, 5803.158542011406, 5821.079043915508, 4547.408836851221, 4551.180787458256, 4560.0879824035155, 4560.726356418617, 4564.338170965208, 4526.34368016639, 4549.613282870943, 4560.612347950429, 4561.1105834362315, 4565.908681826378, 4489.191945449834, 4538.546145385468, 4540.8864778380475, 4545.431821022372, 4570.748608826513, 4510.684252102355, 4511.571400716926, 4528.547145285478, 4532.773361331921, 4536.7504787236685, 4012.3179059559943, 4031.737937034083, 4035.01142220155, 4039.373897045933, 4051.858184963512, 5512.779488820443, 5620.690862002588, 5633.746481408347, 5635.351934527541, 5645.350784659776, 5214.843554693365, 5215.217717342391, 5233.21501774733, 5236.81671141512, 5270.49930256625, 6081.331053584102, 6097.725602347905, 6104.572679912408, 6155.969220153871, 6163.599366041193, 4294.806733696991, 4459.0, 4461.107778444324, 4462.642988560908, 4488.685791994561, 6099.512039036867, 6301.180846489973, 6307.306196318401, 6330.4619107375465, 6400.231972163324, 4360.694751367374, 4372.715773474778, 4377.693561450732, 4382.079763249753, 4387.166438376698, 4431.468223813163, 4450.866474005785, 4455.598996090367, 4492.2587773017085, 4501.144782491317, 4994.9750251248515, 5122.053619624593, 5129.589632829365, 5142.1772516397195, 5144.61415393847, 6033.879322413527, 6082.65817660204, 6083.726232319556, 6095.908561371583, 6171.228596425447, 1538.4230913407473, 1546.0569052877736, 1553.4640549010574, 1554.85228903254, 1556.1363443288858, 952.4047470331043, 996.6461906023258, 1000.8498725191134, 1011.6610935336745, 1018.7249442650443, 5180.5235507880825, 5234.450382709761, 5252.2930047734635, 5274.3670759509105, 5281.313429254173, 5483.588730845203, 5494.423085575957, 5511.944880551223, 5521.585881058937, 5527.296711203503, 4881.243407271879, 5232.964880369376, 5247.396549396868, 5263.868403289872, 5288.286081379041, 2957.5859379686863, 2970.7326340629015, 2977.1663934098488, 2989.282572182704, 2994.9550756738668, 5652.321721393377, 5657.349404818417, 5663.309927784269, 5677.716114194356, 5718.656880587178, 5209.71346575942, 5561.443855614487, 5605.271314729141, 5606.943930560724, 5616.550675945915, 5724.597473618906, 5760.337561180434, 5763.878826638973, 5786.913196302059, 5806.593538452268, 5198.844034678966, 5448.591355648263, 5515.779368825362, 5528.9723551383595, 5569.888602227852, 5405.432429594994, 5411.188321751769, 5455.926747835797, 5457.317835270591, 5491.972540137273, 6300.558960872695, 6512.706928188148, 6516.543841931019, 6520.152380190545, 6526.347365263436, 4429.80065897029, 4446.199684056901, 4446.666500012448, 4453.732776033448, 4515.1195516873895, 6208.192934918612, 6212.378762123752, 6310.242770867525, 6347.936520634735, 6415.743370265323, 6144.723487443165, 6153.138560601609, 6154.1999540059505, 6155.599886007395, 6178.1350610913605, 5921.259842519685, 6155.81468578666, 6180.320164781961, 6180.845478862884, 6207.379262073757, 6016.669083200466, 6053.273607167168, 6077.4226448487325, 6083.574149809471, 6149.200603921461, 6189.412005859436, 6244.625322480666, 6256.777759453976, 6258.155149054819, 6275.780347687809, 5765.308163020464, 5945.435183657545, 6003.369646187088, 6005.609635373861, 6069.605475644069], "value": 4514.893573428128, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [782.4288269563219, 825.2366560931138, 863.7711006583255, 888.2893685051959, 907.5416914458198, 16495.83504164958, 17657.205425755856, 17753.91123044386, 17804.0, 17864.73202901956, 15797.842021579781, 15862.52412427629, 15917.681646367066, 16149.677006459893, 16237.918810405961, 875.5403413208053, 885.5395194498857, 891.5675897189858, 892.335210268351, 893.2898345815092, 866.6749968761715, 891.028778631295, 894.2801045158644, 896.9416987895765, 902.1790170944441, 936.1340759797195, 942.3262367407302, 944.3342443577261, 946.0, 946.5314669238736, 928.4893308680232, 937.5124935033779, 938.4088024544561, 940.0646356874885, 941.3739862991102, 691.9792406227821, 692.8060143159923, 692.9792106236821, 693.7086423702058, 694.4964900447186, 16604.83395166045, 16635.83364166355, 16659.666806663798, 16662.50012499627, 16678.49964501067, 14444.855551444456, 14467.565973020826, 14648.853511464962, 15146.0, 16116.59708507285, 14500.129992200502, 14556.344964476624, 14574.927125364411, 14833.406663733438, 15040.323185456571, 4139.151473947863, 4161.188568229197, 4240.512341080754, 4367.890802729926, 4801.039792041605, 78640.0, 80821.59589202017, 81719.59140204321, 82386.17613823844, 85385.14614853835, 12020.819687704692, 12310.707375725598, 12601.684957875943, 12693.492260309484, 12728.0, 22857.085716571484, 22873.19943801959, 22936.541269174857, 22983.425414364774, 23011.769882300963, 9069.77325566866, 9146.81706365869, 9182.449053056838, 9210.447373157633, 9289.16397524226, 5105.412877519133, 5117.360329958755, 5159.638825282269, 5165.586753059822, 5197.97401013, 3823.1397935464856, 3934.075492259317, 3942.40863870416, 3947.388154836005, 4240.660747140221, 717.2218143314562, 717.8026042838156, 729.1068441159643, 742.2392048150689, 742.3801126059693, 639.3734140542294, 755.5466719967975, 765.5215490318551, 768.5696010234286, 812.4881324765478, 10620.734481638021, 10803.513841877135, 10982.670519884416, 11101.83347249792, 11154.163437742201, 642.996785016072, 752.1388010727686, 760.232165512825, 768.7501561992264, 787.4015748031537, 4908.214685650279, 5032.169692000852, 5164.457731938092, 5223.425423203445, 5229.163333866563, 117426.0, 122024.38987805005, 122427.0, 123200.0, 123641.0, 58656.120158197664, 84142.0, 99428.0, 101497.0, 108829.0, 88792.5560372207, 91769.0, 91895.0, 94785.99999999862, 94852.52573737226, 9778.804423911339, 9828.336255163227, 10092.646757363456, 10109.786825580977, 10202.28583999113, 55769.44230557643, 56537.434625653215, 57681.13478297745, 57825.13262301153, 57853.421465784806, 78721.0, 79693.0, 81523.0, 81736.0, 84511.0, 13961.860381396056, 14086.295685215493, 14498.275086245856, 14536.85463145355, 14591.489297874523, 14354.712905741619, 14493.7825932609, 15640.608984775017, 15670.608234794221, 15832.683346332778, 14980.625484362978, 15396.615084622974, 15473.613159671098, 16154.192290385668, 16734.66530669404, 14471.710565788415, 14727.705445891237, 15167.924160379127, 15347.539573812803, 15684.607884802972, 13887.0, 14662.486812961495, 14820.0, 15095.24523773785, 15928.840711592737, 11947.940260298643, 12215.877841221474, 12382.442790074649, 12565.057620678668, 12723.55467558631, 12129.939350303192, 12250.75498490043, 12477.801943452365, 12491.37543122822, 12599.685007874876], "value": 8261.175343500796, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1508.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 105.0, 111.0, 111.0, 112.0, 112.0, 110.0, 112.0, 110.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 116.0, 146.0, 170.0, 120.0, 142.0, 150.0, 118.0, 186.0, 117.0], "value": 140.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 165.0, 166.0, 161.0, 160.0, 162.0, 174.0, 162.0, 161.0, 163.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 184.0, 75.0, 75.0, 75.0, 76.0, 174.0, 76.0], "value": 95.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 88.0, 154.0, 83.0, 84.0, 84.0, 133.0, 82.0, 84.0, 153.0], "value": 103.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 119.0, 118.0, 119.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 148.0, 148.0, 147.0, 147.0, 148.0, 148.0, 147.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 52.0, 51.0, 51.0, 55.0, 56.0, 53.0, 51.0, 50.0, 56.0], "value": 53.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 60.0, 60.0, 60.0, 60.0, 60.0, 61.0, 64.0, 60.0], "value": 60.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 74.0, 80.0, 72.0, 74.0, 73.0, 73.0, 74.0, 78.0, 73.0], "value": 74.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 127.0, 134.0, 117.0, 130.0, 131.0, 126.0, 120.0, 162.0, 129.0], "value": 130.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 155.0, 154.0, 155.0, 150.0, 153.0, 151.0, 151.0, 152.0, 155.0], "value": 153.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 61.0, 64.0, 61.0, 63.0, 63.0, 63.0, 62.0, 61.0, 65.0], "value": 63.0, "unit": "score"}]}]} 14:12:34 INFO - Return code: 0 14:12:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:12:34 ERROR - # TBPL SUCCESS # 14:12:34 INFO - Running post-action listener: _resource_record_post_action 14:12:34 INFO - [mozharness: 2016-11-01 21:12:34.205832Z] Finished run-tests step (success) 14:12:34 INFO - Running post-run listener: _resource_record_post_run 14:12:34 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 1736704; Write bytes: 285749248; Read time: 272; Write time: 561864 14:12:34 INFO - TinderboxPrint: CPU usage
13.3% 14:12:34 INFO - TinderboxPrint: I/O read bytes / time
1,736,704 / 272 14:12:34 INFO - TinderboxPrint: I/O write bytes / time
285,749,248 / 561,864 14:12:34 INFO - TinderboxPrint: CPU idle
8,214.2 (86.7%) 14:12:34 INFO - TinderboxPrint: CPU user
1,200.3 (12.7%) 14:12:34 INFO - TinderboxPrint: Swap in / out
0 / 0 14:12:34 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 71458816; Read time: 0; Write time: 235208 14:12:34 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 214290432; Read time: 16; Write time: 326656 14:12:34 INFO - Running post-run listener: _upload_blobber_files 14:12:34 INFO - Blob upload gear active. 14:12:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:12:34 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 14:12:34 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'] 14:12:34 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 14:12:35 INFO - (blobuploader) - INFO - Open directory for files ... 14:12:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:12:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:12:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:12:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:12:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:12:39 INFO - (blobuploader) - INFO - Done attempting. 14:12:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:12:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:12:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:12:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:12:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:12:40 INFO - (blobuploader) - INFO - Done attempting. 14:12:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:12:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:12:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:12:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:12:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:12:41 INFO - (blobuploader) - INFO - Done attempting. 14:12:41 INFO - (blobuploader) - INFO - Iteration through files over. 14:12:41 INFO - Return code: 0 14:12:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:12:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:12:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/441df8008c4c7ce614bb43fe1aa80133fae18dc7d7edf8cbde7ca045b3abe02a548d1febc1c9be5fd3b7ef519754717af6d88c4f651e7f11c170af7fb6d48e97", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a0700b2893550170e2bc711113d445532181642a704b4cd8f53a9525e724b7226c041b409c6be7c49fc53ba8fa84f21ac0765b354f987b91efa94db20deeb573", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3db15c19b683b87c7f5716f3701b5972a0afe94b801547798c61d03a434c2d989c65a69994ff9ca2d8f6a9a88b6f41b6bd60309f90ee9ea4f166f726be2eb32d"} 14:12:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:12:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:12:41 INFO - Contents: 14:12:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/441df8008c4c7ce614bb43fe1aa80133fae18dc7d7edf8cbde7ca045b3abe02a548d1febc1c9be5fd3b7ef519754717af6d88c4f651e7f11c170af7fb6d48e97", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a0700b2893550170e2bc711113d445532181642a704b4cd8f53a9525e724b7226c041b409c6be7c49fc53ba8fa84f21ac0765b354f987b91efa94db20deeb573", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3db15c19b683b87c7f5716f3701b5972a0afe94b801547798c61d03a434c2d989c65a69994ff9ca2d8f6a9a88b6f41b6bd60309f90ee9ea4f166f726be2eb32d"} 14:12:41 INFO - Running post-run listener: copy_logs_to_upload_dir 14:12:41 INFO - Copying logs to upload dir... 14:12:41 INFO - mkdir: /builds/slave/test/build/upload/logs 14:12:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1676.758309 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 56 secs) (at 2016-11-01 14:12:41.420996) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-01 14:12:41.424962) ========= 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=745a4373a2a16df560f216e000000264-1478033082.411915-1410601440 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/441df8008c4c7ce614bb43fe1aa80133fae18dc7d7edf8cbde7ca045b3abe02a548d1febc1c9be5fd3b7ef519754717af6d88c4f651e7f11c170af7fb6d48e97", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a0700b2893550170e2bc711113d445532181642a704b4cd8f53a9525e724b7226c041b409c6be7c49fc53ba8fa84f21ac0765b354f987b91efa94db20deeb573", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3db15c19b683b87c7f5716f3701b5972a0afe94b801547798c61d03a434c2d989c65a69994ff9ca2d8f6a9a88b6f41b6bd60309f90ee9ea4f166f726be2eb32d"} build_url:https://queue.taskcluster.net/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011186 build_url: 'https://queue.taskcluster.net/v1/task/VYM0MSPiTEa4xyVYgNC4Wg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/441df8008c4c7ce614bb43fe1aa80133fae18dc7d7edf8cbde7ca045b3abe02a548d1febc1c9be5fd3b7ef519754717af6d88c4f651e7f11c170af7fb6d48e97", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a0700b2893550170e2bc711113d445532181642a704b4cd8f53a9525e724b7226c041b409c6be7c49fc53ba8fa84f21ac0765b354f987b91efa94db20deeb573", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3db15c19b683b87c7f5716f3701b5972a0afe94b801547798c61d03a434c2d989c65a69994ff9ca2d8f6a9a88b6f41b6bd60309f90ee9ea4f166f726be2eb32d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-01 14:12:41.451873) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-01 14:12:41.452538) ========= 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=745a4373a2a16df560f216e000000264-1478033082.411915-1410601440 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004574 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-01 14:12:41.536143) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-01 14:12:41.536561) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-01 14:12:41.537021) ========= ========= Total master_lag: 0.18 =========