builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-057 starttime: 1474255329.23 results: success (0) buildid: 20160918173718 builduid: c62987ef87904a68aa0d432851135612 revision: 896a7672b83764829bbfc93e285d03bf318d3a5b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-18 20:22:09.234127) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-18 20:22:09.236121) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-18 20:22:09.236417) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-18 20:22:09.268142) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-18 20:22:09.268444) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1474253432.33310-1294809706 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-18 20:22: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% 22.2M=0.001s 2016-09-18 20:22:10 (22.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.127299 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-18 20:22:09.427356) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-18 20:22:09.427895) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1474253432.33310-1294809706 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020245 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-18 20:22:09.481789) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-18 20:22:09.482121) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 896a7672b83764829bbfc93e285d03bf318d3a5b --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 896a7672b83764829bbfc93e285d03bf318d3a5b --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=934fc3100db09dcb9af4d4b6000001ab-1474253432.33310-1294809706 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-18 20:22:10,397 truncating revision to first 12 chars 2016-09-18 20:22:10,397 Setting DEBUG logging. 2016-09-18 20:22:10,397 attempt 1/10 2016-09-18 20:22:10,397 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/896a7672b837?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-18 20:22:11,064 unpacking tar archive at: mozilla-aurora-896a7672b837/testing/mozharness/ program finished with exit code 0 elapsedTime=1.058718 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-18 20:22:10.555292) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-18 20:22:10.555599) ========= script_repo_revision: 896a7672b83764829bbfc93e285d03bf318d3a5b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-18 20:22:10.555984) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-18 20:22:10.556247) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-18 20:22:10.572852) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 58 secs) (at 2016-09-18 20:22:10.573122) ========= /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=934fc3100db09dcb9af4d4b6000001ab-1474253432.33310-1294809706 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:22:11 INFO - MultiFileLogger online at 20160918 20:22:11 in /builds/slave/test 20:22: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 20:22:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:22:11 INFO - {'append_to_log': False, 20:22:11 INFO - 'base_work_dir': '/builds/slave/test', 20:22:11 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 20:22:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:22:11 INFO - 'branch': 'Mozilla-Aurora', 20:22:11 INFO - 'buildbot_json_path': 'buildprops.json', 20:22:11 INFO - 'config_files': ('talos/linux_config.py',), 20:22:11 INFO - 'default_actions': ('clobber', 20:22:11 INFO - 'read-buildbot-config', 20:22:11 INFO - 'download-and-extract', 20:22:11 INFO - 'populate-webroot', 20:22:11 INFO - 'create-virtualenv', 20:22:11 INFO - 'install', 20:22:11 INFO - 'run-tests'), 20:22:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:22:11 INFO - 'download_minidump_stackwalk': True, 20:22:11 INFO - 'download_symbols': 'ondemand', 20:22:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:22:11 INFO - 'tooltool.py': '/tools/tooltool.py', 20:22:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:22:11 INFO - '/tools/misc-python/virtualenv.py')}, 20:22:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:22:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:22:11 INFO - 'installer_path': 'installer.exe', 20:22:11 INFO - 'log_level': 'info', 20:22:11 INFO - 'log_name': 'talos', 20:22:11 INFO - 'log_to_console': True, 20:22:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:22:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:22:11 INFO - 'opt_config_files': (), 20:22:11 INFO - 'pip_index': False, 20:22:11 INFO - 'sps_profile': False, 20:22:11 INFO - 'sps_profile_interval': 0, 20:22:11 INFO - 'suite': 'dromaeojs-e10s', 20:22:11 INFO - 'system_bits': '32', 20:22:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:22:11 INFO - 'title': 'talos-linux64-ix-057', 20:22:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:22:11 INFO - 'use_talos_json': True, 20:22:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:22:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:22:11 INFO - 'work_dir': 'build'} 20:22:11 INFO - [mozharness: 2016-09-19 03:22:11.584847Z] Running clobber step. 20:22:11 INFO - Running pre-action listener: _resource_record_pre_action 20:22:11 INFO - Running main action method: clobber 20:22:11 INFO - rmtree: /builds/slave/test/build 20:22:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:22:12 INFO - Running post-action listener: _resource_record_post_action 20:22:12 INFO - [mozharness: 2016-09-19 03:22:12.562357Z] Finished clobber step (success) 20:22:12 INFO - [mozharness: 2016-09-19 03:22:12.562456Z] Running read-buildbot-config step. 20:22:12 INFO - Running pre-action listener: _resource_record_pre_action 20:22:12 INFO - Running main action method: read_buildbot_config 20:22:12 INFO - Using buildbot properties: 20:22:12 INFO - { 20:22:12 INFO - "project": "", 20:22:12 INFO - "product": "firefox", 20:22:12 INFO - "script_repo_revision": "production", 20:22:12 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 20:22:12 INFO - "repository": "", 20:22:12 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 20:22:12 INFO - "buildid": "20160918173718", 20:22:12 INFO - "pgo_build": "True", 20:22:12 INFO - "basedir": "/builds/slave/test", 20:22:12 INFO - "buildnumber": 566, 20:22:12 INFO - "slavename": "talos-linux64-ix-057", 20:22:12 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 20:22:12 INFO - "platform": "ubuntu64_hw", 20:22:12 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 20:22:12 INFO - "branch": "mozilla-aurora", 20:22:12 INFO - "repo_path": "releases/mozilla-aurora", 20:22:12 INFO - "revision": "896a7672b83764829bbfc93e285d03bf318d3a5b", 20:22:12 INFO - "stage_platform": "linux64-pgo", 20:22:12 INFO - "builduid": "c62987ef87904a68aa0d432851135612", 20:22:12 INFO - "slavebuilddir": "test" 20:22:12 INFO - } 20:22:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/ePIxxufxTeCzWVOohoB-9w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 20:22:12 INFO - Running post-action listener: _resource_record_post_action 20:22:12 INFO - [mozharness: 2016-09-19 03:22:12.564883Z] Finished read-buildbot-config step (success) 20:22:12 INFO - [mozharness: 2016-09-19 03:22:12.564971Z] Running download-and-extract step. 20:22:12 INFO - Running pre-action listener: _resource_record_pre_action 20:22:12 INFO - Running main action method: download_and_extract 20:22:12 INFO - mkdir: /builds/slave/test/build/tests 20:22: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')]} 20:22:12 INFO - https://queue.taskcluster.net/v1/task/ePIxxufxTeCzWVOohoB-9w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:22:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIxxufxTeCzWVOohoB-9w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 20:22:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIxxufxTeCzWVOohoB-9w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 20:22:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIxxufxTeCzWVOohoB-9w/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 20:22:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIxxufxTeCzWVOohoB-9w/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 20: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/ePIxxufxTeCzWVOohoB-9w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 20:22:12 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 20:22:12 INFO - retry: Failed, sleeping 30 seconds before retrying 20:22:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIxxufxTeCzWVOohoB-9w/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 20:22:42 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIxxufxTeCzWVOohoB-9w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 20:22:42 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 20:22:42 INFO - retry: Failed, sleeping 60 seconds before retrying 20:23:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIxxufxTeCzWVOohoB-9w/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 20:23:42 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIxxufxTeCzWVOohoB-9w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 20:23:42 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 20:23:42 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIxxufxTeCzWVOohoB-9w/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! 20:23:42 INFO - Caught exception: HTTP Error 404: Not Found 20:23:42 INFO - Caught exception: HTTP Error 404: Not Found 20:23:42 INFO - Caught exception: HTTP Error 404: Not Found 20:23:42 INFO - trying https://queue.taskcluster.net/v1/task/ePIxxufxTeCzWVOohoB-9w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 20:23:42 INFO - Downloading https://queue.taskcluster.net/v1/task/ePIxxufxTeCzWVOohoB-9w/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 20:23:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ePIxxufxTeCzWVOohoB-9w/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 20:23:43 INFO - Downloaded 1361 bytes. 20:23:43 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 20:23:43 INFO - Using the following test package requirements: 20:23:43 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 20:23:43 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 20:23:43 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 20:23:43 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 20:23:43 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 20:23:43 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 20:23:43 INFO - u'jsshell-linux-x86_64.zip'], 20:23:43 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 20:23:43 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 20:23:43 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 20:23:43 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 20:23:43 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 20:23:43 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 20:23:43 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 20:23:43 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 20:23:43 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 20:23:43 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 20:23:43 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 20:23:43 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:23:43 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')]} 20:23:43 INFO - https://queue.taskcluster.net/v1/task/ePIxxufxTeCzWVOohoB-9w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:23:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIxxufxTeCzWVOohoB-9w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 20:23:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIxxufxTeCzWVOohoB-9w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 20:23:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIxxufxTeCzWVOohoB-9w/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 20:23:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIxxufxTeCzWVOohoB-9w/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 20:23:43 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIxxufxTeCzWVOohoB-9w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 20:23:43 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 20:23:43 INFO - retry: Failed, sleeping 30 seconds before retrying 20:24:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIxxufxTeCzWVOohoB-9w/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 20:24:13 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIxxufxTeCzWVOohoB-9w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 20:24:13 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 20:24:13 INFO - retry: Failed, sleeping 60 seconds before retrying 20:25:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIxxufxTeCzWVOohoB-9w/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 20:25:13 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIxxufxTeCzWVOohoB-9w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 20:25:13 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 20:25:13 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIxxufxTeCzWVOohoB-9w/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! 20:25:13 INFO - Caught exception: HTTP Error 404: Not Found 20:25:13 INFO - Caught exception: HTTP Error 404: Not Found 20:25:13 INFO - Caught exception: HTTP Error 404: Not Found 20:25:13 INFO - trying https://queue.taskcluster.net/v1/task/ePIxxufxTeCzWVOohoB-9w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 20:25:13 INFO - Downloading https://queue.taskcluster.net/v1/task/ePIxxufxTeCzWVOohoB-9w/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 20:25:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ePIxxufxTeCzWVOohoB-9w/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 20:25:14 INFO - Downloaded 21770968 bytes. 20:25:14 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'] 20:25:14 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 20:25:15 INFO - Return code: 0 20:25:15 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 20:25:15 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')]} 20:25:15 INFO - https://queue.taskcluster.net/v1/task/ePIxxufxTeCzWVOohoB-9w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:25:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIxxufxTeCzWVOohoB-9w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 20:25:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIxxufxTeCzWVOohoB-9w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 20:25:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIxxufxTeCzWVOohoB-9w/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 20:25:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIxxufxTeCzWVOohoB-9w/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 20:25:15 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIxxufxTeCzWVOohoB-9w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 20:25:15 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 20:25:15 INFO - retry: Failed, sleeping 30 seconds before retrying 20:25:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIxxufxTeCzWVOohoB-9w/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 20:25:46 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIxxufxTeCzWVOohoB-9w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 20:25:46 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 20:25:46 INFO - retry: Failed, sleeping 60 seconds before retrying 20:26:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIxxufxTeCzWVOohoB-9w/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 20:26:46 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIxxufxTeCzWVOohoB-9w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 20:26:46 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 20:26:46 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIxxufxTeCzWVOohoB-9w/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! 20:26:46 INFO - Caught exception: HTTP Error 404: Not Found 20:26:46 INFO - Caught exception: HTTP Error 404: Not Found 20:26:46 INFO - Caught exception: HTTP Error 404: Not Found 20:26:46 INFO - trying https://queue.taskcluster.net/v1/task/ePIxxufxTeCzWVOohoB-9w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 20:26:46 INFO - Downloading https://queue.taskcluster.net/v1/task/ePIxxufxTeCzWVOohoB-9w/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 20:26:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ePIxxufxTeCzWVOohoB-9w/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 20:26:47 INFO - Downloaded 21770968 bytes. 20:26:47 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'] 20:26:47 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 20:26:48 INFO - Return code: 0 20:26:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:26:48 INFO - https://queue.taskcluster.net/v1/task/ePIxxufxTeCzWVOohoB-9w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:26:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIxxufxTeCzWVOohoB-9w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 20:26:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIxxufxTeCzWVOohoB-9w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 20:26:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIxxufxTeCzWVOohoB-9w/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 20:26:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIxxufxTeCzWVOohoB-9w/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 20: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/ePIxxufxTeCzWVOohoB-9w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 20:26:48 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 20:26:48 INFO - retry: Failed, sleeping 30 seconds before retrying 20:27:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIxxufxTeCzWVOohoB-9w/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 20:27:18 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIxxufxTeCzWVOohoB-9w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 20:27:18 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 20:27:18 INFO - retry: Failed, sleeping 60 seconds before retrying 20:28:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIxxufxTeCzWVOohoB-9w/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 20:28:18 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIxxufxTeCzWVOohoB-9w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 20:28:18 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 20:28:18 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIxxufxTeCzWVOohoB-9w/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! 20:28:18 INFO - Caught exception: HTTP Error 404: Not Found 20:28:18 INFO - Caught exception: HTTP Error 404: Not Found 20:28:18 INFO - Caught exception: HTTP Error 404: Not Found 20:28:18 INFO - trying https://queue.taskcluster.net/v1/task/ePIxxufxTeCzWVOohoB-9w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 20:28:18 INFO - Downloading https://queue.taskcluster.net/v1/task/ePIxxufxTeCzWVOohoB-9w/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 20:28:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ePIxxufxTeCzWVOohoB-9w/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 20:28:20 INFO - Downloaded 14413740 bytes. 20:28:20 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'] 20:28:20 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 20:28:20 INFO - Return code: 0 20:28:20 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')]} 20:28:20 INFO - https://queue.taskcluster.net/v1/task/ePIxxufxTeCzWVOohoB-9w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:28:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIxxufxTeCzWVOohoB-9w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 20:28:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIxxufxTeCzWVOohoB-9w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 20:28:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIxxufxTeCzWVOohoB-9w/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 20:28:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIxxufxTeCzWVOohoB-9w/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 20:28:20 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIxxufxTeCzWVOohoB-9w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 20:28:20 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 20:28:20 INFO - retry: Failed, sleeping 30 seconds before retrying 20:28:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIxxufxTeCzWVOohoB-9w/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 20:28:50 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIxxufxTeCzWVOohoB-9w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 20:28:50 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 20:28:50 INFO - retry: Failed, sleeping 60 seconds before retrying 20:29:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIxxufxTeCzWVOohoB-9w/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 20:29:50 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIxxufxTeCzWVOohoB-9w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 20:29:50 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 20:29:50 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIxxufxTeCzWVOohoB-9w/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! 20:29:50 INFO - Caught exception: HTTP Error 404: Not Found 20:29:50 INFO - Caught exception: HTTP Error 404: Not Found 20:29:50 INFO - Caught exception: HTTP Error 404: Not Found 20:29:50 INFO - trying https://queue.taskcluster.net/v1/task/ePIxxufxTeCzWVOohoB-9w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 20:29:50 INFO - Downloading https://queue.taskcluster.net/v1/task/ePIxxufxTeCzWVOohoB-9w/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 20:29:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ePIxxufxTeCzWVOohoB-9w/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 20:29:51 INFO - Downloaded 63903027 bytes. 20:29:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ePIxxufxTeCzWVOohoB-9w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 20:29:51 INFO - mkdir: /builds/slave/test/properties 20:29:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:29:51 INFO - Writing to file /builds/slave/test/properties/build_url 20:29:51 INFO - Contents: 20:29:51 INFO - build_url:https://queue.taskcluster.net/v1/task/ePIxxufxTeCzWVOohoB-9w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 20:29:52 INFO - Running post-action listener: _resource_record_post_action 20:29:52 INFO - Running post-action listener: set_extra_try_arguments 20:29:52 INFO - [mozharness: 2016-09-19 03:29:52.349098Z] Finished download-and-extract step (success) 20:29:52 INFO - [mozharness: 2016-09-19 03:29:52.349328Z] Running populate-webroot step. 20:29:52 INFO - Running pre-action listener: _resource_record_pre_action 20:29:52 INFO - Running main action method: populate_webroot 20:29:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:29:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:29:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:29:52 INFO - '--tppagecycles', 20:29:52 INFO - '7'], 20:29:52 INFO - 'tests': ['tsvgm']}}, 20:29:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:29:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:29:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:29:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:29:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:29:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:29:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:29:52 INFO - 'talos_options': ['--disable-e10s'], 20:29:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:29:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:29:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:29:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:29:52 INFO - 'talos_options': ['--disable-e10s'], 20:29:52 INFO - 'tests': ['damp', 'tps']}, 20:29:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:29:52 INFO - 'tests': ['damp', 'tps']}, 20:29:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:29:52 INFO - 'tests': ['dromaeo_dom']}, 20:29:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:29:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:29:52 INFO - 'tests': ['basic_compositor_video']}, 20:29:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:29:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:29:52 INFO - 'tests': ['a11yr', 20:29:52 INFO - 'ts_paint', 20:29:52 INFO - 'tpaint', 20:29:52 INFO - 'sessionrestore', 20:29:52 INFO - 'sessionrestore_no_auto_restore', 20:29:52 INFO - 'tabpaint']}, 20:29:52 INFO - 'other-e10s': {'tests': ['a11yr', 20:29:52 INFO - 'ts_paint', 20:29:52 INFO - 'tpaint', 20:29:52 INFO - 'sessionrestore', 20:29:52 INFO - 'sessionrestore_no_auto_restore', 20:29:52 INFO - 'tabpaint']}, 20:29:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:29:52 INFO - 'ts_paint', 20:29:52 INFO - 'tpaint', 20:29:52 INFO - 'sessionrestore', 20:29:52 INFO - 'sessionrestore_no_auto_restore', 20:29:52 INFO - 'tabpaint']}, 20:29:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:29:52 INFO - 'ts_paint', 20:29:52 INFO - 'tpaint', 20:29:52 INFO - 'sessionrestore', 20:29:52 INFO - 'sessionrestore_no_auto_restore', 20:29:52 INFO - 'tabpaint']}, 20:29:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:29:52 INFO - 'tests': ['a11yr', 20:29:52 INFO - 'ts_paint', 20:29:52 INFO - 'tpaint', 20:29:52 INFO - 'sessionrestore', 20:29:52 INFO - 'sessionrestore_no_auto_restore', 20:29:52 INFO - 'tabpaint']}, 20:29:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:29:52 INFO - 'tests': ['a11yr', 20:29:52 INFO - 'ts_paint', 20:29:52 INFO - 'tpaint', 20:29:52 INFO - 'sessionrestore', 20:29:52 INFO - 'sessionrestore_no_auto_restore', 20:29:52 INFO - 'tabpaint']}, 20:29:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:29:52 INFO - 'tests': ['tsvgx', 20:29:52 INFO - 'tsvgr_opacity', 20:29:52 INFO - 'tart', 20:29:52 INFO - 'tscrollx', 20:29:52 INFO - 'cart']}, 20:29:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:29:52 INFO - 'tsvgr_opacity', 20:29:52 INFO - 'tart', 20:29:52 INFO - 'tscrollx', 20:29:52 INFO - 'cart']}, 20:29:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:29:52 INFO - 'talos_options': ['--disable-e10s'], 20:29:52 INFO - 'tests': ['tp5o']}, 20:29:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:29:52 INFO - 'tests': ['tp5o']}, 20:29:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:29:52 INFO - 'talos_options': ['--disable-e10s', 20:29:52 INFO - '--xperf_path', 20:29:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:29:52 INFO - 'tests': ['tp5n']}, 20:29:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:29:52 INFO - 'talos_options': ['--xperf_path', 20:29:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:29:52 INFO - 'tests': ['tp5n']}}, 20:29:52 INFO - 'talos.zip': {'path': '', 20:29:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:29:52 INFO - Running post-action listener: _resource_record_post_action 20:29:52 INFO - [mozharness: 2016-09-19 03:29:52.369359Z] Finished populate-webroot step (success) 20:29:52 INFO - [mozharness: 2016-09-19 03:29:52.369446Z] Running create-virtualenv step. 20:29:52 INFO - Running pre-action listener: _resource_record_pre_action 20:29:52 INFO - Running main action method: create_virtualenv 20:29:52 INFO - Creating virtualenv /builds/slave/test/build/venv 20:29:52 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 20:29:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:29:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:29:52 INFO - Using real prefix '/usr' 20:29:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:29:52 INFO - Installing distribute.............................................................................................................................................................................................done. 20:29:54 INFO - Installing pip.................done. 20:29:54 INFO - Return code: 0 20:29:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:29:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:29:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:29:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:29:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:29:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:29:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:29:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1495030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c4400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1753570>, '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 0x1754470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1754900>, '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': '934fc3100db09dcb9af4d4b6000001ab-1474253432.33310-1294809706', '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 20:29:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:29:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:29:54 INFO - Using env: {'DISPLAY': ':0', 20:29:54 INFO - 'HOME': '/home/cltbld', 20:29:54 INFO - 'LANG': 'en_US.UTF-8', 20:29:54 INFO - 'LANGUAGE': 'en_US:en', 20:29:54 INFO - 'LOGNAME': 'cltbld', 20:29:54 INFO - 'MAIL': '/var/mail/cltbld', 20:29:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:29:54 INFO - 'MOZ_NO_REMOTE': '1', 20:29:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:29:54 INFO - 'NO_EM_RESTART': '1', 20:29:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:29:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:29:54 INFO - 'PWD': '/builds/slave/test', 20:29:54 INFO - 'SHELL': '/bin/bash', 20:29:54 INFO - 'SHLVL': '1', 20:29:54 INFO - 'TERM': 'linux', 20:29:54 INFO - 'TMOUT': '86400', 20:29:54 INFO - 'USER': 'cltbld', 20:29:54 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1474253432.33310-1294809706', 20:29:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:29:54 INFO - '_': '/tools/buildbot/bin/python'} 20:29:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:29:55 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 20:29:55 INFO - Cleaning up... 20:29:55 INFO - Return code: 0 20:29:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:29:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:29:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:29:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:29:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:29:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:29:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:29:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1495030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c4400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1753570>, '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 0x1754470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1754900>, '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': '934fc3100db09dcb9af4d4b6000001ab-1474253432.33310-1294809706', '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 20:29:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:29:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:29:55 INFO - Using env: {'DISPLAY': ':0', 20:29:55 INFO - 'HOME': '/home/cltbld', 20:29:55 INFO - 'LANG': 'en_US.UTF-8', 20:29:55 INFO - 'LANGUAGE': 'en_US:en', 20:29:55 INFO - 'LOGNAME': 'cltbld', 20:29:55 INFO - 'MAIL': '/var/mail/cltbld', 20:29:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:29:55 INFO - 'MOZ_NO_REMOTE': '1', 20:29:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:29:55 INFO - 'NO_EM_RESTART': '1', 20:29:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:29:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:29:55 INFO - 'PWD': '/builds/slave/test', 20:29:55 INFO - 'SHELL': '/bin/bash', 20:29:55 INFO - 'SHLVL': '1', 20:29:55 INFO - 'TERM': 'linux', 20:29:55 INFO - 'TMOUT': '86400', 20:29:55 INFO - 'USER': 'cltbld', 20:29:55 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1474253432.33310-1294809706', 20:29:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:29:55 INFO - '_': '/tools/buildbot/bin/python'} 20:29:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:29:55 INFO - Downloading/unpacking psutil>=3.1.1 20:29:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:29:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:29:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:29:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:29:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:29:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:29:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:29:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:29:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:29:57 INFO - Installing collected packages: psutil 20:29:57 INFO - Running setup.py install for psutil 20:29:57 INFO - building 'psutil._psutil_linux' extension 20:29:57 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 20:29:57 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 20:29:57 INFO - building 'psutil._psutil_posix' extension 20:29:57 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 20:29:57 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 20:29:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:29:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:29:57 INFO - Successfully installed psutil 20:29:57 INFO - Cleaning up... 20:29:57 INFO - Return code: 0 20:29:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:29:57 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')]} 20:29:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:29:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:29:57 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')]} 20:29:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:29:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:29:57 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 0x1495030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c4400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1753570>, '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 0x1754470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1754900>, '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': '934fc3100db09dcb9af4d4b6000001ab-1474253432.33310-1294809706', '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 20:29:57 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 20:29:57 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 20:29:57 INFO - Using env: {'DISPLAY': ':0', 20:29:57 INFO - 'HOME': '/home/cltbld', 20:29:57 INFO - 'LANG': 'en_US.UTF-8', 20:29:57 INFO - 'LANGUAGE': 'en_US:en', 20:29:57 INFO - 'LOGNAME': 'cltbld', 20:29:57 INFO - 'MAIL': '/var/mail/cltbld', 20:29:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:29:57 INFO - 'MOZ_NO_REMOTE': '1', 20:29:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:29:57 INFO - 'NO_EM_RESTART': '1', 20:29:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:29:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:29:57 INFO - 'PWD': '/builds/slave/test', 20:29:57 INFO - 'SHELL': '/bin/bash', 20:29:57 INFO - 'SHLVL': '1', 20:29:57 INFO - 'TERM': 'linux', 20:29:57 INFO - 'TMOUT': '86400', 20:29:57 INFO - 'USER': 'cltbld', 20:29:57 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1474253432.33310-1294809706', 20:29:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:29:57 INFO - '_': '/tools/buildbot/bin/python'} 20:29:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:29:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:29: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 20:29: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 20:29: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 20:29: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 20:29: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 20:29: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 20:30:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:30:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:30:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:30:00 INFO - Installing collected packages: mozsystemmonitor 20:30:00 INFO - Running setup.py install for mozsystemmonitor 20:30:00 INFO - Successfully installed mozsystemmonitor 20:30:00 INFO - Cleaning up... 20:30:00 INFO - Return code: 0 20:30:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:30:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:30:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:30:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:30:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:30:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:30:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:30:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1495030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c4400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1753570>, '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 0x1754470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1754900>, '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': '934fc3100db09dcb9af4d4b6000001ab-1474253432.33310-1294809706', '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 20:30:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:30:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:30:00 INFO - Using env: {'DISPLAY': ':0', 20:30:00 INFO - 'HOME': '/home/cltbld', 20:30:00 INFO - 'LANG': 'en_US.UTF-8', 20:30:00 INFO - 'LANGUAGE': 'en_US:en', 20:30:00 INFO - 'LOGNAME': 'cltbld', 20:30:00 INFO - 'MAIL': '/var/mail/cltbld', 20:30:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:30:00 INFO - 'MOZ_NO_REMOTE': '1', 20:30:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:30:00 INFO - 'NO_EM_RESTART': '1', 20:30:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:30:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:30:00 INFO - 'PWD': '/builds/slave/test', 20:30:00 INFO - 'SHELL': '/bin/bash', 20:30:00 INFO - 'SHLVL': '1', 20:30:00 INFO - 'TERM': 'linux', 20:30:00 INFO - 'TMOUT': '86400', 20:30:00 INFO - 'USER': 'cltbld', 20:30:00 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1474253432.33310-1294809706', 20:30:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:30:00 INFO - '_': '/tools/buildbot/bin/python'} 20:30:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:30:00 INFO - Downloading/unpacking jsonschema==2.5.1 20:30: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 20:30: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 20:30: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 20:30: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 20:30: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 20:30: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 20:30:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:30:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:30:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:30:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:30:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:30:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:30:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:30:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:30:02 INFO - Downloading functools32-3.2.3-2.tar.gz 20:30:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:30:02 INFO - warning: no files found matching '*.txt' 20:30:02 INFO - no previously-included directories found matching 'build' 20:30:02 INFO - no previously-included directories found matching 'dist' 20:30:02 INFO - no previously-included directories found matching '.git*' 20:30:02 INFO - Installing collected packages: jsonschema, functools32 20:30:02 INFO - Running setup.py install for functools32 20:30:02 INFO - warning: no files found matching '*.txt' 20:30:02 INFO - no previously-included directories found matching 'build' 20:30:02 INFO - no previously-included directories found matching 'dist' 20:30:02 INFO - no previously-included directories found matching '.git*' 20:30:02 INFO - Successfully installed jsonschema functools32 20:30:02 INFO - Cleaning up... 20:30:02 INFO - Return code: 0 20:30:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:30:02 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')]} 20:30:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:30:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:30:02 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')]} 20:30:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:30:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:30:02 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 0x1495030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c4400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1753570>, '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 0x1754470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1754900>, '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': '934fc3100db09dcb9af4d4b6000001ab-1474253432.33310-1294809706', '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 20:30:02 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 20:30:02 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 20:30:02 INFO - Using env: {'DISPLAY': ':0', 20:30:02 INFO - 'HOME': '/home/cltbld', 20:30:02 INFO - 'LANG': 'en_US.UTF-8', 20:30:02 INFO - 'LANGUAGE': 'en_US:en', 20:30:02 INFO - 'LOGNAME': 'cltbld', 20:30:02 INFO - 'MAIL': '/var/mail/cltbld', 20:30:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:30:02 INFO - 'MOZ_NO_REMOTE': '1', 20:30:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:30:02 INFO - 'NO_EM_RESTART': '1', 20:30:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:30:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:30:02 INFO - 'PWD': '/builds/slave/test', 20:30:02 INFO - 'SHELL': '/bin/bash', 20:30:02 INFO - 'SHLVL': '1', 20:30:02 INFO - 'TERM': 'linux', 20:30:02 INFO - 'TMOUT': '86400', 20:30:02 INFO - 'USER': 'cltbld', 20:30:02 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1474253432.33310-1294809706', 20:30:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:30:02 INFO - '_': '/tools/buildbot/bin/python'} 20:30:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:30:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:30:03 INFO - Cleaning up... 20:30:03 INFO - Return code: 0 20:30:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:30:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:30:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:30:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:30:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:30:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:30:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:30:03 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 0x1495030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c4400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1753570>, '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 0x1754470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1754900>, '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': '934fc3100db09dcb9af4d4b6000001ab-1474253432.33310-1294809706', '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 20:30:03 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 20:30:03 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 20:30:03 INFO - Using env: {'DISPLAY': ':0', 20:30:03 INFO - 'HOME': '/home/cltbld', 20:30:03 INFO - 'LANG': 'en_US.UTF-8', 20:30:03 INFO - 'LANGUAGE': 'en_US:en', 20:30:03 INFO - 'LOGNAME': 'cltbld', 20:30:03 INFO - 'MAIL': '/var/mail/cltbld', 20:30:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:30:03 INFO - 'MOZ_NO_REMOTE': '1', 20:30:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:30:03 INFO - 'NO_EM_RESTART': '1', 20:30:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:30:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:30:03 INFO - 'PWD': '/builds/slave/test', 20:30:03 INFO - 'SHELL': '/bin/bash', 20:30:03 INFO - 'SHLVL': '1', 20:30:03 INFO - 'TERM': 'linux', 20:30:03 INFO - 'TMOUT': '86400', 20:30:03 INFO - 'USER': 'cltbld', 20:30:03 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1474253432.33310-1294809706', 20:30:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:30:03 INFO - '_': '/tools/buildbot/bin/python'} 20:30:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:30:03 INFO - Downloading/unpacking blobuploader==1.2.4 20:30: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 20:30: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 20:30: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 20:30: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 20:30: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 20:30: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 20:30:05 INFO - Downloading blobuploader-1.2.4.tar.gz 20:30:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:30:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:30:05 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 20:30:05 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 20:30:05 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 20:30:05 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 20:30:05 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 20:30:05 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 20:30:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:30:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:30:05 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 20:30:05 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 20:30:05 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 20:30:05 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 20:30:05 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 20:30:05 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 20:30:05 INFO - Downloading docopt-0.6.1.tar.gz 20:30:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:30:05 INFO - Installing collected packages: blobuploader, requests, docopt 20:30:05 INFO - Running setup.py install for blobuploader 20:30:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:30:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:30:06 INFO - Running setup.py install for requests 20:30:06 INFO - Running setup.py install for docopt 20:30:06 INFO - Successfully installed blobuploader requests docopt 20:30:06 INFO - Cleaning up... 20:30:06 INFO - Return code: 0 20:30:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:30:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:30:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:30:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:30:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:30:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:30:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:30:06 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 0x1495030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c4400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1753570>, '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 0x1754470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1754900>, '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': '934fc3100db09dcb9af4d4b6000001ab-1474253432.33310-1294809706', '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 20:30:06 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 20:30:06 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 20:30:06 INFO - Using env: {'DISPLAY': ':0', 20:30:06 INFO - 'HOME': '/home/cltbld', 20:30:06 INFO - 'LANG': 'en_US.UTF-8', 20:30:06 INFO - 'LANGUAGE': 'en_US:en', 20:30:06 INFO - 'LOGNAME': 'cltbld', 20:30:06 INFO - 'MAIL': '/var/mail/cltbld', 20:30:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:30:06 INFO - 'MOZ_NO_REMOTE': '1', 20:30:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:30:06 INFO - 'NO_EM_RESTART': '1', 20:30:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:30:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:30:06 INFO - 'PWD': '/builds/slave/test', 20:30:06 INFO - 'SHELL': '/bin/bash', 20:30:06 INFO - 'SHLVL': '1', 20:30:06 INFO - 'TERM': 'linux', 20:30:06 INFO - 'TMOUT': '86400', 20:30:06 INFO - 'USER': 'cltbld', 20:30:06 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1474253432.33310-1294809706', 20:30:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:30:06 INFO - '_': '/tools/buildbot/bin/python'} 20:30:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:30:06 INFO - Running setup.py (path:/tmp/pip-gxJW6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:30:06 INFO - Running setup.py (path:/tmp/pip-qeyp60-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:30:06 INFO - Running setup.py (path:/tmp/pip-MElf9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:30:06 INFO - Running setup.py (path:/tmp/pip-UCzPLk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:30:07 INFO - Running setup.py (path:/tmp/pip-jm11bM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:30:07 INFO - Running setup.py (path:/tmp/pip-tYpDlr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:30:07 INFO - Running setup.py (path:/tmp/pip-DGn5uN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:30:07 INFO - Running setup.py (path:/tmp/pip-RWzDCs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:30:07 INFO - Running setup.py (path:/tmp/pip-XxJ6r6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:30:07 INFO - Running setup.py (path:/tmp/pip-5huAyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:30:07 INFO - Running setup.py (path:/tmp/pip-SIT0vQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:30:07 INFO - Running setup.py (path:/tmp/pip-fxxzlk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:30:07 INFO - Running setup.py (path:/tmp/pip-CEtYSw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:30:07 INFO - Running setup.py (path:/tmp/pip-jVRyUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:30:07 INFO - Running setup.py (path:/tmp/pip-PX67Jj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:30:07 INFO - Running setup.py (path:/tmp/pip-dCHIz2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:30:07 INFO - Running setup.py (path:/tmp/pip-KP8aIx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:30:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:30:07 INFO - Running setup.py install for manifestparser 20:30:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:30:08 INFO - Running setup.py install for mozcrash 20:30:08 INFO - Running setup.py install for mozdebug 20:30:08 INFO - Running setup.py install for mozdevice 20:30:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:30:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:30:08 INFO - Running setup.py install for mozfile 20:30:08 INFO - Running setup.py install for mozhttpd 20:30:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:30:08 INFO - Running setup.py install for mozinfo 20:30:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:30:08 INFO - Running setup.py install for mozInstall 20:30:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:30:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:30:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:30:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:30:08 INFO - Running setup.py install for mozleak 20:30:08 INFO - Running setup.py install for mozlog 20:30:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:30:08 INFO - Running setup.py install for moznetwork 20:30:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:30:09 INFO - Running setup.py install for mozprocess 20:30:09 INFO - Running setup.py install for mozprofile 20:30:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:30:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:30:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:30:09 INFO - Running setup.py install for mozrunner 20:30:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:30:09 INFO - Running setup.py install for mozscreenshot 20:30:09 INFO - Running setup.py install for moztest 20:30:09 INFO - Running setup.py install for mozversion 20:30:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:30:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:30:09 INFO - Cleaning up... 20:30:09 INFO - Return code: 0 20:30:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:30:09 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')]} 20:30:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:30:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:30:09 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')]} 20:30:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:30:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:30:09 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 0x1495030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c4400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1753570>, '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 0x1754470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1754900>, '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': '934fc3100db09dcb9af4d4b6000001ab-1474253432.33310-1294809706', '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 20:30:09 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 20:30:09 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 20:30:09 INFO - Using env: {'DISPLAY': ':0', 20:30:09 INFO - 'HOME': '/home/cltbld', 20:30:09 INFO - 'LANG': 'en_US.UTF-8', 20:30:09 INFO - 'LANGUAGE': 'en_US:en', 20:30:09 INFO - 'LOGNAME': 'cltbld', 20:30:09 INFO - 'MAIL': '/var/mail/cltbld', 20:30:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:30:09 INFO - 'MOZ_NO_REMOTE': '1', 20:30:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:30:09 INFO - 'NO_EM_RESTART': '1', 20:30:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:30:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:30:09 INFO - 'PWD': '/builds/slave/test', 20:30:09 INFO - 'SHELL': '/bin/bash', 20:30:09 INFO - 'SHLVL': '1', 20:30:09 INFO - 'TERM': 'linux', 20:30:09 INFO - 'TMOUT': '86400', 20:30:09 INFO - 'USER': 'cltbld', 20:30:09 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1474253432.33310-1294809706', 20:30:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:30:09 INFO - '_': '/tools/buildbot/bin/python'} 20:30:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:30:09 INFO - Running setup.py (path:/tmp/pip-XsA5Oe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:30:10 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)) 20:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:30:10 INFO - Running setup.py (path:/tmp/pip-YtLHdE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:30:10 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)) 20:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:30:10 INFO - Running setup.py (path:/tmp/pip-bu09zu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:30:10 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)) 20:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:30:10 INFO - Running setup.py (path:/tmp/pip-xhjZcM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:30:10 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)) 20:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:30:10 INFO - Running setup.py (path:/tmp/pip-lfd4Mj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:30:10 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)) 20:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:30:10 INFO - Running setup.py (path:/tmp/pip-grgRLT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:30:10 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)) 20:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:30:10 INFO - Running setup.py (path:/tmp/pip-_uRkyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:30:10 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)) 20:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:30:10 INFO - Running setup.py (path:/tmp/pip-bvrllC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:30:10 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)) 20:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:30:10 INFO - Running setup.py (path:/tmp/pip-RuvbnR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:30:10 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)) 20:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:30:10 INFO - Running setup.py (path:/tmp/pip-P_vFyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:30:10 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)) 20:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:30:10 INFO - Running setup.py (path:/tmp/pip-1Ahet_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:30:10 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)) 20:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:30:10 INFO - Running setup.py (path:/tmp/pip-AXpd7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:30:10 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)) 20:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:30:10 INFO - Running setup.py (path:/tmp/pip-wR2sgZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:30:10 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)) 20:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:30:10 INFO - Running setup.py (path:/tmp/pip-_OW0kv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:30:10 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)) 20:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:30:10 INFO - Running setup.py (path:/tmp/pip-Wf1T5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:30:11 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)) 20:30:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:30:11 INFO - Running setup.py (path:/tmp/pip-K9zobq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:30:11 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)) 20:30:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:30:11 INFO - Running setup.py (path:/tmp/pip-4Mzn89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:30:11 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)) 20:30:11 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)) 20:30:11 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)) 20:30:11 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)) 20:30:11 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)) 20:30:11 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)) 20:30:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:30:11 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 20:30:11 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 20:30:11 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 20:30:11 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 20:30:11 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 20:30:11 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 20:30:13 INFO - Downloading blessings-1.6.tar.gz 20:30:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:30:13 INFO - Installing collected packages: blessings 20:30:13 INFO - Running setup.py install for blessings 20:30:13 INFO - Successfully installed blessings 20:30:13 INFO - Cleaning up... 20:30:13 INFO - Return code: 0 20:30:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:30:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:30:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:30:13 INFO - Reading from file tmpfile_stdout 20:30:13 INFO - Current package versions: 20:30:13 INFO - argparse == 1.2.1 20:30:13 INFO - blessings == 1.6 20:30:13 INFO - blobuploader == 1.2.4 20:30:13 INFO - docopt == 0.6.1 20:30:13 INFO - functools32 == 3.2.3-2 20:30:13 INFO - jsonschema == 2.5.1 20:30:13 INFO - manifestparser == 1.1 20:30:13 INFO - mozInstall == 1.12 20:30:13 INFO - mozcrash == 0.17 20:30:13 INFO - mozdebug == 0.1 20:30:13 INFO - mozdevice == 0.48 20:30:13 INFO - mozfile == 1.2 20:30:13 INFO - mozhttpd == 0.7 20:30:13 INFO - mozinfo == 0.9 20:30:13 INFO - mozleak == 0.1 20:30:13 INFO - mozlog == 3.3 20:30:13 INFO - moznetwork == 0.27 20:30:13 INFO - mozprocess == 0.23 20:30:13 INFO - mozprofile == 0.28 20:30:13 INFO - mozrunner == 6.12 20:30:13 INFO - mozscreenshot == 0.1 20:30:13 INFO - mozsystemmonitor == 0.3 20:30:13 INFO - moztest == 0.7 20:30:13 INFO - mozversion == 1.4 20:30:13 INFO - psutil == 3.1.1 20:30:13 INFO - requests == 1.2.3 20:30:13 INFO - wsgiref == 0.1.2 20:30:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:30:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:30:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:30:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:30:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:30:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:30:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:30:13 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 0x1495030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c4400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1753570>, '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 0x1754470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1754900>, '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': '934fc3100db09dcb9af4d4b6000001ab-1474253432.33310-1294809706', '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 20:30:13 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 20:30:13 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 20:30:13 INFO - Using env: {'DISPLAY': ':0', 20:30:13 INFO - 'HOME': '/home/cltbld', 20:30:13 INFO - 'LANG': 'en_US.UTF-8', 20:30:13 INFO - 'LANGUAGE': 'en_US:en', 20:30:13 INFO - 'LOGNAME': 'cltbld', 20:30:13 INFO - 'MAIL': '/var/mail/cltbld', 20:30:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:30:13 INFO - 'MOZ_NO_REMOTE': '1', 20:30:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:30:13 INFO - 'NO_EM_RESTART': '1', 20:30:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:30:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:30:13 INFO - 'PWD': '/builds/slave/test', 20:30:13 INFO - 'SHELL': '/bin/bash', 20:30:13 INFO - 'SHLVL': '1', 20:30:13 INFO - 'TERM': 'linux', 20:30:13 INFO - 'TMOUT': '86400', 20:30:13 INFO - 'USER': 'cltbld', 20:30:13 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1474253432.33310-1294809706', 20:30:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:30:13 INFO - '_': '/tools/buildbot/bin/python'} 20:30:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:30:13 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)) 20:30:13 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)) 20:30:13 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)) 20:30:13 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)) 20:30:13 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)) 20:30:13 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)) 20:30:13 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)) 20:30:13 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)) 20:30:13 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)) 20:30:13 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)) 20:30:13 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)) 20:30:13 INFO - Cleaning up... 20:30:13 INFO - Return code: 0 20:30:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:30:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:30:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:30:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:30:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:30:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:30:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:30:13 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 0x1495030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c4400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1753570>, '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 0x1754470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1754900>, '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': '934fc3100db09dcb9af4d4b6000001ab-1474253432.33310-1294809706', '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 20:30:13 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 20:30:13 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 20:30:13 INFO - Using env: {'DISPLAY': ':0', 20:30:13 INFO - 'HOME': '/home/cltbld', 20:30:13 INFO - 'LANG': 'en_US.UTF-8', 20:30:13 INFO - 'LANGUAGE': 'en_US:en', 20:30:13 INFO - 'LOGNAME': 'cltbld', 20:30:13 INFO - 'MAIL': '/var/mail/cltbld', 20:30:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:30:13 INFO - 'MOZ_NO_REMOTE': '1', 20:30:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:30:13 INFO - 'NO_EM_RESTART': '1', 20:30:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:30:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:30:13 INFO - 'PWD': '/builds/slave/test', 20:30:13 INFO - 'SHELL': '/bin/bash', 20:30:13 INFO - 'SHLVL': '1', 20:30:13 INFO - 'TERM': 'linux', 20:30:13 INFO - 'TMOUT': '86400', 20:30:13 INFO - 'USER': 'cltbld', 20:30:13 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1474253432.33310-1294809706', 20:30:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:30:13 INFO - '_': '/tools/buildbot/bin/python'} 20:30:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:30:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:30:13 INFO - Cleaning up... 20:30:13 INFO - Return code: 0 20:30:13 INFO - Running post-action listener: _resource_record_post_action 20:30:13 INFO - Running post-action listener: _start_resource_monitoring 20:30:14 INFO - Starting resource monitoring. 20:30:14 INFO - [mozharness: 2016-09-19 03:30:14.023573Z] Finished create-virtualenv step (success) 20:30:14 INFO - [mozharness: 2016-09-19 03:30:14.023997Z] Running install step. 20:30:14 INFO - Running pre-action listener: _resource_record_pre_action 20:30:14 INFO - Running main action method: install 20:30:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:30:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:30:14 INFO - Reading from file tmpfile_stdout 20:30:14 INFO - Detecting whether we're running mozinstall >=1.0... 20:30:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:30:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:30:14 INFO - Reading from file tmpfile_stdout 20:30:14 INFO - Output received: 20:30:14 INFO - Usage: mozinstall [options] installer 20:30:14 INFO - Options: 20:30:14 INFO - -h, --help show this help message and exit 20:30:14 INFO - -d DEST, --destination=DEST 20:30:14 INFO - Directory to install application into. [default: 20:30:14 INFO - "/builds/slave/test"] 20:30:14 INFO - --app=APP Application being installed. [default: firefox] 20:30:14 INFO - mkdir: /builds/slave/test/build/application 20:30:14 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'] 20:30:14 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 20:30:30 INFO - Reading from file tmpfile_stdout 20:30:30 INFO - Output received: 20:30:30 INFO - /builds/slave/test/build/application/firefox/firefox 20:30:30 INFO - Running post-action listener: _resource_record_post_action 20:30:30 INFO - [mozharness: 2016-09-19 03:30:30.848192Z] Finished install step (success) 20:30:30 INFO - [mozharness: 2016-09-19 03:30:30.848474Z] Running run-tests step. 20:30:30 INFO - Running pre-action listener: _resource_record_pre_action 20:30:30 INFO - Running main action method: run_tests 20:30:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:30:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:30:30 INFO - Python 2.7.3 20:30:30 INFO - Return code: 0 20:30:30 INFO - grabbing minidump binary from tooltool 20:30:30 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')]} 20:30:30 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 0x1753570>, '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 0x1754470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1754900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:30:30 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 20:30:30 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 20:30:30 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 20:30:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:30:30 INFO - Return code: 0 20:30:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:30:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:30:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:30:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:30:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:30:30 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/ePIxxufxTeCzWVOohoB-9w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 20:30:30 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/ePIxxufxTeCzWVOohoB-9w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --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 20:30:30 INFO - Using env: {'DISPLAY': ':0', 20:30:30 INFO - 'HOME': '/home/cltbld', 20:30:30 INFO - 'LANG': 'en_US.UTF-8', 20:30:30 INFO - 'LANGUAGE': 'en_US:en', 20:30:30 INFO - 'LOGNAME': 'cltbld', 20:30:30 INFO - 'MAIL': '/var/mail/cltbld', 20:30:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:30:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:30:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:30:30 INFO - 'MOZ_NO_REMOTE': '1', 20:30:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:30:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:30:30 INFO - 'NO_EM_RESTART': '1', 20:30:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:30:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:30:30 INFO - 'PWD': '/builds/slave/test', 20:30:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:30:30 INFO - 'SHELL': '/bin/bash', 20:30:30 INFO - 'SHLVL': '1', 20:30:30 INFO - 'TERM': 'linux', 20:30:30 INFO - 'TMOUT': '86400', 20:30:30 INFO - 'USER': 'cltbld', 20:30:30 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1474253432.33310-1294809706', 20:30:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:30:30 INFO - '_': '/tools/buildbot/bin/python'} 20:30:30 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/ePIxxufxTeCzWVOohoB-9w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 20:30:31 INFO - mozversion application_buildid: 20160918173718 20:30:31 INFO - mozversion application_changeset: 896a7672b83764829bbfc93e285d03bf318d3a5b 20:30:31 INFO - mozversion application_display_name: FirefoxDeveloperEdition 20:30:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:30:31 INFO - mozversion application_name: Firefox 20:30:31 INFO - mozversion application_remotingname: firefox-dev 20:30:31 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 20:30:31 INFO - mozversion application_vendor: Mozilla 20:30:31 INFO - mozversion application_version: 50.0a2 20:30:31 INFO - mozversion platform_buildid: 20160918173718 20:30:31 INFO - mozversion platform_changeset: 896a7672b83764829bbfc93e285d03bf318d3a5b 20:30:31 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 20:30:31 INFO - mozversion platform_version: 50.0a2 20:30:31 INFO - using testdate: 1474255831 20:30:31 INFO - actual date: 1474255831 20:30:31 INFO - starting webserver on 'localhost:38762' 20:30:31 INFO - SUITE-START | Running 2 tests 20:30:31 INFO - TEST-START | dromaeo_css 20:30:31 INFO - operating with platform_type : linux_ 20:30:31 INFO - Initialising browser for dromaeo_css test... 20:30:31 INFO - TEST-INFO | started process 9639 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3MZb_V/profile http://localhost:38762/getInfo.html) 20:30:35 INFO - PROCESS | 9639 | __metrics Screen width/height:1600/1200 20:30:35 INFO - PROCESS | 9639 | colorDepth:24 20:30:35 INFO - PROCESS | 9639 | Browser inner width/height: 1024/697 20:30:35 INFO - PROCESS | 9639 | __metrics 20:30:36 ERROR - PROCESS | 9639 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 20:30:37 INFO - TEST-INFO | 9639: exit 0 20:30:37 INFO - Browser initialized. 20:30:37 INFO - Running cycle 1/1 for dromaeo_css test... 20:30:37 INFO - TEST-INFO | started process 9763 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3MZb_V/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:30:49 INFO - PROCESS | 9763 | RSS: Main: 153481216 20:30:49 INFO - PROCESS | 9763 | 20:31:38 INFO - PROCESS | 9763 | 1474255898648 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] 20:33:47 INFO - PROCESS | 9763 | Cycle 1(1): loaded http://localhost:38762/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38762/tests/dromaeo/cssquery-ext.html) 20:33:48 INFO - PROCESS | 9763 | RSS: Main: 160792576 20:33:48 INFO - PROCESS | 9763 | 20:36:50 INFO - PROCESS | 9763 | Cycle 1(1): loaded http://localhost:38762/tests/dromaeo/cssquery-ext.html (next: http://localhost:38762/tests/dromaeo/cssquery-jquery.html) 20:36:51 INFO - PROCESS | 9763 | RSS: Main: 156172288 20:36:51 INFO - PROCESS | 9763 | 20:39:52 INFO - PROCESS | 9763 | Cycle 1(1): loaded http://localhost:38762/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38762/tests/dromaeo/cssquery-mootools.html) 20:39:53 INFO - PROCESS | 9763 | RSS: Main: 155721728 20:39:53 INFO - PROCESS | 9763 | 20:42:55 INFO - PROCESS | 9763 | Cycle 1(1): loaded http://localhost:38762/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38762/tests/dromaeo/cssquery-prototype.html) 20:42:55 INFO - PROCESS | 9763 | RSS: Main: 154451968 20:42:55 INFO - PROCESS | 9763 | 20:45:58 INFO - PROCESS | 9763 | Cycle 1(1): loaded http://localhost:38762/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38762/tests/dromaeo/cssquery-yui.html) 20:45:58 INFO - PROCESS | 9763 | RSS: Main: 157306880 20:45:58 INFO - PROCESS | 9763 | 20:49:01 INFO - PROCESS | 9763 | Cycle 1(1): loaded http://localhost:38762/tests/dromaeo/cssquery-yui.html (next: http://localhost:38762/tests/dromaeo/cssquery-dojo.html) 20:49:01 INFO - PROCESS | 9763 | RSS: Main: 157147136 20:49:01 INFO - PROCESS | 9763 | 20:49:01 INFO - PROCESS | 9763 | __start_tp_report 20:49:01 INFO - PROCESS | 9763 | _x_x_mozilla_page_load 20:49:01 INFO - PROCESS | 9763 | _x_x_mozilla_page_load_details 20:49:01 INFO - PROCESS | 9763 | |i|pagename|runs| 20:49:01 INFO - PROCESS | 9763 | |0;dojo.html;3270.280538281578;3378.763486555939;3393.202597389613;3398.0655319787056;3408.8977330680073;5881.264841894763;5901.940980590193;5911.527077833774;6010.819675409739;6013.518918486521;5818.243628328322;5885.705714714269;5888.823335299937;5894.852628684285;5998.730057147428;5225.555827754645;5340;5382.784688612471;5436.83689489314;5450;5278.155495120782;5343.064963631368;5368.00691872003;5411.675299482044;5429.972850135763;5368.8389348319615;5380.91928621071;5403.918941215865;5470.234167216593;5480.068388373986;5452.154915988028;5460.290162278918;5460.945390546083;5461.726913654302;5475.945240547583;5161.509656582619;5190;5293.57651387888;5367.275417818583;5470.070088085035;5729.770809167629;5798.449147330997;5812.011957967114;5822.97088514559;5850.180974663551;6211.658358790265;6241.157443745127;6293.244810622755;6311.873762524724;6318.241810982666;6083.117947897575;6309.305976342599;6311.495080393557;6353.523485738542;6357.427831495188;5911.172435858984;5995.370486098984;6010.579259451796;6021.729022194012;6026.54800889935;6548.508861835381;6561.179852518435;6584.308647591934;6616.338366163442;6616.371444712745;6060.939390606126;6152.046432802923;6294.433500984934;6311.242650881832;6335.904961425582;6259.374062593704;6360.204974378203;6382.361763823674;6410.487161027107;6418.358164183544;6288.496920246369;6315.36846315374;6322.873542529215;6323.27282362525;6326.746930122836;6119.715820550745;6133.365267548864;6370.331115232926;6374.298827129012;6376.426121648981;4725.36207611968;4751.548602882721;4754.524547545287;4786.928196077061;4800.35195248644;4201.810918508613;4234.830606775756;4253.064325848309;4256;4267.509236437787;5871.55963302754;5941.70291485424;6036;6039;6056.273247210275;6195.132681424604;6298.401651843067;6357.332480089616;6367.299597044322;6372.139761132188;6064.969675151596;6093.26880774301;6097.451229389288;6107.053406721965;6109.297430795426;5392;5412.404635490093;5426.430224826337;5466.617336786387;5477.4796394343275;6527.249366322933;6532.934670653232;6580.407763301326;6600.537962342686;6619.966900165468;6293.937060629335;6310.116583678197;6378.776742814165;6398.296187419287;6405.231372235362;6386.552941294251;6541.051547525677;6564.901526477202;6576.177977752781;6620.966895165493;6309.558330916791;6323.620582765049;6340.1123842661145;6342.175517182736;6343.0485427186295;6455.515836312389;6468.191476065492;6469.029645553204;6475.352464753675;6502.122213501117;5988.520918326611;6118.9846826261555;6163.84590385244;6292.370762923671;6294.685265736786;6249.468795152281;6281;6285.371462853678;6288.339724328879;6288.874222515616;6234.688265586793;6237.625742455467;6258.593191442542;6293.992961126198;6300.653464059521;6056.364081771527;6141.05644955797;6160.630362178284;6221.4089661482085;6277;6069.332373439007;6091.939080609137;6101.572889897842;6106.175666284995;6117.938820611915 20:49:01 INFO - PROCESS | 9763 | |1;ext.html;570.5578176912892;635.1584150999926;639.622622652635;658.1345530627225;690.8480134370436;40908;44706.776466117626;44982.32526512097;45020.77489612548;45278.320825187606;44339;44661.55338446615;44860.775696121476;44863;44898.32652510215;9116.1339672731;9236.353455258135;9255.44467331959;9268.25853931684;9268.953655231715;9226.769330766718;9227.44635321883;9243.53782310885;9260;9270.67552635658;9296.8605470918;9331.440113593173;9339.299552533554;9339.43963362197;9349.392289501195;9268.25853931684;9294.395864268801;9308.813823723556;9309.906900930971;9316.58075386606;9093.545322733837;9140.6800761973;9151.313651476166;9152;9154.908450915473;43836.780816096034;44054.33918491225;44115;44122;44248.77875610634;3861.262431905626;4021.939670904939;4040.373742069984;4416.271315233015;4788.688735232234;34662.30675386478;35171.4724279136;35325;36728;36830.263394731955;4009.67922566194;4057.9391309130388;4151.12826306476;4224.8732538023905;4291.849785257501;414675;416354;417002;420435;421993;66110;66794.33205667978;66838.66580667066;66978;67011.66494167499;39552.60447395547;40172.598274016884;40322.19355612871;42653;42806;18743.812561874478;18784.53038674044;18904;19026;19085.236590536224;14820.925895370454;14942.402303907722;14994.850051499345;15006.324715387835;15011.849881501264;21184.788152118283;21223.893880530497;21313.25403610866;21390.465238368855;21567.2451464198;7598.772036838904;7701.768946931601;7707.421943354271;7784.2994130527395;7851.685932562747;1060.390275591538;1091.3015669971226;1100.3068067117665;1139.1228753859482;1191.74377508836;34332.82833585816;34333.31333373318;34921.301573968376;34956.47565286523;34976;1146.9139814513944;1177.3701069927547;1184.8045072562932;1190.8987736042534;1201.591458903977;17576.736348954775;17948.730769038473;18202.271909123752;18328.816711832977;18444.631107378045;656395;667885;668423;668563;670890;63065;64135.35864641387;64238;64266;64999.35000650027;1436.4972259709018;1440.2150827798876;1458.8030615867146;1464.699736554004;1464.7070585882652;32042.679573204903;33414.33171336511;33839.661603383654;33871.83064084664;34011;55923;56256;56286.718566406904;56376.71811640915;56388;506265;508986;510486;511032;513184;31504.527432088078;31658.525122123647;31757.682423175473;31774.205644859063;32168.517472238404;52509;52584.21123683224;53335;53909.46090539044;54260.45739542554;44860.32709509294;45698.31452528281;46310.53689463062;46441.53558464507;47059.529404705514;44080.442262651035;45571;46477;47499.52500475089;47951.76024119857;43998;44296.55703442924;44930.55069449264;45149.32276015928;45254.54745452635;38501.4224786634;40424;40999.1800164001;41166.1766764669;41282.587174127875;30020;30306;30422.23944401319;30479.695203048574;30639.234019148807 20:49:01 INFO - PROCESS | 9763 | |2;jquery.html;425.4235510882756;425.8996652963392;429.55970130616123;434.9021470169212;441.25868540851354;18873;20353.491162720922;20584.279550215746;21440.14239430421;21491;19198;20466.795332046677;20848.270310539134;20892.164313427482;21201.681974770352;6032.879342413149;6188.071789231606;6193.566450348478;6202.751889924398;6216.409441103088;6105.755769769226;6110.511159107283;6115.9694201529155;6146.29317628474;6152.077188421727;6038.758449662008;6066.939330606681;6072.423119803611;6099.7865074722395;6107.725152368132;6023;6030.879382412371;6045.153678485016;6045.395460453941;6073.574849760518;5221.55616772571;5407.080796264605;5422.267993820823;5446.673199608036;5474.2609747683955;13545.45818167282;13707.588772336845;14883.107013579112;14885.330160142712;14895.925520372437;2317.721873375189;2467.3954881054256;2536.201096654548;2772.986135069332;2994.895178668736;10987.505562249638;11041.503132359063;11042.447877606088;11059.004689577976;11209.383483908381;1995.980040199594;2013.1242909334487;2070.492729281321;2079.07481170879;2085.0721428964116;77970;85382.57308713479;87650;87957.12042879617;88755.55622221848;11545.307281563133;11603.361815100081;11606.477708503138;11739.823902641467;11902.047836173086;16737.91631041837;16799.916000420166;16818;16818.159092045593;16843.578910527336;8608.225259726654;8947.642094316154;8986.86519702205;9006.819863602823;9185.311101667268;8719.694810681596;8735.694250701195;8769.254613357936;8852.468851868909;8955.05971872957;5011.273365362075;5078.339815823993;5102.805500826312;5103;5117.053345131163;2056.804603562689;2133.008151209695;2170.4899348653053;2194.813440857513;2226.1540614566684;948.7533241357297;991.2466525440717;1027.7584767579613;1037.9636712715019;1076.359566058194;19772.505687357643;20092.69860952087;20146.89926550358;20427;20847.47881302949;1073.8926107389198;1074.7347928006732;1080.8108580998294;1093.4532733633184;1148.5922497513263;11150.442477876073;11540.192186547029;11740.823887641693;11758.235714678518;11834;474928;481691;483118;491642;509930;95045;95152.52423737837;97580;98037.50981245049;98368;1054.283087500507;1058.8147074261974;1062.3413483640193;1067.4982758103679;1073.8550295709979;15680.529584112495;16953.576160596083;17372.739408908623;18225.347897651074;18591.814081859007;29137.41725165527;36223.818880905426;40882.38676419797;42027.36958945557;44415.33376999283;55621;60712.39287607244;61489.69255153696;61696.38303616906;62456.375436246875;9202;9221;9259.305552083755;9265.166135047879;9344.205742511962;10629.9468502657;14212.644683882985;14308.785368219693;14426.711465770415;14852.183129927958;12061.216020958609;12718.10973231865;12722.87277127254;12767.74464510686;12783.488660453479;12258.87741122613;12500.24998500093;12558.246505209716;12617.68455788576;12752.298623575422;12700.36498175106;12725.300108494122;12748.745025099632;12752.808707869204;12961;9085.273178145864;9221.631134754534;9235.815283694423;9253.861192082259;9277.814443711222;11028.834567481656;12369.93815030919;12538.498460061495;12724.109312348417;12761.425735841724 20:49:01 INFO - PROCESS | 9763 | |3;mootools.html;1570.9293081811318;1578.9842101578981;1733.6186039071408;1788.5975655477528;1878.9665683873866;8605.526696031715;9299.81400371993;9338.439693618388;10022.749431264223;10035.448050357227;9415.152636262736;9710.514474276275;9738.269629777777;9746.31775775696;9751.366161199518;2494.5634513960076;2543.5294470523013;2544.427503811646;2545.7199708032103;2547.0957809977467;2512.510060538196;2597.714251432341;2602.037246218892;2602.141293373182;2615.6861176658826;2586.4439145583697;2593.1183397644795;2596.714361420252;2600.7646367975153;2608.6478325426015;2508.761667641571;2517.0309430869156;2524.129175434472;2531.721510633829;2537.5432422164004;2478.7149477810103;2499.562576549097;2522.924312270635;2524.040864471489;2525.7095434025136;9732.70801875945;9923.454210018446;9943.105120539187;9950.054744799232;9967;5773.451522105393;5898.7640494380175;5923.940760592425;5924.792632257893;5928.49607783339;3473.235888104613;3557.94663080054;3561.928761424783;3570.767900086486;3658.048907284125;1104.3263609198382;1174.2543484887074;1182.7338848759046;1188.696882295018;1197.3474456421272;13930.860691393058;14003.71992560143;14096.859031409656;14169.574912752634;14208.502702405469;5156.535911767959;5261.631685781958;5405.351357837085;5405.675659460445;5429.375621803464;11604.709882252842;11891.28652280866;11893.226940248856;11947.880521194676;12060.457279422448;5958.940410595838;5984.401559843981;5990.5507086968655;6024.909626355608;6025.638461692312;4657.67396282257;5340.385855626652;5351.143816989263;5433.0763770159165;5494.587905907073;4540.795664195053;4550.817967281338;4607.262837945913;4617.907641847144;4642.0715856828765;1419.1556024165604;1428.8283607441797;1440.683049729079;1487.1523231757794;1490.866941124753;988.2983082011853;1016.1261315268863;1018.251585084962;1021.6373187518324;1035.2184101003695;6002.849928751729;6029.427204415573;6260.217472815898;6301.635348298252;6372.171617689671;522.3966318901674;523.264812937823;526.5550609734845;527.5410392958152;533.2694208933785;4054.1688953764406;4241.597048280409;4241.681121279185;4270.594293542109;4321.135772845443;11843.703907402383;12160.270383777002;12182.512699491921;12188.695282618006;12270.815937760763;11783.764324713458;12042.458089385998;12085.879141208652;12105.33420661872;12276.202046866925;8862.291016718647;9001.864972025425;9056.773580660405;9107.499087550248;9121.45271283725;6152.384761523812;6212;6267.62394256346;6294.433500984934;6313.43179113882;10902.890971090188;11198.664040078811;11242.718932026764;11289.20975531705;11331.943340283246;11179.888201117885;11251.662450126509;11396.373199474108;11491.253068550517;11656.650300491;7439.479236453396;8025.157358477276;8237.50574965504;8520.659173632985;8598.140185981352;9115.453072815651;9199.954000229956;9211.861822072808;9224.861627075465;9262.907370926205;7982.321502672338;8172.101068882299;8263.876041859257;8355.874661879956;8550.74347769568;7466.589337586268;7491.513051651843;7589.3549048329305;8128.552929588929;8178.1821817817745;7199.784006479814;7232.710691572278;7303.963480182565;7378.372838308804;7389.926100738924;5216.608754343363;5243.790248390174;5269.288646032736;5273.789048438173;5373.919391209057;5372.704501252312;5394.622376433612;5492.890142197213;5503.752331145028;5511.255980442749 20:49:01 INFO - PROCESS | 9763 | |4;prototype.html;361.887814777419;365.42080801928944;365.5120414246978;366.2181243046097;376.59327925840097;5677.240055582773;5829.47534721876;5915.728118454532;5981.671008094553;5991.430814072662;5864.3256025557075;5894.2042824218715;5897.997340452122;5899.675517846516;5909.113632955059;4651.976740116294;4663.323818046381;4665.790039448233;4680.729846024676;4708.811647534095;4485.7084289521235;4558.065596552716;4597.310403439477;4642.141203877277;4707.552782485658;4540.318952157169;4550.886227844314;4564.8174073037035;4576.588107070363;4589.47221069578;4588.885277868047;4597.172508948388;4620.861374158781;4624.577812418819;4627.768611569408;3875.8837234883;3976.224636195943;4032.5160980682213;4093.672506199497;4095.5494895561465;5674.290713660793;5692.943070569283;5716.256886604757;5716.914246286309;5753.568482363839;5272.604554658416;5292.338457692788;5292.391374991848;5300.867478313035;5318.707471089088;5782.421757824226;6068.211132552784;6123.724432400552;6147.969260153715;6187.3503282155625;4399.802008909607;4410.845620403303;4446.55534446556;4448.065906159711;4467.82128714851;6238.438540531374;6440.806775796734;6464.870702585969;6470.417662410358;6474.287828338879;4491.236489796743;4493.640508759291;4495.393121928498;4509.842155524541;4523.7285762854335;4581.8625441236145;4600.700954438018;4605.769711514478;4611.700239484423;4613.215753321943;5135.717535535507;5257.763400646903;5257.7896884124975;5258;5259.789608415697;6000.459958603747;6207;6233.470155036782;6250.124982502453;6259.715203950525;1589.8887077904667;1597.1535086403992;1602.9358825646843;1603.7834892289625;1614.6770645870638;957.3537861943161;981.4258658684606;998.7203582996773;1002.7693630465034;1013.5742987945081;5362.570994320445;5384.596155288369;5422.53908417781;5426.04662321564;5485.162470572323;5574.637648552831;5623;5680.460356266148;5690.658560486301;5704.600677952503;5384.892302154013;5432.864178395572;5689.516391106719;6120.510359171256;6138.342647485243;3425.2635683328203;3458.9827050865088;3461.6019157797177;3473.2706131712116;3475.2528206435736;6348.206474190726;6620.933790662128;6636.834079147963;6636.966815165893;6678.432333251631;6548.9017664735065;6560.916369306418;6563.737450502022;6575.506836987245;6586.670666466754;6181.289151747516;6675.265720770712;6690.799276021728;6745.898811517831;6762.966185169141;6246.906296405648;6402.583832050902;6426.742930282736;6439.710213040518;6450.967745161432;6354.968225159029;6362.650054247061;6369.8726025480155;6371.139896113966;6371.968140159455;6417.71120299597;6538.574992625464;6580.420699032102;6584.604923704593;6627.734890604322;4542.704724192917;4599.149157405891;4608.516105808976;4625.306204069282;4625.7918393673035;6382.808515744535;6426.325235850169;6450.580712253689;6493.675316234264;6498.707558159799;6199.876002480015;6238.222106699569;6260.780872669435;6275.811725648238;6283.434490895841;5978.8206353809455;6228.4394404502;6313.558050936574;6335.303116657072;6344.429001389897;6214.5028397728975;6217.96891015542;6228.909940760439;6232.563720539519;6245.750169993331;6269.1819372383325;6294.024426213944;6329.30377658448;6350.269718982377;6382.6170429774365;5897.469227769521;6042.939570604413;6090.817275481742;6148.723307451265;6154.938450615616 20:49:01 INFO - PROCESS | 9763 | |5;yui.html;811.3874025111044;834.3408707121374;850.7192626433276;869.7738587967128;922.5433410461823;15831.762523562156;17082.74375884361;18452;18579.163937622805;18770.812291877093;16384.590385240375;16417.83582164178;16493.67012659749;16690;16735.581610459743;870.4168207301124;877.1666916429385;877.9341549383806;884.8451520983834;886.6098916476761;869.0744357259498;869.3566760597175;870.5386145342978;874.9893872577184;881.259741816877;908.550267617527;910.4810258152855;912.4525284829116;915.2952226785404;916.5142474488532;898.5372533145435;905.343625871238;907.0929070929005;910.8633704944278;912.4707669551677;668.9230738465042;669.8358902068976;670.718298314709;674.0866126398757;675.5541342713785;15459.38162473511;15524.379024838992;15527;15602.141882196474;15637.843621563752;17069.402570910082;17150.742738858928;17201.655966880717;17457.912710436492;17785.288588456446;13931.512397066155;13932.787651546027;14047.22740249286;14057.78913316301;14371;4174.269502837022;4222.5566315536735;4223.282042052859;4223.852165174204;4375.518692943773;90634.5468272661;90889.54555227248;92560;94035;94253;12940.741185176244;12991.220526768424;12997.025223108305;12998.740025199442;13260.204387736574;24898.502029959298;24930.37674058127;25073.749262507507;25206.117785877406;26175.214743557724;9191.356605037718;9284.907150928404;9425.38734982224;9548.18840398574;9895.30732848708;4906.6320025997475;5072.163093089599;5162.664426812245;5196.610254230948;5326.813561525406;3959.821808018646;4100.876973690794;4106.240345536085;4111.321631930698;4126.8761937141935;698.7205117952758;701.9333163349473;703.0754557756534;716.2622498826217;719.7876626395226;633.9239291284983;639.4468784501373;653.3368630839701;684.0833283400268;692.2904023376079;9665.661701840543;10010.54952527138;10012.148967337858;10223.233257505568;10995.560177592806;641.252940324526;649.9837504062342;663.3631713555042;671.4594751225213;686.4954258619911;4644.744539050384;4742.933407701023;4938.629602779806;4961.13511410011;5011.462174823069;75702.24297756952;77087.61456192796;95699.52150239343;136239.31880340734;141308;89667;90917;115905.4204728971;117312;119561;89011.55494222487;89049.10950890408;90469;94088.52955735315;94108;9940.778764243394;9997.800043999225;10056.949715251378;10164.390136591828;10252.487375631039;52625.7368713154;53135.73432132969;53321.20018199652;54071.45928540664;54853.72573137269;54653.72673136768;77910.61044694741;79187.60406197932;80399.19600803917;80985.59507202427;13459.46162153542;13977.08414075454;14150.504732334319;14235.857641423454;14386.208758518382;15184.01303915242;15564.687459480001;15884.31148437121;16031;16392.508224753277;14305.64235894111;14407.207603581903;14490.34793434277;14528.27358632043;14577.125372477685;15568.610784730472;15631.29659165363;15671.764923525929;15761.842381576038;15789.684206316038;14371.425142994163;14467.565973020826;14517.419303227753;14669.633259168178;14924.925375373054;11408;11427.542898284308;11568.24806387582;11817.350045747566;11936.940315298369;11139.387333696724;11581.82627260575;11731.589394371156;11744.412779361168;11798.823017654571 20:49:01 INFO - PROCESS | 9763 | __end_tp_report 20:49:01 INFO - PROCESS | 9763 | __start_cc_report 20:49:01 INFO - PROCESS | 9763 | _x_x_mozilla_cycle_collect,345 20:49:01 INFO - PROCESS | 9763 | __end_cc_report 20:49:01 INFO - PROCESS | 9763 | __startTimestamp1474256941551__endTimestamp 20:49:01 INFO - PROCESS | 9763 | 20:49:01 INFO - PROCESS | 9763 | ------- Summary: start ------- 20:49:01 INFO - PROCESS | 9763 | Number of tests: 6 20:49:01 INFO - PROCESS | 9763 | 20:49:01 INFO - PROCESS | 9763 | [#0] dojo.html Cycles:165 Average:5889.40 Median:6109.30 stddev:694.34 (11.4%) stddev-sans-first:665.37 20:49:01 INFO - PROCESS | 9763 | Values: 3270.3 3378.8 3393.2 3398.1 3408.9 5881.3 5901.9 5911.5 6010.8 6013.5 5818.2 5885.7 5888.8 5894.9 5998.7 5225.6 5340.0 5382.8 5436.8 5450.0 5278.2 5343.1 5368.0 5411.7 5430.0 5368.8 5380.9 5403.9 5470.2 5480.1 5452.2 5460.3 5460.9 5461.7 5475.9 5161.5 5190.0 5293.6 5367.3 5470.1 5729.8 5798.4 5812.0 5823.0 5850.2 6211.7 6241.2 6293.2 6311.9 6318.2 6083.1 6309.3 6311.5 6353.5 6357.4 5911.2 5995.4 6010.6 6021.7 6026.5 6548.5 6561.2 6584.3 6616.3 6616.4 6060.9 6152.0 6294.4 6311.2 6335.9 6259.4 6360.2 6382.4 6410.5 6418.4 6288.5 6315.4 6322.9 6323.3 6326.7 6119.7 6133.4 6370.3 6374.3 6376.4 4725.4 4751.5 4754.5 4786.9 4800.4 4201.8 4234.8 4253.1 4256.0 4267.5 5871.6 5941.7 6036.0 6039.0 6056.3 6195.1 6298.4 6357.3 6367.3 6372.1 6065.0 6093.3 6097.5 6107.1 6109.3 5392.0 5412.4 5426.4 5466.6 5477.5 6527.2 6532.9 6580.4 6600.5 6620.0 6293.9 6310.1 6378.8 6398.3 6405.2 6386.6 6541.1 6564.9 6576.2 6621.0 6309.6 6323.6 6340.1 6342.2 6343.0 6455.5 6468.2 6469.0 6475.4 6502.1 5988.5 6119.0 6163.8 6292.4 6294.7 6249.5 6281.0 6285.4 6288.3 6288.9 6234.7 6237.6 6258.6 6294.0 6300.7 6056.4 6141.1 6160.6 6221.4 6277.0 6069.3 6091.9 6101.6 6106.2 6117.9 20:49:01 INFO - PROCESS | 9763 | 20:49:01 INFO - PROCESS | 9763 | [#1] ext.html Cycles:180 Average:69241.71 Median:24332.53 stddev:144156.46 (592.4%) stddev-sans-first:144468.65 20:49:01 INFO - PROCESS | 9763 | Values: 570.6 635.2 639.6 658.1 690.8 40908.0 44706.8 44982.3 45020.8 45278.3 44339.0 44661.6 44860.8 44863.0 44898.3 9116.1 9236.4 9255.4 9268.3 9269.0 9226.8 9227.4 9243.5 9260.0 9270.7 9296.9 9331.4 9339.3 9339.4 9349.4 9268.3 9294.4 9308.8 9309.9 9316.6 9093.5 9140.7 9151.3 9152.0 9154.9 43836.8 44054.3 44115.0 44122.0 44248.8 3861.3 4021.9 4040.4 4416.3 4788.7 34662.3 35171.5 35325.0 36728.0 36830.3 4009.7 4057.9 4151.1 4224.9 4291.8 414675.0 416354.0 417002.0 420435.0 421993.0 66110.0 66794.3 66838.7 66978.0 67011.7 39552.6 40172.6 40322.2 42653.0 42806.0 18743.8 18784.5 18904.0 19026.0 19085.2 14820.9 14942.4 14994.9 15006.3 15011.8 21184.8 21223.9 21313.3 21390.5 21567.2 7598.8 7701.8 7707.4 7784.3 7851.7 1060.4 1091.3 1100.3 1139.1 1191.7 34332.8 34333.3 34921.3 34956.5 34976.0 1146.9 1177.4 1184.8 1190.9 1201.6 17576.7 17948.7 18202.3 18328.8 18444.6 656395.0 667885.0 668423.0 668563.0 670890.0 63065.0 64135.4 64238.0 64266.0 64999.4 1436.5 1440.2 1458.8 1464.7 1464.7 32042.7 33414.3 33839.7 33871.8 34011.0 55923.0 56256.0 56286.7 56376.7 56388.0 506265.0 508986.0 510486.0 511032.0 513184.0 31504.5 31658.5 31757.7 31774.2 32168.5 52509.0 52584.2 53335.0 53909.5 54260.5 44860.3 45698.3 46310.5 46441.5 47059.5 44080.4 45571.0 46477.0 47499.5 47951.8 43998.0 44296.6 44930.6 45149.3 45254.5 38501.4 40424.0 40999.2 41166.2 41282.6 30020.0 30306.0 30422.2 30479.7 30639.2 20:49:01 INFO - PROCESS | 9763 | 20:49:01 INFO - PROCESS | 9763 | [#2] jquery.html Cycles:180 Average:29423.52 Median:2182.65 stddev:80687.04 (3696.7%) stddev-sans-first:80884.02 20:49:01 INFO - PROCESS | 9763 | Values: 425.4 425.9 429.6 434.9 441.3 18873.0 20353.5 20584.3 21440.1 21491.0 19198.0 20466.8 20848.3 20892.2 21201.7 6032.9 6188.1 6193.6 6202.8 6216.4 6105.8 6110.5 6116.0 6146.3 6152.1 6038.8 6066.9 6072.4 6099.8 6107.7 6023.0 6030.9 6045.2 6045.4 6073.6 5221.6 5407.1 5422.3 5446.7 5474.3 13545.5 13707.6 14883.1 14885.3 14895.9 2317.7 2467.4 2536.2 2773.0 2994.9 10987.5 11041.5 11042.4 11059.0 11209.4 1996.0 2013.1 2070.5 2079.1 2085.1 77970.0 85382.6 87650.0 87957.1 88755.6 11545.3 11603.4 11606.5 11739.8 11902.0 16737.9 16799.9 16818.0 16818.2 16843.6 8608.2 8947.6 8986.9 9006.8 9185.3 8719.7 8735.7 8769.3 8852.5 8955.1 5011.3 5078.3 5102.8 5103.0 5117.1 2056.8 2133.0 2170.5 2194.8 2226.2 948.8 991.2 1027.8 1038.0 1076.4 19772.5 20092.7 20146.9 20427.0 20847.5 1073.9 1074.7 1080.8 1093.5 1148.6 11150.4 11540.2 11740.8 11758.2 11834.0 474928.0 481691.0 483118.0 491642.0 509930.0 95045.0 95152.5 97580.0 98037.5 98368.0 1054.3 1058.8 1062.3 1067.5 1073.9 15680.5 16953.6 17372.7 18225.3 18591.8 29137.4 36223.8 40882.4 42027.4 44415.3 55621.0 60712.4 61489.7 61696.4 62456.4 9202.0 9221.0 9259.3 9265.2 9344.2 10629.9 14212.6 14308.8 14426.7 14852.2 12061.2 12718.1 12722.9 12767.7 12783.5 12258.9 12500.2 12558.2 12617.7 12752.3 12700.4 12725.3 12748.7 12752.8 12961.0 9085.3 9221.6 9235.8 9253.9 9277.8 11028.8 12369.9 12538.5 12724.1 12761.4 20:49:01 INFO - PROCESS | 9763 | 20:49:01 INFO - PROCESS | 9763 | [#3] mootools.html Cycles:180 Average:6337.86 Median:4649.87 stddev:3705.46 (79.7%) stddev-sans-first:3698.54 20:49:01 INFO - PROCESS | 9763 | Values: 1570.9 1579.0 1733.6 1788.6 1879.0 8605.5 9299.8 9338.4 10022.7 10035.4 9415.2 9710.5 9738.3 9746.3 9751.4 2494.6 2543.5 2544.4 2545.7 2547.1 2512.5 2597.7 2602.0 2602.1 2615.7 2586.4 2593.1 2596.7 2600.8 2608.6 2508.8 2517.0 2524.1 2531.7 2537.5 2478.7 2499.6 2522.9 2524.0 2525.7 9732.7 9923.5 9943.1 9950.1 9967.0 5773.5 5898.8 5923.9 5924.8 5928.5 3473.2 3557.9 3561.9 3570.8 3658.0 1104.3 1174.3 1182.7 1188.7 1197.3 13930.9 14003.7 14096.9 14169.6 14208.5 5156.5 5261.6 5405.4 5405.7 5429.4 11604.7 11891.3 11893.2 11947.9 12060.5 5958.9 5984.4 5990.6 6024.9 6025.6 4657.7 5340.4 5351.1 5433.1 5494.6 4540.8 4550.8 4607.3 4617.9 4642.1 1419.2 1428.8 1440.7 1487.2 1490.9 988.3 1016.1 1018.3 1021.6 1035.2 6002.8 6029.4 6260.2 6301.6 6372.2 522.4 523.3 526.6 527.5 533.3 4054.2 4241.6 4241.7 4270.6 4321.1 11843.7 12160.3 12182.5 12188.7 12270.8 11783.8 12042.5 12085.9 12105.3 12276.2 8862.3 9001.9 9056.8 9107.5 9121.5 6152.4 6212.0 6267.6 6294.4 6313.4 10902.9 11198.7 11242.7 11289.2 11331.9 11179.9 11251.7 11396.4 11491.3 11656.7 7439.5 8025.2 8237.5 8520.7 8598.1 9115.5 9200.0 9211.9 9224.9 9262.9 7982.3 8172.1 8263.9 8355.9 8550.7 7466.6 7491.5 7589.4 8128.6 8178.2 7199.8 7232.7 7304.0 7378.4 7389.9 5216.6 5243.8 5269.3 5273.8 5373.9 5372.7 5394.6 5492.9 5503.8 5511.3 20:49:01 INFO - PROCESS | 9763 | 20:49:01 INFO - PROCESS | 9763 | [#4] prototype.html Cycles:180 Average:5198.95 Median:5768.00 stddev:1532.77 (26.6%) stddev-sans-first:1493.45 20:49:01 INFO - PROCESS | 9763 | Values: 361.9 365.4 365.5 366.2 376.6 5677.2 5829.5 5915.7 5981.7 5991.4 5864.3 5894.2 5898.0 5899.7 5909.1 4652.0 4663.3 4665.8 4680.7 4708.8 4485.7 4558.1 4597.3 4642.1 4707.6 4540.3 4550.9 4564.8 4576.6 4589.5 4588.9 4597.2 4620.9 4624.6 4627.8 3875.9 3976.2 4032.5 4093.7 4095.5 5674.3 5692.9 5716.3 5716.9 5753.6 5272.6 5292.3 5292.4 5300.9 5318.7 5782.4 6068.2 6123.7 6148.0 6187.4 4399.8 4410.8 4446.6 4448.1 4467.8 6238.4 6440.8 6464.9 6470.4 6474.3 4491.2 4493.6 4495.4 4509.8 4523.7 4581.9 4600.7 4605.8 4611.7 4613.2 5135.7 5257.8 5257.8 5258.0 5259.8 6000.5 6207.0 6233.5 6250.1 6259.7 1589.9 1597.2 1602.9 1603.8 1614.7 957.4 981.4 998.7 1002.8 1013.6 5362.6 5384.6 5422.5 5426.0 5485.2 5574.6 5623.0 5680.5 5690.7 5704.6 5384.9 5432.9 5689.5 6120.5 6138.3 3425.3 3459.0 3461.6 3473.3 3475.3 6348.2 6620.9 6636.8 6637.0 6678.4 6548.9 6560.9 6563.7 6575.5 6586.7 6181.3 6675.3 6690.8 6745.9 6763.0 6246.9 6402.6 6426.7 6439.7 6451.0 6355.0 6362.7 6369.9 6371.1 6372.0 6417.7 6538.6 6580.4 6584.6 6627.7 4542.7 4599.1 4608.5 4625.3 4625.8 6382.8 6426.3 6450.6 6493.7 6498.7 6199.9 6238.2 6260.8 6275.8 6283.4 5978.8 6228.4 6313.6 6335.3 6344.4 6214.5 6218.0 6228.9 6232.6 6245.8 6269.2 6294.0 6329.3 6350.3 6382.6 5897.5 6042.9 6090.8 6148.7 6154.9 20:49:01 INFO - PROCESS | 9763 | 20:49:01 INFO - PROCESS | 9763 | [#5] yui.html Cycles:180 Average:22124.04 Median:4299.69 stddev:31341.88 (728.9%) stddev-sans-first:31388.95 20:49:01 INFO - PROCESS | 9763 | Values: 811.4 834.3 850.7 869.8 922.5 15831.8 17082.7 18452.0 18579.2 18770.8 16384.6 16417.8 16493.7 16690.0 16735.6 870.4 877.2 877.9 884.8 886.6 869.1 869.4 870.5 875.0 881.3 908.6 910.5 912.5 915.3 916.5 898.5 905.3 907.1 910.9 912.5 668.9 669.8 670.7 674.1 675.6 15459.4 15524.4 15527.0 15602.1 15637.8 17069.4 17150.7 17201.7 17457.9 17785.3 13931.5 13932.8 14047.2 14057.8 14371.0 4174.3 4222.6 4223.3 4223.9 4375.5 90634.5 90889.5 92560.0 94035.0 94253.0 12940.7 12991.2 12997.0 12998.7 13260.2 24898.5 24930.4 25073.7 25206.1 26175.2 9191.4 9284.9 9425.4 9548.2 9895.3 4906.6 5072.2 5162.7 5196.6 5326.8 3959.8 4100.9 4106.2 4111.3 4126.9 698.7 701.9 703.1 716.3 719.8 633.9 639.4 653.3 684.1 692.3 9665.7 10010.5 10012.1 10223.2 10995.6 641.3 650.0 663.4 671.5 686.5 4644.7 4742.9 4938.6 4961.1 5011.5 75702.2 77087.6 95699.5 136239.3 141308.0 89667.0 90917.0 115905.4 117312.0 119561.0 89011.6 89049.1 90469.0 94088.5 94108.0 9940.8 9997.8 10056.9 10164.4 10252.5 52625.7 53135.7 53321.2 54071.5 54853.7 54653.7 77910.6 79187.6 80399.2 80985.6 13459.5 13977.1 14150.5 14235.9 14386.2 15184.0 15564.7 15884.3 16031.0 16392.5 14305.6 14407.2 14490.3 14528.3 14577.1 15568.6 15631.3 15671.8 15761.8 15789.7 14371.4 14467.6 14517.4 14669.6 14924.9 11408.0 11427.5 11568.2 11817.4 11936.9 11139.4 11581.8 11731.6 11744.4 11798.8 20:49:01 INFO - PROCESS | 9763 | -------- Summary: end -------- 20:49:01 INFO - PROCESS | 9763 | 20:49:02 INFO - TEST-INFO | 9763: exit 0 20:49:02 INFO - TEST-OK | dromaeo_css | took 1111217ms 20:49:02 INFO - TEST-START | kraken 20:49:02 INFO - operating with platform_type : linux_ 20:49:02 INFO - Initialising browser for kraken test... 20:49:02 INFO - TEST-INFO | started process 10028 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsejFNY/profile http://localhost:38762/getInfo.html) 20:49:06 INFO - PROCESS | 10028 | __metrics Screen width/height:1600/1200 20:49:06 INFO - PROCESS | 10028 | colorDepth:24 20:49:06 INFO - PROCESS | 10028 | Browser inner width/height: 1024/697 20:49:06 INFO - PROCESS | 10028 | __metrics 20:49:07 ERROR - PROCESS | 10028 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 20:49:08 INFO - TEST-INFO | 10028: exit 0 20:49:08 INFO - Browser initialized. 20:49:08 INFO - Running cycle 1/1 for kraken test... 20:49:08 INFO - TEST-INFO | started process 10152 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsejFNY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:49:20 INFO - PROCESS | 10152 | RSS: Main: 153464832 20:49:20 INFO - PROCESS | 10152 | 20:49:22 INFO - PROCESS | 10152 | Cycle 1(1): loaded http://localhost:38762/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38762/tests/kraken/driver.html?testName=audio-beat-detection) 20:49:23 INFO - PROCESS | 10152 | RSS: Main: 158851072 20:49:23 INFO - PROCESS | 10152 | 20:49:26 INFO - PROCESS | 10152 | Cycle 1(1): loaded http://localhost:38762/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38762/tests/kraken/driver.html?testName=audio-dft) 20:49:26 INFO - PROCESS | 10152 | RSS: Main: 157151232 20:49:26 INFO - PROCESS | 10152 | 20:49:29 INFO - PROCESS | 10152 | Cycle 1(1): loaded http://localhost:38762/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38762/tests/kraken/driver.html?testName=audio-fft) 20:49:30 INFO - PROCESS | 10152 | RSS: Main: 157708288 20:49:30 INFO - PROCESS | 10152 | 20:49:32 INFO - PROCESS | 10152 | Cycle 1(1): loaded http://localhost:38762/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38762/tests/kraken/driver.html?testName=audio-oscillator) 20:49:32 INFO - PROCESS | 10152 | RSS: Main: 157491200 20:49:32 INFO - PROCESS | 10152 | 20:49:35 INFO - PROCESS | 10152 | Cycle 1(1): loaded http://localhost:38762/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38762/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:49:35 INFO - PROCESS | 10152 | RSS: Main: 157499392 20:49:35 INFO - PROCESS | 10152 | 20:49:38 INFO - PROCESS | 10152 | Cycle 1(1): loaded http://localhost:38762/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38762/tests/kraken/driver.html?testName=imaging-darkroom) 20:49:39 INFO - PROCESS | 10152 | RSS: Main: 157863936 20:49:39 INFO - PROCESS | 10152 | 20:49:42 INFO - PROCESS | 10152 | Cycle 1(1): loaded http://localhost:38762/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38762/tests/kraken/driver.html?testName=imaging-desaturate) 20:49:43 INFO - PROCESS | 10152 | RSS: Main: 155795456 20:49:43 INFO - PROCESS | 10152 | 20:49:46 INFO - PROCESS | 10152 | Cycle 1(1): loaded http://localhost:38762/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38762/tests/kraken/driver.html?testName=json-parse-financial) 20:49:46 INFO - PROCESS | 10152 | RSS: Main: 156827648 20:49:46 INFO - PROCESS | 10152 | 20:49:48 INFO - PROCESS | 10152 | Cycle 1(1): loaded http://localhost:38762/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38762/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:49:49 INFO - PROCESS | 10152 | RSS: Main: 157634560 20:49:49 INFO - PROCESS | 10152 | 20:49:50 INFO - PROCESS | 10152 | Cycle 1(1): loaded http://localhost:38762/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38762/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:49:51 INFO - PROCESS | 10152 | RSS: Main: 156864512 20:49:51 INFO - PROCESS | 10152 | 20:49:53 INFO - PROCESS | 10152 | Cycle 1(1): loaded http://localhost:38762/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38762/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:49:54 INFO - PROCESS | 10152 | RSS: Main: 158056448 20:49:54 INFO - PROCESS | 10152 | 20:49:56 INFO - PROCESS | 10152 | Cycle 1(1): loaded http://localhost:38762/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38762/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:49:57 INFO - PROCESS | 10152 | RSS: Main: 157474816 20:49:57 INFO - PROCESS | 10152 | 20:50:00 INFO - PROCESS | 10152 | Cycle 1(1): loaded http://localhost:38762/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38762/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:50:00 INFO - PROCESS | 10152 | RSS: Main: 157286400 20:50:00 INFO - PROCESS | 10152 | 20:50:02 INFO - PROCESS | 10152 | Cycle 1(1): loaded http://localhost:38762/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38762/tests/kraken/driver.html?testName=ai-astar) 20:50:02 INFO - PROCESS | 10152 | RSS: Main: 159973376 20:50:02 INFO - PROCESS | 10152 | 20:50:02 INFO - PROCESS | 10152 | __start_tp_report 20:50:02 INFO - PROCESS | 10152 | _x_x_mozilla_page_load 20:50:02 INFO - PROCESS | 10152 | _x_x_mozilla_page_load_details 20:50:02 INFO - PROCESS | 10152 | |i|pagename|runs| 20:50:02 INFO - PROCESS | 10152 | |0;ai-astar;101;112;111;106;111;112;112;112;111;121 20:50:02 INFO - PROCESS | 10152 | |1;audio-beat-detection;142;117;146;170;117;145;148;117;175;118 20:50:02 INFO - PROCESS | 10152 | |2;audio-dft;165;162;168;163;165;162;165;165;162;165 20:50:02 INFO - PROCESS | 10152 | |3;audio-fft;76;75;75;176;75;75;76;75;157;76 20:50:02 INFO - PROCESS | 10152 | |4;audio-oscillator;83;84;157;83;84;83;140;84;84;141 20:50:02 INFO - PROCESS | 10152 | |5;imaging-gaussian-blur;117;117;117;118;118;117;118;120;117;117 20:50:02 INFO - PROCESS | 10152 | |6;imaging-darkroom;150;150;149;149;148;149;149;149;148;147 20:50:02 INFO - PROCESS | 10152 | |7;imaging-desaturate;96;96;105;101;97;95;95;97;96;95 20:50:02 INFO - PROCESS | 10152 | |8;json-parse-financial;51;51;51;55;54;52;52;50;51;51 20:50:02 INFO - PROCESS | 10152 | |9;json-stringify-tinderbox;60;61;62;61;64;61;61;60;61;61 20:50:02 INFO - PROCESS | 10152 | |10;stanford-crypto-aes;72;73;73;82;85;74;73;72;72;73 20:50:02 INFO - PROCESS | 10152 | |11;stanford-crypto-ccm;134;129;127;126;134;129;122;119;147;122 20:50:02 INFO - PROCESS | 10152 | |12;stanford-crypto-pbkdf2;155;160;151;153;154;153;155;154;152;152 20:50:02 INFO - PROCESS | 10152 | |13;stanford-crypto-sha256-iterative;62;64;66;64;66;62;62;64;63;59 20:50:02 INFO - PROCESS | 10152 | __end_tp_report 20:50:02 INFO - PROCESS | 10152 | __start_cc_report 20:50:02 INFO - PROCESS | 10152 | _x_x_mozilla_cycle_collect,881 20:50:02 INFO - PROCESS | 10152 | __end_cc_report 20:50:02 INFO - PROCESS | 10152 | __startTimestamp1474257002547__endTimestamp 20:50:02 INFO - PROCESS | 10152 | 20:50:02 INFO - PROCESS | 10152 | ------- Summary: start ------- 20:50:02 INFO - PROCESS | 10152 | Number of tests: 14 20:50:02 INFO - PROCESS | 10152 | 20:50:02 INFO - PROCESS | 10152 | [#0] ai-astar Cycles:10 Average:110.90 Median:112.00 stddev:5.04 (4.5%) stddev-sans-first:3.87 20:50:02 INFO - PROCESS | 10152 | Values: 101.0 112.0 111.0 106.0 111.0 112.0 112.0 112.0 111.0 121.0 20:50:02 INFO - PROCESS | 10152 | 20:50:02 INFO - PROCESS | 10152 | [#1] audio-beat-detection Cycles:10 Average:139.50 Median:145.50 stddev:21.92 (15.1%) stddev-sans-first:23.23 20:50:02 INFO - PROCESS | 10152 | Values: 142.0 117.0 146.0 170.0 117.0 145.0 148.0 117.0 175.0 118.0 20:50:02 INFO - PROCESS | 10152 | 20:50:02 INFO - PROCESS | 10152 | [#2] audio-dft Cycles:10 Average:164.20 Median:165.00 stddev:1.93 (1.2%) stddev-sans-first:2.03 20:50:02 INFO - PROCESS | 10152 | Values: 165.0 162.0 168.0 163.0 165.0 162.0 165.0 165.0 162.0 165.0 20:50:02 INFO - PROCESS | 10152 | 20:50:02 INFO - PROCESS | 10152 | [#3] audio-fft Cycles:10 Average:93.60 Median:75.00 stddev:38.68 (51.6%) stddev-sans-first:40.50 20:50:02 INFO - PROCESS | 10152 | Values: 76.0 75.0 75.0 176.0 75.0 75.0 76.0 75.0 157.0 76.0 20:50:02 INFO - PROCESS | 10152 | 20:50:02 INFO - PROCESS | 10152 | [#4] audio-oscillator Cycles:10 Average:102.30 Median:83.50 stddev:30.49 (36.5%) stddev-sans-first:31.53 20:50:02 INFO - PROCESS | 10152 | Values: 83.0 84.0 157.0 83.0 84.0 83.0 140.0 84.0 84.0 141.0 20:50:02 INFO - PROCESS | 10152 | 20:50:02 INFO - PROCESS | 10152 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:117.50 stddev:0.97 (0.8%) stddev-sans-first:1.00 20:50:02 INFO - PROCESS | 10152 | Values: 117.0 117.0 117.0 118.0 118.0 117.0 118.0 120.0 117.0 117.0 20:50:02 INFO - PROCESS | 10152 | 20:50:02 INFO - PROCESS | 10152 | [#6] imaging-darkroom Cycles:10 Average:148.80 Median:149.00 stddev:0.92 (0.6%) stddev-sans-first:0.87 20:50:02 INFO - PROCESS | 10152 | Values: 150.0 150.0 149.0 149.0 148.0 149.0 149.0 149.0 148.0 147.0 20:50:02 INFO - PROCESS | 10152 | 20:50:02 INFO - PROCESS | 10152 | [#7] imaging-desaturate Cycles:10 Average:97.30 Median:96.00 stddev:3.23 (3.4%) stddev-sans-first:3.40 20:50:02 INFO - PROCESS | 10152 | Values: 96.0 96.0 105.0 101.0 97.0 95.0 95.0 97.0 96.0 95.0 20:50:02 INFO - PROCESS | 10152 | 20:50:02 INFO - PROCESS | 10152 | [#8] json-parse-financial Cycles:10 Average:51.80 Median:51.50 stddev:1.55 (3.0%) stddev-sans-first:1.62 20:50:02 INFO - PROCESS | 10152 | Values: 51.0 51.0 51.0 55.0 54.0 52.0 52.0 50.0 51.0 51.0 20:50:02 INFO - PROCESS | 10152 | 20:50:02 INFO - PROCESS | 10152 | [#9] json-stringify-tinderbox Cycles:10 Average:61.20 Median:61.00 stddev:1.14 (1.9%) stddev-sans-first:1.12 20:50:02 INFO - PROCESS | 10152 | Values: 60.0 61.0 62.0 61.0 64.0 61.0 61.0 60.0 61.0 61.0 20:50:02 INFO - PROCESS | 10152 | 20:50:02 INFO - PROCESS | 10152 | [#10] stanford-crypto-aes Cycles:10 Average:74.90 Median:73.00 stddev:4.63 (6.3%) stddev-sans-first:4.79 20:50:02 INFO - PROCESS | 10152 | Values: 72.0 73.0 73.0 82.0 85.0 74.0 73.0 72.0 72.0 73.0 20:50:02 INFO - PROCESS | 10152 | 20:50:02 INFO - PROCESS | 10152 | [#11] stanford-crypto-ccm Cycles:10 Average:128.90 Median:129.00 stddev:8.06 (6.2%) stddev-sans-first:8.34 20:50:02 INFO - PROCESS | 10152 | Values: 134.0 129.0 127.0 126.0 134.0 129.0 122.0 119.0 147.0 122.0 20:50:02 INFO - PROCESS | 10152 | 20:50:02 INFO - PROCESS | 10152 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.90 Median:154.00 stddev:2.51 (1.6%) stddev-sans-first:2.64 20:50:02 INFO - PROCESS | 10152 | Values: 155.0 160.0 151.0 153.0 154.0 153.0 155.0 154.0 152.0 152.0 20:50:02 INFO - PROCESS | 10152 | 20:50:02 INFO - PROCESS | 10152 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:64.00 stddev:2.10 (3.3%) stddev-sans-first:2.18 20:50:02 INFO - PROCESS | 10152 | Values: 62.0 64.0 66.0 64.0 66.0 62.0 62.0 64.0 63.0 59.0 20:50:02 INFO - PROCESS | 10152 | -------- Summary: end -------- 20:50:02 INFO - PROCESS | 10152 | 20:50:03 INFO - TEST-INFO | 10152: exit 0 20:50:03 INFO - TEST-OK | kraken | took 61137ms 20:50:03 INFO - SUITE-END | took 1172s 20:50:03 INFO - Completed test suite (00:19:32) 20:50:03 INFO - javascript benchmark 20:50:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7842.836368622374, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3270.280538281578, 3378.763486555939, 3393.202597389613, 3398.0655319787056, 3408.8977330680073, 5881.264841894763, 5901.940980590193, 5911.527077833774, 6010.819675409739, 6013.518918486521, 5818.243628328322, 5885.705714714269, 5888.823335299937, 5894.852628684285, 5998.730057147428, 5225.555827754645, 5340.0, 5382.784688612471, 5436.83689489314, 5450.0, 5278.155495120782, 5343.064963631368, 5368.00691872003, 5411.675299482044, 5429.972850135763, 5368.8389348319615, 5380.91928621071, 5403.918941215865, 5470.234167216593, 5480.068388373986, 5452.154915988028, 5460.290162278918, 5460.945390546083, 5461.726913654302, 5475.945240547583, 5161.509656582619, 5190.0, 5293.57651387888, 5367.275417818583, 5470.070088085035, 5729.770809167629, 5798.449147330997, 5812.011957967114, 5822.97088514559, 5850.180974663551, 6211.658358790265, 6241.157443745127, 6293.244810622755, 6311.873762524724, 6318.241810982666, 6083.117947897575, 6309.305976342599, 6311.495080393557, 6353.523485738542, 6357.427831495188, 5911.172435858984, 5995.370486098984, 6010.579259451796, 6021.729022194012, 6026.54800889935, 6548.508861835381, 6561.179852518435, 6584.308647591934, 6616.338366163442, 6616.371444712745, 6060.939390606126, 6152.046432802923, 6294.433500984934, 6311.242650881832, 6335.904961425582, 6259.374062593704, 6360.204974378203, 6382.361763823674, 6410.487161027107, 6418.358164183544, 6288.496920246369, 6315.36846315374, 6322.873542529215, 6323.27282362525, 6326.746930122836, 6119.715820550745, 6133.365267548864, 6370.331115232926, 6374.298827129012, 6376.426121648981, 4725.36207611968, 4751.548602882721, 4754.524547545287, 4786.928196077061, 4800.35195248644, 4201.810918508613, 4234.830606775756, 4253.064325848309, 4256.0, 4267.509236437787, 5871.55963302754, 5941.70291485424, 6036.0, 6039.0, 6056.273247210275, 6195.132681424604, 6298.401651843067, 6357.332480089616, 6367.299597044322, 6372.139761132188, 6064.969675151596, 6093.26880774301, 6097.451229389288, 6107.053406721965, 6109.297430795426, 5392.0, 5412.404635490093, 5426.430224826337, 5466.617336786387, 5477.4796394343275, 6527.249366322933, 6532.934670653232, 6580.407763301326, 6600.537962342686, 6619.966900165468, 6293.937060629335, 6310.116583678197, 6378.776742814165, 6398.296187419287, 6405.231372235362, 6386.552941294251, 6541.051547525677, 6564.901526477202, 6576.177977752781, 6620.966895165493, 6309.558330916791, 6323.620582765049, 6340.1123842661145, 6342.175517182736, 6343.0485427186295, 6455.515836312389, 6468.191476065492, 6469.029645553204, 6475.352464753675, 6502.122213501117, 5988.520918326611, 6118.9846826261555, 6163.84590385244, 6292.370762923671, 6294.685265736786, 6249.468795152281, 6281.0, 6285.371462853678, 6288.339724328879, 6288.874222515616, 6234.688265586793, 6237.625742455467, 6258.593191442542, 6293.992961126198, 6300.653464059521, 6056.364081771527, 6141.05644955797, 6160.630362178284, 6221.4089661482085, 6277.0, 6069.332373439007, 6091.939080609137, 6101.572889897842, 6106.175666284995, 6117.938820611915], "value": 5840.451564228177, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.5578176912892, 635.1584150999926, 639.622622652635, 658.1345530627225, 690.8480134370436, 40908.0, 44706.776466117626, 44982.32526512097, 45020.77489612548, 45278.320825187606, 44339.0, 44661.55338446615, 44860.775696121476, 44863.0, 44898.32652510215, 9116.1339672731, 9236.353455258135, 9255.44467331959, 9268.25853931684, 9268.953655231715, 9226.769330766718, 9227.44635321883, 9243.53782310885, 9260.0, 9270.67552635658, 9296.8605470918, 9331.440113593173, 9339.299552533554, 9339.43963362197, 9349.392289501195, 9268.25853931684, 9294.395864268801, 9308.813823723556, 9309.906900930971, 9316.58075386606, 9093.545322733837, 9140.6800761973, 9151.313651476166, 9152.0, 9154.908450915473, 43836.780816096034, 44054.33918491225, 44115.0, 44122.0, 44248.77875610634, 3861.262431905626, 4021.939670904939, 4040.373742069984, 4416.271315233015, 4788.688735232234, 34662.30675386478, 35171.4724279136, 35325.0, 36728.0, 36830.263394731955, 4009.67922566194, 4057.9391309130388, 4151.12826306476, 4224.8732538023905, 4291.849785257501, 414675.0, 416354.0, 417002.0, 420435.0, 421993.0, 66110.0, 66794.33205667978, 66838.66580667066, 66978.0, 67011.66494167499, 39552.60447395547, 40172.598274016884, 40322.19355612871, 42653.0, 42806.0, 18743.812561874478, 18784.53038674044, 18904.0, 19026.0, 19085.236590536224, 14820.925895370454, 14942.402303907722, 14994.850051499345, 15006.324715387835, 15011.849881501264, 21184.788152118283, 21223.893880530497, 21313.25403610866, 21390.465238368855, 21567.2451464198, 7598.772036838904, 7701.768946931601, 7707.421943354271, 7784.2994130527395, 7851.685932562747, 1060.390275591538, 1091.3015669971226, 1100.3068067117665, 1139.1228753859482, 1191.74377508836, 34332.82833585816, 34333.31333373318, 34921.301573968376, 34956.47565286523, 34976.0, 1146.9139814513944, 1177.3701069927547, 1184.8045072562932, 1190.8987736042534, 1201.591458903977, 17576.736348954775, 17948.730769038473, 18202.271909123752, 18328.816711832977, 18444.631107378045, 656395.0, 667885.0, 668423.0, 668563.0, 670890.0, 63065.0, 64135.35864641387, 64238.0, 64266.0, 64999.35000650027, 1436.4972259709018, 1440.2150827798876, 1458.8030615867146, 1464.699736554004, 1464.7070585882652, 32042.679573204903, 33414.33171336511, 33839.661603383654, 33871.83064084664, 34011.0, 55923.0, 56256.0, 56286.718566406904, 56376.71811640915, 56388.0, 506265.0, 508986.0, 510486.0, 511032.0, 513184.0, 31504.527432088078, 31658.525122123647, 31757.682423175473, 31774.205644859063, 32168.517472238404, 52509.0, 52584.21123683224, 53335.0, 53909.46090539044, 54260.45739542554, 44860.32709509294, 45698.31452528281, 46310.53689463062, 46441.53558464507, 47059.529404705514, 44080.442262651035, 45571.0, 46477.0, 47499.52500475089, 47951.76024119857, 43998.0, 44296.55703442924, 44930.55069449264, 45149.32276015928, 45254.54745452635, 38501.4224786634, 40424.0, 40999.1800164001, 41166.1766764669, 41282.587174127875, 30020.0, 30306.0, 30422.23944401319, 30479.695203048574, 30639.234019148807], "value": 21674.17482324229, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [425.4235510882756, 425.8996652963392, 429.55970130616123, 434.9021470169212, 441.25868540851354, 18873.0, 20353.491162720922, 20584.279550215746, 21440.14239430421, 21491.0, 19198.0, 20466.795332046677, 20848.270310539134, 20892.164313427482, 21201.681974770352, 6032.879342413149, 6188.071789231606, 6193.566450348478, 6202.751889924398, 6216.409441103088, 6105.755769769226, 6110.511159107283, 6115.9694201529155, 6146.29317628474, 6152.077188421727, 6038.758449662008, 6066.939330606681, 6072.423119803611, 6099.7865074722395, 6107.725152368132, 6023.0, 6030.879382412371, 6045.153678485016, 6045.395460453941, 6073.574849760518, 5221.55616772571, 5407.080796264605, 5422.267993820823, 5446.673199608036, 5474.2609747683955, 13545.45818167282, 13707.588772336845, 14883.107013579112, 14885.330160142712, 14895.925520372437, 2317.721873375189, 2467.3954881054256, 2536.201096654548, 2772.986135069332, 2994.895178668736, 10987.505562249638, 11041.503132359063, 11042.447877606088, 11059.004689577976, 11209.383483908381, 1995.980040199594, 2013.1242909334487, 2070.492729281321, 2079.07481170879, 2085.0721428964116, 77970.0, 85382.57308713479, 87650.0, 87957.12042879617, 88755.55622221848, 11545.307281563133, 11603.361815100081, 11606.477708503138, 11739.823902641467, 11902.047836173086, 16737.91631041837, 16799.916000420166, 16818.0, 16818.159092045593, 16843.578910527336, 8608.225259726654, 8947.642094316154, 8986.86519702205, 9006.819863602823, 9185.311101667268, 8719.694810681596, 8735.694250701195, 8769.254613357936, 8852.468851868909, 8955.05971872957, 5011.273365362075, 5078.339815823993, 5102.805500826312, 5103.0, 5117.053345131163, 2056.804603562689, 2133.008151209695, 2170.4899348653053, 2194.813440857513, 2226.1540614566684, 948.7533241357297, 991.2466525440717, 1027.7584767579613, 1037.9636712715019, 1076.359566058194, 19772.505687357643, 20092.69860952087, 20146.89926550358, 20427.0, 20847.47881302949, 1073.8926107389198, 1074.7347928006732, 1080.8108580998294, 1093.4532733633184, 1148.5922497513263, 11150.442477876073, 11540.192186547029, 11740.823887641693, 11758.235714678518, 11834.0, 474928.0, 481691.0, 483118.0, 491642.0, 509930.0, 95045.0, 95152.52423737837, 97580.0, 98037.50981245049, 98368.0, 1054.283087500507, 1058.8147074261974, 1062.3413483640193, 1067.4982758103679, 1073.8550295709979, 15680.529584112495, 16953.576160596083, 17372.739408908623, 18225.347897651074, 18591.814081859007, 29137.41725165527, 36223.818880905426, 40882.38676419797, 42027.36958945557, 44415.33376999283, 55621.0, 60712.39287607244, 61489.69255153696, 61696.38303616906, 62456.375436246875, 9202.0, 9221.0, 9259.305552083755, 9265.166135047879, 9344.205742511962, 10629.9468502657, 14212.644683882985, 14308.785368219693, 14426.711465770415, 14852.183129927958, 12061.216020958609, 12718.10973231865, 12722.87277127254, 12767.74464510686, 12783.488660453479, 12258.87741122613, 12500.24998500093, 12558.246505209716, 12617.68455788576, 12752.298623575422, 12700.36498175106, 12725.300108494122, 12748.745025099632, 12752.808707869204, 12961.0, 9085.273178145864, 9221.631134754534, 9235.815283694423, 9253.861192082259, 9277.814443711222, 11028.834567481656, 12369.93815030919, 12538.498460061495, 12724.109312348417, 12761.425735841724], "value": 9633.590112531567, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1570.9293081811318, 1578.9842101578981, 1733.6186039071408, 1788.5975655477528, 1878.9665683873866, 8605.526696031715, 9299.81400371993, 9338.439693618388, 10022.749431264223, 10035.448050357227, 9415.152636262736, 9710.514474276275, 9738.269629777777, 9746.31775775696, 9751.366161199518, 2494.5634513960076, 2543.5294470523013, 2544.427503811646, 2545.7199708032103, 2547.0957809977467, 2512.510060538196, 2597.714251432341, 2602.037246218892, 2602.141293373182, 2615.6861176658826, 2586.4439145583697, 2593.1183397644795, 2596.714361420252, 2600.7646367975153, 2608.6478325426015, 2508.761667641571, 2517.0309430869156, 2524.129175434472, 2531.721510633829, 2537.5432422164004, 2478.7149477810103, 2499.562576549097, 2522.924312270635, 2524.040864471489, 2525.7095434025136, 9732.70801875945, 9923.454210018446, 9943.105120539187, 9950.054744799232, 9967.0, 5773.451522105393, 5898.7640494380175, 5923.940760592425, 5924.792632257893, 5928.49607783339, 3473.235888104613, 3557.94663080054, 3561.928761424783, 3570.767900086486, 3658.048907284125, 1104.3263609198382, 1174.2543484887074, 1182.7338848759046, 1188.696882295018, 1197.3474456421272, 13930.860691393058, 14003.71992560143, 14096.859031409656, 14169.574912752634, 14208.502702405469, 5156.535911767959, 5261.631685781958, 5405.351357837085, 5405.675659460445, 5429.375621803464, 11604.709882252842, 11891.28652280866, 11893.226940248856, 11947.880521194676, 12060.457279422448, 5958.940410595838, 5984.401559843981, 5990.5507086968655, 6024.909626355608, 6025.638461692312, 4657.67396282257, 5340.385855626652, 5351.143816989263, 5433.0763770159165, 5494.587905907073, 4540.795664195053, 4550.817967281338, 4607.262837945913, 4617.907641847144, 4642.0715856828765, 1419.1556024165604, 1428.8283607441797, 1440.683049729079, 1487.1523231757794, 1490.866941124753, 988.2983082011853, 1016.1261315268863, 1018.251585084962, 1021.6373187518324, 1035.2184101003695, 6002.849928751729, 6029.427204415573, 6260.217472815898, 6301.635348298252, 6372.171617689671, 522.3966318901674, 523.264812937823, 526.5550609734845, 527.5410392958152, 533.2694208933785, 4054.1688953764406, 4241.597048280409, 4241.681121279185, 4270.594293542109, 4321.135772845443, 11843.703907402383, 12160.270383777002, 12182.512699491921, 12188.695282618006, 12270.815937760763, 11783.764324713458, 12042.458089385998, 12085.879141208652, 12105.33420661872, 12276.202046866925, 8862.291016718647, 9001.864972025425, 9056.773580660405, 9107.499087550248, 9121.45271283725, 6152.384761523812, 6212.0, 6267.62394256346, 6294.433500984934, 6313.43179113882, 10902.890971090188, 11198.664040078811, 11242.718932026764, 11289.20975531705, 11331.943340283246, 11179.888201117885, 11251.662450126509, 11396.373199474108, 11491.253068550517, 11656.650300491, 7439.479236453396, 8025.157358477276, 8237.50574965504, 8520.659173632985, 8598.140185981352, 9115.453072815651, 9199.954000229956, 9211.861822072808, 9224.861627075465, 9262.907370926205, 7982.321502672338, 8172.101068882299, 8263.876041859257, 8355.874661879956, 8550.74347769568, 7466.589337586268, 7491.513051651843, 7589.3549048329305, 8128.552929588929, 8178.1821817817745, 7199.784006479814, 7232.710691572278, 7303.963480182565, 7378.372838308804, 7389.926100738924, 5216.608754343363, 5243.790248390174, 5269.288646032736, 5273.789048438173, 5373.919391209057, 5372.704501252312, 5394.622376433612, 5492.890142197213, 5503.752331145028, 5511.255980442749], "value": 4967.927754404681, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.887814777419, 365.42080801928944, 365.5120414246978, 366.2181243046097, 376.59327925840097, 5677.240055582773, 5829.47534721876, 5915.728118454532, 5981.671008094553, 5991.430814072662, 5864.3256025557075, 5894.2042824218715, 5897.997340452122, 5899.675517846516, 5909.113632955059, 4651.976740116294, 4663.323818046381, 4665.790039448233, 4680.729846024676, 4708.811647534095, 4485.7084289521235, 4558.065596552716, 4597.310403439477, 4642.141203877277, 4707.552782485658, 4540.318952157169, 4550.886227844314, 4564.8174073037035, 4576.588107070363, 4589.47221069578, 4588.885277868047, 4597.172508948388, 4620.861374158781, 4624.577812418819, 4627.768611569408, 3875.8837234883, 3976.224636195943, 4032.5160980682213, 4093.672506199497, 4095.5494895561465, 5674.290713660793, 5692.943070569283, 5716.256886604757, 5716.914246286309, 5753.568482363839, 5272.604554658416, 5292.338457692788, 5292.391374991848, 5300.867478313035, 5318.707471089088, 5782.421757824226, 6068.211132552784, 6123.724432400552, 6147.969260153715, 6187.3503282155625, 4399.802008909607, 4410.845620403303, 4446.55534446556, 4448.065906159711, 4467.82128714851, 6238.438540531374, 6440.806775796734, 6464.870702585969, 6470.417662410358, 6474.287828338879, 4491.236489796743, 4493.640508759291, 4495.393121928498, 4509.842155524541, 4523.7285762854335, 4581.8625441236145, 4600.700954438018, 4605.769711514478, 4611.700239484423, 4613.215753321943, 5135.717535535507, 5257.763400646903, 5257.7896884124975, 5258.0, 5259.789608415697, 6000.459958603747, 6207.0, 6233.470155036782, 6250.124982502453, 6259.715203950525, 1589.8887077904667, 1597.1535086403992, 1602.9358825646843, 1603.7834892289625, 1614.6770645870638, 957.3537861943161, 981.4258658684606, 998.7203582996773, 1002.7693630465034, 1013.5742987945081, 5362.570994320445, 5384.596155288369, 5422.53908417781, 5426.04662321564, 5485.162470572323, 5574.637648552831, 5623.0, 5680.460356266148, 5690.658560486301, 5704.600677952503, 5384.892302154013, 5432.864178395572, 5689.516391106719, 6120.510359171256, 6138.342647485243, 3425.2635683328203, 3458.9827050865088, 3461.6019157797177, 3473.2706131712116, 3475.2528206435736, 6348.206474190726, 6620.933790662128, 6636.834079147963, 6636.966815165893, 6678.432333251631, 6548.9017664735065, 6560.916369306418, 6563.737450502022, 6575.506836987245, 6586.670666466754, 6181.289151747516, 6675.265720770712, 6690.799276021728, 6745.898811517831, 6762.966185169141, 6246.906296405648, 6402.583832050902, 6426.742930282736, 6439.710213040518, 6450.967745161432, 6354.968225159029, 6362.650054247061, 6369.8726025480155, 6371.139896113966, 6371.968140159455, 6417.71120299597, 6538.574992625464, 6580.420699032102, 6584.604923704593, 6627.734890604322, 4542.704724192917, 4599.149157405891, 4608.516105808976, 4625.306204069282, 4625.7918393673035, 6382.808515744535, 6426.325235850169, 6450.580712253689, 6493.675316234264, 6498.707558159799, 6199.876002480015, 6238.222106699569, 6260.780872669435, 6275.811725648238, 6283.434490895841, 5978.8206353809455, 6228.4394404502, 6313.558050936574, 6335.303116657072, 6344.429001389897, 6214.5028397728975, 6217.96891015542, 6228.909940760439, 6232.563720539519, 6245.750169993331, 6269.1819372383325, 6294.024426213944, 6329.30377658448, 6350.269718982377, 6382.6170429774365, 5897.469227769521, 6042.939570604413, 6090.817275481742, 6148.723307451265, 6154.938450615616], "value": 4706.9954718681975, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [811.3874025111044, 834.3408707121374, 850.7192626433276, 869.7738587967128, 922.5433410461823, 15831.762523562156, 17082.74375884361, 18452.0, 18579.163937622805, 18770.812291877093, 16384.590385240375, 16417.83582164178, 16493.67012659749, 16690.0, 16735.581610459743, 870.4168207301124, 877.1666916429385, 877.9341549383806, 884.8451520983834, 886.6098916476761, 869.0744357259498, 869.3566760597175, 870.5386145342978, 874.9893872577184, 881.259741816877, 908.550267617527, 910.4810258152855, 912.4525284829116, 915.2952226785404, 916.5142474488532, 898.5372533145435, 905.343625871238, 907.0929070929005, 910.8633704944278, 912.4707669551677, 668.9230738465042, 669.8358902068976, 670.718298314709, 674.0866126398757, 675.5541342713785, 15459.38162473511, 15524.379024838992, 15527.0, 15602.141882196474, 15637.843621563752, 17069.402570910082, 17150.742738858928, 17201.655966880717, 17457.912710436492, 17785.288588456446, 13931.512397066155, 13932.787651546027, 14047.22740249286, 14057.78913316301, 14371.0, 4174.269502837022, 4222.5566315536735, 4223.282042052859, 4223.852165174204, 4375.518692943773, 90634.5468272661, 90889.54555227248, 92560.0, 94035.0, 94253.0, 12940.741185176244, 12991.220526768424, 12997.025223108305, 12998.740025199442, 13260.204387736574, 24898.502029959298, 24930.37674058127, 25073.749262507507, 25206.117785877406, 26175.214743557724, 9191.356605037718, 9284.907150928404, 9425.38734982224, 9548.18840398574, 9895.30732848708, 4906.6320025997475, 5072.163093089599, 5162.664426812245, 5196.610254230948, 5326.813561525406, 3959.821808018646, 4100.876973690794, 4106.240345536085, 4111.321631930698, 4126.8761937141935, 698.7205117952758, 701.9333163349473, 703.0754557756534, 716.2622498826217, 719.7876626395226, 633.9239291284983, 639.4468784501373, 653.3368630839701, 684.0833283400268, 692.2904023376079, 9665.661701840543, 10010.54952527138, 10012.148967337858, 10223.233257505568, 10995.560177592806, 641.252940324526, 649.9837504062342, 663.3631713555042, 671.4594751225213, 686.4954258619911, 4644.744539050384, 4742.933407701023, 4938.629602779806, 4961.13511410011, 5011.462174823069, 75702.24297756952, 77087.61456192796, 95699.52150239343, 136239.31880340734, 141308.0, 89667.0, 90917.0, 115905.4204728971, 117312.0, 119561.0, 89011.55494222487, 89049.10950890408, 90469.0, 94088.52955735315, 94108.0, 9940.778764243394, 9997.800043999225, 10056.949715251378, 10164.390136591828, 10252.487375631039, 52625.7368713154, 53135.73432132969, 53321.20018199652, 54071.45928540664, 54853.72573137269, 54653.72673136768, 77910.61044694741, 79187.60406197932, 80399.19600803917, 80985.59507202427, 13459.46162153542, 13977.08414075454, 14150.504732334319, 14235.857641423454, 14386.208758518382, 15184.01303915242, 15564.687459480001, 15884.31148437121, 16031.0, 16392.508224753277, 14305.64235894111, 14407.207603581903, 14490.34793434277, 14528.27358632043, 14577.125372477685, 15568.610784730472, 15631.29659165363, 15671.764923525929, 15761.842381576038, 15789.684206316038, 14371.425142994163, 14467.565973020826, 14517.419303227753, 14669.633259168178, 14924.925375373054, 11408.0, 11427.542898284308, 11568.24806387582, 11817.350045747566, 11936.940315298369, 11139.387333696724, 11581.82627260575, 11731.589394371156, 11744.412779361168, 11798.823017654571], "value": 8160.233439779793, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1508.1000000000004, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 112.0, 111.0, 106.0, 111.0, 112.0, 112.0, 112.0, 111.0, 121.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 117.0, 146.0, 170.0, 117.0, 145.0, 148.0, 117.0, 175.0, 118.0], "value": 139.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 162.0, 168.0, 163.0, 165.0, 162.0, 165.0, 165.0, 162.0, 165.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 176.0, 75.0, 75.0, 76.0, 75.0, 157.0, 76.0], "value": 93.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 157.0, 83.0, 84.0, 83.0, 140.0, 84.0, 84.0, 141.0], "value": 102.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 118.0, 120.0, 117.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 149.0, 149.0, 148.0, 149.0, 149.0, 149.0, 148.0, 147.0], "value": 148.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 105.0, 101.0, 97.0, 95.0, 95.0, 97.0, 96.0, 95.0], "value": 97.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 51.0, 55.0, 54.0, 52.0, 52.0, 50.0, 51.0, 51.0], "value": 51.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 62.0, 61.0, 64.0, 61.0, 61.0, 60.0, 61.0, 61.0], "value": 61.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 73.0, 82.0, 85.0, 74.0, 73.0, 72.0, 72.0, 73.0], "value": 74.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 129.0, 127.0, 126.0, 134.0, 129.0, 122.0, 119.0, 147.0, 122.0], "value": 128.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 160.0, 151.0, 153.0, 154.0, 153.0, 155.0, 154.0, 152.0, 152.0], "value": 153.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 66.0, 64.0, 66.0, 62.0, 62.0, 64.0, 63.0, 59.0], "value": 63.2, "unit": "score"}]}]} 20:50:03 INFO - Return code: 0 20:50:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:50:03 ERROR - # TBPL SUCCESS # 20:50:03 INFO - Running post-action listener: _resource_record_post_action 20:50:03 INFO - [mozharness: 2016-09-19 03:50:03.843309Z] Finished run-tests step (success) 20:50:03 INFO - Running post-run listener: _resource_record_post_run 20:50:03 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 266240; Write bytes: 326946816; Read time: 32; Write time: 178784 20:50:03 INFO - TinderboxPrint: CPU usage
13.2% 20:50:03 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 32 20:50:03 INFO - TinderboxPrint: I/O write bytes / time
326,946,816 / 178,784 20:50:03 INFO - TinderboxPrint: CPU idle
8,231.6 (86.8%) 20:50:03 INFO - TinderboxPrint: CPU user
1,199.3 (12.6%) 20:50:03 INFO - TinderboxPrint: Swap in / out
0 / 0 20:50:03 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 78381056; Read time: 0; Write time: 39468 20:50:03 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 266240; Write bytes: 247664640; Read time: 32; Write time: 139288 20:50:04 INFO - Running post-run listener: _upload_blobber_files 20:50:04 INFO - Blob upload gear active. 20:50:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:50: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 20:50: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'] 20:50: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 20:50:04 INFO - (blobuploader) - INFO - Open directory for files ... 20:50:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:50:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:50:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:50:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:50:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:50:08 INFO - (blobuploader) - INFO - Done attempting. 20:50:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:50:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:50:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:50:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:50:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:50:09 INFO - (blobuploader) - INFO - Done attempting. 20:50:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:50:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:50:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:50:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:50:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:50:09 INFO - (blobuploader) - INFO - Done attempting. 20:50:09 INFO - (blobuploader) - INFO - Iteration through files over. 20:50:09 INFO - Return code: 0 20:50:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:50:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:50:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4a8e6971f9d578d093a6ac55387c8e2e27a9cf29fdbe9945e4e4904bd53475abd8c9b0e2f89161ca4be499a3ce006c740321d349512d107bc767c3902128598b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1867da2d637f60633df1dec2c3f0f634a37073287533baa4e5a5f34dab38af95d0418769ec8bbdcf081854167357b3d03d1b9ac7836a6210b10bb25d270df6d3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1bf66e596fd601932250122f454bd1c25e374b4fa76da39737a433023136b584b414ef3f04b60518973022b65aa219cbbb211fe9a2d8f0d1d1c784887d1b3307"} 20:50:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:50:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:50:09 INFO - Contents: 20:50:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4a8e6971f9d578d093a6ac55387c8e2e27a9cf29fdbe9945e4e4904bd53475abd8c9b0e2f89161ca4be499a3ce006c740321d349512d107bc767c3902128598b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1867da2d637f60633df1dec2c3f0f634a37073287533baa4e5a5f34dab38af95d0418769ec8bbdcf081854167357b3d03d1b9ac7836a6210b10bb25d270df6d3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1bf66e596fd601932250122f454bd1c25e374b4fa76da39737a433023136b584b414ef3f04b60518973022b65aa219cbbb211fe9a2d8f0d1d1c784887d1b3307"} 20:50:09 INFO - Running post-run listener: copy_logs_to_upload_dir 20:50:09 INFO - Copying logs to upload dir... 20:50:09 INFO - mkdir: /builds/slave/test/build/upload/logs 20:50:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1678.417788 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 58 secs) (at 2016-09-18 20:50:08.998976) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-18 20:50:09.002148) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1474253432.33310-1294809706 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/4a8e6971f9d578d093a6ac55387c8e2e27a9cf29fdbe9945e4e4904bd53475abd8c9b0e2f89161ca4be499a3ce006c740321d349512d107bc767c3902128598b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1867da2d637f60633df1dec2c3f0f634a37073287533baa4e5a5f34dab38af95d0418769ec8bbdcf081854167357b3d03d1b9ac7836a6210b10bb25d270df6d3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1bf66e596fd601932250122f454bd1c25e374b4fa76da39737a433023136b584b414ef3f04b60518973022b65aa219cbbb211fe9a2d8f0d1d1c784887d1b3307"} build_url:https://queue.taskcluster.net/v1/task/ePIxxufxTeCzWVOohoB-9w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011275 build_url: 'https://queue.taskcluster.net/v1/task/ePIxxufxTeCzWVOohoB-9w/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/4a8e6971f9d578d093a6ac55387c8e2e27a9cf29fdbe9945e4e4904bd53475abd8c9b0e2f89161ca4be499a3ce006c740321d349512d107bc767c3902128598b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1867da2d637f60633df1dec2c3f0f634a37073287533baa4e5a5f34dab38af95d0418769ec8bbdcf081854167357b3d03d1b9ac7836a6210b10bb25d270df6d3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1bf66e596fd601932250122f454bd1c25e374b4fa76da39737a433023136b584b414ef3f04b60518973022b65aa219cbbb211fe9a2d8f0d1d1c784887d1b3307"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-18 20:50:09.028387) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-18 20:50:09.028788) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1474253432.33310-1294809706 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004456 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-18 20:50:09.111082) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-18 20:50:09.111445) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-18 20:50:09.111812) ========= ========= Total master_lag: 0.18 =========