builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-023 starttime: 1475021528.18 results: success (0) buildid: 20160927142619 builduid: 8c07a7d0ee074f5f9df7931312709ca2 revision: 308c6210f18bc167cddc4eae8261fc0eff78e1c4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 17:12:08.183065) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 17:12:08.183539) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-27 17:12:08.183868) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-27 17:12:08.199121) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 17:12:08.199454) ========= 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=6d15e502d8e29d5d2676d664000001c3-1475021269.926239-1991999502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-27 17:12:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 28.4M=0s 2016-09-27 17:12:08 (28.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.079349 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 17:12:08.293481) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 17:12:08.293849) ========= 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=6d15e502d8e29d5d2676d664000001c3-1475021269.926239-1991999502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014336 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 17:12:08.345737) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 17:12:08.346140) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 308c6210f18bc167cddc4eae8261fc0eff78e1c4 --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 308c6210f18bc167cddc4eae8261fc0eff78e1c4 --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=6d15e502d8e29d5d2676d664000001c3-1475021269.926239-1991999502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-27 17:12:09,102 truncating revision to first 12 chars 2016-09-27 17:12:09,102 Setting DEBUG logging. 2016-09-27 17:12:09,102 attempt 1/10 2016-09-27 17:12:09,102 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/308c6210f18b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-27 17:12:09,411 unpacking tar archive at: mozilla-beta-308c6210f18b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.676861 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 17:12:09.038920) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 17:12:09.039455) ========= script_repo_revision: 308c6210f18bc167cddc4eae8261fc0eff78e1c4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 17:12:09.040173) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 17:12:09.040646) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 17:12:09.051894) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 57 secs) (at 2016-09-27 17:12:09.052319) ========= /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=6d15e502d8e29d5d2676d664000001c3-1475021269.926239-1991999502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:12:09 INFO - MultiFileLogger online at 20160927 17:12:09 in /builds/slave/test 17:12:09 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 17:12:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:12:09 INFO - {'append_to_log': False, 17:12:09 INFO - 'base_work_dir': '/builds/slave/test', 17:12:09 INFO - 'blob_upload_branch': 'Mozilla-Beta', 17:12:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:12:09 INFO - 'branch': 'Mozilla-Beta', 17:12:09 INFO - 'buildbot_json_path': 'buildprops.json', 17:12:09 INFO - 'config_files': ('talos/linux_config.py',), 17:12:09 INFO - 'default_actions': ('clobber', 17:12:09 INFO - 'read-buildbot-config', 17:12:09 INFO - 'download-and-extract', 17:12:09 INFO - 'populate-webroot', 17:12:09 INFO - 'create-virtualenv', 17:12:09 INFO - 'install', 17:12:09 INFO - 'run-tests'), 17:12:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:12:09 INFO - 'download_minidump_stackwalk': True, 17:12:09 INFO - 'download_symbols': 'ondemand', 17:12:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:12:09 INFO - 'tooltool.py': '/tools/tooltool.py', 17:12:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:12:09 INFO - '/tools/misc-python/virtualenv.py')}, 17:12:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:12:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:12:09 INFO - 'installer_path': 'installer.exe', 17:12:09 INFO - 'log_level': 'info', 17:12:09 INFO - 'log_name': 'talos', 17:12:09 INFO - 'log_to_console': True, 17:12:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:12:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:12:09 INFO - 'opt_config_files': (), 17:12:09 INFO - 'pip_index': False, 17:12:09 INFO - 'sps_profile': False, 17:12:09 INFO - 'sps_profile_interval': 0, 17:12:09 INFO - 'suite': 'dromaeojs-e10s', 17:12:09 INFO - 'system_bits': '32', 17:12:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:12:09 INFO - 'title': 'talos-linux64-ix-023', 17:12:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:12:09 INFO - 'use_talos_json': True, 17:12:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:12:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:12:09 INFO - 'work_dir': 'build'} 17:12:09 INFO - [mozharness: 2016-09-28 00:12:09.900539Z] Running clobber step. 17:12:09 INFO - Running pre-action listener: _resource_record_pre_action 17:12:09 INFO - Running main action method: clobber 17:12:09 INFO - rmtree: /builds/slave/test/build 17:12:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:12:10 INFO - Running post-action listener: _resource_record_post_action 17:12:10 INFO - [mozharness: 2016-09-28 00:12:10.887615Z] Finished clobber step (success) 17:12:10 INFO - [mozharness: 2016-09-28 00:12:10.887716Z] Running read-buildbot-config step. 17:12:10 INFO - Running pre-action listener: _resource_record_pre_action 17:12:10 INFO - Running main action method: read_buildbot_config 17:12:10 INFO - Using buildbot properties: 17:12:10 INFO - { 17:12:10 INFO - "project": "", 17:12:10 INFO - "product": "firefox", 17:12:10 INFO - "script_repo_revision": "production", 17:12:10 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 17:12:10 INFO - "repository": "", 17:12:10 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 17:12:10 INFO - "buildid": "20160927142619", 17:12:10 INFO - "pgo_build": "True", 17:12:10 INFO - "basedir": "/builds/slave/test", 17:12:10 INFO - "buildnumber": 131, 17:12:10 INFO - "slavename": "talos-linux64-ix-023", 17:12:10 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:12:10 INFO - "platform": "ubuntu64_hw", 17:12:10 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 17:12:10 INFO - "branch": "mozilla-beta", 17:12:10 INFO - "repo_path": "releases/mozilla-beta", 17:12:10 INFO - "revision": "308c6210f18bc167cddc4eae8261fc0eff78e1c4", 17:12:10 INFO - "stage_platform": "linux64-pgo", 17:12:10 INFO - "builduid": "8c07a7d0ee074f5f9df7931312709ca2", 17:12:10 INFO - "slavebuilddir": "test" 17:12:10 INFO - } 17:12:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2. 17:12:10 INFO - Running post-action listener: _resource_record_post_action 17:12:10 INFO - [mozharness: 2016-09-28 00:12:10.890183Z] Finished read-buildbot-config step (success) 17:12:10 INFO - [mozharness: 2016-09-28 00:12:10.890273Z] Running download-and-extract step. 17:12:10 INFO - Running pre-action listener: _resource_record_pre_action 17:12:10 INFO - Running main action method: download_and_extract 17:12:10 INFO - mkdir: /builds/slave/test/build/tests 17:12:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:10 INFO - https://queue.taskcluster.net/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:12:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 17:12:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 17:12:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/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 17:12:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/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 17:12:10 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 17:12:10 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 17:12:10 INFO - retry: Failed, sleeping 30 seconds before retrying 17:12:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/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 17:12:40 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 17:12:40 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 17:12:40 INFO - retry: Failed, sleeping 60 seconds before retrying 17:13:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/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 17:13:40 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 17:13:41 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 17:13:41 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/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! 17:13:41 INFO - Caught exception: HTTP Error 404: Not Found 17:13:41 INFO - Caught exception: HTTP Error 404: Not Found 17:13:41 INFO - Caught exception: HTTP Error 404: Not Found 17:13:41 INFO - trying https://queue.taskcluster.net/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 17:13:41 INFO - Downloading https://queue.taskcluster.net/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/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 17:13:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/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 17:13:41 INFO - Downloaded 1327 bytes. 17:13:41 INFO - Reading from file /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 17:13:41 INFO - Using the following test package requirements: 17:13:41 INFO - {u'common': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 17:13:41 INFO - u'cppunittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 17:13:41 INFO - u'firefox-50.0.en-US.linux-x86_64.cppunittest.tests.zip'], 17:13:41 INFO - u'gtest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 17:13:41 INFO - u'firefox-50.0.en-US.linux-x86_64.gtest.tests.zip'], 17:13:41 INFO - u'jittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 17:13:41 INFO - u'jsshell-linux-x86_64.zip'], 17:13:41 INFO - u'mochitest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 17:13:41 INFO - u'firefox-50.0.en-US.linux-x86_64.mochitest.tests.zip'], 17:13:41 INFO - u'mozbase': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 17:13:41 INFO - u'reftest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 17:13:41 INFO - u'firefox-50.0.en-US.linux-x86_64.reftest.tests.zip'], 17:13:41 INFO - u'talos': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 17:13:41 INFO - u'firefox-50.0.en-US.linux-x86_64.talos.tests.zip'], 17:13:41 INFO - u'web-platform': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 17:13:41 INFO - u'firefox-50.0.en-US.linux-x86_64.web-platform.tests.zip'], 17:13:41 INFO - u'xpcshell': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 17:13:41 INFO - u'firefox-50.0.en-US.linux-x86_64.xpcshell.tests.zip']} 17:13:41 INFO - Downloading packages: [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:13:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:41 INFO - https://queue.taskcluster.net/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:13:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 17:13:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 17:13:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/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 17:13:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/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 17:13:41 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 17:13:41 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 17:13:41 INFO - retry: Failed, sleeping 30 seconds before retrying 17:14:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/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 17:14:11 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 17:14:11 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 17:14:11 INFO - retry: Failed, sleeping 60 seconds before retrying 17:15:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/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 17:15:11 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 17:15:11 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 17:15:11 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/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! 17:15:11 INFO - Caught exception: HTTP Error 404: Not Found 17:15:11 INFO - Caught exception: HTTP Error 404: Not Found 17:15:11 INFO - Caught exception: HTTP Error 404: Not Found 17:15:11 INFO - trying https://queue.taskcluster.net/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 17:15:11 INFO - Downloading https://queue.taskcluster.net/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/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 17:15:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/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 17:15:12 INFO - Downloaded 21772917 bytes. 17:15:12 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'] 17:15:12 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 17:15:13 INFO - Return code: 0 17:15:13 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 17:15:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:13 INFO - https://queue.taskcluster.net/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:15:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 17:15:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 17:15:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/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 17:15:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/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 17:15:13 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 17:15:13 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 17:15:13 INFO - retry: Failed, sleeping 30 seconds before retrying 17:15:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/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 17:15:43 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 17:15:43 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 17:15:43 INFO - retry: Failed, sleeping 60 seconds before retrying 17:16:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/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 17:16:43 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 17:16:43 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 17:16:43 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/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! 17:16:43 INFO - Caught exception: HTTP Error 404: Not Found 17:16:43 INFO - Caught exception: HTTP Error 404: Not Found 17:16:43 INFO - Caught exception: HTTP Error 404: Not Found 17:16:43 INFO - trying https://queue.taskcluster.net/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 17:16:43 INFO - Downloading https://queue.taskcluster.net/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/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 17:16:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/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 17:16:44 INFO - Downloaded 21772917 bytes. 17:16:44 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'] 17:16:44 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 17:16:45 INFO - Return code: 0 17:16: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')]} 17:16:45 INFO - https://queue.taskcluster.net/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:16:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 17:16:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 17:16:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/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 17:16:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/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 17:16:45 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 17:16:45 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 17:16:45 INFO - retry: Failed, sleeping 30 seconds before retrying 17:17:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/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 17:17:16 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 17:17:16 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 17:17:16 INFO - retry: Failed, sleeping 60 seconds before retrying 17:18:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/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 17:18:16 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 17:18:16 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 17:18:16 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/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! 17:18:16 INFO - Caught exception: HTTP Error 404: Not Found 17:18:16 INFO - Caught exception: HTTP Error 404: Not Found 17:18:16 INFO - Caught exception: HTTP Error 404: Not Found 17:18:16 INFO - trying https://queue.taskcluster.net/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 17:18:16 INFO - Downloading https://queue.taskcluster.net/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/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 17:18:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/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 17:18:16 INFO - Downloaded 14413740 bytes. 17:18:16 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'] 17:18:16 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 17:18:17 INFO - Return code: 0 17:18:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:18:17 INFO - https://queue.taskcluster.net/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:18:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 17:18:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 17:18:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/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 17:18:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/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 17:18:17 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 17:18:17 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 17:18:17 INFO - retry: Failed, sleeping 30 seconds before retrying 17:18:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/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 17:18:47 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 17:18:47 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 17:18:47 INFO - retry: Failed, sleeping 60 seconds before retrying 17:19:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/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 17:19:47 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 17:19:47 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 17:19:47 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/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! 17:19:47 INFO - Caught exception: HTTP Error 404: Not Found 17:19:47 INFO - Caught exception: HTTP Error 404: Not Found 17:19:47 INFO - Caught exception: HTTP Error 404: Not Found 17:19:47 INFO - trying https://queue.taskcluster.net/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 17:19:47 INFO - Downloading https://queue.taskcluster.net/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/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 17:19:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/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 17:19:48 INFO - Downloaded 56778201 bytes. 17:19:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 17:19:48 INFO - mkdir: /builds/slave/test/properties 17:19:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:19:48 INFO - Writing to file /builds/slave/test/properties/build_url 17:19:48 INFO - Contents: 17:19:48 INFO - build_url:https://queue.taskcluster.net/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 17:19:49 INFO - Running post-action listener: _resource_record_post_action 17:19:49 INFO - Running post-action listener: set_extra_try_arguments 17:19:49 INFO - [mozharness: 2016-09-28 00:19:49.008163Z] Finished download-and-extract step (success) 17:19:49 INFO - [mozharness: 2016-09-28 00:19:49.008397Z] Running populate-webroot step. 17:19:49 INFO - Running pre-action listener: _resource_record_pre_action 17:19:49 INFO - Running main action method: populate_webroot 17:19:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:19:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:19:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:19:49 INFO - '--tppagecycles', 17:19:49 INFO - '7'], 17:19:49 INFO - 'tests': ['tsvgm']}}, 17:19:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:19:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:19:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:19:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:19:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:19:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:19:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:19:49 INFO - 'talos_options': ['--disable-e10s'], 17:19:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:19:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:19:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:19:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:19:49 INFO - 'talos_options': ['--disable-e10s'], 17:19:49 INFO - 'tests': ['damp', 'tps']}, 17:19:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:19:49 INFO - 'tests': ['damp', 'tps']}, 17:19:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:19:49 INFO - 'tests': ['dromaeo_dom']}, 17:19:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:19:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:19:49 INFO - 'tests': ['basic_compositor_video']}, 17:19:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:19:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:19:49 INFO - 'tests': ['a11yr', 17:19:49 INFO - 'ts_paint', 17:19:49 INFO - 'tpaint', 17:19:49 INFO - 'sessionrestore', 17:19:49 INFO - 'sessionrestore_no_auto_restore', 17:19:49 INFO - 'tabpaint']}, 17:19:49 INFO - 'other-e10s': {'tests': ['a11yr', 17:19:49 INFO - 'ts_paint', 17:19:49 INFO - 'tpaint', 17:19:49 INFO - 'sessionrestore', 17:19:49 INFO - 'sessionrestore_no_auto_restore', 17:19:49 INFO - 'tabpaint']}, 17:19:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:19:49 INFO - 'ts_paint', 17:19:49 INFO - 'tpaint', 17:19:49 INFO - 'sessionrestore', 17:19:49 INFO - 'sessionrestore_no_auto_restore', 17:19:49 INFO - 'tabpaint']}, 17:19:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:19:49 INFO - 'ts_paint', 17:19:49 INFO - 'tpaint', 17:19:49 INFO - 'sessionrestore', 17:19:49 INFO - 'sessionrestore_no_auto_restore', 17:19:49 INFO - 'tabpaint']}, 17:19:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:19:49 INFO - 'tests': ['a11yr', 17:19:49 INFO - 'ts_paint', 17:19:49 INFO - 'tpaint', 17:19:49 INFO - 'sessionrestore', 17:19:49 INFO - 'sessionrestore_no_auto_restore', 17:19:49 INFO - 'tabpaint']}, 17:19:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:19:49 INFO - 'tests': ['a11yr', 17:19:49 INFO - 'ts_paint', 17:19:49 INFO - 'tpaint', 17:19:49 INFO - 'sessionrestore', 17:19:49 INFO - 'sessionrestore_no_auto_restore', 17:19:49 INFO - 'tabpaint']}, 17:19:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:19:49 INFO - 'tests': ['tsvgx', 17:19:49 INFO - 'tsvgr_opacity', 17:19:49 INFO - 'tart', 17:19:49 INFO - 'tscrollx', 17:19:49 INFO - 'cart']}, 17:19:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:19:49 INFO - 'tsvgr_opacity', 17:19:49 INFO - 'tart', 17:19:49 INFO - 'tscrollx', 17:19:49 INFO - 'cart']}, 17:19:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:19:49 INFO - 'talos_options': ['--disable-e10s'], 17:19:49 INFO - 'tests': ['tp5o']}, 17:19:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:19:49 INFO - 'tests': ['tp5o']}, 17:19:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:19:49 INFO - 'talos_options': ['--disable-e10s', 17:19:49 INFO - '--xperf_path', 17:19:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:19:49 INFO - 'tests': ['tp5n']}, 17:19:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:19:49 INFO - 'talos_options': ['--xperf_path', 17:19:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:19:49 INFO - 'tests': ['tp5n']}}, 17:19:49 INFO - 'talos.zip': {'path': '', 17:19:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:19:49 INFO - Running post-action listener: _resource_record_post_action 17:19:49 INFO - [mozharness: 2016-09-28 00:19:49.034119Z] Finished populate-webroot step (success) 17:19:49 INFO - [mozharness: 2016-09-28 00:19:49.034209Z] Running create-virtualenv step. 17:19:49 INFO - Running pre-action listener: _resource_record_pre_action 17:19:49 INFO - Running main action method: create_virtualenv 17:19:49 INFO - Creating virtualenv /builds/slave/test/build/venv 17:19:49 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 17:19:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:19:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:19:49 INFO - Using real prefix '/usr' 17:19:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:19:49 INFO - Installing distribute.............................................................................................................................................................................................done. 17:19:51 INFO - Installing pip.................done. 17:19:51 INFO - Return code: 0 17:19:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:19:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:19:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:19:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:19:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:19:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f4d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220b570>, '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 0x220c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x220c900>, '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': '6d15e502d8e29d5d2676d664000001c3-1475021269.926239-1991999502', '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 17:19:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:19:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:19:51 INFO - Using env: {'DISPLAY': ':0', 17:19:51 INFO - 'HOME': '/home/cltbld', 17:19:51 INFO - 'LANG': 'en_US.UTF-8', 17:19:51 INFO - 'LANGUAGE': 'en_US:en', 17:19:51 INFO - 'LOGNAME': 'cltbld', 17:19:51 INFO - 'MAIL': '/var/mail/cltbld', 17:19:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:19:51 INFO - 'MOZ_NO_REMOTE': '1', 17:19:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:19:51 INFO - 'NO_EM_RESTART': '1', 17:19:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:19:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:19:51 INFO - 'PWD': '/builds/slave/test', 17:19:51 INFO - 'SHELL': '/bin/bash', 17:19:51 INFO - 'SHLVL': '1', 17:19:51 INFO - 'TERM': 'linux', 17:19:51 INFO - 'TMOUT': '86400', 17:19:51 INFO - 'USER': 'cltbld', 17:19:51 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1475021269.926239-1991999502', 17:19:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:19:51 INFO - '_': '/tools/buildbot/bin/python'} 17:19:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:19:51 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 17:19:51 INFO - Cleaning up... 17:19:51 INFO - Return code: 0 17:19:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:19:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:19:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:19:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:19:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:19:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1f4d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220b570>, '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 0x220c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x220c900>, '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': '6d15e502d8e29d5d2676d664000001c3-1475021269.926239-1991999502', '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 17:19:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:19:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:19:51 INFO - Using env: {'DISPLAY': ':0', 17:19:51 INFO - 'HOME': '/home/cltbld', 17:19:51 INFO - 'LANG': 'en_US.UTF-8', 17:19:51 INFO - 'LANGUAGE': 'en_US:en', 17:19:51 INFO - 'LOGNAME': 'cltbld', 17:19:51 INFO - 'MAIL': '/var/mail/cltbld', 17:19:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:19:51 INFO - 'MOZ_NO_REMOTE': '1', 17:19:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:19:51 INFO - 'NO_EM_RESTART': '1', 17:19:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:19:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:19:51 INFO - 'PWD': '/builds/slave/test', 17:19:51 INFO - 'SHELL': '/bin/bash', 17:19:51 INFO - 'SHLVL': '1', 17:19:51 INFO - 'TERM': 'linux', 17:19:51 INFO - 'TMOUT': '86400', 17:19:51 INFO - 'USER': 'cltbld', 17:19:51 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1475021269.926239-1991999502', 17:19:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:19:51 INFO - '_': '/tools/buildbot/bin/python'} 17:19:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:19:52 INFO - Downloading/unpacking psutil>=3.1.1 17:19:52 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 17:19:52 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 17:19:52 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 17:19:52 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 17:19:52 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 17:19:52 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 17:19:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:19:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:19:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:19:54 INFO - Installing collected packages: psutil 17:19:54 INFO - Running setup.py install for psutil 17:19:54 INFO - building 'psutil._psutil_linux' extension 17:19:54 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 17:19:54 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 17:19:54 INFO - building 'psutil._psutil_posix' extension 17:19:54 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 17:19:54 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 17:19:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:19:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:19:54 INFO - Successfully installed psutil 17:19:54 INFO - Cleaning up... 17:19:54 INFO - Return code: 0 17:19:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:19: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')]} 17:19:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:19:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19: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')]} 17:19:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:19:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f4d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220b570>, '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 0x220c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x220c900>, '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': '6d15e502d8e29d5d2676d664000001c3-1475021269.926239-1991999502', '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 17:19:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:19:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:19:54 INFO - Using env: {'DISPLAY': ':0', 17:19:54 INFO - 'HOME': '/home/cltbld', 17:19:54 INFO - 'LANG': 'en_US.UTF-8', 17:19:54 INFO - 'LANGUAGE': 'en_US:en', 17:19:54 INFO - 'LOGNAME': 'cltbld', 17:19:54 INFO - 'MAIL': '/var/mail/cltbld', 17:19:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:19:54 INFO - 'MOZ_NO_REMOTE': '1', 17:19:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:19:54 INFO - 'NO_EM_RESTART': '1', 17:19:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:19:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:19:54 INFO - 'PWD': '/builds/slave/test', 17:19:54 INFO - 'SHELL': '/bin/bash', 17:19:54 INFO - 'SHLVL': '1', 17:19:54 INFO - 'TERM': 'linux', 17:19:54 INFO - 'TMOUT': '86400', 17:19:54 INFO - 'USER': 'cltbld', 17:19:54 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1475021269.926239-1991999502', 17:19:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:19:54 INFO - '_': '/tools/buildbot/bin/python'} 17:19:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:19:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:19:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:19:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:19:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:19:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:19:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:19:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:19:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:19:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:19:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:19:56 INFO - Installing collected packages: mozsystemmonitor 17:19:56 INFO - Running setup.py install for mozsystemmonitor 17:19:56 INFO - Successfully installed mozsystemmonitor 17:19:56 INFO - Cleaning up... 17:19:56 INFO - Return code: 0 17:19:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:19:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:19:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:19:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:19:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:19:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1f4d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220b570>, '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 0x220c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x220c900>, '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': '6d15e502d8e29d5d2676d664000001c3-1475021269.926239-1991999502', '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 17:19:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:19:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:19:57 INFO - Using env: {'DISPLAY': ':0', 17:19:57 INFO - 'HOME': '/home/cltbld', 17:19:57 INFO - 'LANG': 'en_US.UTF-8', 17:19:57 INFO - 'LANGUAGE': 'en_US:en', 17:19:57 INFO - 'LOGNAME': 'cltbld', 17:19:57 INFO - 'MAIL': '/var/mail/cltbld', 17:19:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:19:57 INFO - 'MOZ_NO_REMOTE': '1', 17:19:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:19:57 INFO - 'NO_EM_RESTART': '1', 17:19:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:19:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:19:57 INFO - 'PWD': '/builds/slave/test', 17:19:57 INFO - 'SHELL': '/bin/bash', 17:19:57 INFO - 'SHLVL': '1', 17:19:57 INFO - 'TERM': 'linux', 17:19:57 INFO - 'TMOUT': '86400', 17:19:57 INFO - 'USER': 'cltbld', 17:19:57 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1475021269.926239-1991999502', 17:19:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:19:57 INFO - '_': '/tools/buildbot/bin/python'} 17:19:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:19:57 INFO - Downloading/unpacking jsonschema==2.5.1 17:19:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:19:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:19:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:19:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:19:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:19:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:19:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:19:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:19:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:19:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:19:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:19:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:19:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:19:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:19:59 INFO - Downloading functools32-3.2.3-2.tar.gz 17:19:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:19:59 INFO - warning: no files found matching '*.txt' 17:19:59 INFO - no previously-included directories found matching 'build' 17:19:59 INFO - no previously-included directories found matching 'dist' 17:19:59 INFO - no previously-included directories found matching '.git*' 17:19:59 INFO - Installing collected packages: jsonschema, functools32 17:19:59 INFO - Running setup.py install for functools32 17:19:59 INFO - warning: no files found matching '*.txt' 17:19:59 INFO - no previously-included directories found matching 'build' 17:19:59 INFO - no previously-included directories found matching 'dist' 17:19:59 INFO - no previously-included directories found matching '.git*' 17:19:59 INFO - Successfully installed jsonschema functools32 17:19:59 INFO - Cleaning up... 17:19:59 INFO - Return code: 0 17:19:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:19:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:19:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:19:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:19:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:19:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1f4d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220b570>, '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 0x220c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x220c900>, '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': '6d15e502d8e29d5d2676d664000001c3-1475021269.926239-1991999502', '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 17:19:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:19:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:19:59 INFO - Using env: {'DISPLAY': ':0', 17:19:59 INFO - 'HOME': '/home/cltbld', 17:19:59 INFO - 'LANG': 'en_US.UTF-8', 17:19:59 INFO - 'LANGUAGE': 'en_US:en', 17:19:59 INFO - 'LOGNAME': 'cltbld', 17:19:59 INFO - 'MAIL': '/var/mail/cltbld', 17:19:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:19:59 INFO - 'MOZ_NO_REMOTE': '1', 17:19:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:19:59 INFO - 'NO_EM_RESTART': '1', 17:19:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:19:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:19:59 INFO - 'PWD': '/builds/slave/test', 17:19:59 INFO - 'SHELL': '/bin/bash', 17:19:59 INFO - 'SHLVL': '1', 17:19:59 INFO - 'TERM': 'linux', 17:19:59 INFO - 'TMOUT': '86400', 17:19:59 INFO - 'USER': 'cltbld', 17:19:59 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1475021269.926239-1991999502', 17:19:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:19:59 INFO - '_': '/tools/buildbot/bin/python'} 17:19:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:19:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:19:59 INFO - Cleaning up... 17:19:59 INFO - Return code: 0 17:19:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:19:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:19:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:19:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:19:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:19:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f4d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220b570>, '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 0x220c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x220c900>, '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': '6d15e502d8e29d5d2676d664000001c3-1475021269.926239-1991999502', '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 17:19:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:19:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:19:59 INFO - Using env: {'DISPLAY': ':0', 17:19:59 INFO - 'HOME': '/home/cltbld', 17:19:59 INFO - 'LANG': 'en_US.UTF-8', 17:19:59 INFO - 'LANGUAGE': 'en_US:en', 17:19:59 INFO - 'LOGNAME': 'cltbld', 17:19:59 INFO - 'MAIL': '/var/mail/cltbld', 17:19:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:19:59 INFO - 'MOZ_NO_REMOTE': '1', 17:19:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:19:59 INFO - 'NO_EM_RESTART': '1', 17:19:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:19:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:19:59 INFO - 'PWD': '/builds/slave/test', 17:19:59 INFO - 'SHELL': '/bin/bash', 17:19:59 INFO - 'SHLVL': '1', 17:19:59 INFO - 'TERM': 'linux', 17:19:59 INFO - 'TMOUT': '86400', 17:19:59 INFO - 'USER': 'cltbld', 17:19:59 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1475021269.926239-1991999502', 17:19:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:19:59 INFO - '_': '/tools/buildbot/bin/python'} 17:19:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:19:59 INFO - Downloading/unpacking blobuploader==1.2.4 17:19:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:19:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:19:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:19:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:19:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:19:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:01 INFO - Downloading blobuploader-1.2.4.tar.gz 17:20:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:20:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:20:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:20:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:20:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:20:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:20:02 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 17:20:02 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 17:20:02 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 17:20:02 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 17:20:02 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 17:20:02 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 17:20:02 INFO - Downloading docopt-0.6.1.tar.gz 17:20:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:20:02 INFO - Installing collected packages: blobuploader, requests, docopt 17:20:02 INFO - Running setup.py install for blobuploader 17:20:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:20:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:20:02 INFO - Running setup.py install for requests 17:20:03 INFO - Running setup.py install for docopt 17:20:03 INFO - Successfully installed blobuploader requests docopt 17:20:03 INFO - Cleaning up... 17:20:03 INFO - Return code: 0 17:20:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:20: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')]} 17:20:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:20:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20: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')]} 17:20:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:20:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:03 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 0x1f4d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220b570>, '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 0x220c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x220c900>, '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': '6d15e502d8e29d5d2676d664000001c3-1475021269.926239-1991999502', '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 17:20:03 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 17:20:03 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 17:20:03 INFO - Using env: {'DISPLAY': ':0', 17:20:03 INFO - 'HOME': '/home/cltbld', 17:20:03 INFO - 'LANG': 'en_US.UTF-8', 17:20:03 INFO - 'LANGUAGE': 'en_US:en', 17:20:03 INFO - 'LOGNAME': 'cltbld', 17:20:03 INFO - 'MAIL': '/var/mail/cltbld', 17:20:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:03 INFO - 'MOZ_NO_REMOTE': '1', 17:20:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:03 INFO - 'NO_EM_RESTART': '1', 17:20:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:03 INFO - 'PWD': '/builds/slave/test', 17:20:03 INFO - 'SHELL': '/bin/bash', 17:20:03 INFO - 'SHLVL': '1', 17:20:03 INFO - 'TERM': 'linux', 17:20:03 INFO - 'TMOUT': '86400', 17:20:03 INFO - 'USER': 'cltbld', 17:20:03 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1475021269.926239-1991999502', 17:20:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:03 INFO - '_': '/tools/buildbot/bin/python'} 17:20:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:20:03 INFO - Running setup.py (path:/tmp/pip-tVr5bE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:20:03 INFO - Running setup.py (path:/tmp/pip-Iq8CK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:20:03 INFO - Running setup.py (path:/tmp/pip-czYQUv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:20:03 INFO - Running setup.py (path:/tmp/pip-1jAv1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:20:03 INFO - Running setup.py (path:/tmp/pip-LNgQex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:20:03 INFO - Running setup.py (path:/tmp/pip-nld8ZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:20:03 INFO - Running setup.py (path:/tmp/pip-9rVSPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:20:04 INFO - Running setup.py (path:/tmp/pip-0pUiX5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:20:04 INFO - Running setup.py (path:/tmp/pip-0ue3Ro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:20:04 INFO - Running setup.py (path:/tmp/pip-vW3Lzc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:20:04 INFO - Running setup.py (path:/tmp/pip-kNbiN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:20:04 INFO - Running setup.py (path:/tmp/pip-w7QuXT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:20:04 INFO - Running setup.py (path:/tmp/pip-rFpyLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:20:04 INFO - Running setup.py (path:/tmp/pip-y_PrHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:20:04 INFO - Running setup.py (path:/tmp/pip-kRTFpR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:20:04 INFO - Running setup.py (path:/tmp/pip-Evqj07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:20:04 INFO - Running setup.py (path:/tmp/pip-k4qCeZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:20:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:20:04 INFO - Running setup.py install for manifestparser 17:20:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:20:04 INFO - Running setup.py install for mozcrash 17:20:04 INFO - Running setup.py install for mozdebug 17:20:04 INFO - Running setup.py install for mozdevice 17:20:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:20:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:20:05 INFO - Running setup.py install for mozfile 17:20:05 INFO - Running setup.py install for mozhttpd 17:20:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:20:05 INFO - Running setup.py install for mozinfo 17:20:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:20:05 INFO - Running setup.py install for mozInstall 17:20:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:20:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:20:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:20:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:20:05 INFO - Running setup.py install for mozleak 17:20:05 INFO - Running setup.py install for mozlog 17:20:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:20:05 INFO - Running setup.py install for moznetwork 17:20:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:20:05 INFO - Running setup.py install for mozprocess 17:20:05 INFO - Running setup.py install for mozprofile 17:20:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:20:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:20:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:20:06 INFO - Running setup.py install for mozrunner 17:20:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:20:06 INFO - Running setup.py install for mozscreenshot 17:20:06 INFO - Running setup.py install for moztest 17:20:06 INFO - Running setup.py install for mozversion 17:20:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:20:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:20:06 INFO - Cleaning up... 17:20:06 INFO - Return code: 0 17:20:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:20:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:20:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:20:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:20:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:20:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f4d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220b570>, '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 0x220c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x220c900>, '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': '6d15e502d8e29d5d2676d664000001c3-1475021269.926239-1991999502', '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 17:20:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:20:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:20:06 INFO - Using env: {'DISPLAY': ':0', 17:20:06 INFO - 'HOME': '/home/cltbld', 17:20:06 INFO - 'LANG': 'en_US.UTF-8', 17:20:06 INFO - 'LANGUAGE': 'en_US:en', 17:20:06 INFO - 'LOGNAME': 'cltbld', 17:20:06 INFO - 'MAIL': '/var/mail/cltbld', 17:20:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:06 INFO - 'MOZ_NO_REMOTE': '1', 17:20:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:06 INFO - 'NO_EM_RESTART': '1', 17:20:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:06 INFO - 'PWD': '/builds/slave/test', 17:20:06 INFO - 'SHELL': '/bin/bash', 17:20:06 INFO - 'SHLVL': '1', 17:20:06 INFO - 'TERM': 'linux', 17:20:06 INFO - 'TMOUT': '86400', 17:20:06 INFO - 'USER': 'cltbld', 17:20:06 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1475021269.926239-1991999502', 17:20:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:06 INFO - '_': '/tools/buildbot/bin/python'} 17:20:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:20:06 INFO - Running setup.py (path:/tmp/pip-kQ71EC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:20:06 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:20:06 INFO - Running setup.py (path:/tmp/pip-vW8JDP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:20:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:20:06 INFO - Running setup.py (path:/tmp/pip-dKTRg4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:20:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:20:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:20:06 INFO - Running setup.py (path:/tmp/pip-Fqyhnt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:20:07 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)) 17:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:20:07 INFO - Running setup.py (path:/tmp/pip-osYHlb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:20:07 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)) 17:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:20:07 INFO - Running setup.py (path:/tmp/pip-utHCkB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:20:07 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)) 17:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:20:07 INFO - Running setup.py (path:/tmp/pip-z4rSGu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:20:07 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)) 17:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:20:07 INFO - Running setup.py (path:/tmp/pip-eZLDR_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:20:07 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)) 17:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:20:07 INFO - Running setup.py (path:/tmp/pip-9fj7mo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:20:07 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)) 17:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:20:07 INFO - Running setup.py (path:/tmp/pip-X6OMbN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:20:07 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)) 17:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:20:07 INFO - Running setup.py (path:/tmp/pip-SuoTVd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:20:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:20:07 INFO - Running setup.py (path:/tmp/pip-3XxTlp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:20:07 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)) 17:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:20:07 INFO - Running setup.py (path:/tmp/pip-qO8uWQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:20:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:20:07 INFO - Running setup.py (path:/tmp/pip-_RFukK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:20:07 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)) 17:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:20:07 INFO - Running setup.py (path:/tmp/pip-OkZPgN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:20:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:20:07 INFO - Running setup.py (path:/tmp/pip-NyVgcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:20:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:20:07 INFO - Running setup.py (path:/tmp/pip-FRy08A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:20:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:20:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:20:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:20:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:20:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:20:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:20:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:20:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:20:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:20:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:20:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:20:09 INFO - Downloading blessings-1.6.tar.gz 17:20:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:20:09 INFO - Installing collected packages: blessings 17:20:09 INFO - Running setup.py install for blessings 17:20:10 INFO - Successfully installed blessings 17:20:10 INFO - Cleaning up... 17:20:10 INFO - Return code: 0 17:20:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:20:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:20:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:20:10 INFO - Reading from file tmpfile_stdout 17:20:10 INFO - Current package versions: 17:20:10 INFO - argparse == 1.2.1 17:20:10 INFO - blessings == 1.6 17:20:10 INFO - blobuploader == 1.2.4 17:20:10 INFO - docopt == 0.6.1 17:20:10 INFO - functools32 == 3.2.3-2 17:20:10 INFO - jsonschema == 2.5.1 17:20:10 INFO - manifestparser == 1.1 17:20:10 INFO - mozInstall == 1.12 17:20:10 INFO - mozcrash == 0.17 17:20:10 INFO - mozdebug == 0.1 17:20:10 INFO - mozdevice == 0.48 17:20:10 INFO - mozfile == 1.2 17:20:10 INFO - mozhttpd == 0.7 17:20:10 INFO - mozinfo == 0.9 17:20:10 INFO - mozleak == 0.1 17:20:10 INFO - mozlog == 3.3 17:20:10 INFO - moznetwork == 0.27 17:20:10 INFO - mozprocess == 0.23 17:20:10 INFO - mozprofile == 0.28 17:20:10 INFO - mozrunner == 6.12 17:20:10 INFO - mozscreenshot == 0.1 17:20:10 INFO - mozsystemmonitor == 0.3 17:20:10 INFO - moztest == 0.7 17:20:10 INFO - mozversion == 1.4 17:20:10 INFO - psutil == 3.1.1 17:20:10 INFO - requests == 1.2.3 17:20:10 INFO - wsgiref == 0.1.2 17:20:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:20:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:20:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:20:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:20:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:20:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:10 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 0x1f4d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220b570>, '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 0x220c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x220c900>, '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': '6d15e502d8e29d5d2676d664000001c3-1475021269.926239-1991999502', '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 17:20:10 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 17:20:10 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 17:20:10 INFO - Using env: {'DISPLAY': ':0', 17:20:10 INFO - 'HOME': '/home/cltbld', 17:20:10 INFO - 'LANG': 'en_US.UTF-8', 17:20:10 INFO - 'LANGUAGE': 'en_US:en', 17:20:10 INFO - 'LOGNAME': 'cltbld', 17:20:10 INFO - 'MAIL': '/var/mail/cltbld', 17:20:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:10 INFO - 'MOZ_NO_REMOTE': '1', 17:20:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:10 INFO - 'NO_EM_RESTART': '1', 17:20:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:10 INFO - 'PWD': '/builds/slave/test', 17:20:10 INFO - 'SHELL': '/bin/bash', 17:20:10 INFO - 'SHLVL': '1', 17:20:10 INFO - 'TERM': 'linux', 17:20:10 INFO - 'TMOUT': '86400', 17:20:10 INFO - 'USER': 'cltbld', 17:20:10 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1475021269.926239-1991999502', 17:20:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:10 INFO - '_': '/tools/buildbot/bin/python'} 17:20:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:20:10 INFO - Cleaning up... 17:20:10 INFO - Return code: 0 17:20:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:20:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:20:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:20:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:20:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:20:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:20:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f4d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x220b570>, '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 0x220c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x220c900>, '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': '6d15e502d8e29d5d2676d664000001c3-1475021269.926239-1991999502', '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 17:20:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:20:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:20:10 INFO - Using env: {'DISPLAY': ':0', 17:20:10 INFO - 'HOME': '/home/cltbld', 17:20:10 INFO - 'LANG': 'en_US.UTF-8', 17:20:10 INFO - 'LANGUAGE': 'en_US:en', 17:20:10 INFO - 'LOGNAME': 'cltbld', 17:20:10 INFO - 'MAIL': '/var/mail/cltbld', 17:20:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:10 INFO - 'MOZ_NO_REMOTE': '1', 17:20:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:10 INFO - 'NO_EM_RESTART': '1', 17:20:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:10 INFO - 'PWD': '/builds/slave/test', 17:20:10 INFO - 'SHELL': '/bin/bash', 17:20:10 INFO - 'SHLVL': '1', 17:20:10 INFO - 'TERM': 'linux', 17:20:10 INFO - 'TMOUT': '86400', 17:20:10 INFO - 'USER': 'cltbld', 17:20:10 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1475021269.926239-1991999502', 17:20:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:10 INFO - '_': '/tools/buildbot/bin/python'} 17:20:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:20:10 INFO - Cleaning up... 17:20:10 INFO - Return code: 0 17:20:10 INFO - Running post-action listener: _resource_record_post_action 17:20:10 INFO - Running post-action listener: _start_resource_monitoring 17:20:10 INFO - Starting resource monitoring. 17:20:10 INFO - [mozharness: 2016-09-28 00:20:10.789717Z] Finished create-virtualenv step (success) 17:20:10 INFO - [mozharness: 2016-09-28 00:20:10.790185Z] Running install step. 17:20:10 INFO - Running pre-action listener: _resource_record_pre_action 17:20:10 INFO - Running main action method: install 17:20:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:20:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:20:10 INFO - Reading from file tmpfile_stdout 17:20:10 INFO - Detecting whether we're running mozinstall >=1.0... 17:20:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:20:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:20:11 INFO - Reading from file tmpfile_stdout 17:20:11 INFO - Output received: 17:20:11 INFO - Usage: mozinstall [options] installer 17:20:11 INFO - Options: 17:20:11 INFO - -h, --help show this help message and exit 17:20:11 INFO - -d DEST, --destination=DEST 17:20:11 INFO - Directory to install application into. [default: 17:20:11 INFO - "/builds/slave/test"] 17:20:11 INFO - --app=APP Application being installed. [default: firefox] 17:20:11 INFO - mkdir: /builds/slave/test/build/application 17:20:11 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'] 17:20:11 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 17:20:25 INFO - Reading from file tmpfile_stdout 17:20:25 INFO - Output received: 17:20:25 INFO - /builds/slave/test/build/application/firefox/firefox 17:20:25 INFO - Running post-action listener: _resource_record_post_action 17:20:25 INFO - [mozharness: 2016-09-28 00:20:25.150306Z] Finished install step (success) 17:20:25 INFO - [mozharness: 2016-09-28 00:20:25.150589Z] Running run-tests step. 17:20:25 INFO - Running pre-action listener: _resource_record_pre_action 17:20:25 INFO - Running main action method: run_tests 17:20:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:20:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:20:25 INFO - Python 2.7.3 17:20:25 INFO - Return code: 0 17:20:25 INFO - grabbing minidump binary from tooltool 17:20:25 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')]} 17:20:25 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 0x220b570>, '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 0x220c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x220c900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:20:25 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 17:20:25 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 17:20:25 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 17:20:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:20:25 INFO - Return code: 0 17:20:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:20:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:20:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:20:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:20:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:20:25 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/ZTPlyN3PQL6ZxlJvGNlLbg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 17:20:25 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/ZTPlyN3PQL6ZxlJvGNlLbg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 17:20:25 INFO - Using env: {'DISPLAY': ':0', 17:20:25 INFO - 'HOME': '/home/cltbld', 17:20:25 INFO - 'LANG': 'en_US.UTF-8', 17:20:25 INFO - 'LANGUAGE': 'en_US:en', 17:20:25 INFO - 'LOGNAME': 'cltbld', 17:20:25 INFO - 'MAIL': '/var/mail/cltbld', 17:20:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:20:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:20:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:20:25 INFO - 'MOZ_NO_REMOTE': '1', 17:20:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:20:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:20:25 INFO - 'NO_EM_RESTART': '1', 17:20:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:20:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:20:25 INFO - 'PWD': '/builds/slave/test', 17:20:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:20:25 INFO - 'SHELL': '/bin/bash', 17:20:25 INFO - 'SHLVL': '1', 17:20:25 INFO - 'TERM': 'linux', 17:20:25 INFO - 'TMOUT': '86400', 17:20:25 INFO - 'USER': 'cltbld', 17:20:25 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1475021269.926239-1991999502', 17:20:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:20:25 INFO - '_': '/tools/buildbot/bin/python'} 17:20:25 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/ZTPlyN3PQL6ZxlJvGNlLbg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 17:20:25 INFO - mozversion application_buildid: 20160927142619 17:20:25 INFO - mozversion application_changeset: 308c6210f18bc167cddc4eae8261fc0eff78e1c4 17:20:25 INFO - mozversion application_display_name: Firefox 17:20:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:20:25 INFO - mozversion application_name: Firefox 17:20:25 INFO - mozversion application_remotingname: firefox 17:20:25 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 17:20:25 INFO - mozversion application_vendor: Mozilla 17:20:25 INFO - mozversion application_version: 50.0 17:20:25 INFO - mozversion platform_buildid: 20160927142619 17:20:25 INFO - mozversion platform_changeset: 308c6210f18bc167cddc4eae8261fc0eff78e1c4 17:20:25 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 17:20:25 INFO - mozversion platform_version: 50.0 17:20:25 INFO - using testdate: 1475022025 17:20:25 INFO - actual date: 1475022025 17:20:25 INFO - starting webserver on 'localhost:50611' 17:20:25 INFO - SUITE-START | Running 2 tests 17:20:25 INFO - TEST-START | dromaeo_css 17:20:25 INFO - operating with platform_type : linux_ 17:20:25 INFO - Initialising browser for dromaeo_css test... 17:20:25 INFO - TEST-INFO | started process 28227 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1wNg0z/profile http://localhost:50611/getInfo.html) 17:20:29 INFO - PROCESS | 28227 | __metrics Screen width/height:1600/1200 17:20:29 INFO - PROCESS | 28227 | colorDepth:24 17:20:29 INFO - PROCESS | 28227 | Browser inner width/height: 1024/697 17:20:29 INFO - PROCESS | 28227 | __metrics 17:20:30 ERROR - PROCESS | 28227 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 17:20:30 INFO - TEST-INFO | 28227: exit 0 17:20:30 INFO - Browser initialized. 17:20:30 INFO - Running cycle 1/1 for dromaeo_css test... 17:20:30 INFO - TEST-INFO | started process 28352 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1wNg0z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:20:42 INFO - PROCESS | 28352 | RSS: Main: 150212608 17:20:42 INFO - PROCESS | 28352 | 17:21:32 INFO - PROCESS | 28352 | 1475022092145 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] 17:23:40 INFO - PROCESS | 28352 | Cycle 1(1): loaded http://localhost:50611/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50611/tests/dromaeo/cssquery-ext.html) 17:23:41 INFO - PROCESS | 28352 | RSS: Main: 159416320 17:23:41 INFO - PROCESS | 28352 | 17:26:44 INFO - PROCESS | 28352 | Cycle 1(1): loaded http://localhost:50611/tests/dromaeo/cssquery-ext.html (next: http://localhost:50611/tests/dromaeo/cssquery-jquery.html) 17:26:44 INFO - PROCESS | 28352 | RSS: Main: 155340800 17:26:44 INFO - PROCESS | 28352 | 17:29:46 INFO - PROCESS | 28352 | Cycle 1(1): loaded http://localhost:50611/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50611/tests/dromaeo/cssquery-mootools.html) 17:29:46 INFO - PROCESS | 28352 | RSS: Main: 155541504 17:29:46 INFO - PROCESS | 28352 | 17:32:48 INFO - PROCESS | 28352 | Cycle 1(1): loaded http://localhost:50611/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50611/tests/dromaeo/cssquery-prototype.html) 17:32:49 INFO - PROCESS | 28352 | RSS: Main: 156205056 17:32:49 INFO - PROCESS | 28352 | 17:35:51 INFO - PROCESS | 28352 | Cycle 1(1): loaded http://localhost:50611/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50611/tests/dromaeo/cssquery-yui.html) 17:35:52 INFO - PROCESS | 28352 | RSS: Main: 157310976 17:35:52 INFO - PROCESS | 28352 | 17:38:54 INFO - PROCESS | 28352 | Cycle 1(1): loaded http://localhost:50611/tests/dromaeo/cssquery-yui.html (next: http://localhost:50611/tests/dromaeo/cssquery-dojo.html) 17:38:54 INFO - PROCESS | 28352 | RSS: Main: 157327360 17:38:54 INFO - PROCESS | 28352 | 17:38:54 INFO - PROCESS | 28352 | __start_tp_report 17:38:54 INFO - PROCESS | 28352 | _x_x_mozilla_page_load 17:38:54 INFO - PROCESS | 28352 | _x_x_mozilla_page_load_details 17:38:54 INFO - PROCESS | 28352 | |i|pagename|runs| 17:38:54 INFO - PROCESS | 28352 | |0;dojo.html;3303.504474328851;3329.716974057205;3335.099523128754;3346.29727757171;3361.3949489091956;5736.368999410061;5860.296764388274;5884.470397664215;5887.676177810219;5927.1109333599925;5728.770849166039;5769.855753606162;5810.912836307459;5812.970935145329;5815.127730840365;5204.687718736869;5272.920906186391;5302.814401495948;5310.468953104697;5317.9468205318035;5278.788848446057;5279.445658205891;5284.762185701634;5316.255724198615;5369.221462887879;5277.3139491866;5286;5287.550558202538;5309.389420216667;5363.249145119687;5340.54605358545;5352.5182733553975;5355.277037599952;5362.865928351823;5381.838544843661;5054.469280725508;5120.795168193268;5165.638405311592;5244.842654720364;5249.658772179796;5770.711464426804;5802.738876750556;5817.418258174191;5824.504917082053;5872.559558033165;6207.099970504251;6245.219347581552;6261.655608941506;6267.529935254828;6276.654783986879;6055.485283750886;6216.906746398808;6250.281217659982;6304.275008374004;6310.716017779211;5918.023526118229;5927.051671732502;5935.169076329317;5939.168516407706;5961.254843144607;6434.7104380303;6473.902891456632;6475.287718350977;6479.319671434526;6493.448056915121;6015.428534289235;6027.21646185993;6053.334133245339;6157.4458298753325;6219.564630475914;6136.17161683176;6137.297691397357;6145.432914606747;6175.752969881244;6181.7527298908435;6179.258488981351;6184.257889053342;6188.597741146811;6202.100695399142;6210.844728881723;6112.358202388685;6117.724702388314;6126.203593532812;6139.631622102688;6165.445109940127;4766.142094422968;4786.234202527578;4791.592714619227;4799.0401919615515;4822.541858523435;4208.0321526048565;4226.704130710821;4236.5128010278595;4241.809118589671;4251.958270223753;5903.911441328383;5951.464368206882;5966.671833049137;6002.729877155539;6042.6978651067275;6275.1842260506755;6296.496280297565;6308.337624549356;6323.30443651198;6323.841903952438;5971.0744834550715;5982.2223110996165;5986.461218490357;5995.670238136857;6024.789132380346;5304.310439642822;5314.92027619586;5347.625666203328;5381.542568881689;5382.30030096085;6450.5484616077365;6459.935400645933;6460.580062295936;6469.870602587922;6469.997150441784;6329.936700632935;6333.145025421509;6334.303226645157;6341.714622841891;6348.714307856065;6303.896818056914;6432.195975503062;6442.162518872704;6464.450521705519;6498.642574658439;6295.716692748929;6297.52768542352;6304.779332723333;6305.779297724557;6307.432331090224;6358.682065896594;6412.35876412355;6427.775027874002;6428.774992875227;6429.067785171217;6071.332153463204;6087.908681369871;6091.5126789857595;6240.219972503437;6253.812385628438;6163.137160797582;6208.4722798562625;6215.751369945152;6219.875602488016;6220.906686399798;6039.728212230372;6064.878702426015;6093.664848433379;6159.014557670751;6159.907601385893;6002.279726432856;6109.816705498843;6123.801220575414;6125.387461253839;6172.845678858064;6090.086487026804;6137.346341658241;6139.408446059106;6142.775043102407;6170.907436388368 17:38:54 INFO - PROCESS | 28352 | |1;ext.html;581.8399940016495;648.870225954809;664.3588936676107;672.5225090185965;733.2703959560239;41647.79176104119;46745.532544674585;46762;46762.298565521545;46831.29753053707;47490.76254618731;47914.281285780744;47957.520424795744;48026;48065;8900.510471924026;9072.22886054683;9079.591418386188;9082.77293067672;9105.590248438835;9076.77308067297;9099.863502047474;9165.450072995642;9192.31057670674;9226.723198304062;9231.399959002643;9262.073792620718;9284.07159284073;9335.673251436201;9376.20302274304;9153.08469153086;9165.54172291386;9243.907560924406;9260.722178334661;9282.675106371313;9099.135582119688;9173.587188576463;9189.586468608928;9197.724068277963;9221.308401869886;44435.55564444346;44694.55305446936;44806;44877;44884.326735099;3510.508528805969;3584.9283014339567;3594.730395220343;3661.743677942545;3710.109573702319;35258.29483410317;35587.82206088979;35657.82171089154;35767.64232357669;36230.45654315187;4679.789409476582;4711.4346278446465;4770.880727981794;4795.448523419782;4837.177679794443;365824;367815;368341;370826.9999999973;371018;67630;67874;68005.99999999901;68110.31889681138;68115.65942170356;40450.797746011085;71223.28776712167;71232;71268;71282.28717712757;13967;14550.199739014455;14631.341589628491;14676.486322978644;14698.11811291326;11368.545258189744;11520.596779112691;11525.193236473366;11546.076313894868;11568;21234.938253087283;21270.468238293855;21370.145194192057;21441;21455.356339309845;7563.924360756432;7654.2345765424125;7832.225125266604;7882.408819338572;7942.245486678757;1052.8210204265292;1102.3826657072066;1124.6288724720823;1165;1209.6434917319623;33895;33930;34235;34240.828795855865;34815.12962175915;1120.781447617723;1157.8610566732045;1167.200467679642;1170.0814860334767;1215.598852378713;17445.476635700696;17607.823921760617;17852.46442606724;18049.007304598374;18092.90953545224;424060;424539;598223;600993;601230;65236.34763652398;65389.67305163444;65544.67227663926;65736;65768.67115664486;1460.2771628043974;1460.8539146085518;1482.5922871210503;1493.1712899340753;1509.9169545674874;34669.653303467654;34729;34922.650773492955;35011.82494087513;35465.468017979234;57164;57709.711451442476;57844.13233801581;58005;58201.70899145477;531157;531976;535216;538362.2327553505;539146;30714.692853071185;30931.84534077315;30995.845020774752;31193;31559.52660710045;52093.47906521038;52672.73663631657;53321;53505.464945350046;53688.1946770791;44190.558094418644;44589.33116003198;44730.77634611806;45658.54341456543;48050.519494804605;46617.300740488245;46679;46706;47096;47137.52862471331;45448.54551454443;45933.77033114947;46013.309800352356;46554.767226163654;48152.27771583499;38373.808130959165;39545;39903.85336138471;40035.799821000706;40915.7954210239;30151.246218843826;30642.233944151576;30695.693043070176;30796.846015769777;31168.22079448032 17:38:54 INFO - PROCESS | 28352 | |2;jquery.html;413.25820152825673;425.1280710419027;429.53824638513595;430.82120919818277;440.1636889909173;19197.808021919776;20381.28665496708;20819.16723331067;20871.79128208721;20898.05958731857;20137.798622013775;20556.177752889867;20657.17371305146;20871.37385878426;20893.895530522364;5843.970780146094;6123.2039834821635;6129.509639228873;6134.294556126058;6134.570580059375;5877.8824423511505;6009.729562169713;6037.094435834616;6037.124616930542;6041.6375017499095;5960;5997.100434934751;5997.700114994254;6000.639961602296;6011.969940150293;5794.478496935275;5875.353711091777;5916.3787802280785;5922.792702255443;5931.822045338604;5289.735513224362;5297.735113244361;5301.045811753883;5334.67991920486;5338.172583249564;20513.17947282107;23405.648915266283;23599.05603775847;23757.7624223759;23917.402064948343;2505.473850491399;2580.419405633736;2604.414006848463;2613.1899111275566;2622.7508386703234;15028.09831410108;15321.540353789404;15586.922065389714;16177.19114044293;16558.420455284006;2051.866628669147;2107.1571371451387;2114.74623045234;2154.89225538724;2187.7593464718866;60041.699791501196;83533.99999999939;83600;84540;84817;9767.41395516257;10398.428086455166;10426.739331516772;10527.736806579744;10534.315269507457;14210.573682789325;14226.85773142276;14250.073745206528;14263.714725705428;14300.713985720227;7304.744333948286;7448.255174482617;7482.363999060032;7543.0948286206;7843.254890785366;7036.261192574808;7046.260142685047;7054.611996340251;7219.169795473483;7245.529040612449;4375.146846364992;4409.096135292258;4419.602235798793;4433.911321773547;4470.284754439274;2089.9059542320633;2113.260358874382;2134.32768677866;2158.5321981053035;2177.227084385052;973.600823662295;1028.1209565821264;1053.1522124689698;1064.0689396777818;1141.8287256911365;19414.417567473;20507.58984820295;20733.27433539819;20743.1702731889;21116.260930867345;979.0845559401839;1023.8003589300015;1041.463646222196;1091.770728147098;1095.956161753537;11073.335599864035;11572.710682233012;11768;11834.467448964817;11926.1651684383;570302;586113;586969;590114;607829;63154;100339;100520;101889.49055254676;104358.47820761;1022.0239671114068;1066.4827558634056;1069.7165251208437;1086.1962148010573;1091.7652704668535;17954.19206135753;18477.260909563465;18518.44444666662;18565.907170464063;18911;39483.21033579255;40918.79540602397;44608.77695611501;44831;45360;52954.470455294955;61821.690891547056;62827;63452.04821927582;63745.3625463758;8630.913690863012;8865.867011994955;8866.157715017063;9087.409318394282;9122.224610908148;12779.680507987003;13596.456141754219;13645.181289122684;14071.648208794863;14337.211453370164;11743.823842642196;11855.288682679067;11889.346085965355;11928.701782455508;12353.567625133437;11682.76634467323;11967;12091.214071085351;12207.633770986884;12260.448279827608;11998.160128790902;12135.878641213474;12172.513099475922;12181.39093045362;12272.079594030662;8861.468311901306;8978.506182160045;9070.682526111554;9086.68475409584;9200.723978280663;8788.209061184523;11442.485088170886;11942.34317112567;11992.76014479723;12185.207961482476 17:38:54 INFO - PROCESS | 28352 | |3;mootools.html;1303.537244278281;1420.9059024551095;1455.5633310007001;1773.6364045370701;1843.235057451158;8700.738977830668;9201.861972070425;9344.71965841025;9366;9598.616055357796;9413.62345506179;9479.241660667147;9559.13967742903;9564.043595640433;9584.52077396129;2456.5701002324568;2489.3154382544762;2501.7498250175017;2503.399184195789;2507.0974449198275;2481.6029435290357;2527.811928393652;2536.8731563421848;2551.3111459905813;2553.9233822985248;2495.089292408267;2510.8870100845506;2530.6204069389646;2540.7840333571667;2545.5036267927762;2403.3871362802547;2409.4337830609793;2419.2258477287273;2483.689538807649;2488.925332240036;2469.753024697534;2473.2332976777257;2491.2277194069716;2499.5875680512695;2504.4365017871014;9287.674931377369;9343.112404321646;9389.577469013911;9414.388064775767;9437.669681561181;5546.223528705985;5682.857928551778;5683.062294721366;5686.914696279559;5697.715114244271;3646.507721457596;3676.6323367663285;3756.098536351283;3785.6592906638534;3815.179736356669;1210.9333986630731;1234.481517762542;1276.4383671184648;1309.7053163038336;1310.488909325364;12126.696832579257;12599.496020159091;12708.745825083446;12904.87095129046;12933.159344642569;4577.450705915311;4614.884627884329;4751.263554149044;4788.449328327287;4804.711717296904;9931.751706207258;9959.352642078242;9997.550110245056;10028.448435336126;10066.345687530287;5419.918701219485;5467.535259502907;5469.288992430958;5473.67157970523;5474.835754927359;4590.977045114753;4994.300797888299;5086.262491938648;5114;5120.667156634881;4119.773412462343;4137.524184718735;4162.272166847444;4166.832293198717;4192.182524407772;1262.1795832708628;1271.9872801272054;1280.225463594512;1281.0968267371668;1285.4858056777177;994.8905620381752;1033.5968972100886;1073.9677809665723;1082.226208261097;1110.9111271098293;6309.62142271456;6358.395952384516;6369.554131210771;6412.743490260431;6552.9344706553275;961.8509131084693;976.9804603907882;997.850322451638;1019.0522813783252;1046.28489070861;4405.207062728676;4411;4416.072624748775;4419.652006138094;4526.366308716782;11186;11666.475008624633;11676.532938682527;11697.473613687405;11747;11437.313761174357;11556.364399957914;11558.653240402802;11602.825957610643;11623.6512904613;8308.169183081643;8591.312694984386;8689.522076285864;8868.379213454997;8878.334124940655;6353.237611486651;6416.582922110048;6494.707738151889;6558.540902136805;6774.42417394527;10670.519826607977;10718.624848130277;10738.087262582769;10799.514021868878;10838.349699018085;10539.894601053891;10567.313124646873;10600.787984240425;10804.621838235938;10855;7876.606169691607;7981.082175549886;8118.797030074295;8123.7156699515235;8136.75589732309;9055.23030542385;9069.682561110329;9113.726588202364;9117.179453849185;9126.771830704285;8119.715809946623;8253.422260441712;8266.669333226604;8333.541655209021;8460.534670593177;7838.529688218725;7903.486273392211;7909.446338756232;7934.2859142677435;8024.83950321002;7241.167265764505;7247.818804529929;7268.963655181902;7297;7378.077740282465;5327.9200811987075;5356.544693700923;5415.241866138665;5446.455354464521;5457.454254574511;5440.129579267298;5489.1217405214975;5589.944100558942;5608.355039170548;5689.516391106637 17:38:54 INFO - PROCESS | 28352 | |4;prototype.html;344.56412638012915;360.32619002465395;361.05223787557657;361.3910560705212;363.6854121185174;5770.9422905770925;5886;5886.175935369051;5887.146363777255;5894.168790286316;5803.709814509279;5807.912881306784;5826.504747096502;5836.241288632483;5902.852428689285;4356.891077723067;4506.301523263899;4540.137373898957;4562.543745625428;4592.242280023792;4550.840720574781;4553.203189441834;4576.908461830762;4577.519360467153;4584.7936842842155;4531.207038768202;4540.18276710192;4541.841035563756;4545.886352841172;4548.749818759967;4448;4468.218061839198;4549.499555048958;4554.476235232957;4565.178267911774;3935.429362742415;3953.98023009886;3968.444417781513;3968.861089861841;3969.106950936045;5686.289213848269;5691.544676425918;5722.399148089432;5759.22250496186;5762.625429347121;5039.244113382985;5184.300119483859;5248.343957005374;5249;5250.68495890244;6018.428249316308;6035.547333949928;6036.008117321274;6052.485538729214;6103.29812071613;4375.140565259784;4400.207962566737;4401.779911004437;4405.933910991338;4407.647388208936;6262.248530176363;6301.842453938688;6335.7148928297875;6358.265945643371;6412.711427985705;4444.266695995189;4450;4467.285234362486;4487.833163377545;4506.571875671872;4551;4572.977135114304;4576.244919588297;4583.129205450954;4593.839215627437;5105.617078719111;5164.56101231392;5169.689818610896;5181.326427564392;5218.946916054151;6025.276966764016;6036.366181550961;6077.027675571887;6107.664078475637;6110.511159107261;1530.5102367242598;1554.2927967774635;1555.3234343060806;1566.4439124110777;1575.9527214183593;965.5703212070702;986.5264672957021;996.3025881882711;997.7006897930592;1002.3084071990303;5234;5238.476152384807;5240.3973543042275;5247.323864828964;5336.62643614951;5437.401885792559;5498.415744600032;5541.612087153861;5564.554835613222;5595.664260144405;5148.318951949374;5207.739613019334;5207.869803254873;5274.498922602346;5291.365036195604;2963.748081413104;2986.283292009902;3008.413359394897;3015.8190508569555;3034.347615262729;5434.402215756264;5645.745941432645;5699.715014249271;5704.771809127588;5712.286314105751;5596.3284405870745;5625.943740562624;5642.435756424325;5645.717714114277;6246.6876656167005;6570.901436478457;6584.440322572539;6602.504812139109;6604.669766511655;6655.168103987098;6302.842428939313;6330.746770129143;6345.699131678087;6353.618782873043;6403.199600049994;5957.642541447353;6234.563580549318;6264.310925798068;6283.654399008098;6289.08808222796;6567.06271649874;6584.637844918576;6592.780335637923;6600.768973085919;6624.470042396693;4364.323529852878;4458.550970934394;4464.263396539534;4474.753888536162;4479.126570318756;6239.875202496016;6300.180976473029;6318.526110541636;6327.17746692927;6343.270523889812;5908.547952599795;6164.7842325518395;6190.969045154746;6200.782972596118;6272.5922815016875;6108.747706720201;6137.754489820357;6151.323354431099;6181.238347071063;6187.195664563578;6145.539084568586;6149.938500614937;6204.534659900435;6218.533609979179;6222.719977601109;5997.490213331916;6201.379862013943;6206.596571222856;6232.223816212539;6269.18500594938;6096.793212683235;6110.694465276807;6131.172291740736;6143.32423433413;6150.169727086786 17:38:54 INFO - PROCESS | 28352 | |5;yui.html;821.6918655504186;822.983540329193;894.2130924786189;914.990850091499;939.1547607153565;16092.275847586858;17637.64724705507;17784;17829.55426114348;17939.461816145522;15487.303071361788;16676;16731.414400495985;16793.496195114167;16837.41069062583;859.501489136301;889.3774357949461;890.1321211818457;890.8441022821013;891.0777345447464;878.5387671472464;880.4057261348596;885.2829208341232;886.4769785826361;889.1419779912384;924.5885580916495;926.0415469988563;927.5084205371164;928.6842473558988;928.8653145293928;923.5474617437408;923.5613083785215;923.6351641101761;924.5146298193469;925.4956048953337;682.3722175598411;683.5317807301965;684.8596037812237;685.0717278088168;687.6355531568277;15762.290696918551;15779.92110039454;15874.603134921605;15887.60280992973;16408.26162822676;14947.850521494755;15626.453074142464;16011.839881601152;16536.75194872078;17135.91432042844;13427.462901483928;13626.59120226385;13787.724245515134;13979.161250325013;14022.509212177525;4124.13393187431;4144.191882582898;4187;4243.363495475673;4260.233158031553;70529.6473517629;90800;92951.0704892956;93136.53431732798;93820;12254.203476774159;12268.631941041784;12279.324637145042;12318.076144289214;12401.193922395016;23480.7651923482;23691.407714806923;23819.285421437384;23828.761712382653;24476.265712028668;9225.53872306382;9297.116773906468;9307.208887244524;9327.860082098774;9388.530573471298;5179.430262671103;5182.948170518322;5206.427292997767;5223.7910483580235;5316.867078322995;3752.3433399155037;3889.922201555953;3909.667678247324;3911.2177564487215;3916.373380259145;701.7052837808133;705.4145059600519;711.5126138595078;729.9781006569812;758.2266088589607;814.5845618734488;821.2977903892206;821.4660470694097;827.2678679368681;848.974530764078;10271.589136434459;10608.840867386996;10791.780069414905;10944.890551094388;11246.49390777417;774.5855967057597;779.9275995506179;796.0288448093316;804.2640983500032;830.3772170871846;5113.565346945551;5289.594875518414;5344.652597581145;5410.3507579090765;5417.891642167214;117101;138467;138517;142478;146432.26783866013;115121.42439287917;117084;118481;118817;118904.40547797206;104759.47620262002;107338;107831.46084269685;107846.46076769722;109757;10288.588456461657;10396.636117735843;10413.323133996266;10438.217133715154;10513.789724205626;60879.39120608737;60985.39014609797;62186.37813621806;62405.687971559855;64168.67915660392;81356;88964;91481.54259228661;92469;92990;13211.735765284448;13212.933935330262;13265.33673316311;13298.135621184592;13468.5286014989;14357.641058973191;14525.78211326852;14538.127712337293;14542.709145817236;14668.266586670838;13987.790183147465;14063.085899416505;14102.224377659328;14142.22217778032;14253;13470.595882123553;13747.793783093062;13880.444782209002;14260.144391336553;14695.779563306773;13863.72272554523;13964.860351396763;14289.356978935764;14289.857101428852;14378.784318235026;11543.714829218303;11698.35659038727;11760.235584686969;12031.15781895259;12183.329916854658;11846.407679615812;11902.702432438911;11920.582779602672;12026.15816892809;12241 17:38:54 INFO - PROCESS | 28352 | __end_tp_report 17:38:54 INFO - PROCESS | 28352 | __start_cc_report 17:38:54 INFO - PROCESS | 28352 | _x_x_mozilla_cycle_collect,347 17:38:54 INFO - PROCESS | 28352 | __end_cc_report 17:38:54 INFO - PROCESS | 28352 | __startTimestamp1475023134866__endTimestamp 17:38:54 INFO - PROCESS | 28352 | 17:38:54 INFO - PROCESS | 28352 | ------- Summary: start ------- 17:38:54 INFO - PROCESS | 28352 | Number of tests: 6 17:38:54 INFO - PROCESS | 28352 | 17:38:54 INFO - PROCESS | 28352 | [#0] dojo.html Cycles:165 Average:5817.12 Median:6071.33 stddev:679.51 (11.2%) stddev-sans-first:652.36 17:38:54 INFO - PROCESS | 28352 | Values: 3303.5 3329.7 3335.1 3346.3 3361.4 5736.4 5860.3 5884.5 5887.7 5927.1 5728.8 5769.9 5810.9 5813.0 5815.1 5204.7 5272.9 5302.8 5310.5 5317.9 5278.8 5279.4 5284.8 5316.3 5369.2 5277.3 5286.0 5287.6 5309.4 5363.2 5340.5 5352.5 5355.3 5362.9 5381.8 5054.5 5120.8 5165.6 5244.8 5249.7 5770.7 5802.7 5817.4 5824.5 5872.6 6207.1 6245.2 6261.7 6267.5 6276.7 6055.5 6216.9 6250.3 6304.3 6310.7 5918.0 5927.1 5935.2 5939.2 5961.3 6434.7 6473.9 6475.3 6479.3 6493.4 6015.4 6027.2 6053.3 6157.4 6219.6 6136.2 6137.3 6145.4 6175.8 6181.8 6179.3 6184.3 6188.6 6202.1 6210.8 6112.4 6117.7 6126.2 6139.6 6165.4 4766.1 4786.2 4791.6 4799.0 4822.5 4208.0 4226.7 4236.5 4241.8 4252.0 5903.9 5951.5 5966.7 6002.7 6042.7 6275.2 6296.5 6308.3 6323.3 6323.8 5971.1 5982.2 5986.5 5995.7 6024.8 5304.3 5314.9 5347.6 5381.5 5382.3 6450.5 6459.9 6460.6 6469.9 6470.0 6329.9 6333.1 6334.3 6341.7 6348.7 6303.9 6432.2 6442.2 6464.5 6498.6 6295.7 6297.5 6304.8 6305.8 6307.4 6358.7 6412.4 6427.8 6428.8 6429.1 6071.3 6087.9 6091.5 6240.2 6253.8 6163.1 6208.5 6215.8 6219.9 6220.9 6039.7 6064.9 6093.7 6159.0 6159.9 6002.3 6109.8 6123.8 6125.4 6172.8 6090.1 6137.3 6139.4 6142.8 6170.9 17:38:54 INFO - PROCESS | 28352 | 17:38:54 INFO - PROCESS | 28352 | [#1] ext.html Cycles:180 Average:65508.74 Median:46284.04 stddev:129146.48 (279.0%) stddev-sans-first:129416.77 17:38:54 INFO - PROCESS | 28352 | Values: 581.8 648.9 664.4 672.5 733.3 41647.8 46745.5 46762.0 46762.3 46831.3 47490.8 47914.3 47957.5 48026.0 48065.0 8900.5 9072.2 9079.6 9082.8 9105.6 9076.8 9099.9 9165.5 9192.3 9226.7 9231.4 9262.1 9284.1 9335.7 9376.2 9153.1 9165.5 9243.9 9260.7 9282.7 9099.1 9173.6 9189.6 9197.7 9221.3 44435.6 44694.6 44806.0 44877.0 44884.3 3510.5 3584.9 3594.7 3661.7 3710.1 35258.3 35587.8 35657.8 35767.6 36230.5 4679.8 4711.4 4770.9 4795.4 4837.2 365824.0 367815.0 368341.0 370827.0 371018.0 67630.0 67874.0 68006.0 68110.3 68115.7 40450.8 71223.3 71232.0 71268.0 71282.3 13967.0 14550.2 14631.3 14676.5 14698.1 11368.5 11520.6 11525.2 11546.1 11568.0 21234.9 21270.5 21370.1 21441.0 21455.4 7563.9 7654.2 7832.2 7882.4 7942.2 1052.8 1102.4 1124.6 1165.0 1209.6 33895.0 33930.0 34235.0 34240.8 34815.1 1120.8 1157.9 1167.2 1170.1 1215.6 17445.5 17607.8 17852.5 18049.0 18092.9 424060.0 424539.0 598223.0 600993.0 601230.0 65236.3 65389.7 65544.7 65736.0 65768.7 1460.3 1460.9 1482.6 1493.2 1509.9 34669.7 34729.0 34922.7 35011.8 35465.5 57164.0 57709.7 57844.1 58005.0 58201.7 531157.0 531976.0 535216.0 538362.2 539146.0 30714.7 30931.8 30995.8 31193.0 31559.5 52093.5 52672.7 53321.0 53505.5 53688.2 44190.6 44589.3 44730.8 45658.5 48050.5 46617.3 46679.0 46706.0 47096.0 47137.5 45448.5 45933.8 46013.3 46554.8 48152.3 38373.8 39545.0 39903.9 40035.8 40915.8 30151.2 30642.2 30695.7 30796.8 31168.2 17:38:54 INFO - PROCESS | 28352 | 17:38:54 INFO - PROCESS | 28352 | [#2] jquery.html Cycles:180 Average:32180.23 Median:12796.70 stddev:96595.85 (754.8%) stddev-sans-first:96837.37 17:38:54 INFO - PROCESS | 28352 | Values: 413.3 425.1 429.5 430.8 440.2 19197.8 20381.3 20819.2 20871.8 20898.1 20137.8 20556.2 20657.2 20871.4 20893.9 5844.0 6123.2 6129.5 6134.3 6134.6 5877.9 6009.7 6037.1 6037.1 6041.6 5960.0 5997.1 5997.7 6000.6 6012.0 5794.5 5875.4 5916.4 5922.8 5931.8 5289.7 5297.7 5301.0 5334.7 5338.2 20513.2 23405.6 23599.1 23757.8 23917.4 2505.5 2580.4 2604.4 2613.2 2622.8 15028.1 15321.5 15586.9 16177.2 16558.4 2051.9 2107.2 2114.7 2154.9 2187.8 60041.7 83534.0 83600.0 84540.0 84817.0 9767.4 10398.4 10426.7 10527.7 10534.3 14210.6 14226.9 14250.1 14263.7 14300.7 7304.7 7448.3 7482.4 7543.1 7843.3 7036.3 7046.3 7054.6 7219.2 7245.5 4375.1 4409.1 4419.6 4433.9 4470.3 2089.9 2113.3 2134.3 2158.5 2177.2 973.6 1028.1 1053.2 1064.1 1141.8 19414.4 20507.6 20733.3 20743.2 21116.3 979.1 1023.8 1041.5 1091.8 1096.0 11073.3 11572.7 11768.0 11834.5 11926.2 570302.0 586113.0 586969.0 590114.0 607829.0 63154.0 100339.0 100520.0 101889.5 104358.5 1022.0 1066.5 1069.7 1086.2 1091.8 17954.2 18477.3 18518.4 18565.9 18911.0 39483.2 40918.8 44608.8 44831.0 45360.0 52954.5 61821.7 62827.0 63452.0 63745.4 8630.9 8865.9 8866.2 9087.4 9122.2 12779.7 13596.5 13645.2 14071.6 14337.2 11743.8 11855.3 11889.3 11928.7 12353.6 11682.8 11967.0 12091.2 12207.6 12260.4 11998.2 12135.9 12172.5 12181.4 12272.1 8861.5 8978.5 9070.7 9086.7 9200.7 8788.2 11442.5 11942.3 11992.8 12185.2 17:38:54 INFO - PROCESS | 28352 | 17:38:54 INFO - PROCESS | 28352 | [#3] mootools.html Cycles:180 Average:6120.31 Median:4683.07 stddev:3437.00 (73.4%) stddev-sans-first:3427.57 17:38:54 INFO - PROCESS | 28352 | Values: 1303.5 1420.9 1455.6 1773.6 1843.2 8700.7 9201.9 9344.7 9366.0 9598.6 9413.6 9479.2 9559.1 9564.0 9584.5 2456.6 2489.3 2501.7 2503.4 2507.1 2481.6 2527.8 2536.9 2551.3 2553.9 2495.1 2510.9 2530.6 2540.8 2545.5 2403.4 2409.4 2419.2 2483.7 2488.9 2469.8 2473.2 2491.2 2499.6 2504.4 9287.7 9343.1 9389.6 9414.4 9437.7 5546.2 5682.9 5683.1 5686.9 5697.7 3646.5 3676.6 3756.1 3785.7 3815.2 1210.9 1234.5 1276.4 1309.7 1310.5 12126.7 12599.5 12708.7 12904.9 12933.2 4577.5 4614.9 4751.3 4788.4 4804.7 9931.8 9959.4 9997.6 10028.4 10066.3 5419.9 5467.5 5469.3 5473.7 5474.8 4591.0 4994.3 5086.3 5114.0 5120.7 4119.8 4137.5 4162.3 4166.8 4192.2 1262.2 1272.0 1280.2 1281.1 1285.5 994.9 1033.6 1074.0 1082.2 1110.9 6309.6 6358.4 6369.6 6412.7 6552.9 961.9 977.0 997.9 1019.1 1046.3 4405.2 4411.0 4416.1 4419.7 4526.4 11186.0 11666.5 11676.5 11697.5 11747.0 11437.3 11556.4 11558.7 11602.8 11623.7 8308.2 8591.3 8689.5 8868.4 8878.3 6353.2 6416.6 6494.7 6558.5 6774.4 10670.5 10718.6 10738.1 10799.5 10838.3 10539.9 10567.3 10600.8 10804.6 10855.0 7876.6 7981.1 8118.8 8123.7 8136.8 9055.2 9069.7 9113.7 9117.2 9126.8 8119.7 8253.4 8266.7 8333.5 8460.5 7838.5 7903.5 7909.4 7934.3 8024.8 7241.2 7247.8 7269.0 7297.0 7378.1 5327.9 5356.5 5415.2 5446.5 5457.5 5440.1 5489.1 5589.9 5608.4 5689.5 17:38:54 INFO - PROCESS | 28352 | 17:38:54 INFO - PROCESS | 28352 | [#4] prototype.html Cycles:180 Average:5066.55 Median:5645.73 stddev:1502.32 (26.6%) stddev-sans-first:1464.13 17:38:54 INFO - PROCESS | 28352 | Values: 344.6 360.3 361.1 361.4 363.7 5770.9 5886.0 5886.2 5887.1 5894.2 5803.7 5807.9 5826.5 5836.2 5902.9 4356.9 4506.3 4540.1 4562.5 4592.2 4550.8 4553.2 4576.9 4577.5 4584.8 4531.2 4540.2 4541.8 4545.9 4548.7 4448.0 4468.2 4549.5 4554.5 4565.2 3935.4 3954.0 3968.4 3968.9 3969.1 5686.3 5691.5 5722.4 5759.2 5762.6 5039.2 5184.3 5248.3 5249.0 5250.7 6018.4 6035.5 6036.0 6052.5 6103.3 4375.1 4400.2 4401.8 4405.9 4407.6 6262.2 6301.8 6335.7 6358.3 6412.7 4444.3 4450.0 4467.3 4487.8 4506.6 4551.0 4573.0 4576.2 4583.1 4593.8 5105.6 5164.6 5169.7 5181.3 5218.9 6025.3 6036.4 6077.0 6107.7 6110.5 1530.5 1554.3 1555.3 1566.4 1576.0 965.6 986.5 996.3 997.7 1002.3 5234.0 5238.5 5240.4 5247.3 5336.6 5437.4 5498.4 5541.6 5564.6 5595.7 5148.3 5207.7 5207.9 5274.5 5291.4 2963.7 2986.3 3008.4 3015.8 3034.3 5434.4 5645.7 5699.7 5704.8 5712.3 5596.3 5625.9 5642.4 5645.7 6246.7 6570.9 6584.4 6602.5 6604.7 6655.2 6302.8 6330.7 6345.7 6353.6 6403.2 5957.6 6234.6 6264.3 6283.7 6289.1 6567.1 6584.6 6592.8 6600.8 6624.5 4364.3 4458.6 4464.3 4474.8 4479.1 6239.9 6300.2 6318.5 6327.2 6343.3 5908.5 6164.8 6191.0 6200.8 6272.6 6108.7 6137.8 6151.3 6181.2 6187.2 6145.5 6149.9 6204.5 6218.5 6222.7 5997.5 6201.4 6206.6 6232.2 6269.2 6096.8 6110.7 6131.2 6143.3 6150.2 17:38:54 INFO - PROCESS | 28352 | 17:38:54 INFO - PROCESS | 28352 | [#5] yui.html Cycles:180 Average:24112.54 Median:23586.09 stddev:36104.13 (153.1%) stddev-sans-first:36163.06 17:38:54 INFO - PROCESS | 28352 | Values: 821.7 823.0 894.2 915.0 939.2 16092.3 17637.6 17784.0 17829.6 17939.5 15487.3 16676.0 16731.4 16793.5 16837.4 859.5 889.4 890.1 890.8 891.1 878.5 880.4 885.3 886.5 889.1 924.6 926.0 927.5 928.7 928.9 923.5 923.6 923.6 924.5 925.5 682.4 683.5 684.9 685.1 687.6 15762.3 15779.9 15874.6 15887.6 16408.3 14947.9 15626.5 16011.8 16536.8 17135.9 13427.5 13626.6 13787.7 13979.2 14022.5 4124.1 4144.2 4187.0 4243.4 4260.2 70529.6 90800.0 92951.1 93136.5 93820.0 12254.2 12268.6 12279.3 12318.1 12401.2 23480.8 23691.4 23819.3 23828.8 24476.3 9225.5 9297.1 9307.2 9327.9 9388.5 5179.4 5182.9 5206.4 5223.8 5316.9 3752.3 3889.9 3909.7 3911.2 3916.4 701.7 705.4 711.5 730.0 758.2 814.6 821.3 821.5 827.3 849.0 10271.6 10608.8 10791.8 10944.9 11246.5 774.6 779.9 796.0 804.3 830.4 5113.6 5289.6 5344.7 5410.4 5417.9 117101.0 138467.0 138517.0 142478.0 146432.3 115121.4 117084.0 118481.0 118817.0 118904.4 104759.5 107338.0 107831.5 107846.5 109757.0 10288.6 10396.6 10413.3 10438.2 10513.8 60879.4 60985.4 62186.4 62405.7 64168.7 81356.0 88964.0 91481.5 92469.0 92990.0 13211.7 13212.9 13265.3 13298.1 13468.5 14357.6 14525.8 14538.1 14542.7 14668.3 13987.8 14063.1 14102.2 14142.2 14253.0 13470.6 13747.8 13880.4 14260.1 14695.8 13863.7 13964.9 14289.4 14289.9 14378.8 11543.7 11698.4 11760.2 12031.2 12183.3 11846.4 11902.7 11920.6 12026.2 12241.0 17:38:54 INFO - PROCESS | 28352 | -------- Summary: end -------- 17:38:54 INFO - PROCESS | 28352 | 17:38:55 INFO - TEST-INFO | 28352: exit 0 17:38:55 INFO - TEST-OK | dromaeo_css | took 1110134ms 17:38:55 INFO - TEST-START | kraken 17:38:55 INFO - operating with platform_type : linux_ 17:38:55 INFO - Initialising browser for kraken test... 17:38:55 INFO - TEST-INFO | started process 28588 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHrUxGN/profile http://localhost:50611/getInfo.html) 17:38:59 INFO - PROCESS | 28588 | __metrics Screen width/height:1600/1200 17:38:59 INFO - PROCESS | 28588 | colorDepth:24 17:38:59 INFO - PROCESS | 28588 | Browser inner width/height: 1024/697 17:38:59 INFO - PROCESS | 28588 | __metrics 17:39:00 ERROR - PROCESS | 28588 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 17:39:01 INFO - TEST-INFO | 28588: exit 0 17:39:01 INFO - Browser initialized. 17:39:01 INFO - Running cycle 1/1 for kraken test... 17:39:01 INFO - TEST-INFO | started process 28712 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHrUxGN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:39:12 INFO - PROCESS | 28712 | RSS: Main: 149663744 17:39:12 INFO - PROCESS | 28712 | 17:39:15 INFO - PROCESS | 28712 | Cycle 1(1): loaded http://localhost:50611/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50611/tests/kraken/driver.html?testName=audio-beat-detection) 17:39:16 INFO - PROCESS | 28712 | RSS: Main: 156307456 17:39:16 INFO - PROCESS | 28712 | 17:39:18 INFO - PROCESS | 28712 | Cycle 1(1): loaded http://localhost:50611/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50611/tests/kraken/driver.html?testName=audio-dft) 17:39:19 INFO - PROCESS | 28712 | RSS: Main: 155869184 17:39:19 INFO - PROCESS | 28712 | 17:39:22 INFO - PROCESS | 28712 | Cycle 1(1): loaded http://localhost:50611/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50611/tests/kraken/driver.html?testName=audio-fft) 17:39:22 INFO - PROCESS | 28712 | RSS: Main: 156352512 17:39:22 INFO - PROCESS | 28712 | 17:39:24 INFO - PROCESS | 28712 | Cycle 1(1): loaded http://localhost:50611/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50611/tests/kraken/driver.html?testName=audio-oscillator) 17:39:25 INFO - PROCESS | 28712 | RSS: Main: 155852800 17:39:25 INFO - PROCESS | 28712 | 17:39:27 INFO - PROCESS | 28712 | Cycle 1(1): loaded http://localhost:50611/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50611/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:39:28 INFO - PROCESS | 28712 | RSS: Main: 155889664 17:39:28 INFO - PROCESS | 28712 | 17:39:31 INFO - PROCESS | 28712 | Cycle 1(1): loaded http://localhost:50611/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50611/tests/kraken/driver.html?testName=imaging-darkroom) 17:39:31 INFO - PROCESS | 28712 | RSS: Main: 155815936 17:39:31 INFO - PROCESS | 28712 | 17:39:35 INFO - PROCESS | 28712 | Cycle 1(1): loaded http://localhost:50611/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50611/tests/kraken/driver.html?testName=imaging-desaturate) 17:39:35 INFO - PROCESS | 28712 | RSS: Main: 155996160 17:39:35 INFO - PROCESS | 28712 | 17:39:38 INFO - PROCESS | 28712 | Cycle 1(1): loaded http://localhost:50611/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50611/tests/kraken/driver.html?testName=json-parse-financial) 17:39:39 INFO - PROCESS | 28712 | RSS: Main: 156258304 17:39:39 INFO - PROCESS | 28712 | 17:39:40 INFO - PROCESS | 28712 | Cycle 1(1): loaded http://localhost:50611/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50611/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:39:41 INFO - PROCESS | 28712 | RSS: Main: 155439104 17:39:41 INFO - PROCESS | 28712 | 17:39:43 INFO - PROCESS | 28712 | Cycle 1(1): loaded http://localhost:50611/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50611/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:39:43 INFO - PROCESS | 28712 | RSS: Main: 155582464 17:39:43 INFO - PROCESS | 28712 | 17:39:45 INFO - PROCESS | 28712 | Cycle 1(1): loaded http://localhost:50611/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50611/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:39:46 INFO - PROCESS | 28712 | RSS: Main: 155975680 17:39:46 INFO - PROCESS | 28712 | 17:39:49 INFO - PROCESS | 28712 | Cycle 1(1): loaded http://localhost:50611/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50611/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:39:49 INFO - PROCESS | 28712 | RSS: Main: 156016640 17:39:49 INFO - PROCESS | 28712 | 17:39:52 INFO - PROCESS | 28712 | Cycle 1(1): loaded http://localhost:50611/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50611/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:39:52 INFO - PROCESS | 28712 | RSS: Main: 156270592 17:39:52 INFO - PROCESS | 28712 | 17:39:54 INFO - PROCESS | 28712 | Cycle 1(1): loaded http://localhost:50611/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50611/tests/kraken/driver.html?testName=ai-astar) 17:39:54 INFO - PROCESS | 28712 | RSS: Main: 158068736 17:39:54 INFO - PROCESS | 28712 | 17:39:54 INFO - PROCESS | 28712 | __start_tp_report 17:39:54 INFO - PROCESS | 28712 | _x_x_mozilla_page_load 17:39:54 INFO - PROCESS | 28712 | _x_x_mozilla_page_load_details 17:39:54 INFO - PROCESS | 28712 | |i|pagename|runs| 17:39:54 INFO - PROCESS | 28712 | |0;ai-astar;101;110;106;111;110;111;112;115;110;111 17:39:54 INFO - PROCESS | 28712 | |1;audio-beat-detection;145;126;142;184;122;141;142;118;165;118 17:39:54 INFO - PROCESS | 28712 | |2;audio-dft;162;163;162;163;163;160;160;161;160;161 17:39:54 INFO - PROCESS | 28712 | |3;audio-fft;76;75;75;189;77;75;74;75;159;77 17:39:54 INFO - PROCESS | 28712 | |4;audio-oscillator;84;83;138;84;84;83;142;84;84;140 17:39:54 INFO - PROCESS | 28712 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;119;117;118 17:39:54 INFO - PROCESS | 28712 | |6;imaging-darkroom;147;147;147;147;147;147;147;147;147;147 17:39:54 INFO - PROCESS | 28712 | |7;imaging-desaturate;95;96;95;97;95;95;95;95;95;95 17:39:54 INFO - PROCESS | 28712 | |8;json-parse-financial;54;53;53;53;56;57;53;52;53;52 17:39:54 INFO - PROCESS | 28712 | |9;json-stringify-tinderbox;62;60;60;60;60;59;59;60;60;59 17:39:54 INFO - PROCESS | 28712 | |10;stanford-crypto-aes;73;72;73;73;72;72;72;72;77;76 17:39:54 INFO - PROCESS | 28712 | |11;stanford-crypto-ccm;125;141;125;122;117;132;117;128;154;119 17:39:54 INFO - PROCESS | 28712 | |12;stanford-crypto-pbkdf2;154;154;156;157;153;152;154;153;155;152 17:39:54 INFO - PROCESS | 28712 | |13;stanford-crypto-sha256-iterative;65;66;61;61;61;60;71;60;60;61 17:39:54 INFO - PROCESS | 28712 | __end_tp_report 17:39:54 INFO - PROCESS | 28712 | __start_cc_report 17:39:54 INFO - PROCESS | 28712 | _x_x_mozilla_cycle_collect,897 17:39:54 INFO - PROCESS | 28712 | __end_cc_report 17:39:54 INFO - PROCESS | 28712 | __startTimestamp1475023194883__endTimestamp 17:39:54 INFO - PROCESS | 28712 | 17:39:54 INFO - PROCESS | 28712 | ------- Summary: start ------- 17:39:54 INFO - PROCESS | 28712 | Number of tests: 14 17:39:54 INFO - PROCESS | 28712 | 17:39:54 INFO - PROCESS | 28712 | [#0] ai-astar Cycles:10 Average:109.70 Median:111.00 stddev:3.77 (3.4%) stddev-sans-first:2.35 17:39:54 INFO - PROCESS | 28712 | Values: 101.0 110.0 106.0 111.0 110.0 111.0 112.0 115.0 110.0 111.0 17:39:54 INFO - PROCESS | 28712 | 17:39:54 INFO - PROCESS | 28712 | [#1] audio-beat-detection Cycles:10 Average:140.30 Median:142.00 stddev:21.30 (15.0%) stddev-sans-first:22.52 17:39:54 INFO - PROCESS | 28712 | Values: 145.0 126.0 142.0 184.0 122.0 141.0 142.0 118.0 165.0 118.0 17:39:54 INFO - PROCESS | 28712 | 17:39:54 INFO - PROCESS | 28712 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:1.27 (0.8%) stddev-sans-first:1.33 17:39:54 INFO - PROCESS | 28712 | Values: 162.0 163.0 162.0 163.0 163.0 160.0 160.0 161.0 160.0 161.0 17:39:54 INFO - PROCESS | 28712 | 17:39:54 INFO - PROCESS | 28712 | [#3] audio-fft Cycles:10 Average:95.20 Median:75.00 stddev:42.14 (56.2%) stddev-sans-first:44.12 17:39:54 INFO - PROCESS | 28712 | Values: 76.0 75.0 75.0 189.0 77.0 75.0 74.0 75.0 159.0 77.0 17:39:54 INFO - PROCESS | 28712 | 17:39:54 INFO - PROCESS | 28712 | [#4] audio-oscillator Cycles:10 Average:100.60 Median:84.00 stddev:27.21 (32.4%) stddev-sans-first:28.19 17:39:54 INFO - PROCESS | 28712 | Values: 84.0 83.0 138.0 84.0 84.0 83.0 142.0 84.0 84.0 140.0 17:39:54 INFO - PROCESS | 28712 | 17:39:54 INFO - PROCESS | 28712 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 17:39:54 INFO - PROCESS | 28712 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 119.0 117.0 118.0 17:39:54 INFO - PROCESS | 28712 | 17:39:54 INFO - PROCESS | 28712 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 17:39:54 INFO - PROCESS | 28712 | Values: 147.0 147.0 147.0 147.0 147.0 147.0 147.0 147.0 147.0 147.0 17:39:54 INFO - PROCESS | 28712 | 17:39:54 INFO - PROCESS | 28712 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 17:39:54 INFO - PROCESS | 28712 | Values: 95.0 96.0 95.0 97.0 95.0 95.0 95.0 95.0 95.0 95.0 17:39:54 INFO - PROCESS | 28712 | 17:39:54 INFO - PROCESS | 28712 | [#8] json-parse-financial Cycles:10 Average:53.60 Median:53.00 stddev:1.65 (3.1%) stddev-sans-first:1.74 17:39:54 INFO - PROCESS | 28712 | Values: 54.0 53.0 53.0 53.0 56.0 57.0 53.0 52.0 53.0 52.0 17:39:54 INFO - PROCESS | 28712 | 17:39:54 INFO - PROCESS | 28712 | [#9] json-stringify-tinderbox Cycles:10 Average:59.90 Median:60.00 stddev:0.88 (1.5%) stddev-sans-first:0.50 17:39:54 INFO - PROCESS | 28712 | Values: 62.0 60.0 60.0 60.0 60.0 59.0 59.0 60.0 60.0 59.0 17:39:54 INFO - PROCESS | 28712 | 17:39:54 INFO - PROCESS | 28712 | [#10] stanford-crypto-aes Cycles:10 Average:73.20 Median:73.00 stddev:1.81 (2.5%) stddev-sans-first:1.92 17:39:54 INFO - PROCESS | 28712 | Values: 73.0 72.0 73.0 73.0 72.0 72.0 72.0 72.0 77.0 76.0 17:39:54 INFO - PROCESS | 28712 | 17:39:54 INFO - PROCESS | 28712 | [#11] stanford-crypto-ccm Cycles:10 Average:128.00 Median:126.50 stddev:11.73 (9.3%) stddev-sans-first:12.39 17:39:54 INFO - PROCESS | 28712 | Values: 125.0 141.0 125.0 122.0 117.0 132.0 117.0 128.0 154.0 119.0 17:39:54 INFO - PROCESS | 28712 | 17:39:54 INFO - PROCESS | 28712 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.00 Median:154.00 stddev:1.63 (1.1%) stddev-sans-first:1.73 17:39:54 INFO - PROCESS | 28712 | Values: 154.0 154.0 156.0 157.0 153.0 152.0 154.0 153.0 155.0 152.0 17:39:54 INFO - PROCESS | 28712 | 17:39:54 INFO - PROCESS | 28712 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:61.00 stddev:3.63 (5.9%) stddev-sans-first:3.74 17:39:54 INFO - PROCESS | 28712 | Values: 65.0 66.0 61.0 61.0 61.0 60.0 71.0 60.0 60.0 61.0 17:39:54 INFO - PROCESS | 28712 | -------- Summary: end -------- 17:39:54 INFO - PROCESS | 28712 | 17:39:55 INFO - TEST-INFO | 28712: exit 0 17:39:55 INFO - TEST-OK | kraken | took 60271ms 17:39:55 INFO - SUITE-END | took 1170s 17:39:56 INFO - Completed test suite (00:19:30) 17:39:56 INFO - javascript benchmark 17:39:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7804.757327936921, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3303.504474328851, 3329.716974057205, 3335.099523128754, 3346.29727757171, 3361.3949489091956, 5736.368999410061, 5860.296764388274, 5884.470397664215, 5887.676177810219, 5927.1109333599925, 5728.770849166039, 5769.855753606162, 5810.912836307459, 5812.970935145329, 5815.127730840365, 5204.687718736869, 5272.920906186391, 5302.814401495948, 5310.468953104697, 5317.9468205318035, 5278.788848446057, 5279.445658205891, 5284.762185701634, 5316.255724198615, 5369.221462887879, 5277.3139491866, 5286.0, 5287.550558202538, 5309.389420216667, 5363.249145119687, 5340.54605358545, 5352.5182733553975, 5355.277037599952, 5362.865928351823, 5381.838544843661, 5054.469280725508, 5120.795168193268, 5165.638405311592, 5244.842654720364, 5249.658772179796, 5770.711464426804, 5802.738876750556, 5817.418258174191, 5824.504917082053, 5872.559558033165, 6207.099970504251, 6245.219347581552, 6261.655608941506, 6267.529935254828, 6276.654783986879, 6055.485283750886, 6216.906746398808, 6250.281217659982, 6304.275008374004, 6310.716017779211, 5918.023526118229, 5927.051671732502, 5935.169076329317, 5939.168516407706, 5961.254843144607, 6434.7104380303, 6473.902891456632, 6475.287718350977, 6479.319671434526, 6493.448056915121, 6015.428534289235, 6027.21646185993, 6053.334133245339, 6157.4458298753325, 6219.564630475914, 6136.17161683176, 6137.297691397357, 6145.432914606747, 6175.752969881244, 6181.7527298908435, 6179.258488981351, 6184.257889053342, 6188.597741146811, 6202.100695399142, 6210.844728881723, 6112.358202388685, 6117.724702388314, 6126.203593532812, 6139.631622102688, 6165.445109940127, 4766.142094422968, 4786.234202527578, 4791.592714619227, 4799.0401919615515, 4822.541858523435, 4208.0321526048565, 4226.704130710821, 4236.5128010278595, 4241.809118589671, 4251.958270223753, 5903.911441328383, 5951.464368206882, 5966.671833049137, 6002.729877155539, 6042.6978651067275, 6275.1842260506755, 6296.496280297565, 6308.337624549356, 6323.30443651198, 6323.841903952438, 5971.0744834550715, 5982.2223110996165, 5986.461218490357, 5995.670238136857, 6024.789132380346, 5304.310439642822, 5314.92027619586, 5347.625666203328, 5381.542568881689, 5382.30030096085, 6450.5484616077365, 6459.935400645933, 6460.580062295936, 6469.870602587922, 6469.997150441784, 6329.936700632935, 6333.145025421509, 6334.303226645157, 6341.714622841891, 6348.714307856065, 6303.896818056914, 6432.195975503062, 6442.162518872704, 6464.450521705519, 6498.642574658439, 6295.716692748929, 6297.52768542352, 6304.779332723333, 6305.779297724557, 6307.432331090224, 6358.682065896594, 6412.35876412355, 6427.775027874002, 6428.774992875227, 6429.067785171217, 6071.332153463204, 6087.908681369871, 6091.5126789857595, 6240.219972503437, 6253.812385628438, 6163.137160797582, 6208.4722798562625, 6215.751369945152, 6219.875602488016, 6220.906686399798, 6039.728212230372, 6064.878702426015, 6093.664848433379, 6159.014557670751, 6159.907601385893, 6002.279726432856, 6109.816705498843, 6123.801220575414, 6125.387461253839, 6172.845678858064, 6090.086487026804, 6137.346341658241, 6139.408446059106, 6142.775043102407, 6170.907436388368], "value": 5769.579826228447, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.8399940016495, 648.870225954809, 664.3588936676107, 672.5225090185965, 733.2703959560239, 41647.79176104119, 46745.532544674585, 46762.0, 46762.298565521545, 46831.29753053707, 47490.76254618731, 47914.281285780744, 47957.520424795744, 48026.0, 48065.0, 8900.510471924026, 9072.22886054683, 9079.591418386188, 9082.77293067672, 9105.590248438835, 9076.77308067297, 9099.863502047474, 9165.450072995642, 9192.31057670674, 9226.723198304062, 9231.399959002643, 9262.073792620718, 9284.07159284073, 9335.673251436201, 9376.20302274304, 9153.08469153086, 9165.54172291386, 9243.907560924406, 9260.722178334661, 9282.675106371313, 9099.135582119688, 9173.587188576463, 9189.586468608928, 9197.724068277963, 9221.308401869886, 44435.55564444346, 44694.55305446936, 44806.0, 44877.0, 44884.326735099, 3510.508528805969, 3584.9283014339567, 3594.730395220343, 3661.743677942545, 3710.109573702319, 35258.29483410317, 35587.82206088979, 35657.82171089154, 35767.64232357669, 36230.45654315187, 4679.789409476582, 4711.4346278446465, 4770.880727981794, 4795.448523419782, 4837.177679794443, 365824.0, 367815.0, 368341.0, 370826.9999999973, 371018.0, 67630.0, 67874.0, 68005.99999999901, 68110.31889681138, 68115.65942170356, 40450.797746011085, 71223.28776712167, 71232.0, 71268.0, 71282.28717712757, 13967.0, 14550.199739014455, 14631.341589628491, 14676.486322978644, 14698.11811291326, 11368.545258189744, 11520.596779112691, 11525.193236473366, 11546.076313894868, 11568.0, 21234.938253087283, 21270.468238293855, 21370.145194192057, 21441.0, 21455.356339309845, 7563.924360756432, 7654.2345765424125, 7832.225125266604, 7882.408819338572, 7942.245486678757, 1052.8210204265292, 1102.3826657072066, 1124.6288724720823, 1165.0, 1209.6434917319623, 33895.0, 33930.0, 34235.0, 34240.828795855865, 34815.12962175915, 1120.781447617723, 1157.8610566732045, 1167.200467679642, 1170.0814860334767, 1215.598852378713, 17445.476635700696, 17607.823921760617, 17852.46442606724, 18049.007304598374, 18092.90953545224, 424060.0, 424539.0, 598223.0, 600993.0, 601230.0, 65236.34763652398, 65389.67305163444, 65544.67227663926, 65736.0, 65768.67115664486, 1460.2771628043974, 1460.8539146085518, 1482.5922871210503, 1493.1712899340753, 1509.9169545674874, 34669.653303467654, 34729.0, 34922.650773492955, 35011.82494087513, 35465.468017979234, 57164.0, 57709.711451442476, 57844.13233801581, 58005.0, 58201.70899145477, 531157.0, 531976.0, 535216.0, 538362.2327553505, 539146.0, 30714.692853071185, 30931.84534077315, 30995.845020774752, 31193.0, 31559.52660710045, 52093.47906521038, 52672.73663631657, 53321.0, 53505.464945350046, 53688.1946770791, 44190.558094418644, 44589.33116003198, 44730.77634611806, 45658.54341456543, 48050.519494804605, 46617.300740488245, 46679.0, 46706.0, 47096.0, 47137.52862471331, 45448.54551454443, 45933.77033114947, 46013.309800352356, 46554.767226163654, 48152.27771583499, 38373.808130959165, 39545.0, 39903.85336138471, 40035.799821000706, 40915.7954210239, 30151.246218843826, 30642.233944151576, 30695.693043070176, 30796.846015769777, 31168.22079448032], "value": 21569.882684059805, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [413.25820152825673, 425.1280710419027, 429.53824638513595, 430.82120919818277, 440.1636889909173, 19197.808021919776, 20381.28665496708, 20819.16723331067, 20871.79128208721, 20898.05958731857, 20137.798622013775, 20556.177752889867, 20657.17371305146, 20871.37385878426, 20893.895530522364, 5843.970780146094, 6123.2039834821635, 6129.509639228873, 6134.294556126058, 6134.570580059375, 5877.8824423511505, 6009.729562169713, 6037.094435834616, 6037.124616930542, 6041.6375017499095, 5960.0, 5997.100434934751, 5997.700114994254, 6000.639961602296, 6011.969940150293, 5794.478496935275, 5875.353711091777, 5916.3787802280785, 5922.792702255443, 5931.822045338604, 5289.735513224362, 5297.735113244361, 5301.045811753883, 5334.67991920486, 5338.172583249564, 20513.17947282107, 23405.648915266283, 23599.05603775847, 23757.7624223759, 23917.402064948343, 2505.473850491399, 2580.419405633736, 2604.414006848463, 2613.1899111275566, 2622.7508386703234, 15028.09831410108, 15321.540353789404, 15586.922065389714, 16177.19114044293, 16558.420455284006, 2051.866628669147, 2107.1571371451387, 2114.74623045234, 2154.89225538724, 2187.7593464718866, 60041.699791501196, 83533.99999999939, 83600.0, 84540.0, 84817.0, 9767.41395516257, 10398.428086455166, 10426.739331516772, 10527.736806579744, 10534.315269507457, 14210.573682789325, 14226.85773142276, 14250.073745206528, 14263.714725705428, 14300.713985720227, 7304.744333948286, 7448.255174482617, 7482.363999060032, 7543.0948286206, 7843.254890785366, 7036.261192574808, 7046.260142685047, 7054.611996340251, 7219.169795473483, 7245.529040612449, 4375.146846364992, 4409.096135292258, 4419.602235798793, 4433.911321773547, 4470.284754439274, 2089.9059542320633, 2113.260358874382, 2134.32768677866, 2158.5321981053035, 2177.227084385052, 973.600823662295, 1028.1209565821264, 1053.1522124689698, 1064.0689396777818, 1141.8287256911365, 19414.417567473, 20507.58984820295, 20733.27433539819, 20743.1702731889, 21116.260930867345, 979.0845559401839, 1023.8003589300015, 1041.463646222196, 1091.770728147098, 1095.956161753537, 11073.335599864035, 11572.710682233012, 11768.0, 11834.467448964817, 11926.1651684383, 570302.0, 586113.0, 586969.0, 590114.0, 607829.0, 63154.0, 100339.0, 100520.0, 101889.49055254676, 104358.47820761, 1022.0239671114068, 1066.4827558634056, 1069.7165251208437, 1086.1962148010573, 1091.7652704668535, 17954.19206135753, 18477.260909563465, 18518.44444666662, 18565.907170464063, 18911.0, 39483.21033579255, 40918.79540602397, 44608.77695611501, 44831.0, 45360.0, 52954.470455294955, 61821.690891547056, 62827.0, 63452.04821927582, 63745.3625463758, 8630.913690863012, 8865.867011994955, 8866.157715017063, 9087.409318394282, 9122.224610908148, 12779.680507987003, 13596.456141754219, 13645.181289122684, 14071.648208794863, 14337.211453370164, 11743.823842642196, 11855.288682679067, 11889.346085965355, 11928.701782455508, 12353.567625133437, 11682.76634467323, 11967.0, 12091.214071085351, 12207.633770986884, 12260.448279827608, 11998.160128790902, 12135.878641213474, 12172.513099475922, 12181.39093045362, 12272.079594030662, 8861.468311901306, 8978.506182160045, 9070.682526111554, 9086.68475409584, 9200.723978280663, 8788.209061184523, 11442.485088170886, 11942.34317112567, 11992.76014479723, 12185.207961482476], "value": 9608.998485816774, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1303.537244278281, 1420.9059024551095, 1455.5633310007001, 1773.6364045370701, 1843.235057451158, 8700.738977830668, 9201.861972070425, 9344.71965841025, 9366.0, 9598.616055357796, 9413.62345506179, 9479.241660667147, 9559.13967742903, 9564.043595640433, 9584.52077396129, 2456.5701002324568, 2489.3154382544762, 2501.7498250175017, 2503.399184195789, 2507.0974449198275, 2481.6029435290357, 2527.811928393652, 2536.8731563421848, 2551.3111459905813, 2553.9233822985248, 2495.089292408267, 2510.8870100845506, 2530.6204069389646, 2540.7840333571667, 2545.5036267927762, 2403.3871362802547, 2409.4337830609793, 2419.2258477287273, 2483.689538807649, 2488.925332240036, 2469.753024697534, 2473.2332976777257, 2491.2277194069716, 2499.5875680512695, 2504.4365017871014, 9287.674931377369, 9343.112404321646, 9389.577469013911, 9414.388064775767, 9437.669681561181, 5546.223528705985, 5682.857928551778, 5683.062294721366, 5686.914696279559, 5697.715114244271, 3646.507721457596, 3676.6323367663285, 3756.098536351283, 3785.6592906638534, 3815.179736356669, 1210.9333986630731, 1234.481517762542, 1276.4383671184648, 1309.7053163038336, 1310.488909325364, 12126.696832579257, 12599.496020159091, 12708.745825083446, 12904.87095129046, 12933.159344642569, 4577.450705915311, 4614.884627884329, 4751.263554149044, 4788.449328327287, 4804.711717296904, 9931.751706207258, 9959.352642078242, 9997.550110245056, 10028.448435336126, 10066.345687530287, 5419.918701219485, 5467.535259502907, 5469.288992430958, 5473.67157970523, 5474.835754927359, 4590.977045114753, 4994.300797888299, 5086.262491938648, 5114.0, 5120.667156634881, 4119.773412462343, 4137.524184718735, 4162.272166847444, 4166.832293198717, 4192.182524407772, 1262.1795832708628, 1271.9872801272054, 1280.225463594512, 1281.0968267371668, 1285.4858056777177, 994.8905620381752, 1033.5968972100886, 1073.9677809665723, 1082.226208261097, 1110.9111271098293, 6309.62142271456, 6358.395952384516, 6369.554131210771, 6412.743490260431, 6552.9344706553275, 961.8509131084693, 976.9804603907882, 997.850322451638, 1019.0522813783252, 1046.28489070861, 4405.207062728676, 4411.0, 4416.072624748775, 4419.652006138094, 4526.366308716782, 11186.0, 11666.475008624633, 11676.532938682527, 11697.473613687405, 11747.0, 11437.313761174357, 11556.364399957914, 11558.653240402802, 11602.825957610643, 11623.6512904613, 8308.169183081643, 8591.312694984386, 8689.522076285864, 8868.379213454997, 8878.334124940655, 6353.237611486651, 6416.582922110048, 6494.707738151889, 6558.540902136805, 6774.42417394527, 10670.519826607977, 10718.624848130277, 10738.087262582769, 10799.514021868878, 10838.349699018085, 10539.894601053891, 10567.313124646873, 10600.787984240425, 10804.621838235938, 10855.0, 7876.606169691607, 7981.082175549886, 8118.797030074295, 8123.7156699515235, 8136.75589732309, 9055.23030542385, 9069.682561110329, 9113.726588202364, 9117.179453849185, 9126.771830704285, 8119.715809946623, 8253.422260441712, 8266.669333226604, 8333.541655209021, 8460.534670593177, 7838.529688218725, 7903.486273392211, 7909.446338756232, 7934.2859142677435, 8024.83950321002, 7241.167265764505, 7247.818804529929, 7268.963655181902, 7297.0, 7378.077740282465, 5327.9200811987075, 5356.544693700923, 5415.241866138665, 5446.455354464521, 5457.454254574511, 5440.129579267298, 5489.1217405214975, 5589.944100558942, 5608.355039170548, 5689.516391106637], "value": 4915.835392493677, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.56412638012915, 360.32619002465395, 361.05223787557657, 361.3910560705212, 363.6854121185174, 5770.9422905770925, 5886.0, 5886.175935369051, 5887.146363777255, 5894.168790286316, 5803.709814509279, 5807.912881306784, 5826.504747096502, 5836.241288632483, 5902.852428689285, 4356.891077723067, 4506.301523263899, 4540.137373898957, 4562.543745625428, 4592.242280023792, 4550.840720574781, 4553.203189441834, 4576.908461830762, 4577.519360467153, 4584.7936842842155, 4531.207038768202, 4540.18276710192, 4541.841035563756, 4545.886352841172, 4548.749818759967, 4448.0, 4468.218061839198, 4549.499555048958, 4554.476235232957, 4565.178267911774, 3935.429362742415, 3953.98023009886, 3968.444417781513, 3968.861089861841, 3969.106950936045, 5686.289213848269, 5691.544676425918, 5722.399148089432, 5759.22250496186, 5762.625429347121, 5039.244113382985, 5184.300119483859, 5248.343957005374, 5249.0, 5250.68495890244, 6018.428249316308, 6035.547333949928, 6036.008117321274, 6052.485538729214, 6103.29812071613, 4375.140565259784, 4400.207962566737, 4401.779911004437, 4405.933910991338, 4407.647388208936, 6262.248530176363, 6301.842453938688, 6335.7148928297875, 6358.265945643371, 6412.711427985705, 4444.266695995189, 4450.0, 4467.285234362486, 4487.833163377545, 4506.571875671872, 4551.0, 4572.977135114304, 4576.244919588297, 4583.129205450954, 4593.839215627437, 5105.617078719111, 5164.56101231392, 5169.689818610896, 5181.326427564392, 5218.946916054151, 6025.276966764016, 6036.366181550961, 6077.027675571887, 6107.664078475637, 6110.511159107261, 1530.5102367242598, 1554.2927967774635, 1555.3234343060806, 1566.4439124110777, 1575.9527214183593, 965.5703212070702, 986.5264672957021, 996.3025881882711, 997.7006897930592, 1002.3084071990303, 5234.0, 5238.476152384807, 5240.3973543042275, 5247.323864828964, 5336.62643614951, 5437.401885792559, 5498.415744600032, 5541.612087153861, 5564.554835613222, 5595.664260144405, 5148.318951949374, 5207.739613019334, 5207.869803254873, 5274.498922602346, 5291.365036195604, 2963.748081413104, 2986.283292009902, 3008.413359394897, 3015.8190508569555, 3034.347615262729, 5434.402215756264, 5645.745941432645, 5699.715014249271, 5704.771809127588, 5712.286314105751, 5596.3284405870745, 5625.943740562624, 5642.435756424325, 5645.717714114277, 6246.6876656167005, 6570.901436478457, 6584.440322572539, 6602.504812139109, 6604.669766511655, 6655.168103987098, 6302.842428939313, 6330.746770129143, 6345.699131678087, 6353.618782873043, 6403.199600049994, 5957.642541447353, 6234.563580549318, 6264.310925798068, 6283.654399008098, 6289.08808222796, 6567.06271649874, 6584.637844918576, 6592.780335637923, 6600.768973085919, 6624.470042396693, 4364.323529852878, 4458.550970934394, 4464.263396539534, 4474.753888536162, 4479.126570318756, 6239.875202496016, 6300.180976473029, 6318.526110541636, 6327.17746692927, 6343.270523889812, 5908.547952599795, 6164.7842325518395, 6190.969045154746, 6200.782972596118, 6272.5922815016875, 6108.747706720201, 6137.754489820357, 6151.323354431099, 6181.238347071063, 6187.195664563578, 6145.539084568586, 6149.938500614937, 6204.534659900435, 6218.533609979179, 6222.719977601109, 5997.490213331916, 6201.379862013943, 6206.596571222856, 6232.223816212539, 6269.18500594938, 6096.793212683235, 6110.694465276807, 6131.172291740736, 6143.32423433413, 6150.169727086786], "value": 4585.059837357685, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [821.6918655504186, 822.983540329193, 894.2130924786189, 914.990850091499, 939.1547607153565, 16092.275847586858, 17637.64724705507, 17784.0, 17829.55426114348, 17939.461816145522, 15487.303071361788, 16676.0, 16731.414400495985, 16793.496195114167, 16837.41069062583, 859.501489136301, 889.3774357949461, 890.1321211818457, 890.8441022821013, 891.0777345447464, 878.5387671472464, 880.4057261348596, 885.2829208341232, 886.4769785826361, 889.1419779912384, 924.5885580916495, 926.0415469988563, 927.5084205371164, 928.6842473558988, 928.8653145293928, 923.5474617437408, 923.5613083785215, 923.6351641101761, 924.5146298193469, 925.4956048953337, 682.3722175598411, 683.5317807301965, 684.8596037812237, 685.0717278088168, 687.6355531568277, 15762.290696918551, 15779.92110039454, 15874.603134921605, 15887.60280992973, 16408.26162822676, 14947.850521494755, 15626.453074142464, 16011.839881601152, 16536.75194872078, 17135.91432042844, 13427.462901483928, 13626.59120226385, 13787.724245515134, 13979.161250325013, 14022.509212177525, 4124.13393187431, 4144.191882582898, 4187.0, 4243.363495475673, 4260.233158031553, 70529.6473517629, 90800.0, 92951.0704892956, 93136.53431732798, 93820.0, 12254.203476774159, 12268.631941041784, 12279.324637145042, 12318.076144289214, 12401.193922395016, 23480.7651923482, 23691.407714806923, 23819.285421437384, 23828.761712382653, 24476.265712028668, 9225.53872306382, 9297.116773906468, 9307.208887244524, 9327.860082098774, 9388.530573471298, 5179.430262671103, 5182.948170518322, 5206.427292997767, 5223.7910483580235, 5316.867078322995, 3752.3433399155037, 3889.922201555953, 3909.667678247324, 3911.2177564487215, 3916.373380259145, 701.7052837808133, 705.4145059600519, 711.5126138595078, 729.9781006569812, 758.2266088589607, 814.5845618734488, 821.2977903892206, 821.4660470694097, 827.2678679368681, 848.974530764078, 10271.589136434459, 10608.840867386996, 10791.780069414905, 10944.890551094388, 11246.49390777417, 774.5855967057597, 779.9275995506179, 796.0288448093316, 804.2640983500032, 830.3772170871846, 5113.565346945551, 5289.594875518414, 5344.652597581145, 5410.3507579090765, 5417.891642167214, 117101.0, 138467.0, 138517.0, 142478.0, 146432.26783866013, 115121.42439287917, 117084.0, 118481.0, 118817.0, 118904.40547797206, 104759.47620262002, 107338.0, 107831.46084269685, 107846.46076769722, 109757.0, 10288.588456461657, 10396.636117735843, 10413.323133996266, 10438.217133715154, 10513.789724205626, 60879.39120608737, 60985.39014609797, 62186.37813621806, 62405.687971559855, 64168.67915660392, 81356.0, 88964.0, 91481.54259228661, 92469.0, 92990.0, 13211.735765284448, 13212.933935330262, 13265.33673316311, 13298.135621184592, 13468.5286014989, 14357.641058973191, 14525.78211326852, 14538.127712337293, 14542.709145817236, 14668.266586670838, 13987.790183147465, 14063.085899416505, 14102.224377659328, 14142.22217778032, 14253.0, 13470.595882123553, 13747.793783093062, 13880.444782209002, 14260.144391336553, 14695.779563306773, 13863.72272554523, 13964.860351396763, 14289.356978935764, 14289.857101428852, 14378.784318235026, 11543.714829218303, 11698.35659038727, 11760.235584686969, 12031.15781895259, 12183.329916854658, 11846.407679615812, 11902.702432438911, 11920.582779602672, 12026.15816892809, 12241.0], "value": 8384.987241814235, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1498.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 110.0, 106.0, 111.0, 110.0, 111.0, 112.0, 115.0, 110.0, 111.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 126.0, 142.0, 184.0, 122.0, 141.0, 142.0, 118.0, 165.0, 118.0], "value": 140.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 163.0, 163.0, 160.0, 160.0, 161.0, 160.0, 161.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 189.0, 77.0, 75.0, 74.0, 75.0, 159.0, 77.0], "value": 95.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 138.0, 84.0, 84.0, 83.0, 142.0, 84.0, 84.0, 140.0], "value": 100.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 119.0, 117.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 97.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 53.0, 53.0, 56.0, 57.0, 53.0, 52.0, 53.0, 52.0], "value": 53.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 60.0, 60.0, 60.0, 60.0, 59.0, 59.0, 60.0, 60.0, 59.0], "value": 59.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 73.0, 73.0, 72.0, 72.0, 72.0, 72.0, 77.0, 76.0], "value": 73.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 141.0, 125.0, 122.0, 117.0, 132.0, 117.0, 128.0, 154.0, 119.0], "value": 128.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 154.0, 156.0, 157.0, 153.0, 152.0, 154.0, 153.0, 155.0, 152.0], "value": 154.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 61.0, 61.0, 61.0, 60.0, 71.0, 60.0, 60.0, 61.0], "value": 62.6, "unit": "score"}]}]} 17:39:56 INFO - Return code: 0 17:39:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:39:56 ERROR - # TBPL SUCCESS # 17:39:56 INFO - Running post-action listener: _resource_record_post_action 17:39:56 INFO - [mozharness: 2016-09-28 00:39:56.180363Z] Finished run-tests step (success) 17:39:56 INFO - Running post-run listener: _resource_record_post_run 17:39:56 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291094528; Read time: 16; Write time: 172248 17:39:56 INFO - TinderboxPrint: CPU usage
13.2% 17:39:56 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 17:39:56 INFO - TinderboxPrint: I/O write bytes / time
291,094,528 / 172,248 17:39:56 INFO - TinderboxPrint: CPU idle
8,207.7 (86.8%) 17:39:56 INFO - TinderboxPrint: CPU user
1,195.5 (12.6%) 17:39:56 INFO - TinderboxPrint: Swap in / out
0 / 0 17:39:56 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 70094848; Read time: 0; Write time: 57240 17:39:56 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 0; Write bytes: 220999680; Read time: 0; Write time: 115008 17:39:56 INFO - Running post-run listener: _upload_blobber_files 17:39:56 INFO - Blob upload gear active. 17:39:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:39:56 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 17:39:56 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'] 17:39:56 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 17:39:57 INFO - (blobuploader) - INFO - Open directory for files ... 17:39:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:39:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:39:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:39:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:39:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:39:58 INFO - (blobuploader) - INFO - Done attempting. 17:39:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:39:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:39:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:39:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:39:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:39:59 INFO - (blobuploader) - INFO - Done attempting. 17:39:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:39:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:39:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:40:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:40:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:40:07 INFO - (blobuploader) - INFO - Done attempting. 17:40:07 INFO - (blobuploader) - INFO - Iteration through files over. 17:40:07 INFO - Return code: 0 17:40:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:40:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:40:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ae8d57f8b478ec39942518af044e81aa8d3e42148108c5b0d138551b29841b23dd69a164af0b35402e3e6e7f507108741f0505505deefbb3645c858b0071dd80", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a63fcd6132b523914035fc12ea4e191bccc5cf42ddbe1c6ae4b86b521fbd6a1eb77fc38e0a3f7f498a164de06528e67a7686c7ecb92b474d885ceac42b9463f8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0bb02205e66ab2444e1d198df2127447292db7f6c83de9b1b693a18a3c2f42b281022d36a610db1db46bca230765a512b98a5500d29615ba2f3679dcfbbd7589"} 17:40:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:40:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:40:07 INFO - Contents: 17:40:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ae8d57f8b478ec39942518af044e81aa8d3e42148108c5b0d138551b29841b23dd69a164af0b35402e3e6e7f507108741f0505505deefbb3645c858b0071dd80", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a63fcd6132b523914035fc12ea4e191bccc5cf42ddbe1c6ae4b86b521fbd6a1eb77fc38e0a3f7f498a164de06528e67a7686c7ecb92b474d885ceac42b9463f8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0bb02205e66ab2444e1d198df2127447292db7f6c83de9b1b693a18a3c2f42b281022d36a610db1db46bca230765a512b98a5500d29615ba2f3679dcfbbd7589"} 17:40:07 INFO - Running post-run listener: copy_logs_to_upload_dir 17:40:07 INFO - Copying logs to upload dir... 17:40:07 INFO - mkdir: /builds/slave/test/build/upload/logs 17:40:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1677.477796 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 57 secs) (at 2016-09-27 17:40:06.527258) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 17:40:06.531064) ========= 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=6d15e502d8e29d5d2676d664000001c3-1475021269.926239-1991999502 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/ae8d57f8b478ec39942518af044e81aa8d3e42148108c5b0d138551b29841b23dd69a164af0b35402e3e6e7f507108741f0505505deefbb3645c858b0071dd80", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a63fcd6132b523914035fc12ea4e191bccc5cf42ddbe1c6ae4b86b521fbd6a1eb77fc38e0a3f7f498a164de06528e67a7686c7ecb92b474d885ceac42b9463f8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0bb02205e66ab2444e1d198df2127447292db7f6c83de9b1b693a18a3c2f42b281022d36a610db1db46bca230765a512b98a5500d29615ba2f3679dcfbbd7589"} build_url:https://queue.taskcluster.net/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011314 build_url: 'https://queue.taskcluster.net/v1/task/ZTPlyN3PQL6ZxlJvGNlLbg/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/ae8d57f8b478ec39942518af044e81aa8d3e42148108c5b0d138551b29841b23dd69a164af0b35402e3e6e7f507108741f0505505deefbb3645c858b0071dd80", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a63fcd6132b523914035fc12ea4e191bccc5cf42ddbe1c6ae4b86b521fbd6a1eb77fc38e0a3f7f498a164de06528e67a7686c7ecb92b474d885ceac42b9463f8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0bb02205e66ab2444e1d198df2127447292db7f6c83de9b1b693a18a3c2f42b281022d36a610db1db46bca230765a512b98a5500d29615ba2f3679dcfbbd7589"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 17:40:06.555783) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 17:40:06.556082) ========= 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=6d15e502d8e29d5d2676d664000001c3-1475021269.926239-1991999502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004477 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 17:40:06.640468) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 17:40:06.640813) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 17:40:06.641106) ========= ========= Total master_lag: 0.16 =========