builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-001 starttime: 1477658685.79 results: success (0) buildid: 20161028030558 builduid: f084c4e82a4c4367ae5aeff42fc0e993 revision: 33be6bf8174cd5da272260bcf76a3b7e060ba620 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-28 05:44:45.785757) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-28 05:44:45.786189) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-28 05:44:45.786541) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-28 05:44:45.805077) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 05:44:45.805570) ========= 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=8887e36bb8e381bfd44124ac000001a8-1477657316.358043-1239426292 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-28 05:44:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.2M=0s 2016-10-28 05:44:46 (46.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.106610 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 05:44:45.929790) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 05:44:45.930572) ========= 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=8887e36bb8e381bfd44124ac000001a8-1477657316.358043-1239426292 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021752 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 05:44:45.984034) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 05:44:45.984409) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 33be6bf8174cd5da272260bcf76a3b7e060ba620 --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 33be6bf8174cd5da272260bcf76a3b7e060ba620 --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=8887e36bb8e381bfd44124ac000001a8-1477657316.358043-1239426292 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-28 05:44:46,389 truncating revision to first 12 chars 2016-10-28 05:44:46,390 Setting DEBUG logging. 2016-10-28 05:44:46,390 attempt 1/10 2016-10-28 05:44:46,390 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/33be6bf8174c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-28 05:44:46,704 unpacking tar archive at: mozilla-beta-33be6bf8174c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.648574 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 05:44:46.650815) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-28 05:44:46.651152) ========= script_repo_revision: 33be6bf8174cd5da272260bcf76a3b7e060ba620 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-28 05:44:46.651595) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-28 05:44:46.651936) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-28 05:44:46.665636) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 54 secs) (at 2016-10-28 05:44:46.665964) ========= /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=8887e36bb8e381bfd44124ac000001a8-1477657316.358043-1239426292 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:44:47 INFO - MultiFileLogger online at 20161028 05:44:47 in /builds/slave/test 05:44:47 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 05:44:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:44:47 INFO - {'append_to_log': False, 05:44:47 INFO - 'base_work_dir': '/builds/slave/test', 05:44:47 INFO - 'blob_upload_branch': 'Mozilla-Beta', 05:44:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:44:47 INFO - 'branch': 'Mozilla-Beta', 05:44:47 INFO - 'buildbot_json_path': 'buildprops.json', 05:44:47 INFO - 'config_files': ('talos/linux_config.py',), 05:44:47 INFO - 'default_actions': ('clobber', 05:44:47 INFO - 'read-buildbot-config', 05:44:47 INFO - 'download-and-extract', 05:44:47 INFO - 'populate-webroot', 05:44:47 INFO - 'create-virtualenv', 05:44:47 INFO - 'install', 05:44:47 INFO - 'run-tests'), 05:44:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:44:47 INFO - 'download_minidump_stackwalk': True, 05:44:47 INFO - 'download_symbols': 'ondemand', 05:44:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:44:47 INFO - 'tooltool.py': '/tools/tooltool.py', 05:44:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:44:47 INFO - '/tools/misc-python/virtualenv.py')}, 05:44:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:44:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:44:47 INFO - 'installer_path': 'installer.exe', 05:44:47 INFO - 'log_level': 'info', 05:44:47 INFO - 'log_name': 'talos', 05:44:47 INFO - 'log_to_console': True, 05:44:47 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:44:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:44:47 INFO - 'opt_config_files': (), 05:44:47 INFO - 'pip_index': False, 05:44:47 INFO - 'sps_profile': False, 05:44:47 INFO - 'sps_profile_interval': 0, 05:44:47 INFO - 'suite': 'dromaeojs-e10s', 05:44:47 INFO - 'system_bits': '32', 05:44:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:44:47 INFO - 'title': 'talos-linux64-ix-001', 05:44:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:44:47 INFO - 'use_talos_json': True, 05:44:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:44:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:44:47 INFO - 'work_dir': 'build'} 05:44:47 INFO - [mozharness: 2016-10-28 12:44:47.155309Z] Running clobber step. 05:44:47 INFO - Running pre-action listener: _resource_record_pre_action 05:44:47 INFO - Running main action method: clobber 05:44:47 INFO - rmtree: /builds/slave/test/build 05:44:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:44:48 INFO - Running post-action listener: _resource_record_post_action 05:44:48 INFO - [mozharness: 2016-10-28 12:44:48.142916Z] Finished clobber step (success) 05:44:48 INFO - [mozharness: 2016-10-28 12:44:48.143016Z] Running read-buildbot-config step. 05:44:48 INFO - Running pre-action listener: _resource_record_pre_action 05:44:48 INFO - Running main action method: read_buildbot_config 05:44:48 INFO - Using buildbot properties: 05:44:48 INFO - { 05:44:48 INFO - "project": "", 05:44:48 INFO - "product": "firefox", 05:44:48 INFO - "script_repo_revision": "production", 05:44:48 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 05:44:48 INFO - "repository": "", 05:44:48 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 05:44:48 INFO - "buildid": "20161028030558", 05:44:48 INFO - "pgo_build": "True", 05:44:48 INFO - "basedir": "/builds/slave/test", 05:44:48 INFO - "buildnumber": 308, 05:44:48 INFO - "slavename": "talos-linux64-ix-001", 05:44:48 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:44:48 INFO - "platform": "ubuntu64_hw", 05:44:48 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 05:44:48 INFO - "branch": "mozilla-beta", 05:44:48 INFO - "repo_path": "releases/mozilla-beta", 05:44:48 INFO - "revision": "33be6bf8174cd5da272260bcf76a3b7e060ba620", 05:44:48 INFO - "stage_platform": "linux64-pgo", 05:44:48 INFO - "builduid": "f084c4e82a4c4367ae5aeff42fc0e993", 05:44:48 INFO - "slavebuilddir": "test" 05:44:48 INFO - } 05:44:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2. 05:44:48 INFO - Running post-action listener: _resource_record_post_action 05:44:48 INFO - [mozharness: 2016-10-28 12:44:48.145474Z] Finished read-buildbot-config step (success) 05:44:48 INFO - [mozharness: 2016-10-28 12:44:48.145564Z] Running download-and-extract step. 05:44:48 INFO - Running pre-action listener: _resource_record_pre_action 05:44:48 INFO - Running main action method: download_and_extract 05:44:48 INFO - mkdir: /builds/slave/test/build/tests 05:44: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')]} 05:44:48 INFO - https://queue.taskcluster.net/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:44:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 05:44:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 05:44:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/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 05:44:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/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 05:44:48 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 05:44:48 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 05:44:48 INFO - retry: Failed, sleeping 30 seconds before retrying 05:45:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/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 05:45:18 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 05:45:18 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 05:45:18 INFO - retry: Failed, sleeping 60 seconds before retrying 05:46:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/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 05:46:18 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 05:46:18 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 05:46:18 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/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! 05:46:18 INFO - Caught exception: HTTP Error 404: Not Found 05:46:18 INFO - Caught exception: HTTP Error 404: Not Found 05:46:18 INFO - Caught exception: HTTP Error 404: Not Found 05:46:18 INFO - trying https://queue.taskcluster.net/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 05:46:18 INFO - Downloading https://queue.taskcluster.net/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/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 05:46:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/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 05:46:18 INFO - Downloaded 1327 bytes. 05:46:18 INFO - Reading from file /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 05:46:18 INFO - Using the following test package requirements: 05:46:18 INFO - {u'common': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 05:46:18 INFO - u'cppunittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 05:46:18 INFO - u'firefox-50.0.en-US.linux-x86_64.cppunittest.tests.zip'], 05:46:18 INFO - u'gtest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 05:46:18 INFO - u'firefox-50.0.en-US.linux-x86_64.gtest.tests.zip'], 05:46:18 INFO - u'jittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 05:46:18 INFO - u'jsshell-linux-x86_64.zip'], 05:46:18 INFO - u'mochitest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 05:46:18 INFO - u'firefox-50.0.en-US.linux-x86_64.mochitest.tests.zip'], 05:46:18 INFO - u'mozbase': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 05:46:18 INFO - u'reftest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 05:46:18 INFO - u'firefox-50.0.en-US.linux-x86_64.reftest.tests.zip'], 05:46:18 INFO - u'talos': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 05:46:18 INFO - u'firefox-50.0.en-US.linux-x86_64.talos.tests.zip'], 05:46:18 INFO - u'web-platform': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 05:46:18 INFO - u'firefox-50.0.en-US.linux-x86_64.web-platform.tests.zip'], 05:46:18 INFO - u'xpcshell': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 05:46:18 INFO - u'firefox-50.0.en-US.linux-x86_64.xpcshell.tests.zip']} 05:46:18 INFO - Downloading packages: [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:46:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:46:18 INFO - https://queue.taskcluster.net/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:46:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 05:46:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 05:46:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/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 05:46:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/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 05:46:18 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 05:46:18 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 05:46:18 INFO - retry: Failed, sleeping 30 seconds before retrying 05:46:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/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 05:46:48 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 05:46:48 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 05:46:48 INFO - retry: Failed, sleeping 60 seconds before retrying 05:47:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/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 05:47:48 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 05:47:48 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 05:47:48 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/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! 05:47:48 INFO - Caught exception: HTTP Error 404: Not Found 05:47:48 INFO - Caught exception: HTTP Error 404: Not Found 05:47:48 INFO - Caught exception: HTTP Error 404: Not Found 05:47:48 INFO - trying https://queue.taskcluster.net/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 05:47:48 INFO - Downloading https://queue.taskcluster.net/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/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 05:47:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/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 05:47:49 INFO - Downloaded 21787989 bytes. 05:47:49 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'] 05:47:49 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 05:47:50 INFO - Return code: 0 05:47:50 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 05:47:50 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')]} 05:47:50 INFO - https://queue.taskcluster.net/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:47:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 05:47:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 05:47:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/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 05:47:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/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 05:47:50 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 05:47:50 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 05:47:50 INFO - retry: Failed, sleeping 30 seconds before retrying 05:48:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/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 05:48:21 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 05:48:21 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 05:48:21 INFO - retry: Failed, sleeping 60 seconds before retrying 05:49:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/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 05:49:21 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 05:49:21 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 05:49:21 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/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! 05:49:21 INFO - Caught exception: HTTP Error 404: Not Found 05:49:21 INFO - Caught exception: HTTP Error 404: Not Found 05:49:21 INFO - Caught exception: HTTP Error 404: Not Found 05:49:21 INFO - trying https://queue.taskcluster.net/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 05:49:21 INFO - Downloading https://queue.taskcluster.net/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/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 05:49:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/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 05:49:21 INFO - Downloaded 21787989 bytes. 05:49:21 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'] 05:49:21 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 05:49:23 INFO - Return code: 0 05:49:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:23 INFO - https://queue.taskcluster.net/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:49:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 05:49:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 05:49:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/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 05:49:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/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 05:49:23 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 05:49:23 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 05:49:23 INFO - retry: Failed, sleeping 30 seconds before retrying 05:49:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/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 05:49:53 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 05:49:53 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 05:49:53 INFO - retry: Failed, sleeping 60 seconds before retrying 05:50:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/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 05:50:53 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 05:50:53 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 05:50:53 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/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! 05:50:53 INFO - Caught exception: HTTP Error 404: Not Found 05:50:53 INFO - Caught exception: HTTP Error 404: Not Found 05:50:53 INFO - Caught exception: HTTP Error 404: Not Found 05:50:53 INFO - trying https://queue.taskcluster.net/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 05:50:53 INFO - Downloading https://queue.taskcluster.net/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/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 05:50:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/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 05:50:54 INFO - Downloaded 14413762 bytes. 05:50:54 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'] 05:50:54 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 05:50:54 INFO - Return code: 0 05:50:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:54 INFO - https://queue.taskcluster.net/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:50:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 05:50:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 05:50:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/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 05:50:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/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 05:50:54 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 05:50:54 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 05:50:54 INFO - retry: Failed, sleeping 30 seconds before retrying 05:51:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/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 05:51:24 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 05:51:24 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 05:51:24 INFO - retry: Failed, sleeping 60 seconds before retrying 05:52:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/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 05:52:24 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 05:52:24 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 05:52:24 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/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! 05:52:24 INFO - Caught exception: HTTP Error 404: Not Found 05:52:24 INFO - Caught exception: HTTP Error 404: Not Found 05:52:24 INFO - Caught exception: HTTP Error 404: Not Found 05:52:24 INFO - trying https://queue.taskcluster.net/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 05:52:24 INFO - Downloading https://queue.taskcluster.net/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/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 05:52:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/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 05:52:26 INFO - Downloaded 56786740 bytes. 05:52:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 05:52:26 INFO - mkdir: /builds/slave/test/properties 05:52:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:52:26 INFO - Writing to file /builds/slave/test/properties/build_url 05:52:26 INFO - Contents: 05:52:26 INFO - build_url:https://queue.taskcluster.net/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 05:52:26 INFO - Running post-action listener: _resource_record_post_action 05:52:26 INFO - Running post-action listener: set_extra_try_arguments 05:52:26 INFO - [mozharness: 2016-10-28 12:52:26.724664Z] Finished download-and-extract step (success) 05:52:26 INFO - [mozharness: 2016-10-28 12:52:26.724898Z] Running populate-webroot step. 05:52:26 INFO - Running pre-action listener: _resource_record_pre_action 05:52:26 INFO - Running main action method: populate_webroot 05:52:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:52:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:52:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:52:26 INFO - '--tppagecycles', 05:52:26 INFO - '7'], 05:52:26 INFO - 'tests': ['tsvgm']}}, 05:52:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:52:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:52:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:52:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:52:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:52:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:52:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:26 INFO - 'talos_options': ['--disable-e10s'], 05:52:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:52:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:52:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:26 INFO - 'talos_options': ['--disable-e10s'], 05:52:26 INFO - 'tests': ['damp', 'tps']}, 05:52:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:26 INFO - 'tests': ['damp', 'tps']}, 05:52:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:52:26 INFO - 'tests': ['dromaeo_dom']}, 05:52:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:52:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:52:26 INFO - 'tests': ['basic_compositor_video']}, 05:52:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:52:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:52:26 INFO - 'tests': ['a11yr', 05:52:26 INFO - 'ts_paint', 05:52:26 INFO - 'tpaint', 05:52:26 INFO - 'sessionrestore', 05:52:26 INFO - 'sessionrestore_no_auto_restore', 05:52:26 INFO - 'tabpaint']}, 05:52:26 INFO - 'other-e10s': {'tests': ['a11yr', 05:52:26 INFO - 'ts_paint', 05:52:26 INFO - 'tpaint', 05:52:26 INFO - 'sessionrestore', 05:52:26 INFO - 'sessionrestore_no_auto_restore', 05:52:26 INFO - 'tabpaint']}, 05:52:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:52:26 INFO - 'ts_paint', 05:52:26 INFO - 'tpaint', 05:52:26 INFO - 'sessionrestore', 05:52:26 INFO - 'sessionrestore_no_auto_restore', 05:52:26 INFO - 'tabpaint']}, 05:52:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:52:26 INFO - 'ts_paint', 05:52:26 INFO - 'tpaint', 05:52:26 INFO - 'sessionrestore', 05:52:26 INFO - 'sessionrestore_no_auto_restore', 05:52:26 INFO - 'tabpaint']}, 05:52:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:52:26 INFO - 'tests': ['a11yr', 05:52:26 INFO - 'ts_paint', 05:52:26 INFO - 'tpaint', 05:52:26 INFO - 'sessionrestore', 05:52:26 INFO - 'sessionrestore_no_auto_restore', 05:52:26 INFO - 'tabpaint']}, 05:52:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:52:26 INFO - 'tests': ['a11yr', 05:52:26 INFO - 'ts_paint', 05:52:26 INFO - 'tpaint', 05:52:26 INFO - 'sessionrestore', 05:52:26 INFO - 'sessionrestore_no_auto_restore', 05:52:26 INFO - 'tabpaint']}, 05:52:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:52:26 INFO - 'tests': ['tsvgx', 05:52:26 INFO - 'tsvgr_opacity', 05:52:26 INFO - 'tart', 05:52:26 INFO - 'tscrollx', 05:52:26 INFO - 'cart']}, 05:52:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:52:26 INFO - 'tsvgr_opacity', 05:52:26 INFO - 'tart', 05:52:26 INFO - 'tscrollx', 05:52:26 INFO - 'cart']}, 05:52:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:26 INFO - 'talos_options': ['--disable-e10s'], 05:52:26 INFO - 'tests': ['tp5o']}, 05:52:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:26 INFO - 'tests': ['tp5o']}, 05:52:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:26 INFO - 'talos_options': ['--disable-e10s', 05:52:26 INFO - '--xperf_path', 05:52:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:52:26 INFO - 'tests': ['tp5n']}, 05:52:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:26 INFO - 'talos_options': ['--xperf_path', 05:52:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:52:26 INFO - 'tests': ['tp5n']}}, 05:52:26 INFO - 'talos.zip': {'path': '', 05:52:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:52:26 INFO - Running post-action listener: _resource_record_post_action 05:52:26 INFO - [mozharness: 2016-10-28 12:52:26.741013Z] Finished populate-webroot step (success) 05:52:26 INFO - [mozharness: 2016-10-28 12:52:26.741122Z] Running create-virtualenv step. 05:52:26 INFO - Running pre-action listener: _resource_record_pre_action 05:52:26 INFO - Running main action method: create_virtualenv 05:52:26 INFO - Creating virtualenv /builds/slave/test/build/venv 05:52:26 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:52:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:52:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:52:26 INFO - Using real prefix '/usr' 05:52:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:52:27 INFO - Installing distribute.............................................................................................................................................................................................done. 05:52:29 INFO - Installing pip.................done. 05:52:29 INFO - Return code: 0 05:52:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:52:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b1f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d4e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddd570>, '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 0x1dde470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dde900>, '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': '8887e36bb8e381bfd44124ac000001a8-1477657316.358043-1239426292', '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 05:52:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:52:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:52:29 INFO - Using env: {'DISPLAY': ':0', 05:52:29 INFO - 'HOME': '/home/cltbld', 05:52:29 INFO - 'LANG': 'en_US.UTF-8', 05:52:29 INFO - 'LANGUAGE': 'en_US:en', 05:52:29 INFO - 'LOGNAME': 'cltbld', 05:52:29 INFO - 'MAIL': '/var/mail/cltbld', 05:52:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:29 INFO - 'MOZ_NO_REMOTE': '1', 05:52:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:29 INFO - 'NO_EM_RESTART': '1', 05:52:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:29 INFO - 'PWD': '/builds/slave/test', 05:52:29 INFO - 'SHELL': '/bin/bash', 05:52:29 INFO - 'SHLVL': '1', 05:52:29 INFO - 'TERM': 'linux', 05:52:29 INFO - 'TMOUT': '86400', 05:52:29 INFO - 'USER': 'cltbld', 05:52:29 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1477657316.358043-1239426292', 05:52:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:29 INFO - '_': '/tools/buildbot/bin/python'} 05:52:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:29 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:52:29 INFO - Cleaning up... 05:52:29 INFO - Return code: 0 05:52:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:52:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b1f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d4e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddd570>, '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 0x1dde470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dde900>, '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': '8887e36bb8e381bfd44124ac000001a8-1477657316.358043-1239426292', '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 05:52:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:52:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:52:29 INFO - Using env: {'DISPLAY': ':0', 05:52:29 INFO - 'HOME': '/home/cltbld', 05:52:29 INFO - 'LANG': 'en_US.UTF-8', 05:52:29 INFO - 'LANGUAGE': 'en_US:en', 05:52:29 INFO - 'LOGNAME': 'cltbld', 05:52:29 INFO - 'MAIL': '/var/mail/cltbld', 05:52:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:29 INFO - 'MOZ_NO_REMOTE': '1', 05:52:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:29 INFO - 'NO_EM_RESTART': '1', 05:52:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:29 INFO - 'PWD': '/builds/slave/test', 05:52:29 INFO - 'SHELL': '/bin/bash', 05:52:29 INFO - 'SHLVL': '1', 05:52:29 INFO - 'TERM': 'linux', 05:52:29 INFO - 'TMOUT': '86400', 05:52:29 INFO - 'USER': 'cltbld', 05:52:29 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1477657316.358043-1239426292', 05:52:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:29 INFO - '_': '/tools/buildbot/bin/python'} 05:52:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:29 INFO - Downloading/unpacking psutil>=3.1.1 05:52:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:52:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:52:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:52:31 INFO - Installing collected packages: psutil 05:52:31 INFO - Running setup.py install for psutil 05:52:31 INFO - building 'psutil._psutil_linux' extension 05:52:31 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 05:52:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:52:32 INFO - building 'psutil._psutil_posix' extension 05:52:32 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:52:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:52:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:52:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:52:32 INFO - Successfully installed psutil 05:52:32 INFO - Cleaning up... 05:52:32 INFO - Return code: 0 05:52:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:52:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b1f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d4e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddd570>, '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 0x1dde470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dde900>, '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': '8887e36bb8e381bfd44124ac000001a8-1477657316.358043-1239426292', '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 05:52:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:52:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:52:32 INFO - Using env: {'DISPLAY': ':0', 05:52:32 INFO - 'HOME': '/home/cltbld', 05:52:32 INFO - 'LANG': 'en_US.UTF-8', 05:52:32 INFO - 'LANGUAGE': 'en_US:en', 05:52:32 INFO - 'LOGNAME': 'cltbld', 05:52:32 INFO - 'MAIL': '/var/mail/cltbld', 05:52:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:32 INFO - 'MOZ_NO_REMOTE': '1', 05:52:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:32 INFO - 'NO_EM_RESTART': '1', 05:52:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:32 INFO - 'PWD': '/builds/slave/test', 05:52:32 INFO - 'SHELL': '/bin/bash', 05:52:32 INFO - 'SHLVL': '1', 05:52:32 INFO - 'TERM': 'linux', 05:52:32 INFO - 'TMOUT': '86400', 05:52:32 INFO - 'USER': 'cltbld', 05:52:32 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1477657316.358043-1239426292', 05:52:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:32 INFO - '_': '/tools/buildbot/bin/python'} 05:52:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:52:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:52:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:52:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:52:35 INFO - Installing collected packages: mozsystemmonitor 05:52:35 INFO - Running setup.py install for mozsystemmonitor 05:52:35 INFO - Successfully installed mozsystemmonitor 05:52:35 INFO - Cleaning up... 05:52:35 INFO - Return code: 0 05:52:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:52:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1b1f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d4e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddd570>, '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 0x1dde470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dde900>, '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': '8887e36bb8e381bfd44124ac000001a8-1477657316.358043-1239426292', '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 05:52:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:52:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:52:35 INFO - Using env: {'DISPLAY': ':0', 05:52:35 INFO - 'HOME': '/home/cltbld', 05:52:35 INFO - 'LANG': 'en_US.UTF-8', 05:52:35 INFO - 'LANGUAGE': 'en_US:en', 05:52:35 INFO - 'LOGNAME': 'cltbld', 05:52:35 INFO - 'MAIL': '/var/mail/cltbld', 05:52:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:35 INFO - 'MOZ_NO_REMOTE': '1', 05:52:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:35 INFO - 'NO_EM_RESTART': '1', 05:52:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:35 INFO - 'PWD': '/builds/slave/test', 05:52:35 INFO - 'SHELL': '/bin/bash', 05:52:35 INFO - 'SHLVL': '1', 05:52:35 INFO - 'TERM': 'linux', 05:52:35 INFO - 'TMOUT': '86400', 05:52:35 INFO - 'USER': 'cltbld', 05:52:35 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1477657316.358043-1239426292', 05:52:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:35 INFO - '_': '/tools/buildbot/bin/python'} 05:52:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:35 INFO - Downloading/unpacking jsonschema==2.5.1 05:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:52:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:52:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:37 INFO - Downloading functools32-3.2.3-2.tar.gz 05:52:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:52:38 INFO - warning: no files found matching '*.txt' 05:52:38 INFO - no previously-included directories found matching 'build' 05:52:38 INFO - no previously-included directories found matching 'dist' 05:52:38 INFO - no previously-included directories found matching '.git*' 05:52:38 INFO - Installing collected packages: jsonschema, functools32 05:52:38 INFO - Running setup.py install for functools32 05:52:38 INFO - warning: no files found matching '*.txt' 05:52:38 INFO - no previously-included directories found matching 'build' 05:52:38 INFO - no previously-included directories found matching 'dist' 05:52:38 INFO - no previously-included directories found matching '.git*' 05:52:38 INFO - Successfully installed jsonschema functools32 05:52:38 INFO - Cleaning up... 05:52:38 INFO - Return code: 0 05:52:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:52:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:38 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 0x1b1f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d4e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddd570>, '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 0x1dde470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dde900>, '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': '8887e36bb8e381bfd44124ac000001a8-1477657316.358043-1239426292', '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 05:52:38 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 05:52:38 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 05:52:38 INFO - Using env: {'DISPLAY': ':0', 05:52:38 INFO - 'HOME': '/home/cltbld', 05:52:38 INFO - 'LANG': 'en_US.UTF-8', 05:52:38 INFO - 'LANGUAGE': 'en_US:en', 05:52:38 INFO - 'LOGNAME': 'cltbld', 05:52:38 INFO - 'MAIL': '/var/mail/cltbld', 05:52:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:38 INFO - 'MOZ_NO_REMOTE': '1', 05:52:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:38 INFO - 'NO_EM_RESTART': '1', 05:52:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:38 INFO - 'PWD': '/builds/slave/test', 05:52:38 INFO - 'SHELL': '/bin/bash', 05:52:38 INFO - 'SHLVL': '1', 05:52:38 INFO - 'TERM': 'linux', 05:52:38 INFO - 'TMOUT': '86400', 05:52:38 INFO - 'USER': 'cltbld', 05:52:38 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1477657316.358043-1239426292', 05:52:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:38 INFO - '_': '/tools/buildbot/bin/python'} 05:52:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:52:38 INFO - Cleaning up... 05:52:38 INFO - Return code: 0 05:52:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:52:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:38 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 0x1b1f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d4e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddd570>, '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 0x1dde470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dde900>, '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': '8887e36bb8e381bfd44124ac000001a8-1477657316.358043-1239426292', '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 05:52:38 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 05:52:38 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 05:52:38 INFO - Using env: {'DISPLAY': ':0', 05:52:38 INFO - 'HOME': '/home/cltbld', 05:52:38 INFO - 'LANG': 'en_US.UTF-8', 05:52:38 INFO - 'LANGUAGE': 'en_US:en', 05:52:38 INFO - 'LOGNAME': 'cltbld', 05:52:38 INFO - 'MAIL': '/var/mail/cltbld', 05:52:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:38 INFO - 'MOZ_NO_REMOTE': '1', 05:52:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:38 INFO - 'NO_EM_RESTART': '1', 05:52:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:38 INFO - 'PWD': '/builds/slave/test', 05:52:38 INFO - 'SHELL': '/bin/bash', 05:52:38 INFO - 'SHLVL': '1', 05:52:38 INFO - 'TERM': 'linux', 05:52:38 INFO - 'TMOUT': '86400', 05:52:38 INFO - 'USER': 'cltbld', 05:52:38 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1477657316.358043-1239426292', 05:52:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:38 INFO - '_': '/tools/buildbot/bin/python'} 05:52:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:38 INFO - Downloading/unpacking blobuploader==1.2.4 05:52:38 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 05:52:38 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 05:52:38 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 05:52:38 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 05:52:38 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 05:52:38 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 05:52:40 INFO - Downloading blobuploader-1.2.4.tar.gz 05:52:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:52:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:52:40 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 05:52:40 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 05:52:40 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 05:52:40 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 05:52:40 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 05:52:40 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 05:52:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:52:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:52:41 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 05:52:41 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 05:52:41 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 05:52:41 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 05:52:41 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 05:52:41 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 05:52:41 INFO - Downloading docopt-0.6.1.tar.gz 05:52:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:52:41 INFO - Installing collected packages: blobuploader, requests, docopt 05:52:41 INFO - Running setup.py install for blobuploader 05:52:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:52:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:52:41 INFO - Running setup.py install for requests 05:52:41 INFO - Running setup.py install for docopt 05:52:41 INFO - Successfully installed blobuploader requests docopt 05:52:41 INFO - Cleaning up... 05:52:42 INFO - Return code: 0 05:52:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:52: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')]} 05:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52: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')]} 05:52:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:42 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 0x1b1f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d4e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddd570>, '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 0x1dde470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dde900>, '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': '8887e36bb8e381bfd44124ac000001a8-1477657316.358043-1239426292', '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 05:52:42 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 05:52:42 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 05:52:42 INFO - Using env: {'DISPLAY': ':0', 05:52:42 INFO - 'HOME': '/home/cltbld', 05:52:42 INFO - 'LANG': 'en_US.UTF-8', 05:52:42 INFO - 'LANGUAGE': 'en_US:en', 05:52:42 INFO - 'LOGNAME': 'cltbld', 05:52:42 INFO - 'MAIL': '/var/mail/cltbld', 05:52:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:42 INFO - 'MOZ_NO_REMOTE': '1', 05:52:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:42 INFO - 'NO_EM_RESTART': '1', 05:52:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:42 INFO - 'PWD': '/builds/slave/test', 05:52:42 INFO - 'SHELL': '/bin/bash', 05:52:42 INFO - 'SHLVL': '1', 05:52:42 INFO - 'TERM': 'linux', 05:52:42 INFO - 'TMOUT': '86400', 05:52:42 INFO - 'USER': 'cltbld', 05:52:42 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1477657316.358043-1239426292', 05:52:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:42 INFO - '_': '/tools/buildbot/bin/python'} 05:52:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:52:42 INFO - Running setup.py (path:/tmp/pip-1eT9zP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:52:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:52:42 INFO - Running setup.py (path:/tmp/pip-pKvR2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:52:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:52:42 INFO - Running setup.py (path:/tmp/pip-LTpQQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:52:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:52:42 INFO - Running setup.py (path:/tmp/pip-oQppAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:52:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:52:42 INFO - Running setup.py (path:/tmp/pip-VzUBpx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:52:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:52:42 INFO - Running setup.py (path:/tmp/pip-01sqwk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:52:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:52:42 INFO - Running setup.py (path:/tmp/pip-hDMbLH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:52:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:52:42 INFO - Running setup.py (path:/tmp/pip-5wQWF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:52:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:52:42 INFO - Running setup.py (path:/tmp/pip-Ib6hlk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:52:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:52:42 INFO - Running setup.py (path:/tmp/pip-K5vsql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:52:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:52:42 INFO - Running setup.py (path:/tmp/pip-lXATcE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:52:43 INFO - Running setup.py (path:/tmp/pip-bB238i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:52:43 INFO - Running setup.py (path:/tmp/pip-EKFEuH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:52:43 INFO - Running setup.py (path:/tmp/pip-wz_ZMq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:52:43 INFO - Running setup.py (path:/tmp/pip-1PcvDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:52:43 INFO - Running setup.py (path:/tmp/pip-Do6oP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:52:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:52:43 INFO - Running setup.py (path:/tmp/pip-3opXHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:52:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:52:43 INFO - Running setup.py install for manifestparser 05:52:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:52:43 INFO - Running setup.py install for mozcrash 05:52:43 INFO - Running setup.py install for mozdebug 05:52:43 INFO - Running setup.py install for mozdevice 05:52:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:52:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:52:43 INFO - Running setup.py install for mozfile 05:52:43 INFO - Running setup.py install for mozhttpd 05:52:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:52:44 INFO - Running setup.py install for mozinfo 05:52:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:52:44 INFO - Running setup.py install for mozInstall 05:52:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:52:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:52:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:52:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:52:44 INFO - Running setup.py install for mozleak 05:52:44 INFO - Running setup.py install for mozlog 05:52:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:52:44 INFO - Running setup.py install for moznetwork 05:52:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:52:44 INFO - Running setup.py install for mozprocess 05:52:44 INFO - Running setup.py install for mozprofile 05:52:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:52:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:52:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:52:44 INFO - Running setup.py install for mozrunner 05:52:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:52:44 INFO - Running setup.py install for mozscreenshot 05:52:45 INFO - Running setup.py install for moztest 05:52:45 INFO - Running setup.py install for mozversion 05:52:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:52:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:52:45 INFO - Cleaning up... 05:52:45 INFO - Return code: 0 05:52:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:52:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:45 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 0x1b1f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d4e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddd570>, '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 0x1dde470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dde900>, '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': '8887e36bb8e381bfd44124ac000001a8-1477657316.358043-1239426292', '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 05:52:45 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 05:52:45 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 05:52:45 INFO - Using env: {'DISPLAY': ':0', 05:52:45 INFO - 'HOME': '/home/cltbld', 05:52:45 INFO - 'LANG': 'en_US.UTF-8', 05:52:45 INFO - 'LANGUAGE': 'en_US:en', 05:52:45 INFO - 'LOGNAME': 'cltbld', 05:52:45 INFO - 'MAIL': '/var/mail/cltbld', 05:52:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:45 INFO - 'MOZ_NO_REMOTE': '1', 05:52:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:45 INFO - 'NO_EM_RESTART': '1', 05:52:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:45 INFO - 'PWD': '/builds/slave/test', 05:52:45 INFO - 'SHELL': '/bin/bash', 05:52:45 INFO - 'SHLVL': '1', 05:52:45 INFO - 'TERM': 'linux', 05:52:45 INFO - 'TMOUT': '86400', 05:52:45 INFO - 'USER': 'cltbld', 05:52:45 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1477657316.358043-1239426292', 05:52:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:45 INFO - '_': '/tools/buildbot/bin/python'} 05:52:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:52:45 INFO - Running setup.py (path:/tmp/pip-JPJ5Og-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:52:45 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)) 05:52:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:52:45 INFO - Running setup.py (path:/tmp/pip-ZI8CIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:52:45 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)) 05:52:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:52:45 INFO - Running setup.py (path:/tmp/pip-8p2Ed4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:52:45 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)) 05:52:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:52:45 INFO - Running setup.py (path:/tmp/pip-tD_nGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:52:45 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)) 05:52:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:52:45 INFO - Running setup.py (path:/tmp/pip-X2XPme-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:52:45 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)) 05:52:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:52:45 INFO - Running setup.py (path:/tmp/pip-DEfMBZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:52:45 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)) 05:52:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:52:45 INFO - Running setup.py (path:/tmp/pip-APgMyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:52:46 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)) 05:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:52:46 INFO - Running setup.py (path:/tmp/pip-3ft81a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:52:46 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)) 05:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:52:46 INFO - Running setup.py (path:/tmp/pip-_DbhDA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:52:46 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)) 05:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:52:46 INFO - Running setup.py (path:/tmp/pip-9ek66W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:52:46 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)) 05:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:52:46 INFO - Running setup.py (path:/tmp/pip-AUz2LH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:52:46 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)) 05:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:52:46 INFO - Running setup.py (path:/tmp/pip-bCubcZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:52:46 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)) 05:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:52:46 INFO - Running setup.py (path:/tmp/pip-gYh8uo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:52:46 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)) 05:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:52:46 INFO - Running setup.py (path:/tmp/pip-YDEcII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:52:46 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)) 05:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:52:46 INFO - Running setup.py (path:/tmp/pip-7fZbiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:52:46 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)) 05:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:52:46 INFO - Running setup.py (path:/tmp/pip-VEdqbP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:52:46 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)) 05:52:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:52:46 INFO - Running setup.py (path:/tmp/pip-RM903n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:52:46 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)) 05:52:46 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)) 05:52:46 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)) 05:52:46 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)) 05:52:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:52:46 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)) 05:52:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:52:46 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 05:52:46 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 05:52:46 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 05:52:46 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 05:52:46 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 05:52:46 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 05:52:48 INFO - Downloading blessings-1.6.tar.gz 05:52:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:52:48 INFO - Installing collected packages: blessings 05:52:48 INFO - Running setup.py install for blessings 05:52:48 INFO - Successfully installed blessings 05:52:48 INFO - Cleaning up... 05:52:48 INFO - Return code: 0 05:52:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:52:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:52:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:52:49 INFO - Reading from file tmpfile_stdout 05:52:49 INFO - Current package versions: 05:52:49 INFO - argparse == 1.2.1 05:52:49 INFO - blessings == 1.6 05:52:49 INFO - blobuploader == 1.2.4 05:52:49 INFO - docopt == 0.6.1 05:52:49 INFO - functools32 == 3.2.3-2 05:52:49 INFO - jsonschema == 2.5.1 05:52:49 INFO - manifestparser == 1.1 05:52:49 INFO - mozInstall == 1.12 05:52:49 INFO - mozcrash == 0.17 05:52:49 INFO - mozdebug == 0.1 05:52:49 INFO - mozdevice == 0.48 05:52:49 INFO - mozfile == 1.2 05:52:49 INFO - mozhttpd == 0.7 05:52:49 INFO - mozinfo == 0.9 05:52:49 INFO - mozleak == 0.1 05:52:49 INFO - mozlog == 3.3 05:52:49 INFO - moznetwork == 0.27 05:52:49 INFO - mozprocess == 0.23 05:52:49 INFO - mozprofile == 0.28 05:52:49 INFO - mozrunner == 6.12 05:52:49 INFO - mozscreenshot == 0.1 05:52:49 INFO - mozsystemmonitor == 0.3 05:52:49 INFO - moztest == 0.7 05:52:49 INFO - mozversion == 1.4 05:52:49 INFO - psutil == 3.1.1 05:52:49 INFO - requests == 1.2.3 05:52:49 INFO - wsgiref == 0.1.2 05:52:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:52:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:49 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 0x1b1f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d4e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddd570>, '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 0x1dde470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dde900>, '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': '8887e36bb8e381bfd44124ac000001a8-1477657316.358043-1239426292', '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 05:52:49 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 05:52:49 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 05:52:49 INFO - Using env: {'DISPLAY': ':0', 05:52:49 INFO - 'HOME': '/home/cltbld', 05:52:49 INFO - 'LANG': 'en_US.UTF-8', 05:52:49 INFO - 'LANGUAGE': 'en_US:en', 05:52:49 INFO - 'LOGNAME': 'cltbld', 05:52:49 INFO - 'MAIL': '/var/mail/cltbld', 05:52:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:49 INFO - 'MOZ_NO_REMOTE': '1', 05:52:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:49 INFO - 'NO_EM_RESTART': '1', 05:52:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:49 INFO - 'PWD': '/builds/slave/test', 05:52:49 INFO - 'SHELL': '/bin/bash', 05:52:49 INFO - 'SHLVL': '1', 05:52:49 INFO - 'TERM': 'linux', 05:52:49 INFO - 'TMOUT': '86400', 05:52:49 INFO - 'USER': 'cltbld', 05:52:49 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1477657316.358043-1239426292', 05:52:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:49 INFO - '_': '/tools/buildbot/bin/python'} 05:52:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:49 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)) 05:52:49 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)) 05:52:49 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)) 05:52:49 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)) 05:52:49 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)) 05:52:49 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)) 05:52:49 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)) 05:52:49 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)) 05:52:49 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)) 05:52:49 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)) 05:52:49 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)) 05:52:49 INFO - Cleaning up... 05:52:49 INFO - Return code: 0 05:52:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:52:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:49 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 0x1b1f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d4e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ddd570>, '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 0x1dde470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dde900>, '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': '8887e36bb8e381bfd44124ac000001a8-1477657316.358043-1239426292', '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 05:52:49 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 05:52:49 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 05:52:49 INFO - Using env: {'DISPLAY': ':0', 05:52:49 INFO - 'HOME': '/home/cltbld', 05:52:49 INFO - 'LANG': 'en_US.UTF-8', 05:52:49 INFO - 'LANGUAGE': 'en_US:en', 05:52:49 INFO - 'LOGNAME': 'cltbld', 05:52:49 INFO - 'MAIL': '/var/mail/cltbld', 05:52:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:49 INFO - 'MOZ_NO_REMOTE': '1', 05:52:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:49 INFO - 'NO_EM_RESTART': '1', 05:52:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:49 INFO - 'PWD': '/builds/slave/test', 05:52:49 INFO - 'SHELL': '/bin/bash', 05:52:49 INFO - 'SHLVL': '1', 05:52:49 INFO - 'TERM': 'linux', 05:52:49 INFO - 'TMOUT': '86400', 05:52:49 INFO - 'USER': 'cltbld', 05:52:49 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1477657316.358043-1239426292', 05:52:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:49 INFO - '_': '/tools/buildbot/bin/python'} 05:52:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:52:49 INFO - Cleaning up... 05:52:49 INFO - Return code: 0 05:52:49 INFO - Running post-action listener: _resource_record_post_action 05:52:49 INFO - Running post-action listener: _start_resource_monitoring 05:52:49 INFO - Starting resource monitoring. 05:52:49 INFO - [mozharness: 2016-10-28 12:52:49.568698Z] Finished create-virtualenv step (success) 05:52:49 INFO - [mozharness: 2016-10-28 12:52:49.569235Z] Running install step. 05:52:49 INFO - Running pre-action listener: _resource_record_pre_action 05:52:49 INFO - Running main action method: install 05:52:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:52:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:52:49 INFO - Reading from file tmpfile_stdout 05:52:49 INFO - Detecting whether we're running mozinstall >=1.0... 05:52:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:52:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:52:49 INFO - Reading from file tmpfile_stdout 05:52:49 INFO - Output received: 05:52:49 INFO - Usage: mozinstall [options] installer 05:52:49 INFO - Options: 05:52:49 INFO - -h, --help show this help message and exit 05:52:49 INFO - -d DEST, --destination=DEST 05:52:49 INFO - Directory to install application into. [default: 05:52:49 INFO - "/builds/slave/test"] 05:52:49 INFO - --app=APP Application being installed. [default: firefox] 05:52:49 INFO - mkdir: /builds/slave/test/build/application 05:52:49 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'] 05:52:49 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 05:53:03 INFO - Reading from file tmpfile_stdout 05:53:03 INFO - Output received: 05:53:03 INFO - /builds/slave/test/build/application/firefox/firefox 05:53:03 INFO - Running post-action listener: _resource_record_post_action 05:53:03 INFO - [mozharness: 2016-10-28 12:53:03.360882Z] Finished install step (success) 05:53:03 INFO - [mozharness: 2016-10-28 12:53:03.361210Z] Running run-tests step. 05:53:03 INFO - Running pre-action listener: _resource_record_pre_action 05:53:03 INFO - Running main action method: run_tests 05:53:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:53:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:53:03 INFO - Python 2.7.3 05:53:03 INFO - Return code: 0 05:53:03 INFO - grabbing minidump binary from tooltool 05:53: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')]} 05:53:03 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 0x1ddd570>, '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 0x1dde470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dde900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:53:03 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 05:53:03 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 05:53:03 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 05:53:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:53:03 INFO - Return code: 0 05:53:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:53:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:53:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:53:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:53:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:53:03 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/RU1Cm5eRQ6O5_NyMtPfNCQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 05:53:03 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/RU1Cm5eRQ6O5_NyMtPfNCQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --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 05:53:03 INFO - Using env: {'DISPLAY': ':0', 05:53:03 INFO - 'HOME': '/home/cltbld', 05:53:03 INFO - 'LANG': 'en_US.UTF-8', 05:53:03 INFO - 'LANGUAGE': 'en_US:en', 05:53:03 INFO - 'LOGNAME': 'cltbld', 05:53:03 INFO - 'MAIL': '/var/mail/cltbld', 05:53:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:53:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:53:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:03 INFO - 'MOZ_NO_REMOTE': '1', 05:53:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:53:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:03 INFO - 'NO_EM_RESTART': '1', 05:53:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:03 INFO - 'PWD': '/builds/slave/test', 05:53:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:53:03 INFO - 'SHELL': '/bin/bash', 05:53:03 INFO - 'SHLVL': '1', 05:53:03 INFO - 'TERM': 'linux', 05:53:03 INFO - 'TMOUT': '86400', 05:53:03 INFO - 'USER': 'cltbld', 05:53:03 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1477657316.358043-1239426292', 05:53:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:03 INFO - '_': '/tools/buildbot/bin/python'} 05:53:03 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/RU1Cm5eRQ6O5_NyMtPfNCQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 05:53:03 INFO - mozversion application_buildid: 20161028030558 05:53:03 INFO - mozversion application_changeset: 33be6bf8174cd5da272260bcf76a3b7e060ba620 05:53:03 INFO - mozversion application_display_name: Firefox 05:53:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:53:03 INFO - mozversion application_name: Firefox 05:53:03 INFO - mozversion application_remotingname: firefox 05:53:03 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 05:53:03 INFO - mozversion application_vendor: Mozilla 05:53:03 INFO - mozversion application_version: 50.0 05:53:03 INFO - mozversion platform_buildid: 20161028030558 05:53:03 INFO - mozversion platform_changeset: 33be6bf8174cd5da272260bcf76a3b7e060ba620 05:53:03 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 05:53:03 INFO - mozversion platform_version: 50.0 05:53:03 INFO - using testdate: 1477659183 05:53:03 INFO - actual date: 1477659183 05:53:03 INFO - starting webserver on 'localhost:36824' 05:53:03 INFO - SUITE-START | Running 2 tests 05:53:03 INFO - TEST-START | dromaeo_css 05:53:03 INFO - operating with platform_type : linux_ 05:53:03 INFO - Initialising browser for dromaeo_css test... 05:53:03 INFO - TEST-INFO | started process 27015 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaIaH_n/profile http://localhost:36824/getInfo.html) 05:53:07 INFO - PROCESS | 27015 | __metrics Screen width/height:1600/1200 05:53:08 INFO - PROCESS | 27015 | colorDepth:24 05:53:08 INFO - PROCESS | 27015 | Browser inner width/height: 1024/697 05:53:08 INFO - PROCESS | 27015 | __metrics 05:53:08 ERROR - PROCESS | 27015 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 05:53:09 INFO - TEST-INFO | 27015: exit 0 05:53:09 INFO - Browser initialized. 05:53:09 INFO - Running cycle 1/1 for dromaeo_css test... 05:53:09 INFO - TEST-INFO | started process 27140 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaIaH_n/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:53:21 INFO - PROCESS | 27140 | RSS: Main: 150044672 05:53:21 INFO - PROCESS | 27140 | 05:54:10 INFO - PROCESS | 27140 | 1477659250920 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] 05:56:19 INFO - PROCESS | 27140 | Cycle 1(1): loaded http://localhost:36824/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36824/tests/dromaeo/cssquery-ext.html) 05:56:20 INFO - PROCESS | 27140 | RSS: Main: 158830592 05:56:20 INFO - PROCESS | 27140 | 05:59:22 INFO - PROCESS | 27140 | Cycle 1(1): loaded http://localhost:36824/tests/dromaeo/cssquery-ext.html (next: http://localhost:36824/tests/dromaeo/cssquery-jquery.html) 05:59:22 INFO - PROCESS | 27140 | RSS: Main: 155512832 05:59:22 INFO - PROCESS | 27140 | 06:02:24 INFO - PROCESS | 27140 | Cycle 1(1): loaded http://localhost:36824/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36824/tests/dromaeo/cssquery-mootools.html) 06:02:25 INFO - PROCESS | 27140 | RSS: Main: 155062272 06:02:25 INFO - PROCESS | 27140 | 06:05:26 INFO - PROCESS | 27140 | Cycle 1(1): loaded http://localhost:36824/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36824/tests/dromaeo/cssquery-prototype.html) 06:05:27 INFO - PROCESS | 27140 | RSS: Main: 156385280 06:05:27 INFO - PROCESS | 27140 | 06:08:29 INFO - PROCESS | 27140 | Cycle 1(1): loaded http://localhost:36824/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36824/tests/dromaeo/cssquery-yui.html) 06:08:30 INFO - PROCESS | 27140 | RSS: Main: 157573120 06:08:30 INFO - PROCESS | 27140 | 06:11:32 INFO - PROCESS | 27140 | Cycle 1(1): loaded http://localhost:36824/tests/dromaeo/cssquery-yui.html (next: http://localhost:36824/tests/dromaeo/cssquery-dojo.html) 06:11:33 INFO - PROCESS | 27140 | RSS: Main: 157417472 06:11:33 INFO - PROCESS | 27140 | 06:11:33 INFO - PROCESS | 27140 | __start_tp_report 06:11:33 INFO - PROCESS | 27140 | _x_x_mozilla_page_load 06:11:33 INFO - PROCESS | 27140 | _x_x_mozilla_page_load_details 06:11:33 INFO - PROCESS | 27140 | |i|pagename|runs| 06:11:33 INFO - PROCESS | 27140 | |0;dojo.html;3283.6880496352846;3296.8846090386833;3301.141703157178;3329.5338652588625;3329.816860072695;5749.511291540219;5817.127430885369;5827.41725827417;5842.415758424166;5848.795292164775;5758.683272420015;5817.301923769143;5821.970890145554;5822.243108395914;5851.3270973838025;5187.844364669057;5265.684058956455;5291.126964050946;5293.841184764463;5307.628466007381;5283.867903302429;5297.814576489824;5310.468953104678;5321.6540924839765;5346.946530534684;5116.974415127937;5170.09523333417;5329.7601607927545;5334.946650533503;5336.733163341817;5242.370915490146;5323.574114070865;5331.946680533184;5342.465753424665;5368.516833484966;5220.347456567929;5276.551493123089;5305.204219367087;5307.3896501902;5308.071087559701;5583.664980101207;5626.127950167731;5725.456081672234;5777.075667893159;5840.328362238354;6049.5462840287155;6200.596961197508;6204.255489341263;6205.906911396332;6220.595661282002;6246.781362652331;6250.96874515629;6251.843703907393;6268.937310626881;6269.0909818076125;5572.801847602745;5684.976704193285;5799.101139323411;5830.650160990312;5861.677607731573;6166.753329866845;6257.468115210167;6263.874722505616;6269.498440124779;6295.338989406138;6035.36628653985;6060.090986352083;6084.847878802977;6090.543209259324;6092.847678807977;6016.939830601726;6062.090686396988;6122.326544080148;6188.659623720739;6191.318954914956;6069.635821850703;6176.474999625082;6188.319284878659;6188.319284878659;6196.411340922605;6150.415710507495;6157.599756015845;6187.319394866561;6193.102000210034;6194.34959329273;4616.722996620147;4651.209294419889;4720.787564559603;4722.976385118052;4727.64542659302;4139.172165566899;4205.642520385802;4222.767747773902;4223.472065991751;4245.087306229176;5917.615355001911;5991.041433370639;6027.276726792726;6044.879102418015;6111.724972376165;6163.537734669918;6211.0372892201785;6244.110623064887;6263.655498947602;6275.748970041147;5955.76176952917;5957.314908785545;5981.880362392728;5991.64050156992;6052.364501727343;5303;5354.089804733205;5364.678119312775;5387.191921211849;5388.38033626138;6224.937750622526;6330.208723909512;6331.271903731038;6542.771003014872;6546.70539825709;6206.255249370104;6212.751489940351;6216.285127210429;6221.813345599639;6229.844253893508;6386.93613063882;6489.837754056186;6497.122888410004;6497.382748638872;6497.675116244074;5926.140709597171;6071.696415179312;6093.451589356979;6096.420840020191;6098.5426093042315;6280.5289603279025;6281.246250449975;6282.183316168869;6282.528810339151;6301.6219026858535;6107.633541987495;6133.509319254538;6149.661768602769;6165.32181460048;6167.537434692326;5872.383399742966;5957.344692083954;6009.819705408845;6142.109394137914;6142.754289828356;5972.402759723993;6007.429294217042;6008.128821320972;6018.488428483628;6025.939740602538;6091.7258723358445;6113.5414843887775;6135.877282454415;6143.477804386677;6161.784337548164;5800.100984347433;5849.239598852122;5938.61399009063;5954.255718035246;5970.552208584287 06:11:33 INFO - PROCESS | 27140 | |1;ext.html;585.4935480809098;614.198470995351;651.0884761334133;659.1299484680221;712.2734810493293;40923;45561.772191138996;45590.08819823606;45605.08789824202;45824.77087614557;45541.31688024674;46031.07937841241;46074.30888536666;46163;46229.30656040162;9088.863667045;9240.630374785034;9242.075792420737;9242.815143697122;9243.029481904405;9216.400933939307;9356.953215233949;9357.064293570622;9361.953190234039;9365.34442589019;9324.347295689304;9354.391964522318;9365.85951210729;9371.484568348773;9384.108509691569;9189.264858811279;9207.539623018822;9207.953960230223;9234.39976401535;9249.815003699921;9118.224950879183;9209.125133112411;9211.539423028822;9256.074392560757;9290.1174388433;43074;43647.56352436467;43789;43842;43883.341749873776;3604.189057462076;3718.6839118674943;3799.67702745267;3868.3423817951016;3973.1259122992897;33749;34343;34527.654723452695;34548.30903381943;35068.29863402743;4689.366935463703;4789;4798.928016079762;4814.470408255089;4926.3842019747535;349518;353416;353619;355083.99999999744;355459;60677;60997;61153.38846611477;61221.38778612246;61414;39447.60552394497;40057.39913901294;40239.39640905389;42123.368149477785;42146.78926605409;15789.052656840397;15800.130992795277;15884.92057539728;15910.602234943988;15912.443064492687;13054.282014489294;13182.934085329704;13183.736325273441;13194.934025329812;13211.207327560378;20552.897235513727;20557.383278501668;20639.380818575468;20765.377038688865;20888.686669699968;7632.236776322324;7648.770536883902;7766.5728384939375;7857.371410287164;7860.489068210548;1034.177828626244;1055.0873494427265;1061.2147011211648;1107.4186052322596;1173.4191575170346;33065.834670826494;33465.33069338599;33919;34172.14569635779;34775.82612086974;1144.3420033480616;1168.2698313554029;1175.1949914308725;1225.2587184753274;1230.8584512780965;17056.57358566046;17736.211222969727;17841.7323740144;17853.375131870584;17952.820471795116;566679;567605;570058;570683;603106;63606.6819665908;63916;64300.03549946754;64324;64425.355746442874;1344.9529266475627;1356.0643156222175;1359.3475131936725;1371.766799644063;1401.1593044173414;32501;33053;33469.83265083659;33654.663453366134;34252.657473424944;55473.1679024823;56082;56109.71945140248;56160;56261;493218;500128;501098;501109;509347;30371.392572148874;31618.841905790323;31678.683213168497;31680.683193167773;31694.366112677155;51460.485395145566;52116.47883521268;52420.47579524156;53179.468205319;53738.46261537335;43847.34228986631;43904.56095439005;44116.11767764563;44733.55266447294;45675.771621141685;44208.16285799923;45312.77343613261;45408;46451.53548464472;46855.062898741155;37489.81255093707;41523;43675.56324436842;44998;45705;38402.42396364001;38715.41926871156;39761;41251.793741031106;41808.79095604503;30148.84925575446;30348;30698.539521906743;30859.691403085682;31256 06:11:33 INFO - PROCESS | 27140 | |2;jquery.html;409.64974946420807;412.24353311673076;428.1373033337824;429.8517011630987;443.58081612875844;19207.42377728667;20628.278010269623;20688.48278793031;21218.15127394906;21813.345599631997;19864;20271.898640506814;20502.589948201028;20671.173153073898;20741.688874666892;5810.099434587624;5987.371326010772;6007.128966299906;6036.3360030396625;6046.39536046394;5894.941050589482;5926.674032928187;5937.050071988483;5943.851403714899;6034.185384973016;5779.768809247625;5875.941240587582;5880.764769409218;5884.588078834483;5886.381929897363;5797.652140871519;5839.8540036499;5860.794872179475;5865.501432378253;5873.412658734135;5398.64908780928;5418.783248670048;5418.83743487696;5424.0779067558215;5433.022056029913;23529.294121176394;24338.756612434005;24631.87684061586;24877.253682389557;24880.751192488206;2413.5776239158254;2494.102123235634;2644.9867750661124;2654.21700598322;2985.7163569460868;9922.603095876157;9933.205343572497;10207.795844083152;10241.948790256076;15348.232588370536;2036.979630203694;2047.9795202047937;2056.629806634805;2085.9478513037143;2116.5237821490196;87290.56354718185;89701.55149224213;90376.99999999935;90734.54632726795;91586;11550.537978480766;11661.766764664659;11961.162718609614;11997.280163190237;12039.75920481603;17086.48740537786;17142.742858857127;17144.39994600183;17145.742813857803;17158.914205429144;8371.372147088992;8508.489490630458;8533.829323413496;8572.571371431404;8651.178138076873;8030.959845200737;8170.714025009096;8189.79525511867;8309.709160179365;8329.50022998622;4416.116776644684;4495.955040449554;4512.887177820515;4813.109574728686;5011.323471331397;2085.8227050700557;2124.9256276030264;2160.5030842905903;2167.5881582499273;2232.7097477327843;1029.4492446541065;1055.6621880998007;1056.1497994114657;1089.5587287148717;1104.9392283424488;18840;20028.59942801136;21030.684539731916;21322.893385532974;21432.142714291567;1036.2073014144187;1047.3035431438161;1066.2855886556026;1080.6109800471825;1093.7703082352637;11196.776064478665;11717.707057323634;11745;11775.705607359885;11805.40972951349;530252;534828;540962;559695;561551;62215.68892155601;94869.5256523713;103795.48102259441;105886;106144.46927765312;1042.5725452564411;1075.7687097274124;1080.2654195147375;1096.873859506167;1104.679642903549;16135.435259766322;18758.249670013047;18928.526786829887;18969.620607588047;19195.520111997314;32424.189395264362;43277.783611081744;45425.31862022006;45931.77034114808;46032.309515356625;56958.14562781479;58146;58449.5387615313;64829;66062.33937660755;8349.206825351583;8516.574171291286;8522.318214542945;8550.82898342042;8689.782755431164;12429.316387598768;14171.362288697239;14324.713505730035;14479.348429320495;14549;12552.74894502123;12747.107702460738;12785.680357991125;12861.228326300452;13042.739145217232;8105.959470202612;8370.623321950405;8488.40581159313;8526.104759000464;8580.785480363042;8428.199321064489;8453.239208471266;8567.271781898358;8702.738917832476;8869.068747781648;13331.133476324008;14010;14055.22696251716;14065;14137.787933180805;12997.350132493148;13199.142055766344;13363.331833408096;13423.530176443777;13427.26150061756 06:11:33 INFO - PROCESS | 27140 | |3;mootools.html;1504.4659146003169;1546.9690606187876;1678.2699525706319;1827.661882551728;1835.7797064352262;7969.442139050268;8715.477071375723;8747.781305467366;9371.531423428836;9403.435793852374;8780.078091800366;8946.91053089469;8976.73069807905;9045.231155351787;9045.63817447303;2399.6400539919023;2426.9757302427015;2427.8786060696984;2430.902763889442;2444.6210837320245;2423.9394015149674;2443.657887895696;2477.318737347235;2479.801615870735;2484.5776218042884;2403.2189538400003;2407.037185125946;2433.756624337561;2455.7175924768703;2456.508698260346;2374.643803429482;2381.797547208481;2385.0936644075227;2410.879456027209;2438.1588352018525;2378.607529757588;2380.666706661069;2389.4504264019374;2391.2826152154457;2393;9009.954950225272;9060.864087038699;9146.085391460867;9152.405093668891;9165.587548560265;5278.604104692164;5368.489993450616;5409.783608655649;5419.105847535152;5431.402545719968;3435.209901722593;3527.4708793680898;3595.442706380515;3599;3601.1537288737127;1160.2864238493266;1165.74936388676;1171.543098191706;1197.784398808214;1218;13097.803532947013;13124.606261812161;13140.934295328558;13153.473861045642;13160.736785264242;4425.402570652985;4646.3727396801;4685.086408150378;4710.387649605529;4749.548792864673;10735.087517560938;10815.242932994772;10848.132149428027;10889.401082940356;10895;5437.130059190589;5449.482299181572;5475;5485.040117979338;5490.066688662937;4410.3825464435;4861.513848615181;4979.153543897546;5007.749612519359;5022.899542009212;4188.539260681323;4210.012112632563;4272.230998420314;4292.678049146327;4305.225059489259;1334.9132306400054;1348.730253949214;1357.151780137414;1359.3814814259488;1375.3535838156051;1008.510872226984;1011.3072545306342;1011.7066050845319;1016.0347669713801;1037.159900480613;5904.468597826216;6008.669523176267;6224.62652240867;6226.066090086432;6231.096491008869;441.97569133697954;444.4067170327584;452.4344569288389;453.77311344327836;455.51942700451343;4126.09225970286;4132.152908653718;4133.152703695735;4160.875173744793;4234.661227101825;11128.332300062022;11377.488013039432;11457.312561246184;11505.079593632488;11513.366764828015;10770.946145269223;10995.725106872393;11179.888201118047;11362.545498180145;11419.37193454368;8540.487570745776;8619.482831030158;8791.736247912573;8802.07578204292;8803.603837827313;6289.339619340087;6459.289478157305;6481.902771458526;6506.251781045051;6599.868002639824;10510.737231569272;10657.360558366523;10675.359478431319;10692.62575809874;10764.623238186627;10729.463526823783;10887.564497420015;10890.346579205274;10984.450777461256;11035.44822758875;7615.771526854203;7822.921770782447;7901.565413902291;8120.512769233865;8219.136990616138;9083.68207112748;9102.408343457653;9178.173964343241;9178.862317065383;9196.356255062348;7895.171007044178;8151.225633564802;8167.060788009455;8225.588720563828;8419.284360829153;8061.355091592776;8066.395020373378;8074.475159114639;8100.959495202486;8215.753527394188;7107.076080109553;7155.642217888981;7170.928290717026;7201.423886089205;7454.217307182885;5354.812581559627;5480.534154596904;5509.531689806251;5550.639208451437;5597.468240517144;5391.137418013099;5442.591805614516;5444.237806707143;5459.590530710133;5565.916511252415 06:11:33 INFO - PROCESS | 27140 | |4;prototype.html;313.8164173958236;322.6209204185082;322.8514883153749;328.34495182111687;330.743673652919;5755.338136114348;5762.683052432115;5813.709314534278;5860.619059761112;5881.647101173932;5778.248827652399;5808.273965754281;5809.3609702932645;5809.622374545652;5814.4766970972605;4406.317020861756;4408.074304396081;4425.66807489438;4426.690131690783;4429.822807087713;4207.43199668044;4323.329883868006;4396.868093957187;4449.176902273073;4454.688171827974;4333.739975601474;4353.28170851809;4359.128174365123;4364.585364390394;4385.407969924051;4356.411884395598;4370.71590346628;4387.934180987288;4411.117776444724;4413.183561041185;3754.5407757918606;3804.9809750951067;3834.405667121601;3841.8271177797064;3843.557990831034;5587.441255874421;5599.692016939067;5600.747966341483;5618.690971996539;5633.295838020247;5028.245763135523;5034.949650503485;5051.823186188466;5064.2403639454005;5066.164082926312;5836.387179346192;5995.7109221517585;6026.96986515069;6028.39716028398;6068.57519973602;4185.518665353493;4187.769672668002;4190.895227619303;4210.726302790309;4219.156168766259;6042.909356359658;6263.749450021994;6282.2147231596055;6306.211723534559;6347.3969972852965;4321.351797230378;4382.6055654991205;4387.122575484852;4393.758343291086;4400.559944005638;4437.622802061796;4441.755703436277;4443.200503795968;4450.265706158512;4492.337835001005;5033.030511997866;5132.409772876093;5171.974140129275;5188.22176673502;5201.7399130044105;6080.179175811298;6102.420270074336;6108.816735497942;6113.786017489367;6150.446459818638;1548.5276990517775;1563.5387560669403;1568.9096078225753;1570.1050401271393;1571.6542360680633;928.3640706116332;973;973.5737145082488;977.2328721953374;978.4667356290838;5239.532930779388;5240.868978275574;5250.455942239049;5255.6321057526375;5262.289590905255;5456.454354564512;5478.315210598676;5478.521139076635;5503.862403439946;5508.944910550923;4989.775460104304;5288.894222115613;5289.867753306121;5308.513616187473;5317.9202311965355;2962.415107917254;2966.688497707753;2980.478416277143;3000;3018.879244830226;5632.549396048388;5696.601237913306;5749.741261643236;5790.594658373873;5797.797077102281;5940.732667029994;6371;6447.355924239383;6450.870982580323;6454.773103279455;6474.935250647433;6507.7071531781185;6536.542442029012;6543.9345606544275;6614.86770264592;6073.30157031947;6146.569740118149;6250.812215724642;6286.622802631857;6324.905126423199;6222.439980401605;6235.438810507076;6250.562460627894;6253.499720022296;6265.185525881606;6315.242170939517;6511.479081673549;6515.641639709862;6529.8694026120165;6540.2151741789385;4324.935125973176;4386.517483076923;4396.736195828261;4407.096545208161;4415.602595766396;6226.750929962751;6268.404501572343;6333.461655759128;6376.39424254695;6439.130717353285;6132.17215675878;6132.693365331626;6139.662318572521;6151.876962460815;6207.503399727921;5955;6194;6215.254169499689;6215.502759779117;6218.595791273553;6070;6076.3012253591405;6092.664903430354;6093.141591814539;6102.542309326729;6182.227221597301;6194.659293738888;6203.31763506005;6204.844878878064;6214.8135555933395;5774.855628609318;6010.699465026643;6062.969685151723;6064.211652485325;6069.696515174312 06:11:33 INFO - PROCESS | 27140 | |5;yui.html;718.2027948976637;746.5931067568175;791.1692722641226;804.9396295277855;867.301822033263;14113;14850.702985940288;14856.480023199176;14869.405223791035;14952.476663316786;12899.742005159891;12966.157199782008;12979.545715899945;12991.480340786356;13004.804927926089;694.7741983855242;806.5563939833098;824.0688022534528;826.2027143806225;836.8368168207202;791.4578513718121;791.9999999999972;792.469045739356;792.6948124971899;793.115676021235;883.730462209026;888.6401007591903;889.7686601483596;889.915458031486;892.2282225874604;883.4037025008093;883.6597909804707;885.4642941020654;885.8671199320089;888.0098689960647;644.5874640230256;645.4610400315742;647.3849842649455;650.9121268628722;653.2846533046306;13296.800547991788;13315.067945243836;13324.467021319135;13327.400266988008;13386.330683465787;15742.9212853935;15756.606084847856;15828.366865325488;15898.046117233003;16476.42332518356;13273.668158296023;13455.865441345559;13458.663533411645;13517.932410337984;13560.728785424335;4190.958090419118;4197.244495990721;4296.462942132233;4296.484421869396;4351.390805287262;77797;78468.60765696192;78825.60587197085;88718;90360.09639903583;12824.551140710031;12854.293013884326;12894.742105158031;12909.677258068623;13187.802182967263;22875.428114297276;23183.768162318498;23334.883325583265;23337.533249335258;23430.882845585664;7977.082635496876;8293.253607175384;8329.12544182852;8609.784755381166;8769.517676527852;4984.700917944935;5250.711210883362;5260.684358938476;5275.340582427197;5403.891922161613;3961.286968345668;4099.85650502231;4103.835846566164;4106.219818234586;4112.157007813391;633.7211626884156;645.5868244323636;654.3979538824293;661.1438187547138;680.3298750730527;707.0772641702524;726.4417823767988;740.2449501508431;741.9220981796941;750.339701063061;10187.796244075225;10223.182145428347;10475.476226188812;10498.212634052477;10928.071113955244;624.6814124796296;651.664392837689;673.7843889955266;691.3017851969547;691.3570379546969;5023.723695196799;5055.368078990126;5099.464556221617;5108.438071812097;5121.743912804345;132383.33808330898;138655.30672346774;139132;140452;143202;68924;116048.41975790236;116882;118611.40694296474;121569;102924;104226.47886760518;104717;105104.00366778609;107547.99999999843;9582.329236953346;9650.420974741539;9669.758256043655;9820;9871.95064024704;60044;60742.39257607544;61990.38009619846;62256;62965;89168;89823;90215.54892225497;90716;92073.53963230141;13163.53927612529;13371.465141394236;13542.661433464242;13545.79681304801;13783;14591.635209119857;14700;14705.705885882437;15018.924905375403;15106.018108822891;13050.477980881038;13127.540536081191;13275.402606882906;13778.242196679279;13827.654308642364;13046.934765326112;13707;13860.376283067488;14574.34415451286;14620;12362.196457230611;12896.48414063427;13854.099483533539;13906.860931390556;14118.152910825384;11227;11337.773244535229;11468.82796758066;12241.938790305992;12379.814302785286;11823.349715765715;11973.341466219093;12624.3687815607;12699.238045717286;13166.605001849959 06:11:33 INFO - PROCESS | 27140 | __end_tp_report 06:11:33 INFO - PROCESS | 27140 | __start_cc_report 06:11:33 INFO - PROCESS | 27140 | _x_x_mozilla_cycle_collect,337 06:11:33 INFO - PROCESS | 27140 | __end_cc_report 06:11:33 INFO - PROCESS | 27140 | __startTimestamp1477660293204__endTimestamp 06:11:33 INFO - PROCESS | 27140 | 06:11:33 INFO - PROCESS | 27140 | ------- Summary: start ------- 06:11:33 INFO - PROCESS | 27140 | Number of tests: 6 06:11:33 INFO - PROCESS | 27140 | 06:11:33 INFO - PROCESS | 27140 | [#0] dojo.html Cycles:165 Average:5763.26 Median:6009.82 stddev:663.55 (11.0%) stddev-sans-first:636.44 06:11:33 INFO - PROCESS | 27140 | Values: 3283.7 3296.9 3301.1 3329.5 3329.8 5749.5 5817.1 5827.4 5842.4 5848.8 5758.7 5817.3 5822.0 5822.2 5851.3 5187.8 5265.7 5291.1 5293.8 5307.6 5283.9 5297.8 5310.5 5321.7 5346.9 5117.0 5170.1 5329.8 5334.9 5336.7 5242.4 5323.6 5331.9 5342.5 5368.5 5220.3 5276.6 5305.2 5307.4 5308.1 5583.7 5626.1 5725.5 5777.1 5840.3 6049.5 6200.6 6204.3 6205.9 6220.6 6246.8 6251.0 6251.8 6268.9 6269.1 5572.8 5685.0 5799.1 5830.7 5861.7 6166.8 6257.5 6263.9 6269.5 6295.3 6035.4 6060.1 6084.8 6090.5 6092.8 6016.9 6062.1 6122.3 6188.7 6191.3 6069.6 6176.5 6188.3 6188.3 6196.4 6150.4 6157.6 6187.3 6193.1 6194.3 4616.7 4651.2 4720.8 4723.0 4727.6 4139.2 4205.6 4222.8 4223.5 4245.1 5917.6 5991.0 6027.3 6044.9 6111.7 6163.5 6211.0 6244.1 6263.7 6275.7 5955.8 5957.3 5981.9 5991.6 6052.4 5303.0 5354.1 5364.7 5387.2 5388.4 6224.9 6330.2 6331.3 6542.8 6546.7 6206.3 6212.8 6216.3 6221.8 6229.8 6386.9 6489.8 6497.1 6497.4 6497.7 5926.1 6071.7 6093.5 6096.4 6098.5 6280.5 6281.2 6282.2 6282.5 6301.6 6107.6 6133.5 6149.7 6165.3 6167.5 5872.4 5957.3 6009.8 6142.1 6142.8 5972.4 6007.4 6008.1 6018.5 6025.9 6091.7 6113.5 6135.9 6143.5 6161.8 5800.1 5849.2 5938.6 5954.3 5970.6 06:11:33 INFO - PROCESS | 27140 | 06:11:33 INFO - PROCESS | 27140 | [#1] ext.html Cycles:180 Average:64164.21 Median:44010.34 stddev:128945.34 (293.0%) stddev-sans-first:129218.71 06:11:33 INFO - PROCESS | 27140 | Values: 585.5 614.2 651.1 659.1 712.3 40923.0 45561.8 45590.1 45605.1 45824.8 45541.3 46031.1 46074.3 46163.0 46229.3 9088.9 9240.6 9242.1 9242.8 9243.0 9216.4 9357.0 9357.1 9362.0 9365.3 9324.3 9354.4 9365.9 9371.5 9384.1 9189.3 9207.5 9208.0 9234.4 9249.8 9118.2 9209.1 9211.5 9256.1 9290.1 43074.0 43647.6 43789.0 43842.0 43883.3 3604.2 3718.7 3799.7 3868.3 3973.1 33749.0 34343.0 34527.7 34548.3 35068.3 4689.4 4789.0 4798.9 4814.5 4926.4 349518.0 353416.0 353619.0 355084.0 355459.0 60677.0 60997.0 61153.4 61221.4 61414.0 39447.6 40057.4 40239.4 42123.4 42146.8 15789.1 15800.1 15884.9 15910.6 15912.4 13054.3 13182.9 13183.7 13194.9 13211.2 20552.9 20557.4 20639.4 20765.4 20888.7 7632.2 7648.8 7766.6 7857.4 7860.5 1034.2 1055.1 1061.2 1107.4 1173.4 33065.8 33465.3 33919.0 34172.1 34775.8 1144.3 1168.3 1175.2 1225.3 1230.9 17056.6 17736.2 17841.7 17853.4 17952.8 566679.0 567605.0 570058.0 570683.0 603106.0 63606.7 63916.0 64300.0 64324.0 64425.4 1345.0 1356.1 1359.3 1371.8 1401.2 32501.0 33053.0 33469.8 33654.7 34252.7 55473.2 56082.0 56109.7 56160.0 56261.0 493218.0 500128.0 501098.0 501109.0 509347.0 30371.4 31618.8 31678.7 31680.7 31694.4 51460.5 52116.5 52420.5 53179.5 53738.5 43847.3 43904.6 44116.1 44733.6 45675.8 44208.2 45312.8 45408.0 46451.5 46855.1 37489.8 41523.0 43675.6 44998.0 45705.0 38402.4 38715.4 39761.0 41251.8 41808.8 30148.8 30348.0 30698.5 30859.7 31256.0 06:11:33 INFO - PROCESS | 27140 | 06:11:33 INFO - PROCESS | 27140 | [#2] jquery.html Cycles:180 Average:31394.78 Median:24879.00 stddev:89892.88 (361.3%) stddev-sans-first:90114.95 06:11:33 INFO - PROCESS | 27140 | Values: 409.6 412.2 428.1 429.9 443.6 19207.4 20628.3 20688.5 21218.2 21813.3 19864.0 20271.9 20502.6 20671.2 20741.7 5810.1 5987.4 6007.1 6036.3 6046.4 5894.9 5926.7 5937.1 5943.9 6034.2 5779.8 5875.9 5880.8 5884.6 5886.4 5797.7 5839.9 5860.8 5865.5 5873.4 5398.6 5418.8 5418.8 5424.1 5433.0 23529.3 24338.8 24631.9 24877.3 24880.8 2413.6 2494.1 2645.0 2654.2 2985.7 9922.6 9933.2 10207.8 10241.9 15348.2 2037.0 2048.0 2056.6 2085.9 2116.5 87290.6 89701.6 90377.0 90734.5 91586.0 11550.5 11661.8 11961.2 11997.3 12039.8 17086.5 17142.7 17144.4 17145.7 17158.9 8371.4 8508.5 8533.8 8572.6 8651.2 8031.0 8170.7 8189.8 8309.7 8329.5 4416.1 4496.0 4512.9 4813.1 5011.3 2085.8 2124.9 2160.5 2167.6 2232.7 1029.4 1055.7 1056.1 1089.6 1104.9 18840.0 20028.6 21030.7 21322.9 21432.1 1036.2 1047.3 1066.3 1080.6 1093.8 11196.8 11717.7 11745.0 11775.7 11805.4 530252.0 534828.0 540962.0 559695.0 561551.0 62215.7 94869.5 103795.5 105886.0 106144.5 1042.6 1075.8 1080.3 1096.9 1104.7 16135.4 18758.2 18928.5 18969.6 19195.5 32424.2 43277.8 45425.3 45931.8 46032.3 56958.1 58146.0 58449.5 64829.0 66062.3 8349.2 8516.6 8522.3 8550.8 8689.8 12429.3 14171.4 14324.7 14479.3 14549.0 12552.7 12747.1 12785.7 12861.2 13042.7 8106.0 8370.6 8488.4 8526.1 8580.8 8428.2 8453.2 8567.3 8702.7 8869.1 13331.1 14010.0 14055.2 14065.0 14137.8 12997.4 13199.1 13363.3 13423.5 13427.3 06:11:33 INFO - PROCESS | 27140 | 06:11:33 INFO - PROCESS | 27140 | [#3] mootools.html Cycles:180 Average:6053.32 Median:2426.18 stddev:3483.86 (143.6%) stddev-sans-first:3476.87 06:11:33 INFO - PROCESS | 27140 | Values: 1504.5 1547.0 1678.3 1827.7 1835.8 7969.4 8715.5 8747.8 9371.5 9403.4 8780.1 8946.9 8976.7 9045.2 9045.6 2399.6 2427.0 2427.9 2430.9 2444.6 2423.9 2443.7 2477.3 2479.8 2484.6 2403.2 2407.0 2433.8 2455.7 2456.5 2374.6 2381.8 2385.1 2410.9 2438.2 2378.6 2380.7 2389.5 2391.3 2393.0 9010.0 9060.9 9146.1 9152.4 9165.6 5278.6 5368.5 5409.8 5419.1 5431.4 3435.2 3527.5 3595.4 3599.0 3601.2 1160.3 1165.7 1171.5 1197.8 1218.0 13097.8 13124.6 13140.9 13153.5 13160.7 4425.4 4646.4 4685.1 4710.4 4749.5 10735.1 10815.2 10848.1 10889.4 10895.0 5437.1 5449.5 5475.0 5485.0 5490.1 4410.4 4861.5 4979.2 5007.7 5022.9 4188.5 4210.0 4272.2 4292.7 4305.2 1334.9 1348.7 1357.2 1359.4 1375.4 1008.5 1011.3 1011.7 1016.0 1037.2 5904.5 6008.7 6224.6 6226.1 6231.1 442.0 444.4 452.4 453.8 455.5 4126.1 4132.2 4133.2 4160.9 4234.7 11128.3 11377.5 11457.3 11505.1 11513.4 10770.9 10995.7 11179.9 11362.5 11419.4 8540.5 8619.5 8791.7 8802.1 8803.6 6289.3 6459.3 6481.9 6506.3 6599.9 10510.7 10657.4 10675.4 10692.6 10764.6 10729.5 10887.6 10890.3 10984.5 11035.4 7615.8 7822.9 7901.6 8120.5 8219.1 9083.7 9102.4 9178.2 9178.9 9196.4 7895.2 8151.2 8167.1 8225.6 8419.3 8061.4 8066.4 8074.5 8101.0 8215.8 7107.1 7155.6 7170.9 7201.4 7454.2 5354.8 5480.5 5509.5 5550.6 5597.5 5391.1 5442.6 5444.2 5459.6 5565.9 06:11:33 INFO - PROCESS | 27140 | 06:11:33 INFO - PROCESS | 27140 | [#4] prototype.html Cycles:180 Average:5022.80 Median:5664.95 stddev:1518.50 (26.8%) stddev-sans-first:1481.06 06:11:33 INFO - PROCESS | 27140 | Values: 313.8 322.6 322.9 328.3 330.7 5755.3 5762.7 5813.7 5860.6 5881.6 5778.2 5808.3 5809.4 5809.6 5814.5 4406.3 4408.1 4425.7 4426.7 4429.8 4207.4 4323.3 4396.9 4449.2 4454.7 4333.7 4353.3 4359.1 4364.6 4385.4 4356.4 4370.7 4387.9 4411.1 4413.2 3754.5 3805.0 3834.4 3841.8 3843.6 5587.4 5599.7 5600.7 5618.7 5633.3 5028.2 5034.9 5051.8 5064.2 5066.2 5836.4 5995.7 6027.0 6028.4 6068.6 4185.5 4187.8 4190.9 4210.7 4219.2 6042.9 6263.7 6282.2 6306.2 6347.4 4321.4 4382.6 4387.1 4393.8 4400.6 4437.6 4441.8 4443.2 4450.3 4492.3 5033.0 5132.4 5172.0 5188.2 5201.7 6080.2 6102.4 6108.8 6113.8 6150.4 1548.5 1563.5 1568.9 1570.1 1571.7 928.4 973.0 973.6 977.2 978.5 5239.5 5240.9 5250.5 5255.6 5262.3 5456.5 5478.3 5478.5 5503.9 5508.9 4989.8 5288.9 5289.9 5308.5 5317.9 2962.4 2966.7 2980.5 3000.0 3018.9 5632.5 5696.6 5749.7 5790.6 5797.8 5940.7 6371.0 6447.4 6450.9 6454.8 6474.9 6507.7 6536.5 6543.9 6614.9 6073.3 6146.6 6250.8 6286.6 6324.9 6222.4 6235.4 6250.6 6253.5 6265.2 6315.2 6511.5 6515.6 6529.9 6540.2 4324.9 4386.5 4396.7 4407.1 4415.6 6226.8 6268.4 6333.5 6376.4 6439.1 6132.2 6132.7 6139.7 6151.9 6207.5 5955.0 6194.0 6215.3 6215.5 6218.6 6070.0 6076.3 6092.7 6093.1 6102.5 6182.2 6194.7 6203.3 6204.8 6214.8 5774.9 6010.7 6063.0 6064.2 6069.7 06:11:33 INFO - PROCESS | 27140 | 06:11:33 INFO - PROCESS | 27140 | [#5] yui.html Cycles:180 Average:23357.81 Median:4101.85 stddev:35439.83 (864.0%) stddev-sans-first:35498.47 06:11:33 INFO - PROCESS | 27140 | Values: 718.2 746.6 791.2 804.9 867.3 14113.0 14850.7 14856.5 14869.4 14952.5 12899.7 12966.2 12979.5 12991.5 13004.8 694.8 806.6 824.1 826.2 836.8 791.5 792.0 792.5 792.7 793.1 883.7 888.6 889.8 889.9 892.2 883.4 883.7 885.5 885.9 888.0 644.6 645.5 647.4 650.9 653.3 13296.8 13315.1 13324.5 13327.4 13386.3 15742.9 15756.6 15828.4 15898.0 16476.4 13273.7 13455.9 13458.7 13517.9 13560.7 4191.0 4197.2 4296.5 4296.5 4351.4 77797.0 78468.6 78825.6 88718.0 90360.1 12824.6 12854.3 12894.7 12909.7 13187.8 22875.4 23183.8 23334.9 23337.5 23430.9 7977.1 8293.3 8329.1 8609.8 8769.5 4984.7 5250.7 5260.7 5275.3 5403.9 3961.3 4099.9 4103.8 4106.2 4112.2 633.7 645.6 654.4 661.1 680.3 707.1 726.4 740.2 741.9 750.3 10187.8 10223.2 10475.5 10498.2 10928.1 624.7 651.7 673.8 691.3 691.4 5023.7 5055.4 5099.5 5108.4 5121.7 132383.3 138655.3 139132.0 140452.0 143202.0 68924.0 116048.4 116882.0 118611.4 121569.0 102924.0 104226.5 104717.0 105104.0 107548.0 9582.3 9650.4 9669.8 9820.0 9872.0 60044.0 60742.4 61990.4 62256.0 62965.0 89168.0 89823.0 90215.5 90716.0 92073.5 13163.5 13371.5 13542.7 13545.8 13783.0 14591.6 14700.0 14705.7 15018.9 15106.0 13050.5 13127.5 13275.4 13778.2 13827.7 13046.9 13707.0 13860.4 14574.3 14620.0 12362.2 12896.5 13854.1 13906.9 14118.2 11227.0 11337.8 11468.8 12241.9 12379.8 11823.3 11973.3 12624.4 12699.2 13166.6 06:11:33 INFO - PROCESS | 27140 | -------- Summary: end -------- 06:11:33 INFO - PROCESS | 27140 | 06:11:33 INFO - TEST-INFO | 27140: exit 0 06:11:33 INFO - TEST-OK | dromaeo_css | took 1110272ms 06:11:33 INFO - TEST-START | kraken 06:11:33 INFO - operating with platform_type : linux_ 06:11:33 INFO - Initialising browser for kraken test... 06:11:33 INFO - TEST-INFO | started process 27377 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZinREr/profile http://localhost:36824/getInfo.html) 06:11:38 INFO - PROCESS | 27377 | __metrics Screen width/height:1600/1200 06:11:38 INFO - PROCESS | 27377 | colorDepth:24 06:11:38 INFO - PROCESS | 27377 | Browser inner width/height: 1024/697 06:11:38 INFO - PROCESS | 27377 | __metrics 06:11:39 ERROR - PROCESS | 27377 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 06:11:39 INFO - TEST-INFO | 27377: exit 0 06:11:39 INFO - Browser initialized. 06:11:39 INFO - Running cycle 1/1 for kraken test... 06:11:39 INFO - TEST-INFO | started process 27502 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZinREr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:11:51 INFO - PROCESS | 27502 | RSS: Main: 150175744 06:11:51 INFO - PROCESS | 27502 | 06:11:54 INFO - PROCESS | 27502 | Cycle 1(1): loaded http://localhost:36824/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36824/tests/kraken/driver.html?testName=audio-beat-detection) 06:11:54 INFO - PROCESS | 27502 | RSS: Main: 157171712 06:11:54 INFO - PROCESS | 27502 | 06:11:57 INFO - PROCESS | 27502 | Cycle 1(1): loaded http://localhost:36824/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36824/tests/kraken/driver.html?testName=audio-dft) 06:11:58 INFO - PROCESS | 27502 | RSS: Main: 155955200 06:11:58 INFO - PROCESS | 27502 | 06:12:01 INFO - PROCESS | 27502 | Cycle 1(1): loaded http://localhost:36824/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36824/tests/kraken/driver.html?testName=audio-fft) 06:12:01 INFO - PROCESS | 27502 | RSS: Main: 156291072 06:12:01 INFO - PROCESS | 27502 | 06:12:03 INFO - PROCESS | 27502 | Cycle 1(1): loaded http://localhost:36824/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36824/tests/kraken/driver.html?testName=audio-oscillator) 06:12:04 INFO - PROCESS | 27502 | RSS: Main: 156086272 06:12:04 INFO - PROCESS | 27502 | 06:12:06 INFO - PROCESS | 27502 | Cycle 1(1): loaded http://localhost:36824/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36824/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:12:07 INFO - PROCESS | 27502 | RSS: Main: 156585984 06:12:07 INFO - PROCESS | 27502 | 06:12:10 INFO - PROCESS | 27502 | Cycle 1(1): loaded http://localhost:36824/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36824/tests/kraken/driver.html?testName=imaging-darkroom) 06:12:10 INFO - PROCESS | 27502 | RSS: Main: 156618752 06:12:10 INFO - PROCESS | 27502 | 06:12:14 INFO - PROCESS | 27502 | Cycle 1(1): loaded http://localhost:36824/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36824/tests/kraken/driver.html?testName=imaging-desaturate) 06:12:14 INFO - PROCESS | 27502 | RSS: Main: 156508160 06:12:14 INFO - PROCESS | 27502 | 06:12:17 INFO - PROCESS | 27502 | Cycle 1(1): loaded http://localhost:36824/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36824/tests/kraken/driver.html?testName=json-parse-financial) 06:12:18 INFO - PROCESS | 27502 | RSS: Main: 156581888 06:12:18 INFO - PROCESS | 27502 | 06:12:19 INFO - PROCESS | 27502 | Cycle 1(1): loaded http://localhost:36824/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36824/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:12:20 INFO - PROCESS | 27502 | RSS: Main: 155918336 06:12:20 INFO - PROCESS | 27502 | 06:12:22 INFO - PROCESS | 27502 | Cycle 1(1): loaded http://localhost:36824/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36824/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:12:22 INFO - PROCESS | 27502 | RSS: Main: 157003776 06:12:22 INFO - PROCESS | 27502 | 06:12:24 INFO - PROCESS | 27502 | Cycle 1(1): loaded http://localhost:36824/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36824/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:12:25 INFO - PROCESS | 27502 | RSS: Main: 156921856 06:12:25 INFO - PROCESS | 27502 | 06:12:27 INFO - PROCESS | 27502 | Cycle 1(1): loaded http://localhost:36824/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36824/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:12:28 INFO - PROCESS | 27502 | RSS: Main: 157003776 06:12:28 INFO - PROCESS | 27502 | 06:12:31 INFO - PROCESS | 27502 | Cycle 1(1): loaded http://localhost:36824/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36824/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:12:32 INFO - PROCESS | 27502 | RSS: Main: 157683712 06:12:32 INFO - PROCESS | 27502 | 06:12:33 INFO - PROCESS | 27502 | Cycle 1(1): loaded http://localhost:36824/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36824/tests/kraken/driver.html?testName=ai-astar) 06:12:33 INFO - PROCESS | 27502 | RSS: Main: 158863360 06:12:33 INFO - PROCESS | 27502 | 06:12:33 INFO - PROCESS | 27502 | __start_tp_report 06:12:33 INFO - PROCESS | 27502 | _x_x_mozilla_page_load 06:12:33 INFO - PROCESS | 27502 | _x_x_mozilla_page_load_details 06:12:33 INFO - PROCESS | 27502 | |i|pagename|runs| 06:12:33 INFO - PROCESS | 27502 | |0;ai-astar;100;113;106;110;111;111;113;111;110;111 06:12:33 INFO - PROCESS | 27502 | |1;audio-beat-detection;146;118;143;173;119;154;150;119;179;117 06:12:33 INFO - PROCESS | 27502 | |2;audio-dft;163;163;163;164;162;163;161;161;162;163 06:12:33 INFO - PROCESS | 27502 | |3;audio-fft;76;75;78;167;76;75;76;76;180;77 06:12:33 INFO - PROCESS | 27502 | |4;audio-oscillator;83;84;160;83;84;84;140;85;84;151 06:12:33 INFO - PROCESS | 27502 | |5;imaging-gaussian-blur;117;119;118;117;117;117;117;117;117;118 06:12:33 INFO - PROCESS | 27502 | |6;imaging-darkroom;146;149;148;150;146;147;147;147;147;147 06:12:33 INFO - PROCESS | 27502 | |7;imaging-desaturate;95;96;96;95;97;95;95;96;95;96 06:12:33 INFO - PROCESS | 27502 | |8;json-parse-financial;52;52;51;53;54;53;52;52;53;51 06:12:33 INFO - PROCESS | 27502 | |9;json-stringify-tinderbox;62;60;60;61;62;60;61;61;61;62 06:12:33 INFO - PROCESS | 27502 | |10;stanford-crypto-aes;73;73;72;72;75;71;72;73;79;72 06:12:33 INFO - PROCESS | 27502 | |11;stanford-crypto-ccm;134;132;121;132;128;131;117;125;158;127 06:12:33 INFO - PROCESS | 27502 | |12;stanford-crypto-pbkdf2;157;154;156;158;153;157;153;155;154;154 06:12:33 INFO - PROCESS | 27502 | |13;stanford-crypto-sha256-iterative;61;63;66;62;64;65;61;62;65;60 06:12:33 INFO - PROCESS | 27502 | __end_tp_report 06:12:33 INFO - PROCESS | 27502 | __start_cc_report 06:12:33 INFO - PROCESS | 27502 | _x_x_mozilla_cycle_collect,905 06:12:33 INFO - PROCESS | 27502 | __end_cc_report 06:12:33 INFO - PROCESS | 27502 | __startTimestamp1477660353879__endTimestamp 06:12:33 INFO - PROCESS | 27502 | 06:12:33 INFO - PROCESS | 27502 | ------- Summary: start ------- 06:12:33 INFO - PROCESS | 27502 | Number of tests: 14 06:12:33 INFO - PROCESS | 27502 | 06:12:33 INFO - PROCESS | 27502 | [#0] ai-astar Cycles:10 Average:109.60 Median:111.00 stddev:3.89 (3.5%) stddev-sans-first:2.06 06:12:33 INFO - PROCESS | 27502 | Values: 100.0 113.0 106.0 110.0 111.0 111.0 113.0 111.0 110.0 111.0 06:12:33 INFO - PROCESS | 27502 | 06:12:33 INFO - PROCESS | 27502 | [#1] audio-beat-detection Cycles:10 Average:141.80 Median:148.00 stddev:23.13 (15.6%) stddev-sans-first:24.48 06:12:33 INFO - PROCESS | 27502 | Values: 146.0 118.0 143.0 173.0 119.0 154.0 150.0 119.0 179.0 117.0 06:12:33 INFO - PROCESS | 27502 | 06:12:33 INFO - PROCESS | 27502 | [#2] audio-dft Cycles:10 Average:162.50 Median:163.00 stddev:0.97 (0.6%) stddev-sans-first:1.01 06:12:33 INFO - PROCESS | 27502 | Values: 163.0 163.0 163.0 164.0 162.0 163.0 161.0 161.0 162.0 163.0 06:12:33 INFO - PROCESS | 27502 | 06:12:33 INFO - PROCESS | 27502 | [#3] audio-fft Cycles:10 Average:95.60 Median:76.00 stddev:41.18 (54.2%) stddev-sans-first:43.06 06:12:33 INFO - PROCESS | 27502 | Values: 76.0 75.0 78.0 167.0 76.0 75.0 76.0 76.0 180.0 77.0 06:12:33 INFO - PROCESS | 27502 | 06:12:33 INFO - PROCESS | 27502 | [#4] audio-oscillator Cycles:10 Average:103.80 Median:84.00 stddev:32.46 (38.6%) stddev-sans-first:33.55 06:12:33 INFO - PROCESS | 27502 | Values: 83.0 84.0 160.0 83.0 84.0 84.0 140.0 85.0 84.0 151.0 06:12:33 INFO - PROCESS | 27502 | 06:12:33 INFO - PROCESS | 27502 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 06:12:33 INFO - PROCESS | 27502 | Values: 117.0 119.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 06:12:33 INFO - PROCESS | 27502 | 06:12:33 INFO - PROCESS | 27502 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.00 stddev:1.26 (0.9%) stddev-sans-first:1.24 06:12:33 INFO - PROCESS | 27502 | Values: 146.0 149.0 148.0 150.0 146.0 147.0 147.0 147.0 147.0 147.0 06:12:33 INFO - PROCESS | 27502 | 06:12:33 INFO - PROCESS | 27502 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 06:12:33 INFO - PROCESS | 27502 | Values: 95.0 96.0 96.0 95.0 97.0 95.0 95.0 96.0 95.0 96.0 06:12:33 INFO - PROCESS | 27502 | 06:12:33 INFO - PROCESS | 27502 | [#8] json-parse-financial Cycles:10 Average:52.30 Median:52.50 stddev:0.95 (1.8%) stddev-sans-first:1.00 06:12:33 INFO - PROCESS | 27502 | Values: 52.0 52.0 51.0 53.0 54.0 53.0 52.0 52.0 53.0 51.0 06:12:33 INFO - PROCESS | 27502 | 06:12:33 INFO - PROCESS | 27502 | [#9] json-stringify-tinderbox Cycles:10 Average:61.00 Median:61.00 stddev:0.82 (1.3%) stddev-sans-first:0.78 06:12:33 INFO - PROCESS | 27502 | Values: 62.0 60.0 60.0 61.0 62.0 60.0 61.0 61.0 61.0 62.0 06:12:33 INFO - PROCESS | 27502 | 06:12:33 INFO - PROCESS | 27502 | [#10] stanford-crypto-aes Cycles:10 Average:73.20 Median:73.00 stddev:2.30 (3.2%) stddev-sans-first:2.44 06:12:33 INFO - PROCESS | 27502 | Values: 73.0 73.0 72.0 72.0 75.0 71.0 72.0 73.0 79.0 72.0 06:12:33 INFO - PROCESS | 27502 | 06:12:33 INFO - PROCESS | 27502 | [#11] stanford-crypto-ccm Cycles:10 Average:130.50 Median:131.50 stddev:11.03 (8.4%) stddev-sans-first:11.62 06:12:33 INFO - PROCESS | 27502 | Values: 134.0 132.0 121.0 132.0 128.0 131.0 117.0 125.0 158.0 127.0 06:12:33 INFO - PROCESS | 27502 | 06:12:33 INFO - PROCESS | 27502 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.10 Median:155.50 stddev:1.79 (1.2%) stddev-sans-first:1.76 06:12:33 INFO - PROCESS | 27502 | Values: 157.0 154.0 156.0 158.0 153.0 157.0 153.0 155.0 154.0 154.0 06:12:33 INFO - PROCESS | 27502 | 06:12:33 INFO - PROCESS | 27502 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.90 Median:63.50 stddev:2.02 (3.2%) stddev-sans-first:2.03 06:12:33 INFO - PROCESS | 27502 | Values: 61.0 63.0 66.0 62.0 64.0 65.0 61.0 62.0 65.0 60.0 06:12:33 INFO - PROCESS | 27502 | -------- Summary: end -------- 06:12:33 INFO - PROCESS | 27502 | 06:12:34 INFO - TEST-INFO | 27502: exit 0 06:12:34 INFO - TEST-OK | kraken | took 60862ms 06:12:34 INFO - SUITE-END | took 1171s 06:12:35 INFO - Completed test suite (00:19:31) 06:12:35 INFO - javascript benchmark 06:12:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7651.466274948947, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3283.6880496352846, 3296.8846090386833, 3301.141703157178, 3329.5338652588625, 3329.816860072695, 5749.511291540219, 5817.127430885369, 5827.41725827417, 5842.415758424166, 5848.795292164775, 5758.683272420015, 5817.301923769143, 5821.970890145554, 5822.243108395914, 5851.3270973838025, 5187.844364669057, 5265.684058956455, 5291.126964050946, 5293.841184764463, 5307.628466007381, 5283.867903302429, 5297.814576489824, 5310.468953104678, 5321.6540924839765, 5346.946530534684, 5116.974415127937, 5170.09523333417, 5329.7601607927545, 5334.946650533503, 5336.733163341817, 5242.370915490146, 5323.574114070865, 5331.946680533184, 5342.465753424665, 5368.516833484966, 5220.347456567929, 5276.551493123089, 5305.204219367087, 5307.3896501902, 5308.071087559701, 5583.664980101207, 5626.127950167731, 5725.456081672234, 5777.075667893159, 5840.328362238354, 6049.5462840287155, 6200.596961197508, 6204.255489341263, 6205.906911396332, 6220.595661282002, 6246.781362652331, 6250.96874515629, 6251.843703907393, 6268.937310626881, 6269.0909818076125, 5572.801847602745, 5684.976704193285, 5799.101139323411, 5830.650160990312, 5861.677607731573, 6166.753329866845, 6257.468115210167, 6263.874722505616, 6269.498440124779, 6295.338989406138, 6035.36628653985, 6060.090986352083, 6084.847878802977, 6090.543209259324, 6092.847678807977, 6016.939830601726, 6062.090686396988, 6122.326544080148, 6188.659623720739, 6191.318954914956, 6069.635821850703, 6176.474999625082, 6188.319284878659, 6188.319284878659, 6196.411340922605, 6150.415710507495, 6157.599756015845, 6187.319394866561, 6193.102000210034, 6194.34959329273, 4616.722996620147, 4651.209294419889, 4720.787564559603, 4722.976385118052, 4727.64542659302, 4139.172165566899, 4205.642520385802, 4222.767747773902, 4223.472065991751, 4245.087306229176, 5917.615355001911, 5991.041433370639, 6027.276726792726, 6044.879102418015, 6111.724972376165, 6163.537734669918, 6211.0372892201785, 6244.110623064887, 6263.655498947602, 6275.748970041147, 5955.76176952917, 5957.314908785545, 5981.880362392728, 5991.64050156992, 6052.364501727343, 5303.0, 5354.089804733205, 5364.678119312775, 5387.191921211849, 5388.38033626138, 6224.937750622526, 6330.208723909512, 6331.271903731038, 6542.771003014872, 6546.70539825709, 6206.255249370104, 6212.751489940351, 6216.285127210429, 6221.813345599639, 6229.844253893508, 6386.93613063882, 6489.837754056186, 6497.122888410004, 6497.382748638872, 6497.675116244074, 5926.140709597171, 6071.696415179312, 6093.451589356979, 6096.420840020191, 6098.5426093042315, 6280.5289603279025, 6281.246250449975, 6282.183316168869, 6282.528810339151, 6301.6219026858535, 6107.633541987495, 6133.509319254538, 6149.661768602769, 6165.32181460048, 6167.537434692326, 5872.383399742966, 5957.344692083954, 6009.819705408845, 6142.109394137914, 6142.754289828356, 5972.402759723993, 6007.429294217042, 6008.128821320972, 6018.488428483628, 6025.939740602538, 6091.7258723358445, 6113.5414843887775, 6135.877282454415, 6143.477804386677, 6161.784337548164, 5800.100984347433, 5849.239598852122, 5938.61399009063, 5954.255718035246, 5970.552208584287], "value": 5717.446399486573, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.4935480809098, 614.198470995351, 651.0884761334133, 659.1299484680221, 712.2734810493293, 40923.0, 45561.772191138996, 45590.08819823606, 45605.08789824202, 45824.77087614557, 45541.31688024674, 46031.07937841241, 46074.30888536666, 46163.0, 46229.30656040162, 9088.863667045, 9240.630374785034, 9242.075792420737, 9242.815143697122, 9243.029481904405, 9216.400933939307, 9356.953215233949, 9357.064293570622, 9361.953190234039, 9365.34442589019, 9324.347295689304, 9354.391964522318, 9365.85951210729, 9371.484568348773, 9384.108509691569, 9189.264858811279, 9207.539623018822, 9207.953960230223, 9234.39976401535, 9249.815003699921, 9118.224950879183, 9209.125133112411, 9211.539423028822, 9256.074392560757, 9290.1174388433, 43074.0, 43647.56352436467, 43789.0, 43842.0, 43883.341749873776, 3604.189057462076, 3718.6839118674943, 3799.67702745267, 3868.3423817951016, 3973.1259122992897, 33749.0, 34343.0, 34527.654723452695, 34548.30903381943, 35068.29863402743, 4689.366935463703, 4789.0, 4798.928016079762, 4814.470408255089, 4926.3842019747535, 349518.0, 353416.0, 353619.0, 355083.99999999744, 355459.0, 60677.0, 60997.0, 61153.38846611477, 61221.38778612246, 61414.0, 39447.60552394497, 40057.39913901294, 40239.39640905389, 42123.368149477785, 42146.78926605409, 15789.052656840397, 15800.130992795277, 15884.92057539728, 15910.602234943988, 15912.443064492687, 13054.282014489294, 13182.934085329704, 13183.736325273441, 13194.934025329812, 13211.207327560378, 20552.897235513727, 20557.383278501668, 20639.380818575468, 20765.377038688865, 20888.686669699968, 7632.236776322324, 7648.770536883902, 7766.5728384939375, 7857.371410287164, 7860.489068210548, 1034.177828626244, 1055.0873494427265, 1061.2147011211648, 1107.4186052322596, 1173.4191575170346, 33065.834670826494, 33465.33069338599, 33919.0, 34172.14569635779, 34775.82612086974, 1144.3420033480616, 1168.2698313554029, 1175.1949914308725, 1225.2587184753274, 1230.8584512780965, 17056.57358566046, 17736.211222969727, 17841.7323740144, 17853.375131870584, 17952.820471795116, 566679.0, 567605.0, 570058.0, 570683.0, 603106.0, 63606.6819665908, 63916.0, 64300.03549946754, 64324.0, 64425.355746442874, 1344.9529266475627, 1356.0643156222175, 1359.3475131936725, 1371.766799644063, 1401.1593044173414, 32501.0, 33053.0, 33469.83265083659, 33654.663453366134, 34252.657473424944, 55473.1679024823, 56082.0, 56109.71945140248, 56160.0, 56261.0, 493218.0, 500128.0, 501098.0, 501109.0, 509347.0, 30371.392572148874, 31618.841905790323, 31678.683213168497, 31680.683193167773, 31694.366112677155, 51460.485395145566, 52116.47883521268, 52420.47579524156, 53179.468205319, 53738.46261537335, 43847.34228986631, 43904.56095439005, 44116.11767764563, 44733.55266447294, 45675.771621141685, 44208.16285799923, 45312.77343613261, 45408.0, 46451.53548464472, 46855.062898741155, 37489.81255093707, 41523.0, 43675.56324436842, 44998.0, 45705.0, 38402.42396364001, 38715.41926871156, 39761.0, 41251.793741031106, 41808.79095604503, 30148.84925575446, 30348.0, 30698.539521906743, 30859.691403085682, 31256.0], "value": 21098.928122662088, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [409.64974946420807, 412.24353311673076, 428.1373033337824, 429.8517011630987, 443.58081612875844, 19207.42377728667, 20628.278010269623, 20688.48278793031, 21218.15127394906, 21813.345599631997, 19864.0, 20271.898640506814, 20502.589948201028, 20671.173153073898, 20741.688874666892, 5810.099434587624, 5987.371326010772, 6007.128966299906, 6036.3360030396625, 6046.39536046394, 5894.941050589482, 5926.674032928187, 5937.050071988483, 5943.851403714899, 6034.185384973016, 5779.768809247625, 5875.941240587582, 5880.764769409218, 5884.588078834483, 5886.381929897363, 5797.652140871519, 5839.8540036499, 5860.794872179475, 5865.501432378253, 5873.412658734135, 5398.64908780928, 5418.783248670048, 5418.83743487696, 5424.0779067558215, 5433.022056029913, 23529.294121176394, 24338.756612434005, 24631.87684061586, 24877.253682389557, 24880.751192488206, 2413.5776239158254, 2494.102123235634, 2644.9867750661124, 2654.21700598322, 2985.7163569460868, 9922.603095876157, 9933.205343572497, 10207.795844083152, 10241.948790256076, 15348.232588370536, 2036.979630203694, 2047.9795202047937, 2056.629806634805, 2085.9478513037143, 2116.5237821490196, 87290.56354718185, 89701.55149224213, 90376.99999999935, 90734.54632726795, 91586.0, 11550.537978480766, 11661.766764664659, 11961.162718609614, 11997.280163190237, 12039.75920481603, 17086.48740537786, 17142.742858857127, 17144.39994600183, 17145.742813857803, 17158.914205429144, 8371.372147088992, 8508.489490630458, 8533.829323413496, 8572.571371431404, 8651.178138076873, 8030.959845200737, 8170.714025009096, 8189.79525511867, 8309.709160179365, 8329.50022998622, 4416.116776644684, 4495.955040449554, 4512.887177820515, 4813.109574728686, 5011.323471331397, 2085.8227050700557, 2124.9256276030264, 2160.5030842905903, 2167.5881582499273, 2232.7097477327843, 1029.4492446541065, 1055.6621880998007, 1056.1497994114657, 1089.5587287148717, 1104.9392283424488, 18840.0, 20028.59942801136, 21030.684539731916, 21322.893385532974, 21432.142714291567, 1036.2073014144187, 1047.3035431438161, 1066.2855886556026, 1080.6109800471825, 1093.7703082352637, 11196.776064478665, 11717.707057323634, 11745.0, 11775.705607359885, 11805.40972951349, 530252.0, 534828.0, 540962.0, 559695.0, 561551.0, 62215.68892155601, 94869.5256523713, 103795.48102259441, 105886.0, 106144.46927765312, 1042.5725452564411, 1075.7687097274124, 1080.2654195147375, 1096.873859506167, 1104.679642903549, 16135.435259766322, 18758.249670013047, 18928.526786829887, 18969.620607588047, 19195.520111997314, 32424.189395264362, 43277.783611081744, 45425.31862022006, 45931.77034114808, 46032.309515356625, 56958.14562781479, 58146.0, 58449.5387615313, 64829.0, 66062.33937660755, 8349.206825351583, 8516.574171291286, 8522.318214542945, 8550.82898342042, 8689.782755431164, 12429.316387598768, 14171.362288697239, 14324.713505730035, 14479.348429320495, 14549.0, 12552.74894502123, 12747.107702460738, 12785.680357991125, 12861.228326300452, 13042.739145217232, 8105.959470202612, 8370.623321950405, 8488.40581159313, 8526.104759000464, 8580.785480363042, 8428.199321064489, 8453.239208471266, 8567.271781898358, 8702.738917832476, 8869.068747781648, 13331.133476324008, 14010.0, 14055.22696251716, 14065.0, 14137.787933180805, 12997.350132493148, 13199.142055766344, 13363.331833408096, 13423.530176443777, 13427.26150061756], "value": 9700.425464723887, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1504.4659146003169, 1546.9690606187876, 1678.2699525706319, 1827.661882551728, 1835.7797064352262, 7969.442139050268, 8715.477071375723, 8747.781305467366, 9371.531423428836, 9403.435793852374, 8780.078091800366, 8946.91053089469, 8976.73069807905, 9045.231155351787, 9045.63817447303, 2399.6400539919023, 2426.9757302427015, 2427.8786060696984, 2430.902763889442, 2444.6210837320245, 2423.9394015149674, 2443.657887895696, 2477.318737347235, 2479.801615870735, 2484.5776218042884, 2403.2189538400003, 2407.037185125946, 2433.756624337561, 2455.7175924768703, 2456.508698260346, 2374.643803429482, 2381.797547208481, 2385.0936644075227, 2410.879456027209, 2438.1588352018525, 2378.607529757588, 2380.666706661069, 2389.4504264019374, 2391.2826152154457, 2393.0, 9009.954950225272, 9060.864087038699, 9146.085391460867, 9152.405093668891, 9165.587548560265, 5278.604104692164, 5368.489993450616, 5409.783608655649, 5419.105847535152, 5431.402545719968, 3435.209901722593, 3527.4708793680898, 3595.442706380515, 3599.0, 3601.1537288737127, 1160.2864238493266, 1165.74936388676, 1171.543098191706, 1197.784398808214, 1218.0, 13097.803532947013, 13124.606261812161, 13140.934295328558, 13153.473861045642, 13160.736785264242, 4425.402570652985, 4646.3727396801, 4685.086408150378, 4710.387649605529, 4749.548792864673, 10735.087517560938, 10815.242932994772, 10848.132149428027, 10889.401082940356, 10895.0, 5437.130059190589, 5449.482299181572, 5475.0, 5485.040117979338, 5490.066688662937, 4410.3825464435, 4861.513848615181, 4979.153543897546, 5007.749612519359, 5022.899542009212, 4188.539260681323, 4210.012112632563, 4272.230998420314, 4292.678049146327, 4305.225059489259, 1334.9132306400054, 1348.730253949214, 1357.151780137414, 1359.3814814259488, 1375.3535838156051, 1008.510872226984, 1011.3072545306342, 1011.7066050845319, 1016.0347669713801, 1037.159900480613, 5904.468597826216, 6008.669523176267, 6224.62652240867, 6226.066090086432, 6231.096491008869, 441.97569133697954, 444.4067170327584, 452.4344569288389, 453.77311344327836, 455.51942700451343, 4126.09225970286, 4132.152908653718, 4133.152703695735, 4160.875173744793, 4234.661227101825, 11128.332300062022, 11377.488013039432, 11457.312561246184, 11505.079593632488, 11513.366764828015, 10770.946145269223, 10995.725106872393, 11179.888201118047, 11362.545498180145, 11419.37193454368, 8540.487570745776, 8619.482831030158, 8791.736247912573, 8802.07578204292, 8803.603837827313, 6289.339619340087, 6459.289478157305, 6481.902771458526, 6506.251781045051, 6599.868002639824, 10510.737231569272, 10657.360558366523, 10675.359478431319, 10692.62575809874, 10764.623238186627, 10729.463526823783, 10887.564497420015, 10890.346579205274, 10984.450777461256, 11035.44822758875, 7615.771526854203, 7822.921770782447, 7901.565413902291, 8120.512769233865, 8219.136990616138, 9083.68207112748, 9102.408343457653, 9178.173964343241, 9178.862317065383, 9196.356255062348, 7895.171007044178, 8151.225633564802, 8167.060788009455, 8225.588720563828, 8419.284360829153, 8061.355091592776, 8066.395020373378, 8074.475159114639, 8100.959495202486, 8215.753527394188, 7107.076080109553, 7155.642217888981, 7170.928290717026, 7201.423886089205, 7454.217307182885, 5354.812581559627, 5480.534154596904, 5509.531689806251, 5550.639208451437, 5597.468240517144, 5391.137418013099, 5442.591805614516, 5444.237806707143, 5459.590530710133, 5565.916511252415], "value": 4751.868847379474, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.8164173958236, 322.6209204185082, 322.8514883153749, 328.34495182111687, 330.743673652919, 5755.338136114348, 5762.683052432115, 5813.709314534278, 5860.619059761112, 5881.647101173932, 5778.248827652399, 5808.273965754281, 5809.3609702932645, 5809.622374545652, 5814.4766970972605, 4406.317020861756, 4408.074304396081, 4425.66807489438, 4426.690131690783, 4429.822807087713, 4207.43199668044, 4323.329883868006, 4396.868093957187, 4449.176902273073, 4454.688171827974, 4333.739975601474, 4353.28170851809, 4359.128174365123, 4364.585364390394, 4385.407969924051, 4356.411884395598, 4370.71590346628, 4387.934180987288, 4411.117776444724, 4413.183561041185, 3754.5407757918606, 3804.9809750951067, 3834.405667121601, 3841.8271177797064, 3843.557990831034, 5587.441255874421, 5599.692016939067, 5600.747966341483, 5618.690971996539, 5633.295838020247, 5028.245763135523, 5034.949650503485, 5051.823186188466, 5064.2403639454005, 5066.164082926312, 5836.387179346192, 5995.7109221517585, 6026.96986515069, 6028.39716028398, 6068.57519973602, 4185.518665353493, 4187.769672668002, 4190.895227619303, 4210.726302790309, 4219.156168766259, 6042.909356359658, 6263.749450021994, 6282.2147231596055, 6306.211723534559, 6347.3969972852965, 4321.351797230378, 4382.6055654991205, 4387.122575484852, 4393.758343291086, 4400.559944005638, 4437.622802061796, 4441.755703436277, 4443.200503795968, 4450.265706158512, 4492.337835001005, 5033.030511997866, 5132.409772876093, 5171.974140129275, 5188.22176673502, 5201.7399130044105, 6080.179175811298, 6102.420270074336, 6108.816735497942, 6113.786017489367, 6150.446459818638, 1548.5276990517775, 1563.5387560669403, 1568.9096078225753, 1570.1050401271393, 1571.6542360680633, 928.3640706116332, 973.0, 973.5737145082488, 977.2328721953374, 978.4667356290838, 5239.532930779388, 5240.868978275574, 5250.455942239049, 5255.6321057526375, 5262.289590905255, 5456.454354564512, 5478.315210598676, 5478.521139076635, 5503.862403439946, 5508.944910550923, 4989.775460104304, 5288.894222115613, 5289.867753306121, 5308.513616187473, 5317.9202311965355, 2962.415107917254, 2966.688497707753, 2980.478416277143, 3000.0, 3018.879244830226, 5632.549396048388, 5696.601237913306, 5749.741261643236, 5790.594658373873, 5797.797077102281, 5940.732667029994, 6371.0, 6447.355924239383, 6450.870982580323, 6454.773103279455, 6474.935250647433, 6507.7071531781185, 6536.542442029012, 6543.9345606544275, 6614.86770264592, 6073.30157031947, 6146.569740118149, 6250.812215724642, 6286.622802631857, 6324.905126423199, 6222.439980401605, 6235.438810507076, 6250.562460627894, 6253.499720022296, 6265.185525881606, 6315.242170939517, 6511.479081673549, 6515.641639709862, 6529.8694026120165, 6540.2151741789385, 4324.935125973176, 4386.517483076923, 4396.736195828261, 4407.096545208161, 4415.602595766396, 6226.750929962751, 6268.404501572343, 6333.461655759128, 6376.39424254695, 6439.130717353285, 6132.17215675878, 6132.693365331626, 6139.662318572521, 6151.876962460815, 6207.503399727921, 5955.0, 6194.0, 6215.254169499689, 6215.502759779117, 6218.595791273553, 6070.0, 6076.3012253591405, 6092.664903430354, 6093.141591814539, 6102.542309326729, 6182.227221597301, 6194.659293738888, 6203.31763506005, 6204.844878878064, 6214.8135555933395, 5774.855628609318, 6010.699465026643, 6062.969685151723, 6064.211652485325, 6069.696515174312], "value": 4527.298646587662, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [718.2027948976637, 746.5931067568175, 791.1692722641226, 804.9396295277855, 867.301822033263, 14113.0, 14850.702985940288, 14856.480023199176, 14869.405223791035, 14952.476663316786, 12899.742005159891, 12966.157199782008, 12979.545715899945, 12991.480340786356, 13004.804927926089, 694.7741983855242, 806.5563939833098, 824.0688022534528, 826.2027143806225, 836.8368168207202, 791.4578513718121, 791.9999999999972, 792.469045739356, 792.6948124971899, 793.115676021235, 883.730462209026, 888.6401007591903, 889.7686601483596, 889.915458031486, 892.2282225874604, 883.4037025008093, 883.6597909804707, 885.4642941020654, 885.8671199320089, 888.0098689960647, 644.5874640230256, 645.4610400315742, 647.3849842649455, 650.9121268628722, 653.2846533046306, 13296.800547991788, 13315.067945243836, 13324.467021319135, 13327.400266988008, 13386.330683465787, 15742.9212853935, 15756.606084847856, 15828.366865325488, 15898.046117233003, 16476.42332518356, 13273.668158296023, 13455.865441345559, 13458.663533411645, 13517.932410337984, 13560.728785424335, 4190.958090419118, 4197.244495990721, 4296.462942132233, 4296.484421869396, 4351.390805287262, 77797.0, 78468.60765696192, 78825.60587197085, 88718.0, 90360.09639903583, 12824.551140710031, 12854.293013884326, 12894.742105158031, 12909.677258068623, 13187.802182967263, 22875.428114297276, 23183.768162318498, 23334.883325583265, 23337.533249335258, 23430.882845585664, 7977.082635496876, 8293.253607175384, 8329.12544182852, 8609.784755381166, 8769.517676527852, 4984.700917944935, 5250.711210883362, 5260.684358938476, 5275.340582427197, 5403.891922161613, 3961.286968345668, 4099.85650502231, 4103.835846566164, 4106.219818234586, 4112.157007813391, 633.7211626884156, 645.5868244323636, 654.3979538824293, 661.1438187547138, 680.3298750730527, 707.0772641702524, 726.4417823767988, 740.2449501508431, 741.9220981796941, 750.339701063061, 10187.796244075225, 10223.182145428347, 10475.476226188812, 10498.212634052477, 10928.071113955244, 624.6814124796296, 651.664392837689, 673.7843889955266, 691.3017851969547, 691.3570379546969, 5023.723695196799, 5055.368078990126, 5099.464556221617, 5108.438071812097, 5121.743912804345, 132383.33808330898, 138655.30672346774, 139132.0, 140452.0, 143202.0, 68924.0, 116048.41975790236, 116882.0, 118611.40694296474, 121569.0, 102924.0, 104226.47886760518, 104717.0, 105104.00366778609, 107547.99999999843, 9582.329236953346, 9650.420974741539, 9669.758256043655, 9820.0, 9871.95064024704, 60044.0, 60742.39257607544, 61990.38009619846, 62256.0, 62965.0, 89168.0, 89823.0, 90215.54892225497, 90716.0, 92073.53963230141, 13163.53927612529, 13371.465141394236, 13542.661433464242, 13545.79681304801, 13783.0, 14591.635209119857, 14700.0, 14705.705885882437, 15018.924905375403, 15106.018108822891, 13050.477980881038, 13127.540536081191, 13275.402606882906, 13778.242196679279, 13827.654308642364, 13046.934765326112, 13707.0, 13860.376283067488, 14574.34415451286, 14620.0, 12362.196457230611, 12896.48414063427, 13854.099483533539, 13906.860931390556, 14118.152910825384, 11227.0, 11337.773244535229, 11468.82796758066, 12241.938790305992, 12379.814302785286, 11823.349715765715, 11973.341466219093, 12624.3687815607, 12699.238045717286, 13166.605001849959], "value": 7970.188368690875, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1508.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 113.0, 106.0, 110.0, 111.0, 111.0, 113.0, 111.0, 110.0, 111.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 118.0, 143.0, 173.0, 119.0, 154.0, 150.0, 119.0, 179.0, 117.0], "value": 141.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 164.0, 162.0, 163.0, 161.0, 161.0, 162.0, 163.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 78.0, 167.0, 76.0, 75.0, 76.0, 76.0, 180.0, 77.0], "value": 95.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 160.0, 83.0, 84.0, 84.0, 140.0, 85.0, 84.0, 151.0], "value": 103.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 149.0, 148.0, 150.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 97.0, 95.0, 95.0, 96.0, 95.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 51.0, 53.0, 54.0, 53.0, 52.0, 52.0, 53.0, 51.0], "value": 52.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 60.0, 60.0, 61.0, 62.0, 60.0, 61.0, 61.0, 61.0, 62.0], "value": 61.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 72.0, 72.0, 75.0, 71.0, 72.0, 73.0, 79.0, 72.0], "value": 73.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 132.0, 121.0, 132.0, 128.0, 131.0, 117.0, 125.0, 158.0, 127.0], "value": 130.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 154.0, 156.0, 158.0, 153.0, 157.0, 153.0, 155.0, 154.0, 154.0], "value": 155.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 66.0, 62.0, 64.0, 65.0, 61.0, 62.0, 65.0, 60.0], "value": 62.9, "unit": "score"}]}]} 06:12:35 INFO - Return code: 0 06:12:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:12:35 ERROR - # TBPL SUCCESS # 06:12:35 INFO - Running post-action listener: _resource_record_post_action 06:12:35 INFO - [mozharness: 2016-10-28 13:12:35.204269Z] Finished run-tests step (success) 06:12:35 INFO - Running post-run listener: _resource_record_post_run 06:12:35 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 1748992; Write bytes: 288403456; Read time: 188; Write time: 166420 06:12:35 INFO - TinderboxPrint: CPU usage
13.2% 06:12:35 INFO - TinderboxPrint: I/O read bytes / time
1,748,992 / 188 06:12:35 INFO - TinderboxPrint: I/O write bytes / time
288,403,456 / 166,420 06:12:35 INFO - TinderboxPrint: CPU idle
8,208.7 (86.8%) 06:12:35 INFO - TinderboxPrint: CPU user
1,193.2 (12.6%) 06:12:35 INFO - TinderboxPrint: Swap in / out
0 / 0 06:12:35 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 4096; Write bytes: 71462912; Read time: 20; Write time: 63336 06:12:35 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 12288; Write bytes: 216940544; Read time: 140; Write time: 103084 06:12:35 INFO - Running post-run listener: _upload_blobber_files 06:12:35 INFO - Blob upload gear active. 06:12:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:12:35 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 06:12:35 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'] 06:12:35 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 06:12:36 INFO - (blobuploader) - INFO - Open directory for files ... 06:12:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:12:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:12:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:12:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:12:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:12:39 INFO - (blobuploader) - INFO - Done attempting. 06:12:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:12:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:12:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:12:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:12:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:12:40 INFO - (blobuploader) - INFO - Done attempting. 06:12:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:12:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:12:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:12:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:12:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:12:41 INFO - (blobuploader) - INFO - Done attempting. 06:12:41 INFO - (blobuploader) - INFO - Iteration through files over. 06:12:41 INFO - Return code: 0 06:12:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:12:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:12:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/14d0f0fcdabe1c2e804eb4f38a56e63c733174612ae36f02813b4b9895664bf6ed2969fbbf302eea701329ed1acdb50119a069c2a59d7aa35a9511c40dd3927a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/920cd556a7d82f5c4690b39a714b9d758aa89051516f9d30da28840707af55fde87dcb243b75cc71b14e8e3b6e63e1611f1b34752cf64a3de56cd7ce207504f6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6276dba8a0d7fe26b90b3fd53427b0888e74f858aafbafe59ca3aa088248b16839e192041858db37ea93cde607c502b36f7cf205bf0fbf34978cc5eb60c62528"} 06:12:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:12:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:12:41 INFO - Contents: 06:12:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/14d0f0fcdabe1c2e804eb4f38a56e63c733174612ae36f02813b4b9895664bf6ed2969fbbf302eea701329ed1acdb50119a069c2a59d7aa35a9511c40dd3927a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/920cd556a7d82f5c4690b39a714b9d758aa89051516f9d30da28840707af55fde87dcb243b75cc71b14e8e3b6e63e1611f1b34752cf64a3de56cd7ce207504f6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6276dba8a0d7fe26b90b3fd53427b0888e74f858aafbafe59ca3aa088248b16839e192041858db37ea93cde607c502b36f7cf205bf0fbf34978cc5eb60c62528"} 06:12:41 INFO - Running post-run listener: copy_logs_to_upload_dir 06:12:41 INFO - Copying logs to upload dir... 06:12:41 INFO - mkdir: /builds/slave/test/build/upload/logs 06:12:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1674.285999 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 54 secs) (at 2016-10-28 06:12:40.966444) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-28 06:12:40.969781) ========= 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=8887e36bb8e381bfd44124ac000001a8-1477657316.358043-1239426292 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/14d0f0fcdabe1c2e804eb4f38a56e63c733174612ae36f02813b4b9895664bf6ed2969fbbf302eea701329ed1acdb50119a069c2a59d7aa35a9511c40dd3927a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/920cd556a7d82f5c4690b39a714b9d758aa89051516f9d30da28840707af55fde87dcb243b75cc71b14e8e3b6e63e1611f1b34752cf64a3de56cd7ce207504f6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6276dba8a0d7fe26b90b3fd53427b0888e74f858aafbafe59ca3aa088248b16839e192041858db37ea93cde607c502b36f7cf205bf0fbf34978cc5eb60c62528"} build_url:https://queue.taskcluster.net/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011303 build_url: 'https://queue.taskcluster.net/v1/task/RU1Cm5eRQ6O5_NyMtPfNCQ/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/14d0f0fcdabe1c2e804eb4f38a56e63c733174612ae36f02813b4b9895664bf6ed2969fbbf302eea701329ed1acdb50119a069c2a59d7aa35a9511c40dd3927a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/920cd556a7d82f5c4690b39a714b9d758aa89051516f9d30da28840707af55fde87dcb243b75cc71b14e8e3b6e63e1611f1b34752cf64a3de56cd7ce207504f6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6276dba8a0d7fe26b90b3fd53427b0888e74f858aafbafe59ca3aa088248b16839e192041858db37ea93cde607c502b36f7cf205bf0fbf34978cc5eb60c62528"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-28 06:12:40.995631) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 06:12:40.995960) ========= 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=8887e36bb8e381bfd44124ac000001a8-1477657316.358043-1239426292 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004409 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 06:12:41.079309) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-28 06:12:41.079625) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-28 06:12:41.079950) ========= ========= Total master_lag: 0.18 =========