builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0169 starttime: 1467803464.21 results: success (0) buildid: 20160706024124 builduid: 61d539fbfe6c4133a8983e336060d99c revision: a7d6bb9e7d12166470ad4210dd1f56b7b07d0dc8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 04:11:04.212294) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 04:11:04.212748) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 04:11:04.213015) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 04:11:04.237664) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 04:11:04.238445) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7MeBpy15fw/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.IoOw4GQVvE/Listeners TMPDIR=/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-07-06 04:11:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to 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% 203M=0s 2016-07-06 04:11:04 (203 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.188424 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 04:11:04.452393) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 04:11:04.452673) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7MeBpy15fw/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.IoOw4GQVvE/Listeners TMPDIR=/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.028215 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 04:11:04.500987) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-06 04:11:04.501293) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a7d6bb9e7d12166470ad4210dd1f56b7b07d0dc8 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev a7d6bb9e7d12166470ad4210dd1f56b7b07d0dc8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7MeBpy15fw/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.IoOw4GQVvE/Listeners TMPDIR=/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-07-06 04:11:04,571 truncating revision to first 12 chars 2016-07-06 04:11:04,571 Setting DEBUG logging. 2016-07-06 04:11:04,571 attempt 1/10 2016-07-06 04:11:04,571 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a7d6bb9e7d12?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-06 04:11:05,468 unpacking tar archive at: mozilla-central-a7d6bb9e7d12/testing/mozharness/ program finished with exit code 0 elapsedTime=1.165647 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-06 04:11:05.692648) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 04:11:05.693472) ========= script_repo_revision: a7d6bb9e7d12166470ad4210dd1f56b7b07d0dc8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 04:11:05.694140) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 04:11:05.694406) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 04:11:05.713633) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-07-06 04:11:05.714343) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7MeBpy15fw/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.IoOw4GQVvE/Listeners TMPDIR=/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:11:05 INFO - MultiFileLogger online at 20160706 04:11:05 in /builds/slave/test 04:11:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:11:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:11:05 INFO - {'append_to_log': False, 04:11:05 INFO - 'base_work_dir': '/builds/slave/test', 04:11:05 INFO - 'blob_upload_branch': 'Firefox', 04:11:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:11:05 INFO - 'branch': 'Firefox', 04:11:05 INFO - 'buildbot_json_path': 'buildprops.json', 04:11:05 INFO - 'config_files': ('talos/mac_config.py',), 04:11:05 INFO - 'default_actions': ('clobber', 04:11:05 INFO - 'read-buildbot-config', 04:11:05 INFO - 'download-and-extract', 04:11:05 INFO - 'populate-webroot', 04:11:05 INFO - 'create-virtualenv', 04:11:05 INFO - 'install', 04:11:05 INFO - 'run-tests'), 04:11:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:11:05 INFO - 'download_minidump_stackwalk': True, 04:11:05 INFO - 'download_symbols': 'ondemand', 04:11:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:11:05 INFO - 'tooltool.py': '/tools/tooltool.py', 04:11:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:11:05 INFO - '/tools/misc-python/virtualenv.py')}, 04:11:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:11:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:11:05 INFO - 'installer_path': 'installer.exe', 04:11:05 INFO - 'log_level': 'info', 04:11:05 INFO - 'log_name': 'talos', 04:11:05 INFO - 'log_to_console': True, 04:11:05 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:11:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:11:05 INFO - 'opt_config_files': (), 04:11:05 INFO - 'pip_index': False, 04:11:05 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:11:05 INFO - 'cmd': ('bash', 04:11:05 INFO - '-c', 04:11:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:11:05 INFO - 'enabled': True, 04:11:05 INFO - 'halt_on_failure': False, 04:11:05 INFO - 'name': 'check_screen_resolution'},), 04:11:05 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:11:05 INFO - 'cmd': ('bash', 04:11:05 INFO - '-c', 04:11:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:11:05 INFO - 'enabled': True, 04:11:05 INFO - 'halt_on_failure': False, 04:11:05 INFO - 'name': 'check_screen_resolution'},), 04:11:05 INFO - 'run_cmd_checks_enabled': True, 04:11:05 INFO - 'sps_profile': False, 04:11:05 INFO - 'sps_profile_interval': 0, 04:11:05 INFO - 'suite': 'dromaeojs', 04:11:05 INFO - 'system_bits': '32', 04:11:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:11:05 INFO - 'title': 't-yosemite-r7-0169', 04:11:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:11:05 INFO - 'use_talos_json': True, 04:11:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:11:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:11:05 INFO - 'work_dir': 'build'} 04:11:05 INFO - ##### 04:11:05 INFO - ##### Running clobber step. 04:11:05 INFO - ##### 04:11:05 INFO - Running pre-action listener: _resource_record_pre_action 04:11:05 INFO - Running main action method: clobber 04:11:05 INFO - rmtree: /builds/slave/test/build 04:11:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:11:07 INFO - Running post-action listener: _resource_record_post_action 04:11:07 INFO - ##### 04:11:07 INFO - ##### Finished clobber step (success) 04:11:07 INFO - ##### 04:11:07 INFO - ##### 04:11:07 INFO - ##### Running read-buildbot-config step. 04:11:07 INFO - ##### 04:11:07 INFO - Running pre-action listener: _resource_record_pre_action 04:11:07 INFO - Running main action method: read_buildbot_config 04:11:07 INFO - Using buildbot properties: 04:11:07 INFO - { 04:11:07 INFO - "project": "", 04:11:07 INFO - "product": "firefox", 04:11:07 INFO - "script_repo_revision": "production", 04:11:07 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:11:07 INFO - "repository": "", 04:11:07 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:11:07 INFO - "buildid": "20160706024124", 04:11:07 INFO - "pgo_build": "False", 04:11:07 INFO - "basedir": "/builds/slave/test", 04:11:07 INFO - "buildnumber": 280, 04:11:07 INFO - "slavename": "t-yosemite-r7-0169", 04:11:07 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 04:11:07 INFO - "platform": "yosemite_r7", 04:11:07 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:11:07 INFO - "branch": "mozilla-central", 04:11:07 INFO - "repo_path": "mozilla-central", 04:11:07 INFO - "revision": "a7d6bb9e7d12166470ad4210dd1f56b7b07d0dc8", 04:11:07 INFO - "stage_platform": "macosx64", 04:11:07 INFO - "builduid": "61d539fbfe6c4133a8983e336060d99c", 04:11:07 INFO - "slavebuilddir": "test" 04:11:07 INFO - } 04:11:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 04:11:07 INFO - Running post-action listener: _resource_record_post_action 04:11:07 INFO - ##### 04:11:07 INFO - ##### Finished read-buildbot-config step (success) 04:11:07 INFO - ##### 04:11:07 INFO - ##### 04:11:07 INFO - ##### Running download-and-extract step. 04:11:07 INFO - ##### 04:11:07 INFO - Running pre-action listener: _resource_record_pre_action 04:11:07 INFO - Running main action method: download_and_extract 04:11:07 INFO - mkdir: /builds/slave/test/build/tests 04:11:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:07 INFO - https://queue.taskcluster.net/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 04:11:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 04:11:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 04:11:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 04:11:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #1 04:11:08 INFO - Downloaded 1199 bytes. 04:11:08 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 04:11:08 INFO - Using the following test package requirements: 04:11:08 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 04:11:08 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 04:11:08 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 04:11:08 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 04:11:08 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 04:11:08 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 04:11:08 INFO - u'jsshell-mac.zip'], 04:11:08 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 04:11:08 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 04:11:08 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 04:11:08 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 04:11:08 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 04:11:08 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 04:11:08 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 04:11:08 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 04:11:08 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 04:11:08 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 04:11:08 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 04:11:08 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:11:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:08 INFO - https://queue.taskcluster.net/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:11:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 04:11:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 04:11:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 04:11:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:11:10 INFO - Downloaded 18804128 bytes. 04:11:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:11:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:11:13 INFO - Return code: 0 04:11:13 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip', u'firefox-50.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:11: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')]} 04:11:13 INFO - https://queue.taskcluster.net/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:11:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 04:11:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 04:11:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 04:11:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:11:14 INFO - Downloaded 18804128 bytes. 04:11:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:11:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:11:17 INFO - Return code: 0 04:11:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:17 INFO - https://queue.taskcluster.net/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:11:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 04:11:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 04:11:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip 04:11:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:11:20 INFO - Downloaded 14403333 bytes. 04:11:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:11:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 04:11:20 INFO - Return code: 0 04:11: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')]} 04:11:20 INFO - https://queue.taskcluster.net/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 04:11:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 04:11:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 04:11:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 04:11:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg'}, attempt #1 04:11:24 INFO - Downloaded 112518062 bytes. 04:11:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 04:11:24 INFO - mkdir: /builds/slave/test/properties 04:11:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:11:24 INFO - Writing to file /builds/slave/test/properties/build_url 04:11:24 INFO - Contents: 04:11:24 INFO - build_url:https://queue.taskcluster.net/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 04:11:26 INFO - Running post-action listener: _resource_record_post_action 04:11:26 INFO - Running post-action listener: set_extra_try_arguments 04:11:26 INFO - ##### 04:11:26 INFO - ##### Finished download-and-extract step (success) 04:11:26 INFO - ##### 04:11:26 INFO - ##### 04:11:26 INFO - ##### Running populate-webroot step. 04:11:26 INFO - ##### 04:11:26 INFO - Running pre-action listener: _resource_record_pre_action 04:11:26 INFO - Running main action method: populate_webroot 04:11:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:11:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:11:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:11:26 INFO - '--tppagecycles', 04:11:26 INFO - '7'], 04:11:26 INFO - 'tests': ['tsvgm']}}, 04:11:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:11:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:11:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:11:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:11:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:11:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:11:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:26 INFO - 'talos_options': ['--disable-e10s'], 04:11:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:11:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:11:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:26 INFO - 'talos_options': ['--disable-e10s'], 04:11:26 INFO - 'tests': ['damp', 'tps']}, 04:11:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:26 INFO - 'tests': ['damp', 'tps']}, 04:11:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:11:26 INFO - 'tests': ['dromaeo_dom']}, 04:11:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:11:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:11:26 INFO - 'tests': ['basic_compositor_video']}, 04:11:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:11:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:11:26 INFO - 'tests': ['a11yr', 04:11:26 INFO - 'ts_paint', 04:11:26 INFO - 'tpaint', 04:11:26 INFO - 'sessionrestore', 04:11:26 INFO - 'sessionrestore_no_auto_restore', 04:11:26 INFO - 'tabpaint']}, 04:11:26 INFO - 'other-e10s': {'tests': ['a11yr', 04:11:26 INFO - 'ts_paint', 04:11:26 INFO - 'tpaint', 04:11:26 INFO - 'sessionrestore', 04:11:26 INFO - 'sessionrestore_no_auto_restore', 04:11:26 INFO - 'tabpaint']}, 04:11:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:11:26 INFO - 'ts_paint', 04:11:26 INFO - 'tpaint', 04:11:26 INFO - 'sessionrestore', 04:11:26 INFO - 'sessionrestore_no_auto_restore', 04:11:26 INFO - 'tabpaint']}, 04:11:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:11:26 INFO - 'ts_paint', 04:11:26 INFO - 'tpaint', 04:11:26 INFO - 'sessionrestore', 04:11:26 INFO - 'sessionrestore_no_auto_restore', 04:11:26 INFO - 'tabpaint']}, 04:11:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:11:26 INFO - 'tests': ['a11yr', 04:11:26 INFO - 'ts_paint', 04:11:26 INFO - 'tpaint', 04:11:26 INFO - 'sessionrestore', 04:11:26 INFO - 'sessionrestore_no_auto_restore', 04:11:26 INFO - 'tabpaint']}, 04:11:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:11:26 INFO - 'tests': ['a11yr', 04:11:26 INFO - 'ts_paint', 04:11:26 INFO - 'tpaint', 04:11:26 INFO - 'sessionrestore', 04:11:26 INFO - 'sessionrestore_no_auto_restore', 04:11:26 INFO - 'tabpaint']}, 04:11:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:11:26 INFO - 'tests': ['tsvgx', 04:11:26 INFO - 'tsvgr_opacity', 04:11:26 INFO - 'tart', 04:11:26 INFO - 'tscrollx', 04:11:26 INFO - 'cart']}, 04:11:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:11:26 INFO - 'tsvgr_opacity', 04:11:26 INFO - 'tart', 04:11:26 INFO - 'tscrollx', 04:11:26 INFO - 'cart']}, 04:11:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:26 INFO - 'talos_options': ['--disable-e10s'], 04:11:26 INFO - 'tests': ['tp5o']}, 04:11:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:26 INFO - 'tests': ['tp5o']}, 04:11:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:26 INFO - 'talos_options': ['--disable-e10s', 04:11:26 INFO - '--xperf_path', 04:11:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:11:26 INFO - 'tests': ['tp5n']}, 04:11:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:26 INFO - 'talos_options': ['--xperf_path', 04:11:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:11:26 INFO - 'tests': ['tp5n']}}, 04:11:26 INFO - 'talos.zip': {'path': '', 04:11:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:11:26 INFO - Running post-action listener: _resource_record_post_action 04:11:26 INFO - ##### 04:11:26 INFO - ##### Finished populate-webroot step (success) 04:11:26 INFO - ##### 04:11:26 INFO - ##### 04:11:26 INFO - ##### Running create-virtualenv step. 04:11:26 INFO - ##### 04:11:26 INFO - Running pre-action listener: _resource_record_pre_action 04:11:26 INFO - Running main action method: create_virtualenv 04:11:26 INFO - Creating virtualenv /builds/slave/test/build/venv 04:11:26 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:11:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:11:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:11:26 INFO - Using real prefix '/tools/python27' 04:11:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:11:26 INFO - Installing distribute.............................................................................................................................................................................................done. 04:11:29 INFO - Installing pip.................done. 04:11:29 INFO - Return code: 0 04:11:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:11:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105c91a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d26618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86e2daa790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bf5d30>, '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 0x10595adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bedb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7MeBpy15fw/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IoOw4GQVvE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:11:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:11:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:11:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7MeBpy15fw/Render', 04:11:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:11:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:11:29 INFO - 'HOME': '/Users/cltbld', 04:11:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:11:29 INFO - 'LOGNAME': 'cltbld', 04:11:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:29 INFO - 'MOZ_NO_REMOTE': '1', 04:11:29 INFO - 'NO_EM_RESTART': '1', 04:11:29 INFO - 'PAGER': '/bin/cat', 04:11:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:11:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:29 INFO - 'PWD': '/builds/slave/test', 04:11:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:11:29 INFO - 'SHELL': '/bin/bash', 04:11:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IoOw4GQVvE/Listeners', 04:11:29 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 04:11:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:11:29 INFO - 'USER': 'cltbld', 04:11:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:11:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:11:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:29 INFO - 'XPC_FLAGS': '0x0', 04:11:29 INFO - 'XPC_SERVICE_NAME': '0', 04:11:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:11:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:30 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 04:11:30 INFO - Cleaning up... 04:11:30 INFO - Return code: 0 04:11:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:11: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')]} 04:11:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11: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')]} 04:11:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:30 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 0x105c91a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d26618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86e2daa790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bf5d30>, '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 0x10595adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bedb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7MeBpy15fw/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IoOw4GQVvE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:11:30 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 04:11:30 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 04:11:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7MeBpy15fw/Render', 04:11:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:11:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:11:30 INFO - 'HOME': '/Users/cltbld', 04:11:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:11:30 INFO - 'LOGNAME': 'cltbld', 04:11:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:30 INFO - 'MOZ_NO_REMOTE': '1', 04:11:30 INFO - 'NO_EM_RESTART': '1', 04:11:30 INFO - 'PAGER': '/bin/cat', 04:11:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:11:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:30 INFO - 'PWD': '/builds/slave/test', 04:11:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:11:30 INFO - 'SHELL': '/bin/bash', 04:11:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IoOw4GQVvE/Listeners', 04:11:30 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 04:11:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:11:30 INFO - 'USER': 'cltbld', 04:11:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:11:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:11:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:30 INFO - 'XPC_FLAGS': '0x0', 04:11:30 INFO - 'XPC_SERVICE_NAME': '0', 04:11:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:11:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:30 INFO - Downloading/unpacking psutil>=3.1.1 04:11:30 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 04:11:30 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 04:11:30 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 04:11:30 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 04:11:30 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 04:11:30 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 04:11:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:11:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:11:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:11:33 INFO - Installing collected packages: psutil 04:11:33 INFO - Running setup.py install for psutil 04:11:33 INFO - building 'psutil._psutil_osx' extension 04:11:33 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:11:34 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:11:34 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:11:34 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:11:34 INFO - building 'psutil._psutil_posix' extension 04:11:34 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:11:34 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:11:34 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:11:34 INFO - ^ 04:11:34 INFO - 1 warning generated. 04:11:34 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:11:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:11:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:11:34 INFO - Successfully installed psutil 04:11:34 INFO - Cleaning up... 04:11:34 INFO - Return code: 0 04:11:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:11:34 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')]} 04:11:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:34 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')]} 04:11:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:34 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 0x105c91a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d26618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86e2daa790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bf5d30>, '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 0x10595adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bedb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7MeBpy15fw/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IoOw4GQVvE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:11:34 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 04:11:34 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 04:11:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7MeBpy15fw/Render', 04:11:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:11:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:11:34 INFO - 'HOME': '/Users/cltbld', 04:11:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:11:34 INFO - 'LOGNAME': 'cltbld', 04:11:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:34 INFO - 'MOZ_NO_REMOTE': '1', 04:11:34 INFO - 'NO_EM_RESTART': '1', 04:11:34 INFO - 'PAGER': '/bin/cat', 04:11:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:11:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:34 INFO - 'PWD': '/builds/slave/test', 04:11:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:11:34 INFO - 'SHELL': '/bin/bash', 04:11:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IoOw4GQVvE/Listeners', 04:11:34 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 04:11:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:11:34 INFO - 'USER': 'cltbld', 04:11:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:11:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:11:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:34 INFO - 'XPC_FLAGS': '0x0', 04:11:34 INFO - 'XPC_SERVICE_NAME': '0', 04:11:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:11:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:11:34 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 04:11:34 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 04:11:34 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 04:11:34 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 04:11:34 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 04:11:34 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 04:11:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:11:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:11:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:11:37 INFO - Installing collected packages: mozsystemmonitor 04:11:37 INFO - Running setup.py install for mozsystemmonitor 04:11:37 INFO - Successfully installed mozsystemmonitor 04:11:37 INFO - Cleaning up... 04:11:37 INFO - Return code: 0 04:11:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:11:37 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')]} 04:11:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:37 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')]} 04:11:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:37 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 0x105c91a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d26618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86e2daa790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bf5d30>, '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 0x10595adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bedb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7MeBpy15fw/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IoOw4GQVvE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:11:37 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 04:11:37 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 04:11:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7MeBpy15fw/Render', 04:11:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:11:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:11:37 INFO - 'HOME': '/Users/cltbld', 04:11:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:11:37 INFO - 'LOGNAME': 'cltbld', 04:11:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:37 INFO - 'MOZ_NO_REMOTE': '1', 04:11:37 INFO - 'NO_EM_RESTART': '1', 04:11:37 INFO - 'PAGER': '/bin/cat', 04:11:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:11:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:37 INFO - 'PWD': '/builds/slave/test', 04:11:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:11:37 INFO - 'SHELL': '/bin/bash', 04:11:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IoOw4GQVvE/Listeners', 04:11:37 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 04:11:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:11:37 INFO - 'USER': 'cltbld', 04:11:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:11:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:11:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:37 INFO - 'XPC_FLAGS': '0x0', 04:11:37 INFO - 'XPC_SERVICE_NAME': '0', 04:11:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:11:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:37 INFO - Downloading/unpacking jsonschema==2.5.1 04:11:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:11:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:11:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:40 INFO - Downloading functools32-3.2.3-2.tar.gz 04:11:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:11:40 INFO - warning: no files found matching '*.txt' 04:11:40 INFO - no previously-included directories found matching 'build' 04:11:40 INFO - no previously-included directories found matching 'dist' 04:11:40 INFO - no previously-included directories found matching '.git*' 04:11:40 INFO - Installing collected packages: jsonschema, functools32 04:11:40 INFO - Running setup.py install for functools32 04:11:40 INFO - warning: no files found matching '*.txt' 04:11:40 INFO - no previously-included directories found matching 'build' 04:11:40 INFO - no previously-included directories found matching 'dist' 04:11:40 INFO - no previously-included directories found matching '.git*' 04:11:40 INFO - Successfully installed jsonschema functools32 04:11:40 INFO - Cleaning up... 04:11:41 INFO - Return code: 0 04:11:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:11:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:41 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 0x105c91a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d26618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86e2daa790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bf5d30>, '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 0x10595adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bedb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7MeBpy15fw/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IoOw4GQVvE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:11:41 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 04:11:41 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 04:11:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7MeBpy15fw/Render', 04:11:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:11:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:11:41 INFO - 'HOME': '/Users/cltbld', 04:11:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:11:41 INFO - 'LOGNAME': 'cltbld', 04:11:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:41 INFO - 'MOZ_NO_REMOTE': '1', 04:11:41 INFO - 'NO_EM_RESTART': '1', 04:11:41 INFO - 'PAGER': '/bin/cat', 04:11:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:11:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:41 INFO - 'PWD': '/builds/slave/test', 04:11:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:11:41 INFO - 'SHELL': '/bin/bash', 04:11:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IoOw4GQVvE/Listeners', 04:11:41 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 04:11:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:11:41 INFO - 'USER': 'cltbld', 04:11:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:11:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:11:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:41 INFO - 'XPC_FLAGS': '0x0', 04:11:41 INFO - 'XPC_SERVICE_NAME': '0', 04:11:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:11:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:41 INFO - Downloading/unpacking blobuploader==1.2.4 04:11:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:43 INFO - Downloading blobuploader-1.2.4.tar.gz 04:11:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:11:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:11:43 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 04:11:43 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 04:11:43 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 04:11:43 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 04:11:43 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 04:11:43 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 04:11:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:11:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:11:44 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 04:11:44 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 04:11:44 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 04:11:44 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 04:11:44 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 04:11:44 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 04:11:44 INFO - Downloading docopt-0.6.1.tar.gz 04:11:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:11:45 INFO - Installing collected packages: blobuploader, requests, docopt 04:11:45 INFO - Running setup.py install for blobuploader 04:11:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:11:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:11:45 INFO - Running setup.py install for requests 04:11:45 INFO - Running setup.py install for docopt 04:11:45 INFO - Successfully installed blobuploader requests docopt 04:11:45 INFO - Cleaning up... 04:11:45 INFO - Return code: 0 04:11:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:11:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:45 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 0x105c91a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d26618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86e2daa790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bf5d30>, '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 0x10595adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bedb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7MeBpy15fw/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IoOw4GQVvE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:11:45 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 04:11:45 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 04:11:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7MeBpy15fw/Render', 04:11:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:11:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:11:45 INFO - 'HOME': '/Users/cltbld', 04:11:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:11:45 INFO - 'LOGNAME': 'cltbld', 04:11:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:45 INFO - 'MOZ_NO_REMOTE': '1', 04:11:45 INFO - 'NO_EM_RESTART': '1', 04:11:45 INFO - 'PAGER': '/bin/cat', 04:11:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:11:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:45 INFO - 'PWD': '/builds/slave/test', 04:11:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:11:45 INFO - 'SHELL': '/bin/bash', 04:11:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IoOw4GQVvE/Listeners', 04:11:45 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 04:11:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:11:45 INFO - 'USER': 'cltbld', 04:11:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:11:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:11:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:45 INFO - 'XPC_FLAGS': '0x0', 04:11:45 INFO - 'XPC_SERVICE_NAME': '0', 04:11:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:11:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:11:46 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-baWnT0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:11:46 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-Dqlexf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:11:46 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-HY8Yu4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:11:46 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-0OU9yQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:11:46 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-p6fPPx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:11:46 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-awuFAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:11:46 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-07DbBL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:11:46 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-ksG2Ih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:11:47 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-vB_g5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:11:47 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-nmtjSw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:11:47 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-tTqLSm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:11:47 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-InS7AZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:11:47 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-e9fgNb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:11:47 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-N9Hyie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:11:47 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-4r9iYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:11:47 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-lZxIrf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:11:47 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-hyBPNq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:11:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:11:47 INFO - Running setup.py install for manifestparser 04:11:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:11:48 INFO - Running setup.py install for mozcrash 04:11:48 INFO - Running setup.py install for mozdebug 04:11:48 INFO - Running setup.py install for mozdevice 04:11:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:11:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:11:48 INFO - Running setup.py install for mozfile 04:11:48 INFO - Running setup.py install for mozhttpd 04:11:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:11:48 INFO - Running setup.py install for mozinfo 04:11:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:11:49 INFO - Running setup.py install for mozInstall 04:11:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:11:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:11:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:11:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:11:49 INFO - Running setup.py install for mozleak 04:11:49 INFO - Running setup.py install for mozlog 04:11:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:11:49 INFO - Running setup.py install for moznetwork 04:11:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:11:49 INFO - Running setup.py install for mozprocess 04:11:49 INFO - Running setup.py install for mozprofile 04:11:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:11:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:11:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:11:49 INFO - Running setup.py install for mozrunner 04:11:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:11:50 INFO - Running setup.py install for mozscreenshot 04:11:50 INFO - Running setup.py install for moztest 04:11:50 INFO - Running setup.py install for mozversion 04:11:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:11:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:11:50 INFO - Cleaning up... 04:11:50 INFO - Return code: 0 04:11:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:11:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:50 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 0x105c91a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d26618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86e2daa790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bf5d30>, '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 0x10595adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bedb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7MeBpy15fw/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IoOw4GQVvE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:11:50 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 04:11:50 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 04:11:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7MeBpy15fw/Render', 04:11:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:11:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:11:50 INFO - 'HOME': '/Users/cltbld', 04:11:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:11:50 INFO - 'LOGNAME': 'cltbld', 04:11:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:50 INFO - 'MOZ_NO_REMOTE': '1', 04:11:50 INFO - 'NO_EM_RESTART': '1', 04:11:50 INFO - 'PAGER': '/bin/cat', 04:11:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:11:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:50 INFO - 'PWD': '/builds/slave/test', 04:11:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:11:50 INFO - 'SHELL': '/bin/bash', 04:11:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IoOw4GQVvE/Listeners', 04:11:50 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 04:11:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:11:50 INFO - 'USER': 'cltbld', 04:11:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:11:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:11:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:50 INFO - 'XPC_FLAGS': '0x0', 04:11:50 INFO - 'XPC_SERVICE_NAME': '0', 04:11:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:11:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:11:50 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-AEzJ5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:11:50 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)) 04:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:11:50 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-KhMW8c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:11:51 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)) 04:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:11:51 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-fGs0Wo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:11:51 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)) 04:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:11:51 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-7NQnQi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:11:51 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)) 04:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:11:51 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-iC5xWc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:11:51 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)) 04:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:11:51 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-189EDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:11:51 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)) 04:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:11:51 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-IVToM9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:11:51 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)) 04:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:11:51 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-KCNfHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:11:51 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)) 04:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:11:51 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-MZeZ2m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:11:51 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)) 04:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:11:51 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-dSVsAh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 04:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:11:51 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-JgBOLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:11:52 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)) 04:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:11:52 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-zxNmg1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:11:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 04:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:11:52 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-DgDWXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:11:52 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)) 04:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:11:52 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-Timxq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:11:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 04:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:11:52 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-NnRBeW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:11:52 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)) 04:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:11:52 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-qTUiS0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:11:52 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)) 04:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:11:52 INFO - Running setup.py (path:/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/pip-WY9yKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:11:52 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)) 04:11:52 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)) 04:11:52 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)) 04:11:52 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)) 04:11:52 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)) 04:11:52 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)) 04:11:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:55 INFO - Downloading blessings-1.6.tar.gz 04:11:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:11:55 INFO - Installing collected packages: blessings 04:11:55 INFO - Running setup.py install for blessings 04:11:55 INFO - Successfully installed blessings 04:11:55 INFO - Cleaning up... 04:11:55 INFO - Return code: 0 04:11:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:11:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:11:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:11:55 INFO - Reading from file tmpfile_stdout 04:11:55 INFO - Current package versions: 04:11:55 INFO - blessings == 1.6 04:11:55 INFO - blobuploader == 1.2.4 04:11:55 INFO - docopt == 0.6.1 04:11:55 INFO - functools32 == 3.2.3-2 04:11:55 INFO - jsonschema == 2.5.1 04:11:55 INFO - manifestparser == 1.1 04:11:55 INFO - mozInstall == 1.12 04:11:55 INFO - mozcrash == 0.17 04:11:55 INFO - mozdebug == 0.1 04:11:55 INFO - mozdevice == 0.48 04:11:55 INFO - mozfile == 1.2 04:11:55 INFO - mozhttpd == 0.7 04:11:55 INFO - mozinfo == 0.9 04:11:55 INFO - mozleak == 0.1 04:11:55 INFO - mozlog == 3.2 04:11:55 INFO - moznetwork == 0.27 04:11:55 INFO - mozprocess == 0.22 04:11:55 INFO - mozprofile == 0.28 04:11:55 INFO - mozrunner == 6.11 04:11:55 INFO - mozscreenshot == 0.1 04:11:55 INFO - mozsystemmonitor == 0.3 04:11:55 INFO - moztest == 0.7 04:11:55 INFO - mozversion == 1.4 04:11:55 INFO - psutil == 3.1.1 04:11:55 INFO - requests == 1.2.3 04:11:55 INFO - wsgiref == 0.1.2 04:11:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:11: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')]} 04:11:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11: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')]} 04:11:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:55 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 0x105c91a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d26618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86e2daa790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bf5d30>, '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 0x10595adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bedb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7MeBpy15fw/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IoOw4GQVvE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:11:55 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 04:11:55 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 04:11:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7MeBpy15fw/Render', 04:11:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:11:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:11:55 INFO - 'HOME': '/Users/cltbld', 04:11:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:11:55 INFO - 'LOGNAME': 'cltbld', 04:11:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:55 INFO - 'MOZ_NO_REMOTE': '1', 04:11:55 INFO - 'NO_EM_RESTART': '1', 04:11:55 INFO - 'PAGER': '/bin/cat', 04:11:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:11:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:55 INFO - 'PWD': '/builds/slave/test', 04:11:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:11:55 INFO - 'SHELL': '/bin/bash', 04:11:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IoOw4GQVvE/Listeners', 04:11:55 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 04:11:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:11:55 INFO - 'USER': 'cltbld', 04:11:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:11:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:11:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:55 INFO - 'XPC_FLAGS': '0x0', 04:11:55 INFO - 'XPC_SERVICE_NAME': '0', 04:11:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:11:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:56 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)) 04:11:56 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)) 04:11:56 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)) 04:11:56 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)) 04:11:56 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)) 04:11:56 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)) 04:11:56 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)) 04:11:56 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)) 04:11:56 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)) 04:11:56 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)) 04:11:56 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)) 04:11:56 INFO - Cleaning up... 04:11:56 INFO - Return code: 0 04:11:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:11:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105c91a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d26618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86e2daa790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bf5d30>, '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 0x10595adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bedb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7MeBpy15fw/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IoOw4GQVvE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:11:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:11:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:11:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7MeBpy15fw/Render', 04:11:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:11:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:11:56 INFO - 'HOME': '/Users/cltbld', 04:11:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:11:56 INFO - 'LOGNAME': 'cltbld', 04:11:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:56 INFO - 'MOZ_NO_REMOTE': '1', 04:11:56 INFO - 'NO_EM_RESTART': '1', 04:11:56 INFO - 'PAGER': '/bin/cat', 04:11:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:11:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:56 INFO - 'PWD': '/builds/slave/test', 04:11:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:11:56 INFO - 'SHELL': '/bin/bash', 04:11:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IoOw4GQVvE/Listeners', 04:11:56 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 04:11:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:11:56 INFO - 'USER': 'cltbld', 04:11:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:11:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:11:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:56 INFO - 'XPC_FLAGS': '0x0', 04:11:56 INFO - 'XPC_SERVICE_NAME': '0', 04:11:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:11:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:11:56 INFO - Cleaning up... 04:11:56 INFO - Return code: 0 04:11:56 INFO - Running post-action listener: _resource_record_post_action 04:11:56 INFO - Running post-action listener: _start_resource_monitoring 04:11:56 INFO - Starting resource monitoring. 04:11:56 INFO - ##### 04:11:56 INFO - ##### Finished create-virtualenv step (success) 04:11:56 INFO - ##### 04:11:56 INFO - ##### 04:11:56 INFO - ##### Running install step. 04:11:56 INFO - ##### 04:11:56 INFO - Running pre-action listener: _resource_record_pre_action 04:11:56 INFO - Running main action method: install 04:11:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:11:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:11:56 INFO - Reading from file tmpfile_stdout 04:11:56 INFO - Detecting whether we're running mozinstall >=1.0... 04:11:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:11:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:11:56 INFO - Reading from file tmpfile_stdout 04:11:56 INFO - Output received: 04:11:56 INFO - Usage: mozinstall [options] installer 04:11:56 INFO - Options: 04:11:56 INFO - -h, --help show this help message and exit 04:11:56 INFO - -d DEST, --destination=DEST 04:11:56 INFO - Directory to install application into. [default: 04:11:56 INFO - "/builds/slave/test"] 04:11:56 INFO - --app=APP Application being installed. [default: firefox] 04:11:56 INFO - mkdir: /builds/slave/test/build/application 04:11:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:11:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:12:30 INFO - Reading from file tmpfile_stdout 04:12:30 INFO - Output received: 04:12:30 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:12:30 INFO - Running post-action listener: _resource_record_post_action 04:12:30 INFO - ##### 04:12:30 INFO - ##### Finished install step (success) 04:12:30 INFO - ##### 04:12:30 INFO - ##### 04:12:30 INFO - ##### Running run-tests step. 04:12:30 INFO - ##### 04:12:30 INFO - Running pre-action listener: _resource_record_pre_action 04:12:30 INFO - Running main action method: run_tests 04:12:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:12:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:12:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:12:30 INFO - 2016-07-06 04:12:30.882 screenresolution[1641:7544] starting screenresolution argv=screenresolution get 04:12:30 INFO - 2016-07-06 04:12:30.885 screenresolution[1641:7544] Display 0: 1600x1200x32@60 04:12:30 INFO - 2016-07-06 04:12:30.890 screenresolution[1642:7546] starting screenresolution argv=screenresolution list 04:12:30 INFO - Available Modes on Display 0 04:12:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:12:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:12:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:12:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:12:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:12:31 INFO - Intel Iris: 04:12:31 INFO - Chipset Model: Intel Iris 04:12:31 INFO - Type: GPU 04:12:31 INFO - Bus: Built-In 04:12:31 INFO - VRAM (Dynamic, Max): 1536 MB 04:12:31 INFO - Vendor: Intel (0x8086) 04:12:31 INFO - Device ID: 0x0a2e 04:12:31 INFO - Revision ID: 0x0009 04:12:31 INFO - Displays: 04:12:31 INFO - Display: 04:12:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:12:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:12:31 INFO - Display Serial Number: 1600x1200 60 04:12:31 INFO - Main Display: Yes 04:12:31 INFO - Mirror: Off 04:12:31 INFO - Online: Yes 04:12:31 INFO - Rotation: Supported 04:12:31 INFO - Return code: 0 04:12:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:12:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:12:31 INFO - Python 2.7.3 04:12:31 INFO - Return code: 0 04:12:31 INFO - grabbing minidump binary from tooltool 04:12:31 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')]} 04:12:31 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/macosx64/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 0x105bf5d30>, '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 0x10595adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bedb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:12:31 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:12:31 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/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:12:31 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:12:31 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:12:31 INFO - Return code: 0 04:12:31 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:12:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:12:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:12:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:12:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:12:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0169', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:12:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0169 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:12:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7MeBpy15fw/Render', 04:12:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:12:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:12:31 INFO - 'HOME': '/Users/cltbld', 04:12:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:12:31 INFO - 'LOGNAME': 'cltbld', 04:12:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:12:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:12:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:31 INFO - 'MOZ_NO_REMOTE': '1', 04:12:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:12:31 INFO - 'NO_EM_RESTART': '1', 04:12:31 INFO - 'PAGER': '/bin/cat', 04:12:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:12:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:31 INFO - 'PWD': '/builds/slave/test', 04:12:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:12:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:12:31 INFO - 'SHELL': '/bin/bash', 04:12:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IoOw4GQVvE/Listeners', 04:12:31 INFO - 'TMPDIR': '/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/', 04:12:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:12:31 INFO - 'USER': 'cltbld', 04:12:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:12:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:12:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:31 INFO - 'XPC_FLAGS': '0x0', 04:12:31 INFO - 'XPC_SERVICE_NAME': '0', 04:12:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:12:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0169', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:12:31 INFO - mozversion application_buildid: 20160706024124 04:12:31 INFO - mozversion application_changeset: a7d6bb9e7d12166470ad4210dd1f56b7b07d0dc8 04:12:31 INFO - mozversion application_display_name: Nightly 04:12:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:12:31 INFO - mozversion application_name: Firefox 04:12:31 INFO - mozversion application_remotingname: firefox 04:12:31 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:12:31 INFO - mozversion application_vendor: Mozilla 04:12:31 INFO - mozversion application_version: 50.0a1 04:12:31 INFO - mozversion platform_buildid: 20160706024124 04:12:31 INFO - mozversion platform_changeset: a7d6bb9e7d12166470ad4210dd1f56b7b07d0dc8 04:12:31 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:12:31 INFO - mozversion platform_version: 50.0a1 04:12:31 INFO - using testdate: 1467803551 04:12:31 INFO - actual date: 1467803551 04:12:31 INFO - starting webserver on 'localhost:49279' 04:12:31 INFO - SUITE-START | Running 2 tests 04:12:31 INFO - TEST-START | dromaeo_css 04:12:31 INFO - operating with platform_type : mac_ 04:12:31 INFO - Initialising browser for dromaeo_css test... 04:12:31 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/tmpo81po_/profile http://localhost:49279/getInfo.html) 04:12:33 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 04:12:33 INFO - PROCESS | 1652 | colorDepth:24 04:12:33 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 04:12:33 INFO - PROCESS | 1652 | __metrics 04:12:33 INFO - PROCESS | 1652 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:12:33 INFO - PROCESS | 1652 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:12:34 INFO - TEST-INFO | 1652: exit 0 04:12:34 INFO - Browser initialized. 04:12:34 INFO - Running cycle 1/1 for dromaeo_css test... 04:12:34 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/tmpo81po_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:12:46 INFO - PROCESS | 1654 | RSS: Main: 244035584 04:12:46 INFO - PROCESS | 1654 | 04:13:37 INFO - PROCESS | 1654 | 1467803617586 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] 04:15:49 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49279/tests/dromaeo/cssquery-ext.html) 04:15:50 INFO - PROCESS | 1654 | RSS: Main: 360169472 04:15:50 INFO - PROCESS | 1654 | 04:18:54 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-ext.html (next: http://localhost:49279/tests/dromaeo/cssquery-jquery.html) 04:18:54 INFO - PROCESS | 1654 | RSS: Main: 383475712 04:18:54 INFO - PROCESS | 1654 | 04:21:57 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49279/tests/dromaeo/cssquery-mootools.html) 04:21:57 INFO - PROCESS | 1654 | RSS: Main: 373575680 04:21:57 INFO - PROCESS | 1654 | 04:25:00 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49279/tests/dromaeo/cssquery-prototype.html) 04:25:00 INFO - PROCESS | 1654 | RSS: Main: 373284864 04:25:00 INFO - PROCESS | 1654 | 04:28:03 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49279/tests/dromaeo/cssquery-yui.html) 04:28:04 INFO - PROCESS | 1654 | RSS: Main: 346398720 04:28:04 INFO - PROCESS | 1654 | 04:31:07 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-yui.html (next: http://localhost:49279/tests/dromaeo/cssquery-dojo.html) 04:31:08 INFO - PROCESS | 1654 | RSS: Main: 386146304 04:31:08 INFO - PROCESS | 1654 | 04:31:08 INFO - PROCESS | 1654 | __start_tp_report 04:31:08 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 04:31:08 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 04:31:08 INFO - PROCESS | 1654 | |i|pagename|runs| 04:31:08 INFO - PROCESS | 1654 | |0;dojo.html;3311.4039472894883;3315.701586857183;3365.51200075989;3404.2340473393506;3424.4007298722718;5625.52183064439;5703.3156021277455;5725.227094342263;5745.396733343002;5759.654420734753;5709.086546152616;5726.9140962885485;5761.625494342865;5764.596478246524;5765.769369225236;4370.2789039808395;5139.460356662562;5161.27742116104;5181.1710126379785;5185.351831021122;5249.107651699221;5265.710385928773;5266.683998960056;5267.894642107156;5272.919051594414;5135.460776618457;5192.506711862367;5194.63637545372;5220.086484865153;5258.842234732945;5235.057689615867;5237;5252.6323157379;5254.973725131388;5317.41508434072;5057.2666963290485;5105.642605017651;5146.330976973007;5179.352580927384;5211.270422140903;4808.879778005543;5648.717564121777;5721.828345149611;5750.309962804448;5752.827415177551;6260.624362538262;6279.246490421133;6279.874402511924;6292.307846136921;6293.087502312139;6171.413715697002;6204.782832600882;6266.811995640138;6323.494120470351;6323.9683801580695;5815.73829177688;5827.213326200994;5892.410758924159;5896.823095307148;5903.0555111182;6255.155554000243;6257.749690012349;6268.874622507616;6274.9686251569365;6275.811725648238;6041.093835924647;6119.602225855305;6132.908006379907;6156.815295541141;6177.7837775677635;6256.436920677161;6302.243730752248;6302.653354065479;6306.558540902093;6314.210723659543;6196.907046394308;6233.34549872266;6254.6872656366995;6261.749530018839;6267.905981410283;6121.605402471149;6166.753329866755;6183.505319574513;6243.625382477066;6272.090546870678;4722.055588882237;4885.828995985124;4898.436679781871;4921.311016457699;4925.926111108336;4386.407834942306;4453.354263631755;4459.910801783946;4493.977530112328;4494.438195225597;5750.079987202028;5763.971180144073;5788.884222315614;5817.185594016841;5835.9708201458725;6213.844653883689;6289.24529056507;6301.842453938688;6305;6313.842153946188;5615.606907516435;5673.347565030074;5673.489385955284;5696.914546281726;5771.88456230873;5357.624966252403;5363.517283444508;5374.113271310268;5375.139977603565;5409.810656627078;6213.099100630474;6243.500519958392;6274.592151510137;6276.340984196685;6293.181886354744;6131.724072416663;6146.58628515435;6189.319174890848;6252.187215661935;6292.276388215414;5345.278387417804;6273.341299163704;6274.843128921813;6289.465395441439;6308.243010838729;4557.293619488984;6185.103160041679;6195.96902015487;6216.098665693539;6221.346758590464;6110.0424004731585;6192.535559832941;6197.25632924052;6237.594556353823;6284.340144284784;5980.372060933713;6038.184845045863;6117.755289788359;6120.143179954899;6131.049687298476;6003.529135361864;6128.172696686069;6142.539309551712;6144.78493252734;6145.877082458415;5079.796808127781;5962.791302304398;6056.746550977894;6081.635101893724;6092.482139018056;6187.319394866471;6192.380761923771;6195.845103872259;6209.379062093935;6237.220347456568;5886.970565147147;5970.76116955317;6050.788222412194;6068.423499767515;6088 04:31:08 INFO - PROCESS | 1654 | |1;ext.html;516.1766981664244;517.0202466326309;518.0933366608434;532.846387570909;549.2639862584136;21730.782692173074;31535.526967095513;43176.784116079376;43322.7833860831;43416.56583434164;45466.772666136625;45577.7721111394;45797.08405831881;45837;46390.30414543785;8612.52631105289;9802.754931126708;9810.607575696964;9826.312158148932;9829.213662906986;7701.499402538845;8649.783755406103;8865.556722163867;8953.910460895406;8956.373053886231;11807.11446641501;11886.524539018472;11936.10479214058;12192.81710774339;12282.447289871978;11970.22193557416;12099.092568057431;12133.029357651367;12145.878541214563;12261.203021803643;8701.521416322099;8842.292616590657;8851.513166775825;12023.579174728842;12101.697457563543;33670.831645841856;42279;42341.72974810761;42420.7273781787;44850;3476.391631464509;3581.5702115746017;3597.4244120940784;3983.900402489932;4111;27337.80604165328;31423.528647070314;32751.83624081888;33104.66895331064;33176.83411582927;3263.673632636741;3313.5692359993286;3350.445019803499;3407.335569563936;3413.2490852012515;536578;541140;541459.8051126743;541588;545100.999999996;66221.66889165524;66968;67008.66495667589;67138.66430667815;67151.99999999903;70213.94679079817;70240;70248;70278;70327.2967270331;16677.833221667872;17040.48878533646;17061.40285090016;17065.232064557124;17112.315507379815;13014.089013769135;13204.405801738945;13215.471381144838;13220.40508177115;13233.73532529344;15100.697986040217;15340.079595224322;17297;18853.020432854628;19066;6237.4698150656795;6481.935180648133;7271.800152974805;7318.890216646754;7432.145303290191;738.3908275672592;974.6832279509047;980.7446468520305;994.5275993902839;1067.9786404271872;28903.710962890524;30867.691323086932;31216.21959451032;31329.06012819619;31637.892673756767;1039.939261952804;1065.6376831877199;1066.7706443114769;1135.4720055174384;1200.2138599217526;16191.919040404722;16239;16277.430289939795;16356.509304720877;16651.333946642;675392;680986.5950670214;681338;684127;685326;55325.34023979287;62477;62512;62892;63158.68420657867;1403.985960140406;1428.599992002241;1434.9426022959174;1438.892083093772;1439;26850;30795;32353.191170220933;32430.67569324371;32858.50712239366;50970;51382;51820.96358072893;51843;52020.73989630028;452159;461258;462519;567103;816912.4080657149;39300.803495982334;40988.59011409848;41194.58805411908;41279.380809287286;41342.173156537305;47936.04127917352;47937.280940786615;48081.75959120182;49032.774180644345;49080;34314.14214644654;36091.639083608825;38666.6133338663;39917.40123898202;40824.59175408208;39407;39878.60424885115;39997.000074997195;40907;40950.9762255946;38996.025099372746;39411.21177576375;39734.40398394084;40584.391234132105;42970.570294297904;35394.646053540164;36207;36335.687370549385;36956.81521592375;37072.44391334078;26531.7346826537;26658.466830662892;26726.19821405361;26732.732672673024;26945.865270673523 04:31:08 INFO - PROCESS | 1654 | |2;jquery.html;362.25194972382013;377.52620461321044;387.97866117363543;394.50686641697894;414.00431961133484;15365.385384584617;15874.682506349865;20741.585168296624;20972.05625746841;20973.790262097373;21716.833444963162;21761.564768704655;22017.889910550464;22056.33830985069;22166.1133554658;5340.572754179656;5867.266591676041;6163.167972323746;6187.4740647045055;6191.442770150686;4275.764832934187;4508.842190523333;4515.616172625314;4520.864374068767;6114.449699527042;4353.912921741563;4452.154090722768;4496.595306422421;4510.030343476152;6226.533010024244;6867.931320686779;6902.344277293649;6905.758298459555;6906.896396554056;6911.205211400653;5291.259223708684;5632.464915832989;5633.633813802131;5654.236678048452;5662;11723.7069073273;12208.389580520938;12221.205621634565;13324.600261992156;13703.862961370358;1859.6931506301444;2025.8075482829108;2202.394341556085;2294.529621427603;2708.79684023699;9906.10845023944;10342.017508336696;10667.733306667318;10682.145428365711;10693.572257109707;1850.7964123946356;2034.5422279986885;2062.5565503416838;2068.8758674479577;2208.641685363506;120062.48383181132;124073;126811;131098;136578;20686.655367401072;20764.169433222803;21623.351299461043;21648.675269870964;21879.015444305045;35347;35404.822975884956;35433.46849797255;35507.4673879892;35513.64486355155;10630;11204.271722338022;11274.943625281821;11288.661340159808;11414.801445848232;9154.267658587298;9190.908090919005;9213.355065145375;9310.208632266198;9348.158665720119;9861.013898610081;9980.650677226262;10004.49977501122;10075.34510256831;10100.747481313027;3204.8557814898386;3614.403623402162;3661.5670189515326;3734.178480734234;3759.473673685686;880.8326417980563;891.8974317953518;944.4899754132691;947.2611363136764;974.7222041718077;19946.70079948802;22105;22135.683541709535;22157.446063848533;22186.1125554976;930.9627614895463;969.1810420194925;982.8427451607708;987.7481242283171;1006.1699098243978;11489.195756296978;12554.748905021848;12614.747705046031;12663.810042849365;12798.296093714749;578864;582153;586236.0688196531;593784;594316;131369;133283;134656.32671836577;135801;136914;1001.4441984698417;1006.5671761142632;1021.0963297481782;1033.850091736694;1034.3586976074732;20366.89816550908;20708.378748637566;20710.482237944172;20766.1693532257;20772.85749283804;57069;57395;58103.70948145401;58152.12771808511;58390.4160958385;66428;78744;79262.6036869812;84187.15812841793;84603;5635.577331700057;5714.742836572447;7885.802854928673;8391.202835730595;8471.152884711479;11361.54553817871;11992.880071199177;13074.869251307366;13317;13743.862561374659;11260.38067906273;11719.589814356457;11876.940615296868;11954.58158964432;12033.578824741093;11706.824397633873;11716.531338746354;11716.94141529287;11905.583304584297;11994.400279985792;11811.940940295244;11817.527298907948;12082.939585302018;12143.635690929286;12199.451024704087;7259.455540834353;7409.184989651242;8434.451760635538;8569.785755356166;8601.311895048257;11106.944465277946;11522.884771152181;11666.533338666697;11743.823842642538;11807.468663910317 04:31:08 INFO - PROCESS | 1654 | |3;mootools.html;1403.656104254458;1543.9382424703012;1579.676166385891;1598.432556442463;1842.6314737052594;7818.491798033124;8310.70912518062;8311.750647480578;8316.501009939393;8317.87523187152;8127.227913348237;8510.234078932895;8795.956020219906;8810.074942131065;8915.331350148748;2318.5942460069505;2335.708036495438;2362.633791762271;2364.267077206063;2366.3847399676038;2158.3417057797365;2190.233418303597;2359.374765687094;2368.5973384524586;2371.336025912747;2293.1286111277773;2312.722473303206;2321.7446080931086;2340.391498210469;2344.109238489372;2306.2965795432387;2312.9884350578222;2317.397476656073;2324.732655744594;2324.9186278480342;2308.746037935826;2310.387747246981;2315.397996520917;2316.1661801751525;2316.745158032615;8950.194482496541;8965.641374345018;9008.369414141012;9028.593713282919;9029.277657787361;5207.880305734286;5221.817236396746;5371.086915224382;5378.946210537883;5380.461953804588;3482.547268855058;3518.102883764649;3590.8025058621765;3604.5133906922492;3618.6924111450294;1057.1384321777803;1064.0423618743193;1080.189857606795;1087.2280680716701;1097.0729733375285;11498.42507874603;11608.6517404478;11608.883911160865;11619.07047436203;11655.88344116565;4231.449911511545;4415.492218394926;4435.3125265583885;4592.609628181642;4618.445786505641;9053.77365565866;9071.81856362869;9072;9076.001639819615;9081.273498120267;5206.505381988705;5209.687418754811;5214.504622060898;5216.66091704038;5217.556507696889;3521.595016573127;4298.548652391516;4387.846425375096;4538.478075021349;4876.780544875489;3742.176721121349;3813.9809300953316;3850.1914597934747;3857.517810273716;3878.1855810279594;988.7775250568708;1052.7052425320921;1147.208426185929;1166.7141550320225;1176.2883455509293;837.6942416018231;932.1983094538691;938.877945867033;959.1781295532588;976.912077912977;5889.882202355929;6113.419225173601;6117.663528505975;6153.769246150788;6258.087401389887;444.8220711715275;448.83841816945875;461.8014253870801;464.16913724432885;464.345273164836;3957.039001964542;4007.3788562772816;4057.16828050249;4094;4114.567970363129;10594.523246453773;10906.890931090587;10979.121670266359;11021.669349919515;11053.392063436588;10322.690319290434;10882.40146791934;10892.836607450894;10984.286021408583;11106.833397499044;8209.343252539782;8247.670093196204;8287.751367458864;8348.248657620721;8369.414141010071;5362.812301569426;5615.652243461458;6105.48103411215;6141.017437210204;6155.538334624832;9781.951090244504;9872.555734991798;10063.49682515886;10098.747531311483;10148.035936586013;9378.531073446436;10009;10137.746556336151;10186.286959912735;10258.640947566799;7027.61348125858;7070.7525236616475;7212.963935180501;7651.808704782425;7725.884111738216;8341.541215233221;8363.581820909052;8430.325573954191;8444.282236010007;8449.87325190135;7429.331360177393;7554.848903022019;7559.924400755922;7680.270374314431;7738.4969976951315;7149.106361704787;7224.819379515554;7241.891371629325;7356.448266379936;7400.185979542353;7128.607926564089;7129.21578626361;7193.280671932974;7194.820129496805;7202.099737532809;4604.608608268335;4672.626189904868;4692.92960605598;4716.174669432904;4819.542143496503;5104.2088476286235;5121.975604878965;5143.665661731976;5192;5303.655262407931 04:31:08 INFO - PROCESS | 1654 | |4;prototype.html;267.6761119045953;308.6049856184084;311.7833105991337;318.55561491719055;322.26845061709906;4422.402975598293;4922.507749225076;5405.567554595633;5413.296271484712;5434.972825135868;5331.440198779131;5347.989008243817;5384.273123128377;5405.324334458192;5407.594430417715;3190;3517.3668739626855;3884.261990221863;4127.979360103195;4139.441175441307;3518.472229165633;3957.406389041638;4013.0569316210667;4116.300228961069;4132.710710250284;3851.114243723931;3984.940225896614;4043.8786836394806;4045.2718510668215;4082.734622249559;3217.6943190396873;3759.2293579816073;3863.632954869269;3944.526656801188;4034.636882680573;3524.753267271292;3549.680528752399;3554.449060395643;3560.092176495003;3567.7502574819773;4311.374850646639;4565.338025986247;5179.870503237412;5236.596212461892;5244.895102097975;4124.896877578055;4524.366588677555;4652.906941861178;4694.859154225379;4718.4809670936165;4546.954530454686;5451.536619387357;5600.991821472134;5603.579731520112;5618.803341883015;3303.8348082595776;3455.9286621147526;3486;3976.602339766029;3981.94027089591;4917.950820491821;5230.712310822903;5559.444055594408;5787.913181302284;5916.556258280646;3971.3645816669195;3983.721139520264;4001.919961600752;4009.396241503422;4021.477207962946;4060.7360521566;4068.816903239361;4069.593040695907;4077.4913282085226;4079.85720499787;3886.358750806142;4664.341325444464;4670.346151538787;4677;4718.7168769873915;4765.666403351802;5273.604479664041;5679.829605111853;5709.25779648643;5710.885782284331;1322.9404676789568;1354.76291648963;1355.5052405871984;1359.272789057869;1359.904806663544;768.7885831396298;773.961301934901;841.2596914715134;846.8560344741409;866.7963028688254;5188.403333616607;5351.919721204185;5396.708008115047;5408.862859541457;5431.701256430855;5223.425423203445;5877.324107727581;5884.32330282023;5918.556108291896;5926.940730592725;4947.455779864212;5043.4365346742625;5253.975474782457;5359.973200133974;5392.568594512508;2691.1522870295794;2730.494858451193;2849.301921029361;3032.969670303313;3045.74111200546;6023.668698221552;6035.336113027563;6036.547258955596;6046.818595442144;6061.7575296987625;5747.333273350765;6115.510759139258;6133.29467111279;6137.754489820447;6162.198914141133;6142.723577439026;6146.7848625297;6164.845878853064;6178.382161783786;6214.844628884314;5533.6403133797785;5851.707414629337;5887.264091988502;5895.852603684943;6037.818865434044;4907.288443175648;5807.390224026416;5834.795782147605;5845.883082338244;5849.94150058494;4743.312219728051;6062.6665533394325;6079.969600151971;6149.2620885494025;6151.384861513813;3438.2951494942977;3590.7666001709804;3787.3561494546543;3863.4784304119707;3905.4337121117846;5830.242068531234;5873.559483038704;5877.324962385699;5889.882202356014;5933.554983376351;4218.49378074633;4775.761211939459;5308.46915308466;5735.885282294247;5770.942290577208;5715.028445164249;5717.37108918027;5731.484166425042;5732.197492351158;5737.196792448977;5239.26650268955;5323.760430780701;5521.398794349594;5578.88002559025;5618.719064046863;5008.724520151427;5487.506124448819;5702.51734549012;5721.456461636138;5723.341815691082;4919.901601967869;5546.97226513881;5575.163725441216;5596.636218645775;5725.3091047207745 04:31:08 INFO - PROCESS | 1654 | |5;yui.html;749.5540153608603;751.9962400187998;791.244361634639;797.9865570725179;870.0907551608568;11833.881661183386;17470;18316.450506484794;18362.449126526226;18370.816291837094;16567.83432165678;17089.82910170898;17261;17274.395396161137;17310.913445432787;895.5656506594297;912.406935491929;917.3486824354716;918.9035151309116;919.7332773495679;678.2606958415327;727.9563226206418;730.8794048981912;745.4409193105171;747.8354761952362;772.8917951486796;922.4373132389237;938.6386241297082;957.4781743949529;960.7646126698934;945.4043952310069;945.8392073347513;947.5072962059725;947.8436058050482;948.0140653720192;565.7227958300444;700.9088818453569;700.9228984811666;701.8947157926301;704.3695892176473;12558.497660093586;12718.745625087446;12727.74544509114;12751.681207969876;15258.465953691679;12671.873281267162;14376.424943002268;14432.783508247385;14693.92653036728;14874.776878346833;9785.510724463747;11542.769144617061;11766.754911522934;11881.87122223396;12097.516099356015;3834.194819087995;3857.787821669807;3860.401637746154;3882.417637354391;4013.1572369802375;111433.44283278532;113178.75961086636;114995.42502287519;116050;116172.25741613882;11146;11190.94404527972;11200.327980321206;11260.605878794202;11263.887361126448;22470;23013.7698623015;23030.309090727304;23083.845807709546;23093.19173828908;6908.689108990107;7981.760547183594;8090.797730056795;8122.796930076677;8167.550784706898;4390.7585082820115;4505.699440527379;4519.367288579601;4581.518940511265;4587.243104887723;3526.647335266453;3630.546181727284;3654.8903532894055;3657.6159503251774;3660.743747937672;654.4175683641563;666.1240468783534;666.1306994372294;681.8397676546008;683.2108914204102;537.4544836990458;543.4674019460872;637.2607774981;659.3241927024742;719.7372958869975;9405.623775049058;9499.667511637059;9673.322867399354;9774.12032917041;9782.461964591874;622.7633499270248;655.8753836770999;690.1063123255396;694.3438450664175;700.4676445901151;3475.0923430168814;4175.039740859619;4278.251306021434;4389.385486031958;4695.131400690815;87490;91045.08954910366;98664;98908.50545747225;149541;134965;137182;138077;141320;141996;114811.55565333054;116513.417432914;117723.41138294425;119159;121579.3921030407;7071;8243.25810677042;9098.36311458218;9102.726918192464;9451.149396554343;59043.70478147582;61626;63607;64343.35656643561;64799.67600161969;93840.53079734558;99474.00525994936;99703;100243.49878250562;103496.48251758693;12080.96330047555;12111.515539378326;12232.571859984857;12330.691732706755;12487;13371.197728136343;13867.722645547234;13951.651208719863;13973.441062357799;14270.215138167085;12404.81392779091;12673.429695663901;12897.935510322388;13065.738685226432;13094.279814610289;10933.890661093288;11154.944225278821;11461.885381146081;11565.190436669689;12169.391530423267;12233.877661223274;12278.201916875374;12294.75410491803;12686.746265074831;12709.682257943256;8468.66125354979;10527.736806579896;10573.048425641422;10744.30162039465;10781.892181078088;8993.415427997159;10432;10565.207609429477;10760.838587421038;10831.729206769578 04:31:08 INFO - PROCESS | 1654 | __end_tp_report 04:31:08 INFO - PROCESS | 1654 | __start_cc_report 04:31:08 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,1191 04:31:08 INFO - PROCESS | 1654 | __end_cc_report 04:31:08 INFO - PROCESS | 1654 | __startTimestamp1467804668143__endTimestamp 04:31:08 INFO - PROCESS | 1654 | 04:31:08 INFO - PROCESS | 1654 | ------- Summary: start ------- 04:31:08 INFO - PROCESS | 1654 | Number of tests: 6 04:31:08 INFO - PROCESS | 1654 | 04:31:08 INFO - PROCESS | 1654 | [#0] dojo.html Cycles:165 Average:5731.35 Median:6003.53 stddev:661.68 (11.0%) stddev-sans-first:635.90 04:31:08 INFO - PROCESS | 1654 | Values: 3311.4 3315.7 3365.5 3404.2 3424.4 5625.5 5703.3 5725.2 5745.4 5759.7 5709.1 5726.9 5761.6 5764.6 5765.8 4370.3 5139.5 5161.3 5181.2 5185.4 5249.1 5265.7 5266.7 5267.9 5272.9 5135.5 5192.5 5194.6 5220.1 5258.8 5235.1 5237.0 5252.6 5255.0 5317.4 5057.3 5105.6 5146.3 5179.4 5211.3 4808.9 5648.7 5721.8 5750.3 5752.8 6260.6 6279.2 6279.9 6292.3 6293.1 6171.4 6204.8 6266.8 6323.5 6324.0 5815.7 5827.2 5892.4 5896.8 5903.1 6255.2 6257.7 6268.9 6275.0 6275.8 6041.1 6119.6 6132.9 6156.8 6177.8 6256.4 6302.2 6302.7 6306.6 6314.2 6196.9 6233.3 6254.7 6261.7 6267.9 6121.6 6166.8 6183.5 6243.6 6272.1 4722.1 4885.8 4898.4 4921.3 4925.9 4386.4 4453.4 4459.9 4494.0 4494.4 5750.1 5764.0 5788.9 5817.2 5836.0 6213.8 6289.2 6301.8 6305.0 6313.8 5615.6 5673.3 5673.5 5696.9 5771.9 5357.6 5363.5 5374.1 5375.1 5409.8 6213.1 6243.5 6274.6 6276.3 6293.2 6131.7 6146.6 6189.3 6252.2 6292.3 5345.3 6273.3 6274.8 6289.5 6308.2 4557.3 6185.1 6196.0 6216.1 6221.3 6110.0 6192.5 6197.3 6237.6 6284.3 5980.4 6038.2 6117.8 6120.1 6131.0 6003.5 6128.2 6142.5 6144.8 6145.9 5079.8 5962.8 6056.7 6081.6 6092.5 6187.3 6192.4 6195.8 6209.4 6237.2 5887.0 5970.8 6050.8 6068.4 6088.0 04:31:08 INFO - PROCESS | 1654 | 04:31:08 INFO - PROCESS | 1654 | [#1] ext.html Cycles:180 Average:73517.60 Median:40290.70 stddev:160574.62 (398.5%) stddev-sans-first:160931.53 04:31:08 INFO - PROCESS | 1654 | Values: 516.2 517.0 518.1 532.8 549.3 21730.8 31535.5 43176.8 43322.8 43416.6 45466.8 45577.8 45797.1 45837.0 46390.3 8612.5 9802.8 9810.6 9826.3 9829.2 7701.5 8649.8 8865.6 8953.9 8956.4 11807.1 11886.5 11936.1 12192.8 12282.4 11970.2 12099.1 12133.0 12145.9 12261.2 8701.5 8842.3 8851.5 12023.6 12101.7 33670.8 42279.0 42341.7 42420.7 44850.0 3476.4 3581.6 3597.4 3983.9 4111.0 27337.8 31423.5 32751.8 33104.7 33176.8 3263.7 3313.6 3350.4 3407.3 3413.2 536578.0 541140.0 541459.8 541588.0 545101.0 66221.7 66968.0 67008.7 67138.7 67152.0 70213.9 70240.0 70248.0 70278.0 70327.3 16677.8 17040.5 17061.4 17065.2 17112.3 13014.1 13204.4 13215.5 13220.4 13233.7 15100.7 15340.1 17297.0 18853.0 19066.0 6237.5 6481.9 7271.8 7318.9 7432.1 738.4 974.7 980.7 994.5 1068.0 28903.7 30867.7 31216.2 31329.1 31637.9 1039.9 1065.6 1066.8 1135.5 1200.2 16191.9 16239.0 16277.4 16356.5 16651.3 675392.0 680986.6 681338.0 684127.0 685326.0 55325.3 62477.0 62512.0 62892.0 63158.7 1404.0 1428.6 1434.9 1438.9 1439.0 26850.0 30795.0 32353.2 32430.7 32858.5 50970.0 51382.0 51821.0 51843.0 52020.7 452159.0 461258.0 462519.0 567103.0 816912.4 39300.8 40988.6 41194.6 41279.4 41342.2 47936.0 47937.3 48081.8 49032.8 49080.0 34314.1 36091.6 38666.6 39917.4 40824.6 39407.0 39878.6 39997.0 40907.0 40951.0 38996.0 39411.2 39734.4 40584.4 42970.6 35394.6 36207.0 36335.7 36956.8 37072.4 26531.7 26658.5 26726.2 26732.7 26945.9 04:31:08 INFO - PROCESS | 1654 | 04:31:08 INFO - PROCESS | 1654 | [#2] jquery.html Cycles:180 Average:36271.53 Median:12156.82 stddev:98383.99 (809.3%) stddev-sans-first:98623.04 04:31:08 INFO - PROCESS | 1654 | Values: 362.3 377.5 388.0 394.5 414.0 15365.4 15874.7 20741.6 20972.1 20973.8 21716.8 21761.6 22017.9 22056.3 22166.1 5340.6 5867.3 6163.2 6187.5 6191.4 4275.8 4508.8 4515.6 4520.9 6114.4 4353.9 4452.2 4496.6 4510.0 6226.5 6867.9 6902.3 6905.8 6906.9 6911.2 5291.3 5632.5 5633.6 5654.2 5662.0 11723.7 12208.4 12221.2 13324.6 13703.9 1859.7 2025.8 2202.4 2294.5 2708.8 9906.1 10342.0 10667.7 10682.1 10693.6 1850.8 2034.5 2062.6 2068.9 2208.6 120062.5 124073.0 126811.0 131098.0 136578.0 20686.7 20764.2 21623.4 21648.7 21879.0 35347.0 35404.8 35433.5 35507.5 35513.6 10630.0 11204.3 11274.9 11288.7 11414.8 9154.3 9190.9 9213.4 9310.2 9348.2 9861.0 9980.7 10004.5 10075.3 10100.7 3204.9 3614.4 3661.6 3734.2 3759.5 880.8 891.9 944.5 947.3 974.7 19946.7 22105.0 22135.7 22157.4 22186.1 931.0 969.2 982.8 987.7 1006.2 11489.2 12554.7 12614.7 12663.8 12798.3 578864.0 582153.0 586236.1 593784.0 594316.0 131369.0 133283.0 134656.3 135801.0 136914.0 1001.4 1006.6 1021.1 1033.9 1034.4 20366.9 20708.4 20710.5 20766.2 20772.9 57069.0 57395.0 58103.7 58152.1 58390.4 66428.0 78744.0 79262.6 84187.2 84603.0 5635.6 5714.7 7885.8 8391.2 8471.2 11361.5 11992.9 13074.9 13317.0 13743.9 11260.4 11719.6 11876.9 11954.6 12033.6 11706.8 11716.5 11716.9 11905.6 11994.4 11811.9 11817.5 12082.9 12143.6 12199.5 7259.5 7409.2 8434.5 8569.8 8601.3 11106.9 11522.9 11666.5 11743.8 11807.5 04:31:08 INFO - PROCESS | 1654 | 04:31:08 INFO - PROCESS | 1654 | [#3] mootools.html Cycles:180 Average:5657.75 Median:2568.49 stddev:3219.04 (125.3%) stddev-sans-first:3212.19 04:31:08 INFO - PROCESS | 1654 | Values: 1403.7 1543.9 1579.7 1598.4 1842.6 7818.5 8310.7 8311.8 8316.5 8317.9 8127.2 8510.2 8796.0 8810.1 8915.3 2318.6 2335.7 2362.6 2364.3 2366.4 2158.3 2190.2 2359.4 2368.6 2371.3 2293.1 2312.7 2321.7 2340.4 2344.1 2306.3 2313.0 2317.4 2324.7 2324.9 2308.7 2310.4 2315.4 2316.2 2316.7 8950.2 8965.6 9008.4 9028.6 9029.3 5207.9 5221.8 5371.1 5378.9 5380.5 3482.5 3518.1 3590.8 3604.5 3618.7 1057.1 1064.0 1080.2 1087.2 1097.1 11498.4 11608.7 11608.9 11619.1 11655.9 4231.4 4415.5 4435.3 4592.6 4618.4 9053.8 9071.8 9072.0 9076.0 9081.3 5206.5 5209.7 5214.5 5216.7 5217.6 3521.6 4298.5 4387.8 4538.5 4876.8 3742.2 3814.0 3850.2 3857.5 3878.2 988.8 1052.7 1147.2 1166.7 1176.3 837.7 932.2 938.9 959.2 976.9 5889.9 6113.4 6117.7 6153.8 6258.1 444.8 448.8 461.8 464.2 464.3 3957.0 4007.4 4057.2 4094.0 4114.6 10594.5 10906.9 10979.1 11021.7 11053.4 10322.7 10882.4 10892.8 10984.3 11106.8 8209.3 8247.7 8287.8 8348.2 8369.4 5362.8 5615.7 6105.5 6141.0 6155.5 9782.0 9872.6 10063.5 10098.7 10148.0 9378.5 10009.0 10137.7 10186.3 10258.6 7027.6 7070.8 7213.0 7651.8 7725.9 8341.5 8363.6 8430.3 8444.3 8449.9 7429.3 7554.8 7559.9 7680.3 7738.5 7149.1 7224.8 7241.9 7356.4 7400.2 7128.6 7129.2 7193.3 7194.8 7202.1 4604.6 4672.6 4692.9 4716.2 4819.5 5104.2 5122.0 5143.7 5192.0 5303.7 04:31:08 INFO - PROCESS | 1654 | 04:31:08 INFO - PROCESS | 1654 | [#4] prototype.html Cycles:180 Average:4602.73 Median:5242.08 stddev:1457.82 (27.8%) stddev-sans-first:1425.14 04:31:08 INFO - PROCESS | 1654 | Values: 267.7 308.6 311.8 318.6 322.3 4422.4 4922.5 5405.6 5413.3 5435.0 5331.4 5348.0 5384.3 5405.3 5407.6 3190.0 3517.4 3884.3 4128.0 4139.4 3518.5 3957.4 4013.1 4116.3 4132.7 3851.1 3984.9 4043.9 4045.3 4082.7 3217.7 3759.2 3863.6 3944.5 4034.6 3524.8 3549.7 3554.4 3560.1 3567.8 4311.4 4565.3 5179.9 5236.6 5244.9 4124.9 4524.4 4652.9 4694.9 4718.5 4547.0 5451.5 5601.0 5603.6 5618.8 3303.8 3455.9 3486.0 3976.6 3981.9 4918.0 5230.7 5559.4 5787.9 5916.6 3971.4 3983.7 4001.9 4009.4 4021.5 4060.7 4068.8 4069.6 4077.5 4079.9 3886.4 4664.3 4670.3 4677.0 4718.7 4765.7 5273.6 5679.8 5709.3 5710.9 1322.9 1354.8 1355.5 1359.3 1359.9 768.8 774.0 841.3 846.9 866.8 5188.4 5351.9 5396.7 5408.9 5431.7 5223.4 5877.3 5884.3 5918.6 5926.9 4947.5 5043.4 5254.0 5360.0 5392.6 2691.2 2730.5 2849.3 3033.0 3045.7 6023.7 6035.3 6036.5 6046.8 6061.8 5747.3 6115.5 6133.3 6137.8 6162.2 6142.7 6146.8 6164.8 6178.4 6214.8 5533.6 5851.7 5887.3 5895.9 6037.8 4907.3 5807.4 5834.8 5845.9 5849.9 4743.3 6062.7 6080.0 6149.3 6151.4 3438.3 3590.8 3787.4 3863.5 3905.4 5830.2 5873.6 5877.3 5889.9 5933.6 4218.5 4775.8 5308.5 5735.9 5770.9 5715.0 5717.4 5731.5 5732.2 5737.2 5239.3 5323.8 5521.4 5578.9 5618.7 5008.7 5487.5 5702.5 5721.5 5723.3 4919.9 5547.0 5575.2 5596.6 5725.3 04:31:08 INFO - PROCESS | 1654 | 04:31:08 INFO - PROCESS | 1654 | [#5] yui.html Cycles:180 Average:24382.72 Median:3747.47 stddev:38576.92 (1029.4%) stddev-sans-first:38644.33 04:31:08 INFO - PROCESS | 1654 | Values: 749.6 752.0 791.2 798.0 870.1 11833.9 17470.0 18316.5 18362.4 18370.8 16567.8 17089.8 17261.0 17274.4 17310.9 895.6 912.4 917.3 918.9 919.7 678.3 728.0 730.9 745.4 747.8 772.9 922.4 938.6 957.5 960.8 945.4 945.8 947.5 947.8 948.0 565.7 700.9 700.9 701.9 704.4 12558.5 12718.7 12727.7 12751.7 15258.5 12671.9 14376.4 14432.8 14693.9 14874.8 9785.5 11542.8 11766.8 11881.9 12097.5 3834.2 3857.8 3860.4 3882.4 4013.2 111433.4 113178.8 114995.4 116050.0 116172.3 11146.0 11190.9 11200.3 11260.6 11263.9 22470.0 23013.8 23030.3 23083.8 23093.2 6908.7 7981.8 8090.8 8122.8 8167.6 4390.8 4505.7 4519.4 4581.5 4587.2 3526.6 3630.5 3654.9 3657.6 3660.7 654.4 666.1 666.1 681.8 683.2 537.5 543.5 637.3 659.3 719.7 9405.6 9499.7 9673.3 9774.1 9782.5 622.8 655.9 690.1 694.3 700.5 3475.1 4175.0 4278.3 4389.4 4695.1 87490.0 91045.1 98664.0 98908.5 149541.0 134965.0 137182.0 138077.0 141320.0 141996.0 114811.6 116513.4 117723.4 119159.0 121579.4 7071.0 8243.3 9098.4 9102.7 9451.1 59043.7 61626.0 63607.0 64343.4 64799.7 93840.5 99474.0 99703.0 100243.5 103496.5 12081.0 12111.5 12232.6 12330.7 12487.0 13371.2 13867.7 13951.7 13973.4 14270.2 12404.8 12673.4 12897.9 13065.7 13094.3 10933.9 11154.9 11461.9 11565.2 12169.4 12233.9 12278.2 12294.8 12686.7 12709.7 8468.7 10527.7 10573.0 10744.3 10781.9 8993.4 10432.0 10565.2 10760.8 10831.7 04:31:08 INFO - PROCESS | 1654 | -------- Summary: end -------- 04:31:08 INFO - PROCESS | 1654 | 04:31:08 INFO - TEST-INFO | 1654: exit 0 04:31:08 INFO - TEST-OK | dromaeo_css | took 1117292ms 04:31:08 INFO - TEST-START | kraken 04:31:08 INFO - operating with platform_type : mac_ 04:31:08 INFO - Initialising browser for kraken test... 04:31:08 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/tmpawFHEM/profile http://localhost:49279/getInfo.html) 04:31:11 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 04:31:11 INFO - PROCESS | 1665 | colorDepth:24 04:31:11 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 04:31:11 INFO - PROCESS | 1665 | __metrics 04:31:11 INFO - PROCESS | 1665 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:31:11 INFO - PROCESS | 1665 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:31:11 INFO - TEST-INFO | 1665: exit 0 04:31:11 INFO - Browser initialized. 04:31:11 INFO - Running cycle 1/1 for kraken test... 04:31:11 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/tmpawFHEM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:31:23 INFO - PROCESS | 1666 | RSS: Main: 243871744 04:31:23 INFO - PROCESS | 1666 | 04:31:26 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection) 04:31:27 INFO - PROCESS | 1666 | RSS: Main: 294395904 04:31:27 INFO - PROCESS | 1666 | 04:31:30 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-dft) 04:31:30 INFO - PROCESS | 1666 | RSS: Main: 304947200 04:31:30 INFO - PROCESS | 1666 | 04:31:34 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-fft) 04:31:34 INFO - PROCESS | 1666 | RSS: Main: 389341184 04:31:34 INFO - PROCESS | 1666 | 04:31:36 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator) 04:31:37 INFO - PROCESS | 1666 | RSS: Main: 291229696 04:31:37 INFO - PROCESS | 1666 | 04:31:39 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:31:40 INFO - PROCESS | 1666 | RSS: Main: 294907904 04:31:40 INFO - PROCESS | 1666 | 04:31:43 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom) 04:31:43 INFO - PROCESS | 1666 | RSS: Main: 332079104 04:31:43 INFO - PROCESS | 1666 | 04:31:46 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate) 04:31:47 INFO - PROCESS | 1666 | RSS: Main: 332750848 04:31:47 INFO - PROCESS | 1666 | 04:31:50 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial) 04:31:50 INFO - PROCESS | 1666 | RSS: Main: 330883072 04:31:50 INFO - PROCESS | 1666 | 04:31:52 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:31:52 INFO - PROCESS | 1666 | RSS: Main: 311857152 04:31:52 INFO - PROCESS | 1666 | 04:31:54 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:31:55 INFO - PROCESS | 1666 | RSS: Main: 318431232 04:31:55 INFO - PROCESS | 1666 | 04:31:57 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:31:58 INFO - PROCESS | 1666 | RSS: Main: 319184896 04:31:58 INFO - PROCESS | 1666 | 04:32:01 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:32:02 INFO - PROCESS | 1666 | RSS: Main: 326217728 04:32:02 INFO - PROCESS | 1666 | 04:32:04 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:32:05 INFO - PROCESS | 1666 | RSS: Main: 328540160 04:32:05 INFO - PROCESS | 1666 | 04:32:07 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49279/tests/kraken/driver.html?testName=ai-astar) 04:32:07 INFO - PROCESS | 1666 | RSS: Main: 371879936 04:32:07 INFO - PROCESS | 1666 | 04:32:07 INFO - PROCESS | 1666 | __start_tp_report 04:32:07 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 04:32:07 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 04:32:07 INFO - PROCESS | 1666 | |i|pagename|runs| 04:32:07 INFO - PROCESS | 1666 | |0;ai-astar;100;112;113;112;114;112;112;113;111;114 04:32:07 INFO - PROCESS | 1666 | |1;audio-beat-detection;141;108;109;156;127;118;128;106;141;104 04:32:07 INFO - PROCESS | 1666 | |2;audio-dft;186;185;189;185;184;180;182;185;183;183 04:32:07 INFO - PROCESS | 1666 | |3;audio-fft;80;75;59;110;58;57;62;67;83;56 04:32:07 INFO - PROCESS | 1666 | |4;audio-oscillator;84;96;92;71;77;99;130;82;67;114 04:32:07 INFO - PROCESS | 1666 | |5;imaging-gaussian-blur;90;87;88;88;87;87;94;86;127;85 04:32:07 INFO - PROCESS | 1666 | |6;imaging-darkroom;93;92;93;96;94;93;100;142;105;92 04:32:07 INFO - PROCESS | 1666 | |7;imaging-desaturate;86;84;84;84;85;83;84;84;85;85 04:32:07 INFO - PROCESS | 1666 | |8;json-parse-financial;56;55;53;54;54;54;55;53;54;54 04:32:07 INFO - PROCESS | 1666 | |9;json-stringify-tinderbox;64;73;80;75;72;68;69;71;70;70 04:32:07 INFO - PROCESS | 1666 | |10;stanford-crypto-aes;83;83;86;86;85;85;85;83;84;83 04:32:07 INFO - PROCESS | 1666 | |11;stanford-crypto-ccm;135;144;151;148;135;138;136;155;247;152 04:32:07 INFO - PROCESS | 1666 | |12;stanford-crypto-pbkdf2;163;164;163;163;165;162;160;162;162;161 04:32:07 INFO - PROCESS | 1666 | |13;stanford-crypto-sha256-iterative;66;66;67;66;66;66;65;65;65;65 04:32:07 INFO - PROCESS | 1666 | __end_tp_report 04:32:07 INFO - PROCESS | 1666 | __start_cc_report 04:32:07 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,2092 04:32:07 INFO - PROCESS | 1666 | __end_cc_report 04:32:07 INFO - PROCESS | 1666 | __startTimestamp1467804727377__endTimestamp 04:32:07 INFO - PROCESS | 1666 | 04:32:07 INFO - PROCESS | 1666 | ------- Summary: start ------- 04:32:07 INFO - PROCESS | 1666 | Number of tests: 14 04:32:07 INFO - PROCESS | 1666 | 04:32:07 INFO - PROCESS | 1666 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.50 stddev:4.08 (3.6%) stddev-sans-first:1.01 04:32:07 INFO - PROCESS | 1666 | Values: 100.0 112.0 113.0 112.0 114.0 112.0 112.0 113.0 111.0 114.0 04:32:07 INFO - PROCESS | 1666 | 04:32:07 INFO - PROCESS | 1666 | [#1] audio-beat-detection Cycles:10 Average:123.80 Median:127.50 stddev:17.85 (14.0%) stddev-sans-first:17.81 04:32:07 INFO - PROCESS | 1666 | Values: 141.0 108.0 109.0 156.0 127.0 118.0 128.0 106.0 141.0 104.0 04:32:07 INFO - PROCESS | 1666 | 04:32:07 INFO - PROCESS | 1666 | [#2] audio-dft Cycles:10 Average:184.20 Median:185.00 stddev:2.44 (1.3%) stddev-sans-first:2.50 04:32:07 INFO - PROCESS | 1666 | Values: 186.0 185.0 189.0 185.0 184.0 180.0 182.0 185.0 183.0 183.0 04:32:07 INFO - PROCESS | 1666 | 04:32:07 INFO - PROCESS | 1666 | [#3] audio-fft Cycles:10 Average:70.70 Median:64.50 stddev:16.97 (26.3%) stddev-sans-first:17.66 04:32:07 INFO - PROCESS | 1666 | Values: 80.0 75.0 59.0 110.0 58.0 57.0 62.0 67.0 83.0 56.0 04:32:07 INFO - PROCESS | 1666 | 04:32:07 INFO - PROCESS | 1666 | [#4] audio-oscillator Cycles:10 Average:91.20 Median:83.00 stddev:19.56 (23.6%) stddev-sans-first:20.57 04:32:07 INFO - PROCESS | 1666 | Values: 84.0 96.0 92.0 71.0 77.0 99.0 130.0 82.0 67.0 114.0 04:32:07 INFO - PROCESS | 1666 | 04:32:07 INFO - PROCESS | 1666 | [#5] imaging-gaussian-blur Cycles:10 Average:91.90 Median:87.50 stddev:12.58 (14.4%) stddev-sans-first:13.33 04:32:07 INFO - PROCESS | 1666 | Values: 90.0 87.0 88.0 88.0 87.0 87.0 94.0 86.0 127.0 85.0 04:32:07 INFO - PROCESS | 1666 | 04:32:07 INFO - PROCESS | 1666 | [#6] imaging-darkroom Cycles:10 Average:100.00 Median:93.00 stddev:15.33 (16.5%) stddev-sans-first:16.05 04:32:07 INFO - PROCESS | 1666 | Values: 93.0 92.0 93.0 96.0 94.0 93.0 100.0 142.0 105.0 92.0 04:32:07 INFO - PROCESS | 1666 | 04:32:07 INFO - PROCESS | 1666 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.50 stddev:0.84 (1.0%) stddev-sans-first:0.67 04:32:07 INFO - PROCESS | 1666 | Values: 86.0 84.0 84.0 84.0 85.0 83.0 84.0 84.0 85.0 85.0 04:32:07 INFO - PROCESS | 1666 | 04:32:07 INFO - PROCESS | 1666 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.00 stddev:0.92 (1.7%) stddev-sans-first:0.71 04:32:07 INFO - PROCESS | 1666 | Values: 56.0 55.0 53.0 54.0 54.0 54.0 55.0 53.0 54.0 54.0 04:32:07 INFO - PROCESS | 1666 | 04:32:07 INFO - PROCESS | 1666 | [#9] json-stringify-tinderbox Cycles:10 Average:71.20 Median:71.50 stddev:4.29 (6.0%) stddev-sans-first:3.67 04:32:07 INFO - PROCESS | 1666 | Values: 64.0 73.0 80.0 75.0 72.0 68.0 69.0 71.0 70.0 70.0 04:32:07 INFO - PROCESS | 1666 | 04:32:07 INFO - PROCESS | 1666 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:85.00 stddev:1.25 (1.5%) stddev-sans-first:1.24 04:32:07 INFO - PROCESS | 1666 | Values: 83.0 83.0 86.0 86.0 85.0 85.0 85.0 83.0 84.0 83.0 04:32:07 INFO - PROCESS | 1666 | 04:32:07 INFO - PROCESS | 1666 | [#11] stanford-crypto-ccm Cycles:10 Average:154.10 Median:149.50 stddev:33.50 (22.4%) stddev-sans-first:34.81 04:32:07 INFO - PROCESS | 1666 | Values: 135.0 144.0 151.0 148.0 135.0 138.0 136.0 155.0 247.0 152.0 04:32:07 INFO - PROCESS | 1666 | 04:32:07 INFO - PROCESS | 1666 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.50 Median:163.00 stddev:1.43 (0.9%) stddev-sans-first:1.51 04:32:07 INFO - PROCESS | 1666 | Values: 163.0 164.0 163.0 163.0 165.0 162.0 160.0 162.0 162.0 161.0 04:32:07 INFO - PROCESS | 1666 | 04:32:07 INFO - PROCESS | 1666 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:66.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 04:32:07 INFO - PROCESS | 1666 | Values: 66.0 66.0 67.0 66.0 66.0 66.0 65.0 65.0 65.0 65.0 04:32:07 INFO - PROCESS | 1666 | -------- Summary: end -------- 04:32:07 INFO - PROCESS | 1666 | 04:32:08 INFO - TEST-INFO | 1666: exit 0 04:32:08 INFO - TEST-OK | kraken | took 59501ms 04:32:08 INFO - SUITE-END | took 1176s 04:32:08 INFO - Completed test suite (00:19:37) 04:32:08 INFO - javascript benchmark 04:32:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3311.4039472894883, 3315.701586857183, 3365.51200075989, 3404.2340473393506, 3424.4007298722718, 5625.52183064439, 5703.3156021277455, 5725.227094342263, 5745.396733343002, 5759.654420734753, 5709.086546152616, 5726.9140962885485, 5761.625494342865, 5764.596478246524, 5765.769369225236, 4370.2789039808395, 5139.460356662562, 5161.27742116104, 5181.1710126379785, 5185.351831021122, 5249.107651699221, 5265.710385928773, 5266.683998960056, 5267.894642107156, 5272.919051594414, 5135.460776618457, 5192.506711862367, 5194.63637545372, 5220.086484865153, 5258.842234732945, 5235.057689615867, 5237.0, 5252.6323157379, 5254.973725131388, 5317.41508434072, 5057.2666963290485, 5105.642605017651, 5146.330976973007, 5179.352580927384, 5211.270422140903, 4808.879778005543, 5648.717564121777, 5721.828345149611, 5750.309962804448, 5752.827415177551, 6260.624362538262, 6279.246490421133, 6279.874402511924, 6292.307846136921, 6293.087502312139, 6171.413715697002, 6204.782832600882, 6266.811995640138, 6323.494120470351, 6323.9683801580695, 5815.73829177688, 5827.213326200994, 5892.410758924159, 5896.823095307148, 5903.0555111182, 6255.155554000243, 6257.749690012349, 6268.874622507616, 6274.9686251569365, 6275.811725648238, 6041.093835924647, 6119.602225855305, 6132.908006379907, 6156.815295541141, 6177.7837775677635, 6256.436920677161, 6302.243730752248, 6302.653354065479, 6306.558540902093, 6314.210723659543, 6196.907046394308, 6233.34549872266, 6254.6872656366995, 6261.749530018839, 6267.905981410283, 6121.605402471149, 6166.753329866755, 6183.505319574513, 6243.625382477066, 6272.090546870678, 4722.055588882237, 4885.828995985124, 4898.436679781871, 4921.311016457699, 4925.926111108336, 4386.407834942306, 4453.354263631755, 4459.910801783946, 4493.977530112328, 4494.438195225597, 5750.079987202028, 5763.971180144073, 5788.884222315614, 5817.185594016841, 5835.9708201458725, 6213.844653883689, 6289.24529056507, 6301.842453938688, 6305.0, 6313.842153946188, 5615.606907516435, 5673.347565030074, 5673.489385955284, 5696.914546281726, 5771.88456230873, 5357.624966252403, 5363.517283444508, 5374.113271310268, 5375.139977603565, 5409.810656627078, 6213.099100630474, 6243.500519958392, 6274.592151510137, 6276.340984196685, 6293.181886354744, 6131.724072416663, 6146.58628515435, 6189.319174890848, 6252.187215661935, 6292.276388215414, 5345.278387417804, 6273.341299163704, 6274.843128921813, 6289.465395441439, 6308.243010838729, 4557.293619488984, 6185.103160041679, 6195.96902015487, 6216.098665693539, 6221.346758590464, 6110.0424004731585, 6192.535559832941, 6197.25632924052, 6237.594556353823, 6284.340144284784, 5980.372060933713, 6038.184845045863, 6117.755289788359, 6120.143179954899, 6131.049687298476, 6003.529135361864, 6128.172696686069, 6142.539309551712, 6144.78493252734, 6145.877082458415, 5079.796808127781, 5962.791302304398, 6056.746550977894, 6081.635101893724, 6092.482139018056, 6187.319394866471, 6192.380761923771, 6195.845103872259, 6209.379062093935, 6237.220347456568, 5886.970565147147, 5970.76116955317, 6050.788222412194, 6068.423499767515, 6088.0], "value": 5689.446748870953, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [516.1766981664244, 517.0202466326309, 518.0933366608434, 532.846387570909, 549.2639862584136, 21730.782692173074, 31535.526967095513, 43176.784116079376, 43322.7833860831, 43416.56583434164, 45466.772666136625, 45577.7721111394, 45797.08405831881, 45837.0, 46390.30414543785, 8612.52631105289, 9802.754931126708, 9810.607575696964, 9826.312158148932, 9829.213662906986, 7701.499402538845, 8649.783755406103, 8865.556722163867, 8953.910460895406, 8956.373053886231, 11807.11446641501, 11886.524539018472, 11936.10479214058, 12192.81710774339, 12282.447289871978, 11970.22193557416, 12099.092568057431, 12133.029357651367, 12145.878541214563, 12261.203021803643, 8701.521416322099, 8842.292616590657, 8851.513166775825, 12023.579174728842, 12101.697457563543, 33670.831645841856, 42279.0, 42341.72974810761, 42420.7273781787, 44850.0, 3476.391631464509, 3581.5702115746017, 3597.4244120940784, 3983.900402489932, 4111.0, 27337.80604165328, 31423.528647070314, 32751.83624081888, 33104.66895331064, 33176.83411582927, 3263.673632636741, 3313.5692359993286, 3350.445019803499, 3407.335569563936, 3413.2490852012515, 536578.0, 541140.0, 541459.8051126743, 541588.0, 545100.999999996, 66221.66889165524, 66968.0, 67008.66495667589, 67138.66430667815, 67151.99999999903, 70213.94679079817, 70240.0, 70248.0, 70278.0, 70327.2967270331, 16677.833221667872, 17040.48878533646, 17061.40285090016, 17065.232064557124, 17112.315507379815, 13014.089013769135, 13204.405801738945, 13215.471381144838, 13220.40508177115, 13233.73532529344, 15100.697986040217, 15340.079595224322, 17297.0, 18853.020432854628, 19066.0, 6237.4698150656795, 6481.935180648133, 7271.800152974805, 7318.890216646754, 7432.145303290191, 738.3908275672592, 974.6832279509047, 980.7446468520305, 994.5275993902839, 1067.9786404271872, 28903.710962890524, 30867.691323086932, 31216.21959451032, 31329.06012819619, 31637.892673756767, 1039.939261952804, 1065.6376831877199, 1066.7706443114769, 1135.4720055174384, 1200.2138599217526, 16191.919040404722, 16239.0, 16277.430289939795, 16356.509304720877, 16651.333946642, 675392.0, 680986.5950670214, 681338.0, 684127.0, 685326.0, 55325.34023979287, 62477.0, 62512.0, 62892.0, 63158.68420657867, 1403.985960140406, 1428.599992002241, 1434.9426022959174, 1438.892083093772, 1439.0, 26850.0, 30795.0, 32353.191170220933, 32430.67569324371, 32858.50712239366, 50970.0, 51382.0, 51820.96358072893, 51843.0, 52020.73989630028, 452159.0, 461258.0, 462519.0, 567103.0, 816912.4080657149, 39300.803495982334, 40988.59011409848, 41194.58805411908, 41279.380809287286, 41342.173156537305, 47936.04127917352, 47937.280940786615, 48081.75959120182, 49032.774180644345, 49080.0, 34314.14214644654, 36091.639083608825, 38666.6133338663, 39917.40123898202, 40824.59175408208, 39407.0, 39878.60424885115, 39997.000074997195, 40907.0, 40950.9762255946, 38996.025099372746, 39411.21177576375, 39734.40398394084, 40584.391234132105, 42970.570294297904, 35394.646053540164, 36207.0, 36335.687370549385, 36956.81521592375, 37072.44391334078, 26531.7346826537, 26658.466830662892, 26726.19821405361, 26732.732672673024, 26945.865270673523], "value": 20993.154033687984, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.25194972382013, 377.52620461321044, 387.97866117363543, 394.50686641697894, 414.00431961133484, 15365.385384584617, 15874.682506349865, 20741.585168296624, 20972.05625746841, 20973.790262097373, 21716.833444963162, 21761.564768704655, 22017.889910550464, 22056.33830985069, 22166.1133554658, 5340.572754179656, 5867.266591676041, 6163.167972323746, 6187.4740647045055, 6191.442770150686, 4275.764832934187, 4508.842190523333, 4515.616172625314, 4520.864374068767, 6114.449699527042, 4353.912921741563, 4452.154090722768, 4496.595306422421, 4510.030343476152, 6226.533010024244, 6867.931320686779, 6902.344277293649, 6905.758298459555, 6906.896396554056, 6911.205211400653, 5291.259223708684, 5632.464915832989, 5633.633813802131, 5654.236678048452, 5662.0, 11723.7069073273, 12208.389580520938, 12221.205621634565, 13324.600261992156, 13703.862961370358, 1859.6931506301444, 2025.8075482829108, 2202.394341556085, 2294.529621427603, 2708.79684023699, 9906.10845023944, 10342.017508336696, 10667.733306667318, 10682.145428365711, 10693.572257109707, 1850.7964123946356, 2034.5422279986885, 2062.5565503416838, 2068.8758674479577, 2208.641685363506, 120062.48383181132, 124073.0, 126811.0, 131098.0, 136578.0, 20686.655367401072, 20764.169433222803, 21623.351299461043, 21648.675269870964, 21879.015444305045, 35347.0, 35404.822975884956, 35433.46849797255, 35507.4673879892, 35513.64486355155, 10630.0, 11204.271722338022, 11274.943625281821, 11288.661340159808, 11414.801445848232, 9154.267658587298, 9190.908090919005, 9213.355065145375, 9310.208632266198, 9348.158665720119, 9861.013898610081, 9980.650677226262, 10004.49977501122, 10075.34510256831, 10100.747481313027, 3204.8557814898386, 3614.403623402162, 3661.5670189515326, 3734.178480734234, 3759.473673685686, 880.8326417980563, 891.8974317953518, 944.4899754132691, 947.2611363136764, 974.7222041718077, 19946.70079948802, 22105.0, 22135.683541709535, 22157.446063848533, 22186.1125554976, 930.9627614895463, 969.1810420194925, 982.8427451607708, 987.7481242283171, 1006.1699098243978, 11489.195756296978, 12554.748905021848, 12614.747705046031, 12663.810042849365, 12798.296093714749, 578864.0, 582153.0, 586236.0688196531, 593784.0, 594316.0, 131369.0, 133283.0, 134656.32671836577, 135801.0, 136914.0, 1001.4441984698417, 1006.5671761142632, 1021.0963297481782, 1033.850091736694, 1034.3586976074732, 20366.89816550908, 20708.378748637566, 20710.482237944172, 20766.1693532257, 20772.85749283804, 57069.0, 57395.0, 58103.70948145401, 58152.12771808511, 58390.4160958385, 66428.0, 78744.0, 79262.6036869812, 84187.15812841793, 84603.0, 5635.577331700057, 5714.742836572447, 7885.802854928673, 8391.202835730595, 8471.152884711479, 11361.54553817871, 11992.880071199177, 13074.869251307366, 13317.0, 13743.862561374659, 11260.38067906273, 11719.589814356457, 11876.940615296868, 11954.58158964432, 12033.578824741093, 11706.824397633873, 11716.531338746354, 11716.94141529287, 11905.583304584297, 11994.400279985792, 11811.940940295244, 11817.527298907948, 12082.939585302018, 12143.635690929286, 12199.451024704087, 7259.455540834353, 7409.184989651242, 8434.451760635538, 8569.785755356166, 8601.311895048257, 11106.944465277946, 11522.884771152181, 11666.533338666697, 11743.823842642538, 11807.468663910317], "value": 10443.983775949966, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1403.656104254458, 1543.9382424703012, 1579.676166385891, 1598.432556442463, 1842.6314737052594, 7818.491798033124, 8310.70912518062, 8311.750647480578, 8316.501009939393, 8317.87523187152, 8127.227913348237, 8510.234078932895, 8795.956020219906, 8810.074942131065, 8915.331350148748, 2318.5942460069505, 2335.708036495438, 2362.633791762271, 2364.267077206063, 2366.3847399676038, 2158.3417057797365, 2190.233418303597, 2359.374765687094, 2368.5973384524586, 2371.336025912747, 2293.1286111277773, 2312.722473303206, 2321.7446080931086, 2340.391498210469, 2344.109238489372, 2306.2965795432387, 2312.9884350578222, 2317.397476656073, 2324.732655744594, 2324.9186278480342, 2308.746037935826, 2310.387747246981, 2315.397996520917, 2316.1661801751525, 2316.745158032615, 8950.194482496541, 8965.641374345018, 9008.369414141012, 9028.593713282919, 9029.277657787361, 5207.880305734286, 5221.817236396746, 5371.086915224382, 5378.946210537883, 5380.461953804588, 3482.547268855058, 3518.102883764649, 3590.8025058621765, 3604.5133906922492, 3618.6924111450294, 1057.1384321777803, 1064.0423618743193, 1080.189857606795, 1087.2280680716701, 1097.0729733375285, 11498.42507874603, 11608.6517404478, 11608.883911160865, 11619.07047436203, 11655.88344116565, 4231.449911511545, 4415.492218394926, 4435.3125265583885, 4592.609628181642, 4618.445786505641, 9053.77365565866, 9071.81856362869, 9072.0, 9076.001639819615, 9081.273498120267, 5206.505381988705, 5209.687418754811, 5214.504622060898, 5216.66091704038, 5217.556507696889, 3521.595016573127, 4298.548652391516, 4387.846425375096, 4538.478075021349, 4876.780544875489, 3742.176721121349, 3813.9809300953316, 3850.1914597934747, 3857.517810273716, 3878.1855810279594, 988.7775250568708, 1052.7052425320921, 1147.208426185929, 1166.7141550320225, 1176.2883455509293, 837.6942416018231, 932.1983094538691, 938.877945867033, 959.1781295532588, 976.912077912977, 5889.882202355929, 6113.419225173601, 6117.663528505975, 6153.769246150788, 6258.087401389887, 444.8220711715275, 448.83841816945875, 461.8014253870801, 464.16913724432885, 464.345273164836, 3957.039001964542, 4007.3788562772816, 4057.16828050249, 4094.0, 4114.567970363129, 10594.523246453773, 10906.890931090587, 10979.121670266359, 11021.669349919515, 11053.392063436588, 10322.690319290434, 10882.40146791934, 10892.836607450894, 10984.286021408583, 11106.833397499044, 8209.343252539782, 8247.670093196204, 8287.751367458864, 8348.248657620721, 8369.414141010071, 5362.812301569426, 5615.652243461458, 6105.48103411215, 6141.017437210204, 6155.538334624832, 9781.951090244504, 9872.555734991798, 10063.49682515886, 10098.747531311483, 10148.035936586013, 9378.531073446436, 10009.0, 10137.746556336151, 10186.286959912735, 10258.640947566799, 7027.61348125858, 7070.7525236616475, 7212.963935180501, 7651.808704782425, 7725.884111738216, 8341.541215233221, 8363.581820909052, 8430.325573954191, 8444.282236010007, 8449.87325190135, 7429.331360177393, 7554.848903022019, 7559.924400755922, 7680.270374314431, 7738.4969976951315, 7149.106361704787, 7224.819379515554, 7241.891371629325, 7356.448266379936, 7400.185979542353, 7128.607926564089, 7129.21578626361, 7193.280671932974, 7194.820129496805, 7202.099737532809, 4604.608608268335, 4672.626189904868, 4692.92960605598, 4716.174669432904, 4819.542143496503, 5104.2088476286235, 5121.975604878965, 5143.665661731976, 5192.0, 5303.655262407931], "value": 4452.480734910075, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [267.6761119045953, 308.6049856184084, 311.7833105991337, 318.55561491719055, 322.26845061709906, 4422.402975598293, 4922.507749225076, 5405.567554595633, 5413.296271484712, 5434.972825135868, 5331.440198779131, 5347.989008243817, 5384.273123128377, 5405.324334458192, 5407.594430417715, 3190.0, 3517.3668739626855, 3884.261990221863, 4127.979360103195, 4139.441175441307, 3518.472229165633, 3957.406389041638, 4013.0569316210667, 4116.300228961069, 4132.710710250284, 3851.114243723931, 3984.940225896614, 4043.8786836394806, 4045.2718510668215, 4082.734622249559, 3217.6943190396873, 3759.2293579816073, 3863.632954869269, 3944.526656801188, 4034.636882680573, 3524.753267271292, 3549.680528752399, 3554.449060395643, 3560.092176495003, 3567.7502574819773, 4311.374850646639, 4565.338025986247, 5179.870503237412, 5236.596212461892, 5244.895102097975, 4124.896877578055, 4524.366588677555, 4652.906941861178, 4694.859154225379, 4718.4809670936165, 4546.954530454686, 5451.536619387357, 5600.991821472134, 5603.579731520112, 5618.803341883015, 3303.8348082595776, 3455.9286621147526, 3486.0, 3976.602339766029, 3981.94027089591, 4917.950820491821, 5230.712310822903, 5559.444055594408, 5787.913181302284, 5916.556258280646, 3971.3645816669195, 3983.721139520264, 4001.919961600752, 4009.396241503422, 4021.477207962946, 4060.7360521566, 4068.816903239361, 4069.593040695907, 4077.4913282085226, 4079.85720499787, 3886.358750806142, 4664.341325444464, 4670.346151538787, 4677.0, 4718.7168769873915, 4765.666403351802, 5273.604479664041, 5679.829605111853, 5709.25779648643, 5710.885782284331, 1322.9404676789568, 1354.76291648963, 1355.5052405871984, 1359.272789057869, 1359.904806663544, 768.7885831396298, 773.961301934901, 841.2596914715134, 846.8560344741409, 866.7963028688254, 5188.403333616607, 5351.919721204185, 5396.708008115047, 5408.862859541457, 5431.701256430855, 5223.425423203445, 5877.324107727581, 5884.32330282023, 5918.556108291896, 5926.940730592725, 4947.455779864212, 5043.4365346742625, 5253.975474782457, 5359.973200133974, 5392.568594512508, 2691.1522870295794, 2730.494858451193, 2849.301921029361, 3032.969670303313, 3045.74111200546, 6023.668698221552, 6035.336113027563, 6036.547258955596, 6046.818595442144, 6061.7575296987625, 5747.333273350765, 6115.510759139258, 6133.29467111279, 6137.754489820447, 6162.198914141133, 6142.723577439026, 6146.7848625297, 6164.845878853064, 6178.382161783786, 6214.844628884314, 5533.6403133797785, 5851.707414629337, 5887.264091988502, 5895.852603684943, 6037.818865434044, 4907.288443175648, 5807.390224026416, 5834.795782147605, 5845.883082338244, 5849.94150058494, 4743.312219728051, 6062.6665533394325, 6079.969600151971, 6149.2620885494025, 6151.384861513813, 3438.2951494942977, 3590.7666001709804, 3787.3561494546543, 3863.4784304119707, 3905.4337121117846, 5830.242068531234, 5873.559483038704, 5877.324962385699, 5889.882202356014, 5933.554983376351, 4218.49378074633, 4775.761211939459, 5308.46915308466, 5735.885282294247, 5770.942290577208, 5715.028445164249, 5717.37108918027, 5731.484166425042, 5732.197492351158, 5737.196792448977, 5239.26650268955, 5323.760430780701, 5521.398794349594, 5578.88002559025, 5618.719064046863, 5008.724520151427, 5487.506124448819, 5702.51734549012, 5721.456461636138, 5723.341815691082, 4919.901601967869, 5546.97226513881, 5575.163725441216, 5596.636218645775, 5725.3091047207745], "value": 4131.895347327911, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [749.5540153608603, 751.9962400187998, 791.244361634639, 797.9865570725179, 870.0907551608568, 11833.881661183386, 17470.0, 18316.450506484794, 18362.449126526226, 18370.816291837094, 16567.83432165678, 17089.82910170898, 17261.0, 17274.395396161137, 17310.913445432787, 895.5656506594297, 912.406935491929, 917.3486824354716, 918.9035151309116, 919.7332773495679, 678.2606958415327, 727.9563226206418, 730.8794048981912, 745.4409193105171, 747.8354761952362, 772.8917951486796, 922.4373132389237, 938.6386241297082, 957.4781743949529, 960.7646126698934, 945.4043952310069, 945.8392073347513, 947.5072962059725, 947.8436058050482, 948.0140653720192, 565.7227958300444, 700.9088818453569, 700.9228984811666, 701.8947157926301, 704.3695892176473, 12558.497660093586, 12718.745625087446, 12727.74544509114, 12751.681207969876, 15258.465953691679, 12671.873281267162, 14376.424943002268, 14432.783508247385, 14693.92653036728, 14874.776878346833, 9785.510724463747, 11542.769144617061, 11766.754911522934, 11881.87122223396, 12097.516099356015, 3834.194819087995, 3857.787821669807, 3860.401637746154, 3882.417637354391, 4013.1572369802375, 111433.44283278532, 113178.75961086636, 114995.42502287519, 116050.0, 116172.25741613882, 11146.0, 11190.94404527972, 11200.327980321206, 11260.605878794202, 11263.887361126448, 22470.0, 23013.7698623015, 23030.309090727304, 23083.845807709546, 23093.19173828908, 6908.689108990107, 7981.760547183594, 8090.797730056795, 8122.796930076677, 8167.550784706898, 4390.7585082820115, 4505.699440527379, 4519.367288579601, 4581.518940511265, 4587.243104887723, 3526.647335266453, 3630.546181727284, 3654.8903532894055, 3657.6159503251774, 3660.743747937672, 654.4175683641563, 666.1240468783534, 666.1306994372294, 681.8397676546008, 683.2108914204102, 537.4544836990458, 543.4674019460872, 637.2607774981, 659.3241927024742, 719.7372958869975, 9405.623775049058, 9499.667511637059, 9673.322867399354, 9774.12032917041, 9782.461964591874, 622.7633499270248, 655.8753836770999, 690.1063123255396, 694.3438450664175, 700.4676445901151, 3475.0923430168814, 4175.039740859619, 4278.251306021434, 4389.385486031958, 4695.131400690815, 87490.0, 91045.08954910366, 98664.0, 98908.50545747225, 149541.0, 134965.0, 137182.0, 138077.0, 141320.0, 141996.0, 114811.55565333054, 116513.417432914, 117723.41138294425, 119159.0, 121579.3921030407, 7071.0, 8243.25810677042, 9098.36311458218, 9102.726918192464, 9451.149396554343, 59043.70478147582, 61626.0, 63607.0, 64343.35656643561, 64799.67600161969, 93840.53079734558, 99474.00525994936, 99703.0, 100243.49878250562, 103496.48251758693, 12080.96330047555, 12111.515539378326, 12232.571859984857, 12330.691732706755, 12487.0, 13371.197728136343, 13867.722645547234, 13951.651208719863, 13973.441062357799, 14270.215138167085, 12404.81392779091, 12673.429695663901, 12897.935510322388, 13065.738685226432, 13094.279814610289, 10933.890661093288, 11154.944225278821, 11461.885381146081, 11565.190436669689, 12169.391530423267, 12233.877661223274, 12278.201916875374, 12294.75410491803, 12686.746265074831, 12709.682257943256, 8468.66125354979, 10527.736806579896, 10573.048425641422, 10744.30162039465, 10781.892181078088, 8993.415427997159, 10432.0, 10565.207609429477, 10760.838587421038, 10831.729206769578], "value": 7733.107950418088, "unit": "score"}], "name": "dromaeo_css", "value": 7496.551450902307, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 112.0, 113.0, 112.0, 114.0, 112.0, 112.0, 113.0, 111.0, 114.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 108.0, 109.0, 156.0, 127.0, 118.0, 128.0, 106.0, 141.0, 104.0], "value": 123.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 185.0, 189.0, 185.0, 184.0, 180.0, 182.0, 185.0, 183.0, 183.0], "value": 184.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 75.0, 59.0, 110.0, 58.0, 57.0, 62.0, 67.0, 83.0, 56.0], "value": 70.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 96.0, 92.0, 71.0, 77.0, 99.0, 130.0, 82.0, 67.0, 114.0], "value": 91.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 88.0, 88.0, 87.0, 87.0, 94.0, 86.0, 127.0, 85.0], "value": 91.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 93.0, 96.0, 94.0, 93.0, 100.0, 142.0, 105.0, 92.0], "value": 100.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 84.0, 84.0, 85.0, 83.0, 84.0, 84.0, 85.0, 85.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 53.0, 54.0, 54.0, 54.0, 55.0, 53.0, 54.0, 54.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 73.0, 80.0, 75.0, 72.0, 68.0, 69.0, 71.0, 70.0, 70.0], "value": 71.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 86.0, 86.0, 85.0, 85.0, 85.0, 83.0, 84.0, 83.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 144.0, 151.0, 148.0, 135.0, 138.0, 136.0, 155.0, 247.0, 152.0], "value": 154.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 163.0, 163.0, 165.0, 162.0, 160.0, 162.0, 162.0, 161.0], "value": 162.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 66.0, 66.0, 66.0, 65.0, 65.0, 65.0, 65.0], "value": 65.7, "unit": "score"}], "name": "kraken", "value": 1449.5, "alertThreshold": 2.0}]} 04:32:08 INFO - Return code: 0 04:32:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:32:08 INFO - # TBPL SUCCESS # 04:32:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:32:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:32:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:32:08 INFO - 2016-07-06 04:32:08.674 screenresolution[1670:9713] starting screenresolution argv=screenresolution get 04:32:08 INFO - 2016-07-06 04:32:08.677 screenresolution[1670:9713] Display 0: 1600x1200x32@60 04:32:08 INFO - 2016-07-06 04:32:08.683 screenresolution[1671:9716] starting screenresolution argv=screenresolution list 04:32:08 INFO - Available Modes on Display 0 04:32:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:32:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:32:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:32:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:32:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:32:08 INFO - Intel Iris: 04:32:08 INFO - Chipset Model: Intel Iris 04:32:08 INFO - Type: GPU 04:32:08 INFO - Bus: Built-In 04:32:08 INFO - VRAM (Dynamic, Max): 1536 MB 04:32:08 INFO - Vendor: Intel (0x8086) 04:32:08 INFO - Device ID: 0x0a2e 04:32:08 INFO - Revision ID: 0x0009 04:32:08 INFO - Displays: 04:32:08 INFO - Display: 04:32:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:32:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:32:08 INFO - Display Serial Number: 1600x1200 60 04:32:08 INFO - Main Display: Yes 04:32:08 INFO - Mirror: Off 04:32:08 INFO - Online: Yes 04:32:08 INFO - Rotation: Supported 04:32:08 INFO - Return code: 0 04:32:08 INFO - Running post-action listener: _resource_record_post_action 04:32:08 INFO - ##### 04:32:08 INFO - ##### Finished run-tests step (success) 04:32:08 INFO - ##### 04:32:08 INFO - Running post-run listener: _resource_record_post_run 04:32:08 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 37963264; Write bytes: 705023488; Read time: 388; Write time: 1818 04:32:08 INFO - TinderboxPrint: CPU usage
53.5% 04:32:08 INFO - TinderboxPrint: I/O read bytes / time
37,963,264 / 388 04:32:08 INFO - TinderboxPrint: I/O write bytes / time
705,023,488 / 1,818 04:32:08 INFO - TinderboxPrint: CPU idle
2,255.0 (46.5%) 04:32:08 INFO - TinderboxPrint: CPU system
972.5 (20.1%) 04:32:08 INFO - TinderboxPrint: CPU user
1,622.1 (33.4%) 04:32:08 INFO - TinderboxPrint: Swap in / out
445,333,504 / 0 04:32:08 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 398705152; Write bytes: 392869376; Read time: 29426; Write time: 736 04:32:09 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 35964416; Write bytes: 294373376; Read time: 366; Write time: 1046 04:32:09 INFO - Running post-run listener: _upload_blobber_files 04:32:09 INFO - Blob upload gear active. 04:32:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:32:09 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 04:32:09 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:32:09 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:32:09 INFO - (blobuploader) - INFO - Open directory for files ... 04:32:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:32:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:32:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:32:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:32:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:32:11 INFO - (blobuploader) - INFO - Done attempting. 04:32:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:32:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:32:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:32:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:32:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:32:11 INFO - (blobuploader) - INFO - Done attempting. 04:32:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:32:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:32:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:32:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:32:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:32:15 INFO - (blobuploader) - INFO - Done attempting. 04:32:15 INFO - (blobuploader) - INFO - Iteration through files over. 04:32:15 INFO - Return code: 0 04:32:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:32:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:32:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/59b49167875e779b4fc163b271e73ff0106a86dfe7078e3ead1538e1b6d18cc3c4b36dbf27e050327a4dc31335fa1844f707ef6635d876dc19d95e6974d6b6d9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11ab4425be9be123401b99350e4e14d148af77184047048d53121d5f17934dbd221630d3b300d048559e3872e52df69a98306a322e2d64fa3428ff84619da775", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c63a8d39261aabe140cd976abe7f8a056e5f3a30efce5d4c27a48693d5a3a0b3c552357fc09950c2a197b76bb5f27d96d4d738f7e80713930b9b303e7c17606"} 04:32:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:32:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:32:15 INFO - Contents: 04:32:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/59b49167875e779b4fc163b271e73ff0106a86dfe7078e3ead1538e1b6d18cc3c4b36dbf27e050327a4dc31335fa1844f707ef6635d876dc19d95e6974d6b6d9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11ab4425be9be123401b99350e4e14d148af77184047048d53121d5f17934dbd221630d3b300d048559e3872e52df69a98306a322e2d64fa3428ff84619da775", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c63a8d39261aabe140cd976abe7f8a056e5f3a30efce5d4c27a48693d5a3a0b3c552357fc09950c2a197b76bb5f27d96d4d738f7e80713930b9b303e7c17606"} 04:32:15 INFO - Running post-run listener: copy_logs_to_upload_dir 04:32:15 INFO - Copying logs to upload dir... 04:32:15 INFO - mkdir: /builds/slave/test/build/upload/logs 04:32:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.645290 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-07-06 04:32:15.399585) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 04:32:15.403251) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7MeBpy15fw/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test/properties RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.IoOw4GQVvE/Listeners TMPDIR=/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/59b49167875e779b4fc163b271e73ff0106a86dfe7078e3ead1538e1b6d18cc3c4b36dbf27e050327a4dc31335fa1844f707ef6635d876dc19d95e6974d6b6d9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11ab4425be9be123401b99350e4e14d148af77184047048d53121d5f17934dbd221630d3b300d048559e3872e52df69a98306a322e2d64fa3428ff84619da775", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c63a8d39261aabe140cd976abe7f8a056e5f3a30efce5d4c27a48693d5a3a0b3c552357fc09950c2a197b76bb5f27d96d4d738f7e80713930b9b303e7c17606"} build_url:https://queue.taskcluster.net/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011134 build_url: 'https://queue.taskcluster.net/v1/task/F6wQtCPbS2KLqmFSqxzeLg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/59b49167875e779b4fc163b271e73ff0106a86dfe7078e3ead1538e1b6d18cc3c4b36dbf27e050327a4dc31335fa1844f707ef6635d876dc19d95e6974d6b6d9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11ab4425be9be123401b99350e4e14d148af77184047048d53121d5f17934dbd221630d3b300d048559e3872e52df69a98306a322e2d64fa3428ff84619da775", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c63a8d39261aabe140cd976abe7f8a056e5f3a30efce5d4c27a48693d5a3a0b3c552357fc09950c2a197b76bb5f27d96d4d738f7e80713930b9b303e7c17606"}' ========= master_lag: 0.29 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 04:32:15.709110) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 04:32:15.709437) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7MeBpy15fw/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.IoOw4GQVvE/Listeners TMPDIR=/var/folders/cg/wrlbrw9n1wqgrfyf5k_pzmxr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005359 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 04:32:15.734709) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 04:32:15.734985) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 04:32:15.735282) ========= ========= Total master_lag: 0.43 =========