builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-006 starttime: 1475534348.66 results: success (0) buildid: 20161003124659 builduid: 37a071889354493a83defb3343a4d14d revision: 47dff98b4b466b0b373ff04a2bb95542260be0c3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-03 15:39:08.656440) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-03 15:39:08.656949) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-03 15:39:08.657275) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-03 15:39:08.685108) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 15:39:08.685884) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1475534349.28359-1514254637 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-03 15:39:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 22.5M=0.001s 2016-10-03 15:39:09 (22.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.154149 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 15:39:08.857599) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 15:39:08.858218) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1475534349.28359-1514254637 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014816 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 15:39:08.912071) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-03 15:39:08.912508) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 47dff98b4b466b0b373ff04a2bb95542260be0c3 --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 47dff98b4b466b0b373ff04a2bb95542260be0c3 --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=e31afd3c0f0de4e86ebe4d94000001b5-1475534349.28359-1514254637 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-03 15:39:10,048 truncating revision to first 12 chars 2016-10-03 15:39:10,048 Setting DEBUG logging. 2016-10-03 15:39:10,049 attempt 1/10 2016-10-03 15:39:10,049 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/47dff98b4b46?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-03 15:39:11,103 unpacking tar archive at: mozilla-beta-47dff98b4b46/testing/mozharness/ program finished with exit code 0 elapsedTime=1.410475 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-03 15:39:10.337142) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-03 15:39:10.337515) ========= script_repo_revision: 47dff98b4b466b0b373ff04a2bb95542260be0c3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-03 15:39:10.337991) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-03 15:39:10.338299) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-03 15:39:10.347580) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 52 secs) (at 2016-10-03 15:39:10.347919) ========= /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=e31afd3c0f0de4e86ebe4d94000001b5-1475534349.28359-1514254637 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:39:11 INFO - MultiFileLogger online at 20161003 15:39:11 in /builds/slave/test 15:39:11 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 15:39:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:39:11 INFO - {'append_to_log': False, 15:39:11 INFO - 'base_work_dir': '/builds/slave/test', 15:39:11 INFO - 'blob_upload_branch': 'Mozilla-Beta', 15:39:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:39:11 INFO - 'branch': 'Mozilla-Beta', 15:39:11 INFO - 'buildbot_json_path': 'buildprops.json', 15:39:11 INFO - 'config_files': ('talos/linux_config.py',), 15:39:11 INFO - 'default_actions': ('clobber', 15:39:11 INFO - 'read-buildbot-config', 15:39:11 INFO - 'download-and-extract', 15:39:11 INFO - 'populate-webroot', 15:39:11 INFO - 'create-virtualenv', 15:39:11 INFO - 'install', 15:39:11 INFO - 'run-tests'), 15:39:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:39:11 INFO - 'download_minidump_stackwalk': True, 15:39:11 INFO - 'download_symbols': 'ondemand', 15:39:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:39:11 INFO - 'tooltool.py': '/tools/tooltool.py', 15:39:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:39:11 INFO - '/tools/misc-python/virtualenv.py')}, 15:39:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:39:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:39:11 INFO - 'installer_path': 'installer.exe', 15:39:11 INFO - 'log_level': 'info', 15:39:11 INFO - 'log_name': 'talos', 15:39:11 INFO - 'log_to_console': True, 15:39:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:39:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:39:11 INFO - 'opt_config_files': (), 15:39:11 INFO - 'pip_index': False, 15:39:11 INFO - 'sps_profile': False, 15:39:11 INFO - 'sps_profile_interval': 0, 15:39:11 INFO - 'suite': 'dromaeojs-e10s', 15:39:11 INFO - 'system_bits': '32', 15:39:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:39:11 INFO - 'title': 'talos-linux64-ix-006', 15:39:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:39:11 INFO - 'use_talos_json': True, 15:39:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:39:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:39:11 INFO - 'work_dir': 'build'} 15:39:11 INFO - [mozharness: 2016-10-03 22:39:11.574606Z] Running clobber step. 15:39:11 INFO - Running pre-action listener: _resource_record_pre_action 15:39:11 INFO - Running main action method: clobber 15:39:11 INFO - rmtree: /builds/slave/test/build 15:39:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:39:12 INFO - Running post-action listener: _resource_record_post_action 15:39:12 INFO - [mozharness: 2016-10-03 22:39:12.044243Z] Finished clobber step (success) 15:39:12 INFO - [mozharness: 2016-10-03 22:39:12.044346Z] Running read-buildbot-config step. 15:39:12 INFO - Running pre-action listener: _resource_record_pre_action 15:39:12 INFO - Running main action method: read_buildbot_config 15:39:12 INFO - Using buildbot properties: 15:39:12 INFO - { 15:39:12 INFO - "project": "", 15:39:12 INFO - "product": "firefox", 15:39:12 INFO - "script_repo_revision": "production", 15:39:12 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 15:39:12 INFO - "repository": "", 15:39:12 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 15:39:12 INFO - "buildid": "20161003124659", 15:39:12 INFO - "pgo_build": "True", 15:39:12 INFO - "basedir": "/builds/slave/test", 15:39:12 INFO - "buildnumber": 267, 15:39:12 INFO - "slavename": "talos-linux64-ix-006", 15:39:12 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:39:12 INFO - "platform": "ubuntu64_hw", 15:39:12 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 15:39:12 INFO - "branch": "mozilla-beta", 15:39:12 INFO - "repo_path": "releases/mozilla-beta", 15:39:12 INFO - "revision": "47dff98b4b466b0b373ff04a2bb95542260be0c3", 15:39:12 INFO - "stage_platform": "linux64-pgo", 15:39:12 INFO - "builduid": "37a071889354493a83defb3343a4d14d", 15:39:12 INFO - "slavebuilddir": "test" 15:39:12 INFO - } 15:39:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2. 15:39:12 INFO - Running post-action listener: _resource_record_post_action 15:39:12 INFO - [mozharness: 2016-10-03 22:39:12.046777Z] Finished read-buildbot-config step (success) 15:39:12 INFO - [mozharness: 2016-10-03 22:39:12.046865Z] Running download-and-extract step. 15:39:12 INFO - Running pre-action listener: _resource_record_pre_action 15:39:12 INFO - Running main action method: download_and_extract 15:39:12 INFO - mkdir: /builds/slave/test/build/tests 15:39:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:39:12 INFO - https://queue.taskcluster.net/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:39:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 15:39:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 15:39:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/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 15:39:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/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 15:39:12 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 15:39:12 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 15:39:12 INFO - retry: Failed, sleeping 30 seconds before retrying 15:39:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/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 15:39:42 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 15:39:42 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 15:39:42 INFO - retry: Failed, sleeping 60 seconds before retrying 15:40:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/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 15:40:42 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 15:40:42 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 15:40:42 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/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! 15:40:42 INFO - Caught exception: HTTP Error 404: Not Found 15:40:42 INFO - Caught exception: HTTP Error 404: Not Found 15:40:42 INFO - Caught exception: HTTP Error 404: Not Found 15:40:42 INFO - trying https://queue.taskcluster.net/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 15:40:42 INFO - Downloading https://queue.taskcluster.net/v1/task/KreGsP7xSne2N8C4Uzlstg/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 15:40:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KreGsP7xSne2N8C4Uzlstg/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 15:40:42 INFO - Downloaded 1327 bytes. 15:40:42 INFO - Reading from file /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 15:40:42 INFO - Using the following test package requirements: 15:40:42 INFO - {u'common': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 15:40:42 INFO - u'cppunittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 15:40:42 INFO - u'firefox-50.0.en-US.linux-x86_64.cppunittest.tests.zip'], 15:40:42 INFO - u'gtest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 15:40:42 INFO - u'firefox-50.0.en-US.linux-x86_64.gtest.tests.zip'], 15:40:42 INFO - u'jittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 15:40:42 INFO - u'jsshell-linux-x86_64.zip'], 15:40:42 INFO - u'mochitest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 15:40:42 INFO - u'firefox-50.0.en-US.linux-x86_64.mochitest.tests.zip'], 15:40:42 INFO - u'mozbase': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 15:40:42 INFO - u'reftest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 15:40:42 INFO - u'firefox-50.0.en-US.linux-x86_64.reftest.tests.zip'], 15:40:42 INFO - u'talos': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 15:40:42 INFO - u'firefox-50.0.en-US.linux-x86_64.talos.tests.zip'], 15:40:42 INFO - u'web-platform': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 15:40:42 INFO - u'firefox-50.0.en-US.linux-x86_64.web-platform.tests.zip'], 15:40:42 INFO - u'xpcshell': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 15:40:42 INFO - u'firefox-50.0.en-US.linux-x86_64.xpcshell.tests.zip']} 15:40:42 INFO - Downloading packages: [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:40:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:40:42 INFO - https://queue.taskcluster.net/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:40:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:40:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:40:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/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 15:40:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/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 15:40:42 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:40:42 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 15:40:42 INFO - retry: Failed, sleeping 30 seconds before retrying 15:41:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/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 15:41:12 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:41:12 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 15:41:12 INFO - retry: Failed, sleeping 60 seconds before retrying 15:42:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/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 15:42:12 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:42:12 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 15:42:12 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/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! 15:42:12 INFO - Caught exception: HTTP Error 404: Not Found 15:42:12 INFO - Caught exception: HTTP Error 404: Not Found 15:42:12 INFO - Caught exception: HTTP Error 404: Not Found 15:42:12 INFO - trying https://queue.taskcluster.net/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:42:12 INFO - Downloading https://queue.taskcluster.net/v1/task/KreGsP7xSne2N8C4Uzlstg/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 15:42:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KreGsP7xSne2N8C4Uzlstg/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 15:42:13 INFO - Downloaded 21841512 bytes. 15:42:13 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'] 15:42:13 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 15:42:14 INFO - Return code: 0 15:42:14 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 15:42:14 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')]} 15:42:14 INFO - https://queue.taskcluster.net/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:42:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:42:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:42:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/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 15:42:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/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 15:42:14 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:42:14 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 15:42:14 INFO - retry: Failed, sleeping 30 seconds before retrying 15:42:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/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 15:42:44 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:42:44 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 15:42:44 INFO - retry: Failed, sleeping 60 seconds before retrying 15:43:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/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 15:43:44 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:43:44 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 15:43:44 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/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! 15:43:44 INFO - Caught exception: HTTP Error 404: Not Found 15:43:44 INFO - Caught exception: HTTP Error 404: Not Found 15:43:44 INFO - Caught exception: HTTP Error 404: Not Found 15:43:44 INFO - trying https://queue.taskcluster.net/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:43:44 INFO - Downloading https://queue.taskcluster.net/v1/task/KreGsP7xSne2N8C4Uzlstg/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 15:43:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KreGsP7xSne2N8C4Uzlstg/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 15:43:45 INFO - Downloaded 21841512 bytes. 15:43:45 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'] 15:43:45 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 15:43:47 INFO - Return code: 0 15:43:47 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')]} 15:43:47 INFO - https://queue.taskcluster.net/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:43:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 15:43:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 15:43:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/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 15:43:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/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 15:43:47 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 15:43:47 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 15:43:47 INFO - retry: Failed, sleeping 30 seconds before retrying 15:44:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/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 15:44:17 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 15:44:17 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 15:44:17 INFO - retry: Failed, sleeping 60 seconds before retrying 15:45:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/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 15:45:17 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 15:45:17 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 15:45:17 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/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! 15:45:17 INFO - Caught exception: HTTP Error 404: Not Found 15:45:17 INFO - Caught exception: HTTP Error 404: Not Found 15:45:17 INFO - Caught exception: HTTP Error 404: Not Found 15:45:17 INFO - trying https://queue.taskcluster.net/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 15:45:17 INFO - Downloading https://queue.taskcluster.net/v1/task/KreGsP7xSne2N8C4Uzlstg/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 15:45:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KreGsP7xSne2N8C4Uzlstg/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 15:45:18 INFO - Downloaded 14413740 bytes. 15:45:18 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'] 15:45:18 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 15:45:18 INFO - Return code: 0 15:45:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:18 INFO - https://queue.taskcluster.net/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:45:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:45:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:45:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/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 15:45:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/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 15:45:18 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:45:18 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 15:45:18 INFO - retry: Failed, sleeping 30 seconds before retrying 15:45:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/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 15:45:48 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:45:48 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 15:45:48 INFO - retry: Failed, sleeping 60 seconds before retrying 15:46:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/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 15:46:48 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:46:48 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 15:46:48 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/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! 15:46:48 INFO - Caught exception: HTTP Error 404: Not Found 15:46:48 INFO - Caught exception: HTTP Error 404: Not Found 15:46:48 INFO - Caught exception: HTTP Error 404: Not Found 15:46:48 INFO - trying https://queue.taskcluster.net/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:46:48 INFO - Downloading https://queue.taskcluster.net/v1/task/KreGsP7xSne2N8C4Uzlstg/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 15:46:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KreGsP7xSne2N8C4Uzlstg/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 15:46:49 INFO - Downloaded 56810134 bytes. 15:46:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:46:49 INFO - mkdir: /builds/slave/test/properties 15:46:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:46:49 INFO - Writing to file /builds/slave/test/properties/build_url 15:46:49 INFO - Contents: 15:46:49 INFO - build_url:https://queue.taskcluster.net/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:46:50 INFO - Running post-action listener: _resource_record_post_action 15:46:50 INFO - Running post-action listener: set_extra_try_arguments 15:46:50 INFO - [mozharness: 2016-10-03 22:46:50.183092Z] Finished download-and-extract step (success) 15:46:50 INFO - [mozharness: 2016-10-03 22:46:50.183325Z] Running populate-webroot step. 15:46:50 INFO - Running pre-action listener: _resource_record_pre_action 15:46:50 INFO - Running main action method: populate_webroot 15:46:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:46:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:46:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:46:50 INFO - '--tppagecycles', 15:46:50 INFO - '7'], 15:46:50 INFO - 'tests': ['tsvgm']}}, 15:46:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:46:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:46:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:46:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:46:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:46:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:46:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:46:50 INFO - 'talos_options': ['--disable-e10s'], 15:46:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:46:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:46:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:46:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:46:50 INFO - 'talos_options': ['--disable-e10s'], 15:46:50 INFO - 'tests': ['damp', 'tps']}, 15:46:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:46:50 INFO - 'tests': ['damp', 'tps']}, 15:46:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:46:50 INFO - 'tests': ['dromaeo_dom']}, 15:46:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:46:50 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:46:50 INFO - 'tests': ['basic_compositor_video']}, 15:46:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:46:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:46:50 INFO - 'tests': ['a11yr', 15:46:50 INFO - 'ts_paint', 15:46:50 INFO - 'tpaint', 15:46:50 INFO - 'sessionrestore', 15:46:50 INFO - 'sessionrestore_no_auto_restore', 15:46:50 INFO - 'tabpaint']}, 15:46:50 INFO - 'other-e10s': {'tests': ['a11yr', 15:46:50 INFO - 'ts_paint', 15:46:50 INFO - 'tpaint', 15:46:50 INFO - 'sessionrestore', 15:46:50 INFO - 'sessionrestore_no_auto_restore', 15:46:50 INFO - 'tabpaint']}, 15:46:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:46:50 INFO - 'ts_paint', 15:46:50 INFO - 'tpaint', 15:46:50 INFO - 'sessionrestore', 15:46:50 INFO - 'sessionrestore_no_auto_restore', 15:46:50 INFO - 'tabpaint']}, 15:46:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:46:50 INFO - 'ts_paint', 15:46:50 INFO - 'tpaint', 15:46:50 INFO - 'sessionrestore', 15:46:50 INFO - 'sessionrestore_no_auto_restore', 15:46:50 INFO - 'tabpaint']}, 15:46:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:46:50 INFO - 'tests': ['a11yr', 15:46:50 INFO - 'ts_paint', 15:46:50 INFO - 'tpaint', 15:46:50 INFO - 'sessionrestore', 15:46:50 INFO - 'sessionrestore_no_auto_restore', 15:46:50 INFO - 'tabpaint']}, 15:46:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:46:50 INFO - 'tests': ['a11yr', 15:46:50 INFO - 'ts_paint', 15:46:50 INFO - 'tpaint', 15:46:50 INFO - 'sessionrestore', 15:46:50 INFO - 'sessionrestore_no_auto_restore', 15:46:50 INFO - 'tabpaint']}, 15:46:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:46:50 INFO - 'tests': ['tsvgx', 15:46:50 INFO - 'tsvgr_opacity', 15:46:50 INFO - 'tart', 15:46:50 INFO - 'tscrollx', 15:46:50 INFO - 'cart']}, 15:46:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:46:50 INFO - 'tsvgr_opacity', 15:46:50 INFO - 'tart', 15:46:50 INFO - 'tscrollx', 15:46:50 INFO - 'cart']}, 15:46:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:46:50 INFO - 'talos_options': ['--disable-e10s'], 15:46:50 INFO - 'tests': ['tp5o']}, 15:46:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:46:50 INFO - 'tests': ['tp5o']}, 15:46:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:46:50 INFO - 'talos_options': ['--disable-e10s', 15:46:50 INFO - '--xperf_path', 15:46:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:46:50 INFO - 'tests': ['tp5n']}, 15:46:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:46:50 INFO - 'talos_options': ['--xperf_path', 15:46:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:46:50 INFO - 'tests': ['tp5n']}}, 15:46:50 INFO - 'talos.zip': {'path': '', 15:46:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:46:50 INFO - Running post-action listener: _resource_record_post_action 15:46:50 INFO - [mozharness: 2016-10-03 22:46:50.200446Z] Finished populate-webroot step (success) 15:46:50 INFO - [mozharness: 2016-10-03 22:46:50.200535Z] Running create-virtualenv step. 15:46:50 INFO - Running pre-action listener: _resource_record_pre_action 15:46:50 INFO - Running main action method: create_virtualenv 15:46:50 INFO - Creating virtualenv /builds/slave/test/build/venv 15:46:50 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 15:46:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:46:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:46:50 INFO - Using real prefix '/usr' 15:46:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:46:50 INFO - Installing distribute.............................................................................................................................................................................................done. 15:46:52 INFO - Installing pip.................done. 15:46:52 INFO - Return code: 0 15:46:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:46:52 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')]} 15:46:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:46:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:46:52 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')]} 15:46:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:46:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:46:52 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 0x239e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25cd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265c570>, '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 0x265d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265d900>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1475534349.28359-1514254637', '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 15:46:52 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 15:46:52 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 15:46:52 INFO - Using env: {'DISPLAY': ':0', 15:46:52 INFO - 'HOME': '/home/cltbld', 15:46:52 INFO - 'LANG': 'en_US.UTF-8', 15:46:52 INFO - 'LANGUAGE': 'en_US:en', 15:46:52 INFO - 'LOGNAME': 'cltbld', 15:46:52 INFO - 'MAIL': '/var/mail/cltbld', 15:46:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:46:52 INFO - 'MOZ_NO_REMOTE': '1', 15:46:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:46:52 INFO - 'NO_EM_RESTART': '1', 15:46:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:46:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:46:52 INFO - 'PWD': '/builds/slave/test', 15:46:52 INFO - 'SHELL': '/bin/bash', 15:46:52 INFO - 'SHLVL': '1', 15:46:52 INFO - 'TERM': 'linux', 15:46:52 INFO - 'TMOUT': '86400', 15:46:52 INFO - 'USER': 'cltbld', 15:46:52 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1475534349.28359-1514254637', 15:46:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:46:52 INFO - '_': '/tools/buildbot/bin/python'} 15:46:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:46:52 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 15:46:52 INFO - Cleaning up... 15:46:52 INFO - Return code: 0 15:46:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:46:52 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')]} 15:46:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:46:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:46:52 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')]} 15:46:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:46:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:46:52 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 0x239e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25cd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265c570>, '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 0x265d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265d900>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1475534349.28359-1514254637', '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 15:46:52 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 15:46:52 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 15:46:52 INFO - Using env: {'DISPLAY': ':0', 15:46:52 INFO - 'HOME': '/home/cltbld', 15:46:52 INFO - 'LANG': 'en_US.UTF-8', 15:46:52 INFO - 'LANGUAGE': 'en_US:en', 15:46:52 INFO - 'LOGNAME': 'cltbld', 15:46:52 INFO - 'MAIL': '/var/mail/cltbld', 15:46:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:46:52 INFO - 'MOZ_NO_REMOTE': '1', 15:46:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:46:52 INFO - 'NO_EM_RESTART': '1', 15:46:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:46:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:46:52 INFO - 'PWD': '/builds/slave/test', 15:46:52 INFO - 'SHELL': '/bin/bash', 15:46:52 INFO - 'SHLVL': '1', 15:46:52 INFO - 'TERM': 'linux', 15:46:52 INFO - 'TMOUT': '86400', 15:46:52 INFO - 'USER': 'cltbld', 15:46:52 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1475534349.28359-1514254637', 15:46:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:46:52 INFO - '_': '/tools/buildbot/bin/python'} 15:46:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:46:53 INFO - Downloading/unpacking psutil>=3.1.1 15:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:46:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:46:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:46:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:46:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:46:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:46:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:46:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:46:55 INFO - Installing collected packages: psutil 15:46:55 INFO - Running setup.py install for psutil 15:46:55 INFO - building 'psutil._psutil_linux' extension 15:46:55 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 15:46:55 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 15:46:55 INFO - building 'psutil._psutil_posix' extension 15:46:55 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 15:46:55 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 15:46:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:46:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:46:55 INFO - Successfully installed psutil 15:46:55 INFO - Cleaning up... 15:46:55 INFO - Return code: 0 15:46:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:46:55 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')]} 15:46:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:46:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:46:55 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')]} 15:46:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:46:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:46:55 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 0x239e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25cd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265c570>, '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 0x265d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265d900>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1475534349.28359-1514254637', '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 15:46:55 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 15:46:55 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 15:46:55 INFO - Using env: {'DISPLAY': ':0', 15:46:55 INFO - 'HOME': '/home/cltbld', 15:46:55 INFO - 'LANG': 'en_US.UTF-8', 15:46:55 INFO - 'LANGUAGE': 'en_US:en', 15:46:55 INFO - 'LOGNAME': 'cltbld', 15:46:55 INFO - 'MAIL': '/var/mail/cltbld', 15:46:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:46:55 INFO - 'MOZ_NO_REMOTE': '1', 15:46:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:46:55 INFO - 'NO_EM_RESTART': '1', 15:46:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:46:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:46:55 INFO - 'PWD': '/builds/slave/test', 15:46:55 INFO - 'SHELL': '/bin/bash', 15:46:55 INFO - 'SHLVL': '1', 15:46:55 INFO - 'TERM': 'linux', 15:46:55 INFO - 'TMOUT': '86400', 15:46:55 INFO - 'USER': 'cltbld', 15:46:55 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1475534349.28359-1514254637', 15:46:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:46:55 INFO - '_': '/tools/buildbot/bin/python'} 15:46:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:46:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:46:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:46:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:46:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:46:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:46:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:46:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:46:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:46:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:46:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:46:57 INFO - Installing collected packages: mozsystemmonitor 15:46:57 INFO - Running setup.py install for mozsystemmonitor 15:46:57 INFO - Successfully installed mozsystemmonitor 15:46:57 INFO - Cleaning up... 15:46:58 INFO - Return code: 0 15:46:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:46:58 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')]} 15:46:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:46:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:46:58 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')]} 15:46:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:46:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:46:58 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 0x239e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25cd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265c570>, '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 0x265d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265d900>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1475534349.28359-1514254637', '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 15:46:58 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 15:46:58 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 15:46:58 INFO - Using env: {'DISPLAY': ':0', 15:46:58 INFO - 'HOME': '/home/cltbld', 15:46:58 INFO - 'LANG': 'en_US.UTF-8', 15:46:58 INFO - 'LANGUAGE': 'en_US:en', 15:46:58 INFO - 'LOGNAME': 'cltbld', 15:46:58 INFO - 'MAIL': '/var/mail/cltbld', 15:46:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:46:58 INFO - 'MOZ_NO_REMOTE': '1', 15:46:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:46:58 INFO - 'NO_EM_RESTART': '1', 15:46:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:46:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:46:58 INFO - 'PWD': '/builds/slave/test', 15:46:58 INFO - 'SHELL': '/bin/bash', 15:46:58 INFO - 'SHLVL': '1', 15:46:58 INFO - 'TERM': 'linux', 15:46:58 INFO - 'TMOUT': '86400', 15:46:58 INFO - 'USER': 'cltbld', 15:46:58 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1475534349.28359-1514254637', 15:46:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:46:58 INFO - '_': '/tools/buildbot/bin/python'} 15:46:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:46:58 INFO - Downloading/unpacking jsonschema==2.5.1 15:46:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:46:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:46:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:46:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:46:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:46:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:47:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:47:00 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 15:47:00 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 15:47:00 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 15:47:00 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 15:47:00 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 15:47:00 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 15:47:00 INFO - Downloading functools32-3.2.3-2.tar.gz 15:47:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:47:00 INFO - warning: no files found matching '*.txt' 15:47:00 INFO - no previously-included directories found matching 'build' 15:47:00 INFO - no previously-included directories found matching 'dist' 15:47:00 INFO - no previously-included directories found matching '.git*' 15:47:00 INFO - Installing collected packages: jsonschema, functools32 15:47:00 INFO - Running setup.py install for functools32 15:47:00 INFO - warning: no files found matching '*.txt' 15:47:00 INFO - no previously-included directories found matching 'build' 15:47:00 INFO - no previously-included directories found matching 'dist' 15:47:00 INFO - no previously-included directories found matching '.git*' 15:47:00 INFO - Successfully installed jsonschema functools32 15:47:00 INFO - Cleaning up... 15:47:00 INFO - Return code: 0 15:47:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:47:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:00 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 0x239e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25cd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265c570>, '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 0x265d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265d900>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1475534349.28359-1514254637', '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 15:47:00 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 15:47:00 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 15:47:00 INFO - Using env: {'DISPLAY': ':0', 15:47:00 INFO - 'HOME': '/home/cltbld', 15:47:00 INFO - 'LANG': 'en_US.UTF-8', 15:47:00 INFO - 'LANGUAGE': 'en_US:en', 15:47:00 INFO - 'LOGNAME': 'cltbld', 15:47:00 INFO - 'MAIL': '/var/mail/cltbld', 15:47:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:00 INFO - 'MOZ_NO_REMOTE': '1', 15:47:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:00 INFO - 'NO_EM_RESTART': '1', 15:47:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:00 INFO - 'PWD': '/builds/slave/test', 15:47:00 INFO - 'SHELL': '/bin/bash', 15:47:00 INFO - 'SHLVL': '1', 15:47:00 INFO - 'TERM': 'linux', 15:47:00 INFO - 'TMOUT': '86400', 15:47:00 INFO - 'USER': 'cltbld', 15:47:00 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1475534349.28359-1514254637', 15:47:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:00 INFO - '_': '/tools/buildbot/bin/python'} 15:47:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:47:00 INFO - Cleaning up... 15:47:00 INFO - Return code: 0 15:47:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:47:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:00 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 0x239e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25cd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265c570>, '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 0x265d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265d900>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1475534349.28359-1514254637', '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 15:47:00 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 15:47:00 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 15:47:00 INFO - Using env: {'DISPLAY': ':0', 15:47:00 INFO - 'HOME': '/home/cltbld', 15:47:00 INFO - 'LANG': 'en_US.UTF-8', 15:47:00 INFO - 'LANGUAGE': 'en_US:en', 15:47:00 INFO - 'LOGNAME': 'cltbld', 15:47:00 INFO - 'MAIL': '/var/mail/cltbld', 15:47:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:00 INFO - 'MOZ_NO_REMOTE': '1', 15:47:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:00 INFO - 'NO_EM_RESTART': '1', 15:47:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:00 INFO - 'PWD': '/builds/slave/test', 15:47:00 INFO - 'SHELL': '/bin/bash', 15:47:00 INFO - 'SHLVL': '1', 15:47:00 INFO - 'TERM': 'linux', 15:47:00 INFO - 'TMOUT': '86400', 15:47:00 INFO - 'USER': 'cltbld', 15:47:00 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1475534349.28359-1514254637', 15:47:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:00 INFO - '_': '/tools/buildbot/bin/python'} 15:47:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:01 INFO - Downloading/unpacking blobuploader==1.2.4 15:47: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 15:47: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 15:47: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 15:47: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 15:47: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 15:47: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 15:47:02 INFO - Downloading blobuploader-1.2.4.tar.gz 15:47:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:47:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:47:03 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 15:47:03 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 15:47:03 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 15:47:03 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 15:47:03 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 15:47:03 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 15:47:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:47:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:47:03 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 15:47:03 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 15:47:03 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 15:47:03 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 15:47:03 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 15:47:03 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 15:47:03 INFO - Downloading docopt-0.6.1.tar.gz 15:47:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:47:03 INFO - Installing collected packages: blobuploader, requests, docopt 15:47:03 INFO - Running setup.py install for blobuploader 15:47:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:47:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:47:03 INFO - Running setup.py install for requests 15:47:04 INFO - Running setup.py install for docopt 15:47:04 INFO - Successfully installed blobuploader requests docopt 15:47:04 INFO - Cleaning up... 15:47:04 INFO - Return code: 0 15:47:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:47:04 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')]} 15:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:04 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')]} 15:47:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:04 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 0x239e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25cd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265c570>, '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 0x265d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265d900>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1475534349.28359-1514254637', '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 15:47:04 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 15:47:04 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 15:47:04 INFO - Using env: {'DISPLAY': ':0', 15:47:04 INFO - 'HOME': '/home/cltbld', 15:47:04 INFO - 'LANG': 'en_US.UTF-8', 15:47:04 INFO - 'LANGUAGE': 'en_US:en', 15:47:04 INFO - 'LOGNAME': 'cltbld', 15:47:04 INFO - 'MAIL': '/var/mail/cltbld', 15:47:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:04 INFO - 'MOZ_NO_REMOTE': '1', 15:47:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:04 INFO - 'NO_EM_RESTART': '1', 15:47:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:04 INFO - 'PWD': '/builds/slave/test', 15:47:04 INFO - 'SHELL': '/bin/bash', 15:47:04 INFO - 'SHLVL': '1', 15:47:04 INFO - 'TERM': 'linux', 15:47:04 INFO - 'TMOUT': '86400', 15:47:04 INFO - 'USER': 'cltbld', 15:47:04 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1475534349.28359-1514254637', 15:47:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:04 INFO - '_': '/tools/buildbot/bin/python'} 15:47:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:47:04 INFO - Running setup.py (path:/tmp/pip-cNSXCG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:47:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:47:04 INFO - Running setup.py (path:/tmp/pip-JTjTrs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:47:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:47:04 INFO - Running setup.py (path:/tmp/pip-EZDPTE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:47:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:47:04 INFO - Running setup.py (path:/tmp/pip-K4fHzo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:47:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:47:04 INFO - Running setup.py (path:/tmp/pip-i2aQxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:47:05 INFO - Running setup.py (path:/tmp/pip-yDSnAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:47:05 INFO - Running setup.py (path:/tmp/pip-MLvjqy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:47:05 INFO - Running setup.py (path:/tmp/pip-fPZ4el-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:47:05 INFO - Running setup.py (path:/tmp/pip-vE0wXR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:47:05 INFO - Running setup.py (path:/tmp/pip-JHcIPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:47:05 INFO - Running setup.py (path:/tmp/pip-nxGADF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:47:05 INFO - Running setup.py (path:/tmp/pip-N1ba0s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:47:05 INFO - Running setup.py (path:/tmp/pip-1mnHSx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:47:05 INFO - Running setup.py (path:/tmp/pip-DKTQRr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:47:05 INFO - Running setup.py (path:/tmp/pip-Oo3lYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:47:05 INFO - Running setup.py (path:/tmp/pip-GFsi4Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:47:05 INFO - Running setup.py (path:/tmp/pip-vUwWRk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:47:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:47:05 INFO - Running setup.py install for manifestparser 15:47:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:47:06 INFO - Running setup.py install for mozcrash 15:47:06 INFO - Running setup.py install for mozdebug 15:47:06 INFO - Running setup.py install for mozdevice 15:47:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:47:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:47:06 INFO - Running setup.py install for mozfile 15:47:06 INFO - Running setup.py install for mozhttpd 15:47:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:47:06 INFO - Running setup.py install for mozinfo 15:47:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:47:06 INFO - Running setup.py install for mozInstall 15:47:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:47:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:47:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:47:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:47:06 INFO - Running setup.py install for mozleak 15:47:06 INFO - Running setup.py install for mozlog 15:47:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:47:06 INFO - Running setup.py install for moznetwork 15:47:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:47:07 INFO - Running setup.py install for mozprocess 15:47:07 INFO - Running setup.py install for mozprofile 15:47:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:47:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:47:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:47:07 INFO - Running setup.py install for mozrunner 15:47:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:47:07 INFO - Running setup.py install for mozscreenshot 15:47:07 INFO - Running setup.py install for moztest 15:47:07 INFO - Running setup.py install for mozversion 15:47:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:47:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:47:07 INFO - Cleaning up... 15:47:07 INFO - Return code: 0 15:47:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:47:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:07 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 0x239e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25cd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265c570>, '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 0x265d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265d900>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1475534349.28359-1514254637', '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 15:47:07 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 15:47:07 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 15:47:07 INFO - Using env: {'DISPLAY': ':0', 15:47:07 INFO - 'HOME': '/home/cltbld', 15:47:07 INFO - 'LANG': 'en_US.UTF-8', 15:47:07 INFO - 'LANGUAGE': 'en_US:en', 15:47:07 INFO - 'LOGNAME': 'cltbld', 15:47:07 INFO - 'MAIL': '/var/mail/cltbld', 15:47:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:07 INFO - 'MOZ_NO_REMOTE': '1', 15:47:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:07 INFO - 'NO_EM_RESTART': '1', 15:47:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:07 INFO - 'PWD': '/builds/slave/test', 15:47:07 INFO - 'SHELL': '/bin/bash', 15:47:07 INFO - 'SHLVL': '1', 15:47:07 INFO - 'TERM': 'linux', 15:47:07 INFO - 'TMOUT': '86400', 15:47:07 INFO - 'USER': 'cltbld', 15:47:07 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1475534349.28359-1514254637', 15:47:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:07 INFO - '_': '/tools/buildbot/bin/python'} 15:47:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:47:07 INFO - Running setup.py (path:/tmp/pip-3fh6sC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:47:07 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)) 15:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:47:07 INFO - Running setup.py (path:/tmp/pip-vZHGW7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:47:08 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)) 15:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:47:08 INFO - Running setup.py (path:/tmp/pip-euIr6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:47:08 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)) 15:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:47:08 INFO - Running setup.py (path:/tmp/pip-2fwwlL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:47:08 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)) 15:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:47:08 INFO - Running setup.py (path:/tmp/pip-ulz84m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:47:08 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)) 15:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:47:08 INFO - Running setup.py (path:/tmp/pip-4jwu3D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:47:08 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)) 15:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:47:08 INFO - Running setup.py (path:/tmp/pip-2uKYKj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:47:08 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)) 15:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:47:08 INFO - Running setup.py (path:/tmp/pip-_lwFY2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:47:08 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)) 15:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:47:08 INFO - Running setup.py (path:/tmp/pip-bgGUpv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:47:08 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)) 15:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:47:08 INFO - Running setup.py (path:/tmp/pip-HP7UFO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:47:08 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)) 15:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:47:08 INFO - Running setup.py (path:/tmp/pip-w6jFda-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:47:08 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)) 15:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:47:08 INFO - Running setup.py (path:/tmp/pip-QY3F87-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:47:08 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)) 15:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:47:08 INFO - Running setup.py (path:/tmp/pip-AK8A7D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:47:08 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)) 15:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:47:08 INFO - Running setup.py (path:/tmp/pip-NfMNra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:47:08 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)) 15:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:47:08 INFO - Running setup.py (path:/tmp/pip-lzUDs7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:47:09 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)) 15:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:47:09 INFO - Running setup.py (path:/tmp/pip-3HmClc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:47:09 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)) 15:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:47:09 INFO - Running setup.py (path:/tmp/pip-rlcWjw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:47:09 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)) 15:47:09 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)) 15:47:09 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)) 15:47:09 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)) 15:47:09 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)) 15:47:09 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)) 15:47:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:47:09 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 15:47:09 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 15:47:09 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 15:47:09 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 15:47:09 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 15:47:09 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 15:47:11 INFO - Downloading blessings-1.6.tar.gz 15:47:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:47:11 INFO - Installing collected packages: blessings 15:47:11 INFO - Running setup.py install for blessings 15:47:11 INFO - Successfully installed blessings 15:47:11 INFO - Cleaning up... 15:47:11 INFO - Return code: 0 15:47:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:47:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:47:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:47:11 INFO - Reading from file tmpfile_stdout 15:47:11 INFO - Current package versions: 15:47:11 INFO - argparse == 1.2.1 15:47:11 INFO - blessings == 1.6 15:47:11 INFO - blobuploader == 1.2.4 15:47:11 INFO - docopt == 0.6.1 15:47:11 INFO - functools32 == 3.2.3-2 15:47:11 INFO - jsonschema == 2.5.1 15:47:11 INFO - manifestparser == 1.1 15:47:11 INFO - mozInstall == 1.12 15:47:11 INFO - mozcrash == 0.17 15:47:11 INFO - mozdebug == 0.1 15:47:11 INFO - mozdevice == 0.48 15:47:11 INFO - mozfile == 1.2 15:47:11 INFO - mozhttpd == 0.7 15:47:11 INFO - mozinfo == 0.9 15:47:11 INFO - mozleak == 0.1 15:47:11 INFO - mozlog == 3.3 15:47:11 INFO - moznetwork == 0.27 15:47:11 INFO - mozprocess == 0.23 15:47:11 INFO - mozprofile == 0.28 15:47:11 INFO - mozrunner == 6.12 15:47:11 INFO - mozscreenshot == 0.1 15:47:11 INFO - mozsystemmonitor == 0.3 15:47:11 INFO - moztest == 0.7 15:47:11 INFO - mozversion == 1.4 15:47:11 INFO - psutil == 3.1.1 15:47:11 INFO - requests == 1.2.3 15:47:11 INFO - wsgiref == 0.1.2 15:47:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:47:11 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')]} 15:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:11 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')]} 15:47:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:11 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 0x239e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25cd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265c570>, '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 0x265d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265d900>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1475534349.28359-1514254637', '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 15:47:11 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 15:47:11 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 15:47:11 INFO - Using env: {'DISPLAY': ':0', 15:47:11 INFO - 'HOME': '/home/cltbld', 15:47:11 INFO - 'LANG': 'en_US.UTF-8', 15:47:11 INFO - 'LANGUAGE': 'en_US:en', 15:47:11 INFO - 'LOGNAME': 'cltbld', 15:47:11 INFO - 'MAIL': '/var/mail/cltbld', 15:47:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:11 INFO - 'MOZ_NO_REMOTE': '1', 15:47:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:11 INFO - 'NO_EM_RESTART': '1', 15:47:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:11 INFO - 'PWD': '/builds/slave/test', 15:47:11 INFO - 'SHELL': '/bin/bash', 15:47:11 INFO - 'SHLVL': '1', 15:47:11 INFO - 'TERM': 'linux', 15:47:11 INFO - 'TMOUT': '86400', 15:47:11 INFO - 'USER': 'cltbld', 15:47:11 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1475534349.28359-1514254637', 15:47:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:11 INFO - '_': '/tools/buildbot/bin/python'} 15:47:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:11 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)) 15:47:11 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)) 15:47:11 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)) 15:47:11 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)) 15:47:11 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)) 15:47:11 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)) 15:47:11 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)) 15:47:11 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)) 15:47:11 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)) 15:47:11 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)) 15:47:11 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)) 15:47:11 INFO - Cleaning up... 15:47:11 INFO - Return code: 0 15:47:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:47:11 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')]} 15:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:11 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')]} 15:47:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:11 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 0x239e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25cd400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265c570>, '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 0x265d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265d900>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1475534349.28359-1514254637', '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 15:47:11 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 15:47:11 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 15:47:11 INFO - Using env: {'DISPLAY': ':0', 15:47:11 INFO - 'HOME': '/home/cltbld', 15:47:11 INFO - 'LANG': 'en_US.UTF-8', 15:47:11 INFO - 'LANGUAGE': 'en_US:en', 15:47:11 INFO - 'LOGNAME': 'cltbld', 15:47:11 INFO - 'MAIL': '/var/mail/cltbld', 15:47:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:11 INFO - 'MOZ_NO_REMOTE': '1', 15:47:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:11 INFO - 'NO_EM_RESTART': '1', 15:47:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:11 INFO - 'PWD': '/builds/slave/test', 15:47:11 INFO - 'SHELL': '/bin/bash', 15:47:11 INFO - 'SHLVL': '1', 15:47:11 INFO - 'TERM': 'linux', 15:47:11 INFO - 'TMOUT': '86400', 15:47:11 INFO - 'USER': 'cltbld', 15:47:11 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1475534349.28359-1514254637', 15:47:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:11 INFO - '_': '/tools/buildbot/bin/python'} 15:47:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:47:11 INFO - Cleaning up... 15:47:11 INFO - Return code: 0 15:47:11 INFO - Running post-action listener: _resource_record_post_action 15:47:11 INFO - Running post-action listener: _start_resource_monitoring 15:47:11 INFO - Starting resource monitoring. 15:47:11 INFO - [mozharness: 2016-10-03 22:47:11.977159Z] Finished create-virtualenv step (success) 15:47:11 INFO - [mozharness: 2016-10-03 22:47:11.977704Z] Running install step. 15:47:11 INFO - Running pre-action listener: _resource_record_pre_action 15:47:11 INFO - Running main action method: install 15:47:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:47:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:47:12 INFO - Reading from file tmpfile_stdout 15:47:12 INFO - Detecting whether we're running mozinstall >=1.0... 15:47:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:47:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:47:12 INFO - Reading from file tmpfile_stdout 15:47:12 INFO - Output received: 15:47:12 INFO - Usage: mozinstall [options] installer 15:47:12 INFO - Options: 15:47:12 INFO - -h, --help show this help message and exit 15:47:12 INFO - -d DEST, --destination=DEST 15:47:12 INFO - Directory to install application into. [default: 15:47:12 INFO - "/builds/slave/test"] 15:47:12 INFO - --app=APP Application being installed. [default: firefox] 15:47:12 INFO - mkdir: /builds/slave/test/build/application 15:47:12 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'] 15:47:12 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 15:47:26 INFO - Reading from file tmpfile_stdout 15:47:26 INFO - Output received: 15:47:26 INFO - /builds/slave/test/build/application/firefox/firefox 15:47:26 INFO - Running post-action listener: _resource_record_post_action 15:47:26 INFO - [mozharness: 2016-10-03 22:47:26.376638Z] Finished install step (success) 15:47:26 INFO - [mozharness: 2016-10-03 22:47:26.376920Z] Running run-tests step. 15:47:26 INFO - Running pre-action listener: _resource_record_pre_action 15:47:26 INFO - Running main action method: run_tests 15:47:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:47:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:47:26 INFO - Python 2.7.3 15:47:26 INFO - Return code: 0 15:47:26 INFO - grabbing minidump binary from tooltool 15:47:26 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')]} 15:47:26 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 0x265c570>, '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 0x265d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x265d900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:47:26 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 15:47:26 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 15:47:26 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 15:47:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:47:26 INFO - Return code: 0 15:47:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:47:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:47:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:47:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:47:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:47:26 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/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 15:47:26 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/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --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 15:47:26 INFO - Using env: {'DISPLAY': ':0', 15:47:26 INFO - 'HOME': '/home/cltbld', 15:47:26 INFO - 'LANG': 'en_US.UTF-8', 15:47:26 INFO - 'LANGUAGE': 'en_US:en', 15:47:26 INFO - 'LOGNAME': 'cltbld', 15:47:26 INFO - 'MAIL': '/var/mail/cltbld', 15:47:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:47:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:47:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:26 INFO - 'MOZ_NO_REMOTE': '1', 15:47:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:47:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:26 INFO - 'NO_EM_RESTART': '1', 15:47:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:26 INFO - 'PWD': '/builds/slave/test', 15:47:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:47:26 INFO - 'SHELL': '/bin/bash', 15:47:26 INFO - 'SHLVL': '1', 15:47:26 INFO - 'TERM': 'linux', 15:47:26 INFO - 'TMOUT': '86400', 15:47:26 INFO - 'USER': 'cltbld', 15:47:26 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1475534349.28359-1514254637', 15:47:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:26 INFO - '_': '/tools/buildbot/bin/python'} 15:47:26 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/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 15:47:26 INFO - mozversion application_buildid: 20161003124659 15:47:26 INFO - mozversion application_changeset: 47dff98b4b466b0b373ff04a2bb95542260be0c3 15:47:26 INFO - mozversion application_display_name: Firefox 15:47:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:47:26 INFO - mozversion application_name: Firefox 15:47:26 INFO - mozversion application_remotingname: firefox 15:47:26 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 15:47:26 INFO - mozversion application_vendor: Mozilla 15:47:26 INFO - mozversion application_version: 50.0 15:47:26 INFO - mozversion platform_buildid: 20161003124659 15:47:26 INFO - mozversion platform_changeset: 47dff98b4b466b0b373ff04a2bb95542260be0c3 15:47:26 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 15:47:26 INFO - mozversion platform_version: 50.0 15:47:26 INFO - using testdate: 1475534846 15:47:26 INFO - actual date: 1475534846 15:47:26 INFO - starting webserver on 'localhost:46150' 15:47:26 INFO - SUITE-START | Running 2 tests 15:47:26 INFO - TEST-START | dromaeo_css 15:47:26 INFO - operating with platform_type : linux_ 15:47:26 INFO - Initialising browser for dromaeo_css test... 15:47:26 INFO - TEST-INFO | started process 13836 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYX3HMI/profile http://localhost:46150/getInfo.html) 15:47:31 INFO - PROCESS | 13836 | __metrics Screen width/height:1600/1200 15:47:31 INFO - PROCESS | 13836 | colorDepth:24 15:47:31 INFO - PROCESS | 13836 | Browser inner width/height: 1024/697 15:47:31 INFO - PROCESS | 13836 | __metrics 15:47:31 ERROR - PROCESS | 13836 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 15:47:32 INFO - TEST-INFO | 13836: exit 0 15:47:32 INFO - Browser initialized. 15:47:32 INFO - Running cycle 1/1 for dromaeo_css test... 15:47:32 INFO - TEST-INFO | started process 13961 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYX3HMI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:47:44 INFO - PROCESS | 13961 | RSS: Main: 150257664 15:47:44 INFO - PROCESS | 13961 | 15:48:34 INFO - PROCESS | 13961 | 1475534914037 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] 15:50:42 INFO - PROCESS | 13961 | Cycle 1(1): loaded http://localhost:46150/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46150/tests/dromaeo/cssquery-ext.html) 15:50:43 INFO - PROCESS | 13961 | RSS: Main: 158412800 15:50:43 INFO - PROCESS | 13961 | 15:53:45 INFO - PROCESS | 13961 | Cycle 1(1): loaded http://localhost:46150/tests/dromaeo/cssquery-ext.html (next: http://localhost:46150/tests/dromaeo/cssquery-jquery.html) 15:53:46 INFO - PROCESS | 13961 | RSS: Main: 155779072 15:53:46 INFO - PROCESS | 13961 | 15:56:48 INFO - PROCESS | 13961 | Cycle 1(1): loaded http://localhost:46150/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46150/tests/dromaeo/cssquery-mootools.html) 15:56:48 INFO - PROCESS | 13961 | RSS: Main: 155410432 15:56:48 INFO - PROCESS | 13961 | 15:59:50 INFO - PROCESS | 13961 | Cycle 1(1): loaded http://localhost:46150/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46150/tests/dromaeo/cssquery-prototype.html) 15:59:51 INFO - PROCESS | 13961 | RSS: Main: 157052928 15:59:51 INFO - PROCESS | 13961 | 16:02:53 INFO - PROCESS | 13961 | Cycle 1(1): loaded http://localhost:46150/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46150/tests/dromaeo/cssquery-yui.html) 16:02:54 INFO - PROCESS | 13961 | RSS: Main: 157769728 16:02:54 INFO - PROCESS | 13961 | 16:05:56 INFO - PROCESS | 13961 | Cycle 1(1): loaded http://localhost:46150/tests/dromaeo/cssquery-yui.html (next: http://localhost:46150/tests/dromaeo/cssquery-dojo.html) 16:05:56 INFO - PROCESS | 13961 | RSS: Main: 157097984 16:05:56 INFO - PROCESS | 13961 | 16:05:56 INFO - PROCESS | 13961 | __start_tp_report 16:05:56 INFO - PROCESS | 13961 | _x_x_mozilla_page_load 16:05:56 INFO - PROCESS | 13961 | _x_x_mozilla_page_load_details 16:05:56 INFO - PROCESS | 13961 | |i|pagename|runs| 16:05:56 INFO - PROCESS | 13961 | |0;dojo.html;3284.4744840825474;3295.242094318307;3304.504324351347;3332.5334453176542;3335.4329763940127;5772.942270577293;5807.767689292423;5809.070548712207;5809.157672137538;5836.79571215007;5872.354041055481;5918.4673379395845;5929.555283353744;5934.554908381878;5948.791792287271;5322.654027488201;5381.784728610851;5389.757460914268;5415.0523658359825;5464.508194262516;5401.351837779453;5422.91865622016;5435.809746658868;5443.101888188444;5448.700321482317;5214.217867319913;5220.060389129955;5417.6207665463435;5434.864128396782;5439.5376393006445;5294.444083371229;5321.308229930123;5344.652597581145;5382.946170538284;5457.345118585756;5296.152615581488;5332.786688532454;5392.245085688007;5393.5954803389905;5396.865078373033;5869.765209391662;5879.412058794129;5939.524838012949;5971.402859714038;5987;6076.4834989025985;6140.570160088796;6163.691815409256;6182.938170618281;6217.067439884008;6244.781432649881;6254.124422580842;6256.499480041586;6257.812265632038;6258.812235632939;5825.359210486843;5829.647952427329;5831.970840145772;5842.036064049385;5862.062070068811;6200.937990620127;6280.811575652738;6299.811005669837;6310.432061114522;6414.198225221848;6132.50939924805;6166.784162554289;6172.475339596184;6182.6599537025895;6188.721507532172;6210.875782484325;6215;6285.937140628626;6296.653684047421;6298.811035668938;6093.086037094471;6094.6647934363145;6110.816675499653;6143.56995010345;6220.875582488325;6178.938210617836;6189.288231853395;6196.938030619726;6218.502519798496;6221.06683997395;4758.928616070762;4761.857144285677;4768.690035147704;4768.904621907543;4785.976070119627;4101.569335219759;4158.521769996429;4180.372944058355;4202.768847713344;4269.295566231537;5962.195103661037;6025;6033.879322413615;6037.245344331958;6047.15339852421;6333.2400111985935;6344.270408902943;6345.8730825384155;6347.55567110307;6351.269603995507;5776.740046697909;5876.177335173079;5927;5940.257467816523;6027.367126451747;5379.058664733656;5389.0299746046085;5392.272043274186;5410.269613602192;5426.348838139448;6363.077353783768;6471.449926756279;6490.4807615390655;6496.577722448026;6497.837554061186;6196.876062478816;6218.22272215973;6219.849327874358;6324.146240257691;6330.968345158245;6479.639275751956;6530.9020364693615;6542.443892269211;6548.1487406638735;6560.147180866456;5984.222051133324;6195.504359651127;6209.875802484015;6214.875702486015;6245.594036387621;6116.66358350295;6120.508083830795;6149.292831324276;6253.906191407042;6266.028765541349;6061.181740465157;6063.211782468251;6067.120267561268;6077.878442431215;6082.513398927987;6043.758249669964;6073.787417440545;6085.726142323695;6086.513078953762;6092.360302168386;5880.500157486662;6000.729967151576;6026.517878569792;6080.69596520181;6113.052476866093;6144.600600960924;6146.245452195804;6192.287886893065;6199.039148931923;6202.472789812917;5882.588218824641;6039.48664363534;6071.3625069368845;6072.301685306246;6079.878402432015 16:05:56 INFO - PROCESS | 13961 | |1;ext.html;602.0728078758711;632.9398707122823;656.3862788292946;665.1618960110261;707.4128473367106;41607;46040.76979615097;46063.078738425254;46480.535194648044;46504.767476162655;45660.315095273596;45899;46072.769636151774;46211.537884621146;46255.30617040747;9052.54737263136;9110.134537218953;9182.494962777044;9193;9215.17063464288;9049.592768325409;9088.954555227214;9153.359264851462;9162.770930726718;9172.495512746797;9176.265898728087;9206.26349892007;9221.123993220634;9225.446473211596;9237.861432078524;9216.17054465098;9223.169914707674;9225.215856652192;9226.07739226082;9238.399504032217;9082.727518174466;9169.541522923893;9174.128457796498;9191.264698824078;9199.172074513259;45028.54971450309;45145.548544514466;45180.54819451796;45330.32004519935;45609.54390456086;3794.5067141271734;3888.786116763577;3923.5880232575455;3933.7443066200603;4065.532463766675;34860.30279394398;34956.6504334956;35078.12304692378;35248.6475135248;36230.27539449196;4624.468186158601;4732.361131247307;4739.170645137087;4739.597134243593;4836.202026665596;387178;387553;387732;388189;389259;66495.33504664988;66694;66754;66809.33190668031;66984;40354.79822600868;41637.58362416398;41651.58348416538;43471.26114955366;43749.562504375186;19340.8065919339;19617.705734413994;19626.509337266398;19639.410817675493;19694.704579431032;14697.55907322782;14825.406983720746;14846.70306593862;14892.851071489147;14947.252637368305;20804.791952080286;21267.78732212689;21346.359609211748;21408.892955535124;21544.245951391626;7307.926920730831;7486.213947535539;7519.473636845478;7598.240175982358;7606.847863042708;1050.847627094067;1052.2529004406804;1112.504935303782;1153.4694040741354;1190.33936165429;32844.343113137606;32915.50626740553;33524;33609.66390336114;33658.158546036546;1098.181854518373;1187.9881201187877;1201.2251698576142;1212.9818052729215;1257.7295881385546;17335.479935601954;17860.642787144185;17923.820761792475;17986.37047703324;18093.909530452263;557719;563297;563557;564083;565761;64389;65268;65304.346956530775;65487.34512654908;65530.34469655243;1439.79842822005;1445.802340585614;1473.5432016075051;1480.415235981781;1492.5373134328393;33203;33536.10577353858;33552.32895342128;33567.83216083904;33734.15664608405;57360;57432.1385179231;57651.42348576628;58016.4198358011;58025.70987145206;476798;478100;478705;479952;482343;31974.36051279008;32019.359612807148;32199.678003220604;32380.514292286105;32436.67563324431;52333.953320932604;52794.208086879495;52841.73579132234;53078.469215307356;54404;43727.56272437362;44400.780020392216;45670.08659826718;46202.30696539488;47478.52521474741;45599.31601025921;45833;46446.30330545112;46457.53542464532;47147.52852471431;38630.42054369243;43438;44293.778531107135;44375.55624443714;44829.77585112053;37104;37284.25431491409;37508;38337;38631.80684096562;29060.564091539065;29084;29120.205673970915;29333.26666833346;29662.703372965992 16:05:56 INFO - PROCESS | 13961 | |2;jquery.html;416.71038628153445;431.84481511955534;435.4643788140587;441.865231104513;446.39067672626857;19185.1366688499;20280.695789563168;20970.790292097092;21105.894470527626;21118;20132.993350332497;20678.379648610528;21186.682199766976;21462;21505.354839354804;5875.412458754123;6056.424639659225;6113.144159817629;6149.877002459948;6185.907211391833;6004.18943442634;6015.398460153971;6035.124906888498;6036.63780173191;6062.302835173945;5769.855753606152;5900.232969713953;5925.762969481216;5957.136215248786;6000.579959402844;5871.324797648283;5888.882222355572;5941.079132734433;5953.28560572734;5964.791232306892;5271.472852714736;5391.867707781371;5397.919031214535;5398.838034858961;5411.891762164774;24569.50860982788;25194.49611007788;25239.49521009588;25269.115580954764;25338.113166039286;2349.5770761262966;2447.155731272708;2559.6928368595886;3196.568463257454;3316.4859446785786;10862.72843178919;10911.727206819893;10953.397563134024;13659.907207423383;15793.21033948298;2032.3090149349143;2036.7250421193246;2051.476873397274;2052.5279185787203;2056.331692200026;52293.47706522962;55224;64613;86747.56626216891;88257.55871220602;11577.884221157681;11755.294682318918;11791.528338866521;11953.820692689616;12048.397580120958;17010.744838827428;17062.146892655564;17079.829201707824;17081.40215092466;17112.144392780312;8853.778655533535;8864.335174861782;8936.195742383217;9073.183413492818;9125.726228213165;8295.253427191581;8417.915820841836;8451.408401411842;8669.609867555975;8701.041026333003;5007.173816320266;5045.924311135336;5103.464136265713;5290.68255904647;5354.8219391733755;2035.5521785207231;2103.5477372365017;2156.13754498202;2173.30454254637;2173.5870184664864;988.3940835705578;1031.7361232490139;1035.9430231337199;1050.5640159333943;1089.5478376473834;20160.69758953617;20295.391138265877;20431.38705838827;20431.4892127698;20664.380068597966;1006.7030226083323;1028.8662473878499;1031.7884833609091;1055.6358056470506;1075.634284343327;10801.243912926177;11401.315921044597;11478.655640330804;11577.421128943688;11700.88299117015;506813;508919;511065;523890;531718;58153.70923145442;58403.41596584065;59365.40634593685;95779;95956;940.4874343482682;984.414273507262;1034.8395998620076;1037.113268155731;1039.5010395010438;16297.755533666766;18957;19005.23979040878;19343.8065619342;19432;42493.575064250195;43448.78275608602;44487.55512444834;45026.54973450224;45468;58470.4152958465;63464.36535634584;67191.66404167948;67364;69005;8595;8665.696700615448;8682.262007729414;8699.695510657097;8859.202671759573;9772.462514561767;13886.652833679238;14451.49419770303;14544.200068996306;14593.197374144524;12206.450709717907;12441.191322564004;12611.74776504483;12703.491860325483;12714.491420343084;11770.823437648613;12131.757364852478;12156.513739450676;12299.569515066929;12413.131080824256;12138.817917731418;12203.69490762738;12408.62774116778;12750.234985900875;12781;7950.801229969065;8736.257418119278;8874.689385871721;9201.355905086579;9243.232188196967;11798.410079496163;11984.700382490159;12300.323482208207;12373.257604543756;12926.030547709148 16:05:56 INFO - PROCESS | 13961 | |3;mootools.html;1513.5383707969067;1518.8329283778785;1685.4438035448295;1821.8451431628312;1851.8981456019912;8128.187181281869;8204.179582041792;8770.122987701234;8773.122687731224;9008.954955225232;9034.367594268404;9410.435373877572;9436.811263774738;9457.243420526358;9474.431534107958;2453.153661986612;2478.5414698280874;2492.264781889338;2494.2018554062706;2495.292607520842;2427.186892391051;2498.7626175513296;2499.5875680512786;2507.761762632556;2519.407939134302;2507.874606269679;2514.3211332940095;2526.68416447944;2527.519771243467;2527.949441011179;2380.4048987753063;2401.267613377919;2406.42245860993;2438.756124387565;2438.9512209755885;2412.2280870121567;2412.3848418653133;2422.2612103308484;2426.6723992260995;2438.244144315268;9420.057994200593;9435.575399107056;9537.1893389062;9548.856767148498;9555.140037396668;5414.864628384283;5553.305836770403;5556.277683901108;5557.527610153142;5585.218069470277;3454.9827250863586;3498.352804731133;3573.1424458129864;3614.367485689994;3632.0738211756097;1177.7055736065984;1216.391804097951;1218.2933898339031;1228.1587112827742;1232.8150777383375;13035.41340639664;13038;13055.608331749967;13064.934675326562;13090.934545327404;4690.50328015684;4710.717356958594;4736.834210802605;4754.477007529169;4902.607791376681;10982.615608453665;10990.615328463466;11000.449977501094;11009.449527523591;11011;5427.402985671573;5450.754716037788;5460.672359658433;5463.890722185534;5477.424870388551;4413.867583972486;4881.072596206709;4988.35151430319;5005.074061298671;5032.47159048302;4362.541933097043;4425.955740442554;4437.933430998538;4498.392716983165;4546.340780586796;1374.9312534373241;1394.6680919721641;1407.8099456573232;1414.745345837759;1437.4106616287272;1058.915286777056;1063.8244689626124;1066.4827558634056;1070.0957690751302;1096.2874131814385;6380.968095159495;6416.454601358843;6496.123023391781;6531.869362612816;6546.672666366662;451.28246088719095;458.6422590379509;459.21245064714174;469.4859129253462;476.3973573429614;4470.821167153343;4492.191405547033;4512.729236245836;4559.749213793273;4604.97697511517;10435.113015393777;10777.568897244179;10825.512851921683;10825.78348433027;10847.728806779895;10421.06210441064;10481.790364192673;10634.680959571226;10700.30448020876;10719.464026798629;8148.51108933454;8198.549079800548;8317.209865062809;8324.62539185738;8334.958325208336;6077.331493535796;6134.8159555213415;6213.813585592439;6291.339409361951;6321.336259692666;9966.800663986825;9972.800543989224;10026.047525485068;10092.444915529717;10093.89906100959;9839.704808855746;9937.10566049059;9995.500224988577;9996.500174991075;10168.796624067329;7501.774946751606;7631.656575454007;7765.262300081483;8016;8261.38039647017;9221;9264.490453025148;9272.768180795534;9291.21024712907;9292.070792920655;8205.79485512843;8326.750197494084;8371.246587807127;8409;8422.073571906963;8205.671773129008;8310;8331;8340.082590915115;8532.402731808963;7668.731594394392;7682.769516914278;7692.269234422721;7755.534667919943;7776.222377762178;5477.3427188737605;5520.227168196376;5545.528630066489;5583.832485025456;5670.064439367458;5459.617826752248;5531.446855314436;5661.57538184646;5662.518685911744;5680.460356266148 16:05:56 INFO - PROCESS | 13961 | |4;prototype.html;334.4181124842773;350.85965613754496;352.1021395441623;355.2380144589856;357.11791874071054;5610.326760788701;5754.712264386774;5817;5859.589828711986;5890.970545147279;5669.348024977129;5690.374058853523;5693.943060569393;5714.428557144294;5762.1068734346245;4522.886927826806;4529.968328187899;4530.456345238576;4536.639008297514;4549.454065512143;4452.131834292314;4506.594406503414;4511.872031992002;4513.2101882170655;4545.52272011439;4467.307567327053;4469.865904022885;4470.307102399133;4480.910381792362;4507.301368287905;4487.394201782767;4497.302918047708;4498.910021799546;4529.592336689714;4551.112533056055;3949.980250098731;3957.960420395788;4025.335819589764;4062.878113656595;4068.593140685937;5525.143602741581;5529.557635389159;5534.640248383842;5553.16702494629;5586.435797976533;5182.6006978116075;5216.713080780555;5225.869353266199;5230.947690523084;5245.947540524584;5884.176215329857;5958.731857066442;6008.819735407901;6024.909626355608;6094.451499365034;4398.164348773755;4401;4421.668374871865;4422.491413487458;4436.378906953029;6261.342559031327;6304.558680892385;6318.546734251148;6325.9051114233325;6344.6510441925675;4329.848455304113;4467.329900514884;4513.480949690762;4537.500874903758;4541.137183935041;4631.374764406829;4636.188666983265;4640.164770341371;4647.419072615923;4661.067786442657;5203.973980130075;5227.294315267466;5273.6572122811895;5276.4434491825;5301.469853014668;5880.059190529495;5953.255843019622;6077.604955677867;6078.574499784972;6083.300420451705;1577.1325770826;1594.1152660273428;1601.0953811096692;1607.3650907891317;1613.5401410597924;1022.907938285543;1031.9886511219047;1043.175891046065;1043.7181960870523;1058.0794708603564;5112.897742045138;5157.871053223699;5196.818111366159;5219.295395121686;5225.843224703265;5459.66238271626;5482.588805839578;5501.394846566875;5505.752241149078;5542.63972841764;5043.848684539396;5201.713905735221;5202.297689811827;5239.318888544465;5253.290805741252;2940.368095706903;2952.5237381309344;2970.301979034925;2971.628546431696;2979.912331998805;5590.8043218487155;5631.057285236587;5648.971755141198;5690.260266165372;5716.571257155647;5243.659162154448;5513.724313784295;5530.557555395559;5532.5573954083575;5558.305211848519;5629.705167811427;5635.5773317001385;5641.2384328116;5642.605017648807;5654.6889921054735;5061.83577777106;5426.430224826494;5444.8366549003595;5473;5480.232767412485;5432.565394768488;5437.3747019091725;5484;5492.945070549244;5499.450054994629;5655.830325090254;5663.49917271915;5671.262735844314;5677.886442271214;5689.573282003784;4007.2987227234535;4150.605692459211;4151.169766046743;4161.625453709181;4164.937940825192;5395.649282796606;5499.285092937893;5535.640183388067;6009.90985135232;6249.906251406142;6130.601510901955;6135.601185922901;6137.539684523589;6145.8156255312415;6148.354422785543;5987.491063259672;6055.9091613626715;6123.112148738497;6146.170267013896;6146.354632763674;6045.486133678686;6061.787837425669;6078.361772014052;6102.267727872683;6123.969380153071;6126.540509461719;6154.415330543591;6157.84605384869;6168.660723660242;6182.629042257479;5825.621334613236;5960.701964901651;5992.370801065826;5995.790147344822;6002.369751176238 16:05:56 INFO - PROCESS | 13961 | |5;yui.html;791.4894892794144;808.7654580171749;825.187190617242;827.2885318625985;905.4476769170809;16383.262753176106;17570.824291757093;17611.82388176118;17623;17669.46991590251;16163.272652730626;16273.918630406832;16298.7555186672;16315.428959986402;16333.754993675104;712.2592503796071;829.5561874397199;835.4987007795335;842.4229402859031;869.6956065377115;875;875.7197696737047;876.2157868707503;876.9429987050853;877.4252864373846;922.0318665401335;924.9491277979708;927.0868194828089;927.7819712367589;929.6560272699111;921.3550514639745;921.709661456639;922.3313098003961;924.3206243411088;924.9768755781125;674.2010717300016;675.1965161457849;676.3642176354211;676.7123972311748;680.0886811672383;14049;14170.787438188436;14178.645533861632;14518.854811451962;14552.708945821025;14016.299185040707;14506.347214375379;14554.272286385638;16279.680110921314;17039.829601703947;14101.2244326562;14311.284435778169;14425.711485770331;14435.35040923161;14748.115113093249;4144.70987030908;4792.305115758196;4840.346553215306;4919.11455937931;4923.58149557288;76263;76387;76439;76707.61646191789;76728;12379.504819807107;12490.125691201529;12522.37388130608;12591.433385497674;12616.369181540886;20841.68737468939;22644.547109057727;22723.659145112837;22735.658965115537;22755.203567875044;9220.723378298662;9396.436213827192;9413.858792118124;9440.339176257596;9489.533675665723;5112.463191364927;5117.462666420047;5219.42586315505;5229.607779416559;5340.305760251143;3653.7442379033214;3780.4518344839844;3795.7532760370486;3799.4490798834013;3817.5418949725654;666.3203532396928;688.9069975553336;689.4622194688151;691.2120182991393;701.9017337572744;714.6569646569676;811.9350451963828;825.2284114353099;825.2696363718153;850.4302117581235;10102.646407375707;10560.47197640115;10633.87322535496;10802.189835762349;11075.667729968114;737.502186024442;741.7033186725353;763.2024534361606;776.8290975985274;849.9405041647149;5095.464976177448;5202.4277329493725;5315.989961907225;5386.649867758583;5428.75570599324;113158;120466;123914.38042809728;132324;133438;108474.45762771135;109185;110812.4459377698;112043;112139.43930280296;67722.66138669275;69000;97405.51297243468;99392.50303748435;99467.50266248768;10870.130389568658;11047.83428248593;11144.832827507431;11208.658930268099;11312.886871131182;39882;47434.52565474301;52905.47094529159;52946.73526632342;54076.729616351666;75145;80323.19676803157;80991;82960;83198.08806691736;14573.489927852474;14640.780388294397;14679.85320146785;14813.33339999681;14839.10965342083;16113.113778742281;16329.510114696579;16477.34090636361;16837.663246735243;16873.325066997182;15518.138695719357;15618.687626247638;16213.67572648564;16433.424830130887;16708;15423.922880385526;15718.493103140634;16037.91981040134;16562.254698538352;16831.66336673235;14756.262186890397;14956.476523321631;15183.696326073637;15745;16587.66824663524;11878.821817672915;11951.163418560966;11997;12149;12556.49774009066;12958.546450874173;13006.934965325112;13189.340532973121;13283.80074298867;13518.121322114031 16:05:56 INFO - PROCESS | 13961 | __end_tp_report 16:05:56 INFO - PROCESS | 13961 | __start_cc_report 16:05:56 INFO - PROCESS | 13961 | _x_x_mozilla_cycle_collect,368 16:05:56 INFO - PROCESS | 13961 | __end_cc_report 16:05:56 INFO - PROCESS | 13961 | __startTimestamp1475535956719__endTimestamp 16:05:56 INFO - PROCESS | 13961 | 16:05:56 INFO - PROCESS | 13961 | ------- Summary: start ------- 16:05:56 INFO - PROCESS | 13961 | Number of tests: 6 16:05:56 INFO - PROCESS | 13961 | 16:05:56 INFO - PROCESS | 13961 | [#0] dojo.html Cycles:165 Average:5811.48 Median:6061.18 stddev:663.98 (11.0%) stddev-sans-first:635.73 16:05:56 INFO - PROCESS | 13961 | Values: 3284.5 3295.2 3304.5 3332.5 3335.4 5772.9 5807.8 5809.1 5809.2 5836.8 5872.4 5918.5 5929.6 5934.6 5948.8 5322.7 5381.8 5389.8 5415.1 5464.5 5401.4 5422.9 5435.8 5443.1 5448.7 5214.2 5220.1 5417.6 5434.9 5439.5 5294.4 5321.3 5344.7 5382.9 5457.3 5296.2 5332.8 5392.2 5393.6 5396.9 5869.8 5879.4 5939.5 5971.4 5987.0 6076.5 6140.6 6163.7 6182.9 6217.1 6244.8 6254.1 6256.5 6257.8 6258.8 5825.4 5829.6 5832.0 5842.0 5862.1 6200.9 6280.8 6299.8 6310.4 6414.2 6132.5 6166.8 6172.5 6182.7 6188.7 6210.9 6215.0 6285.9 6296.7 6298.8 6093.1 6094.7 6110.8 6143.6 6220.9 6178.9 6189.3 6196.9 6218.5 6221.1 4758.9 4761.9 4768.7 4768.9 4786.0 4101.6 4158.5 4180.4 4202.8 4269.3 5962.2 6025.0 6033.9 6037.2 6047.2 6333.2 6344.3 6345.9 6347.6 6351.3 5776.7 5876.2 5927.0 5940.3 6027.4 5379.1 5389.0 5392.3 5410.3 5426.3 6363.1 6471.4 6490.5 6496.6 6497.8 6196.9 6218.2 6219.8 6324.1 6331.0 6479.6 6530.9 6542.4 6548.1 6560.1 5984.2 6195.5 6209.9 6214.9 6245.6 6116.7 6120.5 6149.3 6253.9 6266.0 6061.2 6063.2 6067.1 6077.9 6082.5 6043.8 6073.8 6085.7 6086.5 6092.4 5880.5 6000.7 6026.5 6080.7 6113.1 6144.6 6146.2 6192.3 6199.0 6202.5 5882.6 6039.5 6071.4 6072.3 6079.9 16:05:56 INFO - PROCESS | 13961 | 16:05:56 INFO - PROCESS | 13961 | [#1] ext.html Cycles:180 Average:64661.25 Median:45255.43 stddev:127733.30 (282.2%) stddev-sans-first:128001.08 16:05:56 INFO - PROCESS | 13961 | Values: 602.1 632.9 656.4 665.2 707.4 41607.0 46040.8 46063.1 46480.5 46504.8 45660.3 45899.0 46072.8 46211.5 46255.3 9052.5 9110.1 9182.5 9193.0 9215.2 9049.6 9089.0 9153.4 9162.8 9172.5 9176.3 9206.3 9221.1 9225.4 9237.9 9216.2 9223.2 9225.2 9226.1 9238.4 9082.7 9169.5 9174.1 9191.3 9199.2 45028.5 45145.5 45180.5 45330.3 45609.5 3794.5 3888.8 3923.6 3933.7 4065.5 34860.3 34956.7 35078.1 35248.6 36230.3 4624.5 4732.4 4739.2 4739.6 4836.2 387178.0 387553.0 387732.0 388189.0 389259.0 66495.3 66694.0 66754.0 66809.3 66984.0 40354.8 41637.6 41651.6 43471.3 43749.6 19340.8 19617.7 19626.5 19639.4 19694.7 14697.6 14825.4 14846.7 14892.9 14947.3 20804.8 21267.8 21346.4 21408.9 21544.2 7307.9 7486.2 7519.5 7598.2 7606.8 1050.8 1052.3 1112.5 1153.5 1190.3 32844.3 32915.5 33524.0 33609.7 33658.2 1098.2 1188.0 1201.2 1213.0 1257.7 17335.5 17860.6 17923.8 17986.4 18093.9 557719.0 563297.0 563557.0 564083.0 565761.0 64389.0 65268.0 65304.3 65487.3 65530.3 1439.8 1445.8 1473.5 1480.4 1492.5 33203.0 33536.1 33552.3 33567.8 33734.2 57360.0 57432.1 57651.4 58016.4 58025.7 476798.0 478100.0 478705.0 479952.0 482343.0 31974.4 32019.4 32199.7 32380.5 32436.7 52334.0 52794.2 52841.7 53078.5 54404.0 43727.6 44400.8 45670.1 46202.3 47478.5 45599.3 45833.0 46446.3 46457.5 47147.5 38630.4 43438.0 44293.8 44375.6 44829.8 37104.0 37284.3 37508.0 38337.0 38631.8 29060.6 29084.0 29120.2 29333.3 29662.7 16:05:56 INFO - PROCESS | 13961 | 16:05:56 INFO - PROCESS | 13961 | [#2] jquery.html Cycles:180 Average:29719.29 Median:25254.31 stddev:84620.03 (335.1%) stddev-sans-first:84828.81 16:05:56 INFO - PROCESS | 13961 | Values: 416.7 431.8 435.5 441.9 446.4 19185.1 20280.7 20970.8 21105.9 21118.0 20133.0 20678.4 21186.7 21462.0 21505.4 5875.4 6056.4 6113.1 6149.9 6185.9 6004.2 6015.4 6035.1 6036.6 6062.3 5769.9 5900.2 5925.8 5957.1 6000.6 5871.3 5888.9 5941.1 5953.3 5964.8 5271.5 5391.9 5397.9 5398.8 5411.9 24569.5 25194.5 25239.5 25269.1 25338.1 2349.6 2447.2 2559.7 3196.6 3316.5 10862.7 10911.7 10953.4 13659.9 15793.2 2032.3 2036.7 2051.5 2052.5 2056.3 52293.5 55224.0 64613.0 86747.6 88257.6 11577.9 11755.3 11791.5 11953.8 12048.4 17010.7 17062.1 17079.8 17081.4 17112.1 8853.8 8864.3 8936.2 9073.2 9125.7 8295.3 8417.9 8451.4 8669.6 8701.0 5007.2 5045.9 5103.5 5290.7 5354.8 2035.6 2103.5 2156.1 2173.3 2173.6 988.4 1031.7 1035.9 1050.6 1089.5 20160.7 20295.4 20431.4 20431.5 20664.4 1006.7 1028.9 1031.8 1055.6 1075.6 10801.2 11401.3 11478.7 11577.4 11700.9 506813.0 508919.0 511065.0 523890.0 531718.0 58153.7 58403.4 59365.4 95779.0 95956.0 940.5 984.4 1034.8 1037.1 1039.5 16297.8 18957.0 19005.2 19343.8 19432.0 42493.6 43448.8 44487.6 45026.5 45468.0 58470.4 63464.4 67191.7 67364.0 69005.0 8595.0 8665.7 8682.3 8699.7 8859.2 9772.5 13886.7 14451.5 14544.2 14593.2 12206.5 12441.2 12611.7 12703.5 12714.5 11770.8 12131.8 12156.5 12299.6 12413.1 12138.8 12203.7 12408.6 12750.2 12781.0 7950.8 8736.3 8874.7 9201.4 9243.2 11798.4 11984.7 12300.3 12373.3 12926.0 16:05:56 INFO - PROCESS | 13961 | 16:05:56 INFO - PROCESS | 13961 | [#3] mootools.html Cycles:180 Average:6049.27 Median:4723.78 stddev:3379.01 (71.5%) stddev-sans-first:3371.30 16:05:56 INFO - PROCESS | 13961 | Values: 1513.5 1518.8 1685.4 1821.8 1851.9 8128.2 8204.2 8770.1 8773.1 9009.0 9034.4 9410.4 9436.8 9457.2 9474.4 2453.2 2478.5 2492.3 2494.2 2495.3 2427.2 2498.8 2499.6 2507.8 2519.4 2507.9 2514.3 2526.7 2527.5 2527.9 2380.4 2401.3 2406.4 2438.8 2439.0 2412.2 2412.4 2422.3 2426.7 2438.2 9420.1 9435.6 9537.2 9548.9 9555.1 5414.9 5553.3 5556.3 5557.5 5585.2 3455.0 3498.4 3573.1 3614.4 3632.1 1177.7 1216.4 1218.3 1228.2 1232.8 13035.4 13038.0 13055.6 13064.9 13090.9 4690.5 4710.7 4736.8 4754.5 4902.6 10982.6 10990.6 11000.4 11009.4 11011.0 5427.4 5450.8 5460.7 5463.9 5477.4 4413.9 4881.1 4988.4 5005.1 5032.5 4362.5 4426.0 4437.9 4498.4 4546.3 1374.9 1394.7 1407.8 1414.7 1437.4 1058.9 1063.8 1066.5 1070.1 1096.3 6381.0 6416.5 6496.1 6531.9 6546.7 451.3 458.6 459.2 469.5 476.4 4470.8 4492.2 4512.7 4559.7 4605.0 10435.1 10777.6 10825.5 10825.8 10847.7 10421.1 10481.8 10634.7 10700.3 10719.5 8148.5 8198.5 8317.2 8324.6 8335.0 6077.3 6134.8 6213.8 6291.3 6321.3 9966.8 9972.8 10026.0 10092.4 10093.9 9839.7 9937.1 9995.5 9996.5 10168.8 7501.8 7631.7 7765.3 8016.0 8261.4 9221.0 9264.5 9272.8 9291.2 9292.1 8205.8 8326.8 8371.2 8409.0 8422.1 8205.7 8310.0 8331.0 8340.1 8532.4 7668.7 7682.8 7692.3 7755.5 7776.2 5477.3 5520.2 5545.5 5583.8 5670.1 5459.6 5531.4 5661.6 5662.5 5680.5 16:05:56 INFO - PROCESS | 13961 | 16:05:56 INFO - PROCESS | 13961 | [#4] prototype.html Cycles:180 Average:4911.67 Median:5441.11 stddev:1401.56 (25.8%) stddev-sans-first:1362.73 16:05:56 INFO - PROCESS | 13961 | Values: 334.4 350.9 352.1 355.2 357.1 5610.3 5754.7 5817.0 5859.6 5891.0 5669.3 5690.4 5693.9 5714.4 5762.1 4522.9 4530.0 4530.5 4536.6 4549.5 4452.1 4506.6 4511.9 4513.2 4545.5 4467.3 4469.9 4470.3 4480.9 4507.3 4487.4 4497.3 4498.9 4529.6 4551.1 3950.0 3958.0 4025.3 4062.9 4068.6 5525.1 5529.6 5534.6 5553.2 5586.4 5182.6 5216.7 5225.9 5230.9 5245.9 5884.2 5958.7 6008.8 6024.9 6094.5 4398.2 4401.0 4421.7 4422.5 4436.4 6261.3 6304.6 6318.5 6325.9 6344.7 4329.8 4467.3 4513.5 4537.5 4541.1 4631.4 4636.2 4640.2 4647.4 4661.1 5204.0 5227.3 5273.7 5276.4 5301.5 5880.1 5953.3 6077.6 6078.6 6083.3 1577.1 1594.1 1601.1 1607.4 1613.5 1022.9 1032.0 1043.2 1043.7 1058.1 5112.9 5157.9 5196.8 5219.3 5225.8 5459.7 5482.6 5501.4 5505.8 5542.6 5043.8 5201.7 5202.3 5239.3 5253.3 2940.4 2952.5 2970.3 2971.6 2979.9 5590.8 5631.1 5649.0 5690.3 5716.6 5243.7 5513.7 5530.6 5532.6 5558.3 5629.7 5635.6 5641.2 5642.6 5654.7 5061.8 5426.4 5444.8 5473.0 5480.2 5432.6 5437.4 5484.0 5492.9 5499.5 5655.8 5663.5 5671.3 5677.9 5689.6 4007.3 4150.6 4151.2 4161.6 4164.9 5395.6 5499.3 5535.6 6009.9 6249.9 6130.6 6135.6 6137.5 6145.8 6148.4 5987.5 6055.9 6123.1 6146.2 6146.4 6045.5 6061.8 6078.4 6102.3 6124.0 6126.5 6154.4 6157.8 6168.7 6182.6 5825.6 5960.7 5992.4 5995.8 6002.4 16:05:56 INFO - PROCESS | 13961 | 16:05:56 INFO - PROCESS | 13961 | [#5] yui.html Cycles:180 Average:22288.62 Median:3717.10 stddev:31857.92 (857.1%) stddev-sans-first:31906.40 16:05:56 INFO - PROCESS | 13961 | Values: 791.5 808.8 825.2 827.3 905.4 16383.3 17570.8 17611.8 17623.0 17669.5 16163.3 16273.9 16298.8 16315.4 16333.8 712.3 829.6 835.5 842.4 869.7 875.0 875.7 876.2 876.9 877.4 922.0 924.9 927.1 927.8 929.7 921.4 921.7 922.3 924.3 925.0 674.2 675.2 676.4 676.7 680.1 14049.0 14170.8 14178.6 14518.9 14552.7 14016.3 14506.3 14554.3 16279.7 17039.8 14101.2 14311.3 14425.7 14435.4 14748.1 4144.7 4792.3 4840.3 4919.1 4923.6 76263.0 76387.0 76439.0 76707.6 76728.0 12379.5 12490.1 12522.4 12591.4 12616.4 20841.7 22644.5 22723.7 22735.7 22755.2 9220.7 9396.4 9413.9 9440.3 9489.5 5112.5 5117.5 5219.4 5229.6 5340.3 3653.7 3780.5 3795.8 3799.4 3817.5 666.3 688.9 689.5 691.2 701.9 714.7 811.9 825.2 825.3 850.4 10102.6 10560.5 10633.9 10802.2 11075.7 737.5 741.7 763.2 776.8 849.9 5095.5 5202.4 5316.0 5386.6 5428.8 113158.0 120466.0 123914.4 132324.0 133438.0 108474.5 109185.0 110812.4 112043.0 112139.4 67722.7 69000.0 97405.5 99392.5 99467.5 10870.1 11047.8 11144.8 11208.7 11312.9 39882.0 47434.5 52905.5 52946.7 54076.7 75145.0 80323.2 80991.0 82960.0 83198.1 14573.5 14640.8 14679.9 14813.3 14839.1 16113.1 16329.5 16477.3 16837.7 16873.3 15518.1 15618.7 16213.7 16433.4 16708.0 15423.9 15718.5 16037.9 16562.3 16831.7 14756.3 14956.5 15183.7 15745.0 16587.7 11878.8 11951.2 11997.0 12149.0 12556.5 12958.5 13006.9 13189.3 13283.8 13518.1 16:05:56 INFO - PROCESS | 13961 | -------- Summary: end -------- 16:05:56 INFO - PROCESS | 13961 | 16:05:57 INFO - TEST-INFO | 13961: exit 0 16:05:57 INFO - TEST-OK | dromaeo_css | took 1110724ms 16:05:57 INFO - TEST-START | kraken 16:05:57 INFO - operating with platform_type : linux_ 16:05:57 INFO - Initialising browser for kraken test... 16:05:57 INFO - TEST-INFO | started process 14205 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxO1Qo6/profile http://localhost:46150/getInfo.html) 16:06:01 INFO - PROCESS | 14205 | __metrics Screen width/height:1600/1200 16:06:01 INFO - PROCESS | 14205 | colorDepth:24 16:06:01 INFO - PROCESS | 14205 | Browser inner width/height: 1024/697 16:06:01 INFO - PROCESS | 14205 | __metrics 16:06:02 ERROR - PROCESS | 14205 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 16:06:03 INFO - TEST-INFO | 14205: exit 0 16:06:03 INFO - Browser initialized. 16:06:03 INFO - Running cycle 1/1 for kraken test... 16:06:03 INFO - TEST-INFO | started process 14329 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxO1Qo6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:06:14 INFO - PROCESS | 14329 | RSS: Main: 150515712 16:06:14 INFO - PROCESS | 14329 | 16:06:17 INFO - PROCESS | 14329 | Cycle 1(1): loaded http://localhost:46150/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46150/tests/kraken/driver.html?testName=audio-beat-detection) 16:06:18 INFO - PROCESS | 14329 | RSS: Main: 156692480 16:06:18 INFO - PROCESS | 14329 | 16:06:20 INFO - PROCESS | 14329 | Cycle 1(1): loaded http://localhost:46150/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46150/tests/kraken/driver.html?testName=audio-dft) 16:06:21 INFO - PROCESS | 14329 | RSS: Main: 155246592 16:06:21 INFO - PROCESS | 14329 | 16:06:24 INFO - PROCESS | 14329 | Cycle 1(1): loaded http://localhost:46150/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46150/tests/kraken/driver.html?testName=audio-fft) 16:06:24 INFO - PROCESS | 14329 | RSS: Main: 156086272 16:06:24 INFO - PROCESS | 14329 | 16:06:26 INFO - PROCESS | 14329 | Cycle 1(1): loaded http://localhost:46150/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46150/tests/kraken/driver.html?testName=audio-oscillator) 16:06:27 INFO - PROCESS | 14329 | RSS: Main: 155811840 16:06:27 INFO - PROCESS | 14329 | 16:06:29 INFO - PROCESS | 14329 | Cycle 1(1): loaded http://localhost:46150/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46150/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:06:30 INFO - PROCESS | 14329 | RSS: Main: 156045312 16:06:30 INFO - PROCESS | 14329 | 16:06:33 INFO - PROCESS | 14329 | Cycle 1(1): loaded http://localhost:46150/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46150/tests/kraken/driver.html?testName=imaging-darkroom) 16:06:33 INFO - PROCESS | 14329 | RSS: Main: 155983872 16:06:33 INFO - PROCESS | 14329 | 16:06:37 INFO - PROCESS | 14329 | Cycle 1(1): loaded http://localhost:46150/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46150/tests/kraken/driver.html?testName=imaging-desaturate) 16:06:37 INFO - PROCESS | 14329 | RSS: Main: 156336128 16:06:37 INFO - PROCESS | 14329 | 16:06:40 INFO - PROCESS | 14329 | Cycle 1(1): loaded http://localhost:46150/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46150/tests/kraken/driver.html?testName=json-parse-financial) 16:06:41 INFO - PROCESS | 14329 | RSS: Main: 156127232 16:06:41 INFO - PROCESS | 14329 | 16:06:42 INFO - PROCESS | 14329 | Cycle 1(1): loaded http://localhost:46150/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46150/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:06:43 INFO - PROCESS | 14329 | RSS: Main: 155402240 16:06:43 INFO - PROCESS | 14329 | 16:06:45 INFO - PROCESS | 14329 | Cycle 1(1): loaded http://localhost:46150/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46150/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:06:45 INFO - PROCESS | 14329 | RSS: Main: 155865088 16:06:45 INFO - PROCESS | 14329 | 16:06:47 INFO - PROCESS | 14329 | Cycle 1(1): loaded http://localhost:46150/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46150/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:06:48 INFO - PROCESS | 14329 | RSS: Main: 156545024 16:06:48 INFO - PROCESS | 14329 | 16:06:51 INFO - PROCESS | 14329 | Cycle 1(1): loaded http://localhost:46150/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46150/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:06:51 INFO - PROCESS | 14329 | RSS: Main: 156319744 16:06:51 INFO - PROCESS | 14329 | 16:06:54 INFO - PROCESS | 14329 | Cycle 1(1): loaded http://localhost:46150/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46150/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:06:54 INFO - PROCESS | 14329 | RSS: Main: 156659712 16:06:54 INFO - PROCESS | 14329 | 16:06:56 INFO - PROCESS | 14329 | Cycle 1(1): loaded http://localhost:46150/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46150/tests/kraken/driver.html?testName=ai-astar) 16:06:56 INFO - PROCESS | 14329 | RSS: Main: 158576640 16:06:56 INFO - PROCESS | 14329 | 16:06:56 INFO - PROCESS | 14329 | __start_tp_report 16:06:56 INFO - PROCESS | 14329 | _x_x_mozilla_page_load 16:06:56 INFO - PROCESS | 14329 | _x_x_mozilla_page_load_details 16:06:56 INFO - PROCESS | 14329 | |i|pagename|runs| 16:06:56 INFO - PROCESS | 14329 | |0;ai-astar;102;112;107;111;113;111;111;110;110;110 16:06:56 INFO - PROCESS | 14329 | |1;audio-beat-detection;145;118;146;178;122;145;147;120;178;122 16:06:56 INFO - PROCESS | 14329 | |2;audio-dft;163;162;165;163;164;163;164;163;162;162 16:06:56 INFO - PROCESS | 14329 | |3;audio-fft;75;77;84;177;76;76;74;77;153;77 16:06:56 INFO - PROCESS | 14329 | |4;audio-oscillator;84;84;155;84;83;83;140;84;83;137 16:06:56 INFO - PROCESS | 14329 | |5;imaging-gaussian-blur;117;118;116;117;117;117;117;117;117;117 16:06:56 INFO - PROCESS | 14329 | |6;imaging-darkroom;148;147;146;146;147;146;147;147;147;147 16:06:56 INFO - PROCESS | 14329 | |7;imaging-desaturate;95;95;95;96;96;96;95;95;96;95 16:06:56 INFO - PROCESS | 14329 | |8;json-parse-financial;52;51;50;50;50;51;51;51;51;51 16:06:56 INFO - PROCESS | 14329 | |9;json-stringify-tinderbox;64;61;62;61;62;61;60;62;63;62 16:06:56 INFO - PROCESS | 14329 | |10;stanford-crypto-aes;72;71;72;72;72;72;73;73;76;73 16:06:56 INFO - PROCESS | 14329 | |11;stanford-crypto-ccm;118;120;121;118;124;133;119;116;154;115 16:06:56 INFO - PROCESS | 14329 | |12;stanford-crypto-pbkdf2;151;150;155;152;152;157;157;155;150;152 16:06:56 INFO - PROCESS | 14329 | |13;stanford-crypto-sha256-iterative;61;61;64;62;62;64;64;61;61;65 16:06:56 INFO - PROCESS | 14329 | __end_tp_report 16:06:56 INFO - PROCESS | 14329 | __start_cc_report 16:06:56 INFO - PROCESS | 14329 | _x_x_mozilla_cycle_collect,905 16:06:56 INFO - PROCESS | 14329 | __end_cc_report 16:06:56 INFO - PROCESS | 14329 | __startTimestamp1475536016871__endTimestamp 16:06:56 INFO - PROCESS | 14329 | 16:06:56 INFO - PROCESS | 14329 | ------- Summary: start ------- 16:06:56 INFO - PROCESS | 14329 | Number of tests: 14 16:06:56 INFO - PROCESS | 14329 | 16:06:56 INFO - PROCESS | 14329 | [#0] ai-astar Cycles:10 Average:109.70 Median:111.00 stddev:3.13 (2.8%) stddev-sans-first:1.67 16:06:56 INFO - PROCESS | 14329 | Values: 102.0 112.0 107.0 111.0 113.0 111.0 111.0 110.0 110.0 110.0 16:06:56 INFO - PROCESS | 14329 | 16:06:56 INFO - PROCESS | 14329 | [#1] audio-beat-detection Cycles:10 Average:142.10 Median:145.50 stddev:22.39 (15.4%) stddev-sans-first:23.72 16:06:56 INFO - PROCESS | 14329 | Values: 145.0 118.0 146.0 178.0 122.0 145.0 147.0 120.0 178.0 122.0 16:06:56 INFO - PROCESS | 14329 | 16:06:56 INFO - PROCESS | 14329 | [#2] audio-dft Cycles:10 Average:163.10 Median:163.00 stddev:0.99 (0.6%) stddev-sans-first:1.05 16:06:56 INFO - PROCESS | 14329 | Values: 163.0 162.0 165.0 163.0 164.0 163.0 164.0 163.0 162.0 162.0 16:06:56 INFO - PROCESS | 14329 | 16:06:56 INFO - PROCESS | 14329 | [#3] audio-fft Cycles:10 Average:94.60 Median:76.50 stddev:37.63 (49.2%) stddev-sans-first:39.24 16:06:56 INFO - PROCESS | 14329 | Values: 75.0 77.0 84.0 177.0 76.0 76.0 74.0 77.0 153.0 77.0 16:06:56 INFO - PROCESS | 14329 | 16:06:56 INFO - PROCESS | 14329 | [#4] audio-oscillator Cycles:10 Average:101.70 Median:83.50 stddev:29.54 (35.4%) stddev-sans-first:30.63 16:06:56 INFO - PROCESS | 14329 | Values: 84.0 84.0 155.0 84.0 83.0 83.0 140.0 84.0 83.0 137.0 16:06:56 INFO - PROCESS | 14329 | 16:06:56 INFO - PROCESS | 14329 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 16:06:56 INFO - PROCESS | 14329 | Values: 117.0 118.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 16:06:56 INFO - PROCESS | 14329 | 16:06:56 INFO - PROCESS | 14329 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.50 16:06:56 INFO - PROCESS | 14329 | Values: 148.0 147.0 146.0 146.0 147.0 146.0 147.0 147.0 147.0 147.0 16:06:56 INFO - PROCESS | 14329 | 16:06:56 INFO - PROCESS | 14329 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 16:06:56 INFO - PROCESS | 14329 | Values: 95.0 95.0 95.0 96.0 96.0 96.0 95.0 95.0 96.0 95.0 16:06:56 INFO - PROCESS | 14329 | 16:06:56 INFO - PROCESS | 14329 | [#8] json-parse-financial Cycles:10 Average:50.80 Median:51.00 stddev:0.63 (1.2%) stddev-sans-first:0.50 16:06:56 INFO - PROCESS | 14329 | Values: 52.0 51.0 50.0 50.0 50.0 51.0 51.0 51.0 51.0 51.0 16:06:56 INFO - PROCESS | 14329 | 16:06:56 INFO - PROCESS | 14329 | [#9] json-stringify-tinderbox Cycles:10 Average:61.80 Median:62.00 stddev:1.14 (1.8%) stddev-sans-first:0.88 16:06:56 INFO - PROCESS | 14329 | Values: 64.0 61.0 62.0 61.0 62.0 61.0 60.0 62.0 63.0 62.0 16:06:56 INFO - PROCESS | 14329 | 16:06:56 INFO - PROCESS | 14329 | [#10] stanford-crypto-aes Cycles:10 Average:72.60 Median:72.50 stddev:1.35 (1.9%) stddev-sans-first:1.41 16:06:56 INFO - PROCESS | 14329 | Values: 72.0 71.0 72.0 72.0 72.0 72.0 73.0 73.0 76.0 73.0 16:06:56 INFO - PROCESS | 14329 | 16:06:56 INFO - PROCESS | 14329 | [#11] stanford-crypto-ccm Cycles:10 Average:123.80 Median:120.50 stddev:11.77 (9.8%) stddev-sans-first:12.30 16:06:56 INFO - PROCESS | 14329 | Values: 118.0 120.0 121.0 118.0 124.0 133.0 119.0 116.0 154.0 115.0 16:06:56 INFO - PROCESS | 14329 | 16:06:56 INFO - PROCESS | 14329 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.10 Median:153.50 stddev:2.69 (1.7%) stddev-sans-first:2.74 16:06:56 INFO - PROCESS | 14329 | Values: 151.0 150.0 155.0 152.0 152.0 157.0 157.0 155.0 150.0 152.0 16:06:56 INFO - PROCESS | 14329 | 16:06:56 INFO - PROCESS | 14329 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.50 Median:63.00 stddev:1.58 (2.5%) stddev-sans-first:1.58 16:06:56 INFO - PROCESS | 14329 | Values: 61.0 61.0 64.0 62.0 62.0 64.0 64.0 61.0 61.0 65.0 16:06:56 INFO - PROCESS | 14329 | -------- Summary: end -------- 16:06:56 INFO - PROCESS | 14329 | 16:06:57 INFO - TEST-INFO | 14329: exit 0 16:06:57 INFO - TEST-OK | kraken | took 60391ms 16:06:57 INFO - SUITE-END | took 1171s 16:06:58 INFO - Completed test suite (00:19:31) 16:06:58 INFO - javascript benchmark 16:06:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7730.262503767509, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3284.4744840825474, 3295.242094318307, 3304.504324351347, 3332.5334453176542, 3335.4329763940127, 5772.942270577293, 5807.767689292423, 5809.070548712207, 5809.157672137538, 5836.79571215007, 5872.354041055481, 5918.4673379395845, 5929.555283353744, 5934.554908381878, 5948.791792287271, 5322.654027488201, 5381.784728610851, 5389.757460914268, 5415.0523658359825, 5464.508194262516, 5401.351837779453, 5422.91865622016, 5435.809746658868, 5443.101888188444, 5448.700321482317, 5214.217867319913, 5220.060389129955, 5417.6207665463435, 5434.864128396782, 5439.5376393006445, 5294.444083371229, 5321.308229930123, 5344.652597581145, 5382.946170538284, 5457.345118585756, 5296.152615581488, 5332.786688532454, 5392.245085688007, 5393.5954803389905, 5396.865078373033, 5869.765209391662, 5879.412058794129, 5939.524838012949, 5971.402859714038, 5987.0, 6076.4834989025985, 6140.570160088796, 6163.691815409256, 6182.938170618281, 6217.067439884008, 6244.781432649881, 6254.124422580842, 6256.499480041586, 6257.812265632038, 6258.812235632939, 5825.359210486843, 5829.647952427329, 5831.970840145772, 5842.036064049385, 5862.062070068811, 6200.937990620127, 6280.811575652738, 6299.811005669837, 6310.432061114522, 6414.198225221848, 6132.50939924805, 6166.784162554289, 6172.475339596184, 6182.6599537025895, 6188.721507532172, 6210.875782484325, 6215.0, 6285.937140628626, 6296.653684047421, 6298.811035668938, 6093.086037094471, 6094.6647934363145, 6110.816675499653, 6143.56995010345, 6220.875582488325, 6178.938210617836, 6189.288231853395, 6196.938030619726, 6218.502519798496, 6221.06683997395, 4758.928616070762, 4761.857144285677, 4768.690035147704, 4768.904621907543, 4785.976070119627, 4101.569335219759, 4158.521769996429, 4180.372944058355, 4202.768847713344, 4269.295566231537, 5962.195103661037, 6025.0, 6033.879322413615, 6037.245344331958, 6047.15339852421, 6333.2400111985935, 6344.270408902943, 6345.8730825384155, 6347.55567110307, 6351.269603995507, 5776.740046697909, 5876.177335173079, 5927.0, 5940.257467816523, 6027.367126451747, 5379.058664733656, 5389.0299746046085, 5392.272043274186, 5410.269613602192, 5426.348838139448, 6363.077353783768, 6471.449926756279, 6490.4807615390655, 6496.577722448026, 6497.837554061186, 6196.876062478816, 6218.22272215973, 6219.849327874358, 6324.146240257691, 6330.968345158245, 6479.639275751956, 6530.9020364693615, 6542.443892269211, 6548.1487406638735, 6560.147180866456, 5984.222051133324, 6195.504359651127, 6209.875802484015, 6214.875702486015, 6245.594036387621, 6116.66358350295, 6120.508083830795, 6149.292831324276, 6253.906191407042, 6266.028765541349, 6061.181740465157, 6063.211782468251, 6067.120267561268, 6077.878442431215, 6082.513398927987, 6043.758249669964, 6073.787417440545, 6085.726142323695, 6086.513078953762, 6092.360302168386, 5880.500157486662, 6000.729967151576, 6026.517878569792, 6080.69596520181, 6113.052476866093, 6144.600600960924, 6146.245452195804, 6192.287886893065, 6199.039148931923, 6202.472789812917, 5882.588218824641, 6039.48664363534, 6071.3625069368845, 6072.301685306246, 6079.878402432015], "value": 5765.417177152287, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [602.0728078758711, 632.9398707122823, 656.3862788292946, 665.1618960110261, 707.4128473367106, 41607.0, 46040.76979615097, 46063.078738425254, 46480.535194648044, 46504.767476162655, 45660.315095273596, 45899.0, 46072.769636151774, 46211.537884621146, 46255.30617040747, 9052.54737263136, 9110.134537218953, 9182.494962777044, 9193.0, 9215.17063464288, 9049.592768325409, 9088.954555227214, 9153.359264851462, 9162.770930726718, 9172.495512746797, 9176.265898728087, 9206.26349892007, 9221.123993220634, 9225.446473211596, 9237.861432078524, 9216.17054465098, 9223.169914707674, 9225.215856652192, 9226.07739226082, 9238.399504032217, 9082.727518174466, 9169.541522923893, 9174.128457796498, 9191.264698824078, 9199.172074513259, 45028.54971450309, 45145.548544514466, 45180.54819451796, 45330.32004519935, 45609.54390456086, 3794.5067141271734, 3888.786116763577, 3923.5880232575455, 3933.7443066200603, 4065.532463766675, 34860.30279394398, 34956.6504334956, 35078.12304692378, 35248.6475135248, 36230.27539449196, 4624.468186158601, 4732.361131247307, 4739.170645137087, 4739.597134243593, 4836.202026665596, 387178.0, 387553.0, 387732.0, 388189.0, 389259.0, 66495.33504664988, 66694.0, 66754.0, 66809.33190668031, 66984.0, 40354.79822600868, 41637.58362416398, 41651.58348416538, 43471.26114955366, 43749.562504375186, 19340.8065919339, 19617.705734413994, 19626.509337266398, 19639.410817675493, 19694.704579431032, 14697.55907322782, 14825.406983720746, 14846.70306593862, 14892.851071489147, 14947.252637368305, 20804.791952080286, 21267.78732212689, 21346.359609211748, 21408.892955535124, 21544.245951391626, 7307.926920730831, 7486.213947535539, 7519.473636845478, 7598.240175982358, 7606.847863042708, 1050.847627094067, 1052.2529004406804, 1112.504935303782, 1153.4694040741354, 1190.33936165429, 32844.343113137606, 32915.50626740553, 33524.0, 33609.66390336114, 33658.158546036546, 1098.181854518373, 1187.9881201187877, 1201.2251698576142, 1212.9818052729215, 1257.7295881385546, 17335.479935601954, 17860.642787144185, 17923.820761792475, 17986.37047703324, 18093.909530452263, 557719.0, 563297.0, 563557.0, 564083.0, 565761.0, 64389.0, 65268.0, 65304.346956530775, 65487.34512654908, 65530.34469655243, 1439.79842822005, 1445.802340585614, 1473.5432016075051, 1480.415235981781, 1492.5373134328393, 33203.0, 33536.10577353858, 33552.32895342128, 33567.83216083904, 33734.15664608405, 57360.0, 57432.1385179231, 57651.42348576628, 58016.4198358011, 58025.70987145206, 476798.0, 478100.0, 478705.0, 479952.0, 482343.0, 31974.36051279008, 32019.359612807148, 32199.678003220604, 32380.514292286105, 32436.67563324431, 52333.953320932604, 52794.208086879495, 52841.73579132234, 53078.469215307356, 54404.0, 43727.56272437362, 44400.780020392216, 45670.08659826718, 46202.30696539488, 47478.52521474741, 45599.31601025921, 45833.0, 46446.30330545112, 46457.53542464532, 47147.52852471431, 38630.42054369243, 43438.0, 44293.778531107135, 44375.55624443714, 44829.77585112053, 37104.0, 37284.25431491409, 37508.0, 38337.0, 38631.80684096562, 29060.564091539065, 29084.0, 29120.205673970915, 29333.26666833346, 29662.703372965992], "value": 21481.299284092307, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [416.71038628153445, 431.84481511955534, 435.4643788140587, 441.865231104513, 446.39067672626857, 19185.1366688499, 20280.695789563168, 20970.790292097092, 21105.894470527626, 21118.0, 20132.993350332497, 20678.379648610528, 21186.682199766976, 21462.0, 21505.354839354804, 5875.412458754123, 6056.424639659225, 6113.144159817629, 6149.877002459948, 6185.907211391833, 6004.18943442634, 6015.398460153971, 6035.124906888498, 6036.63780173191, 6062.302835173945, 5769.855753606152, 5900.232969713953, 5925.762969481216, 5957.136215248786, 6000.579959402844, 5871.324797648283, 5888.882222355572, 5941.079132734433, 5953.28560572734, 5964.791232306892, 5271.472852714736, 5391.867707781371, 5397.919031214535, 5398.838034858961, 5411.891762164774, 24569.50860982788, 25194.49611007788, 25239.49521009588, 25269.115580954764, 25338.113166039286, 2349.5770761262966, 2447.155731272708, 2559.6928368595886, 3196.568463257454, 3316.4859446785786, 10862.72843178919, 10911.727206819893, 10953.397563134024, 13659.907207423383, 15793.21033948298, 2032.3090149349143, 2036.7250421193246, 2051.476873397274, 2052.5279185787203, 2056.331692200026, 52293.47706522962, 55224.0, 64613.0, 86747.56626216891, 88257.55871220602, 11577.884221157681, 11755.294682318918, 11791.528338866521, 11953.820692689616, 12048.397580120958, 17010.744838827428, 17062.146892655564, 17079.829201707824, 17081.40215092466, 17112.144392780312, 8853.778655533535, 8864.335174861782, 8936.195742383217, 9073.183413492818, 9125.726228213165, 8295.253427191581, 8417.915820841836, 8451.408401411842, 8669.609867555975, 8701.041026333003, 5007.173816320266, 5045.924311135336, 5103.464136265713, 5290.68255904647, 5354.8219391733755, 2035.5521785207231, 2103.5477372365017, 2156.13754498202, 2173.30454254637, 2173.5870184664864, 988.3940835705578, 1031.7361232490139, 1035.9430231337199, 1050.5640159333943, 1089.5478376473834, 20160.69758953617, 20295.391138265877, 20431.38705838827, 20431.4892127698, 20664.380068597966, 1006.7030226083323, 1028.8662473878499, 1031.7884833609091, 1055.6358056470506, 1075.634284343327, 10801.243912926177, 11401.315921044597, 11478.655640330804, 11577.421128943688, 11700.88299117015, 506813.0, 508919.0, 511065.0, 523890.0, 531718.0, 58153.70923145442, 58403.41596584065, 59365.40634593685, 95779.0, 95956.0, 940.4874343482682, 984.414273507262, 1034.8395998620076, 1037.113268155731, 1039.5010395010438, 16297.755533666766, 18957.0, 19005.23979040878, 19343.8065619342, 19432.0, 42493.575064250195, 43448.78275608602, 44487.55512444834, 45026.54973450224, 45468.0, 58470.4152958465, 63464.36535634584, 67191.66404167948, 67364.0, 69005.0, 8595.0, 8665.696700615448, 8682.262007729414, 8699.695510657097, 8859.202671759573, 9772.462514561767, 13886.652833679238, 14451.49419770303, 14544.200068996306, 14593.197374144524, 12206.450709717907, 12441.191322564004, 12611.74776504483, 12703.491860325483, 12714.491420343084, 11770.823437648613, 12131.757364852478, 12156.513739450676, 12299.569515066929, 12413.131080824256, 12138.817917731418, 12203.69490762738, 12408.62774116778, 12750.234985900875, 12781.0, 7950.801229969065, 8736.257418119278, 8874.689385871721, 9201.355905086579, 9243.232188196967, 11798.410079496163, 11984.700382490159, 12300.323482208207, 12373.257604543756, 12926.030547709148], "value": 9699.573898985518, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1513.5383707969067, 1518.8329283778785, 1685.4438035448295, 1821.8451431628312, 1851.8981456019912, 8128.187181281869, 8204.179582041792, 8770.122987701234, 8773.122687731224, 9008.954955225232, 9034.367594268404, 9410.435373877572, 9436.811263774738, 9457.243420526358, 9474.431534107958, 2453.153661986612, 2478.5414698280874, 2492.264781889338, 2494.2018554062706, 2495.292607520842, 2427.186892391051, 2498.7626175513296, 2499.5875680512786, 2507.761762632556, 2519.407939134302, 2507.874606269679, 2514.3211332940095, 2526.68416447944, 2527.519771243467, 2527.949441011179, 2380.4048987753063, 2401.267613377919, 2406.42245860993, 2438.756124387565, 2438.9512209755885, 2412.2280870121567, 2412.3848418653133, 2422.2612103308484, 2426.6723992260995, 2438.244144315268, 9420.057994200593, 9435.575399107056, 9537.1893389062, 9548.856767148498, 9555.140037396668, 5414.864628384283, 5553.305836770403, 5556.277683901108, 5557.527610153142, 5585.218069470277, 3454.9827250863586, 3498.352804731133, 3573.1424458129864, 3614.367485689994, 3632.0738211756097, 1177.7055736065984, 1216.391804097951, 1218.2933898339031, 1228.1587112827742, 1232.8150777383375, 13035.41340639664, 13038.0, 13055.608331749967, 13064.934675326562, 13090.934545327404, 4690.50328015684, 4710.717356958594, 4736.834210802605, 4754.477007529169, 4902.607791376681, 10982.615608453665, 10990.615328463466, 11000.449977501094, 11009.449527523591, 11011.0, 5427.402985671573, 5450.754716037788, 5460.672359658433, 5463.890722185534, 5477.424870388551, 4413.867583972486, 4881.072596206709, 4988.35151430319, 5005.074061298671, 5032.47159048302, 4362.541933097043, 4425.955740442554, 4437.933430998538, 4498.392716983165, 4546.340780586796, 1374.9312534373241, 1394.6680919721641, 1407.8099456573232, 1414.745345837759, 1437.4106616287272, 1058.915286777056, 1063.8244689626124, 1066.4827558634056, 1070.0957690751302, 1096.2874131814385, 6380.968095159495, 6416.454601358843, 6496.123023391781, 6531.869362612816, 6546.672666366662, 451.28246088719095, 458.6422590379509, 459.21245064714174, 469.4859129253462, 476.3973573429614, 4470.821167153343, 4492.191405547033, 4512.729236245836, 4559.749213793273, 4604.97697511517, 10435.113015393777, 10777.568897244179, 10825.512851921683, 10825.78348433027, 10847.728806779895, 10421.06210441064, 10481.790364192673, 10634.680959571226, 10700.30448020876, 10719.464026798629, 8148.51108933454, 8198.549079800548, 8317.209865062809, 8324.62539185738, 8334.958325208336, 6077.331493535796, 6134.8159555213415, 6213.813585592439, 6291.339409361951, 6321.336259692666, 9966.800663986825, 9972.800543989224, 10026.047525485068, 10092.444915529717, 10093.89906100959, 9839.704808855746, 9937.10566049059, 9995.500224988577, 9996.500174991075, 10168.796624067329, 7501.774946751606, 7631.656575454007, 7765.262300081483, 8016.0, 8261.38039647017, 9221.0, 9264.490453025148, 9272.768180795534, 9291.21024712907, 9292.070792920655, 8205.79485512843, 8326.750197494084, 8371.246587807127, 8409.0, 8422.073571906963, 8205.671773129008, 8310.0, 8331.0, 8340.082590915115, 8532.402731808963, 7668.731594394392, 7682.769516914278, 7692.269234422721, 7755.534667919943, 7776.222377762178, 5477.3427188737605, 5520.227168196376, 5545.528630066489, 5583.832485025456, 5670.064439367458, 5459.617826752248, 5531.446855314436, 5661.57538184646, 5662.518685911744, 5680.460356266148], "value": 4797.322198827914, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.4181124842773, 350.85965613754496, 352.1021395441623, 355.2380144589856, 357.11791874071054, 5610.326760788701, 5754.712264386774, 5817.0, 5859.589828711986, 5890.970545147279, 5669.348024977129, 5690.374058853523, 5693.943060569393, 5714.428557144294, 5762.1068734346245, 4522.886927826806, 4529.968328187899, 4530.456345238576, 4536.639008297514, 4549.454065512143, 4452.131834292314, 4506.594406503414, 4511.872031992002, 4513.2101882170655, 4545.52272011439, 4467.307567327053, 4469.865904022885, 4470.307102399133, 4480.910381792362, 4507.301368287905, 4487.394201782767, 4497.302918047708, 4498.910021799546, 4529.592336689714, 4551.112533056055, 3949.980250098731, 3957.960420395788, 4025.335819589764, 4062.878113656595, 4068.593140685937, 5525.143602741581, 5529.557635389159, 5534.640248383842, 5553.16702494629, 5586.435797976533, 5182.6006978116075, 5216.713080780555, 5225.869353266199, 5230.947690523084, 5245.947540524584, 5884.176215329857, 5958.731857066442, 6008.819735407901, 6024.909626355608, 6094.451499365034, 4398.164348773755, 4401.0, 4421.668374871865, 4422.491413487458, 4436.378906953029, 6261.342559031327, 6304.558680892385, 6318.546734251148, 6325.9051114233325, 6344.6510441925675, 4329.848455304113, 4467.329900514884, 4513.480949690762, 4537.500874903758, 4541.137183935041, 4631.374764406829, 4636.188666983265, 4640.164770341371, 4647.419072615923, 4661.067786442657, 5203.973980130075, 5227.294315267466, 5273.6572122811895, 5276.4434491825, 5301.469853014668, 5880.059190529495, 5953.255843019622, 6077.604955677867, 6078.574499784972, 6083.300420451705, 1577.1325770826, 1594.1152660273428, 1601.0953811096692, 1607.3650907891317, 1613.5401410597924, 1022.907938285543, 1031.9886511219047, 1043.175891046065, 1043.7181960870523, 1058.0794708603564, 5112.897742045138, 5157.871053223699, 5196.818111366159, 5219.295395121686, 5225.843224703265, 5459.66238271626, 5482.588805839578, 5501.394846566875, 5505.752241149078, 5542.63972841764, 5043.848684539396, 5201.713905735221, 5202.297689811827, 5239.318888544465, 5253.290805741252, 2940.368095706903, 2952.5237381309344, 2970.301979034925, 2971.628546431696, 2979.912331998805, 5590.8043218487155, 5631.057285236587, 5648.971755141198, 5690.260266165372, 5716.571257155647, 5243.659162154448, 5513.724313784295, 5530.557555395559, 5532.5573954083575, 5558.305211848519, 5629.705167811427, 5635.5773317001385, 5641.2384328116, 5642.605017648807, 5654.6889921054735, 5061.83577777106, 5426.430224826494, 5444.8366549003595, 5473.0, 5480.232767412485, 5432.565394768488, 5437.3747019091725, 5484.0, 5492.945070549244, 5499.450054994629, 5655.830325090254, 5663.49917271915, 5671.262735844314, 5677.886442271214, 5689.573282003784, 4007.2987227234535, 4150.605692459211, 4151.169766046743, 4161.625453709181, 4164.937940825192, 5395.649282796606, 5499.285092937893, 5535.640183388067, 6009.90985135232, 6249.906251406142, 6130.601510901955, 6135.601185922901, 6137.539684523589, 6145.8156255312415, 6148.354422785543, 5987.491063259672, 6055.9091613626715, 6123.112148738497, 6146.170267013896, 6146.354632763674, 6045.486133678686, 6061.787837425669, 6078.361772014052, 6102.267727872683, 6123.969380153071, 6126.540509461719, 6154.415330543591, 6157.84605384869, 6168.660723660242, 6182.629042257479, 5825.621334613236, 5960.701964901651, 5992.370801065826, 5995.790147344822, 6002.369751176238], "value": 4469.155998886549, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [791.4894892794144, 808.7654580171749, 825.187190617242, 827.2885318625985, 905.4476769170809, 16383.262753176106, 17570.824291757093, 17611.82388176118, 17623.0, 17669.46991590251, 16163.272652730626, 16273.918630406832, 16298.7555186672, 16315.428959986402, 16333.754993675104, 712.2592503796071, 829.5561874397199, 835.4987007795335, 842.4229402859031, 869.6956065377115, 875.0, 875.7197696737047, 876.2157868707503, 876.9429987050853, 877.4252864373846, 922.0318665401335, 924.9491277979708, 927.0868194828089, 927.7819712367589, 929.6560272699111, 921.3550514639745, 921.709661456639, 922.3313098003961, 924.3206243411088, 924.9768755781125, 674.2010717300016, 675.1965161457849, 676.3642176354211, 676.7123972311748, 680.0886811672383, 14049.0, 14170.787438188436, 14178.645533861632, 14518.854811451962, 14552.708945821025, 14016.299185040707, 14506.347214375379, 14554.272286385638, 16279.680110921314, 17039.829601703947, 14101.2244326562, 14311.284435778169, 14425.711485770331, 14435.35040923161, 14748.115113093249, 4144.70987030908, 4792.305115758196, 4840.346553215306, 4919.11455937931, 4923.58149557288, 76263.0, 76387.0, 76439.0, 76707.61646191789, 76728.0, 12379.504819807107, 12490.125691201529, 12522.37388130608, 12591.433385497674, 12616.369181540886, 20841.68737468939, 22644.547109057727, 22723.659145112837, 22735.658965115537, 22755.203567875044, 9220.723378298662, 9396.436213827192, 9413.858792118124, 9440.339176257596, 9489.533675665723, 5112.463191364927, 5117.462666420047, 5219.42586315505, 5229.607779416559, 5340.305760251143, 3653.7442379033214, 3780.4518344839844, 3795.7532760370486, 3799.4490798834013, 3817.5418949725654, 666.3203532396928, 688.9069975553336, 689.4622194688151, 691.2120182991393, 701.9017337572744, 714.6569646569676, 811.9350451963828, 825.2284114353099, 825.2696363718153, 850.4302117581235, 10102.646407375707, 10560.47197640115, 10633.87322535496, 10802.189835762349, 11075.667729968114, 737.502186024442, 741.7033186725353, 763.2024534361606, 776.8290975985274, 849.9405041647149, 5095.464976177448, 5202.4277329493725, 5315.989961907225, 5386.649867758583, 5428.75570599324, 113158.0, 120466.0, 123914.38042809728, 132324.0, 133438.0, 108474.45762771135, 109185.0, 110812.4459377698, 112043.0, 112139.43930280296, 67722.66138669275, 69000.0, 97405.51297243468, 99392.50303748435, 99467.50266248768, 10870.130389568658, 11047.83428248593, 11144.832827507431, 11208.658930268099, 11312.886871131182, 39882.0, 47434.52565474301, 52905.47094529159, 52946.73526632342, 54076.729616351666, 75145.0, 80323.19676803157, 80991.0, 82960.0, 83198.08806691736, 14573.489927852474, 14640.780388294397, 14679.85320146785, 14813.33339999681, 14839.10965342083, 16113.113778742281, 16329.510114696579, 16477.34090636361, 16837.663246735243, 16873.325066997182, 15518.138695719357, 15618.687626247638, 16213.67572648564, 16433.424830130887, 16708.0, 15423.922880385526, 15718.493103140634, 16037.91981040134, 16562.254698538352, 16831.66336673235, 14756.262186890397, 14956.476523321631, 15183.696326073637, 15745.0, 16587.66824663524, 11878.821817672915, 11951.163418560966, 11997.0, 12149.0, 12556.49774009066, 12958.546450874173, 13006.934965325112, 13189.340532973121, 13283.80074298867, 13518.121322114031], "value": 8284.26073740487, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1494.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 107.0, 111.0, 113.0, 111.0, 111.0, 110.0, 110.0, 110.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 118.0, 146.0, 178.0, 122.0, 145.0, 147.0, 120.0, 178.0, 122.0], "value": 142.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 165.0, 163.0, 164.0, 163.0, 164.0, 163.0, 162.0, 162.0], "value": 163.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 84.0, 177.0, 76.0, 76.0, 74.0, 77.0, 153.0, 77.0], "value": 94.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 155.0, 84.0, 83.0, 83.0, 140.0, 84.0, 83.0, 137.0], "value": 101.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 146.0, 146.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 50.0, 50.0, 50.0, 51.0, 51.0, 51.0, 51.0, 51.0], "value": 50.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 61.0, 62.0, 61.0, 62.0, 61.0, 60.0, 62.0, 63.0, 62.0], "value": 61.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 72.0, 72.0, 72.0, 72.0, 73.0, 73.0, 76.0, 73.0], "value": 72.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 120.0, 121.0, 118.0, 124.0, 133.0, 119.0, 116.0, 154.0, 115.0], "value": 123.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 155.0, 152.0, 152.0, 157.0, 157.0, 155.0, 150.0, 152.0], "value": 153.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 64.0, 62.0, 62.0, 64.0, 64.0, 61.0, 61.0, 65.0], "value": 62.5, "unit": "score"}]}]} 16:06:58 INFO - Return code: 0 16:06:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:06:58 ERROR - # TBPL SUCCESS # 16:06:58 INFO - Running post-action listener: _resource_record_post_action 16:06:58 INFO - [mozharness: 2016-10-03 23:06:58.159125Z] Finished run-tests step (success) 16:06:58 INFO - Running post-run listener: _resource_record_post_run 16:06:58 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 1867776; Write bytes: 290189312; Read time: 392; Write time: 159096 16:06:58 INFO - TinderboxPrint: CPU usage
13.2% 16:06:58 INFO - TinderboxPrint: I/O read bytes / time
1,867,776 / 392 16:06:58 INFO - TinderboxPrint: I/O write bytes / time
290,189,312 / 159,096 16:06:58 INFO - TinderboxPrint: CPU idle
8,210.9 (86.7%) 16:06:58 INFO - TinderboxPrint: CPU user
1,200.2 (12.7%) 16:06:58 INFO - TinderboxPrint: Swap in / out
0 / 0 16:06:58 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 70123520; Read time: 0; Write time: 36336 16:06:58 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 220065792; Read time: 0; Write time: 122760 16:06:58 INFO - Running post-run listener: _upload_blobber_files 16:06:58 INFO - Blob upload gear active. 16:06:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:06:58 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 16:06:58 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'] 16:06:58 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 16:06:59 INFO - (blobuploader) - INFO - Open directory for files ... 16:06:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:06:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:06:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:06:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:06:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:06:59 INFO - (blobuploader) - INFO - Done attempting. 16:06:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:06:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:06:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:07:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:07:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:07:03 INFO - (blobuploader) - INFO - Done attempting. 16:07:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:07:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:07:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:07:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:07:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:07:03 INFO - (blobuploader) - INFO - Done attempting. 16:07:03 INFO - (blobuploader) - INFO - Iteration through files over. 16:07:03 INFO - Return code: 0 16:07:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:07:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:07:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f0f133c50555308e583a103a7316a85cd87e8f3280495b2459d73a6231425f492a88d19c6f1d92c973a831db643e133afac04797c061cd7b31797ccb90a8272c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/10f2980952cb5e70c6065dafb950a94f2065c25d9e6bf0570e3ae9f507f344c90c5b5a94a6dba082db118314cb3f17442cd2d9d9089e958831179ef251f9f6de", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6d4c95d9a3a44debc27365ffc0dd23e4d01b25f79b16d97e8f4b9d1b648dd441afc80faf45372145fdf7a7fd48eb4567618be032ef56ac1d28b81f264c380244"} 16:07:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:07:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:07:03 INFO - Contents: 16:07:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f0f133c50555308e583a103a7316a85cd87e8f3280495b2459d73a6231425f492a88d19c6f1d92c973a831db643e133afac04797c061cd7b31797ccb90a8272c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/10f2980952cb5e70c6065dafb950a94f2065c25d9e6bf0570e3ae9f507f344c90c5b5a94a6dba082db118314cb3f17442cd2d9d9089e958831179ef251f9f6de", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6d4c95d9a3a44debc27365ffc0dd23e4d01b25f79b16d97e8f4b9d1b648dd441afc80faf45372145fdf7a7fd48eb4567618be032ef56ac1d28b81f264c380244"} 16:07:03 INFO - Running post-run listener: copy_logs_to_upload_dir 16:07:03 INFO - Copying logs to upload dir... 16:07:03 INFO - mkdir: /builds/slave/test/build/upload/logs 16:07:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1672.493684 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 52 secs) (at 2016-10-03 16:07:02.857137) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-03 16:07:02.861079) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1475534349.28359-1514254637 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/f0f133c50555308e583a103a7316a85cd87e8f3280495b2459d73a6231425f492a88d19c6f1d92c973a831db643e133afac04797c061cd7b31797ccb90a8272c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/10f2980952cb5e70c6065dafb950a94f2065c25d9e6bf0570e3ae9f507f344c90c5b5a94a6dba082db118314cb3f17442cd2d9d9089e958831179ef251f9f6de", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6d4c95d9a3a44debc27365ffc0dd23e4d01b25f79b16d97e8f4b9d1b648dd441afc80faf45372145fdf7a7fd48eb4567618be032ef56ac1d28b81f264c380244"} build_url:https://queue.taskcluster.net/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011579 build_url: 'https://queue.taskcluster.net/v1/task/KreGsP7xSne2N8C4Uzlstg/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/f0f133c50555308e583a103a7316a85cd87e8f3280495b2459d73a6231425f492a88d19c6f1d92c973a831db643e133afac04797c061cd7b31797ccb90a8272c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/10f2980952cb5e70c6065dafb950a94f2065c25d9e6bf0570e3ae9f507f344c90c5b5a94a6dba082db118314cb3f17442cd2d9d9089e958831179ef251f9f6de", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6d4c95d9a3a44debc27365ffc0dd23e4d01b25f79b16d97e8f4b9d1b648dd441afc80faf45372145fdf7a7fd48eb4567618be032ef56ac1d28b81f264c380244"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-03 16:07:02.890138) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 16:07:02.890897) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1475534349.28359-1514254637 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004509 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 16:07:02.973668) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-03 16:07:02.974280) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-03 16:07:02.974879) ========= ========= Total master_lag: 0.18 =========