builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-032 starttime: 1473096009.29 results: success (0) buildid: 20160905071519 builduid: 4e9a9030d151432c8c640f6671ce6c5c revision: 37c314d53f827e5fc094fcb9b1537b4101681507 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-05 10:20:09.294812) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-05 10:20:09.295278) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-05 10:20:09.295592) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-05 10:20:09.322049) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-05 10:20:09.322357) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1473095866.778852-703103568 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-05 10:20:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.9M=0s 2016-09-05 10:20:10 (46.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.107019 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-05 10:20:09.448350) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-05 10:20:09.448698) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1473095866.778852-703103568 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019318 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-05 10:20:09.498889) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-05 10:20:09.499245) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 37c314d53f827e5fc094fcb9b1537b4101681507 --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-aurora --rev 37c314d53f827e5fc094fcb9b1537b4101681507 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1473095866.778852-703103568 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-05 10:20:10,542 truncating revision to first 12 chars 2016-09-05 10:20:10,542 Setting DEBUG logging. 2016-09-05 10:20:10,543 attempt 1/10 2016-09-05 10:20:10,543 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/37c314d53f82?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-05 10:20:10,865 unpacking tar archive at: mozilla-aurora-37c314d53f82/testing/mozharness/ program finished with exit code 0 elapsedTime=0.650861 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-05 10:20:10.163539) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-05 10:20:10.163894) ========= script_repo_revision: 37c314d53f827e5fc094fcb9b1537b4101681507 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-05 10:20:10.164335) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-05 10:20:10.164665) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-05 10:20:10.176917) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 1 secs) (at 2016-09-05 10:20:10.177229) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1473095866.778852-703103568 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:20:11 INFO - MultiFileLogger online at 20160905 10:20:11 in /builds/slave/test 10:20:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 10:20:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:20:11 INFO - {'append_to_log': False, 10:20:11 INFO - 'base_work_dir': '/builds/slave/test', 10:20:11 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 10:20:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:20:11 INFO - 'branch': 'Mozilla-Aurora', 10:20:11 INFO - 'buildbot_json_path': 'buildprops.json', 10:20:11 INFO - 'config_files': ('talos/linux_config.py',), 10:20:11 INFO - 'default_actions': ('clobber', 10:20:11 INFO - 'read-buildbot-config', 10:20:11 INFO - 'download-and-extract', 10:20:11 INFO - 'populate-webroot', 10:20:11 INFO - 'create-virtualenv', 10:20:11 INFO - 'install', 10:20:11 INFO - 'run-tests'), 10:20:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:20:11 INFO - 'download_minidump_stackwalk': True, 10:20:11 INFO - 'download_symbols': 'ondemand', 10:20:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:20:11 INFO - 'tooltool.py': '/tools/tooltool.py', 10:20:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:20:11 INFO - '/tools/misc-python/virtualenv.py')}, 10:20:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:20:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:20:11 INFO - 'installer_path': 'installer.exe', 10:20:11 INFO - 'log_level': 'info', 10:20:11 INFO - 'log_name': 'talos', 10:20:11 INFO - 'log_to_console': True, 10:20:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:20:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:20:11 INFO - 'opt_config_files': (), 10:20:11 INFO - 'pip_index': False, 10:20:11 INFO - 'sps_profile': False, 10:20:11 INFO - 'sps_profile_interval': 0, 10:20:11 INFO - 'suite': 'dromaeojs-e10s', 10:20:11 INFO - 'system_bits': '32', 10:20:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:20:11 INFO - 'title': 'talos-linux64-ix-032', 10:20:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:20:11 INFO - 'use_talos_json': True, 10:20:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:20:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:20:11 INFO - 'work_dir': 'build'} 10:20:11 INFO - [mozharness: 2016-09-05 17:20:11.312688Z] Running clobber step. 10:20:11 INFO - Running pre-action listener: _resource_record_pre_action 10:20:11 INFO - Running main action method: clobber 10:20:11 INFO - rmtree: /builds/slave/test/build 10:20:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:20:11 INFO - Running post-action listener: _resource_record_post_action 10:20:11 INFO - [mozharness: 2016-09-05 17:20:11.771071Z] Finished clobber step (success) 10:20:11 INFO - [mozharness: 2016-09-05 17:20:11.771174Z] Running read-buildbot-config step. 10:20:11 INFO - Running pre-action listener: _resource_record_pre_action 10:20:11 INFO - Running main action method: read_buildbot_config 10:20:11 INFO - Using buildbot properties: 10:20:11 INFO - { 10:20:11 INFO - "project": "", 10:20:11 INFO - "product": "firefox", 10:20:11 INFO - "script_repo_revision": "production", 10:20:11 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 10:20:11 INFO - "repository": "", 10:20:11 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 10:20:11 INFO - "buildid": "20160905071519", 10:20:11 INFO - "pgo_build": "True", 10:20:11 INFO - "basedir": "/builds/slave/test", 10:20:11 INFO - "buildnumber": 537, 10:20:11 INFO - "slavename": "talos-linux64-ix-032", 10:20:11 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:20:11 INFO - "platform": "ubuntu64_hw", 10:20:11 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 10:20:11 INFO - "branch": "mozilla-aurora", 10:20:11 INFO - "repo_path": "releases/mozilla-aurora", 10:20:11 INFO - "revision": "37c314d53f827e5fc094fcb9b1537b4101681507", 10:20:11 INFO - "stage_platform": "linux64-pgo", 10:20:11 INFO - "builduid": "4e9a9030d151432c8c640f6671ce6c5c", 10:20:11 INFO - "slavebuilddir": "test" 10:20:11 INFO - } 10:20:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 10:20:11 INFO - Running post-action listener: _resource_record_post_action 10:20:11 INFO - [mozharness: 2016-09-05 17:20:11.773617Z] Finished read-buildbot-config step (success) 10:20:11 INFO - [mozharness: 2016-09-05 17:20:11.773706Z] Running download-and-extract step. 10:20:11 INFO - Running pre-action listener: _resource_record_pre_action 10:20:11 INFO - Running main action method: download_and_extract 10:20:11 INFO - mkdir: /builds/slave/test/build/tests 10:20: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')]} 10:20:11 INFO - https://queue.taskcluster.net/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:20:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 10:20:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 10:20:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 10:20:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:20:11 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 10:20:11 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 10:20:11 INFO - retry: Failed, sleeping 30 seconds before retrying 10:20:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #2 10:20:41 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 10:20:41 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 10:20:41 INFO - retry: Failed, sleeping 60 seconds before retrying 10:21:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #3 10:21:41 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 10:21:41 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 10:21:41 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json! 10:21:41 INFO - Caught exception: HTTP Error 404: Not Found 10:21:41 INFO - Caught exception: HTTP Error 404: Not Found 10:21:41 INFO - Caught exception: HTTP Error 404: Not Found 10:21:41 INFO - trying https://queue.taskcluster.net/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 10:21:41 INFO - Downloading https://queue.taskcluster.net/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 10:21:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:21:42 INFO - Downloaded 1361 bytes. 10:21:42 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 10:21:42 INFO - Using the following test package requirements: 10:21:42 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 10:21:42 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 10:21:42 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 10:21:42 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 10:21:42 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 10:21:42 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 10:21:42 INFO - u'jsshell-linux-x86_64.zip'], 10:21:42 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 10:21:42 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 10:21:42 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 10:21:42 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 10:21:42 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 10:21:42 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 10:21:42 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 10:21:42 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 10:21:42 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 10:21:42 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 10:21:42 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 10:21:42 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:21: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')]} 10:21:42 INFO - https://queue.taskcluster.net/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:21:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 10:21:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 10:21:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 10:21:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:21:42 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 10:21:42 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 10:21:42 INFO - retry: Failed, sleeping 30 seconds before retrying 10:22:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #2 10:22:12 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 10:22:12 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 10:22:12 INFO - retry: Failed, sleeping 60 seconds before retrying 10:23:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #3 10:23:12 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 10:23:12 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 10:23:12 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip! 10:23:12 INFO - Caught exception: HTTP Error 404: Not Found 10:23:12 INFO - Caught exception: HTTP Error 404: Not Found 10:23:12 INFO - Caught exception: HTTP Error 404: Not Found 10:23:12 INFO - trying https://queue.taskcluster.net/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 10:23:12 INFO - Downloading https://queue.taskcluster.net/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 10:23:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:23:13 INFO - Downloaded 21769279 bytes. 10:23:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:23:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:23:14 INFO - Return code: 0 10:23:14 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:23: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')]} 10:23:14 INFO - https://queue.taskcluster.net/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:23:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 10:23:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 10:23:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 10:23:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:23:14 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 10:23:14 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 10:23:14 INFO - retry: Failed, sleeping 30 seconds before retrying 10:23:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #2 10:23:44 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 10:23:44 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 10:23:44 INFO - retry: Failed, sleeping 60 seconds before retrying 10:24:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #3 10:24:44 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 10:24:44 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 10:24:44 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip! 10:24:44 INFO - Caught exception: HTTP Error 404: Not Found 10:24:44 INFO - Caught exception: HTTP Error 404: Not Found 10:24:44 INFO - Caught exception: HTTP Error 404: Not Found 10:24:44 INFO - trying https://queue.taskcluster.net/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 10:24:44 INFO - Downloading https://queue.taskcluster.net/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 10:24:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:24:45 INFO - Downloaded 21769279 bytes. 10:24:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:24:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:24:46 INFO - Return code: 0 10:24:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:24:46 INFO - https://queue.taskcluster.net/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:24:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 10:24:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 10:24:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 10:24:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:24:46 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 10:24:46 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 10:24:46 INFO - retry: Failed, sleeping 30 seconds before retrying 10:25:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 10:25:16 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 10:25:16 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 10:25:16 INFO - retry: Failed, sleeping 60 seconds before retrying 10:26:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #3 10:26:16 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 10:26:16 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 10:26:16 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip! 10:26:16 INFO - Caught exception: HTTP Error 404: Not Found 10:26:16 INFO - Caught exception: HTTP Error 404: Not Found 10:26:16 INFO - Caught exception: HTTP Error 404: Not Found 10:26:16 INFO - trying https://queue.taskcluster.net/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 10:26:16 INFO - Downloading https://queue.taskcluster.net/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 10:26:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:26:18 INFO - Downloaded 14413740 bytes. 10:26:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:26:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:26:18 INFO - Return code: 0 10:26: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')]} 10:26:18 INFO - https://queue.taskcluster.net/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:26:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 10:26:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 10:26:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 10:26:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:26:18 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 10:26:18 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 10:26:18 INFO - retry: Failed, sleeping 30 seconds before retrying 10:26:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #2 10:26:48 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 10:26:48 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 10:26:48 INFO - retry: Failed, sleeping 60 seconds before retrying 10:27:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #3 10:27:48 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 10:27:48 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 10:27:48 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2! 10:27:48 INFO - Caught exception: HTTP Error 404: Not Found 10:27:48 INFO - Caught exception: HTTP Error 404: Not Found 10:27:48 INFO - Caught exception: HTTP Error 404: Not Found 10:27:48 INFO - trying https://queue.taskcluster.net/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 10:27:48 INFO - Downloading https://queue.taskcluster.net/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 10:27:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:27:50 INFO - Downloaded 63897279 bytes. 10:27:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 10:27:50 INFO - mkdir: /builds/slave/test/properties 10:27:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:27:50 INFO - Writing to file /builds/slave/test/properties/build_url 10:27:50 INFO - Contents: 10:27:50 INFO - build_url:https://queue.taskcluster.net/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 10:27:50 INFO - Running post-action listener: _resource_record_post_action 10:27:50 INFO - Running post-action listener: set_extra_try_arguments 10:27:50 INFO - [mozharness: 2016-09-05 17:27:50.811309Z] Finished download-and-extract step (success) 10:27:50 INFO - [mozharness: 2016-09-05 17:27:50.811541Z] Running populate-webroot step. 10:27:50 INFO - Running pre-action listener: _resource_record_pre_action 10:27:50 INFO - Running main action method: populate_webroot 10:27:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:27:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:27:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:27:50 INFO - '--tppagecycles', 10:27:50 INFO - '7'], 10:27:50 INFO - 'tests': ['tsvgm']}}, 10:27:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:27:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:27:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:27:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:27:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:27:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:27:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:27:50 INFO - 'talos_options': ['--disable-e10s'], 10:27:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:27:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:27:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:27:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:27:50 INFO - 'talos_options': ['--disable-e10s'], 10:27:50 INFO - 'tests': ['damp', 'tps']}, 10:27:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:27:50 INFO - 'tests': ['damp', 'tps']}, 10:27:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:27:50 INFO - 'tests': ['dromaeo_dom']}, 10:27:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:27:50 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:27:50 INFO - 'tests': ['basic_compositor_video']}, 10:27:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:27:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:27:50 INFO - 'tests': ['a11yr', 10:27:50 INFO - 'ts_paint', 10:27:50 INFO - 'tpaint', 10:27:50 INFO - 'sessionrestore', 10:27:50 INFO - 'sessionrestore_no_auto_restore', 10:27:50 INFO - 'tabpaint']}, 10:27:50 INFO - 'other-e10s': {'tests': ['a11yr', 10:27:50 INFO - 'ts_paint', 10:27:50 INFO - 'tpaint', 10:27:50 INFO - 'sessionrestore', 10:27:50 INFO - 'sessionrestore_no_auto_restore', 10:27:50 INFO - 'tabpaint']}, 10:27:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:27:50 INFO - 'ts_paint', 10:27:50 INFO - 'tpaint', 10:27:50 INFO - 'sessionrestore', 10:27:50 INFO - 'sessionrestore_no_auto_restore', 10:27:50 INFO - 'tabpaint']}, 10:27:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:27:50 INFO - 'ts_paint', 10:27:50 INFO - 'tpaint', 10:27:50 INFO - 'sessionrestore', 10:27:50 INFO - 'sessionrestore_no_auto_restore', 10:27:50 INFO - 'tabpaint']}, 10:27:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:27:50 INFO - 'tests': ['a11yr', 10:27:50 INFO - 'ts_paint', 10:27:50 INFO - 'tpaint', 10:27:50 INFO - 'sessionrestore', 10:27:50 INFO - 'sessionrestore_no_auto_restore', 10:27:50 INFO - 'tabpaint']}, 10:27:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:27:50 INFO - 'tests': ['a11yr', 10:27:50 INFO - 'ts_paint', 10:27:50 INFO - 'tpaint', 10:27:50 INFO - 'sessionrestore', 10:27:50 INFO - 'sessionrestore_no_auto_restore', 10:27:50 INFO - 'tabpaint']}, 10:27:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:27:50 INFO - 'tests': ['tsvgx', 10:27:50 INFO - 'tsvgr_opacity', 10:27:50 INFO - 'tart', 10:27:50 INFO - 'tscrollx', 10:27:50 INFO - 'cart']}, 10:27:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:27:50 INFO - 'tsvgr_opacity', 10:27:50 INFO - 'tart', 10:27:50 INFO - 'tscrollx', 10:27:50 INFO - 'cart']}, 10:27:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:27:50 INFO - 'talos_options': ['--disable-e10s'], 10:27:50 INFO - 'tests': ['tp5o']}, 10:27:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:27:50 INFO - 'tests': ['tp5o']}, 10:27:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:27:50 INFO - 'talos_options': ['--disable-e10s', 10:27:50 INFO - '--xperf_path', 10:27:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:27:50 INFO - 'tests': ['tp5n']}, 10:27:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:27:50 INFO - 'talos_options': ['--xperf_path', 10:27:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:27:50 INFO - 'tests': ['tp5n']}}, 10:27:50 INFO - 'talos.zip': {'path': '', 10:27:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:27:50 INFO - Running post-action listener: _resource_record_post_action 10:27:50 INFO - [mozharness: 2016-09-05 17:27:50.827092Z] Finished populate-webroot step (success) 10:27:50 INFO - [mozharness: 2016-09-05 17:27:50.827181Z] Running create-virtualenv step. 10:27:50 INFO - Running pre-action listener: _resource_record_pre_action 10:27:50 INFO - Running main action method: create_virtualenv 10:27:50 INFO - Creating virtualenv /builds/slave/test/build/venv 10:27: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 10:27:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:27:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:27:50 INFO - Using real prefix '/usr' 10:27:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:27:51 INFO - Installing distribute.............................................................................................................................................................................................done. 10:27:53 INFO - Installing pip.................done. 10:27:53 INFO - Return code: 0 10:27:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:27:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:27:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:27:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:27:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2173030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a2400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2431570>, '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 0x2432470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2432900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1473095866.778852-703103568', '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 10:27:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:27:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:27:53 INFO - Using env: {'DISPLAY': ':0', 10:27:53 INFO - 'HOME': '/home/cltbld', 10:27:53 INFO - 'LANG': 'en_US.UTF-8', 10:27:53 INFO - 'LANGUAGE': 'en_US:en', 10:27:53 INFO - 'LOGNAME': 'cltbld', 10:27:53 INFO - 'MAIL': '/var/mail/cltbld', 10:27:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:27:53 INFO - 'MOZ_NO_REMOTE': '1', 10:27:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:27:53 INFO - 'NO_EM_RESTART': '1', 10:27:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:27:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:27:53 INFO - 'PWD': '/builds/slave/test', 10:27:53 INFO - 'SHELL': '/bin/bash', 10:27:53 INFO - 'SHLVL': '1', 10:27:53 INFO - 'TERM': 'linux', 10:27:53 INFO - 'TMOUT': '86400', 10:27:53 INFO - 'USER': 'cltbld', 10:27:53 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1473095866.778852-703103568', 10:27:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:27:53 INFO - '_': '/tools/buildbot/bin/python'} 10:27:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:27:53 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 10:27:53 INFO - Cleaning up... 10:27:53 INFO - Return code: 0 10:27:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:27:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:27:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:27:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:27:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2173030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a2400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2431570>, '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 0x2432470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2432900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1473095866.778852-703103568', '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 10:27:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:27:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:27:53 INFO - Using env: {'DISPLAY': ':0', 10:27:53 INFO - 'HOME': '/home/cltbld', 10:27:53 INFO - 'LANG': 'en_US.UTF-8', 10:27:53 INFO - 'LANGUAGE': 'en_US:en', 10:27:53 INFO - 'LOGNAME': 'cltbld', 10:27:53 INFO - 'MAIL': '/var/mail/cltbld', 10:27:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:27:53 INFO - 'MOZ_NO_REMOTE': '1', 10:27:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:27:53 INFO - 'NO_EM_RESTART': '1', 10:27:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:27:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:27:53 INFO - 'PWD': '/builds/slave/test', 10:27:53 INFO - 'SHELL': '/bin/bash', 10:27:53 INFO - 'SHLVL': '1', 10:27:53 INFO - 'TERM': 'linux', 10:27:53 INFO - 'TMOUT': '86400', 10:27:53 INFO - 'USER': 'cltbld', 10:27:53 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1473095866.778852-703103568', 10:27:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:27:53 INFO - '_': '/tools/buildbot/bin/python'} 10:27:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:27:53 INFO - Downloading/unpacking psutil>=3.1.1 10:27: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 10:27: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 10:27: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 10:27: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 10:27: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 10:27: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 10:27:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:27:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:27:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:27:55 INFO - Installing collected packages: psutil 10:27:55 INFO - Running setup.py install for psutil 10:27:55 INFO - building 'psutil._psutil_linux' extension 10:27: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 10:27:56 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 10:27:56 INFO - building 'psutil._psutil_posix' extension 10:27:56 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 10:27:56 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 10:27:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:27:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:27:56 INFO - Successfully installed psutil 10:27:56 INFO - Cleaning up... 10:27:56 INFO - Return code: 0 10:27:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:27:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:27:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:27:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:27:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:27:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2173030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a2400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2431570>, '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 0x2432470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2432900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1473095866.778852-703103568', '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 10:27:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:27:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:27:56 INFO - Using env: {'DISPLAY': ':0', 10:27:56 INFO - 'HOME': '/home/cltbld', 10:27:56 INFO - 'LANG': 'en_US.UTF-8', 10:27:56 INFO - 'LANGUAGE': 'en_US:en', 10:27:56 INFO - 'LOGNAME': 'cltbld', 10:27:56 INFO - 'MAIL': '/var/mail/cltbld', 10:27:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:27:56 INFO - 'MOZ_NO_REMOTE': '1', 10:27:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:27:56 INFO - 'NO_EM_RESTART': '1', 10:27:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:27:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:27:56 INFO - 'PWD': '/builds/slave/test', 10:27:56 INFO - 'SHELL': '/bin/bash', 10:27:56 INFO - 'SHLVL': '1', 10:27:56 INFO - 'TERM': 'linux', 10:27:56 INFO - 'TMOUT': '86400', 10:27:56 INFO - 'USER': 'cltbld', 10:27:56 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1473095866.778852-703103568', 10:27:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:27:56 INFO - '_': '/tools/buildbot/bin/python'} 10:27:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:27:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:27:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:27:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:27:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:27:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:27:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:27:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:27:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:27:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:27:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:27:58 INFO - Installing collected packages: mozsystemmonitor 10:27:58 INFO - Running setup.py install for mozsystemmonitor 10:27:58 INFO - Successfully installed mozsystemmonitor 10:27:58 INFO - Cleaning up... 10:27:58 INFO - Return code: 0 10:27:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:27: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')]} 10:27:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:27:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27: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')]} 10:27:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:27:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27: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 0x2173030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a2400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2431570>, '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 0x2432470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2432900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1473095866.778852-703103568', '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 10:27: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 10:27: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 10:27:58 INFO - Using env: {'DISPLAY': ':0', 10:27:58 INFO - 'HOME': '/home/cltbld', 10:27:58 INFO - 'LANG': 'en_US.UTF-8', 10:27:58 INFO - 'LANGUAGE': 'en_US:en', 10:27:58 INFO - 'LOGNAME': 'cltbld', 10:27:58 INFO - 'MAIL': '/var/mail/cltbld', 10:27:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:27:58 INFO - 'MOZ_NO_REMOTE': '1', 10:27:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:27:58 INFO - 'NO_EM_RESTART': '1', 10:27:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:27:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:27:58 INFO - 'PWD': '/builds/slave/test', 10:27:58 INFO - 'SHELL': '/bin/bash', 10:27:58 INFO - 'SHLVL': '1', 10:27:58 INFO - 'TERM': 'linux', 10:27:58 INFO - 'TMOUT': '86400', 10:27:58 INFO - 'USER': 'cltbld', 10:27:58 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1473095866.778852-703103568', 10:27:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:27:58 INFO - '_': '/tools/buildbot/bin/python'} 10:27:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:27:58 INFO - Downloading/unpacking jsonschema==2.5.1 10:27: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 10:27: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 10:27: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 10:27: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 10:27: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 10:27: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 10:28:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:28:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:28: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 10:28: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 10:28: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 10:28: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 10:28: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 10:28: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 10:28:01 INFO - Downloading functools32-3.2.3-2.tar.gz 10:28:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:28:01 INFO - warning: no files found matching '*.txt' 10:28:01 INFO - no previously-included directories found matching 'build' 10:28:01 INFO - no previously-included directories found matching 'dist' 10:28:01 INFO - no previously-included directories found matching '.git*' 10:28:01 INFO - Installing collected packages: jsonschema, functools32 10:28:01 INFO - Running setup.py install for functools32 10:28:01 INFO - warning: no files found matching '*.txt' 10:28:01 INFO - no previously-included directories found matching 'build' 10:28:01 INFO - no previously-included directories found matching 'dist' 10:28:01 INFO - no previously-included directories found matching '.git*' 10:28:01 INFO - Successfully installed jsonschema functools32 10:28:01 INFO - Cleaning up... 10:28:01 INFO - Return code: 0 10:28:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:28:01 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')]} 10:28:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:28:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:01 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')]} 10:28:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:28:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:01 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 0x2173030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a2400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2431570>, '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 0x2432470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2432900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1473095866.778852-703103568', '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 10:28:01 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 10:28:01 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 10:28:01 INFO - Using env: {'DISPLAY': ':0', 10:28:01 INFO - 'HOME': '/home/cltbld', 10:28:01 INFO - 'LANG': 'en_US.UTF-8', 10:28:01 INFO - 'LANGUAGE': 'en_US:en', 10:28:01 INFO - 'LOGNAME': 'cltbld', 10:28:01 INFO - 'MAIL': '/var/mail/cltbld', 10:28:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:01 INFO - 'MOZ_NO_REMOTE': '1', 10:28:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:28:01 INFO - 'NO_EM_RESTART': '1', 10:28:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:28:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:01 INFO - 'PWD': '/builds/slave/test', 10:28:01 INFO - 'SHELL': '/bin/bash', 10:28:01 INFO - 'SHLVL': '1', 10:28:01 INFO - 'TERM': 'linux', 10:28:01 INFO - 'TMOUT': '86400', 10:28:01 INFO - 'USER': 'cltbld', 10:28:01 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1473095866.778852-703103568', 10:28:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:01 INFO - '_': '/tools/buildbot/bin/python'} 10:28:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:28:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:28:01 INFO - Cleaning up... 10:28:01 INFO - Return code: 0 10:28:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:28:01 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')]} 10:28:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:28:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:01 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')]} 10:28:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:28:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:01 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 0x2173030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a2400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2431570>, '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 0x2432470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2432900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1473095866.778852-703103568', '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 10:28:01 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 10:28:01 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 10:28:01 INFO - Using env: {'DISPLAY': ':0', 10:28:01 INFO - 'HOME': '/home/cltbld', 10:28:01 INFO - 'LANG': 'en_US.UTF-8', 10:28:01 INFO - 'LANGUAGE': 'en_US:en', 10:28:01 INFO - 'LOGNAME': 'cltbld', 10:28:01 INFO - 'MAIL': '/var/mail/cltbld', 10:28:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:01 INFO - 'MOZ_NO_REMOTE': '1', 10:28:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:28:01 INFO - 'NO_EM_RESTART': '1', 10:28:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:28:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:01 INFO - 'PWD': '/builds/slave/test', 10:28:01 INFO - 'SHELL': '/bin/bash', 10:28:01 INFO - 'SHLVL': '1', 10:28:01 INFO - 'TERM': 'linux', 10:28:01 INFO - 'TMOUT': '86400', 10:28:01 INFO - 'USER': 'cltbld', 10:28:01 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1473095866.778852-703103568', 10:28:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:01 INFO - '_': '/tools/buildbot/bin/python'} 10:28:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:28:01 INFO - Downloading/unpacking blobuploader==1.2.4 10:28: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 10:28: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 10:28: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 10:28: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 10:28: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 10:28: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 10:28:03 INFO - Downloading blobuploader-1.2.4.tar.gz 10:28:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:28:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:28: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 10:28: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 10:28: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 10:28: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 10:28: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 10:28: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 10:28:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:28:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:28:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:28:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:28:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:28:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:28:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:28:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:28:04 INFO - Downloading docopt-0.6.1.tar.gz 10:28:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:28:04 INFO - Installing collected packages: blobuploader, requests, docopt 10:28:04 INFO - Running setup.py install for blobuploader 10:28:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:28:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:28:04 INFO - Running setup.py install for requests 10:28:04 INFO - Running setup.py install for docopt 10:28:04 INFO - Successfully installed blobuploader requests docopt 10:28:04 INFO - Cleaning up... 10:28:05 INFO - Return code: 0 10:28:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:28:05 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')]} 10:28:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:28:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:05 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')]} 10:28:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:28:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:05 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 0x2173030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a2400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2431570>, '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 0x2432470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2432900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1473095866.778852-703103568', '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 10:28:05 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 10:28:05 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 10:28:05 INFO - Using env: {'DISPLAY': ':0', 10:28:05 INFO - 'HOME': '/home/cltbld', 10:28:05 INFO - 'LANG': 'en_US.UTF-8', 10:28:05 INFO - 'LANGUAGE': 'en_US:en', 10:28:05 INFO - 'LOGNAME': 'cltbld', 10:28:05 INFO - 'MAIL': '/var/mail/cltbld', 10:28:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:05 INFO - 'MOZ_NO_REMOTE': '1', 10:28:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:28:05 INFO - 'NO_EM_RESTART': '1', 10:28:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:28:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:05 INFO - 'PWD': '/builds/slave/test', 10:28:05 INFO - 'SHELL': '/bin/bash', 10:28:05 INFO - 'SHLVL': '1', 10:28:05 INFO - 'TERM': 'linux', 10:28:05 INFO - 'TMOUT': '86400', 10:28:05 INFO - 'USER': 'cltbld', 10:28:05 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1473095866.778852-703103568', 10:28:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:05 INFO - '_': '/tools/buildbot/bin/python'} 10:28:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:28:05 INFO - Running setup.py (path:/tmp/pip-zSPecZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:28:05 INFO - Running setup.py (path:/tmp/pip-gj3ztL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:28:05 INFO - Running setup.py (path:/tmp/pip-dQ2Qu3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:28:05 INFO - Running setup.py (path:/tmp/pip-9LZlHq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:28:05 INFO - Running setup.py (path:/tmp/pip-q8yli3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:28:05 INFO - Running setup.py (path:/tmp/pip-WKRJBs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:28:05 INFO - Running setup.py (path:/tmp/pip-PttkfZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:28:05 INFO - Running setup.py (path:/tmp/pip-RYE4Bh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:28:05 INFO - Running setup.py (path:/tmp/pip-AmYNCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:28:05 INFO - Running setup.py (path:/tmp/pip-Bm7zrI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:28:05 INFO - Running setup.py (path:/tmp/pip-vBkbIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:28:06 INFO - Running setup.py (path:/tmp/pip-y8hA5F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:28:06 INFO - Running setup.py (path:/tmp/pip-6gPPWA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:28:06 INFO - Running setup.py (path:/tmp/pip-HfQtlP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:28:06 INFO - Running setup.py (path:/tmp/pip-C6jAvi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:28:06 INFO - Running setup.py (path:/tmp/pip-CCoQXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:28:06 INFO - Running setup.py (path:/tmp/pip-ajbDFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:28:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:28:06 INFO - Running setup.py install for manifestparser 10:28:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:28:06 INFO - Running setup.py install for mozcrash 10:28:06 INFO - Running setup.py install for mozdebug 10:28:06 INFO - Running setup.py install for mozdevice 10:28:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:28:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:28:06 INFO - Running setup.py install for mozfile 10:28:07 INFO - Running setup.py install for mozhttpd 10:28:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:28:07 INFO - Running setup.py install for mozinfo 10:28:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:28:07 INFO - Running setup.py install for mozInstall 10:28:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:28:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:28:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:28:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:28:07 INFO - Running setup.py install for mozleak 10:28:07 INFO - Running setup.py install for mozlog 10:28:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:28:07 INFO - Running setup.py install for moznetwork 10:28:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:28:07 INFO - Running setup.py install for mozprocess 10:28:07 INFO - Running setup.py install for mozprofile 10:28:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:28:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:28:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:28:07 INFO - Running setup.py install for mozrunner 10:28:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:28:08 INFO - Running setup.py install for mozscreenshot 10:28:08 INFO - Running setup.py install for moztest 10:28:08 INFO - Running setup.py install for mozversion 10:28:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:28:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:28:08 INFO - Cleaning up... 10:28:08 INFO - Return code: 0 10:28:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:28:08 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')]} 10:28:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:28:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:08 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')]} 10:28:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:28:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:08 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 0x2173030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a2400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2431570>, '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 0x2432470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2432900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1473095866.778852-703103568', '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 10:28:08 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 10:28:08 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 10:28:08 INFO - Using env: {'DISPLAY': ':0', 10:28:08 INFO - 'HOME': '/home/cltbld', 10:28:08 INFO - 'LANG': 'en_US.UTF-8', 10:28:08 INFO - 'LANGUAGE': 'en_US:en', 10:28:08 INFO - 'LOGNAME': 'cltbld', 10:28:08 INFO - 'MAIL': '/var/mail/cltbld', 10:28:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:08 INFO - 'MOZ_NO_REMOTE': '1', 10:28:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:28:08 INFO - 'NO_EM_RESTART': '1', 10:28:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:28:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:08 INFO - 'PWD': '/builds/slave/test', 10:28:08 INFO - 'SHELL': '/bin/bash', 10:28:08 INFO - 'SHLVL': '1', 10:28:08 INFO - 'TERM': 'linux', 10:28:08 INFO - 'TMOUT': '86400', 10:28:08 INFO - 'USER': 'cltbld', 10:28:08 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1473095866.778852-703103568', 10:28:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:08 INFO - '_': '/tools/buildbot/bin/python'} 10:28:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:28:08 INFO - Running setup.py (path:/tmp/pip-A6DYWy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:28:08 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)) 10:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:28:08 INFO - Running setup.py (path:/tmp/pip-hXzRJ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:28: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)) 10:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:28:08 INFO - Running setup.py (path:/tmp/pip-eDuC_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:28: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)) 10:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:28:08 INFO - Running setup.py (path:/tmp/pip-cffMAP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:28: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)) 10:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:28:08 INFO - Running setup.py (path:/tmp/pip-HMHRAb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:28: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)) 10:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:28:08 INFO - Running setup.py (path:/tmp/pip-aanGJt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:28: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)) 10:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:28:08 INFO - Running setup.py (path:/tmp/pip-SN7K8h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:28:09 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)) 10:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:28:09 INFO - Running setup.py (path:/tmp/pip-Y0rdFp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:28:09 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)) 10:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:28:09 INFO - Running setup.py (path:/tmp/pip-yD7JAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:28:09 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)) 10:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:28:09 INFO - Running setup.py (path:/tmp/pip-O7cFH6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:28:09 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)) 10:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:28:09 INFO - Running setup.py (path:/tmp/pip-8CF5Il-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:28:09 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)) 10:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:28:09 INFO - Running setup.py (path:/tmp/pip-1Todxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:28:09 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)) 10:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:28:09 INFO - Running setup.py (path:/tmp/pip-FHlh05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:28:09 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)) 10:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:28:09 INFO - Running setup.py (path:/tmp/pip-BhkQXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:28:09 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)) 10:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:28:09 INFO - Running setup.py (path:/tmp/pip-m6I4YR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:28: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)) 10:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:28:09 INFO - Running setup.py (path:/tmp/pip-1h4o1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:28: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)) 10:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:28:09 INFO - Running setup.py (path:/tmp/pip-FtU8cD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:28: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)) 10:28: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)) 10:28: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)) 10:28: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)) 10:28: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)) 10:28: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)) 10:28:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:28: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 10:28: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 10:28: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 10:28: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 10:28: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 10:28: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 10:28:11 INFO - Downloading blessings-1.6.tar.gz 10:28:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:28:11 INFO - Installing collected packages: blessings 10:28:11 INFO - Running setup.py install for blessings 10:28:11 INFO - Successfully installed blessings 10:28:11 INFO - Cleaning up... 10:28:11 INFO - Return code: 0 10:28:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:28:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:28:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:28:12 INFO - Reading from file tmpfile_stdout 10:28:12 INFO - Current package versions: 10:28:12 INFO - argparse == 1.2.1 10:28:12 INFO - blessings == 1.6 10:28:12 INFO - blobuploader == 1.2.4 10:28:12 INFO - docopt == 0.6.1 10:28:12 INFO - functools32 == 3.2.3-2 10:28:12 INFO - jsonschema == 2.5.1 10:28:12 INFO - manifestparser == 1.1 10:28:12 INFO - mozInstall == 1.12 10:28:12 INFO - mozcrash == 0.17 10:28:12 INFO - mozdebug == 0.1 10:28:12 INFO - mozdevice == 0.48 10:28:12 INFO - mozfile == 1.2 10:28:12 INFO - mozhttpd == 0.7 10:28:12 INFO - mozinfo == 0.9 10:28:12 INFO - mozleak == 0.1 10:28:12 INFO - mozlog == 3.3 10:28:12 INFO - moznetwork == 0.27 10:28:12 INFO - mozprocess == 0.23 10:28:12 INFO - mozprofile == 0.28 10:28:12 INFO - mozrunner == 6.12 10:28:12 INFO - mozscreenshot == 0.1 10:28:12 INFO - mozsystemmonitor == 0.3 10:28:12 INFO - moztest == 0.7 10:28:12 INFO - mozversion == 1.4 10:28:12 INFO - psutil == 3.1.1 10:28:12 INFO - requests == 1.2.3 10:28:12 INFO - wsgiref == 0.1.2 10:28:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:28: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')]} 10:28:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:28:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28: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')]} 10:28:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:28:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:12 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 0x2173030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a2400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2431570>, '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 0x2432470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2432900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1473095866.778852-703103568', '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 10:28:12 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 10:28:12 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 10:28:12 INFO - Using env: {'DISPLAY': ':0', 10:28:12 INFO - 'HOME': '/home/cltbld', 10:28:12 INFO - 'LANG': 'en_US.UTF-8', 10:28:12 INFO - 'LANGUAGE': 'en_US:en', 10:28:12 INFO - 'LOGNAME': 'cltbld', 10:28:12 INFO - 'MAIL': '/var/mail/cltbld', 10:28:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:12 INFO - 'MOZ_NO_REMOTE': '1', 10:28:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:28:12 INFO - 'NO_EM_RESTART': '1', 10:28:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:28:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:12 INFO - 'PWD': '/builds/slave/test', 10:28:12 INFO - 'SHELL': '/bin/bash', 10:28:12 INFO - 'SHLVL': '1', 10:28:12 INFO - 'TERM': 'linux', 10:28:12 INFO - 'TMOUT': '86400', 10:28:12 INFO - 'USER': 'cltbld', 10:28:12 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1473095866.778852-703103568', 10:28:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:12 INFO - '_': '/tools/buildbot/bin/python'} 10:28:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:28:12 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)) 10:28:12 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)) 10:28:12 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)) 10:28:12 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)) 10:28:12 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)) 10:28:12 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)) 10:28:12 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)) 10:28:12 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)) 10:28:12 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)) 10:28:12 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)) 10:28:12 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)) 10:28:12 INFO - Cleaning up... 10:28:12 INFO - Return code: 0 10:28:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:28: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')]} 10:28:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:28:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28: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')]} 10:28:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:28:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:12 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 0x2173030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a2400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2431570>, '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 0x2432470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2432900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1473095866.778852-703103568', '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 10:28:12 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 10:28:12 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 10:28:12 INFO - Using env: {'DISPLAY': ':0', 10:28:12 INFO - 'HOME': '/home/cltbld', 10:28:12 INFO - 'LANG': 'en_US.UTF-8', 10:28:12 INFO - 'LANGUAGE': 'en_US:en', 10:28:12 INFO - 'LOGNAME': 'cltbld', 10:28:12 INFO - 'MAIL': '/var/mail/cltbld', 10:28:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:12 INFO - 'MOZ_NO_REMOTE': '1', 10:28:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:28:12 INFO - 'NO_EM_RESTART': '1', 10:28:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:28:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:12 INFO - 'PWD': '/builds/slave/test', 10:28:12 INFO - 'SHELL': '/bin/bash', 10:28:12 INFO - 'SHLVL': '1', 10:28:12 INFO - 'TERM': 'linux', 10:28:12 INFO - 'TMOUT': '86400', 10:28:12 INFO - 'USER': 'cltbld', 10:28:12 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1473095866.778852-703103568', 10:28:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:12 INFO - '_': '/tools/buildbot/bin/python'} 10:28:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:28:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:28:12 INFO - Cleaning up... 10:28:12 INFO - Return code: 0 10:28:12 INFO - Running post-action listener: _resource_record_post_action 10:28:12 INFO - Running post-action listener: _start_resource_monitoring 10:28:12 INFO - Starting resource monitoring. 10:28:12 INFO - [mozharness: 2016-09-05 17:28:12.583935Z] Finished create-virtualenv step (success) 10:28:12 INFO - [mozharness: 2016-09-05 17:28:12.584411Z] Running install step. 10:28:12 INFO - Running pre-action listener: _resource_record_pre_action 10:28:12 INFO - Running main action method: install 10:28:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:28:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:28:12 INFO - Reading from file tmpfile_stdout 10:28:12 INFO - Detecting whether we're running mozinstall >=1.0... 10:28:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:28:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:28:12 INFO - Reading from file tmpfile_stdout 10:28:12 INFO - Output received: 10:28:12 INFO - Usage: mozinstall [options] installer 10:28:12 INFO - Options: 10:28:12 INFO - -h, --help show this help message and exit 10:28:12 INFO - -d DEST, --destination=DEST 10:28:12 INFO - Directory to install application into. [default: 10:28:12 INFO - "/builds/slave/test"] 10:28:12 INFO - --app=APP Application being installed. [default: firefox] 10:28:12 INFO - mkdir: /builds/slave/test/build/application 10:28:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:28:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:28:29 INFO - Reading from file tmpfile_stdout 10:28:29 INFO - Output received: 10:28:29 INFO - /builds/slave/test/build/application/firefox/firefox 10:28:29 INFO - Running post-action listener: _resource_record_post_action 10:28:29 INFO - [mozharness: 2016-09-05 17:28:29.605338Z] Finished install step (success) 10:28:29 INFO - [mozharness: 2016-09-05 17:28:29.605618Z] Running run-tests step. 10:28:29 INFO - Running pre-action listener: _resource_record_pre_action 10:28:29 INFO - Running main action method: run_tests 10:28:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:28:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:28:29 INFO - Python 2.7.3 10:28:29 INFO - Return code: 0 10:28:29 INFO - grabbing minidump binary from tooltool 10:28:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:28:29 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 0x2431570>, '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 0x2432470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2432900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:28:29 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 10:28:29 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 10:28:29 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 10:28:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:28:29 INFO - Return code: 0 10:28:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:28:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:28:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:28:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:28:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:28:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 10:28:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:28:29 INFO - Using env: {'DISPLAY': ':0', 10:28:29 INFO - 'HOME': '/home/cltbld', 10:28:29 INFO - 'LANG': 'en_US.UTF-8', 10:28:29 INFO - 'LANGUAGE': 'en_US:en', 10:28:29 INFO - 'LOGNAME': 'cltbld', 10:28:29 INFO - 'MAIL': '/var/mail/cltbld', 10:28:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:28:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:28:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:29 INFO - 'MOZ_NO_REMOTE': '1', 10:28:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:28:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:28:29 INFO - 'NO_EM_RESTART': '1', 10:28:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:28:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:29 INFO - 'PWD': '/builds/slave/test', 10:28:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:28:29 INFO - 'SHELL': '/bin/bash', 10:28:29 INFO - 'SHLVL': '1', 10:28:29 INFO - 'TERM': 'linux', 10:28:29 INFO - 'TMOUT': '86400', 10:28:29 INFO - 'USER': 'cltbld', 10:28:29 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1473095866.778852-703103568', 10:28:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:29 INFO - '_': '/tools/buildbot/bin/python'} 10:28:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:28:29 INFO - mozversion application_buildid: 20160905071519 10:28:29 INFO - mozversion application_changeset: 37c314d53f827e5fc094fcb9b1537b4101681507 10:28:29 INFO - mozversion application_display_name: FirefoxDeveloperEdition 10:28:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:28:29 INFO - mozversion application_name: Firefox 10:28:29 INFO - mozversion application_remotingname: firefox-dev 10:28:29 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:28:29 INFO - mozversion application_vendor: Mozilla 10:28:29 INFO - mozversion application_version: 50.0a2 10:28:29 INFO - mozversion platform_buildid: 20160905071519 10:28:29 INFO - mozversion platform_changeset: 37c314d53f827e5fc094fcb9b1537b4101681507 10:28:29 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:28:29 INFO - mozversion platform_version: 50.0a2 10:28:29 INFO - using testdate: 1473096509 10:28:29 INFO - actual date: 1473096509 10:28:29 INFO - starting webserver on 'localhost:57637' 10:28:29 INFO - SUITE-START | Running 2 tests 10:28:29 INFO - TEST-START | dromaeo_css 10:28:29 INFO - operating with platform_type : linux_ 10:28:29 INFO - Initialising browser for dromaeo_css test... 10:28:29 INFO - TEST-INFO | started process 10397 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp499GwC/profile http://localhost:57637/getInfo.html) 10:28:34 INFO - PROCESS | 10397 | __metrics Screen width/height:1600/1200 10:28:34 INFO - PROCESS | 10397 | colorDepth:24 10:28:34 INFO - PROCESS | 10397 | Browser inner width/height: 1024/697 10:28:34 INFO - PROCESS | 10397 | __metrics 10:28:35 ERROR - PROCESS | 10397 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 10:28:36 INFO - TEST-INFO | 10397: exit 0 10:28:36 INFO - Browser initialized. 10:28:36 INFO - Running cycle 1/1 for dromaeo_css test... 10:28:36 INFO - TEST-INFO | started process 10525 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp499GwC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:28:48 INFO - PROCESS | 10525 | RSS: Main: 152616960 10:28:48 INFO - PROCESS | 10525 | 10:29:37 INFO - PROCESS | 10525 | 1473096577772 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] 10:31:46 INFO - PROCESS | 10525 | Cycle 1(1): loaded http://localhost:57637/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57637/tests/dromaeo/cssquery-ext.html) 10:31:47 INFO - PROCESS | 10525 | RSS: Main: 157974528 10:31:47 INFO - PROCESS | 10525 | 10:34:49 INFO - PROCESS | 10525 | Cycle 1(1): loaded http://localhost:57637/tests/dromaeo/cssquery-ext.html (next: http://localhost:57637/tests/dromaeo/cssquery-jquery.html) 10:34:50 INFO - PROCESS | 10525 | RSS: Main: 153935872 10:34:50 INFO - PROCESS | 10525 | 10:37:52 INFO - PROCESS | 10525 | Cycle 1(1): loaded http://localhost:57637/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57637/tests/dromaeo/cssquery-mootools.html) 10:37:52 INFO - PROCESS | 10525 | RSS: Main: 154079232 10:37:52 INFO - PROCESS | 10525 | 10:40:54 INFO - PROCESS | 10525 | Cycle 1(1): loaded http://localhost:57637/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57637/tests/dromaeo/cssquery-prototype.html) 10:40:55 INFO - PROCESS | 10525 | RSS: Main: 152936448 10:40:55 INFO - PROCESS | 10525 | 10:43:57 INFO - PROCESS | 10525 | Cycle 1(1): loaded http://localhost:57637/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57637/tests/dromaeo/cssquery-yui.html) 10:43:58 INFO - PROCESS | 10525 | RSS: Main: 155512832 10:43:58 INFO - PROCESS | 10525 | 10:47:00 INFO - PROCESS | 10525 | Cycle 1(1): loaded http://localhost:57637/tests/dromaeo/cssquery-yui.html (next: http://localhost:57637/tests/dromaeo/cssquery-dojo.html) 10:47:00 INFO - PROCESS | 10525 | RSS: Main: 156266496 10:47:00 INFO - PROCESS | 10525 | 10:47:00 INFO - PROCESS | 10525 | __start_tp_report 10:47:00 INFO - PROCESS | 10525 | _x_x_mozilla_page_load 10:47:00 INFO - PROCESS | 10525 | _x_x_mozilla_page_load_details 10:47:00 INFO - PROCESS | 10525 | |i|pagename|runs| 10:47:00 INFO - PROCESS | 10525 | |0;dojo.html;3297.637259901411;3301;3318.7179089777383;3336.1326055225636;3336.683015113565;5758.366579676237;5797.217375654291;5805.419458054193;5836.737346819393;5865.472107510323;5768.798092066779;5786.363500014995;5813.82558523245;5829.067349224125;5840.503557197643;5328.92006619901;5338.119210330291;5354.678719276836;5395.352557693082;5401.378841433247;5220.190870415092;5226.137687281594;5282.550983166436;5331.546818520411;5332.893342133155;5377.4084850666395;5377.542908852733;5379.462053794628;5447.564194864422;5454.59090568207;5368.194770784414;5423.701696406696;5441.782328706847;5443.237946687467;5475.0966090595;5128.051310507568;5160.896782064376;5190.688558686453;5199.948000519984;5297.708626025567;5699.173619825144;5790.7683692652245;5791.5656325775735;5807.128930660392;5807.245058142456;6208.161898143783;6211.658358790265;6237.937620623827;6243.250809902841;6245.0320200369015;5946.672932988684;6039.1545183674325;6118.131909153803;6131.14164017038;6301.747930082791;5792.073268277098;5799.623024503436;5800.970995144998;5801.680907550083;5803.274590676166;6298.02380631003;6321.589096708699;6323;6323.620582764956;6349.9682501587195;5916.9645312070215;6053.394660534;6057.57596968208;6073.39266073398;6111.877762444727;6261.279952805395;6275.843103922439;6292.1505596743855;6302.180716506825;6304.621722696653;6204.503639708812;6248.281447633581;6260.906086408708;6271.62370257786;6289.842753931097;6001.639901605918;6114.7283117296465;6131.101423540749;6143.846403839851;6282.465990390868;4756.571908528249;4760.9525904301;4770.570648641639;4773.1408346497965;4794.5924596409695;4242.7242229255;4247.660187185018;4266.893327666833;4275.978620106879;4292.828286868553;5690.687012214368;5887.76448942046;5951.464368206882;5974.3726908674835;6060.727267272895;6228.128062071313;6278.843028924313;6294.590851594723;6302.621842689453;6305.905411418832;6029.909551356734;6062.636241825505;6066.423689749467;6080.966235739935;6085.995810691186;4988.5260900214425;5007;5036.395632524121;5174;5306.257124002643;6436.356364363526;6559.311272316338;6563.212414510289;6563.671816409256;6575.572587781779;6264.812055638338;6272.310045895039;6305.337939516285;6313.305536390902;6325.335839736761;6112.1387513176505;6365.108884756045;6548.770793022221;6552.312007239362;6562.278149403657;6036.6679832609625;6183.96908015457;6191.907121393093;6193.163922870355;6194;6271.717772700331;6273.498120150286;6278.246610406781;6293.150424692608;6300.621962682254;5937.079752638348;6031.879362412815;6097.390260973867;6156.815295541141;6169.290531588925;5975.970120149372;6084.056971169476;6130.448259656652;6134.754609815557;6139.2325959255095;6008.609440386361;6044.939550604614;6071.878562428638;6076.179715738319;6100.664463454553;5884.58807883444;6021.126936594257;6091.0558863376245;6099.420555047263;6180.938190618036;5877.529797616266;5958.731857066529;5966.970165149147;5985.491233245223;6005.609635373687 10:47:00 INFO - PROCESS | 10525 | |1;ext.html;565.5588640860128;604.9243844519435;620.5718054542366;633.8066889598672;673.030835596741;42615;46997.76501117494;47155;47296.290555641695;47414.52585474144;47284.76357618216;47645.28532072021;47906.041879162396;48013.27980080293;48153;9141.45151290923;9213.12475314844;9237.261019118454;9250.213731832768;9280.211182049534;9121.589528471202;9257.490838003907;9259.6296148154;9260.166585007348;9272.953635231814;9297.581608827586;9326.673566425177;9365.297602679791;9371.906280937172;9380.765480862965;9237.861432078524;9269.860952085724;9272.814543709123;9296.256299496024;9341.065893410605;9197.816043679155;9243;9254.167124958718;9267.490288034156;9271.67549135777;45143.322850157274;45250.09499810018;45294;45437.545624543665;45589.54410455886;3785.734998550103;3866.3620502617036;3915.647591716731;4462.866114016552;4758.428988521399;35167;35277;35510.11224719377;36367;36788;4735.1713450146435;4747.121782470254;4844.176489996709;4864.1974074277705;4875.58557522611;410781;412616;413558;415546;415862.999999997;66522.66738666275;67110;67141;67416.6629166851;67446;38961.61038389637;39448.605513944494;39528.20943581112;70710.64644676847;71117.28882711107;17672.823271767116;17729.202185901664;17754.467365979042;17765.289388424575;17798.37705680295;13242.20546767197;13427.462901483832;13442.663933401547;13445.394957226948;13478.932605336911;20704;21031.8948405257;21053.26313579048;21141.89429052845;21192.470188245108;7605.315521603082;7805.453618246782;7880.093789214199;7929;7952.244536768998;1067.5889782433665;1145.2670291013758;1186.0689358853258;1195.5277665322149;1210.7396909664465;34145.65854341425;34413.31173376569;35190.824045879606;35505.64494355075;35569.46645800315;1194;1238.8389509363726;1257.9245245285313;1259.3829023778283;1260.3446207971804;18479.81520184808;18486.445406637824;18581.721274180898;18619.44141675752;18694.71957920632;651028;652322;653084;654689;656288;66996.66501667559;67417;67683;67872;67949;1436.2531483628454;1454.5418193269086;1474.0787008119926;1476.9414754466125;1489.8435664255096;34421;34528.48207276843;34803.65196348004;34903.47644785381;34935;57550.42449575618;57672.71163644323;57688.134677979026;58094;58483.4151658478;515751;519176;523346;523361;525344;31302.686973129978;31497.21256968594;31501.52747708832;31913.840430797696;32077.198070048435;53729;54583.454165457835;54776;55067;55895.16157257563;44848.32727509155;48960.510394895595;49549.25676114789;49576.256356155405;50440.495595045046;45816;46408.76795616;47493.52506474891;47640.52359476361;48138;46230.53769462397;49425.50574494209;50952.490475094775;51292;51789;43817.34273985829;43998;44298.335524966504;48740.512594873595;50011;37405;37864.43203351897;37978.8101059504;38457;38766.22467550577 10:47:00 INFO - PROCESS | 10525 | |2;jquery.html;415.56365815893315;418.8973701443145;423.92369373512753;426.567034460023;446.34833143610325;19439.902800485994;20296.69554956675;21071.789282107173;21183.470413239676;21200.57598848022;20219.090140943656;20234.39296821094;20435.386938391835;20488.385348439533;20645.896770516163;5887.264091988502;6043.153958445821;6104.694765261741;6111.816645500642;6119.326874043873;5982;5985;6013.398660133996;6027.638341699512;6052.303985041711;5953.166556682047;5970.492508136814;5970.6119102258435;5979.671118088503;5979.880402391949;5779.248697669297;5917.230760001194;5929.584929054968;5982.999999999956;5989.041753319491;5171.948280517185;5206.245094461282;5356.4375740547075;5367.087595108841;5379.273798037254;14582.562523124323;14780.778288325684;20860.37418877421;21882.343529694135;23687.644685329735;2388.6297623868327;2462.729099799021;2478.3556275368355;2486.639437281602;2602.258356368426;10901.945490272497;10908.34549926999;11020.50407731654;11173.888261117367;11239.887601124048;2009.6836572045188;2023.0693880814842;2053.394248696623;2073.533454972634;2083.895535366258;78209.60895195487;86458.5677071617;90696.54651726765;92276;92387;11556.537738490535;11878.40607969598;11903.88096119045;12014.75970480603;12209.938950305192;16470.341186352653;16479.093649849372;16525.91737041331;16542.255598498097;16590.75113873293;8246.917530824734;8541.103184165697;8575.528345941033;8647.913520864837;8676.8698469523;8043.47717398379;8090.676372945016;8105.8378832424205;8318.209770071833;8356.456830306011;5023.8492845214705;5070.467600901926;5092.9236061459105;5180.430152683201;5217.06092903281;1788.2399980008445;1859.4421673497895;1875.7092650639172;1876.587150826816;1886.4906475251605;945.6217512994857;1039.3192458939407;1058.312097136852;1084.1868598551087;1117.6702872652586;20349.389518314474;21048.368548943556;21164;21179.47051323729;21585.136594536358;1029.4389557691077;1044.6657069737762;1075.7579544602402;1094.414488248783;1104.5968221599057;11489.827652585218;11746;11771;11958.222715523463;12003.1597788154;445926;449309;450713;577020;578032;103383;104410;106825.46587267015;106964;109211;1036.5905467340358;1045.3205416479198;1081.6538707613488;1083.8970297821695;1089.8746644135867;15445.691086177989;17963.5509112268;18798;18838.905805470884;19678.11448484793;31602;39088.6091139085;42029.579704202566;45563.54436455593;46649.30026049544;57213;61910;62059.6897015512;64107.35892641014;64473;9038.502882341272;9086.500242486727;9145.3598248122;9165.908340916772;9419.058094190526;7724.1889601593275;10673;13280.80078798838;13934.512292069729;14435.78346324785;11668.94165529167;12204.450799713857;12612.87387126117;12883.48466061347;13139.408726607517;11671.88328116708;12151.81772273399;12611.87388126107;12901.354932253538;13186.538471153464;12328.568500102454;12339.876601234231;12377.62867113988;12405.44175512086;12533.74932501363;8382.077971423018;8393.83212335762;8457.830843382975;8603.870941936002;8652.394332396672;9095.863562046443;12226.938865305972;12453.377331133588;12501.56244531437;12727.87272127304 10:47:00 INFO - PROCESS | 10525 | |3;mootools.html;1522.3758259113763;1530.0131415237172;1732.410980266709;1808.7648605681259;1856.675081860675;8823.955880220607;9216.861747073783;9559.235261179107;10304.639337623184;10305.948470257657;9433.24534037277;9640.084192001766;9856.655017074403;9911.603535858576;9917.752056198598;2364.4325361913147;2434.342727463593;2435.1355268879556;2438.0247900839718;2441.24321460347;2385.0817435287368;2397.652340410639;2430.7569243075727;2447.730749617541;2453.9386515337083;2408.3256688127353;2432.1609044879488;2449.5590793657134;2492.389364605674;2495.0394098272113;2324.23300310897;2327.592671282519;2347.2371479269223;2350.388898886293;2353.870537120458;2296.5062511559927;2303.0557471436796;2303.6199027160496;2309.1340747219792;2318.26974503031;9916.25628077897;9952.35309704874;9992.300538962276;10039.29724919256;10070.597176112946;5548.278723765925;5616.213730077751;5680.772769089232;5710.942890571124;5718.628289161233;3585.2829434113282;3630.2013557017676;3644.5262115925025;3648.4892115103908;3726.217494326195;1307.2809954524973;1307.8430588329365;1308.2281453942219;1320.498210679945;1337.3981708231336;13698.794518082137;13807.861921380758;14103.717925641533;14137.151770893677;14220.786688199581;4815.807367705323;4851.830185943546;4855.732934688555;4969.801207951641;5026.597872170218;12106.213096148722;12121.515139394325;12121.575744848888;12133.757324853454;12158.148929574845;5602.13166959122;5620.100783874561;5626.690532020696;5650;5655.773769049274;4632.907341853144;5077.365329333833;5167.147420675622;5195.844124676266;5248.475152484721;4314.094040251583;4442.622377097919;4497.875531117221;4539.500654927955;4551.180787458223;1291.3091496049756;1359.1776974930222;1362.046567402822;1374.2372982994534;1376.593904798087;930.2929773372285;1021.1116328793996;1042.7288904884633;1043.2280112716687;1054.894510548939;6494.967525162344;6508;6543.607383557001;6594.538382313288;6726.764563240263;452.8075567883636;455.9954400455953;457.8557754307449;1072.7157303314627;1157.1437136518916;4209.663226941837;4369.710935274102;4393.0994146199955;4418.270985287391;4478.104379124123;12302;12471.75056498865;12768.361581920866;12781.424835882222;12811.679708007374;11750.118741094451;12316.876831231752;12602.432890519765;12625.431855566521;12639.1784534005;8984.505852178192;9158.81682366349;9162.450252984841;9173.312001599907;9209.079092090871;6417.422431981144;6530.346965303432;6617.43751781104;6673.499487538551;6739.359760822714;11209.15931305139;11565.190436669352;11619.709507262049;11741.765164696488;11968.521259149536;11516.19386642927;11734.70663233426;11936;11996.64010079699;12041;7898.447108702336;8211.425200236165;8492.447990880573;8802.163794439773;9027.32295077885;9889.851652225367;9897.505124743879;9957;9960.501974901372;10004.599816007278;8359.373047021376;8434.240918317135;8473.533955632252;8527.189916958127;8564.700235491728;8295.668173273001;8307.875381869157;8336.874946875923;8441.071482136836;8483.36374771907;7322.780316590511;7631.618419078913;7721.112072111779;7723.729669461542;7738.264864837832;5585.3297604287745;5742.368339482737;5752.022156233366;5793.452140070025;5830.650160990354;5553.6390134641115;5632.633878797865;5687.744051517609;5759.395263497272;5768.913466298093 10:47:00 INFO - PROCESS | 10525 | |4;prototype.html;344.73799912066823;348.56565234061844;352.2092901436276;356.85627563658477;360.8394264552275;5829.766809327622;5862.267216597926;5866.120081987704;5877.735501902414;5911.113333000047;5748.798792042279;5769.278840144982;5781.855453613652;5823.330317013545;5857.414258574151;4350.5649435056475;4455.242608756519;4511.278195488722;4533.773311334437;4535.750533720644;4490.8877278067985;4504.954950450487;4509.684322097454;4514.9774251128865;4541.613962813165;4453.51011388747;4483.843065492709;4510.909781804362;4513.954860451387;4542.250528662767;4399.38408622793;4432.601065904052;4457.10857828434;4475.328700694889;4491.169133710274;3895.9805200974097;3935.232629637222;3936.8228429720443;3940.6059394060653;3942.0342016205927;5605.831825045255;5645.096784514499;5650.51970582501;5658.717064146817;5698.914516282259;5086.593072554187;5126.794928202868;5141.460146684619;5195.415398303516;5195.922061169085;5974.4921681657115;5978.701064946778;5981.91027134589;6002.729877155539;6028.728707208186;4324.070324880166;4360.193364227628;4380.802863871133;4390.297552391602;4399.428074350314;6080.875038117918;6106.603070800384;6275.843103922392;6299.68501574924;6356.332585078592;4387;4388.648908087345;4391.912161756811;4395;4421;4451.643868490513;4476.776161191992;4487.798049087799;4487.820487180542;4492.191405546968;4887.535684110004;4996.925046124311;5133.281340612317;5134.178531434953;5174.120399532088;6008.669523176267;6018.488428483541;6031.668258245751;6052.576319657582;6090.294717479113;1543.1821134798574;1556.704226197019;1559.469780274712;1560.087348900883;1580.4073472447833;950.3062764182185;981.65642025292;1002.8445590933417;1012.3318609717551;1013.9493025348703;5155.793768249303;5226.876221612371;5270.631055826056;5318.680879147263;5331.667707682698;5525.430674736267;5536;5550.639208451437;5587.189857470726;5588.133839254922;4909.159065350494;5192.948070519322;5222.3472065991755;5234.790608375699;5308.336457942757;2976.9851150744107;2995.7603391728608;2996.865141068657;3000.489916714164;3002.2794529313246;5638.915416268759;5663.518600918886;5675.4324567543745;5772.604369186824;5791.102379131242;5896.587238893237;6327.4938004959495;6366.649834259068;6420.903686444707;6426.196725409324;6490.383413575702;6503.9349606504275;6518.902216466662;6520.5435619507125;6545.345465453512;6025.939740602538;6243.282022567463;6311.538499985101;6312.274088479883;6336.17629708135;6186.133941248138;6218.502519798496;6223.0397424811035;6241.31345551998;6265.496280892644;6326.3939554455355;6487.44856687168;6503.707333169924;6539.4768418525455;6546.214454265519;4467.2182368086105;4500.887477813081;4513.97743011296;4516.88707782308;4518.728876267303;6129;6321.905171422524;6323.7786677466065;6343.397377249154;6404.231492220963;6174.363793594611;6185.350538193425;6188.195534580475;6199.628022318675;6229.037853076266;5944.64332140073;6135.417135372132;6139.26328840542;6147.354527774519;6198.876022479615;6047.78832740852;6080.4831589313635;6088.086786981989;6097.414672185175;6099;6211.689415529115;6231;6233.96883015582;6237.407446292595;6257.2491301044165;5786.222613145629;5997.860406522746;6006.759729610767;6010.819675409744;6025.638461692312 10:47:00 INFO - PROCESS | 10525 | |5;yui.html;803.6222975201654;812.7886749445146;831.1273163178661;856.4133568505574;904.8733177355175;15691.764623530642;16413.753793693104;17047.57381065474;17199.226034828433;17403.65192696147;15650.530484085495;15858.762118568231;15859.920700396511;15968.121753303592;16019.038857668518;867.4014929698487;873.4104479476343;880.9515476648781;884.5621417398364;886.8403687336277;901.2564634176798;902.7291812456269;902.9683961061364;903.3992395057279;904.1726819959729;937.3953799799125;938.9530523473833;939.4457270210575;940.4968341937065;940.6801687426274;928.9674861379887;934.8597710343503;936.2556767369923;936.536414474836;936.8969413364524;688.7933619914056;690.0477341269067;695.9338862808025;696.1124566178113;696.6621188723465;15390.538283851502;15504.922475387551;15547.911646184772;15560.61098472536;15658.530244092695;15594.922025389915;15749.448769293134;15868.603284917854;16048.197590120564;16124.59688507785;12142.332171730552;12232.510699572007;12481.438335274934;12574.937125314407;12757.107002509829;3971.8609848655447;4028.154087641599;4035.7578545287083;4039.63643272104;4121.237571049335;87646.5617671914;87875.56062219712;88347;88537;88729.78175545663;11661.358625275521;11883.524659013716;11942.741919383512;12084.516619335303;12650.873491265154;21837.126514939544;22163.667544986838;22292.331230063122;22358.329250122522;23290.65064024007;8534.445261058012;8615.095414981462;8820.073892241351;8842.867356989651;9038.502882341403;4982.128127577659;5015.498450154955;5076.263941728429;5131.871703207375;5221.13851214553;3569.23261498779;3698.926021479609;3699.8150092495266;3723.162288485069;3732.3654978653694;632.5161251642497;635.2218532297898;642.6240649220258;654.018971542686;655.367570294668;699.3600855217419;716.9390601798906;723.7322190789441;741.1735914455344;743.605888878895;9273.35086543949;9974.45140517264;10187.745306367251;10189.796204075878;10510.579576816994;631.6930866911714;663.1048085085097;681.6387314723205;705.9858802823915;718.1489934427719;4783.972195034282;4845.176320025604;4895.583875370562;4926.975365123223;4943.1596628573225;124990;129098;130110;130675.34662326628;132002;31625.683743162735;32437.675623243937;41103;105570.4721476403;108727;96526;98009.01990980141;98112.50943745236;101031;101342.49328753309;9188.95405522968;9356.251499879858;9371;9583.856242156513;9592.76018099553;54661.72669136629;56195.438045620656;56313.43686563082;56421.71789141028;56994.7150264246;79011;81326;81500.59249703714;83233.16766832254;85082;11686.18196726255;11782.941085294862;11914.285142891455;12128.514859405524;12272.631821045383;12917.935410322889;12999.545015924397;13004.089713719948;13034.47862085506;13091.738165236833;12974.091813572959;12978.221306721627;12997.675058123623;13008.21950682962;13270.402831872396;12690.555830545887;12702.920251778332;12710.428030738824;12740.554080607135;12774.297413642338;12400.441980110736;12893.677658058623;12894.871051289367;12965.870341296466;12971.870281297066;9843.261755368232;10021.799564008825;10409.906233202651;10429.895701043197;10519.737006574896;10246.897531024595;10573.418461984666;10593.788124237319;10715.839262410915;10719.303245289031 10:47:00 INFO - PROCESS | 10525 | __end_tp_report 10:47:00 INFO - PROCESS | 10525 | __start_cc_report 10:47:00 INFO - PROCESS | 10525 | _x_x_mozilla_cycle_collect,340 10:47:00 INFO - PROCESS | 10525 | __end_cc_report 10:47:00 INFO - PROCESS | 10525 | __startTimestamp1473097620765__endTimestamp 10:47:00 INFO - PROCESS | 10525 | 10:47:00 INFO - PROCESS | 10525 | ------- Summary: start ------- 10:47:00 INFO - PROCESS | 10525 | Number of tests: 6 10:47:00 INFO - PROCESS | 10525 | 10:47:00 INFO - PROCESS | 10525 | [#0] dojo.html Cycles:165 Average:5785.59 Median:6029.91 stddev:668.62 (11.1%) stddev-sans-first:641.55 10:47:00 INFO - PROCESS | 10525 | Values: 3297.6 3301.0 3318.7 3336.1 3336.7 5758.4 5797.2 5805.4 5836.7 5865.5 5768.8 5786.4 5813.8 5829.1 5840.5 5328.9 5338.1 5354.7 5395.4 5401.4 5220.2 5226.1 5282.6 5331.5 5332.9 5377.4 5377.5 5379.5 5447.6 5454.6 5368.2 5423.7 5441.8 5443.2 5475.1 5128.1 5160.9 5190.7 5199.9 5297.7 5699.2 5790.8 5791.6 5807.1 5807.2 6208.2 6211.7 6237.9 6243.3 6245.0 5946.7 6039.2 6118.1 6131.1 6301.7 5792.1 5799.6 5801.0 5801.7 5803.3 6298.0 6321.6 6323.0 6323.6 6350.0 5917.0 6053.4 6057.6 6073.4 6111.9 6261.3 6275.8 6292.2 6302.2 6304.6 6204.5 6248.3 6260.9 6271.6 6289.8 6001.6 6114.7 6131.1 6143.8 6282.5 4756.6 4761.0 4770.6 4773.1 4794.6 4242.7 4247.7 4266.9 4276.0 4292.8 5690.7 5887.8 5951.5 5974.4 6060.7 6228.1 6278.8 6294.6 6302.6 6305.9 6029.9 6062.6 6066.4 6081.0 6086.0 4988.5 5007.0 5036.4 5174.0 5306.3 6436.4 6559.3 6563.2 6563.7 6575.6 6264.8 6272.3 6305.3 6313.3 6325.3 6112.1 6365.1 6548.8 6552.3 6562.3 6036.7 6184.0 6191.9 6193.2 6194.0 6271.7 6273.5 6278.2 6293.2 6300.6 5937.1 6031.9 6097.4 6156.8 6169.3 5976.0 6084.1 6130.4 6134.8 6139.2 6008.6 6044.9 6071.9 6076.2 6100.7 5884.6 6021.1 6091.1 6099.4 6180.9 5877.5 5958.7 5967.0 5985.5 6005.6 10:47:00 INFO - PROCESS | 10525 | 10:47:00 INFO - PROCESS | 10525 | [#1] ext.html Cycles:180 Average:70357.93 Median:26080.82 stddev:143178.05 (549.0%) stddev-sans-first:143483.82 10:47:00 INFO - PROCESS | 10525 | Values: 565.6 604.9 620.6 633.8 673.0 42615.0 46997.8 47155.0 47296.3 47414.5 47284.8 47645.3 47906.0 48013.3 48153.0 9141.5 9213.1 9237.3 9250.2 9280.2 9121.6 9257.5 9259.6 9260.2 9273.0 9297.6 9326.7 9365.3 9371.9 9380.8 9237.9 9269.9 9272.8 9296.3 9341.1 9197.8 9243.0 9254.2 9267.5 9271.7 45143.3 45250.1 45294.0 45437.5 45589.5 3785.7 3866.4 3915.6 4462.9 4758.4 35167.0 35277.0 35510.1 36367.0 36788.0 4735.2 4747.1 4844.2 4864.2 4875.6 410781.0 412616.0 413558.0 415546.0 415863.0 66522.7 67110.0 67141.0 67416.7 67446.0 38961.6 39448.6 39528.2 70710.6 71117.3 17672.8 17729.2 17754.5 17765.3 17798.4 13242.2 13427.5 13442.7 13445.4 13478.9 20704.0 21031.9 21053.3 21141.9 21192.5 7605.3 7805.5 7880.1 7929.0 7952.2 1067.6 1145.3 1186.1 1195.5 1210.7 34145.7 34413.3 35190.8 35505.6 35569.5 1194.0 1238.8 1257.9 1259.4 1260.3 18479.8 18486.4 18581.7 18619.4 18694.7 651028.0 652322.0 653084.0 654689.0 656288.0 66996.7 67417.0 67683.0 67872.0 67949.0 1436.3 1454.5 1474.1 1476.9 1489.8 34421.0 34528.5 34803.7 34903.5 34935.0 57550.4 57672.7 57688.1 58094.0 58483.4 515751.0 519176.0 523346.0 523361.0 525344.0 31302.7 31497.2 31501.5 31913.8 32077.2 53729.0 54583.5 54776.0 55067.0 55895.2 44848.3 48960.5 49549.3 49576.3 50440.5 45816.0 46408.8 47493.5 47640.5 48138.0 46230.5 49425.5 50952.5 51292.0 51789.0 43817.3 43998.0 44298.3 48740.5 50011.0 37405.0 37864.4 37978.8 38457.0 38766.2 10:47:00 INFO - PROCESS | 10525 | 10:47:00 INFO - PROCESS | 10525 | [#2] jquery.html Cycles:180 Average:30221.32 Median:21171.74 stddev:83541.66 (394.6%) stddev-sans-first:83746.04 10:47:00 INFO - PROCESS | 10525 | Values: 415.6 418.9 423.9 426.6 446.3 19439.9 20296.7 21071.8 21183.5 21200.6 20219.1 20234.4 20435.4 20488.4 20645.9 5887.3 6043.2 6104.7 6111.8 6119.3 5982.0 5985.0 6013.4 6027.6 6052.3 5953.2 5970.5 5970.6 5979.7 5979.9 5779.2 5917.2 5929.6 5983.0 5989.0 5171.9 5206.2 5356.4 5367.1 5379.3 14582.6 14780.8 20860.4 21882.3 23687.6 2388.6 2462.7 2478.4 2486.6 2602.3 10901.9 10908.3 11020.5 11173.9 11239.9 2009.7 2023.1 2053.4 2073.5 2083.9 78209.6 86458.6 90696.5 92276.0 92387.0 11556.5 11878.4 11903.9 12014.8 12209.9 16470.3 16479.1 16525.9 16542.3 16590.8 8246.9 8541.1 8575.5 8647.9 8676.9 8043.5 8090.7 8105.8 8318.2 8356.5 5023.8 5070.5 5092.9 5180.4 5217.1 1788.2 1859.4 1875.7 1876.6 1886.5 945.6 1039.3 1058.3 1084.2 1117.7 20349.4 21048.4 21164.0 21179.5 21585.1 1029.4 1044.7 1075.8 1094.4 1104.6 11489.8 11746.0 11771.0 11958.2 12003.2 445926.0 449309.0 450713.0 577020.0 578032.0 103383.0 104410.0 106825.5 106964.0 109211.0 1036.6 1045.3 1081.7 1083.9 1089.9 15445.7 17963.6 18798.0 18838.9 19678.1 31602.0 39088.6 42029.6 45563.5 46649.3 57213.0 61910.0 62059.7 64107.4 64473.0 9038.5 9086.5 9145.4 9165.9 9419.1 7724.2 10673.0 13280.8 13934.5 14435.8 11668.9 12204.5 12612.9 12883.5 13139.4 11671.9 12151.8 12611.9 12901.4 13186.5 12328.6 12339.9 12377.6 12405.4 12533.7 8382.1 8393.8 8457.8 8603.9 8652.4 9095.9 12226.9 12453.4 12501.6 12727.9 10:47:00 INFO - PROCESS | 10525 | 10:47:00 INFO - PROCESS | 10525 | [#3] mootools.html Cycles:180 Average:6455.75 Median:4430.45 stddev:3842.35 (86.7%) stddev-sans-first:3835.24 10:47:00 INFO - PROCESS | 10525 | Values: 1522.4 1530.0 1732.4 1808.8 1856.7 8824.0 9216.9 9559.2 10304.6 10305.9 9433.2 9640.1 9856.7 9911.6 9917.8 2364.4 2434.3 2435.1 2438.0 2441.2 2385.1 2397.7 2430.8 2447.7 2453.9 2408.3 2432.2 2449.6 2492.4 2495.0 2324.2 2327.6 2347.2 2350.4 2353.9 2296.5 2303.1 2303.6 2309.1 2318.3 9916.3 9952.4 9992.3 10039.3 10070.6 5548.3 5616.2 5680.8 5710.9 5718.6 3585.3 3630.2 3644.5 3648.5 3726.2 1307.3 1307.8 1308.2 1320.5 1337.4 13698.8 13807.9 14103.7 14137.2 14220.8 4815.8 4851.8 4855.7 4969.8 5026.6 12106.2 12121.5 12121.6 12133.8 12158.1 5602.1 5620.1 5626.7 5650.0 5655.8 4632.9 5077.4 5167.1 5195.8 5248.5 4314.1 4442.6 4497.9 4539.5 4551.2 1291.3 1359.2 1362.0 1374.2 1376.6 930.3 1021.1 1042.7 1043.2 1054.9 6495.0 6508.0 6543.6 6594.5 6726.8 452.8 456.0 457.9 1072.7 1157.1 4209.7 4369.7 4393.1 4418.3 4478.1 12302.0 12471.8 12768.4 12781.4 12811.7 11750.1 12316.9 12602.4 12625.4 12639.2 8984.5 9158.8 9162.5 9173.3 9209.1 6417.4 6530.3 6617.4 6673.5 6739.4 11209.2 11565.2 11619.7 11741.8 11968.5 11516.2 11734.7 11936.0 11996.6 12041.0 7898.4 8211.4 8492.4 8802.2 9027.3 9889.9 9897.5 9957.0 9960.5 10004.6 8359.4 8434.2 8473.5 8527.2 8564.7 8295.7 8307.9 8336.9 8441.1 8483.4 7322.8 7631.6 7721.1 7723.7 7738.3 5585.3 5742.4 5752.0 5793.5 5830.7 5553.6 5632.6 5687.7 5759.4 5768.9 10:47:00 INFO - PROCESS | 10525 | 10:47:00 INFO - PROCESS | 10525 | [#4] prototype.html Cycles:180 Average:5046.19 Median:5647.81 stddev:1500.42 (26.6%) stddev-sans-first:1462.55 10:47:00 INFO - PROCESS | 10525 | Values: 344.7 348.6 352.2 356.9 360.8 5829.8 5862.3 5866.1 5877.7 5911.1 5748.8 5769.3 5781.9 5823.3 5857.4 4350.6 4455.2 4511.3 4533.8 4535.8 4490.9 4505.0 4509.7 4515.0 4541.6 4453.5 4483.8 4510.9 4514.0 4542.3 4399.4 4432.6 4457.1 4475.3 4491.2 3896.0 3935.2 3936.8 3940.6 3942.0 5605.8 5645.1 5650.5 5658.7 5698.9 5086.6 5126.8 5141.5 5195.4 5195.9 5974.5 5978.7 5981.9 6002.7 6028.7 4324.1 4360.2 4380.8 4390.3 4399.4 6080.9 6106.6 6275.8 6299.7 6356.3 4387.0 4388.6 4391.9 4395.0 4421.0 4451.6 4476.8 4487.8 4487.8 4492.2 4887.5 4996.9 5133.3 5134.2 5174.1 6008.7 6018.5 6031.7 6052.6 6090.3 1543.2 1556.7 1559.5 1560.1 1580.4 950.3 981.7 1002.8 1012.3 1013.9 5155.8 5226.9 5270.6 5318.7 5331.7 5525.4 5536.0 5550.6 5587.2 5588.1 4909.2 5192.9 5222.3 5234.8 5308.3 2977.0 2995.8 2996.9 3000.5 3002.3 5638.9 5663.5 5675.4 5772.6 5791.1 5896.6 6327.5 6366.6 6420.9 6426.2 6490.4 6503.9 6518.9 6520.5 6545.3 6025.9 6243.3 6311.5 6312.3 6336.2 6186.1 6218.5 6223.0 6241.3 6265.5 6326.4 6487.4 6503.7 6539.5 6546.2 4467.2 4500.9 4514.0 4516.9 4518.7 6129.0 6321.9 6323.8 6343.4 6404.2 6174.4 6185.4 6188.2 6199.6 6229.0 5944.6 6135.4 6139.3 6147.4 6198.9 6047.8 6080.5 6088.1 6097.4 6099.0 6211.7 6231.0 6234.0 6237.4 6257.2 5786.2 5997.9 6006.8 6010.8 6025.6 10:47:00 INFO - PROCESS | 10525 | 10:47:00 INFO - PROCESS | 10525 | [#5] yui.html Cycles:180 Average:21307.51 Median:4037.70 stddev:31894.85 (789.9%) stddev-sans-first:31947.17 10:47:00 INFO - PROCESS | 10525 | Values: 803.6 812.8 831.1 856.4 904.9 15691.8 16413.8 17047.6 17199.2 17403.7 15650.5 15858.8 15859.9 15968.1 16019.0 867.4 873.4 881.0 884.6 886.8 901.3 902.7 903.0 903.4 904.2 937.4 939.0 939.4 940.5 940.7 929.0 934.9 936.3 936.5 936.9 688.8 690.0 695.9 696.1 696.7 15390.5 15504.9 15547.9 15560.6 15658.5 15594.9 15749.4 15868.6 16048.2 16124.6 12142.3 12232.5 12481.4 12574.9 12757.1 3971.9 4028.2 4035.8 4039.6 4121.2 87646.6 87875.6 88347.0 88537.0 88729.8 11661.4 11883.5 11942.7 12084.5 12650.9 21837.1 22163.7 22292.3 22358.3 23290.7 8534.4 8615.1 8820.1 8842.9 9038.5 4982.1 5015.5 5076.3 5131.9 5221.1 3569.2 3698.9 3699.8 3723.2 3732.4 632.5 635.2 642.6 654.0 655.4 699.4 716.9 723.7 741.2 743.6 9273.4 9974.5 10187.7 10189.8 10510.6 631.7 663.1 681.6 706.0 718.1 4784.0 4845.2 4895.6 4927.0 4943.2 124990.0 129098.0 130110.0 130675.3 132002.0 31625.7 32437.7 41103.0 105570.5 108727.0 96526.0 98009.0 98112.5 101031.0 101342.5 9189.0 9356.3 9371.0 9583.9 9592.8 54661.7 56195.4 56313.4 56421.7 56994.7 79011.0 81326.0 81500.6 83233.2 85082.0 11686.2 11782.9 11914.3 12128.5 12272.6 12917.9 12999.5 13004.1 13034.5 13091.7 12974.1 12978.2 12997.7 13008.2 13270.4 12690.6 12702.9 12710.4 12740.6 12774.3 12400.4 12893.7 12894.9 12965.9 12971.9 9843.3 10021.8 10409.9 10429.9 10519.7 10246.9 10573.4 10593.8 10715.8 10719.3 10:47:00 INFO - PROCESS | 10525 | -------- Summary: end -------- 10:47:00 INFO - PROCESS | 10525 | 10:47:01 INFO - TEST-INFO | 10525: exit 0 10:47:01 INFO - TEST-OK | dromaeo_css | took 1111707ms 10:47:01 INFO - TEST-START | kraken 10:47:01 INFO - operating with platform_type : linux_ 10:47:01 INFO - Initialising browser for kraken test... 10:47:01 INFO - TEST-INFO | started process 10796 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLE_WGB/profile http://localhost:57637/getInfo.html) 10:47:06 INFO - PROCESS | 10796 | __metrics Screen width/height:1600/1200 10:47:06 INFO - PROCESS | 10796 | colorDepth:24 10:47:06 INFO - PROCESS | 10796 | Browser inner width/height: 1024/697 10:47:06 INFO - PROCESS | 10796 | __metrics 10:47:07 ERROR - PROCESS | 10796 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 10:47:07 INFO - TEST-INFO | 10796: exit 0 10:47:07 INFO - Browser initialized. 10:47:07 INFO - Running cycle 1/1 for kraken test... 10:47:07 INFO - TEST-INFO | started process 10920 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLE_WGB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:47:19 INFO - PROCESS | 10920 | RSS: Main: 152944640 10:47:19 INFO - PROCESS | 10920 | 10:47:22 INFO - PROCESS | 10920 | Cycle 1(1): loaded http://localhost:57637/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57637/tests/kraken/driver.html?testName=audio-beat-detection) 10:47:23 INFO - PROCESS | 10920 | RSS: Main: 158183424 10:47:23 INFO - PROCESS | 10920 | 10:47:25 INFO - PROCESS | 10920 | Cycle 1(1): loaded http://localhost:57637/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57637/tests/kraken/driver.html?testName=audio-dft) 10:47:26 INFO - PROCESS | 10920 | RSS: Main: 156250112 10:47:26 INFO - PROCESS | 10920 | 10:47:29 INFO - PROCESS | 10920 | Cycle 1(1): loaded http://localhost:57637/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57637/tests/kraken/driver.html?testName=audio-fft) 10:47:29 INFO - PROCESS | 10920 | RSS: Main: 157716480 10:47:29 INFO - PROCESS | 10920 | 10:47:32 INFO - PROCESS | 10920 | Cycle 1(1): loaded http://localhost:57637/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57637/tests/kraken/driver.html?testName=audio-oscillator) 10:47:32 INFO - PROCESS | 10920 | RSS: Main: 156778496 10:47:32 INFO - PROCESS | 10920 | 10:47:34 INFO - PROCESS | 10920 | Cycle 1(1): loaded http://localhost:57637/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57637/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:47:35 INFO - PROCESS | 10920 | RSS: Main: 156577792 10:47:35 INFO - PROCESS | 10920 | 10:47:38 INFO - PROCESS | 10920 | Cycle 1(1): loaded http://localhost:57637/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57637/tests/kraken/driver.html?testName=imaging-darkroom) 10:47:39 INFO - PROCESS | 10920 | RSS: Main: 156303360 10:47:39 INFO - PROCESS | 10920 | 10:47:42 INFO - PROCESS | 10920 | Cycle 1(1): loaded http://localhost:57637/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57637/tests/kraken/driver.html?testName=imaging-desaturate) 10:47:43 INFO - PROCESS | 10920 | RSS: Main: 156618752 10:47:43 INFO - PROCESS | 10920 | 10:47:46 INFO - PROCESS | 10920 | Cycle 1(1): loaded http://localhost:57637/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57637/tests/kraken/driver.html?testName=json-parse-financial) 10:47:46 INFO - PROCESS | 10920 | RSS: Main: 157663232 10:47:46 INFO - PROCESS | 10920 | 10:47:48 INFO - PROCESS | 10920 | Cycle 1(1): loaded http://localhost:57637/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57637/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:47:48 INFO - PROCESS | 10920 | RSS: Main: 157433856 10:47:48 INFO - PROCESS | 10920 | 10:47:50 INFO - PROCESS | 10920 | Cycle 1(1): loaded http://localhost:57637/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57637/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:47:51 INFO - PROCESS | 10920 | RSS: Main: 156995584 10:47:51 INFO - PROCESS | 10920 | 10:47:53 INFO - PROCESS | 10920 | Cycle 1(1): loaded http://localhost:57637/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57637/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:47:53 INFO - PROCESS | 10920 | RSS: Main: 157118464 10:47:53 INFO - PROCESS | 10920 | 10:47:56 INFO - PROCESS | 10920 | Cycle 1(1): loaded http://localhost:57637/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57637/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:47:56 INFO - PROCESS | 10920 | RSS: Main: 157847552 10:47:56 INFO - PROCESS | 10920 | 10:47:59 INFO - PROCESS | 10920 | Cycle 1(1): loaded http://localhost:57637/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57637/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:48:00 INFO - PROCESS | 10920 | RSS: Main: 157700096 10:48:00 INFO - PROCESS | 10920 | 10:48:01 INFO - PROCESS | 10920 | Cycle 1(1): loaded http://localhost:57637/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57637/tests/kraken/driver.html?testName=ai-astar) 10:48:02 INFO - PROCESS | 10920 | RSS: Main: 158306304 10:48:02 INFO - PROCESS | 10920 | 10:48:02 INFO - PROCESS | 10920 | __start_tp_report 10:48:02 INFO - PROCESS | 10920 | _x_x_mozilla_page_load 10:48:02 INFO - PROCESS | 10920 | _x_x_mozilla_page_load_details 10:48:02 INFO - PROCESS | 10920 | |i|pagename|runs| 10:48:02 INFO - PROCESS | 10920 | |0;ai-astar;99;110;105;109;111;111;110;113;111;110 10:48:02 INFO - PROCESS | 10920 | |1;audio-beat-detection;154;115;142;169;121;148;147;121;181;117 10:48:02 INFO - PROCESS | 10920 | |2;audio-dft;163;162;161;161;163;168;162;162;163;162 10:48:02 INFO - PROCESS | 10920 | |3;audio-fft;78;75;84;194;75;75;76;76;172;75 10:48:02 INFO - PROCESS | 10920 | |4;audio-oscillator;83;84;138;84;83;83;141;83;84;143 10:48:02 INFO - PROCESS | 10920 | |5;imaging-gaussian-blur;117;117;117;117;117;117;118;118;119;117 10:48:02 INFO - PROCESS | 10920 | |6;imaging-darkroom;147;148;147;147;147;147;147;147;148;147 10:48:02 INFO - PROCESS | 10920 | |7;imaging-desaturate;95;96;97;96;96;96;95;95;96;95 10:48:02 INFO - PROCESS | 10920 | |8;json-parse-financial;53;53;53;53;52;53;55;53;51;58 10:48:02 INFO - PROCESS | 10920 | |9;json-stringify-tinderbox;64;62;61;61;63;60;60;60;61;60 10:48:02 INFO - PROCESS | 10920 | |10;stanford-crypto-aes;73;74;83;75;75;74;75;73;86;73 10:48:02 INFO - PROCESS | 10920 | |11;stanford-crypto-ccm;128;117;119;116;126;120;120;118;148;133 10:48:02 INFO - PROCESS | 10920 | |12;stanford-crypto-pbkdf2;157;154;152;153;152;150;152;151;154;151 10:48:02 INFO - PROCESS | 10920 | |13;stanford-crypto-sha256-iterative;64;71;62;61;63;62;62;66;62;64 10:48:02 INFO - PROCESS | 10920 | __end_tp_report 10:48:02 INFO - PROCESS | 10920 | __start_cc_report 10:48:02 INFO - PROCESS | 10920 | _x_x_mozilla_cycle_collect,855 10:48:02 INFO - PROCESS | 10920 | __end_cc_report 10:48:02 INFO - PROCESS | 10920 | __startTimestamp1473097682135__endTimestamp 10:48:02 INFO - PROCESS | 10920 | 10:48:02 INFO - PROCESS | 10920 | ------- Summary: start ------- 10:48:02 INFO - PROCESS | 10920 | Number of tests: 14 10:48:02 INFO - PROCESS | 10920 | 10:48:02 INFO - PROCESS | 10920 | [#0] ai-astar Cycles:10 Average:108.90 Median:111.00 stddev:4.04 (3.6%) stddev-sans-first:2.18 10:48:02 INFO - PROCESS | 10920 | Values: 99.0 110.0 105.0 109.0 111.0 111.0 110.0 113.0 111.0 110.0 10:48:02 INFO - PROCESS | 10920 | 10:48:02 INFO - PROCESS | 10920 | [#1] audio-beat-detection Cycles:10 Average:141.50 Median:147.50 stddev:22.82 (15.5%) stddev-sans-first:23.76 10:48:02 INFO - PROCESS | 10920 | Values: 154.0 115.0 142.0 169.0 121.0 148.0 147.0 121.0 181.0 117.0 10:48:02 INFO - PROCESS | 10920 | 10:48:02 INFO - PROCESS | 10920 | [#2] audio-dft Cycles:10 Average:162.70 Median:162.50 stddev:2.00 (1.2%) stddev-sans-first:2.12 10:48:02 INFO - PROCESS | 10920 | Values: 163.0 162.0 161.0 161.0 163.0 168.0 162.0 162.0 163.0 162.0 10:48:02 INFO - PROCESS | 10920 | 10:48:02 INFO - PROCESS | 10920 | [#3] audio-fft Cycles:10 Average:98.00 Median:75.50 stddev:45.18 (59.8%) stddev-sans-first:47.34 10:48:02 INFO - PROCESS | 10920 | Values: 78.0 75.0 84.0 194.0 75.0 75.0 76.0 76.0 172.0 75.0 10:48:02 INFO - PROCESS | 10920 | 10:48:02 INFO - PROCESS | 10920 | [#4] audio-oscillator Cycles:10 Average:100.60 Median:83.00 stddev:27.68 (33.3%) stddev-sans-first:28.61 10:48:02 INFO - PROCESS | 10920 | Values: 83.0 84.0 138.0 84.0 83.0 83.0 141.0 83.0 84.0 143.0 10:48:02 INFO - PROCESS | 10920 | 10:48:02 INFO - PROCESS | 10920 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 10:48:02 INFO - PROCESS | 10920 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 118.0 118.0 119.0 117.0 10:48:02 INFO - PROCESS | 10920 | 10:48:02 INFO - PROCESS | 10920 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 10:48:02 INFO - PROCESS | 10920 | Values: 147.0 148.0 147.0 147.0 147.0 147.0 147.0 147.0 148.0 147.0 10:48:02 INFO - PROCESS | 10920 | 10:48:02 INFO - PROCESS | 10920 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 10:48:02 INFO - PROCESS | 10920 | Values: 95.0 96.0 97.0 96.0 96.0 96.0 95.0 95.0 96.0 95.0 10:48:02 INFO - PROCESS | 10920 | 10:48:02 INFO - PROCESS | 10920 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:53.00 stddev:1.90 (3.6%) stddev-sans-first:2.01 10:48:02 INFO - PROCESS | 10920 | Values: 53.0 53.0 53.0 53.0 52.0 53.0 55.0 53.0 51.0 58.0 10:48:02 INFO - PROCESS | 10920 | 10:48:02 INFO - PROCESS | 10920 | [#9] json-stringify-tinderbox Cycles:10 Average:61.20 Median:61.00 stddev:1.40 (2.3%) stddev-sans-first:1.05 10:48:02 INFO - PROCESS | 10920 | Values: 64.0 62.0 61.0 61.0 63.0 60.0 60.0 60.0 61.0 60.0 10:48:02 INFO - PROCESS | 10920 | 10:48:02 INFO - PROCESS | 10920 | [#10] stanford-crypto-aes Cycles:10 Average:76.10 Median:75.00 stddev:4.56 (6.1%) stddev-sans-first:4.69 10:48:02 INFO - PROCESS | 10920 | Values: 73.0 74.0 83.0 75.0 75.0 74.0 75.0 73.0 86.0 73.0 10:48:02 INFO - PROCESS | 10920 | 10:48:02 INFO - PROCESS | 10920 | [#11] stanford-crypto-ccm Cycles:10 Average:124.50 Median:123.00 stddev:9.89 (8.0%) stddev-sans-first:10.41 10:48:02 INFO - PROCESS | 10920 | Values: 128.0 117.0 119.0 116.0 126.0 120.0 120.0 118.0 148.0 133.0 10:48:02 INFO - PROCESS | 10920 | 10:48:02 INFO - PROCESS | 10920 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.60 Median:152.50 stddev:2.01 (1.3%) stddev-sans-first:1.36 10:48:02 INFO - PROCESS | 10920 | Values: 157.0 154.0 152.0 153.0 152.0 150.0 152.0 151.0 154.0 151.0 10:48:02 INFO - PROCESS | 10920 | 10:48:02 INFO - PROCESS | 10920 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:63.50 stddev:2.95 (4.6%) stddev-sans-first:3.12 10:48:02 INFO - PROCESS | 10920 | Values: 64.0 71.0 62.0 61.0 63.0 62.0 62.0 66.0 62.0 64.0 10:48:02 INFO - PROCESS | 10920 | -------- Summary: end -------- 10:48:02 INFO - PROCESS | 10920 | 10:48:03 INFO - TEST-INFO | 10920: exit 0 10:48:03 INFO - TEST-OK | kraken | took 61558ms 10:48:03 INFO - SUITE-END | took 1173s 10:48:03 INFO - Completed test suite (00:19:33) 10:48:03 INFO - javascript benchmark 10:48:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7770.207161653499, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3297.637259901411, 3301.0, 3318.7179089777383, 3336.1326055225636, 3336.683015113565, 5758.366579676237, 5797.217375654291, 5805.419458054193, 5836.737346819393, 5865.472107510323, 5768.798092066779, 5786.363500014995, 5813.82558523245, 5829.067349224125, 5840.503557197643, 5328.92006619901, 5338.119210330291, 5354.678719276836, 5395.352557693082, 5401.378841433247, 5220.190870415092, 5226.137687281594, 5282.550983166436, 5331.546818520411, 5332.893342133155, 5377.4084850666395, 5377.542908852733, 5379.462053794628, 5447.564194864422, 5454.59090568207, 5368.194770784414, 5423.701696406696, 5441.782328706847, 5443.237946687467, 5475.0966090595, 5128.051310507568, 5160.896782064376, 5190.688558686453, 5199.948000519984, 5297.708626025567, 5699.173619825144, 5790.7683692652245, 5791.5656325775735, 5807.128930660392, 5807.245058142456, 6208.161898143783, 6211.658358790265, 6237.937620623827, 6243.250809902841, 6245.0320200369015, 5946.672932988684, 6039.1545183674325, 6118.131909153803, 6131.14164017038, 6301.747930082791, 5792.073268277098, 5799.623024503436, 5800.970995144998, 5801.680907550083, 5803.274590676166, 6298.02380631003, 6321.589096708699, 6323.0, 6323.620582764956, 6349.9682501587195, 5916.9645312070215, 6053.394660534, 6057.57596968208, 6073.39266073398, 6111.877762444727, 6261.279952805395, 6275.843103922439, 6292.1505596743855, 6302.180716506825, 6304.621722696653, 6204.503639708812, 6248.281447633581, 6260.906086408708, 6271.62370257786, 6289.842753931097, 6001.639901605918, 6114.7283117296465, 6131.101423540749, 6143.846403839851, 6282.465990390868, 4756.571908528249, 4760.9525904301, 4770.570648641639, 4773.1408346497965, 4794.5924596409695, 4242.7242229255, 4247.660187185018, 4266.893327666833, 4275.978620106879, 4292.828286868553, 5690.687012214368, 5887.76448942046, 5951.464368206882, 5974.3726908674835, 6060.727267272895, 6228.128062071313, 6278.843028924313, 6294.590851594723, 6302.621842689453, 6305.905411418832, 6029.909551356734, 6062.636241825505, 6066.423689749467, 6080.966235739935, 6085.995810691186, 4988.5260900214425, 5007.0, 5036.395632524121, 5174.0, 5306.257124002643, 6436.356364363526, 6559.311272316338, 6563.212414510289, 6563.671816409256, 6575.572587781779, 6264.812055638338, 6272.310045895039, 6305.337939516285, 6313.305536390902, 6325.335839736761, 6112.1387513176505, 6365.108884756045, 6548.770793022221, 6552.312007239362, 6562.278149403657, 6036.6679832609625, 6183.96908015457, 6191.907121393093, 6193.163922870355, 6194.0, 6271.717772700331, 6273.498120150286, 6278.246610406781, 6293.150424692608, 6300.621962682254, 5937.079752638348, 6031.879362412815, 6097.390260973867, 6156.815295541141, 6169.290531588925, 5975.970120149372, 6084.056971169476, 6130.448259656652, 6134.754609815557, 6139.2325959255095, 6008.609440386361, 6044.939550604614, 6071.878562428638, 6076.179715738319, 6100.664463454553, 5884.58807883444, 6021.126936594257, 6091.0558863376245, 6099.420555047263, 6180.938190618036, 5877.529797616266, 5958.731857066529, 5966.970165149147, 5985.491233245223, 6005.609635373687], "value": 5739.532621194414, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.5588640860128, 604.9243844519435, 620.5718054542366, 633.8066889598672, 673.030835596741, 42615.0, 46997.76501117494, 47155.0, 47296.290555641695, 47414.52585474144, 47284.76357618216, 47645.28532072021, 47906.041879162396, 48013.27980080293, 48153.0, 9141.45151290923, 9213.12475314844, 9237.261019118454, 9250.213731832768, 9280.211182049534, 9121.589528471202, 9257.490838003907, 9259.6296148154, 9260.166585007348, 9272.953635231814, 9297.581608827586, 9326.673566425177, 9365.297602679791, 9371.906280937172, 9380.765480862965, 9237.861432078524, 9269.860952085724, 9272.814543709123, 9296.256299496024, 9341.065893410605, 9197.816043679155, 9243.0, 9254.167124958718, 9267.490288034156, 9271.67549135777, 45143.322850157274, 45250.09499810018, 45294.0, 45437.545624543665, 45589.54410455886, 3785.734998550103, 3866.3620502617036, 3915.647591716731, 4462.866114016552, 4758.428988521399, 35167.0, 35277.0, 35510.11224719377, 36367.0, 36788.0, 4735.1713450146435, 4747.121782470254, 4844.176489996709, 4864.1974074277705, 4875.58557522611, 410781.0, 412616.0, 413558.0, 415546.0, 415862.999999997, 66522.66738666275, 67110.0, 67141.0, 67416.6629166851, 67446.0, 38961.61038389637, 39448.605513944494, 39528.20943581112, 70710.64644676847, 71117.28882711107, 17672.823271767116, 17729.202185901664, 17754.467365979042, 17765.289388424575, 17798.37705680295, 13242.20546767197, 13427.462901483832, 13442.663933401547, 13445.394957226948, 13478.932605336911, 20704.0, 21031.8948405257, 21053.26313579048, 21141.89429052845, 21192.470188245108, 7605.315521603082, 7805.453618246782, 7880.093789214199, 7929.0, 7952.244536768998, 1067.5889782433665, 1145.2670291013758, 1186.0689358853258, 1195.5277665322149, 1210.7396909664465, 34145.65854341425, 34413.31173376569, 35190.824045879606, 35505.64494355075, 35569.46645800315, 1194.0, 1238.8389509363726, 1257.9245245285313, 1259.3829023778283, 1260.3446207971804, 18479.81520184808, 18486.445406637824, 18581.721274180898, 18619.44141675752, 18694.71957920632, 651028.0, 652322.0, 653084.0, 654689.0, 656288.0, 66996.66501667559, 67417.0, 67683.0, 67872.0, 67949.0, 1436.2531483628454, 1454.5418193269086, 1474.0787008119926, 1476.9414754466125, 1489.8435664255096, 34421.0, 34528.48207276843, 34803.65196348004, 34903.47644785381, 34935.0, 57550.42449575618, 57672.71163644323, 57688.134677979026, 58094.0, 58483.4151658478, 515751.0, 519176.0, 523346.0, 523361.0, 525344.0, 31302.686973129978, 31497.21256968594, 31501.52747708832, 31913.840430797696, 32077.198070048435, 53729.0, 54583.454165457835, 54776.0, 55067.0, 55895.16157257563, 44848.32727509155, 48960.510394895595, 49549.25676114789, 49576.256356155405, 50440.495595045046, 45816.0, 46408.76795616, 47493.52506474891, 47640.52359476361, 48138.0, 46230.53769462397, 49425.50574494209, 50952.490475094775, 51292.0, 51789.0, 43817.34273985829, 43998.0, 44298.335524966504, 48740.512594873595, 50011.0, 37405.0, 37864.43203351897, 37978.8101059504, 38457.0, 38766.22467550577], "value": 22364.950592364185, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [415.56365815893315, 418.8973701443145, 423.92369373512753, 426.567034460023, 446.34833143610325, 19439.902800485994, 20296.69554956675, 21071.789282107173, 21183.470413239676, 21200.57598848022, 20219.090140943656, 20234.39296821094, 20435.386938391835, 20488.385348439533, 20645.896770516163, 5887.264091988502, 6043.153958445821, 6104.694765261741, 6111.816645500642, 6119.326874043873, 5982.0, 5985.0, 6013.398660133996, 6027.638341699512, 6052.303985041711, 5953.166556682047, 5970.492508136814, 5970.6119102258435, 5979.671118088503, 5979.880402391949, 5779.248697669297, 5917.230760001194, 5929.584929054968, 5982.999999999956, 5989.041753319491, 5171.948280517185, 5206.245094461282, 5356.4375740547075, 5367.087595108841, 5379.273798037254, 14582.562523124323, 14780.778288325684, 20860.37418877421, 21882.343529694135, 23687.644685329735, 2388.6297623868327, 2462.729099799021, 2478.3556275368355, 2486.639437281602, 2602.258356368426, 10901.945490272497, 10908.34549926999, 11020.50407731654, 11173.888261117367, 11239.887601124048, 2009.6836572045188, 2023.0693880814842, 2053.394248696623, 2073.533454972634, 2083.895535366258, 78209.60895195487, 86458.5677071617, 90696.54651726765, 92276.0, 92387.0, 11556.537738490535, 11878.40607969598, 11903.88096119045, 12014.75970480603, 12209.938950305192, 16470.341186352653, 16479.093649849372, 16525.91737041331, 16542.255598498097, 16590.75113873293, 8246.917530824734, 8541.103184165697, 8575.528345941033, 8647.913520864837, 8676.8698469523, 8043.47717398379, 8090.676372945016, 8105.8378832424205, 8318.209770071833, 8356.456830306011, 5023.8492845214705, 5070.467600901926, 5092.9236061459105, 5180.430152683201, 5217.06092903281, 1788.2399980008445, 1859.4421673497895, 1875.7092650639172, 1876.587150826816, 1886.4906475251605, 945.6217512994857, 1039.3192458939407, 1058.312097136852, 1084.1868598551087, 1117.6702872652586, 20349.389518314474, 21048.368548943556, 21164.0, 21179.47051323729, 21585.136594536358, 1029.4389557691077, 1044.6657069737762, 1075.7579544602402, 1094.414488248783, 1104.5968221599057, 11489.827652585218, 11746.0, 11771.0, 11958.222715523463, 12003.1597788154, 445926.0, 449309.0, 450713.0, 577020.0, 578032.0, 103383.0, 104410.0, 106825.46587267015, 106964.0, 109211.0, 1036.5905467340358, 1045.3205416479198, 1081.6538707613488, 1083.8970297821695, 1089.8746644135867, 15445.691086177989, 17963.5509112268, 18798.0, 18838.905805470884, 19678.11448484793, 31602.0, 39088.6091139085, 42029.579704202566, 45563.54436455593, 46649.30026049544, 57213.0, 61910.0, 62059.6897015512, 64107.35892641014, 64473.0, 9038.502882341272, 9086.500242486727, 9145.3598248122, 9165.908340916772, 9419.058094190526, 7724.1889601593275, 10673.0, 13280.80078798838, 13934.512292069729, 14435.78346324785, 11668.94165529167, 12204.450799713857, 12612.87387126117, 12883.48466061347, 13139.408726607517, 11671.88328116708, 12151.81772273399, 12611.87388126107, 12901.354932253538, 13186.538471153464, 12328.568500102454, 12339.876601234231, 12377.62867113988, 12405.44175512086, 12533.74932501363, 8382.077971423018, 8393.83212335762, 8457.830843382975, 8603.870941936002, 8652.394332396672, 9095.863562046443, 12226.938865305972, 12453.377331133588, 12501.56244531437, 12727.87272127304], "value": 9608.421512396442, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1522.3758259113763, 1530.0131415237172, 1732.410980266709, 1808.7648605681259, 1856.675081860675, 8823.955880220607, 9216.861747073783, 9559.235261179107, 10304.639337623184, 10305.948470257657, 9433.24534037277, 9640.084192001766, 9856.655017074403, 9911.603535858576, 9917.752056198598, 2364.4325361913147, 2434.342727463593, 2435.1355268879556, 2438.0247900839718, 2441.24321460347, 2385.0817435287368, 2397.652340410639, 2430.7569243075727, 2447.730749617541, 2453.9386515337083, 2408.3256688127353, 2432.1609044879488, 2449.5590793657134, 2492.389364605674, 2495.0394098272113, 2324.23300310897, 2327.592671282519, 2347.2371479269223, 2350.388898886293, 2353.870537120458, 2296.5062511559927, 2303.0557471436796, 2303.6199027160496, 2309.1340747219792, 2318.26974503031, 9916.25628077897, 9952.35309704874, 9992.300538962276, 10039.29724919256, 10070.597176112946, 5548.278723765925, 5616.213730077751, 5680.772769089232, 5710.942890571124, 5718.628289161233, 3585.2829434113282, 3630.2013557017676, 3644.5262115925025, 3648.4892115103908, 3726.217494326195, 1307.2809954524973, 1307.8430588329365, 1308.2281453942219, 1320.498210679945, 1337.3981708231336, 13698.794518082137, 13807.861921380758, 14103.717925641533, 14137.151770893677, 14220.786688199581, 4815.807367705323, 4851.830185943546, 4855.732934688555, 4969.801207951641, 5026.597872170218, 12106.213096148722, 12121.515139394325, 12121.575744848888, 12133.757324853454, 12158.148929574845, 5602.13166959122, 5620.100783874561, 5626.690532020696, 5650.0, 5655.773769049274, 4632.907341853144, 5077.365329333833, 5167.147420675622, 5195.844124676266, 5248.475152484721, 4314.094040251583, 4442.622377097919, 4497.875531117221, 4539.500654927955, 4551.180787458223, 1291.3091496049756, 1359.1776974930222, 1362.046567402822, 1374.2372982994534, 1376.593904798087, 930.2929773372285, 1021.1116328793996, 1042.7288904884633, 1043.2280112716687, 1054.894510548939, 6494.967525162344, 6508.0, 6543.607383557001, 6594.538382313288, 6726.764563240263, 452.8075567883636, 455.9954400455953, 457.8557754307449, 1072.7157303314627, 1157.1437136518916, 4209.663226941837, 4369.710935274102, 4393.0994146199955, 4418.270985287391, 4478.104379124123, 12302.0, 12471.75056498865, 12768.361581920866, 12781.424835882222, 12811.679708007374, 11750.118741094451, 12316.876831231752, 12602.432890519765, 12625.431855566521, 12639.1784534005, 8984.505852178192, 9158.81682366349, 9162.450252984841, 9173.312001599907, 9209.079092090871, 6417.422431981144, 6530.346965303432, 6617.43751781104, 6673.499487538551, 6739.359760822714, 11209.15931305139, 11565.190436669352, 11619.709507262049, 11741.765164696488, 11968.521259149536, 11516.19386642927, 11734.70663233426, 11936.0, 11996.64010079699, 12041.0, 7898.447108702336, 8211.425200236165, 8492.447990880573, 8802.163794439773, 9027.32295077885, 9889.851652225367, 9897.505124743879, 9957.0, 9960.501974901372, 10004.599816007278, 8359.373047021376, 8434.240918317135, 8473.533955632252, 8527.189916958127, 8564.700235491728, 8295.668173273001, 8307.875381869157, 8336.874946875923, 8441.071482136836, 8483.36374771907, 7322.780316590511, 7631.618419078913, 7721.112072111779, 7723.729669461542, 7738.264864837832, 5585.3297604287745, 5742.368339482737, 5752.022156233366, 5793.452140070025, 5830.650160990354, 5553.6390134641115, 5632.633878797865, 5687.744051517609, 5759.395263497272, 5768.913466298093], "value": 5041.815567444251, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.73799912066823, 348.56565234061844, 352.2092901436276, 356.85627563658477, 360.8394264552275, 5829.766809327622, 5862.267216597926, 5866.120081987704, 5877.735501902414, 5911.113333000047, 5748.798792042279, 5769.278840144982, 5781.855453613652, 5823.330317013545, 5857.414258574151, 4350.5649435056475, 4455.242608756519, 4511.278195488722, 4533.773311334437, 4535.750533720644, 4490.8877278067985, 4504.954950450487, 4509.684322097454, 4514.9774251128865, 4541.613962813165, 4453.51011388747, 4483.843065492709, 4510.909781804362, 4513.954860451387, 4542.250528662767, 4399.38408622793, 4432.601065904052, 4457.10857828434, 4475.328700694889, 4491.169133710274, 3895.9805200974097, 3935.232629637222, 3936.8228429720443, 3940.6059394060653, 3942.0342016205927, 5605.831825045255, 5645.096784514499, 5650.51970582501, 5658.717064146817, 5698.914516282259, 5086.593072554187, 5126.794928202868, 5141.460146684619, 5195.415398303516, 5195.922061169085, 5974.4921681657115, 5978.701064946778, 5981.91027134589, 6002.729877155539, 6028.728707208186, 4324.070324880166, 4360.193364227628, 4380.802863871133, 4390.297552391602, 4399.428074350314, 6080.875038117918, 6106.603070800384, 6275.843103922392, 6299.68501574924, 6356.332585078592, 4387.0, 4388.648908087345, 4391.912161756811, 4395.0, 4421.0, 4451.643868490513, 4476.776161191992, 4487.798049087799, 4487.820487180542, 4492.191405546968, 4887.535684110004, 4996.925046124311, 5133.281340612317, 5134.178531434953, 5174.120399532088, 6008.669523176267, 6018.488428483541, 6031.668258245751, 6052.576319657582, 6090.294717479113, 1543.1821134798574, 1556.704226197019, 1559.469780274712, 1560.087348900883, 1580.4073472447833, 950.3062764182185, 981.65642025292, 1002.8445590933417, 1012.3318609717551, 1013.9493025348703, 5155.793768249303, 5226.876221612371, 5270.631055826056, 5318.680879147263, 5331.667707682698, 5525.430674736267, 5536.0, 5550.639208451437, 5587.189857470726, 5588.133839254922, 4909.159065350494, 5192.948070519322, 5222.3472065991755, 5234.790608375699, 5308.336457942757, 2976.9851150744107, 2995.7603391728608, 2996.865141068657, 3000.489916714164, 3002.2794529313246, 5638.915416268759, 5663.518600918886, 5675.4324567543745, 5772.604369186824, 5791.102379131242, 5896.587238893237, 6327.4938004959495, 6366.649834259068, 6420.903686444707, 6426.196725409324, 6490.383413575702, 6503.9349606504275, 6518.902216466662, 6520.5435619507125, 6545.345465453512, 6025.939740602538, 6243.282022567463, 6311.538499985101, 6312.274088479883, 6336.17629708135, 6186.133941248138, 6218.502519798496, 6223.0397424811035, 6241.31345551998, 6265.496280892644, 6326.3939554455355, 6487.44856687168, 6503.707333169924, 6539.4768418525455, 6546.214454265519, 4467.2182368086105, 4500.887477813081, 4513.97743011296, 4516.88707782308, 4518.728876267303, 6129.0, 6321.905171422524, 6323.7786677466065, 6343.397377249154, 6404.231492220963, 6174.363793594611, 6185.350538193425, 6188.195534580475, 6199.628022318675, 6229.037853076266, 5944.64332140073, 6135.417135372132, 6139.26328840542, 6147.354527774519, 6198.876022479615, 6047.78832740852, 6080.4831589313635, 6088.086786981989, 6097.414672185175, 6099.0, 6211.689415529115, 6231.0, 6233.96883015582, 6237.407446292595, 6257.2491301044165, 5786.222613145629, 5997.860406522746, 6006.759729610767, 6010.819675409744, 6025.638461692312], "value": 4565.15100790402, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [803.6222975201654, 812.7886749445146, 831.1273163178661, 856.4133568505574, 904.8733177355175, 15691.764623530642, 16413.753793693104, 17047.57381065474, 17199.226034828433, 17403.65192696147, 15650.530484085495, 15858.762118568231, 15859.920700396511, 15968.121753303592, 16019.038857668518, 867.4014929698487, 873.4104479476343, 880.9515476648781, 884.5621417398364, 886.8403687336277, 901.2564634176798, 902.7291812456269, 902.9683961061364, 903.3992395057279, 904.1726819959729, 937.3953799799125, 938.9530523473833, 939.4457270210575, 940.4968341937065, 940.6801687426274, 928.9674861379887, 934.8597710343503, 936.2556767369923, 936.536414474836, 936.8969413364524, 688.7933619914056, 690.0477341269067, 695.9338862808025, 696.1124566178113, 696.6621188723465, 15390.538283851502, 15504.922475387551, 15547.911646184772, 15560.61098472536, 15658.530244092695, 15594.922025389915, 15749.448769293134, 15868.603284917854, 16048.197590120564, 16124.59688507785, 12142.332171730552, 12232.510699572007, 12481.438335274934, 12574.937125314407, 12757.107002509829, 3971.8609848655447, 4028.154087641599, 4035.7578545287083, 4039.63643272104, 4121.237571049335, 87646.5617671914, 87875.56062219712, 88347.0, 88537.0, 88729.78175545663, 11661.358625275521, 11883.524659013716, 11942.741919383512, 12084.516619335303, 12650.873491265154, 21837.126514939544, 22163.667544986838, 22292.331230063122, 22358.329250122522, 23290.65064024007, 8534.445261058012, 8615.095414981462, 8820.073892241351, 8842.867356989651, 9038.502882341403, 4982.128127577659, 5015.498450154955, 5076.263941728429, 5131.871703207375, 5221.13851214553, 3569.23261498779, 3698.926021479609, 3699.8150092495266, 3723.162288485069, 3732.3654978653694, 632.5161251642497, 635.2218532297898, 642.6240649220258, 654.018971542686, 655.367570294668, 699.3600855217419, 716.9390601798906, 723.7322190789441, 741.1735914455344, 743.605888878895, 9273.35086543949, 9974.45140517264, 10187.745306367251, 10189.796204075878, 10510.579576816994, 631.6930866911714, 663.1048085085097, 681.6387314723205, 705.9858802823915, 718.1489934427719, 4783.972195034282, 4845.176320025604, 4895.583875370562, 4926.975365123223, 4943.1596628573225, 124990.0, 129098.0, 130110.0, 130675.34662326628, 132002.0, 31625.683743162735, 32437.675623243937, 41103.0, 105570.4721476403, 108727.0, 96526.0, 98009.01990980141, 98112.50943745236, 101031.0, 101342.49328753309, 9188.95405522968, 9356.251499879858, 9371.0, 9583.856242156513, 9592.76018099553, 54661.72669136629, 56195.438045620656, 56313.43686563082, 56421.71789141028, 56994.7150264246, 79011.0, 81326.0, 81500.59249703714, 83233.16766832254, 85082.0, 11686.18196726255, 11782.941085294862, 11914.285142891455, 12128.514859405524, 12272.631821045383, 12917.935410322889, 12999.545015924397, 13004.089713719948, 13034.47862085506, 13091.738165236833, 12974.091813572959, 12978.221306721627, 12997.675058123623, 13008.21950682962, 13270.402831872396, 12690.555830545887, 12702.920251778332, 12710.428030738824, 12740.554080607135, 12774.297413642338, 12400.441980110736, 12893.677658058623, 12894.871051289367, 12965.870341296466, 12971.870281297066, 9843.261755368232, 10021.799564008825, 10409.906233202651, 10429.895701043197, 10519.737006574896, 10246.897531024595, 10573.418461984666, 10593.788124237319, 10715.839262410915, 10719.303245289031], "value": 7752.017584387697, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1503.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 110.0, 105.0, 109.0, 111.0, 111.0, 110.0, 113.0, 111.0, 110.0], "value": 108.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 115.0, 142.0, 169.0, 121.0, 148.0, 147.0, 121.0, 181.0, 117.0], "value": 141.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 161.0, 161.0, 163.0, 168.0, 162.0, 162.0, 163.0, 162.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 75.0, 84.0, 194.0, 75.0, 75.0, 76.0, 76.0, 172.0, 75.0], "value": 98.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 138.0, 84.0, 83.0, 83.0, 141.0, 83.0, 84.0, 143.0], "value": 100.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 119.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 148.0, 147.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 97.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 53.0, 53.0, 52.0, 53.0, 55.0, 53.0, 51.0, 58.0], "value": 53.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 61.0, 61.0, 63.0, 60.0, 60.0, 60.0, 61.0, 60.0], "value": 61.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 83.0, 75.0, 75.0, 74.0, 75.0, 73.0, 86.0, 73.0], "value": 76.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 117.0, 119.0, 116.0, 126.0, 120.0, 120.0, 118.0, 148.0, 133.0], "value": 124.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 154.0, 152.0, 153.0, 152.0, 150.0, 152.0, 151.0, 154.0, 151.0], "value": 152.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 71.0, 62.0, 61.0, 63.0, 62.0, 62.0, 66.0, 62.0, 64.0], "value": 63.7, "unit": "score"}]}]} 10:48:03 INFO - Return code: 0 10:48:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:48:03 ERROR - # TBPL SUCCESS # 10:48:03 INFO - Running post-action listener: _resource_record_post_action 10:48:03 INFO - [mozharness: 2016-09-05 17:48:03.442151Z] Finished run-tests step (success) 10:48:03 INFO - Running post-run listener: _resource_record_post_run 10:48:03 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 12288; Write bytes: 325701632; Read time: 140; Write time: 499740 10:48:03 INFO - TinderboxPrint: CPU usage
13.3% 10:48:03 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 140 10:48:03 INFO - TinderboxPrint: I/O write bytes / time
325,701,632 / 499,740 10:48:03 INFO - TinderboxPrint: CPU idle
8,235.1 (86.7%) 10:48:03 INFO - TinderboxPrint: CPU user
1,199.5 (12.6%) 10:48:03 INFO - TinderboxPrint: Swap in / out
0 / 0 10:48:03 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 79446016; Read time: 24; Write time: 157252 10:48:03 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 245747712; Read time: 104; Write time: 342244 10:48:04 INFO - Running post-run listener: _upload_blobber_files 10:48:04 INFO - Blob upload gear active. 10:48:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:48:04 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 10:48:04 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:48:04 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:48:04 INFO - (blobuploader) - INFO - Open directory for files ... 10:48:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:48:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:48:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:48:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:48:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:48:09 INFO - (blobuploader) - INFO - Done attempting. 10:48:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:48:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:48:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:48:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:48:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:48:10 INFO - (blobuploader) - INFO - Done attempting. 10:48:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:48:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:48:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:48:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:48:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:48:12 INFO - (blobuploader) - INFO - Done attempting. 10:48:12 INFO - (blobuploader) - INFO - Iteration through files over. 10:48:12 INFO - Return code: 0 10:48:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:48:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:48:12 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6e80f22de113106a2b5642db544e2f808229922e46f6362a4f557ccbbed91be40dc3e2ce4c83a656801aecfb315bf945dfe29a70f002cf645dd18bfcd1bdc24d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a0c8b5912ff0c5344122d4a65c1d58482fddc0f29025e8cb7871cbaaf3353e23c9240a1d0fe2f9f3b74107a6152a0f82de1253c6de781f470e4dc3b0363c4633", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9c9a508a406a885d6e4df25c9d0de680c5dd1a80f06b64849c2774fa38354730de9480a028d0194b2fa40bbfe7124247ef82ff234b40ed51f34ad8733bca682a"} 10:48:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:48:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:48:12 INFO - Contents: 10:48:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6e80f22de113106a2b5642db544e2f808229922e46f6362a4f557ccbbed91be40dc3e2ce4c83a656801aecfb315bf945dfe29a70f002cf645dd18bfcd1bdc24d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a0c8b5912ff0c5344122d4a65c1d58482fddc0f29025e8cb7871cbaaf3353e23c9240a1d0fe2f9f3b74107a6152a0f82de1253c6de781f470e4dc3b0363c4633", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9c9a508a406a885d6e4df25c9d0de680c5dd1a80f06b64849c2774fa38354730de9480a028d0194b2fa40bbfe7124247ef82ff234b40ed51f34ad8733bca682a"} 10:48:12 INFO - Running post-run listener: copy_logs_to_upload_dir 10:48:12 INFO - Copying logs to upload dir... 10:48:12 INFO - mkdir: /builds/slave/test/build/upload/logs 10:48:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1681.400432 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 1 secs) (at 2016-09-05 10:48:11.587109) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-05 10:48:11.591083) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1473095866.778852-703103568 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-Aurora/sha512/6e80f22de113106a2b5642db544e2f808229922e46f6362a4f557ccbbed91be40dc3e2ce4c83a656801aecfb315bf945dfe29a70f002cf645dd18bfcd1bdc24d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a0c8b5912ff0c5344122d4a65c1d58482fddc0f29025e8cb7871cbaaf3353e23c9240a1d0fe2f9f3b74107a6152a0f82de1253c6de781f470e4dc3b0363c4633", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9c9a508a406a885d6e4df25c9d0de680c5dd1a80f06b64849c2774fa38354730de9480a028d0194b2fa40bbfe7124247ef82ff234b40ed51f34ad8733bca682a"} build_url:https://queue.taskcluster.net/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011315 build_url: 'https://queue.taskcluster.net/v1/task/AgXHR6EITOSNRTnEkhfJqA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6e80f22de113106a2b5642db544e2f808229922e46f6362a4f557ccbbed91be40dc3e2ce4c83a656801aecfb315bf945dfe29a70f002cf645dd18bfcd1bdc24d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a0c8b5912ff0c5344122d4a65c1d58482fddc0f29025e8cb7871cbaaf3353e23c9240a1d0fe2f9f3b74107a6152a0f82de1253c6de781f470e4dc3b0363c4633", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9c9a508a406a885d6e4df25c9d0de680c5dd1a80f06b64849c2774fa38354730de9480a028d0194b2fa40bbfe7124247ef82ff234b40ed51f34ad8733bca682a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-05 10:48:11.616180) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-05 10:48:11.616495) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1473095866.778852-703103568 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004503 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-05 10:48:11.699436) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-05 10:48:11.699979) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-05 10:48:11.700447) ========= ========= Total master_lag: 0.16 =========