builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-018 starttime: 1476439864.45 results: success (0) buildid: 20161014000335 builduid: fd28a5b452bc440383227e9acfec6c7d revision: c216304c306bda09e8b8766f692885fa378ddb3c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 03:11:04.446085) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 03:11:04.446694) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 03:11:04.446980) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 03:11:04.462185) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 03:11:04.462579) ========= 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=62c568580acbfdaac3eec7be000001dc-1476439863.868837-1407430733 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-14 03:11:04-- 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% 224M=0s 2016-10-14 03:11:04 (224 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.115818 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 03:11:04.592537) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 03:11:04.592895) ========= 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=62c568580acbfdaac3eec7be000001dc-1476439863.868837-1407430733 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016884 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 03:11:04.642667) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-14 03:11:04.643028) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev c216304c306bda09e8b8766f692885fa378ddb3c --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 c216304c306bda09e8b8766f692885fa378ddb3c --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=62c568580acbfdaac3eec7be000001dc-1476439863.868837-1407430733 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-14 03:11:04,765 truncating revision to first 12 chars 2016-10-14 03:11:04,765 Setting DEBUG logging. 2016-10-14 03:11:04,765 attempt 1/10 2016-10-14 03:11:04,765 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/c216304c306b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-14 03:11:05,735 unpacking tar archive at: mozilla-beta-c216304c306b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.740106 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-14 03:11:06.396668) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 03:11:06.397009) ========= script_repo_revision: c216304c306bda09e8b8766f692885fa378ddb3c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 03:11:06.397409) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 03:11:06.397728) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 03:11:06.406342) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 51 secs) (at 2016-10-14 03:11:06.406752) ========= /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=62c568580acbfdaac3eec7be000001dc-1476439863.868837-1407430733 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:11:06 INFO - MultiFileLogger online at 20161014 03:11:06 in /builds/slave/test 03:11:06 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 03:11:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:11:06 INFO - {'append_to_log': False, 03:11:06 INFO - 'base_work_dir': '/builds/slave/test', 03:11:06 INFO - 'blob_upload_branch': 'Mozilla-Beta', 03:11:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:11:06 INFO - 'branch': 'Mozilla-Beta', 03:11:06 INFO - 'buildbot_json_path': 'buildprops.json', 03:11:06 INFO - 'config_files': ('talos/linux_config.py',), 03:11:06 INFO - 'default_actions': ('clobber', 03:11:06 INFO - 'read-buildbot-config', 03:11:06 INFO - 'download-and-extract', 03:11:06 INFO - 'populate-webroot', 03:11:06 INFO - 'create-virtualenv', 03:11:06 INFO - 'install', 03:11:06 INFO - 'run-tests'), 03:11:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:11:06 INFO - 'download_minidump_stackwalk': True, 03:11:06 INFO - 'download_symbols': 'ondemand', 03:11:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:11:06 INFO - 'tooltool.py': '/tools/tooltool.py', 03:11:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:11:06 INFO - '/tools/misc-python/virtualenv.py')}, 03:11:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:11:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:11:06 INFO - 'installer_path': 'installer.exe', 03:11:06 INFO - 'log_level': 'info', 03:11:06 INFO - 'log_name': 'talos', 03:11:06 INFO - 'log_to_console': True, 03:11:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:11:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:11:06 INFO - 'opt_config_files': (), 03:11:06 INFO - 'pip_index': False, 03:11:06 INFO - 'sps_profile': False, 03:11:06 INFO - 'sps_profile_interval': 0, 03:11:06 INFO - 'suite': 'dromaeojs-e10s', 03:11:06 INFO - 'system_bits': '32', 03:11:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:11:06 INFO - 'title': 'talos-linux64-ix-018', 03:11:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:11:06 INFO - 'use_talos_json': True, 03:11:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:11:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:11:06 INFO - 'work_dir': 'build'} 03:11:06 INFO - [mozharness: 2016-10-14 10:11:06.620133Z] Running clobber step. 03:11:06 INFO - Running pre-action listener: _resource_record_pre_action 03:11:06 INFO - Running main action method: clobber 03:11:06 INFO - rmtree: /builds/slave/test/build 03:11:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:11:07 INFO - Running post-action listener: _resource_record_post_action 03:11:07 INFO - [mozharness: 2016-10-14 10:11:07.599683Z] Finished clobber step (success) 03:11:07 INFO - [mozharness: 2016-10-14 10:11:07.599784Z] Running read-buildbot-config step. 03:11:07 INFO - Running pre-action listener: _resource_record_pre_action 03:11:07 INFO - Running main action method: read_buildbot_config 03:11:07 INFO - Using buildbot properties: 03:11:07 INFO - { 03:11:07 INFO - "project": "", 03:11:07 INFO - "product": "firefox", 03:11:07 INFO - "script_repo_revision": "production", 03:11:07 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 03:11:07 INFO - "repository": "", 03:11:07 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 03:11:07 INFO - "buildid": "20161014000335", 03:11:07 INFO - "pgo_build": "True", 03:11:07 INFO - "basedir": "/builds/slave/test", 03:11:07 INFO - "buildnumber": 159, 03:11:07 INFO - "slavename": "talos-linux64-ix-018", 03:11:07 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:11:07 INFO - "platform": "ubuntu64_hw", 03:11:07 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 03:11:07 INFO - "branch": "mozilla-beta", 03:11:07 INFO - "repo_path": "releases/mozilla-beta", 03:11:07 INFO - "revision": "c216304c306bda09e8b8766f692885fa378ddb3c", 03:11:07 INFO - "stage_platform": "linux64-pgo", 03:11:07 INFO - "builduid": "fd28a5b452bc440383227e9acfec6c7d", 03:11:07 INFO - "slavebuilddir": "test" 03:11:07 INFO - } 03:11:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2. 03:11:07 INFO - Running post-action listener: _resource_record_post_action 03:11:07 INFO - [mozharness: 2016-10-14 10:11:07.602235Z] Finished read-buildbot-config step (success) 03:11:07 INFO - [mozharness: 2016-10-14 10:11:07.602325Z] Running download-and-extract step. 03:11:07 INFO - Running pre-action listener: _resource_record_pre_action 03:11:07 INFO - Running main action method: download_and_extract 03:11:07 INFO - mkdir: /builds/slave/test/build/tests 03:11:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:07 INFO - https://queue.taskcluster.net/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:11:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 03:11:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 03:11:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/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 03:11:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/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 03:11:07 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 03:11:07 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:11:07 INFO - retry: Failed, sleeping 30 seconds before retrying 03:11:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/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 03:11:37 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 03:11:37 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:11:37 INFO - retry: Failed, sleeping 60 seconds before retrying 03:12:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/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 03:12:37 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 03:12:37 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:12:37 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/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! 03:12:37 INFO - Caught exception: HTTP Error 404: Not Found 03:12:37 INFO - Caught exception: HTTP Error 404: Not Found 03:12:37 INFO - Caught exception: HTTP Error 404: Not Found 03:12:37 INFO - trying https://queue.taskcluster.net/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 03:12:37 INFO - Downloading https://queue.taskcluster.net/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/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 03:12:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/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 03:12:38 INFO - Downloaded 1327 bytes. 03:12:38 INFO - Reading from file /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 03:12:38 INFO - Using the following test package requirements: 03:12:38 INFO - {u'common': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 03:12:38 INFO - u'cppunittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 03:12:38 INFO - u'firefox-50.0.en-US.linux-x86_64.cppunittest.tests.zip'], 03:12:38 INFO - u'gtest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 03:12:38 INFO - u'firefox-50.0.en-US.linux-x86_64.gtest.tests.zip'], 03:12:38 INFO - u'jittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 03:12:38 INFO - u'jsshell-linux-x86_64.zip'], 03:12:38 INFO - u'mochitest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 03:12:38 INFO - u'firefox-50.0.en-US.linux-x86_64.mochitest.tests.zip'], 03:12:38 INFO - u'mozbase': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 03:12:38 INFO - u'reftest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 03:12:38 INFO - u'firefox-50.0.en-US.linux-x86_64.reftest.tests.zip'], 03:12:38 INFO - u'talos': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 03:12:38 INFO - u'firefox-50.0.en-US.linux-x86_64.talos.tests.zip'], 03:12:38 INFO - u'web-platform': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 03:12:38 INFO - u'firefox-50.0.en-US.linux-x86_64.web-platform.tests.zip'], 03:12:38 INFO - u'xpcshell': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 03:12:38 INFO - u'firefox-50.0.en-US.linux-x86_64.xpcshell.tests.zip']} 03:12:38 INFO - Downloading packages: [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:12: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')]} 03:12:38 INFO - https://queue.taskcluster.net/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:12:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 03:12:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 03:12:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/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 03:12:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/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 03:12:38 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 03:12:38 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:12:38 INFO - retry: Failed, sleeping 30 seconds before retrying 03:13:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/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 03:13:08 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 03:13:08 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:13:08 INFO - retry: Failed, sleeping 60 seconds before retrying 03:14:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/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 03:14:08 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 03:14:08 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:14:08 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/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! 03:14:08 INFO - Caught exception: HTTP Error 404: Not Found 03:14:08 INFO - Caught exception: HTTP Error 404: Not Found 03:14:08 INFO - Caught exception: HTTP Error 404: Not Found 03:14:08 INFO - trying https://queue.taskcluster.net/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 03:14:08 INFO - Downloading https://queue.taskcluster.net/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/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 03:14:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/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 03:14:09 INFO - Downloaded 21773897 bytes. 03:14:09 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'] 03:14:09 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 03:14:10 INFO - Return code: 0 03:14:10 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 03:14:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:14:10 INFO - https://queue.taskcluster.net/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:14:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 03:14:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 03:14:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/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 03:14:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/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 03:14:10 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 03:14:10 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:14:10 INFO - retry: Failed, sleeping 30 seconds before retrying 03:14:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/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 03:14:40 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 03:14:40 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:14:40 INFO - retry: Failed, sleeping 60 seconds before retrying 03:15:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/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 03:15:40 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 03:15:40 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:15:40 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/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! 03:15:40 INFO - Caught exception: HTTP Error 404: Not Found 03:15:40 INFO - Caught exception: HTTP Error 404: Not Found 03:15:40 INFO - Caught exception: HTTP Error 404: Not Found 03:15:40 INFO - trying https://queue.taskcluster.net/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 03:15:40 INFO - Downloading https://queue.taskcluster.net/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/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 03:15:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/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 03:15:41 INFO - Downloaded 21773897 bytes. 03:15:41 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'] 03:15:41 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 03:15:42 INFO - Return code: 0 03:15:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:15:42 INFO - https://queue.taskcluster.net/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:15:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 03:15:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 03:15:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/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 03:15:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/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 03:15:42 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 03:15:42 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:15:42 INFO - retry: Failed, sleeping 30 seconds before retrying 03:16:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/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 03:16:12 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 03:16:12 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:16:12 INFO - retry: Failed, sleeping 60 seconds before retrying 03:17:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/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 03:17:12 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 03:17:12 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:17:12 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/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! 03:17:12 INFO - Caught exception: HTTP Error 404: Not Found 03:17:12 INFO - Caught exception: HTTP Error 404: Not Found 03:17:12 INFO - Caught exception: HTTP Error 404: Not Found 03:17:12 INFO - trying https://queue.taskcluster.net/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 03:17:12 INFO - Downloading https://queue.taskcluster.net/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/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 03:17:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/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 03:17:13 INFO - Downloaded 14413740 bytes. 03:17:13 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'] 03:17:13 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 03:17:13 INFO - Return code: 0 03:17:13 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')]} 03:17:13 INFO - https://queue.taskcluster.net/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:17:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 03:17:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 03:17:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/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 03:17:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/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 03:17:13 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 03:17:13 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:17:13 INFO - retry: Failed, sleeping 30 seconds before retrying 03:17:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/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 03:17:43 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 03:17:43 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:17:43 INFO - retry: Failed, sleeping 60 seconds before retrying 03:18:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/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 03:18:43 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 03:18:43 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:18:43 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/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! 03:18:43 INFO - Caught exception: HTTP Error 404: Not Found 03:18:43 INFO - Caught exception: HTTP Error 404: Not Found 03:18:43 INFO - Caught exception: HTTP Error 404: Not Found 03:18:43 INFO - trying https://queue.taskcluster.net/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 03:18:43 INFO - Downloading https://queue.taskcluster.net/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/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 03:18:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/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 03:18:45 INFO - Downloaded 56783359 bytes. 03:18:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 03:18:45 INFO - mkdir: /builds/slave/test/properties 03:18:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:18:45 INFO - Writing to file /builds/slave/test/properties/build_url 03:18:45 INFO - Contents: 03:18:45 INFO - build_url:https://queue.taskcluster.net/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 03:18:45 INFO - Running post-action listener: _resource_record_post_action 03:18:45 INFO - Running post-action listener: set_extra_try_arguments 03:18:45 INFO - [mozharness: 2016-10-14 10:18:45.835145Z] Finished download-and-extract step (success) 03:18:45 INFO - [mozharness: 2016-10-14 10:18:45.835379Z] Running populate-webroot step. 03:18:45 INFO - Running pre-action listener: _resource_record_pre_action 03:18:45 INFO - Running main action method: populate_webroot 03:18:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:18:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:18:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:18:45 INFO - '--tppagecycles', 03:18:45 INFO - '7'], 03:18:45 INFO - 'tests': ['tsvgm']}}, 03:18:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:18:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:18:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:18:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:18:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:18:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:18:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:45 INFO - 'talos_options': ['--disable-e10s'], 03:18:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:18:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:18:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:45 INFO - 'talos_options': ['--disable-e10s'], 03:18:45 INFO - 'tests': ['damp', 'tps']}, 03:18:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:45 INFO - 'tests': ['damp', 'tps']}, 03:18:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:18:45 INFO - 'tests': ['dromaeo_dom']}, 03:18:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:18:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:18:45 INFO - 'tests': ['basic_compositor_video']}, 03:18:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:18:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:18:45 INFO - 'tests': ['a11yr', 03:18:45 INFO - 'ts_paint', 03:18:45 INFO - 'tpaint', 03:18:45 INFO - 'sessionrestore', 03:18:45 INFO - 'sessionrestore_no_auto_restore', 03:18:45 INFO - 'tabpaint']}, 03:18:45 INFO - 'other-e10s': {'tests': ['a11yr', 03:18:45 INFO - 'ts_paint', 03:18:45 INFO - 'tpaint', 03:18:45 INFO - 'sessionrestore', 03:18:45 INFO - 'sessionrestore_no_auto_restore', 03:18:45 INFO - 'tabpaint']}, 03:18:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:18:45 INFO - 'ts_paint', 03:18:45 INFO - 'tpaint', 03:18:45 INFO - 'sessionrestore', 03:18:45 INFO - 'sessionrestore_no_auto_restore', 03:18:45 INFO - 'tabpaint']}, 03:18:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:18:45 INFO - 'ts_paint', 03:18:45 INFO - 'tpaint', 03:18:45 INFO - 'sessionrestore', 03:18:45 INFO - 'sessionrestore_no_auto_restore', 03:18:45 INFO - 'tabpaint']}, 03:18:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:18:45 INFO - 'tests': ['a11yr', 03:18:45 INFO - 'ts_paint', 03:18:45 INFO - 'tpaint', 03:18:45 INFO - 'sessionrestore', 03:18:45 INFO - 'sessionrestore_no_auto_restore', 03:18:45 INFO - 'tabpaint']}, 03:18:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:18:45 INFO - 'tests': ['a11yr', 03:18:45 INFO - 'ts_paint', 03:18:45 INFO - 'tpaint', 03:18:45 INFO - 'sessionrestore', 03:18:45 INFO - 'sessionrestore_no_auto_restore', 03:18:45 INFO - 'tabpaint']}, 03:18:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:18:45 INFO - 'tests': ['tsvgx', 03:18:45 INFO - 'tsvgr_opacity', 03:18:45 INFO - 'tart', 03:18:45 INFO - 'tscrollx', 03:18:45 INFO - 'cart']}, 03:18:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:18:45 INFO - 'tsvgr_opacity', 03:18:45 INFO - 'tart', 03:18:45 INFO - 'tscrollx', 03:18:45 INFO - 'cart']}, 03:18:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:45 INFO - 'talos_options': ['--disable-e10s'], 03:18:45 INFO - 'tests': ['tp5o']}, 03:18:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:45 INFO - 'tests': ['tp5o']}, 03:18:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:45 INFO - 'talos_options': ['--disable-e10s', 03:18:45 INFO - '--xperf_path', 03:18:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:18:45 INFO - 'tests': ['tp5n']}, 03:18:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:45 INFO - 'talos_options': ['--xperf_path', 03:18:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:18:45 INFO - 'tests': ['tp5n']}}, 03:18:45 INFO - 'talos.zip': {'path': '', 03:18:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:18:45 INFO - Running post-action listener: _resource_record_post_action 03:18:45 INFO - [mozharness: 2016-10-14 10:18:45.855936Z] Finished populate-webroot step (success) 03:18:45 INFO - [mozharness: 2016-10-14 10:18:45.856026Z] Running create-virtualenv step. 03:18:45 INFO - Running pre-action listener: _resource_record_pre_action 03:18:45 INFO - Running main action method: create_virtualenv 03:18:45 INFO - Creating virtualenv /builds/slave/test/build/venv 03:18:45 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 03:18:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:18:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:18:45 INFO - Using real prefix '/usr' 03:18:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:18:46 INFO - Installing distribute.............................................................................................................................................................................................done. 03:18:48 INFO - Installing pip.................done. 03:18:48 INFO - Return code: 0 03:18:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:18: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')]} 03:18:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18: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')]} 03:18:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2019570>, '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 0x201a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x201a900>, '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': '62c568580acbfdaac3eec7be000001dc-1476439863.868837-1407430733', '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 03:18:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:18:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:18:48 INFO - Using env: {'DISPLAY': ':0', 03:18:48 INFO - 'HOME': '/home/cltbld', 03:18:48 INFO - 'LANG': 'en_US.UTF-8', 03:18:48 INFO - 'LANGUAGE': 'en_US:en', 03:18:48 INFO - 'LOGNAME': 'cltbld', 03:18:48 INFO - 'MAIL': '/var/mail/cltbld', 03:18:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:48 INFO - 'MOZ_NO_REMOTE': '1', 03:18:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:48 INFO - 'NO_EM_RESTART': '1', 03:18:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:48 INFO - 'PWD': '/builds/slave/test', 03:18:48 INFO - 'SHELL': '/bin/bash', 03:18:48 INFO - 'SHLVL': '1', 03:18:48 INFO - 'TERM': 'linux', 03:18:48 INFO - 'TMOUT': '86400', 03:18:48 INFO - 'USER': 'cltbld', 03:18:48 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1476439863.868837-1407430733', 03:18:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:48 INFO - '_': '/tools/buildbot/bin/python'} 03:18:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:48 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 03:18:48 INFO - Cleaning up... 03:18:48 INFO - Return code: 0 03:18:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:18: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')]} 03:18:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18: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')]} 03:18:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1d5b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2019570>, '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 0x201a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x201a900>, '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': '62c568580acbfdaac3eec7be000001dc-1476439863.868837-1407430733', '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 03:18:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:18:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:18:48 INFO - Using env: {'DISPLAY': ':0', 03:18:48 INFO - 'HOME': '/home/cltbld', 03:18:48 INFO - 'LANG': 'en_US.UTF-8', 03:18:48 INFO - 'LANGUAGE': 'en_US:en', 03:18:48 INFO - 'LOGNAME': 'cltbld', 03:18:48 INFO - 'MAIL': '/var/mail/cltbld', 03:18:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:48 INFO - 'MOZ_NO_REMOTE': '1', 03:18:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:48 INFO - 'NO_EM_RESTART': '1', 03:18:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:48 INFO - 'PWD': '/builds/slave/test', 03:18:48 INFO - 'SHELL': '/bin/bash', 03:18:48 INFO - 'SHLVL': '1', 03:18:48 INFO - 'TERM': 'linux', 03:18:48 INFO - 'TMOUT': '86400', 03:18:48 INFO - 'USER': 'cltbld', 03:18:48 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1476439863.868837-1407430733', 03:18:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:48 INFO - '_': '/tools/buildbot/bin/python'} 03:18:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:48 INFO - Downloading/unpacking psutil>=3.1.1 03:18:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:18:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:18:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:18:50 INFO - Installing collected packages: psutil 03:18:50 INFO - Running setup.py install for psutil 03:18:50 INFO - building 'psutil._psutil_linux' extension 03:18:50 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 03:18:51 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 03:18:51 INFO - building 'psutil._psutil_posix' extension 03:18:51 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 03:18:51 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 03:18:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:18:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:18:51 INFO - Successfully installed psutil 03:18:51 INFO - Cleaning up... 03:18:51 INFO - Return code: 0 03:18:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:18: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')]} 03:18:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18: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')]} 03:18:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:51 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 0x1d5b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2019570>, '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 0x201a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x201a900>, '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': '62c568580acbfdaac3eec7be000001dc-1476439863.868837-1407430733', '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 03:18:51 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 03:18:51 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 03:18:51 INFO - Using env: {'DISPLAY': ':0', 03:18:51 INFO - 'HOME': '/home/cltbld', 03:18:51 INFO - 'LANG': 'en_US.UTF-8', 03:18:51 INFO - 'LANGUAGE': 'en_US:en', 03:18:51 INFO - 'LOGNAME': 'cltbld', 03:18:51 INFO - 'MAIL': '/var/mail/cltbld', 03:18:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:51 INFO - 'MOZ_NO_REMOTE': '1', 03:18:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:51 INFO - 'NO_EM_RESTART': '1', 03:18:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:51 INFO - 'PWD': '/builds/slave/test', 03:18:51 INFO - 'SHELL': '/bin/bash', 03:18:51 INFO - 'SHLVL': '1', 03:18:51 INFO - 'TERM': 'linux', 03:18:51 INFO - 'TMOUT': '86400', 03:18:51 INFO - 'USER': 'cltbld', 03:18:51 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1476439863.868837-1407430733', 03:18:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:51 INFO - '_': '/tools/buildbot/bin/python'} 03:18:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:18:51 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 03:18:51 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 03:18:51 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 03:18:51 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 03:18:51 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 03:18:51 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 03:18:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:18:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:18:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:18:53 INFO - Installing collected packages: mozsystemmonitor 03:18:53 INFO - Running setup.py install for mozsystemmonitor 03:18:53 INFO - Successfully installed mozsystemmonitor 03:18:53 INFO - Cleaning up... 03:18:53 INFO - Return code: 0 03:18:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:18:53 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')]} 03:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:53 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')]} 03:18:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:53 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 0x1d5b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2019570>, '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 0x201a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x201a900>, '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': '62c568580acbfdaac3eec7be000001dc-1476439863.868837-1407430733', '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 03:18:53 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 03:18:53 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 03:18:53 INFO - Using env: {'DISPLAY': ':0', 03:18:53 INFO - 'HOME': '/home/cltbld', 03:18:53 INFO - 'LANG': 'en_US.UTF-8', 03:18:53 INFO - 'LANGUAGE': 'en_US:en', 03:18:53 INFO - 'LOGNAME': 'cltbld', 03:18:53 INFO - 'MAIL': '/var/mail/cltbld', 03:18:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:53 INFO - 'MOZ_NO_REMOTE': '1', 03:18:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:53 INFO - 'NO_EM_RESTART': '1', 03:18:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:53 INFO - 'PWD': '/builds/slave/test', 03:18:53 INFO - 'SHELL': '/bin/bash', 03:18:53 INFO - 'SHLVL': '1', 03:18:53 INFO - 'TERM': 'linux', 03:18:53 INFO - 'TMOUT': '86400', 03:18:53 INFO - 'USER': 'cltbld', 03:18:53 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1476439863.868837-1407430733', 03:18:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:53 INFO - '_': '/tools/buildbot/bin/python'} 03:18:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:53 INFO - Downloading/unpacking jsonschema==2.5.1 03:18:53 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 03:18:53 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 03:18:53 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 03:18:53 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 03:18:53 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 03:18:53 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 03:18:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:18:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:18:55 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 03:18:55 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 03:18:55 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 03:18:55 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 03:18:55 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 03:18:55 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 03:18:56 INFO - Downloading functools32-3.2.3-2.tar.gz 03:18:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:18:56 INFO - warning: no files found matching '*.txt' 03:18:56 INFO - no previously-included directories found matching 'build' 03:18:56 INFO - no previously-included directories found matching 'dist' 03:18:56 INFO - no previously-included directories found matching '.git*' 03:18:56 INFO - Installing collected packages: jsonschema, functools32 03:18:56 INFO - Running setup.py install for functools32 03:18:56 INFO - warning: no files found matching '*.txt' 03:18:56 INFO - no previously-included directories found matching 'build' 03:18:56 INFO - no previously-included directories found matching 'dist' 03:18:56 INFO - no previously-included directories found matching '.git*' 03:18:56 INFO - Successfully installed jsonschema functools32 03:18:56 INFO - Cleaning up... 03:18:56 INFO - Return code: 0 03:18:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:18:56 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')]} 03:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:56 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')]} 03:18:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:56 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 0x1d5b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2019570>, '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 0x201a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x201a900>, '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': '62c568580acbfdaac3eec7be000001dc-1476439863.868837-1407430733', '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 03:18:56 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 03:18:56 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 03:18:56 INFO - Using env: {'DISPLAY': ':0', 03:18:56 INFO - 'HOME': '/home/cltbld', 03:18:56 INFO - 'LANG': 'en_US.UTF-8', 03:18:56 INFO - 'LANGUAGE': 'en_US:en', 03:18:56 INFO - 'LOGNAME': 'cltbld', 03:18:56 INFO - 'MAIL': '/var/mail/cltbld', 03:18:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:56 INFO - 'MOZ_NO_REMOTE': '1', 03:18:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:56 INFO - 'NO_EM_RESTART': '1', 03:18:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:56 INFO - 'PWD': '/builds/slave/test', 03:18:56 INFO - 'SHELL': '/bin/bash', 03:18:56 INFO - 'SHLVL': '1', 03:18:56 INFO - 'TERM': 'linux', 03:18:56 INFO - 'TMOUT': '86400', 03:18:56 INFO - 'USER': 'cltbld', 03:18:56 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1476439863.868837-1407430733', 03:18:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:56 INFO - '_': '/tools/buildbot/bin/python'} 03:18:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:18:56 INFO - Cleaning up... 03:18:56 INFO - Return code: 0 03:18:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:18:56 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')]} 03:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:56 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')]} 03:18:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:56 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 0x1d5b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2019570>, '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 0x201a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x201a900>, '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': '62c568580acbfdaac3eec7be000001dc-1476439863.868837-1407430733', '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 03:18:56 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 03:18:56 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 03:18:56 INFO - Using env: {'DISPLAY': ':0', 03:18:56 INFO - 'HOME': '/home/cltbld', 03:18:56 INFO - 'LANG': 'en_US.UTF-8', 03:18:56 INFO - 'LANGUAGE': 'en_US:en', 03:18:56 INFO - 'LOGNAME': 'cltbld', 03:18:56 INFO - 'MAIL': '/var/mail/cltbld', 03:18:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:56 INFO - 'MOZ_NO_REMOTE': '1', 03:18:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:56 INFO - 'NO_EM_RESTART': '1', 03:18:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:56 INFO - 'PWD': '/builds/slave/test', 03:18:56 INFO - 'SHELL': '/bin/bash', 03:18:56 INFO - 'SHLVL': '1', 03:18:56 INFO - 'TERM': 'linux', 03:18:56 INFO - 'TMOUT': '86400', 03:18:56 INFO - 'USER': 'cltbld', 03:18:56 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1476439863.868837-1407430733', 03:18:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:56 INFO - '_': '/tools/buildbot/bin/python'} 03:18:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:56 INFO - Downloading/unpacking blobuploader==1.2.4 03:18:56 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 03:18:56 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 03:18:56 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 03:18:56 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 03:18:56 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 03:18:56 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 03:18:58 INFO - Downloading blobuploader-1.2.4.tar.gz 03:18:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:18:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:18:58 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 03:18:58 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 03:18:58 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 03:18:58 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 03:18:58 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 03:18:58 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 03:18:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:18:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:18:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:59 INFO - Downloading docopt-0.6.1.tar.gz 03:18:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:18:59 INFO - Installing collected packages: blobuploader, requests, docopt 03:18:59 INFO - Running setup.py install for blobuploader 03:18:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:18:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:18:59 INFO - Running setup.py install for requests 03:18:59 INFO - Running setup.py install for docopt 03:18:59 INFO - Successfully installed blobuploader requests docopt 03:18:59 INFO - Cleaning up... 03:19:00 INFO - Return code: 0 03:19:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:19: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')]} 03:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19: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')]} 03:19:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:00 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 0x1d5b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2019570>, '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 0x201a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x201a900>, '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': '62c568580acbfdaac3eec7be000001dc-1476439863.868837-1407430733', '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 03:19:00 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 03:19:00 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 03:19:00 INFO - Using env: {'DISPLAY': ':0', 03:19:00 INFO - 'HOME': '/home/cltbld', 03:19:00 INFO - 'LANG': 'en_US.UTF-8', 03:19:00 INFO - 'LANGUAGE': 'en_US:en', 03:19:00 INFO - 'LOGNAME': 'cltbld', 03:19:00 INFO - 'MAIL': '/var/mail/cltbld', 03:19:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:00 INFO - 'MOZ_NO_REMOTE': '1', 03:19:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:00 INFO - 'NO_EM_RESTART': '1', 03:19:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:00 INFO - 'PWD': '/builds/slave/test', 03:19:00 INFO - 'SHELL': '/bin/bash', 03:19:00 INFO - 'SHLVL': '1', 03:19:00 INFO - 'TERM': 'linux', 03:19:00 INFO - 'TMOUT': '86400', 03:19:00 INFO - 'USER': 'cltbld', 03:19:00 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1476439863.868837-1407430733', 03:19:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:00 INFO - '_': '/tools/buildbot/bin/python'} 03:19:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:19:00 INFO - Running setup.py (path:/tmp/pip-kVaKKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:19:00 INFO - Running setup.py (path:/tmp/pip-gi2Bmm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:19:00 INFO - Running setup.py (path:/tmp/pip-hXEAMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:19:00 INFO - Running setup.py (path:/tmp/pip-s9jvRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:19:00 INFO - Running setup.py (path:/tmp/pip-27YA4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:19:00 INFO - Running setup.py (path:/tmp/pip-j02Mki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:19:00 INFO - Running setup.py (path:/tmp/pip-SwOJsc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:19:00 INFO - Running setup.py (path:/tmp/pip-mTbK_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:19:00 INFO - Running setup.py (path:/tmp/pip-nNMTTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:19:00 INFO - Running setup.py (path:/tmp/pip-8dVftz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:19:00 INFO - Running setup.py (path:/tmp/pip-XZDTXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:19:01 INFO - Running setup.py (path:/tmp/pip-XCozlq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:19:01 INFO - Running setup.py (path:/tmp/pip-d_uzuN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:19:01 INFO - Running setup.py (path:/tmp/pip-bnRtDd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:19:01 INFO - Running setup.py (path:/tmp/pip-WdwxZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:19:01 INFO - Running setup.py (path:/tmp/pip-Rhs3bL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:19:01 INFO - Running setup.py (path:/tmp/pip-5zSXDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:19:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:19:01 INFO - Running setup.py install for manifestparser 03:19:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:19:01 INFO - Running setup.py install for mozcrash 03:19:01 INFO - Running setup.py install for mozdebug 03:19:01 INFO - Running setup.py install for mozdevice 03:19:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:19:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:19:01 INFO - Running setup.py install for mozfile 03:19:02 INFO - Running setup.py install for mozhttpd 03:19:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:19:02 INFO - Running setup.py install for mozinfo 03:19:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:19:02 INFO - Running setup.py install for mozInstall 03:19:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:19:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:19:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:19:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:19:02 INFO - Running setup.py install for mozleak 03:19:02 INFO - Running setup.py install for mozlog 03:19:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:19:02 INFO - Running setup.py install for moznetwork 03:19:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:19:02 INFO - Running setup.py install for mozprocess 03:19:02 INFO - Running setup.py install for mozprofile 03:19:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:19:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:19:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:19:02 INFO - Running setup.py install for mozrunner 03:19:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:19:02 INFO - Running setup.py install for mozscreenshot 03:19:03 INFO - Running setup.py install for moztest 03:19:03 INFO - Running setup.py install for mozversion 03:19:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:19:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:19:03 INFO - Cleaning up... 03:19:03 INFO - Return code: 0 03:19:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:19:03 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')]} 03:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:03 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')]} 03:19:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:03 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 0x1d5b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2019570>, '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 0x201a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x201a900>, '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': '62c568580acbfdaac3eec7be000001dc-1476439863.868837-1407430733', '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 03:19:03 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 03:19:03 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 03:19:03 INFO - Using env: {'DISPLAY': ':0', 03:19:03 INFO - 'HOME': '/home/cltbld', 03:19:03 INFO - 'LANG': 'en_US.UTF-8', 03:19:03 INFO - 'LANGUAGE': 'en_US:en', 03:19:03 INFO - 'LOGNAME': 'cltbld', 03:19:03 INFO - 'MAIL': '/var/mail/cltbld', 03:19:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:03 INFO - 'MOZ_NO_REMOTE': '1', 03:19:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:03 INFO - 'NO_EM_RESTART': '1', 03:19:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:03 INFO - 'PWD': '/builds/slave/test', 03:19:03 INFO - 'SHELL': '/bin/bash', 03:19:03 INFO - 'SHLVL': '1', 03:19:03 INFO - 'TERM': 'linux', 03:19:03 INFO - 'TMOUT': '86400', 03:19:03 INFO - 'USER': 'cltbld', 03:19:03 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1476439863.868837-1407430733', 03:19:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:03 INFO - '_': '/tools/buildbot/bin/python'} 03:19:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:19:03 INFO - Running setup.py (path:/tmp/pip-zFkB7S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:19:03 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)) 03:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:19:03 INFO - Running setup.py (path:/tmp/pip-uPDmBb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:19:03 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)) 03:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:19:03 INFO - Running setup.py (path:/tmp/pip-KEcKqF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:19:03 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)) 03:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:19:03 INFO - Running setup.py (path:/tmp/pip-ZXrT2w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:19:03 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)) 03:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:19:03 INFO - Running setup.py (path:/tmp/pip-cqMx8f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:19:03 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)) 03:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:19:03 INFO - Running setup.py (path:/tmp/pip-uvQ4e6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:19:03 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)) 03:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:19:03 INFO - Running setup.py (path:/tmp/pip-oFVS2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:19:04 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)) 03:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:19:04 INFO - Running setup.py (path:/tmp/pip-R9j5Ym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:19:04 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)) 03:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:19:04 INFO - Running setup.py (path:/tmp/pip-cwbIBl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:19:04 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)) 03:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:19:04 INFO - Running setup.py (path:/tmp/pip-15_Sxt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:19:04 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)) 03:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:19:04 INFO - Running setup.py (path:/tmp/pip-V8gx3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:19:04 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)) 03:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:19:04 INFO - Running setup.py (path:/tmp/pip-9FsUOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:19:04 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)) 03:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:19:04 INFO - Running setup.py (path:/tmp/pip-_mGZ2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:19:04 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)) 03:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:19:04 INFO - Running setup.py (path:/tmp/pip-aKWvwX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:19:04 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)) 03:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:19:04 INFO - Running setup.py (path:/tmp/pip-Bb0RKh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:19:04 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)) 03:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:19:04 INFO - Running setup.py (path:/tmp/pip-wAj_6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:19:04 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)) 03:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:19:04 INFO - Running setup.py (path:/tmp/pip-99x1ST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:19:04 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)) 03:19:04 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)) 03:19:04 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)) 03:19:04 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)) 03:19:04 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)) 03:19:04 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)) 03:19:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:19:04 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 03:19:04 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 03:19:04 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 03:19:04 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 03:19:04 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 03:19:04 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 03:19:06 INFO - Downloading blessings-1.6.tar.gz 03:19:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:19:06 INFO - Installing collected packages: blessings 03:19:06 INFO - Running setup.py install for blessings 03:19:06 INFO - Successfully installed blessings 03:19:06 INFO - Cleaning up... 03:19:06 INFO - Return code: 0 03:19:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:19:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:19:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:19:07 INFO - Reading from file tmpfile_stdout 03:19:07 INFO - Current package versions: 03:19:07 INFO - argparse == 1.2.1 03:19:07 INFO - blessings == 1.6 03:19:07 INFO - blobuploader == 1.2.4 03:19:07 INFO - docopt == 0.6.1 03:19:07 INFO - functools32 == 3.2.3-2 03:19:07 INFO - jsonschema == 2.5.1 03:19:07 INFO - manifestparser == 1.1 03:19:07 INFO - mozInstall == 1.12 03:19:07 INFO - mozcrash == 0.17 03:19:07 INFO - mozdebug == 0.1 03:19:07 INFO - mozdevice == 0.48 03:19:07 INFO - mozfile == 1.2 03:19:07 INFO - mozhttpd == 0.7 03:19:07 INFO - mozinfo == 0.9 03:19:07 INFO - mozleak == 0.1 03:19:07 INFO - mozlog == 3.3 03:19:07 INFO - moznetwork == 0.27 03:19:07 INFO - mozprocess == 0.23 03:19:07 INFO - mozprofile == 0.28 03:19:07 INFO - mozrunner == 6.12 03:19:07 INFO - mozscreenshot == 0.1 03:19:07 INFO - mozsystemmonitor == 0.3 03:19:07 INFO - moztest == 0.7 03:19:07 INFO - mozversion == 1.4 03:19:07 INFO - psutil == 3.1.1 03:19:07 INFO - requests == 1.2.3 03:19:07 INFO - wsgiref == 0.1.2 03:19:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:19:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:19:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:07 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 0x1d5b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2019570>, '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 0x201a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x201a900>, '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': '62c568580acbfdaac3eec7be000001dc-1476439863.868837-1407430733', '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 03:19:07 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 03:19:07 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 03:19:07 INFO - Using env: {'DISPLAY': ':0', 03:19:07 INFO - 'HOME': '/home/cltbld', 03:19:07 INFO - 'LANG': 'en_US.UTF-8', 03:19:07 INFO - 'LANGUAGE': 'en_US:en', 03:19:07 INFO - 'LOGNAME': 'cltbld', 03:19:07 INFO - 'MAIL': '/var/mail/cltbld', 03:19:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:07 INFO - 'MOZ_NO_REMOTE': '1', 03:19:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:07 INFO - 'NO_EM_RESTART': '1', 03:19:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:07 INFO - 'PWD': '/builds/slave/test', 03:19:07 INFO - 'SHELL': '/bin/bash', 03:19:07 INFO - 'SHLVL': '1', 03:19:07 INFO - 'TERM': 'linux', 03:19:07 INFO - 'TMOUT': '86400', 03:19:07 INFO - 'USER': 'cltbld', 03:19:07 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1476439863.868837-1407430733', 03:19:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:07 INFO - '_': '/tools/buildbot/bin/python'} 03:19:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:07 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)) 03:19:07 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)) 03:19:07 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)) 03:19:07 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)) 03:19:07 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)) 03:19:07 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)) 03:19:07 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)) 03:19:07 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)) 03:19:07 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)) 03:19:07 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)) 03:19:07 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)) 03:19:07 INFO - Cleaning up... 03:19:07 INFO - Return code: 0 03:19:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:19:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:19:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:19:07 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 0x1d5b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2019570>, '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 0x201a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x201a900>, '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': '62c568580acbfdaac3eec7be000001dc-1476439863.868837-1407430733', '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 03:19:07 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 03:19:07 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 03:19:07 INFO - Using env: {'DISPLAY': ':0', 03:19:07 INFO - 'HOME': '/home/cltbld', 03:19:07 INFO - 'LANG': 'en_US.UTF-8', 03:19:07 INFO - 'LANGUAGE': 'en_US:en', 03:19:07 INFO - 'LOGNAME': 'cltbld', 03:19:07 INFO - 'MAIL': '/var/mail/cltbld', 03:19:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:07 INFO - 'MOZ_NO_REMOTE': '1', 03:19:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:07 INFO - 'NO_EM_RESTART': '1', 03:19:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:07 INFO - 'PWD': '/builds/slave/test', 03:19:07 INFO - 'SHELL': '/bin/bash', 03:19:07 INFO - 'SHLVL': '1', 03:19:07 INFO - 'TERM': 'linux', 03:19:07 INFO - 'TMOUT': '86400', 03:19:07 INFO - 'USER': 'cltbld', 03:19:07 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1476439863.868837-1407430733', 03:19:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:07 INFO - '_': '/tools/buildbot/bin/python'} 03:19:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:19:07 INFO - Cleaning up... 03:19:07 INFO - Return code: 0 03:19:07 INFO - Running post-action listener: _resource_record_post_action 03:19:07 INFO - Running post-action listener: _start_resource_monitoring 03:19:07 INFO - Starting resource monitoring. 03:19:07 INFO - [mozharness: 2016-10-14 10:19:07.616747Z] Finished create-virtualenv step (success) 03:19:07 INFO - [mozharness: 2016-10-14 10:19:07.617175Z] Running install step. 03:19:07 INFO - Running pre-action listener: _resource_record_pre_action 03:19:07 INFO - Running main action method: install 03:19:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:19:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:19:07 INFO - Reading from file tmpfile_stdout 03:19:07 INFO - Detecting whether we're running mozinstall >=1.0... 03:19:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:19:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:19:07 INFO - Reading from file tmpfile_stdout 03:19:07 INFO - Output received: 03:19:07 INFO - Usage: mozinstall [options] installer 03:19:07 INFO - Options: 03:19:07 INFO - -h, --help show this help message and exit 03:19:07 INFO - -d DEST, --destination=DEST 03:19:07 INFO - Directory to install application into. [default: 03:19:07 INFO - "/builds/slave/test"] 03:19:07 INFO - --app=APP Application being installed. [default: firefox] 03:19:07 INFO - mkdir: /builds/slave/test/build/application 03:19:07 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'] 03:19:07 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 03:19:21 INFO - Reading from file tmpfile_stdout 03:19:21 INFO - Output received: 03:19:21 INFO - /builds/slave/test/build/application/firefox/firefox 03:19:21 INFO - Running post-action listener: _resource_record_post_action 03:19:21 INFO - [mozharness: 2016-10-14 10:19:21.394697Z] Finished install step (success) 03:19:21 INFO - [mozharness: 2016-10-14 10:19:21.395023Z] Running run-tests step. 03:19:21 INFO - Running pre-action listener: _resource_record_pre_action 03:19:21 INFO - Running main action method: run_tests 03:19:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:19:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:19:21 INFO - Python 2.7.3 03:19:21 INFO - Return code: 0 03:19:21 INFO - grabbing minidump binary from tooltool 03:19:21 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')]} 03:19:21 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 0x2019570>, '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 0x201a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x201a900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:19:21 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 03:19:21 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 03:19:21 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 03:19:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:19:21 INFO - Return code: 0 03:19:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:19:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:19:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:19:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:19:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:19:21 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/RU6M4E7bS1qSRjNfkEBg6Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 03:19:21 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/RU6M4E7bS1qSRjNfkEBg6Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --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 03:19:21 INFO - Using env: {'DISPLAY': ':0', 03:19:21 INFO - 'HOME': '/home/cltbld', 03:19:21 INFO - 'LANG': 'en_US.UTF-8', 03:19:21 INFO - 'LANGUAGE': 'en_US:en', 03:19:21 INFO - 'LOGNAME': 'cltbld', 03:19:21 INFO - 'MAIL': '/var/mail/cltbld', 03:19:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:19:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:19:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:21 INFO - 'MOZ_NO_REMOTE': '1', 03:19:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:19:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:21 INFO - 'NO_EM_RESTART': '1', 03:19:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:21 INFO - 'PWD': '/builds/slave/test', 03:19:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:19:21 INFO - 'SHELL': '/bin/bash', 03:19:21 INFO - 'SHLVL': '1', 03:19:21 INFO - 'TERM': 'linux', 03:19:21 INFO - 'TMOUT': '86400', 03:19:21 INFO - 'USER': 'cltbld', 03:19:21 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1476439863.868837-1407430733', 03:19:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:21 INFO - '_': '/tools/buildbot/bin/python'} 03:19:21 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/RU6M4E7bS1qSRjNfkEBg6Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 03:19:21 INFO - mozversion application_buildid: 20161014000335 03:19:21 INFO - mozversion application_changeset: c216304c306bda09e8b8766f692885fa378ddb3c 03:19:21 INFO - mozversion application_display_name: Firefox 03:19:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:19:21 INFO - mozversion application_name: Firefox 03:19:21 INFO - mozversion application_remotingname: firefox 03:19:21 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 03:19:21 INFO - mozversion application_vendor: Mozilla 03:19:21 INFO - mozversion application_version: 50.0 03:19:21 INFO - mozversion platform_buildid: 20161014000335 03:19:21 INFO - mozversion platform_changeset: c216304c306bda09e8b8766f692885fa378ddb3c 03:19:21 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 03:19:21 INFO - mozversion platform_version: 50.0 03:19:21 INFO - using testdate: 1476440361 03:19:21 INFO - actual date: 1476440361 03:19:21 INFO - starting webserver on 'localhost:50364' 03:19:21 INFO - SUITE-START | Running 2 tests 03:19:21 INFO - TEST-START | dromaeo_css 03:19:21 INFO - operating with platform_type : linux_ 03:19:21 INFO - Initialising browser for dromaeo_css test... 03:19:21 INFO - TEST-INFO | started process 27778 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwQTzbg/profile http://localhost:50364/getInfo.html) 03:19:26 INFO - PROCESS | 27778 | __metrics Screen width/height:1600/1200 03:19:26 INFO - PROCESS | 27778 | colorDepth:24 03:19:26 INFO - PROCESS | 27778 | Browser inner width/height: 1024/697 03:19:26 INFO - PROCESS | 27778 | __metrics 03:19:26 ERROR - PROCESS | 27778 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 03:19:27 INFO - TEST-INFO | 27778: exit 0 03:19:27 INFO - Browser initialized. 03:19:27 INFO - Running cycle 1/1 for dromaeo_css test... 03:19:27 INFO - TEST-INFO | started process 27900 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwQTzbg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:19:39 INFO - PROCESS | 27900 | RSS: Main: 149954560 03:19:39 INFO - PROCESS | 27900 | 03:20:28 INFO - PROCESS | 27900 | 1476440428794 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] 03:22:37 INFO - PROCESS | 27900 | Cycle 1(1): loaded http://localhost:50364/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50364/tests/dromaeo/cssquery-ext.html) 03:22:38 INFO - PROCESS | 27900 | RSS: Main: 158625792 03:22:38 INFO - PROCESS | 27900 | 03:25:40 INFO - PROCESS | 27900 | Cycle 1(1): loaded http://localhost:50364/tests/dromaeo/cssquery-ext.html (next: http://localhost:50364/tests/dromaeo/cssquery-jquery.html) 03:25:40 INFO - PROCESS | 27900 | RSS: Main: 154431488 03:25:40 INFO - PROCESS | 27900 | 03:28:42 INFO - PROCESS | 27900 | Cycle 1(1): loaded http://localhost:50364/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50364/tests/dromaeo/cssquery-mootools.html) 03:28:43 INFO - PROCESS | 27900 | RSS: Main: 154324992 03:28:43 INFO - PROCESS | 27900 | 03:31:44 INFO - PROCESS | 27900 | Cycle 1(1): loaded http://localhost:50364/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50364/tests/dromaeo/cssquery-prototype.html) 03:31:45 INFO - PROCESS | 27900 | RSS: Main: 155955200 03:31:45 INFO - PROCESS | 27900 | 03:34:48 INFO - PROCESS | 27900 | Cycle 1(1): loaded http://localhost:50364/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50364/tests/dromaeo/cssquery-yui.html) 03:34:48 INFO - PROCESS | 27900 | RSS: Main: 157134848 03:34:48 INFO - PROCESS | 27900 | 03:37:51 INFO - PROCESS | 27900 | Cycle 1(1): loaded http://localhost:50364/tests/dromaeo/cssquery-yui.html (next: http://localhost:50364/tests/dromaeo/cssquery-dojo.html) 03:37:51 INFO - PROCESS | 27900 | RSS: Main: 156917760 03:37:51 INFO - PROCESS | 27900 | 03:37:51 INFO - PROCESS | 27900 | __start_tp_report 03:37:51 INFO - PROCESS | 27900 | _x_x_mozilla_page_load 03:37:51 INFO - PROCESS | 27900 | _x_x_mozilla_page_load_details 03:37:51 INFO - PROCESS | 27900 | |i|pagename|runs| 03:37:51 INFO - PROCESS | 27900 | |0;dojo.html;3312.552805371275;3339.0650617827;3342.481915303127;3355.9496607550877;3366.8148251846155;5772.105323674832;5853.941460585393;5856.677882716449;5884.794032208873;5886.941130588688;5725.7995970141055;5743.195952566644;5794.246747922764;5804.82585522435;5809.709514524267;5207.661502002376;5258.0535503609335;5258.158694608864;5286.365636123652;5302.681839089648;5299.788008479656;5305.575553955694;5306.071437498442;5308.604408705677;5334.67991920486;5002.7248501332415;5154.664946778447;5301.5228629423345;5304.549113325372;5309.177077552986;5231.372235331765;5313.601479889024;5320.308359913187;5320.787168513255;5371.543418809406;5211.973940130275;5265.183896496049;5282.0756367635895;5283.920741188886;5297.894042119175;5491.643043202179;5642.548596112301;5742.6841523716175;5791.957447659462;5861.941380586182;6079.878402431927;6180.84547886302;6188.721507532172;6193.225846769154;6200.472959798422;6191.380861913773;6233.937660623381;6243.594166379171;6248.187735594389;6254.687265636746;5535.612507124462;5770.769169233267;5808.215890854723;5825.592208545403;5853.47318741311;6312.274088479883;6409.166808314889;6409.455196308273;6411.551191416556;6416.7433302668305;6134.969325153345;6152.600080994721;6168.228971378578;6173.351798061229;6175.84560385994;5933.495652869468;6123.050927106306;6208.379162083846;6260.843478912972;6269.5611307208055;6129.417705317987;6207.410296021871;6221.751129954751;6224.813255602339;6229.0967809667345;6211.16149319845;6228.781992630236;6229;6234.345393733593;6251.749930002749;4517.254652982287;4571.81712731487;4696.037312351028;4713.222318317439;4728.479867214673;4114.321137012419;4155.709100362946;4164.000639846415;4168.291390463568;4184.686148538872;5871.471567558855;5874.148248503943;5876.9118463223085;5890.511057756858;5950.31571369298;5934.43622855828;6138.940218748475;6213.5339849511465;6216.222972128484;6224.408681175281;5787.942120578825;5811.476967072984;5844.532437404998;5855.912161317584;5893.705314734246;5101.132807422747;5131.358580177478;5136.1268584340005;5138.409082955433;5168.069747445421;6099.176611157437;6356.173697419398;6361.173047503795;6402.263739669905;6412.35876412355;6275.184226050585;6278.15244941927;6278.183836101461;6297.118403423433;6325.209348831396;6486.351364863476;6518.120053792677;6543.214814222133;6557;6566.4418524425955;5940;6109.1010297800785;6120.142398366865;6174.135621012972;6179.567430279837;6295.685215739286;6314.116023756769;6350.110984462087;6358.0780786784735;6359.618422894641;6130.6628135452975;6200.100985357189;6224.875502490016;6229.3770622937345;6241.625502469685;5817.389174136655;6097.908531372122;6126.5098792097415;6193.938060619336;6206.472449841814;6115.0827375892195;6137.938620613737;6170.969145154246;6176.598521096114;6186.969065154645;6189.288231853215;6197.225346831646;6213.844653883689;6222.28443728977;6226.377362263737;5809.302883653989;5932.110183472513;6037.366076561898;6044.032954727222;6044.516438684983 03:37:51 INFO - PROCESS | 27900 | |1;ext.html;593.685346766214;641.2625480697199;659.831742905559;661.7386132477671;705.6029062456339;42228.57771422288;46536.069278614494;46638;46656.766716166414;46667.53332466674;37122;37446.063848403806;37519.43720844183;38111.809440952755;38888.22223555527;8978.41640293382;9099.545022748869;9105.63577456901;9125.817483650322;9146.954265228664;9156.542172891362;9202.263818894473;9224.492652904088;9226.031266716998;9246.53767311635;9267.629294828232;9278.907210927871;9315.953420232889;9350.953245233799;9353.485558294291;9175.220106290973;9211.30915181364;9222.446653200795;9229.6308147674;9244.67643632473;9112;9142.268618510503;9156.954215228949;9189.908100918972;9205.723828285161;44535.10929781386;44708.55291447076;45077.54922450766;45131.77434112841;45151;3924.274009308287;4102.671786257122;4477.082198149372;4528.25283828168;4639.164950308943;33827.4925876112;35564;35961;36279.637203628154;36902.63097369046;4844.539768721966;4858.708477491362;4878.048780487807;4908.533689299511;4934.284528743348;344520;344716;346460.9999999975;346635;347726;65268.020979685345;65288.347116528224;65718;65811.34188658147;65835.34164658292;40196.598034019284;40554;40729.796351018056;42851.35722964158;68896;18037.368692095715;18183.818161818475;18188.727169092475;18191;18200.544986375182;13268.336583170996;13287.335633218301;13306.467741290433;13333.66665833362;13345.866541334657;20967.370978870353;21092.894535527223;21263.149474021175;21361;21455.892720536296;7516.661750221253;7610.467267291237;7663.157052724196;7799.855039863969;7879.803004924923;1006.642641862143;1046.5133712823422;1077.4235783855756;1115.7462423118466;1140.5380820767602;34141.31717365639;34947.12632184216;35251.212725247125;35343.64656353455;35476.29047419037;1187.8455800745849;1189.2804853063772;1228.6375519221851;1261.5584545409217;1265.1207410849556;18125.728114078298;18336.418094612836;18345.357912473;18616.906915465606;18744.343947961755;575959;577237;577878;578397;581576;66937.66531167313;66964;67143.32856671371;67172.32827671661;67233.3276667227;1415.2994267837487;1458.905171163871;1463.84629613889;1475.7122361139689;1477.56411858502;33192.502112467846;34320.65679343174;34682.82658586691;34912.825435873674;35151.47272790859;57991.42008580029;58117;58396;58498;58845;474293;475846;476427;476631;478278;31504;32630.34739305248;32766.836165819972;32884.342313154084;32906.17734556655;53074.73462632662;53226.46773532215;53519;53900.730496348835;55527.72236138793;43682.78158609186;45465.77267113643;45909.77045114753;46309.53690463052;47228.291575625706;47214;47414;47423.288650670955;47791.28313075376;48010.51989480061;44702.776486117364;45596.31605525853;45823.541764581925;46243.768781157225;46344;37229.81385093057;39453.802730986165;39791.801040995764;40449.39325910173;42048.789756051025;30772.384552309275;30940.53589196119;31008.534871976488;31107;31196.844015779774 03:37:51 INFO - PROCESS | 27900 | |2;jquery.html;409.28375343149486;415.6072511476656;421.3742592250508;424.626328830629;435.97384156950585;19402.22391104356;19976.60046799065;20939.267125650604;21095.367138985817;21099.050542725578;19290.807091929077;19301.420957371265;19692.90153549234;19787.703184452246;19944.202231910742;5848.67832269225;6073.453389194971;6086.087086936973;6090.543209259301;6095.908561371583;5998.55010874184;6007.722084465879;6009.57932944694;6037.094435834616;6038.365971572987;5769.3076830780155;5967.761289548413;5985.521158307347;5993;6011.669358185298;5879.176915231871;5915.497182739494;5975.820725378224;5986.640801551921;6008.36912124225;5199.714015729133;5349.0639138151055;5374.220737992969;5384.6499977501335;5385.703786291752;22243.443913902283;24565.631515527282;24689.38276543083;24896.751032489807;25082.749172508225;2484.329231107609;2663.440677457736;2824.576313552963;2868.885244590214;2875.7411832934927;15056.774148387783;15563.144027078506;15624.609384765357;15675.451359202487;15743.763843542356;2044.570640165567;2124.7237859078377;2164.350694791572;2173.174193806359;2275.340151356105;78785;82271;82954.75567866547;83655;84758.57620711857;11685;11713.355765432983;11744.17790754656;11892.464839082262;12812.487500499876;16484.505464836075;16498.092604906604;16509.17454127289;16516.75224871628;16518;8278.668853245923;8461.534615596078;8492.787680308042;8562.61468233931;8689.261412779984;8226.05400378952;8235.629396677165;8320;8407.201315874981;8431.494110353398;5046.217836235316;5079.492050794891;5084.237364395296;5100.974495127501;5120.564751996122;2019.294145844546;2059.166037754712;2128.6700561413004;2138.6364318065657;2167.729033870766;933.8552524358736;987.0968064221157;1011.6863772230632;1074.7259448840496;1084.5932775209296;20124.798752012586;20222.595548088957;20591.176352945713;20768.48078798042;20792.37622871316;1000.6997900629927;1016.6848277034143;1030.3714734012246;1047.544318221576;1073.672529878379;10723.624673136403;11480.734045032463;11647.76704465906;11719.648410547697;11733.120015998835;550002;550792;557096;558176;558177;88034;91431;92169;92518;94060;1031.8761748590218;1033.937963722164;1038.309524166436;1051.3901936876593;1059.6344261229863;17845.37541186052;18124.818751812312;18452.26190952347;18641.81358186455;18783.812161878206;37015.81492092522;40456;42425.36361954635;44094.559054410325;45171;62064;62866.685666573205;63527.36472635214;63627;63785.3621463798;8953.238974687225;9116.954415227881;9144;9194.95402522983;9216.861747073934;13980.58058258254;14161;14252.786208206679;14298.928505357822;14649.92675036618;12161.209521381083;12338;12525.874741252472;12571.18287311322;12645.367731613567;12086.274823510617;12508.437120329789;12637.557685480964;12814.679633008876;13048.086633935533;12401.689957751129;12515.499380024698;12566.308853013172;12607.87392126067;12748.553800616934;9144.177024067865;9200.893504105286;9200.907990920274;9259.53702314895;9462.810743784948;11528.308301501937;12287.324197168884;12431.31627760482;12561.309127998047;12648.177868438523 03:37:51 INFO - PROCESS | 27900 | |3;mootools.html;1536.5159974607998;1569.0428838408568;1721.388906938037;1831.8900865948053;1868.056631401142;8684.218420342168;9144.679936202234;9298.163165315129;9970.351927124731;9986.650467233649;9172.357934944557;9597.47213903235;9610.615575376976;9621.230301575875;9640.325177237597;2530.418003859109;2583.974160258392;2584.4701836123645;2585.7026441959133;2587.6894772627215;2504.4615407687343;2571.2928944540213;2573.716891141973;2584.9095281665145;2585.780208682255;2509.949801003979;2541.504406640706;2586.2241327601737;2594.7405259473994;2601.7268186840392;2486.2044145873238;2498.2005758157397;2502.649629051934;2503.2990762586505;2510.134003768715;2419.201663451057;2454.950900981988;2456.385903524119;2460.852348859074;2470.17249221511;9652.131308182226;9674.613015479372;9762.56068476913;9783.608655653765;9788;5757.222774925373;5856.092305692625;5937.70311484424;5938.8812223755285;5942.5840191186635;3687.870924517656;3826.655600995896;3861.131245469775;3882.9029274268087;3896;1215.2283300104498;1284.9229046257256;1299.7010687541917;1304.4912484131196;1321.894248460121;13802.65493362664;13836.792448113287;13943.302834858216;13981.231032293219;13987.370568324348;5103.2855400244;5118.38579370478;5303;5381.27352807366;5387.757550910218;11857.822132668018;11858.88141118595;11864.940675296568;11878.524859005543;11889.108316876269;5904.76380944766;5934.6142500737315;5947.137665038632;5967.283925928829;5994.970025149846;4540.977295113504;5198.376194856566;5271.947280527223;5324.813631522956;5411.053065713484;4458.464984201916;4541.3188021797;4591.334256532784;4608.953910460919;4617.676762626651;1395.3023488255872;1437.4250299880132;1449.623097994529;1457.30049576204;1458.6280498473034;851.7104184577149;975.2490582251627;1042.6871938418444;1058.1640504001907;1068.7862427514372;6385.904211436832;6580.934190658128;6738.8652226956165;6780.932190678129;6812.62530560814;505.8659455244363;1042.2183362478142;1058.9682309530726;1077.5151181968147;1154.7344110854551;4480.663950203748;4698.530146985274;4719.221328480831;4733.455652599926;4735.857924262277;12225.510979560719;12355.75288494243;12439.253644781342;12446.751064978649;12487.375631218403;11373.601923932623;11836.822447663291;11837.230580012272;12376.504939802488;12409.317487538092;8508.149185081566;8874.822503549893;8909.643614255487;8916.286697064219;8929.151730585583;6495.090687303876;6519.217693876765;6620.768273110418;6667.733290668319;6713;11036.227464077758;11232.157588180755;11287.492062857027;11362.943185284352;11690.941545292219;11215.158863085138;11629.883701163219;11705.297682139098;11792.115591330856;11792.469338879599;9004.729858104267;9325.160735533835;9363.204127649225;9383.436993780122;9545.952270238604;9679.612815487584;9746.366486178376;9748.317617766688;9775.657851975147;9784.755381115529;8216.46592971455;8350.164983501601;8445.40882138269;8630;8788.868166977372;8138.145494722969;8511.616977235915;8587.141285871363;8617.267532259828;8723.781905452415;7647.923520764721;7692.461527693008;7705.730299439717;7767;7768.417368697257;5833.154192642128;5879.353271140257;5884.176215329943;5922.763089476372;5995.730192141451;5720.427957204246;5731.111677689964;5792.957267691688;5798.884022319615;5804.506616937608 03:37:51 INFO - PROCESS | 27900 | |4;prototype.html;351.39033776397946;352.87120201126595;356.8019749039283;360.1141192666041;366.1742770053529;5745.971270143648;5816.389279125689;5817.080363480052;5824.708764561771;5860.267466566679;5650.145162816407;5687.488126068653;5691.317041954961;5739.3399759027725;5740.827775166741;4474.798634061459;4475.664325175609;4491.685582009244;4513.142502924434;4536.115457485792;4449.555044495541;4479.664025198107;4485.686001979862;4510.954890451103;4523.117991991563;4435.733855968636;4438.689291749579;4453.2206863798865;4476.462824461069;4487.326900964848;4388.319810429372;4433.2685106957315;4459.331100334959;4463.977680111611;4465.330200469923;3957.584453632356;3967.682585393162;3977.6618987386105;3981.581933896928;4011.939820902689;5501.14732216507;5533.280673512418;5583.888322233533;5598.384177740445;5604.187392828057;5080.491950804927;5144.533807864741;5175.378954525443;5177.352830896138;5205.037068142368;6004.789832355847;6005.54958378119;6009.557706150536;6020.367861374581;6025.517958563304;4294.699371044028;4380.846670366522;4390.253656878306;4406;4414.3157810539415;6042.154098426224;6224.533160012972;6243.968780156116;6272.5922815016875;6289.40250676185;4328.28583283761;4384.627306678968;4396.934045989249;4400.163968845909;4428.357888106271;4445.4220951276775;4480.439945006874;4482.887927801766;4491.977540112279;4500.527444618333;4875.414950205998;5129.768855474659;5137.510122064634;5138.87152821175;5149.485051494896;5950.583459157818;6002.369751176064;6024.518038556905;6026.306974697878;6063.9090413643835;1540.4454396417282;1554.1374537131774;1562.6952744214768;1566.3343079191297;1572.1667516216423;955.0878910640322;989.9852651032605;996.531630133836;1012.772126271583;1023.7542989682422;5184.8631577895585;5200.985807767449;5207.921881171786;5216.58267338612;5221.373435187802;5399.973000135053;5489.862753431116;5494.554923059281;5507.531859791962;5552.86117847049;4842.782074806642;5125.666831655931;5164.140909272659;5190.792368305226;5219.4780521947505;2859.642544681915;2884;2904.4481548505714;2907.520259157215;2924.7952643314766;5544.500994910478;5569.749361278752;5580.693061881554;5601.747921343549;5625.128105143709;5278.736063196825;5434.538064264581;5496.422875598085;5553.389127196006;5587.944120558743;5599.060493241081;5614.052622373287;5615.634983726045;5632.60571759981;5645.745941432645;5122.308488354173;5433.592480563894;5436.537894278872;5459.781608735606;5460.426655201147;5335.759890805;5364.471125729148;5392.865178370572;5425.83722488326;5438.320209973754;6238.844028899314;6482.611043337415;6487.772927947499;6495.707693153725;6515.641639709862;4356.520782713836;4382.627476664392;4407.471103467605;4419.24872771636;4430.933535996898;6145.293291271561;6217.844553886008;6281.560290779602;6291.685415729104;6377.521685873486;6104.847378815565;6105.908411373922;6106.297775755845;6108.08378743192;6124.87631308045;5897.616654917417;6080.300765411857;6110.144579758926;6151.569390142647;6161.322254551906;6045.637261764308;6049.485793707584;6059.787907423219;6064.878702426015;6105.267367915879;6124.724387402666;6176.289726681489;6188.257409110935;6223.106255591172;6229.595076320024;5802.709864506842;5971.880562388815;5986.2517185351835;5996.520278377807;6006.189164462741 03:37:51 INFO - PROCESS | 27900 | |5;yui.html;826.4751882554576;847.4957400346796;879.2174964281786;886.4238245140658;906.6600024990629;15562.844371556295;17142.228599713013;17575.648487030252;17712.29150833965;17943.013134277626;14900.850991490082;15035.173065481395;15036.548903532912;15050.322735476902;15058.548243552683;848.7156802471179;850.851101057314;872.7861673889875;886.366248132585;887.7336798960318;878.9912100878973;881.625309243569;882.0561998661435;882.2853488674162;882.3779235638891;926.157196950775;930.2511478259999;930.4789317981952;931.5295775633296;933.0296491648677;926.4441335198894;927.4852456886425;927.8608208768671;927.8840144981878;928.1971095002808;673.3064943108606;677.6645560447561;681.6932380428777;682.9760958366483;684.0457561701448;15489.22553872313;15644.92177539105;15654.295556699863;15658.530244092695;15833.92083039589;13780.586582402444;14296.857031429656;14344.995850290485;14502.564923052325;14598.124112553282;13256.270905100215;13344.132631379027;13376.866231337659;13597;13806;4099.077707515815;4178.498580170369;4181.686373521968;4199.202151591188;4203.957960420387;79249;80101;80298.19701803025;80589.59705201496;81257.18742812556;11409.506098561478;11420.200585958903;11532.654020379403;11547.422628868522;11685.298882067103;19744.70382944257;19805.702914456295;19836.801631983784;19869.205231790565;19879.10544025522;8916.375853690179;8943.642254309754;9069.41048831837;9207.861882071775;9232.53837308132;4975.328330675385;5063.291139240509;5065.949340506621;5098.898022039539;5114.64197506171;4037.1320166164414;4106.3840423936645;4158.812853421603;4178.979105104455;4198.874033778991;713.2418588180161;715.7938872999014;722.3895808042196;725.0248415880632;728.883378659412;674.9493787965922;806.6249194124642;809.8947136872287;848.249299370062;851.9616617252238;9694.418334899929;9933.25500587459;10093.899061009295;10148.441835699108;10251.58993640261;628.1802248066226;646.2632598837329;767.3055884424605;782.7847341981001;812.2770734046703;4063.2076745035024;4529.682922195415;5138.409082955433;5177.145770947826;5346.5455436287575;72379.2762072383;73861.26138738652;74874.25125748782;87862.56068719615;128326;105549;106859.46570267255;107228;107868.46065769778;110997.44501277442;59611.105833412534;59663.701681491315;61227;97750;99865.99999999854;10058.54736536843;10461.529231184768;10553.736156596147;10673.46632668379;10743.623973161215;54449.72775136099;55074.724626376614;58975;59480.10779838393;61199.38800611937;80075.59962200152;89914;91742.54128729313;91891;96987;14186.716265674835;14443.806050311094;14683.119012859263;14740.926295368454;16026.839731602535;16201.189940503164;16206.594835129215;16429.753553696944;16434;16472.42346517866;15297.694046119237;15394.230288485754;15692.293846776694;16129.919350403643;16192.352305907632;14162.504312349018;14895.553133406016;15140.848591514385;15304.770428443804;15688.843111568738;12862.935685321514;13649.658758531115;14798;15241.237938103272;15557.611059723598;11512.884871151182;11702.180847340604;11854.525818967144;12416.317102559446;12816.743665126833;11713.355765432983;12032.63902082904;12082.879171208528;12215.69460763488;12384.133110682526 03:37:51 INFO - PROCESS | 27900 | __end_tp_report 03:37:51 INFO - PROCESS | 27900 | __start_cc_report 03:37:51 INFO - PROCESS | 27900 | _x_x_mozilla_cycle_collect,364 03:37:51 INFO - PROCESS | 27900 | __end_cc_report 03:37:51 INFO - PROCESS | 27900 | __startTimestamp1476441471343__endTimestamp 03:37:51 INFO - PROCESS | 27900 | 03:37:51 INFO - PROCESS | 27900 | ------- Summary: start ------- 03:37:51 INFO - PROCESS | 27900 | Number of tests: 6 03:37:51 INFO - PROCESS | 27900 | 03:37:51 INFO - PROCESS | 27900 | [#0] dojo.html Cycles:165 Average:5769.44 Median:6044.03 stddev:686.41 (11.4%) stddev-sans-first:660.90 03:37:51 INFO - PROCESS | 27900 | Values: 3312.6 3339.1 3342.5 3355.9 3366.8 5772.1 5853.9 5856.7 5884.8 5886.9 5725.8 5743.2 5794.2 5804.8 5809.7 5207.7 5258.1 5258.2 5286.4 5302.7 5299.8 5305.6 5306.1 5308.6 5334.7 5002.7 5154.7 5301.5 5304.5 5309.2 5231.4 5313.6 5320.3 5320.8 5371.5 5212.0 5265.2 5282.1 5283.9 5297.9 5491.6 5642.5 5742.7 5792.0 5861.9 6079.9 6180.8 6188.7 6193.2 6200.5 6191.4 6233.9 6243.6 6248.2 6254.7 5535.6 5770.8 5808.2 5825.6 5853.5 6312.3 6409.2 6409.5 6411.6 6416.7 6135.0 6152.6 6168.2 6173.4 6175.8 5933.5 6123.1 6208.4 6260.8 6269.6 6129.4 6207.4 6221.8 6224.8 6229.1 6211.2 6228.8 6229.0 6234.3 6251.7 4517.3 4571.8 4696.0 4713.2 4728.5 4114.3 4155.7 4164.0 4168.3 4184.7 5871.5 5874.1 5876.9 5890.5 5950.3 5934.4 6138.9 6213.5 6216.2 6224.4 5787.9 5811.5 5844.5 5855.9 5893.7 5101.1 5131.4 5136.1 5138.4 5168.1 6099.2 6356.2 6361.2 6402.3 6412.4 6275.2 6278.2 6278.2 6297.1 6325.2 6486.4 6518.1 6543.2 6557.0 6566.4 5940.0 6109.1 6120.1 6174.1 6179.6 6295.7 6314.1 6350.1 6358.1 6359.6 6130.7 6200.1 6224.9 6229.4 6241.6 5817.4 6097.9 6126.5 6193.9 6206.5 6115.1 6137.9 6171.0 6176.6 6187.0 6189.3 6197.2 6213.8 6222.3 6226.4 5809.3 5932.1 6037.4 6044.0 6044.5 03:37:51 INFO - PROCESS | 27900 | 03:37:51 INFO - PROCESS | 27900 | [#1] ext.html Cycles:180 Average:64070.88 Median:24997.01 stddev:126364.96 (505.5%) stddev-sans-first:126629.57 03:37:51 INFO - PROCESS | 27900 | Values: 593.7 641.3 659.8 661.7 705.6 42228.6 46536.1 46638.0 46656.8 46667.5 37122.0 37446.1 37519.4 38111.8 38888.2 8978.4 9099.5 9105.6 9125.8 9147.0 9156.5 9202.3 9224.5 9226.0 9246.5 9267.6 9278.9 9316.0 9351.0 9353.5 9175.2 9211.3 9222.4 9229.6 9244.7 9112.0 9142.3 9157.0 9189.9 9205.7 44535.1 44708.6 45077.5 45131.8 45151.0 3924.3 4102.7 4477.1 4528.3 4639.2 33827.5 35564.0 35961.0 36279.6 36902.6 4844.5 4858.7 4878.0 4908.5 4934.3 344520.0 344716.0 346461.0 346635.0 347726.0 65268.0 65288.3 65718.0 65811.3 65835.3 40196.6 40554.0 40729.8 42851.4 68896.0 18037.4 18183.8 18188.7 18191.0 18200.5 13268.3 13287.3 13306.5 13333.7 13345.9 20967.4 21092.9 21263.1 21361.0 21455.9 7516.7 7610.5 7663.2 7799.9 7879.8 1006.6 1046.5 1077.4 1115.7 1140.5 34141.3 34947.1 35251.2 35343.6 35476.3 1187.8 1189.3 1228.6 1261.6 1265.1 18125.7 18336.4 18345.4 18616.9 18744.3 575959.0 577237.0 577878.0 578397.0 581576.0 66937.7 66964.0 67143.3 67172.3 67233.3 1415.3 1458.9 1463.8 1475.7 1477.6 33192.5 34320.7 34682.8 34912.8 35151.5 57991.4 58117.0 58396.0 58498.0 58845.0 474293.0 475846.0 476427.0 476631.0 478278.0 31504.0 32630.3 32766.8 32884.3 32906.2 53074.7 53226.5 53519.0 53900.7 55527.7 43682.8 45465.8 45909.8 46309.5 47228.3 47214.0 47414.0 47423.3 47791.3 48010.5 44702.8 45596.3 45823.5 46243.8 46344.0 37229.8 39453.8 39791.8 40449.4 42048.8 30772.4 30940.5 31008.5 31107.0 31196.8 03:37:51 INFO - PROCESS | 27900 | 03:37:51 INFO - PROCESS | 27900 | [#2] jquery.html Cycles:180 Average:31583.81 Median:13586.86 stddev:91116.22 (670.6%) stddev-sans-first:91341.76 03:37:51 INFO - PROCESS | 27900 | Values: 409.3 415.6 421.4 424.6 436.0 19402.2 19976.6 20939.3 21095.4 21099.1 19290.8 19301.4 19692.9 19787.7 19944.2 5848.7 6073.5 6086.1 6090.5 6095.9 5998.6 6007.7 6009.6 6037.1 6038.4 5769.3 5967.8 5985.5 5993.0 6011.7 5879.2 5915.5 5975.8 5986.6 6008.4 5199.7 5349.1 5374.2 5384.6 5385.7 22243.4 24565.6 24689.4 24896.8 25082.7 2484.3 2663.4 2824.6 2868.9 2875.7 15056.8 15563.1 15624.6 15675.5 15743.8 2044.6 2124.7 2164.4 2173.2 2275.3 78785.0 82271.0 82954.8 83655.0 84758.6 11685.0 11713.4 11744.2 11892.5 12812.5 16484.5 16498.1 16509.2 16516.8 16518.0 8278.7 8461.5 8492.8 8562.6 8689.3 8226.1 8235.6 8320.0 8407.2 8431.5 5046.2 5079.5 5084.2 5101.0 5120.6 2019.3 2059.2 2128.7 2138.6 2167.7 933.9 987.1 1011.7 1074.7 1084.6 20124.8 20222.6 20591.2 20768.5 20792.4 1000.7 1016.7 1030.4 1047.5 1073.7 10723.6 11480.7 11647.8 11719.6 11733.1 550002.0 550792.0 557096.0 558176.0 558177.0 88034.0 91431.0 92169.0 92518.0 94060.0 1031.9 1033.9 1038.3 1051.4 1059.6 17845.4 18124.8 18452.3 18641.8 18783.8 37015.8 40456.0 42425.4 44094.6 45171.0 62064.0 62866.7 63527.4 63627.0 63785.4 8953.2 9117.0 9144.0 9195.0 9216.9 13980.6 14161.0 14252.8 14298.9 14649.9 12161.2 12338.0 12525.9 12571.2 12645.4 12086.3 12508.4 12637.6 12814.7 13048.1 12401.7 12515.5 12566.3 12607.9 12748.6 9144.2 9200.9 9200.9 9259.5 9462.8 11528.3 12287.3 12431.3 12561.3 12648.2 03:37:51 INFO - PROCESS | 27900 | 03:37:51 INFO - PROCESS | 27900 | [#3] mootools.html Cycles:180 Average:6491.23 Median:4726.34 stddev:3718.25 (78.7%) stddev-sans-first:3710.04 03:37:51 INFO - PROCESS | 27900 | Values: 1536.5 1569.0 1721.4 1831.9 1868.1 8684.2 9144.7 9298.2 9970.4 9986.7 9172.4 9597.5 9610.6 9621.2 9640.3 2530.4 2584.0 2584.5 2585.7 2587.7 2504.5 2571.3 2573.7 2584.9 2585.8 2509.9 2541.5 2586.2 2594.7 2601.7 2486.2 2498.2 2502.6 2503.3 2510.1 2419.2 2455.0 2456.4 2460.9 2470.2 9652.1 9674.6 9762.6 9783.6 9788.0 5757.2 5856.1 5937.7 5938.9 5942.6 3687.9 3826.7 3861.1 3882.9 3896.0 1215.2 1284.9 1299.7 1304.5 1321.9 13802.7 13836.8 13943.3 13981.2 13987.4 5103.3 5118.4 5303.0 5381.3 5387.8 11857.8 11858.9 11864.9 11878.5 11889.1 5904.8 5934.6 5947.1 5967.3 5995.0 4541.0 5198.4 5271.9 5324.8 5411.1 4458.5 4541.3 4591.3 4609.0 4617.7 1395.3 1437.4 1449.6 1457.3 1458.6 851.7 975.2 1042.7 1058.2 1068.8 6385.9 6580.9 6738.9 6780.9 6812.6 505.9 1042.2 1059.0 1077.5 1154.7 4480.7 4698.5 4719.2 4733.5 4735.9 12225.5 12355.8 12439.3 12446.8 12487.4 11373.6 11836.8 11837.2 12376.5 12409.3 8508.1 8874.8 8909.6 8916.3 8929.2 6495.1 6519.2 6620.8 6667.7 6713.0 11036.2 11232.2 11287.5 11362.9 11690.9 11215.2 11629.9 11705.3 11792.1 11792.5 9004.7 9325.2 9363.2 9383.4 9546.0 9679.6 9746.4 9748.3 9775.7 9784.8 8216.5 8350.2 8445.4 8630.0 8788.9 8138.1 8511.6 8587.1 8617.3 8723.8 7647.9 7692.5 7705.7 7767.0 7768.4 5833.2 5879.4 5884.2 5922.8 5995.7 5720.4 5731.1 5793.0 5798.9 5804.5 03:37:51 INFO - PROCESS | 27900 | 03:37:51 INFO - PROCESS | 27900 | [#4] prototype.html Cycles:180 Average:4923.35 Median:5435.54 stddev:1432.10 (26.3%) stddev-sans-first:1394.40 03:37:51 INFO - PROCESS | 27900 | Values: 351.4 352.9 356.8 360.1 366.2 5746.0 5816.4 5817.1 5824.7 5860.3 5650.1 5687.5 5691.3 5739.3 5740.8 4474.8 4475.7 4491.7 4513.1 4536.1 4449.6 4479.7 4485.7 4511.0 4523.1 4435.7 4438.7 4453.2 4476.5 4487.3 4388.3 4433.3 4459.3 4464.0 4465.3 3957.6 3967.7 3977.7 3981.6 4011.9 5501.1 5533.3 5583.9 5598.4 5604.2 5080.5 5144.5 5175.4 5177.4 5205.0 6004.8 6005.5 6009.6 6020.4 6025.5 4294.7 4380.8 4390.3 4406.0 4414.3 6042.2 6224.5 6244.0 6272.6 6289.4 4328.3 4384.6 4396.9 4400.2 4428.4 4445.4 4480.4 4482.9 4492.0 4500.5 4875.4 5129.8 5137.5 5138.9 5149.5 5950.6 6002.4 6024.5 6026.3 6063.9 1540.4 1554.1 1562.7 1566.3 1572.2 955.1 990.0 996.5 1012.8 1023.8 5184.9 5201.0 5207.9 5216.6 5221.4 5400.0 5489.9 5494.6 5507.5 5552.9 4842.8 5125.7 5164.1 5190.8 5219.5 2859.6 2884.0 2904.4 2907.5 2924.8 5544.5 5569.7 5580.7 5601.7 5625.1 5278.7 5434.5 5496.4 5553.4 5587.9 5599.1 5614.1 5615.6 5632.6 5645.7 5122.3 5433.6 5436.5 5459.8 5460.4 5335.8 5364.5 5392.9 5425.8 5438.3 6238.8 6482.6 6487.8 6495.7 6515.6 4356.5 4382.6 4407.5 4419.2 4430.9 6145.3 6217.8 6281.6 6291.7 6377.5 6104.8 6105.9 6106.3 6108.1 6124.9 5897.6 6080.3 6110.1 6151.6 6161.3 6045.6 6049.5 6059.8 6064.9 6105.3 6124.7 6176.3 6188.3 6223.1 6229.6 5802.7 5971.9 5986.3 5996.5 6006.2 03:37:51 INFO - PROCESS | 27900 | 03:37:51 INFO - PROCESS | 27900 | [#5] yui.html Cycles:180 Average:21160.14 Median:4180.33 stddev:29491.38 (705.5%) stddev-sans-first:29534.59 03:37:51 INFO - PROCESS | 27900 | Values: 826.5 847.5 879.2 886.4 906.7 15562.8 17142.2 17575.6 17712.3 17943.0 14900.9 15035.2 15036.5 15050.3 15058.5 848.7 850.9 872.8 886.4 887.7 879.0 881.6 882.1 882.3 882.4 926.2 930.3 930.5 931.5 933.0 926.4 927.5 927.9 927.9 928.2 673.3 677.7 681.7 683.0 684.0 15489.2 15644.9 15654.3 15658.5 15833.9 13780.6 14296.9 14345.0 14502.6 14598.1 13256.3 13344.1 13376.9 13597.0 13806.0 4099.1 4178.5 4181.7 4199.2 4204.0 79249.0 80101.0 80298.2 80589.6 81257.2 11409.5 11420.2 11532.7 11547.4 11685.3 19744.7 19805.7 19836.8 19869.2 19879.1 8916.4 8943.6 9069.4 9207.9 9232.5 4975.3 5063.3 5065.9 5098.9 5114.6 4037.1 4106.4 4158.8 4179.0 4198.9 713.2 715.8 722.4 725.0 728.9 674.9 806.6 809.9 848.2 852.0 9694.4 9933.3 10093.9 10148.4 10251.6 628.2 646.3 767.3 782.8 812.3 4063.2 4529.7 5138.4 5177.1 5346.5 72379.3 73861.3 74874.3 87862.6 128326.0 105549.0 106859.5 107228.0 107868.5 110997.4 59611.1 59663.7 61227.0 97750.0 99866.0 10058.5 10461.5 10553.7 10673.5 10743.6 54449.7 55074.7 58975.0 59480.1 61199.4 80075.6 89914.0 91742.5 91891.0 96987.0 14186.7 14443.8 14683.1 14740.9 16026.8 16201.2 16206.6 16429.8 16434.0 16472.4 15297.7 15394.2 15692.3 16129.9 16192.4 14162.5 14895.6 15140.8 15304.8 15688.8 12862.9 13649.7 14798.0 15241.2 15557.6 11512.9 11702.2 11854.5 12416.3 12816.7 11713.4 12032.6 12082.9 12215.7 12384.1 03:37:51 INFO - PROCESS | 27900 | -------- Summary: end -------- 03:37:51 INFO - PROCESS | 27900 | 03:37:51 INFO - TEST-INFO | 27900: exit 0 03:37:52 INFO - TEST-OK | dromaeo_css | took 1110347ms 03:37:52 INFO - TEST-START | kraken 03:37:52 INFO - operating with platform_type : linux_ 03:37:52 INFO - Initialising browser for kraken test... 03:37:52 INFO - TEST-INFO | started process 28142 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPBXyuv/profile http://localhost:50364/getInfo.html) 03:37:55 INFO - PROCESS | 28142 | __metrics Screen width/height:1600/1200 03:37:55 INFO - PROCESS | 28142 | colorDepth:24 03:37:55 INFO - PROCESS | 28142 | Browser inner width/height: 1024/697 03:37:55 INFO - PROCESS | 28142 | __metrics 03:37:56 ERROR - PROCESS | 28142 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 03:37:57 INFO - TEST-INFO | 28142: exit 0 03:37:57 INFO - Browser initialized. 03:37:57 INFO - Running cycle 1/1 for kraken test... 03:37:57 INFO - TEST-INFO | started process 28264 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPBXyuv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:38:09 INFO - PROCESS | 28264 | RSS: Main: 150192128 03:38:09 INFO - PROCESS | 28264 | 03:38:11 INFO - PROCESS | 28264 | Cycle 1(1): loaded http://localhost:50364/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50364/tests/kraken/driver.html?testName=audio-beat-detection) 03:38:12 INFO - PROCESS | 28264 | RSS: Main: 156512256 03:38:12 INFO - PROCESS | 28264 | 03:38:15 INFO - PROCESS | 28264 | Cycle 1(1): loaded http://localhost:50364/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50364/tests/kraken/driver.html?testName=audio-dft) 03:38:15 INFO - PROCESS | 28264 | RSS: Main: 155815936 03:38:15 INFO - PROCESS | 28264 | 03:38:18 INFO - PROCESS | 28264 | Cycle 1(1): loaded http://localhost:50364/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50364/tests/kraken/driver.html?testName=audio-fft) 03:38:19 INFO - PROCESS | 28264 | RSS: Main: 155820032 03:38:19 INFO - PROCESS | 28264 | 03:38:21 INFO - PROCESS | 28264 | Cycle 1(1): loaded http://localhost:50364/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50364/tests/kraken/driver.html?testName=audio-oscillator) 03:38:21 INFO - PROCESS | 28264 | RSS: Main: 156426240 03:38:21 INFO - PROCESS | 28264 | 03:38:23 INFO - PROCESS | 28264 | Cycle 1(1): loaded http://localhost:50364/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50364/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:38:24 INFO - PROCESS | 28264 | RSS: Main: 155836416 03:38:24 INFO - PROCESS | 28264 | 03:38:27 INFO - PROCESS | 28264 | Cycle 1(1): loaded http://localhost:50364/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50364/tests/kraken/driver.html?testName=imaging-darkroom) 03:38:28 INFO - PROCESS | 28264 | RSS: Main: 155746304 03:38:28 INFO - PROCESS | 28264 | 03:38:31 INFO - PROCESS | 28264 | Cycle 1(1): loaded http://localhost:50364/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50364/tests/kraken/driver.html?testName=imaging-desaturate) 03:38:32 INFO - PROCESS | 28264 | RSS: Main: 156442624 03:38:32 INFO - PROCESS | 28264 | 03:38:35 INFO - PROCESS | 28264 | Cycle 1(1): loaded http://localhost:50364/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50364/tests/kraken/driver.html?testName=json-parse-financial) 03:38:35 INFO - PROCESS | 28264 | RSS: Main: 156639232 03:38:35 INFO - PROCESS | 28264 | 03:38:37 INFO - PROCESS | 28264 | Cycle 1(1): loaded http://localhost:50364/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50364/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:38:37 INFO - PROCESS | 28264 | RSS: Main: 155897856 03:38:37 INFO - PROCESS | 28264 | 03:38:39 INFO - PROCESS | 28264 | Cycle 1(1): loaded http://localhost:50364/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50364/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:38:40 INFO - PROCESS | 28264 | RSS: Main: 155983872 03:38:40 INFO - PROCESS | 28264 | 03:38:42 INFO - PROCESS | 28264 | Cycle 1(1): loaded http://localhost:50364/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50364/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:38:42 INFO - PROCESS | 28264 | RSS: Main: 156147712 03:38:42 INFO - PROCESS | 28264 | 03:38:45 INFO - PROCESS | 28264 | Cycle 1(1): loaded http://localhost:50364/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50364/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:38:46 INFO - PROCESS | 28264 | RSS: Main: 156844032 03:38:46 INFO - PROCESS | 28264 | 03:38:48 INFO - PROCESS | 28264 | Cycle 1(1): loaded http://localhost:50364/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50364/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:38:49 INFO - PROCESS | 28264 | RSS: Main: 156704768 03:38:49 INFO - PROCESS | 28264 | 03:38:51 INFO - PROCESS | 28264 | Cycle 1(1): loaded http://localhost:50364/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50364/tests/kraken/driver.html?testName=ai-astar) 03:38:51 INFO - PROCESS | 28264 | RSS: Main: 158617600 03:38:51 INFO - PROCESS | 28264 | 03:38:51 INFO - PROCESS | 28264 | __start_tp_report 03:38:51 INFO - PROCESS | 28264 | _x_x_mozilla_page_load 03:38:51 INFO - PROCESS | 28264 | _x_x_mozilla_page_load_details 03:38:51 INFO - PROCESS | 28264 | |i|pagename|runs| 03:38:51 INFO - PROCESS | 28264 | |0;ai-astar;99;111;101;108;110;111;109;109;109;108 03:38:51 INFO - PROCESS | 28264 | |1;audio-beat-detection;148;121;150;168;116;144;149;117;164;120 03:38:51 INFO - PROCESS | 28264 | |2;audio-dft;163;161;161;163;161;162;168;162;162;160 03:38:51 INFO - PROCESS | 28264 | |3;audio-fft;74;76;77;173;76;76;76;76;166;77 03:38:51 INFO - PROCESS | 28264 | |4;audio-oscillator;89;84;146;84;84;83;141;83;83;149 03:38:51 INFO - PROCESS | 28264 | |5;imaging-gaussian-blur;117;118;118;117;117;118;117;117;117;117 03:38:51 INFO - PROCESS | 28264 | |6;imaging-darkroom;147;148;148;148;147;147;148;148;147;147 03:38:51 INFO - PROCESS | 28264 | |7;imaging-desaturate;95;95;95;97;95;95;95;96;96;96 03:38:51 INFO - PROCESS | 28264 | |8;json-parse-financial;52;57;52;51;50;56;55;52;51;51 03:38:51 INFO - PROCESS | 28264 | |9;json-stringify-tinderbox;60;60;60;60;61;60;61;60;62;60 03:38:51 INFO - PROCESS | 28264 | |10;stanford-crypto-aes;73;74;81;81;81;73;72;73;76;72 03:38:51 INFO - PROCESS | 28264 | |11;stanford-crypto-ccm;121;120;120;122;123;137;117;131;148;132 03:38:51 INFO - PROCESS | 28264 | |12;stanford-crypto-pbkdf2;159;157;154;153;157;156;159;160;158;155 03:38:51 INFO - PROCESS | 28264 | |13;stanford-crypto-sha256-iterative;65;62;63;61;61;62;61;60;61;61 03:38:51 INFO - PROCESS | 28264 | __end_tp_report 03:38:51 INFO - PROCESS | 28264 | __start_cc_report 03:38:51 INFO - PROCESS | 28264 | _x_x_mozilla_cycle_collect,859 03:38:51 INFO - PROCESS | 28264 | __end_cc_report 03:38:51 INFO - PROCESS | 28264 | __startTimestamp1476441531282__endTimestamp 03:38:51 INFO - PROCESS | 28264 | 03:38:51 INFO - PROCESS | 28264 | ------- Summary: start ------- 03:38:51 INFO - PROCESS | 28264 | Number of tests: 14 03:38:51 INFO - PROCESS | 28264 | 03:38:51 INFO - PROCESS | 28264 | [#0] ai-astar Cycles:10 Average:107.50 Median:109.50 stddev:4.12 (3.8%) stddev-sans-first:3.00 03:38:51 INFO - PROCESS | 28264 | Values: 99.0 111.0 101.0 108.0 110.0 111.0 109.0 109.0 109.0 108.0 03:38:51 INFO - PROCESS | 28264 | 03:38:51 INFO - PROCESS | 28264 | [#1] audio-beat-detection Cycles:10 Average:139.70 Median:148.50 stddev:19.68 (13.3%) stddev-sans-first:20.64 03:38:51 INFO - PROCESS | 28264 | Values: 148.0 121.0 150.0 168.0 116.0 144.0 149.0 117.0 164.0 120.0 03:38:51 INFO - PROCESS | 28264 | 03:38:51 INFO - PROCESS | 28264 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.00 stddev:2.21 (1.4%) stddev-sans-first:2.33 03:38:51 INFO - PROCESS | 28264 | Values: 163.0 161.0 161.0 163.0 161.0 162.0 168.0 162.0 162.0 160.0 03:38:51 INFO - PROCESS | 28264 | 03:38:51 INFO - PROCESS | 28264 | [#3] audio-fft Cycles:10 Average:94.70 Median:76.00 stddev:39.47 (51.9%) stddev-sans-first:41.14 03:38:51 INFO - PROCESS | 28264 | Values: 74.0 76.0 77.0 173.0 76.0 76.0 76.0 76.0 166.0 77.0 03:38:51 INFO - PROCESS | 28264 | 03:38:51 INFO - PROCESS | 28264 | [#4] audio-oscillator Cycles:10 Average:102.60 Median:83.50 stddev:29.60 (35.5%) stddev-sans-first:30.99 03:38:51 INFO - PROCESS | 28264 | Values: 89.0 84.0 146.0 84.0 84.0 83.0 141.0 83.0 83.0 149.0 03:38:51 INFO - PROCESS | 28264 | 03:38:51 INFO - PROCESS | 28264 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 03:38:51 INFO - PROCESS | 28264 | Values: 117.0 118.0 118.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 03:38:51 INFO - PROCESS | 28264 | 03:38:51 INFO - PROCESS | 28264 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 03:38:51 INFO - PROCESS | 28264 | Values: 147.0 148.0 148.0 148.0 147.0 147.0 148.0 148.0 147.0 147.0 03:38:51 INFO - PROCESS | 28264 | 03:38:51 INFO - PROCESS | 28264 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 03:38:51 INFO - PROCESS | 28264 | Values: 95.0 95.0 95.0 97.0 95.0 95.0 95.0 96.0 96.0 96.0 03:38:51 INFO - PROCESS | 28264 | 03:38:51 INFO - PROCESS | 28264 | [#8] json-parse-financial Cycles:10 Average:52.70 Median:52.00 stddev:2.41 (4.6%) stddev-sans-first:2.54 03:38:51 INFO - PROCESS | 28264 | Values: 52.0 57.0 52.0 51.0 50.0 56.0 55.0 52.0 51.0 51.0 03:38:51 INFO - PROCESS | 28264 | 03:38:51 INFO - PROCESS | 28264 | [#9] json-stringify-tinderbox Cycles:10 Average:60.40 Median:60.00 stddev:0.70 (1.2%) stddev-sans-first:0.73 03:38:51 INFO - PROCESS | 28264 | Values: 60.0 60.0 60.0 60.0 61.0 60.0 61.0 60.0 62.0 60.0 03:38:51 INFO - PROCESS | 28264 | 03:38:51 INFO - PROCESS | 28264 | [#10] stanford-crypto-aes Cycles:10 Average:75.60 Median:75.00 stddev:3.89 (5.2%) stddev-sans-first:4.01 03:38:51 INFO - PROCESS | 28264 | Values: 73.0 74.0 81.0 81.0 81.0 73.0 72.0 73.0 76.0 72.0 03:38:51 INFO - PROCESS | 28264 | 03:38:51 INFO - PROCESS | 28264 | [#11] stanford-crypto-ccm Cycles:10 Average:127.10 Median:127.00 stddev:9.76 (7.7%) stddev-sans-first:10.10 03:38:51 INFO - PROCESS | 28264 | Values: 121.0 120.0 120.0 122.0 123.0 137.0 117.0 131.0 148.0 132.0 03:38:51 INFO - PROCESS | 28264 | 03:38:51 INFO - PROCESS | 28264 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.80 Median:157.50 stddev:2.30 (1.5%) stddev-sans-first:2.30 03:38:51 INFO - PROCESS | 28264 | Values: 159.0 157.0 154.0 153.0 157.0 156.0 159.0 160.0 158.0 155.0 03:38:51 INFO - PROCESS | 28264 | 03:38:51 INFO - PROCESS | 28264 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.70 Median:61.50 stddev:1.42 (2.3%) stddev-sans-first:0.87 03:38:51 INFO - PROCESS | 28264 | Values: 65.0 62.0 63.0 61.0 61.0 62.0 61.0 60.0 61.0 61.0 03:38:51 INFO - PROCESS | 28264 | -------- Summary: end -------- 03:38:51 INFO - PROCESS | 28264 | 03:38:52 INFO - TEST-INFO | 28264: exit 0 03:38:52 INFO - TEST-OK | kraken | took 60186ms 03:38:52 INFO - SUITE-END | took 1170s 03:38:52 INFO - Completed test suite (00:19:30) 03:38:52 INFO - javascript benchmark 03:38:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7807.202573493872, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3312.552805371275, 3339.0650617827, 3342.481915303127, 3355.9496607550877, 3366.8148251846155, 5772.105323674832, 5853.941460585393, 5856.677882716449, 5884.794032208873, 5886.941130588688, 5725.7995970141055, 5743.195952566644, 5794.246747922764, 5804.82585522435, 5809.709514524267, 5207.661502002376, 5258.0535503609335, 5258.158694608864, 5286.365636123652, 5302.681839089648, 5299.788008479656, 5305.575553955694, 5306.071437498442, 5308.604408705677, 5334.67991920486, 5002.7248501332415, 5154.664946778447, 5301.5228629423345, 5304.549113325372, 5309.177077552986, 5231.372235331765, 5313.601479889024, 5320.308359913187, 5320.787168513255, 5371.543418809406, 5211.973940130275, 5265.183896496049, 5282.0756367635895, 5283.920741188886, 5297.894042119175, 5491.643043202179, 5642.548596112301, 5742.6841523716175, 5791.957447659462, 5861.941380586182, 6079.878402431927, 6180.84547886302, 6188.721507532172, 6193.225846769154, 6200.472959798422, 6191.380861913773, 6233.937660623381, 6243.594166379171, 6248.187735594389, 6254.687265636746, 5535.612507124462, 5770.769169233267, 5808.215890854723, 5825.592208545403, 5853.47318741311, 6312.274088479883, 6409.166808314889, 6409.455196308273, 6411.551191416556, 6416.7433302668305, 6134.969325153345, 6152.600080994721, 6168.228971378578, 6173.351798061229, 6175.84560385994, 5933.495652869468, 6123.050927106306, 6208.379162083846, 6260.843478912972, 6269.5611307208055, 6129.417705317987, 6207.410296021871, 6221.751129954751, 6224.813255602339, 6229.0967809667345, 6211.16149319845, 6228.781992630236, 6229.0, 6234.345393733593, 6251.749930002749, 4517.254652982287, 4571.81712731487, 4696.037312351028, 4713.222318317439, 4728.479867214673, 4114.321137012419, 4155.709100362946, 4164.000639846415, 4168.291390463568, 4184.686148538872, 5871.471567558855, 5874.148248503943, 5876.9118463223085, 5890.511057756858, 5950.31571369298, 5934.43622855828, 6138.940218748475, 6213.5339849511465, 6216.222972128484, 6224.408681175281, 5787.942120578825, 5811.476967072984, 5844.532437404998, 5855.912161317584, 5893.705314734246, 5101.132807422747, 5131.358580177478, 5136.1268584340005, 5138.409082955433, 5168.069747445421, 6099.176611157437, 6356.173697419398, 6361.173047503795, 6402.263739669905, 6412.35876412355, 6275.184226050585, 6278.15244941927, 6278.183836101461, 6297.118403423433, 6325.209348831396, 6486.351364863476, 6518.120053792677, 6543.214814222133, 6557.0, 6566.4418524425955, 5940.0, 6109.1010297800785, 6120.142398366865, 6174.135621012972, 6179.567430279837, 6295.685215739286, 6314.116023756769, 6350.110984462087, 6358.0780786784735, 6359.618422894641, 6130.6628135452975, 6200.100985357189, 6224.875502490016, 6229.3770622937345, 6241.625502469685, 5817.389174136655, 6097.908531372122, 6126.5098792097415, 6193.938060619336, 6206.472449841814, 6115.0827375892195, 6137.938620613737, 6170.969145154246, 6176.598521096114, 6186.969065154645, 6189.288231853215, 6197.225346831646, 6213.844653883689, 6222.28443728977, 6226.377362263737, 5809.302883653989, 5932.110183472513, 6037.366076561898, 6044.032954727222, 6044.516438684983], "value": 5721.207905802798, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.685346766214, 641.2625480697199, 659.831742905559, 661.7386132477671, 705.6029062456339, 42228.57771422288, 46536.069278614494, 46638.0, 46656.766716166414, 46667.53332466674, 37122.0, 37446.063848403806, 37519.43720844183, 38111.809440952755, 38888.22223555527, 8978.41640293382, 9099.545022748869, 9105.63577456901, 9125.817483650322, 9146.954265228664, 9156.542172891362, 9202.263818894473, 9224.492652904088, 9226.031266716998, 9246.53767311635, 9267.629294828232, 9278.907210927871, 9315.953420232889, 9350.953245233799, 9353.485558294291, 9175.220106290973, 9211.30915181364, 9222.446653200795, 9229.6308147674, 9244.67643632473, 9112.0, 9142.268618510503, 9156.954215228949, 9189.908100918972, 9205.723828285161, 44535.10929781386, 44708.55291447076, 45077.54922450766, 45131.77434112841, 45151.0, 3924.274009308287, 4102.671786257122, 4477.082198149372, 4528.25283828168, 4639.164950308943, 33827.4925876112, 35564.0, 35961.0, 36279.637203628154, 36902.63097369046, 4844.539768721966, 4858.708477491362, 4878.048780487807, 4908.533689299511, 4934.284528743348, 344520.0, 344716.0, 346460.9999999975, 346635.0, 347726.0, 65268.020979685345, 65288.347116528224, 65718.0, 65811.34188658147, 65835.34164658292, 40196.598034019284, 40554.0, 40729.796351018056, 42851.35722964158, 68896.0, 18037.368692095715, 18183.818161818475, 18188.727169092475, 18191.0, 18200.544986375182, 13268.336583170996, 13287.335633218301, 13306.467741290433, 13333.66665833362, 13345.866541334657, 20967.370978870353, 21092.894535527223, 21263.149474021175, 21361.0, 21455.892720536296, 7516.661750221253, 7610.467267291237, 7663.157052724196, 7799.855039863969, 7879.803004924923, 1006.642641862143, 1046.5133712823422, 1077.4235783855756, 1115.7462423118466, 1140.5380820767602, 34141.31717365639, 34947.12632184216, 35251.212725247125, 35343.64656353455, 35476.29047419037, 1187.8455800745849, 1189.2804853063772, 1228.6375519221851, 1261.5584545409217, 1265.1207410849556, 18125.728114078298, 18336.418094612836, 18345.357912473, 18616.906915465606, 18744.343947961755, 575959.0, 577237.0, 577878.0, 578397.0, 581576.0, 66937.66531167313, 66964.0, 67143.32856671371, 67172.32827671661, 67233.3276667227, 1415.2994267837487, 1458.905171163871, 1463.84629613889, 1475.7122361139689, 1477.56411858502, 33192.502112467846, 34320.65679343174, 34682.82658586691, 34912.825435873674, 35151.47272790859, 57991.42008580029, 58117.0, 58396.0, 58498.0, 58845.0, 474293.0, 475846.0, 476427.0, 476631.0, 478278.0, 31504.0, 32630.34739305248, 32766.836165819972, 32884.342313154084, 32906.17734556655, 53074.73462632662, 53226.46773532215, 53519.0, 53900.730496348835, 55527.72236138793, 43682.78158609186, 45465.77267113643, 45909.77045114753, 46309.53690463052, 47228.291575625706, 47214.0, 47414.0, 47423.288650670955, 47791.28313075376, 48010.51989480061, 44702.776486117364, 45596.31605525853, 45823.541764581925, 46243.768781157225, 46344.0, 37229.81385093057, 39453.802730986165, 39791.801040995764, 40449.39325910173, 42048.789756051025, 30772.384552309275, 30940.53589196119, 31008.534871976488, 31107.0, 31196.844015779774], "value": 21575.28355736958, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [409.28375343149486, 415.6072511476656, 421.3742592250508, 424.626328830629, 435.97384156950585, 19402.22391104356, 19976.60046799065, 20939.267125650604, 21095.367138985817, 21099.050542725578, 19290.807091929077, 19301.420957371265, 19692.90153549234, 19787.703184452246, 19944.202231910742, 5848.67832269225, 6073.453389194971, 6086.087086936973, 6090.543209259301, 6095.908561371583, 5998.55010874184, 6007.722084465879, 6009.57932944694, 6037.094435834616, 6038.365971572987, 5769.3076830780155, 5967.761289548413, 5985.521158307347, 5993.0, 6011.669358185298, 5879.176915231871, 5915.497182739494, 5975.820725378224, 5986.640801551921, 6008.36912124225, 5199.714015729133, 5349.0639138151055, 5374.220737992969, 5384.6499977501335, 5385.703786291752, 22243.443913902283, 24565.631515527282, 24689.38276543083, 24896.751032489807, 25082.749172508225, 2484.329231107609, 2663.440677457736, 2824.576313552963, 2868.885244590214, 2875.7411832934927, 15056.774148387783, 15563.144027078506, 15624.609384765357, 15675.451359202487, 15743.763843542356, 2044.570640165567, 2124.7237859078377, 2164.350694791572, 2173.174193806359, 2275.340151356105, 78785.0, 82271.0, 82954.75567866547, 83655.0, 84758.57620711857, 11685.0, 11713.355765432983, 11744.17790754656, 11892.464839082262, 12812.487500499876, 16484.505464836075, 16498.092604906604, 16509.17454127289, 16516.75224871628, 16518.0, 8278.668853245923, 8461.534615596078, 8492.787680308042, 8562.61468233931, 8689.261412779984, 8226.05400378952, 8235.629396677165, 8320.0, 8407.201315874981, 8431.494110353398, 5046.217836235316, 5079.492050794891, 5084.237364395296, 5100.974495127501, 5120.564751996122, 2019.294145844546, 2059.166037754712, 2128.6700561413004, 2138.6364318065657, 2167.729033870766, 933.8552524358736, 987.0968064221157, 1011.6863772230632, 1074.7259448840496, 1084.5932775209296, 20124.798752012586, 20222.595548088957, 20591.176352945713, 20768.48078798042, 20792.37622871316, 1000.6997900629927, 1016.6848277034143, 1030.3714734012246, 1047.544318221576, 1073.672529878379, 10723.624673136403, 11480.734045032463, 11647.76704465906, 11719.648410547697, 11733.120015998835, 550002.0, 550792.0, 557096.0, 558176.0, 558177.0, 88034.0, 91431.0, 92169.0, 92518.0, 94060.0, 1031.8761748590218, 1033.937963722164, 1038.309524166436, 1051.3901936876593, 1059.6344261229863, 17845.37541186052, 18124.818751812312, 18452.26190952347, 18641.81358186455, 18783.812161878206, 37015.81492092522, 40456.0, 42425.36361954635, 44094.559054410325, 45171.0, 62064.0, 62866.685666573205, 63527.36472635214, 63627.0, 63785.3621463798, 8953.238974687225, 9116.954415227881, 9144.0, 9194.95402522983, 9216.861747073934, 13980.58058258254, 14161.0, 14252.786208206679, 14298.928505357822, 14649.92675036618, 12161.209521381083, 12338.0, 12525.874741252472, 12571.18287311322, 12645.367731613567, 12086.274823510617, 12508.437120329789, 12637.557685480964, 12814.679633008876, 13048.086633935533, 12401.689957751129, 12515.499380024698, 12566.308853013172, 12607.87392126067, 12748.553800616934, 9144.177024067865, 9200.893504105286, 9200.907990920274, 9259.53702314895, 9462.810743784948, 11528.308301501937, 12287.324197168884, 12431.31627760482, 12561.309127998047, 12648.177868438523], "value": 9858.75248663263, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1536.5159974607998, 1569.0428838408568, 1721.388906938037, 1831.8900865948053, 1868.056631401142, 8684.218420342168, 9144.679936202234, 9298.163165315129, 9970.351927124731, 9986.650467233649, 9172.357934944557, 9597.47213903235, 9610.615575376976, 9621.230301575875, 9640.325177237597, 2530.418003859109, 2583.974160258392, 2584.4701836123645, 2585.7026441959133, 2587.6894772627215, 2504.4615407687343, 2571.2928944540213, 2573.716891141973, 2584.9095281665145, 2585.780208682255, 2509.949801003979, 2541.504406640706, 2586.2241327601737, 2594.7405259473994, 2601.7268186840392, 2486.2044145873238, 2498.2005758157397, 2502.649629051934, 2503.2990762586505, 2510.134003768715, 2419.201663451057, 2454.950900981988, 2456.385903524119, 2460.852348859074, 2470.17249221511, 9652.131308182226, 9674.613015479372, 9762.56068476913, 9783.608655653765, 9788.0, 5757.222774925373, 5856.092305692625, 5937.70311484424, 5938.8812223755285, 5942.5840191186635, 3687.870924517656, 3826.655600995896, 3861.131245469775, 3882.9029274268087, 3896.0, 1215.2283300104498, 1284.9229046257256, 1299.7010687541917, 1304.4912484131196, 1321.894248460121, 13802.65493362664, 13836.792448113287, 13943.302834858216, 13981.231032293219, 13987.370568324348, 5103.2855400244, 5118.38579370478, 5303.0, 5381.27352807366, 5387.757550910218, 11857.822132668018, 11858.88141118595, 11864.940675296568, 11878.524859005543, 11889.108316876269, 5904.76380944766, 5934.6142500737315, 5947.137665038632, 5967.283925928829, 5994.970025149846, 4540.977295113504, 5198.376194856566, 5271.947280527223, 5324.813631522956, 5411.053065713484, 4458.464984201916, 4541.3188021797, 4591.334256532784, 4608.953910460919, 4617.676762626651, 1395.3023488255872, 1437.4250299880132, 1449.623097994529, 1457.30049576204, 1458.6280498473034, 851.7104184577149, 975.2490582251627, 1042.6871938418444, 1058.1640504001907, 1068.7862427514372, 6385.904211436832, 6580.934190658128, 6738.8652226956165, 6780.932190678129, 6812.62530560814, 505.8659455244363, 1042.2183362478142, 1058.9682309530726, 1077.5151181968147, 1154.7344110854551, 4480.663950203748, 4698.530146985274, 4719.221328480831, 4733.455652599926, 4735.857924262277, 12225.510979560719, 12355.75288494243, 12439.253644781342, 12446.751064978649, 12487.375631218403, 11373.601923932623, 11836.822447663291, 11837.230580012272, 12376.504939802488, 12409.317487538092, 8508.149185081566, 8874.822503549893, 8909.643614255487, 8916.286697064219, 8929.151730585583, 6495.090687303876, 6519.217693876765, 6620.768273110418, 6667.733290668319, 6713.0, 11036.227464077758, 11232.157588180755, 11287.492062857027, 11362.943185284352, 11690.941545292219, 11215.158863085138, 11629.883701163219, 11705.297682139098, 11792.115591330856, 11792.469338879599, 9004.729858104267, 9325.160735533835, 9363.204127649225, 9383.436993780122, 9545.952270238604, 9679.612815487584, 9746.366486178376, 9748.317617766688, 9775.657851975147, 9784.755381115529, 8216.46592971455, 8350.164983501601, 8445.40882138269, 8630.0, 8788.868166977372, 8138.145494722969, 8511.616977235915, 8587.141285871363, 8617.267532259828, 8723.781905452415, 7647.923520764721, 7692.461527693008, 7705.730299439717, 7767.0, 7768.417368697257, 5833.154192642128, 5879.353271140257, 5884.176215329943, 5922.763089476372, 5995.730192141451, 5720.427957204246, 5731.111677689964, 5792.957267691688, 5798.884022319615, 5804.506616937608], "value": 5163.837731399586, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.39033776397946, 352.87120201126595, 356.8019749039283, 360.1141192666041, 366.1742770053529, 5745.971270143648, 5816.389279125689, 5817.080363480052, 5824.708764561771, 5860.267466566679, 5650.145162816407, 5687.488126068653, 5691.317041954961, 5739.3399759027725, 5740.827775166741, 4474.798634061459, 4475.664325175609, 4491.685582009244, 4513.142502924434, 4536.115457485792, 4449.555044495541, 4479.664025198107, 4485.686001979862, 4510.954890451103, 4523.117991991563, 4435.733855968636, 4438.689291749579, 4453.2206863798865, 4476.462824461069, 4487.326900964848, 4388.319810429372, 4433.2685106957315, 4459.331100334959, 4463.977680111611, 4465.330200469923, 3957.584453632356, 3967.682585393162, 3977.6618987386105, 3981.581933896928, 4011.939820902689, 5501.14732216507, 5533.280673512418, 5583.888322233533, 5598.384177740445, 5604.187392828057, 5080.491950804927, 5144.533807864741, 5175.378954525443, 5177.352830896138, 5205.037068142368, 6004.789832355847, 6005.54958378119, 6009.557706150536, 6020.367861374581, 6025.517958563304, 4294.699371044028, 4380.846670366522, 4390.253656878306, 4406.0, 4414.3157810539415, 6042.154098426224, 6224.533160012972, 6243.968780156116, 6272.5922815016875, 6289.40250676185, 4328.28583283761, 4384.627306678968, 4396.934045989249, 4400.163968845909, 4428.357888106271, 4445.4220951276775, 4480.439945006874, 4482.887927801766, 4491.977540112279, 4500.527444618333, 4875.414950205998, 5129.768855474659, 5137.510122064634, 5138.87152821175, 5149.485051494896, 5950.583459157818, 6002.369751176064, 6024.518038556905, 6026.306974697878, 6063.9090413643835, 1540.4454396417282, 1554.1374537131774, 1562.6952744214768, 1566.3343079191297, 1572.1667516216423, 955.0878910640322, 989.9852651032605, 996.531630133836, 1012.772126271583, 1023.7542989682422, 5184.8631577895585, 5200.985807767449, 5207.921881171786, 5216.58267338612, 5221.373435187802, 5399.973000135053, 5489.862753431116, 5494.554923059281, 5507.531859791962, 5552.86117847049, 4842.782074806642, 5125.666831655931, 5164.140909272659, 5190.792368305226, 5219.4780521947505, 2859.642544681915, 2884.0, 2904.4481548505714, 2907.520259157215, 2924.7952643314766, 5544.500994910478, 5569.749361278752, 5580.693061881554, 5601.747921343549, 5625.128105143709, 5278.736063196825, 5434.538064264581, 5496.422875598085, 5553.389127196006, 5587.944120558743, 5599.060493241081, 5614.052622373287, 5615.634983726045, 5632.60571759981, 5645.745941432645, 5122.308488354173, 5433.592480563894, 5436.537894278872, 5459.781608735606, 5460.426655201147, 5335.759890805, 5364.471125729148, 5392.865178370572, 5425.83722488326, 5438.320209973754, 6238.844028899314, 6482.611043337415, 6487.772927947499, 6495.707693153725, 6515.641639709862, 4356.520782713836, 4382.627476664392, 4407.471103467605, 4419.24872771636, 4430.933535996898, 6145.293291271561, 6217.844553886008, 6281.560290779602, 6291.685415729104, 6377.521685873486, 6104.847378815565, 6105.908411373922, 6106.297775755845, 6108.08378743192, 6124.87631308045, 5897.616654917417, 6080.300765411857, 6110.144579758926, 6151.569390142647, 6161.322254551906, 6045.637261764308, 6049.485793707584, 6059.787907423219, 6064.878702426015, 6105.267367915879, 6124.724387402666, 6176.289726681489, 6188.257409110935, 6223.106255591172, 6229.595076320024, 5802.709864506842, 5971.880562388815, 5986.2517185351835, 5996.520278377807, 6006.189164462741], "value": 4469.769761486155, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [826.4751882554576, 847.4957400346796, 879.2174964281786, 886.4238245140658, 906.6600024990629, 15562.844371556295, 17142.228599713013, 17575.648487030252, 17712.29150833965, 17943.013134277626, 14900.850991490082, 15035.173065481395, 15036.548903532912, 15050.322735476902, 15058.548243552683, 848.7156802471179, 850.851101057314, 872.7861673889875, 886.366248132585, 887.7336798960318, 878.9912100878973, 881.625309243569, 882.0561998661435, 882.2853488674162, 882.3779235638891, 926.157196950775, 930.2511478259999, 930.4789317981952, 931.5295775633296, 933.0296491648677, 926.4441335198894, 927.4852456886425, 927.8608208768671, 927.8840144981878, 928.1971095002808, 673.3064943108606, 677.6645560447561, 681.6932380428777, 682.9760958366483, 684.0457561701448, 15489.22553872313, 15644.92177539105, 15654.295556699863, 15658.530244092695, 15833.92083039589, 13780.586582402444, 14296.857031429656, 14344.995850290485, 14502.564923052325, 14598.124112553282, 13256.270905100215, 13344.132631379027, 13376.866231337659, 13597.0, 13806.0, 4099.077707515815, 4178.498580170369, 4181.686373521968, 4199.202151591188, 4203.957960420387, 79249.0, 80101.0, 80298.19701803025, 80589.59705201496, 81257.18742812556, 11409.506098561478, 11420.200585958903, 11532.654020379403, 11547.422628868522, 11685.298882067103, 19744.70382944257, 19805.702914456295, 19836.801631983784, 19869.205231790565, 19879.10544025522, 8916.375853690179, 8943.642254309754, 9069.41048831837, 9207.861882071775, 9232.53837308132, 4975.328330675385, 5063.291139240509, 5065.949340506621, 5098.898022039539, 5114.64197506171, 4037.1320166164414, 4106.3840423936645, 4158.812853421603, 4178.979105104455, 4198.874033778991, 713.2418588180161, 715.7938872999014, 722.3895808042196, 725.0248415880632, 728.883378659412, 674.9493787965922, 806.6249194124642, 809.8947136872287, 848.249299370062, 851.9616617252238, 9694.418334899929, 9933.25500587459, 10093.899061009295, 10148.441835699108, 10251.58993640261, 628.1802248066226, 646.2632598837329, 767.3055884424605, 782.7847341981001, 812.2770734046703, 4063.2076745035024, 4529.682922195415, 5138.409082955433, 5177.145770947826, 5346.5455436287575, 72379.2762072383, 73861.26138738652, 74874.25125748782, 87862.56068719615, 128326.0, 105549.0, 106859.46570267255, 107228.0, 107868.46065769778, 110997.44501277442, 59611.105833412534, 59663.701681491315, 61227.0, 97750.0, 99865.99999999854, 10058.54736536843, 10461.529231184768, 10553.736156596147, 10673.46632668379, 10743.623973161215, 54449.72775136099, 55074.724626376614, 58975.0, 59480.10779838393, 61199.38800611937, 80075.59962200152, 89914.0, 91742.54128729313, 91891.0, 96987.0, 14186.716265674835, 14443.806050311094, 14683.119012859263, 14740.926295368454, 16026.839731602535, 16201.189940503164, 16206.594835129215, 16429.753553696944, 16434.0, 16472.42346517866, 15297.694046119237, 15394.230288485754, 15692.293846776694, 16129.919350403643, 16192.352305907632, 14162.504312349018, 14895.553133406016, 15140.848591514385, 15304.770428443804, 15688.843111568738, 12862.935685321514, 13649.658758531115, 14798.0, 15241.237938103272, 15557.611059723598, 11512.884871151182, 11702.180847340604, 11854.525818967144, 12416.317102559446, 12816.743665126833, 11713.355765432983, 12032.63902082904, 12082.879171208528, 12215.69460763488, 12384.133110682526], "value": 8061.340925210259, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1501.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 111.0, 101.0, 108.0, 110.0, 111.0, 109.0, 109.0, 109.0, 108.0], "value": 107.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 121.0, 150.0, 168.0, 116.0, 144.0, 149.0, 117.0, 164.0, 120.0], "value": 139.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 161.0, 163.0, 161.0, 162.0, 168.0, 162.0, 162.0, 160.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 77.0, 173.0, 76.0, 76.0, 76.0, 76.0, 166.0, 77.0], "value": 94.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 84.0, 146.0, 84.0, 84.0, 83.0, 141.0, 83.0, 83.0, 149.0], "value": 102.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 148.0, 147.0, 147.0, 148.0, 148.0, 147.0, 147.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 97.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 57.0, 52.0, 51.0, 50.0, 56.0, 55.0, 52.0, 51.0, 51.0], "value": 52.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 60.0, 61.0, 60.0, 61.0, 60.0, 62.0, 60.0], "value": 60.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 81.0, 81.0, 81.0, 73.0, 72.0, 73.0, 76.0, 72.0], "value": 75.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 120.0, 120.0, 122.0, 123.0, 137.0, 117.0, 131.0, 148.0, 132.0], "value": 127.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 157.0, 154.0, 153.0, 157.0, 156.0, 159.0, 160.0, 158.0, 155.0], "value": 156.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 62.0, 63.0, 61.0, 61.0, 62.0, 61.0, 60.0, 61.0, 61.0], "value": 61.7, "unit": "score"}]}]} 03:38:52 INFO - Return code: 0 03:38:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:38:52 ERROR - # TBPL SUCCESS # 03:38:52 INFO - Running post-action listener: _resource_record_post_action 03:38:52 INFO - [mozharness: 2016-10-14 10:38:52.617019Z] Finished run-tests step (success) 03:38:52 INFO - Running post-run listener: _resource_record_post_run 03:38:52 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291868672; Read time: 12; Write time: 215436 03:38:52 INFO - TinderboxPrint: CPU usage
13.2% 03:38:52 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 03:38:52 INFO - TinderboxPrint: I/O write bytes / time
291,868,672 / 215,436 03:38:52 INFO - TinderboxPrint: CPU idle
8,197.4 (86.8%) 03:38:52 INFO - TinderboxPrint: CPU user
1,199.3 (12.7%) 03:38:52 INFO - TinderboxPrint: Swap in / out
0 / 0 03:38:52 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 70090752; Read time: 0; Write time: 66748 03:38:52 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 4096; Write bytes: 221777920; Read time: 12; Write time: 148688 03:38:53 INFO - Running post-run listener: _upload_blobber_files 03:38:53 INFO - Blob upload gear active. 03:38:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:38:53 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 03:38:53 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'] 03:38:53 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 03:38:53 INFO - (blobuploader) - INFO - Open directory for files ... 03:38:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:38:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:38:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:38:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:38:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:38:54 INFO - (blobuploader) - INFO - Done attempting. 03:38:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:38:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:38:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:38:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:38:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:38:55 INFO - (blobuploader) - INFO - Done attempting. 03:38:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:38:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:38:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:38:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:38:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:38:58 INFO - (blobuploader) - INFO - Done attempting. 03:38:58 INFO - (blobuploader) - INFO - Iteration through files over. 03:38:58 INFO - Return code: 0 03:38:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:38:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:38:58 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/27aac613d887cebb197a73f6d00322826a9106cd540c778f760d811823ea63c60cafb2efd68123452ac41ff4fe92b5537d71eaddb72124f3bc17806ba227b887", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/150f21f1cf8011bc2afbe8cf655ece8cd341119f9620471f2841617ffb5d1806950cb8a066d2d762024c80642481d8e4411b1c2ac91c3470b2dfc2f85858a315", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/75b65e97c751bdc18685b547320541d4790dc67671a5b51ae6ba5702d8d471d3b57dc2b2819f35a2873e47c7175ca3b8e8fc0ae582264404cb5668fa59acac9a"} 03:38:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:38:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:38:58 INFO - Contents: 03:38:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/27aac613d887cebb197a73f6d00322826a9106cd540c778f760d811823ea63c60cafb2efd68123452ac41ff4fe92b5537d71eaddb72124f3bc17806ba227b887", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/150f21f1cf8011bc2afbe8cf655ece8cd341119f9620471f2841617ffb5d1806950cb8a066d2d762024c80642481d8e4411b1c2ac91c3470b2dfc2f85858a315", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/75b65e97c751bdc18685b547320541d4790dc67671a5b51ae6ba5702d8d471d3b57dc2b2819f35a2873e47c7175ca3b8e8fc0ae582264404cb5668fa59acac9a"} 03:38:58 INFO - Running post-run listener: copy_logs_to_upload_dir 03:38:58 INFO - Copying logs to upload dir... 03:38:58 INFO - mkdir: /builds/slave/test/build/upload/logs 03:38:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1671.613368 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 51 secs) (at 2016-10-14 03:38:58.039087) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 03:38:58.043229) ========= 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=62c568580acbfdaac3eec7be000001dc-1476439863.868837-1407430733 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/27aac613d887cebb197a73f6d00322826a9106cd540c778f760d811823ea63c60cafb2efd68123452ac41ff4fe92b5537d71eaddb72124f3bc17806ba227b887", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/150f21f1cf8011bc2afbe8cf655ece8cd341119f9620471f2841617ffb5d1806950cb8a066d2d762024c80642481d8e4411b1c2ac91c3470b2dfc2f85858a315", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/75b65e97c751bdc18685b547320541d4790dc67671a5b51ae6ba5702d8d471d3b57dc2b2819f35a2873e47c7175ca3b8e8fc0ae582264404cb5668fa59acac9a"} build_url:https://queue.taskcluster.net/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011295 build_url: 'https://queue.taskcluster.net/v1/task/RU6M4E7bS1qSRjNfkEBg6Q/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/27aac613d887cebb197a73f6d00322826a9106cd540c778f760d811823ea63c60cafb2efd68123452ac41ff4fe92b5537d71eaddb72124f3bc17806ba227b887", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/150f21f1cf8011bc2afbe8cf655ece8cd341119f9620471f2841617ffb5d1806950cb8a066d2d762024c80642481d8e4411b1c2ac91c3470b2dfc2f85858a315", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/75b65e97c751bdc18685b547320541d4790dc67671a5b51ae6ba5702d8d471d3b57dc2b2819f35a2873e47c7175ca3b8e8fc0ae582264404cb5668fa59acac9a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 03:38:58.069185) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 03:38:58.069568) ========= 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=62c568580acbfdaac3eec7be000001dc-1476439863.868837-1407430733 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004540 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 03:38:58.153244) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 03:38:58.153621) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 03:38:58.154003) ========= ========= Total master_lag: 0.17 =========