builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0258 starttime: 1475353009.65 results: success (0) buildid: 20161001113855 builduid: d5763962992d4e08b573dde219f3f4e8 revision: 9522156a6cdac7dae1d1e8cd53a229e5644190fc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-01 13:16:49.652552) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-01 13:16:49.652987) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-01 13:16:49.653276) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-01 13:16:49.677512) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 13:16:49.677874) ========= 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.Sh5roUtZVQ/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.iBAqghRgCr/Listeners TMPDIR=/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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-10-01 13:16:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 184M=0s 2016-10-01 13:16:49 (184 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125901 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 13:16:49.825883) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 13:16:49.826193) ========= 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.Sh5roUtZVQ/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.iBAqghRgCr/Listeners TMPDIR=/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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.026627 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 13:16:49.874624) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-01 13:16:49.874985) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9522156a6cdac7dae1d1e8cd53a229e5644190fc --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9522156a6cdac7dae1d1e8cd53a229e5644190fc --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Sh5roUtZVQ/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.iBAqghRgCr/Listeners TMPDIR=/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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-10-01 13:16:49,959 truncating revision to first 12 chars 2016-10-01 13:16:49,959 Setting DEBUG logging. 2016-10-01 13:16:49,960 attempt 1/10 2016-10-01 13:16:49,960 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/9522156a6cda?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-01 13:16:51,654 unpacking tar archive at: mozilla-aurora-9522156a6cda/testing/mozharness/ program finished with exit code 0 elapsedTime=1.970330 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-01 13:16:51.867627) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-01 13:16:51.868047) ========= script_repo_revision: 9522156a6cdac7dae1d1e8cd53a229e5644190fc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-01 13:16:51.868441) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-01 13:16:51.868705) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-01 13:16:51.886513) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-10-01 13:16:51.886797) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Sh5roUtZVQ/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.iBAqghRgCr/Listeners TMPDIR=/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 13:16:52 INFO - MultiFileLogger online at 20161001 13:16:52 in /builds/slave/test 13:16:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 13:16:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:16:52 INFO - {'append_to_log': False, 13:16:52 INFO - 'base_work_dir': '/builds/slave/test', 13:16:52 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 13:16:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:16:52 INFO - 'branch': 'Mozilla-Aurora', 13:16:52 INFO - 'buildbot_json_path': 'buildprops.json', 13:16:52 INFO - 'config_files': ('talos/mac_config.py',), 13:16:52 INFO - 'default_actions': ('clobber', 13:16:52 INFO - 'read-buildbot-config', 13:16:52 INFO - 'download-and-extract', 13:16:52 INFO - 'populate-webroot', 13:16:52 INFO - 'create-virtualenv', 13:16:52 INFO - 'install', 13:16:52 INFO - 'run-tests'), 13:16:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:16:52 INFO - 'download_minidump_stackwalk': True, 13:16:52 INFO - 'download_symbols': 'ondemand', 13:16:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:16:52 INFO - 'tooltool.py': '/tools/tooltool.py', 13:16:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:16:52 INFO - '/tools/misc-python/virtualenv.py')}, 13:16:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:16:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:16:52 INFO - 'installer_path': 'installer.exe', 13:16:52 INFO - 'log_level': 'info', 13:16:52 INFO - 'log_name': 'talos', 13:16:52 INFO - 'log_to_console': True, 13:16:52 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:16:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:16:52 INFO - 'opt_config_files': (), 13:16:52 INFO - 'pip_index': False, 13:16:52 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:16:52 INFO - 'cmd': ('bash', 13:16:52 INFO - '-c', 13:16:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:16:52 INFO - 'enabled': True, 13:16:52 INFO - 'halt_on_failure': False, 13:16:52 INFO - 'name': 'check_screen_resolution'},), 13:16:52 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:16:52 INFO - 'cmd': ('bash', 13:16:52 INFO - '-c', 13:16:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:16:52 INFO - 'enabled': True, 13:16:52 INFO - 'halt_on_failure': False, 13:16:52 INFO - 'name': 'check_screen_resolution'},), 13:16:52 INFO - 'run_cmd_checks_enabled': True, 13:16:52 INFO - 'sps_profile': False, 13:16:52 INFO - 'sps_profile_interval': 0, 13:16:52 INFO - 'suite': 'dromaeojs', 13:16:52 INFO - 'system_bits': '32', 13:16:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:16:52 INFO - 'title': 't-yosemite-r7-0258', 13:16:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:16:52 INFO - 'use_talos_json': True, 13:16:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:16:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:16:52 INFO - 'work_dir': 'build'} 13:16:52 INFO - [mozharness: 2016-10-01 20:16:52.084003Z] Running clobber step. 13:16:52 INFO - Running pre-action listener: _resource_record_pre_action 13:16:52 INFO - Running main action method: clobber 13:16:52 INFO - rmtree: /builds/slave/test/build 13:16:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:16:54 INFO - Running post-action listener: _resource_record_post_action 13:16:54 INFO - [mozharness: 2016-10-01 20:16:54.123292Z] Finished clobber step (success) 13:16:54 INFO - [mozharness: 2016-10-01 20:16:54.123581Z] Running read-buildbot-config step. 13:16:54 INFO - Running pre-action listener: _resource_record_pre_action 13:16:54 INFO - Running main action method: read_buildbot_config 13:16:54 INFO - Using buildbot properties: 13:16:54 INFO - { 13:16:54 INFO - "project": "", 13:16:54 INFO - "product": "firefox", 13:16:54 INFO - "script_repo_revision": "production", 13:16:54 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 13:16:54 INFO - "repository": "", 13:16:54 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 13:16:54 INFO - "buildid": "20161001113855", 13:16:54 INFO - "pgo_build": "False", 13:16:54 INFO - "basedir": "/builds/slave/test", 13:16:54 INFO - "buildnumber": 31, 13:16:54 INFO - "slavename": "t-yosemite-r7-0258", 13:16:54 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 13:16:54 INFO - "platform": "yosemite_r7", 13:16:54 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 13:16:54 INFO - "branch": "mozilla-aurora", 13:16:54 INFO - "repo_path": "releases/mozilla-aurora", 13:16:54 INFO - "revision": "9522156a6cdac7dae1d1e8cd53a229e5644190fc", 13:16:54 INFO - "stage_platform": "macosx64", 13:16:54 INFO - "builduid": "d5763962992d4e08b573dde219f3f4e8", 13:16:54 INFO - "slavebuilddir": "test" 13:16:54 INFO - } 13:16:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/XR_z8aYQS-atyXYG_b8LCg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 13:16:54 INFO - Running post-action listener: _resource_record_post_action 13:16:54 INFO - [mozharness: 2016-10-01 20:16:54.127973Z] Finished read-buildbot-config step (success) 13:16:54 INFO - [mozharness: 2016-10-01 20:16:54.128135Z] Running download-and-extract step. 13:16:54 INFO - Running pre-action listener: _resource_record_pre_action 13:16:54 INFO - Running main action method: download_and_extract 13:16:54 INFO - mkdir: /builds/slave/test/build/tests 13:16:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:16:54 INFO - trying https://queue.taskcluster.net/v1/task/XR_z8aYQS-atyXYG_b8LCg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 13:16:54 INFO - Downloading https://queue.taskcluster.net/v1/task/XR_z8aYQS-atyXYG_b8LCg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 13:16:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XR_z8aYQS-atyXYG_b8LCg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 13:16:55 INFO - Downloaded 1199 bytes. 13:16:55 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 13:16:55 INFO - Using the following test package requirements: 13:16:55 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 13:16:55 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 13:16:55 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 13:16:55 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 13:16:55 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 13:16:55 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 13:16:55 INFO - u'jsshell-mac.zip'], 13:16:55 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 13:16:55 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 13:16:55 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 13:16:55 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 13:16:55 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 13:16:55 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 13:16:55 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 13:16:55 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 13:16:55 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 13:16:55 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 13:16:55 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 13:16:55 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 13:16:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XR_z8aYQS-atyXYG_b8LCg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 13:16:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XR_z8aYQS-atyXYG_b8LCg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 13:16:55 INFO - Fetch https://queue.taskcluster.net/v1/task/XR_z8aYQS-atyXYG_b8LCg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 13:16:56 INFO - Expected file size: 16434038 13:17:02 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 13:17:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XR_z8aYQS-atyXYG_b8LCg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 13:17:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XR_z8aYQS-atyXYG_b8LCg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 13:17:02 INFO - Fetch https://queue.taskcluster.net/v1/task/XR_z8aYQS-atyXYG_b8LCg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 13:17:03 INFO - Expected file size: 16434038 13:17:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XR_z8aYQS-atyXYG_b8LCg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 13:17:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XR_z8aYQS-atyXYG_b8LCg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 13:17:09 INFO - Fetch https://queue.taskcluster.net/v1/task/XR_z8aYQS-atyXYG_b8LCg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 13:17:10 INFO - Expected file size: 14414059 13:17:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:17:11 INFO - trying https://queue.taskcluster.net/v1/task/XR_z8aYQS-atyXYG_b8LCg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 13:17:11 INFO - Downloading https://queue.taskcluster.net/v1/task/XR_z8aYQS-atyXYG_b8LCg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 13:17:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XR_z8aYQS-atyXYG_b8LCg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 13:17:14 INFO - Downloaded 115273391 bytes. 13:17:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XR_z8aYQS-atyXYG_b8LCg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 13:17:14 INFO - mkdir: /builds/slave/test/properties 13:17:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:17:14 INFO - Writing to file /builds/slave/test/properties/build_url 13:17:14 INFO - Contents: 13:17:14 INFO - build_url:https://queue.taskcluster.net/v1/task/XR_z8aYQS-atyXYG_b8LCg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 13:17:14 INFO - Running post-action listener: _resource_record_post_action 13:17:14 INFO - Running post-action listener: set_extra_try_arguments 13:17:14 INFO - [mozharness: 2016-10-01 20:17:14.756326Z] Finished download-and-extract step (success) 13:17:14 INFO - [mozharness: 2016-10-01 20:17:14.756463Z] Running populate-webroot step. 13:17:14 INFO - Running pre-action listener: _resource_record_pre_action 13:17:14 INFO - Running main action method: populate_webroot 13:17:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:17:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:17:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:17:14 INFO - '--tppagecycles', 13:17:14 INFO - '7'], 13:17:14 INFO - 'tests': ['tsvgm']}}, 13:17:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:17:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:17:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:17:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:17:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:17:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:17:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:14 INFO - 'talos_options': ['--disable-e10s'], 13:17:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:17:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:17:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:14 INFO - 'talos_options': ['--disable-e10s'], 13:17:14 INFO - 'tests': ['damp', 'tps']}, 13:17:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:14 INFO - 'tests': ['damp', 'tps']}, 13:17:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:17:14 INFO - 'tests': ['dromaeo_dom']}, 13:17:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:17:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:17:14 INFO - 'tests': ['basic_compositor_video']}, 13:17:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:17:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:17:14 INFO - 'tests': ['a11yr', 13:17:14 INFO - 'ts_paint', 13:17:14 INFO - 'tpaint', 13:17:14 INFO - 'sessionrestore', 13:17:14 INFO - 'sessionrestore_no_auto_restore', 13:17:14 INFO - 'tabpaint']}, 13:17:14 INFO - 'other-e10s': {'tests': ['a11yr', 13:17:14 INFO - 'ts_paint', 13:17:14 INFO - 'tpaint', 13:17:14 INFO - 'sessionrestore', 13:17:14 INFO - 'sessionrestore_no_auto_restore', 13:17:14 INFO - 'tabpaint']}, 13:17:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:17:14 INFO - 'ts_paint', 13:17:14 INFO - 'tpaint', 13:17:14 INFO - 'sessionrestore', 13:17:14 INFO - 'sessionrestore_no_auto_restore', 13:17:14 INFO - 'tabpaint']}, 13:17:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:17:14 INFO - 'ts_paint', 13:17:14 INFO - 'tpaint', 13:17:14 INFO - 'sessionrestore', 13:17:14 INFO - 'sessionrestore_no_auto_restore', 13:17:14 INFO - 'tabpaint']}, 13:17:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:17:14 INFO - 'tests': ['a11yr', 13:17:14 INFO - 'ts_paint', 13:17:14 INFO - 'tpaint', 13:17:14 INFO - 'sessionrestore', 13:17:14 INFO - 'sessionrestore_no_auto_restore', 13:17:14 INFO - 'tabpaint']}, 13:17:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:17:14 INFO - 'tests': ['a11yr', 13:17:14 INFO - 'ts_paint', 13:17:14 INFO - 'tpaint', 13:17:14 INFO - 'sessionrestore', 13:17:14 INFO - 'sessionrestore_no_auto_restore', 13:17:14 INFO - 'tabpaint']}, 13:17:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:17:14 INFO - 'tests': ['tsvgx', 13:17:14 INFO - 'tsvgr_opacity', 13:17:14 INFO - 'tart', 13:17:14 INFO - 'tscrollx', 13:17:14 INFO - 'cart']}, 13:17:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:17:14 INFO - 'tsvgr_opacity', 13:17:14 INFO - 'tart', 13:17:14 INFO - 'tscrollx', 13:17:14 INFO - 'cart']}, 13:17:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:14 INFO - 'talos_options': ['--disable-e10s'], 13:17:14 INFO - 'tests': ['tp5o']}, 13:17:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:14 INFO - 'tests': ['tp5o']}, 13:17:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:14 INFO - 'talos_options': ['--disable-e10s', 13:17:14 INFO - '--xperf_path', 13:17:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:17:14 INFO - 'tests': ['tp5n']}, 13:17:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:14 INFO - 'talos_options': ['--xperf_path', 13:17:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:17:14 INFO - 'tests': ['tp5n']}}, 13:17:14 INFO - 'talos.zip': {'path': '', 13:17:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:17:14 INFO - Running post-action listener: _resource_record_post_action 13:17:14 INFO - [mozharness: 2016-10-01 20:17:14.774636Z] Finished populate-webroot step (success) 13:17:14 INFO - [mozharness: 2016-10-01 20:17:14.774746Z] Running create-virtualenv step. 13:17:14 INFO - Running pre-action listener: _resource_record_pre_action 13:17:14 INFO - Running main action method: create_virtualenv 13:17:14 INFO - Creating virtualenv /builds/slave/test/build/venv 13:17:14 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 13:17:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:17:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:17:14 INFO - Using real prefix '/tools/python27' 13:17:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:17:15 INFO - Installing distribute.............................................................................................................................................................................................done. 13:17:18 INFO - Installing pip.................done. 13:17:18 INFO - Return code: 0 13:17:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:17:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:17:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:17:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:18 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 0x109f78490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109eee570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9225ad6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d8cd30>, '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 0x109bf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d84b20>, '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.Sh5roUtZVQ/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.iBAqghRgCr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 13:17:18 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 13:17:18 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 13:17:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sh5roUtZVQ/Render', 13:17:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:17:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:17:18 INFO - 'HOME': '/Users/cltbld', 13:17:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:17:18 INFO - 'LOGNAME': 'cltbld', 13:17:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:18 INFO - 'MOZ_NO_REMOTE': '1', 13:17:18 INFO - 'NO_EM_RESTART': '1', 13:17:18 INFO - 'PAGER': '/bin/cat', 13:17:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:17:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:18 INFO - 'PWD': '/builds/slave/test', 13:17:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:17:18 INFO - 'SHELL': '/bin/bash', 13:17:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iBAqghRgCr/Listeners', 13:17:18 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 13:17:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:17:18 INFO - 'USER': 'cltbld', 13:17:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:17:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:17:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:18 INFO - 'XPC_FLAGS': '0x0', 13:17:18 INFO - 'XPC_SERVICE_NAME': '0', 13:17:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:17:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:18 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 13:17:18 INFO - Cleaning up... 13:17:18 INFO - Return code: 0 13:17:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:17:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:17:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:17:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:18 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 0x109f78490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109eee570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9225ad6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d8cd30>, '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 0x109bf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d84b20>, '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.Sh5roUtZVQ/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.iBAqghRgCr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 13:17:18 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 13:17:18 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 13:17:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sh5roUtZVQ/Render', 13:17:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:17:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:17:18 INFO - 'HOME': '/Users/cltbld', 13:17:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:17:18 INFO - 'LOGNAME': 'cltbld', 13:17:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:18 INFO - 'MOZ_NO_REMOTE': '1', 13:17:18 INFO - 'NO_EM_RESTART': '1', 13:17:18 INFO - 'PAGER': '/bin/cat', 13:17:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:17:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:18 INFO - 'PWD': '/builds/slave/test', 13:17:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:17:18 INFO - 'SHELL': '/bin/bash', 13:17:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iBAqghRgCr/Listeners', 13:17:18 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 13:17:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:17:18 INFO - 'USER': 'cltbld', 13:17:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:17:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:17:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:18 INFO - 'XPC_FLAGS': '0x0', 13:17:18 INFO - 'XPC_SERVICE_NAME': '0', 13:17:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:17:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:19 INFO - Downloading/unpacking psutil>=3.1.1 13:17:19 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 13:17:19 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 13:17:19 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 13:17:19 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 13:17:19 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 13:17:19 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 13:17:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:17:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:17:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:17:22 INFO - Installing collected packages: psutil 13:17:22 INFO - Running setup.py install for psutil 13:17:22 INFO - building 'psutil._psutil_osx' extension 13:17:22 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 13:17:22 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 13:17:23 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 13:17:23 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 13:17:23 INFO - building 'psutil._psutil_posix' extension 13:17:23 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 13:17:23 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:17:23 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:17:23 INFO - ^ 13:17:23 INFO - 1 warning generated. 13:17:23 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 13:17:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:17:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:17:23 INFO - Successfully installed psutil 13:17:23 INFO - Cleaning up... 13:17:23 INFO - Return code: 0 13:17:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:17:23 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:17:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:23 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:17:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:23 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 0x109f78490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109eee570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9225ad6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d8cd30>, '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 0x109bf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d84b20>, '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.Sh5roUtZVQ/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.iBAqghRgCr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 13:17:23 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 13:17:23 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 13:17:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sh5roUtZVQ/Render', 13:17:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:17:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:17:23 INFO - 'HOME': '/Users/cltbld', 13:17:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:17:23 INFO - 'LOGNAME': 'cltbld', 13:17:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:23 INFO - 'MOZ_NO_REMOTE': '1', 13:17:23 INFO - 'NO_EM_RESTART': '1', 13:17:23 INFO - 'PAGER': '/bin/cat', 13:17:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:17:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:23 INFO - 'PWD': '/builds/slave/test', 13:17:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:17:23 INFO - 'SHELL': '/bin/bash', 13:17:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iBAqghRgCr/Listeners', 13:17:23 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 13:17:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:17:23 INFO - 'USER': 'cltbld', 13:17:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:17:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:17:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:23 INFO - 'XPC_FLAGS': '0x0', 13:17:23 INFO - 'XPC_SERVICE_NAME': '0', 13:17:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:17:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:17:23 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 13:17:23 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 13:17:23 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 13:17:23 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 13:17:23 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 13:17:23 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 13:17:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:17:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:17:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:17:26 INFO - Installing collected packages: mozsystemmonitor 13:17:26 INFO - Running setup.py install for mozsystemmonitor 13:17:26 INFO - Successfully installed mozsystemmonitor 13:17:26 INFO - Cleaning up... 13:17:26 INFO - Return code: 0 13:17:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:17:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:17:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:17:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:26 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 0x109f78490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109eee570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9225ad6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d8cd30>, '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 0x109bf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d84b20>, '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.Sh5roUtZVQ/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.iBAqghRgCr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 13:17:26 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 13:17:26 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 13:17:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sh5roUtZVQ/Render', 13:17:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:17:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:17:26 INFO - 'HOME': '/Users/cltbld', 13:17:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:17:26 INFO - 'LOGNAME': 'cltbld', 13:17:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:26 INFO - 'MOZ_NO_REMOTE': '1', 13:17:26 INFO - 'NO_EM_RESTART': '1', 13:17:26 INFO - 'PAGER': '/bin/cat', 13:17:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:17:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:26 INFO - 'PWD': '/builds/slave/test', 13:17:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:17:26 INFO - 'SHELL': '/bin/bash', 13:17:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iBAqghRgCr/Listeners', 13:17:26 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 13:17:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:17:26 INFO - 'USER': 'cltbld', 13:17:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:17:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:17:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:26 INFO - 'XPC_FLAGS': '0x0', 13:17:26 INFO - 'XPC_SERVICE_NAME': '0', 13:17:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:17:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:26 INFO - Downloading/unpacking jsonschema==2.5.1 13:17:26 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 13:17:26 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 13:17:26 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 13:17:26 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 13:17:26 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 13:17:26 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 13:17:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:17:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:17:29 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 13:17:29 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 13:17:29 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 13:17:29 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 13:17:29 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 13:17:29 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 13:17:29 INFO - Downloading functools32-3.2.3-2.tar.gz 13:17:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:17:29 INFO - warning: no files found matching '*.txt' 13:17:29 INFO - no previously-included directories found matching 'build' 13:17:29 INFO - no previously-included directories found matching 'dist' 13:17:29 INFO - no previously-included directories found matching '.git*' 13:17:29 INFO - Installing collected packages: jsonschema, functools32 13:17:29 INFO - Running setup.py install for functools32 13:17:29 INFO - warning: no files found matching '*.txt' 13:17:29 INFO - no previously-included directories found matching 'build' 13:17:29 INFO - no previously-included directories found matching 'dist' 13:17:29 INFO - no previously-included directories found matching '.git*' 13:17:30 INFO - Successfully installed jsonschema functools32 13:17:30 INFO - Cleaning up... 13:17:30 INFO - Return code: 0 13:17:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:17: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:17:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17: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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109f78490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109eee570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9225ad6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d8cd30>, '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 0x109bf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d84b20>, '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.Sh5roUtZVQ/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.iBAqghRgCr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 13:17: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:17: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 functools32==3.2.3-2 13:17:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sh5roUtZVQ/Render', 13:17:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:17:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:17:30 INFO - 'HOME': '/Users/cltbld', 13:17:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:17:30 INFO - 'LOGNAME': 'cltbld', 13:17:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:30 INFO - 'MOZ_NO_REMOTE': '1', 13:17:30 INFO - 'NO_EM_RESTART': '1', 13:17:30 INFO - 'PAGER': '/bin/cat', 13:17:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:17:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:30 INFO - 'PWD': '/builds/slave/test', 13:17:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:17:30 INFO - 'SHELL': '/bin/bash', 13:17:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iBAqghRgCr/Listeners', 13:17:30 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 13:17:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:17:30 INFO - 'USER': 'cltbld', 13:17:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:17:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:17:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:30 INFO - 'XPC_FLAGS': '0x0', 13:17:30 INFO - 'XPC_SERVICE_NAME': '0', 13:17:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:17:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:17:30 INFO - Cleaning up... 13:17:30 INFO - Return code: 0 13:17:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:17: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:17:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17: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', '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 0x109f78490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109eee570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9225ad6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d8cd30>, '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 0x109bf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d84b20>, '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.Sh5roUtZVQ/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.iBAqghRgCr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 13:17: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:17: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 blobuploader==1.2.4 13:17:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sh5roUtZVQ/Render', 13:17:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:17:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:17:30 INFO - 'HOME': '/Users/cltbld', 13:17:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:17:30 INFO - 'LOGNAME': 'cltbld', 13:17:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:30 INFO - 'MOZ_NO_REMOTE': '1', 13:17:30 INFO - 'NO_EM_RESTART': '1', 13:17:30 INFO - 'PAGER': '/bin/cat', 13:17:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:17:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:30 INFO - 'PWD': '/builds/slave/test', 13:17:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:17:30 INFO - 'SHELL': '/bin/bash', 13:17:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iBAqghRgCr/Listeners', 13:17:30 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 13:17:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:17:30 INFO - 'USER': 'cltbld', 13:17:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:17:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:17:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:30 INFO - 'XPC_FLAGS': '0x0', 13:17:30 INFO - 'XPC_SERVICE_NAME': '0', 13:17:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:17:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:30 INFO - Downloading/unpacking blobuploader==1.2.4 13:17: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 13:17: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 13:17: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 13:17: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 13:17: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 13:17: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 13:17:33 INFO - Downloading blobuploader-1.2.4.tar.gz 13:17:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:17:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:17:33 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 13:17:33 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 13:17:33 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 13:17:33 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 13:17:33 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 13:17:33 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 13:17:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:17:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:17:33 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 13:17:33 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 13:17:33 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 13:17:33 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 13:17:33 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 13:17:33 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 13:17:34 INFO - Downloading docopt-0.6.1.tar.gz 13:17:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:17:34 INFO - Installing collected packages: blobuploader, requests, docopt 13:17:34 INFO - Running setup.py install for blobuploader 13:17:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:17:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:17:34 INFO - Running setup.py install for requests 13:17:35 INFO - Running setup.py install for docopt 13:17:35 INFO - Successfully installed blobuploader requests docopt 13:17:35 INFO - Cleaning up... 13:17:35 INFO - Return code: 0 13:17:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:17:35 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:17:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:35 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:17:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:35 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 0x109f78490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109eee570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9225ad6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d8cd30>, '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 0x109bf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d84b20>, '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.Sh5roUtZVQ/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.iBAqghRgCr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 13:17:35 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 13:17:35 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 13:17:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sh5roUtZVQ/Render', 13:17:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:17:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:17:35 INFO - 'HOME': '/Users/cltbld', 13:17:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:17:35 INFO - 'LOGNAME': 'cltbld', 13:17:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:35 INFO - 'MOZ_NO_REMOTE': '1', 13:17:35 INFO - 'NO_EM_RESTART': '1', 13:17:35 INFO - 'PAGER': '/bin/cat', 13:17:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:17:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:35 INFO - 'PWD': '/builds/slave/test', 13:17:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:17:35 INFO - 'SHELL': '/bin/bash', 13:17:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iBAqghRgCr/Listeners', 13:17:35 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 13:17:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:17:35 INFO - 'USER': 'cltbld', 13:17:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:17:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:17:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:35 INFO - 'XPC_FLAGS': '0x0', 13:17:35 INFO - 'XPC_SERVICE_NAME': '0', 13:17:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:17:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:17:35 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-_BESmn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:17:35 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-cs2I6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:17:35 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-UhRzYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:17:35 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-LMKFOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:17:36 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-Lt9463-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:17:36 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-V9fULA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:17:36 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-82KT6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:17:36 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-nAKmKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:17:36 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-W56J25-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:17:36 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-rdA3Cx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:17:36 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-FzoZvA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:17:36 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-ohTT3U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:17:36 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-RkenQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:17:36 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-mGODvG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:17:37 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-cs6AoX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:17:37 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-jcH4SM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:17:37 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-sVVwyl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:17:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:17:37 INFO - Running setup.py install for manifestparser 13:17:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:17:37 INFO - Running setup.py install for mozcrash 13:17:37 INFO - Running setup.py install for mozdebug 13:17:37 INFO - Running setup.py install for mozdevice 13:17:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:17:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:17:37 INFO - Running setup.py install for mozfile 13:17:38 INFO - Running setup.py install for mozhttpd 13:17:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:17:38 INFO - Running setup.py install for mozinfo 13:17:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:17:38 INFO - Running setup.py install for mozInstall 13:17:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:17:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:17:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:17:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:17:38 INFO - Running setup.py install for mozleak 13:17:38 INFO - Running setup.py install for mozlog 13:17:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:17:38 INFO - Running setup.py install for moznetwork 13:17:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:17:39 INFO - Running setup.py install for mozprocess 13:17:39 INFO - Running setup.py install for mozprofile 13:17:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:17:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:17:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:17:39 INFO - Running setup.py install for mozrunner 13:17:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:17:39 INFO - Running setup.py install for mozscreenshot 13:17:39 INFO - Running setup.py install for moztest 13:17:39 INFO - Running setup.py install for mozversion 13:17:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:17:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:17:39 INFO - Cleaning up... 13:17:39 INFO - Return code: 0 13:17:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:17:39 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:17:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:39 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:17:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:39 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 0x109f78490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109eee570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9225ad6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d8cd30>, '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 0x109bf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d84b20>, '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.Sh5roUtZVQ/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.iBAqghRgCr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 13:17:39 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 13:17:39 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 13:17:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sh5roUtZVQ/Render', 13:17:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:17:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:17:39 INFO - 'HOME': '/Users/cltbld', 13:17:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:17:39 INFO - 'LOGNAME': 'cltbld', 13:17:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:39 INFO - 'MOZ_NO_REMOTE': '1', 13:17:39 INFO - 'NO_EM_RESTART': '1', 13:17:39 INFO - 'PAGER': '/bin/cat', 13:17:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:17:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:39 INFO - 'PWD': '/builds/slave/test', 13:17:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:17:39 INFO - 'SHELL': '/bin/bash', 13:17:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iBAqghRgCr/Listeners', 13:17:39 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 13:17:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:17:39 INFO - 'USER': 'cltbld', 13:17:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:17:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:17:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:39 INFO - 'XPC_FLAGS': '0x0', 13:17:39 INFO - 'XPC_SERVICE_NAME': '0', 13:17:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:17:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:17:40 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-3Ga3FQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:17:40 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)) 13:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:17:40 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-rRVa6v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:17:40 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)) 13:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:17:40 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-0Dpx7T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:17:40 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)) 13:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:17:40 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-yupZep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:17:40 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)) 13:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:17:40 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-1y8yQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:17:40 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)) 13:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:17:40 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-CBM1OI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:17:40 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)) 13:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:17:40 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-y0nRuv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:17:40 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)) 13:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:17:40 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-ejqWiW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:17:41 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)) 13:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:17:41 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-gN5oJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:17:41 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)) 13:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:17:41 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-o9VKTn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:17:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 13:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:17:41 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-Olxge2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:17:41 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)) 13:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:17:41 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-JIj_ss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:17:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:17:41 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-Q5_Op6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:17:41 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)) 13:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:17:41 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-TkgAl9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:17:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:17:41 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-R78EJL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:17:41 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)) 13:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:17:41 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-i6l1a9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:17:41 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)) 13:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:17:41 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-71iCxq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:17:42 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)) 13:17:42 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)) 13:17:42 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)) 13:17:42 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)) 13:17:42 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)) 13:17:42 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)) 13:17:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:17:42 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 13:17:42 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 13:17:42 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 13:17:42 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 13:17:42 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 13:17:42 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 13:17:44 INFO - Downloading blessings-1.6.tar.gz 13:17:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:17:44 INFO - Installing collected packages: blessings 13:17:44 INFO - Running setup.py install for blessings 13:17:44 INFO - Successfully installed blessings 13:17:44 INFO - Cleaning up... 13:17:44 INFO - Return code: 0 13:17:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:17:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:17:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:17:45 INFO - Reading from file tmpfile_stdout 13:17:45 INFO - Current package versions: 13:17:45 INFO - blessings == 1.6 13:17:45 INFO - blobuploader == 1.2.4 13:17:45 INFO - docopt == 0.6.1 13:17:45 INFO - functools32 == 3.2.3-2 13:17:45 INFO - jsonschema == 2.5.1 13:17:45 INFO - manifestparser == 1.1 13:17:45 INFO - mozInstall == 1.12 13:17:45 INFO - mozcrash == 0.17 13:17:45 INFO - mozdebug == 0.1 13:17:45 INFO - mozdevice == 0.48 13:17:45 INFO - mozfile == 1.2 13:17:45 INFO - mozhttpd == 0.7 13:17:45 INFO - mozinfo == 0.9 13:17:45 INFO - mozleak == 0.1 13:17:45 INFO - mozlog == 3.4 13:17:45 INFO - moznetwork == 0.27 13:17:45 INFO - mozprocess == 0.23 13:17:45 INFO - mozprofile == 0.28 13:17:45 INFO - mozrunner == 6.12 13:17:45 INFO - mozscreenshot == 0.1 13:17:45 INFO - mozsystemmonitor == 0.3 13:17:45 INFO - moztest == 0.7 13:17:45 INFO - mozversion == 1.4 13:17:45 INFO - psutil == 3.1.1 13:17:45 INFO - requests == 1.2.3 13:17:45 INFO - wsgiref == 0.1.2 13:17:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:17: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:17:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:45 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 0x109f78490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109eee570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9225ad6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d8cd30>, '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 0x109bf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d84b20>, '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.Sh5roUtZVQ/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.iBAqghRgCr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 13:17:45 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 13:17:45 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 13:17:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sh5roUtZVQ/Render', 13:17:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:17:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:17:45 INFO - 'HOME': '/Users/cltbld', 13:17:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:17:45 INFO - 'LOGNAME': 'cltbld', 13:17:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:45 INFO - 'MOZ_NO_REMOTE': '1', 13:17:45 INFO - 'NO_EM_RESTART': '1', 13:17:45 INFO - 'PAGER': '/bin/cat', 13:17:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:17:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:45 INFO - 'PWD': '/builds/slave/test', 13:17:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:17:45 INFO - 'SHELL': '/bin/bash', 13:17:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iBAqghRgCr/Listeners', 13:17:45 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 13:17:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:17:45 INFO - 'USER': 'cltbld', 13:17:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:17:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:17:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:45 INFO - 'XPC_FLAGS': '0x0', 13:17:45 INFO - 'XPC_SERVICE_NAME': '0', 13:17:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:17:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:45 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)) 13:17:45 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)) 13:17:45 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)) 13:17:45 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)) 13:17:45 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)) 13:17:45 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)) 13:17:45 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)) 13:17:45 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)) 13:17:45 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)) 13:17:45 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)) 13:17:45 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)) 13:17:45 INFO - Cleaning up... 13:17:45 INFO - Return code: 0 13:17:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:17: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:17:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:45 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 0x109f78490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109eee570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9225ad6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d8cd30>, '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 0x109bf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d84b20>, '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.Sh5roUtZVQ/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.iBAqghRgCr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 13:17:45 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 13:17:45 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 13:17:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sh5roUtZVQ/Render', 13:17:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:17:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:17:45 INFO - 'HOME': '/Users/cltbld', 13:17:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:17:45 INFO - 'LOGNAME': 'cltbld', 13:17:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:45 INFO - 'MOZ_NO_REMOTE': '1', 13:17:45 INFO - 'NO_EM_RESTART': '1', 13:17:45 INFO - 'PAGER': '/bin/cat', 13:17:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:17:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:45 INFO - 'PWD': '/builds/slave/test', 13:17:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:17:45 INFO - 'SHELL': '/bin/bash', 13:17:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iBAqghRgCr/Listeners', 13:17:45 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 13:17:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:17:45 INFO - 'USER': 'cltbld', 13:17:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:17:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:17:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:45 INFO - 'XPC_FLAGS': '0x0', 13:17:45 INFO - 'XPC_SERVICE_NAME': '0', 13:17:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:17:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:17:45 INFO - Cleaning up... 13:17:45 INFO - Return code: 0 13:17:45 INFO - Running post-action listener: _resource_record_post_action 13:17:45 INFO - Running post-action listener: _start_resource_monitoring 13:17:45 INFO - Starting resource monitoring. 13:17:45 INFO - [mozharness: 2016-10-01 20:17:45.742136Z] Finished create-virtualenv step (success) 13:17:45 INFO - [mozharness: 2016-10-01 20:17:45.743163Z] Running install step. 13:17:45 INFO - Running pre-action listener: _resource_record_pre_action 13:17:45 INFO - Running main action method: install 13:17:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:17:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:17:46 INFO - Reading from file tmpfile_stdout 13:17:46 INFO - Detecting whether we're running mozinstall >=1.0... 13:17:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:17:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:17:46 INFO - Reading from file tmpfile_stdout 13:17:46 INFO - Output received: 13:17:46 INFO - Usage: mozinstall [options] installer 13:17:46 INFO - Options: 13:17:46 INFO - -h, --help show this help message and exit 13:17:46 INFO - -d DEST, --destination=DEST 13:17:46 INFO - Directory to install application into. [default: 13:17:46 INFO - "/builds/slave/test"] 13:17:46 INFO - --app=APP Application being installed. [default: firefox] 13:17:46 INFO - mkdir: /builds/slave/test/build/application 13:17:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 13:17:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 13:18:17 INFO - Reading from file tmpfile_stdout 13:18:17 INFO - Output received: 13:18:17 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 13:18:17 INFO - Running post-action listener: _resource_record_post_action 13:18:17 INFO - [mozharness: 2016-10-01 20:18:17.832525Z] Finished install step (success) 13:18:17 INFO - [mozharness: 2016-10-01 20:18:17.832658Z] Running run-tests step. 13:18:17 INFO - Running pre-action listener: _resource_record_pre_action 13:18:17 INFO - Running main action method: run_tests 13:18:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:18:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:18:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:18:17 INFO - 2016-10-01 13:18:17.845 screenresolution[1717:8480] starting screenresolution argv=screenresolution get 13:18:17 INFO - 2016-10-01 13:18:17.848 screenresolution[1717:8480] Display 0: 1600x1200x32@60 13:18:17 INFO - 2016-10-01 13:18:17.854 screenresolution[1718:8482] starting screenresolution argv=screenresolution list 13:18:17 INFO - Available Modes on Display 0 13:18:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:18:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:18:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:18:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:18:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:18:18 INFO - Intel Iris: 13:18:18 INFO - Chipset Model: Intel Iris 13:18:18 INFO - Type: GPU 13:18:18 INFO - Bus: Built-In 13:18:18 INFO - VRAM (Dynamic, Max): 1536 MB 13:18:18 INFO - Vendor: Intel (0x8086) 13:18:18 INFO - Device ID: 0x0a2e 13:18:18 INFO - Revision ID: 0x0009 13:18:18 INFO - Displays: 13:18:18 INFO - Display: 13:18:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:18:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:18:18 INFO - Display Serial Number: 1600x1200 60 13:18:18 INFO - Main Display: Yes 13:18:18 INFO - Mirror: Off 13:18:18 INFO - Online: Yes 13:18:18 INFO - Rotation: Supported 13:18:18 INFO - Return code: 0 13:18:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:18:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:18:18 INFO - Python 2.7.3 13:18:18 INFO - Return code: 0 13:18:18 INFO - grabbing minidump binary from tooltool 13:18:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:18 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 0x109d8cd30>, '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 0x109bf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d84b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:18:18 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 13:18:18 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 13:18:18 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 13:18:18 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:18:18 INFO - Return code: 0 13:18:18 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:18:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:18:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:18:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:18:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:18:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XR_z8aYQS-atyXYG_b8LCg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0258', '--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 13:18:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XR_z8aYQS-atyXYG_b8LCg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0258 --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 13:18:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Sh5roUtZVQ/Render', 13:18:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:18:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:18:18 INFO - 'HOME': '/Users/cltbld', 13:18:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:18:18 INFO - 'LOGNAME': 'cltbld', 13:18:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:18:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:18:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:18 INFO - 'MOZ_NO_REMOTE': '1', 13:18:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:18:18 INFO - 'NO_EM_RESTART': '1', 13:18:18 INFO - 'PAGER': '/bin/cat', 13:18:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:18:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:18 INFO - 'PWD': '/builds/slave/test', 13:18:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:18:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:18:18 INFO - 'SHELL': '/bin/bash', 13:18:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iBAqghRgCr/Listeners', 13:18:18 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 13:18:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:18:18 INFO - 'USER': 'cltbld', 13:18:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:18:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:18:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:18 INFO - 'XPC_FLAGS': '0x0', 13:18:18 INFO - 'XPC_SERVICE_NAME': '0', 13:18:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:18:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XR_z8aYQS-atyXYG_b8LCg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0258', '--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 13:18:18 INFO - mozversion application_buildid: 20161001113855 13:18:18 INFO - mozversion application_changeset: 9522156a6cdac7dae1d1e8cd53a229e5644190fc 13:18:18 INFO - mozversion application_display_name: FirefoxDeveloperEdition 13:18:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:18:18 INFO - mozversion application_name: Firefox 13:18:18 INFO - mozversion application_remotingname: firefox-dev 13:18:18 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:18:18 INFO - mozversion application_vendor: Mozilla 13:18:18 INFO - mozversion application_version: 51.0a2 13:18:18 INFO - mozversion platform_buildid: 20161001113855 13:18:18 INFO - mozversion platform_changeset: 9522156a6cdac7dae1d1e8cd53a229e5644190fc 13:18:18 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:18:18 INFO - mozversion platform_version: 51.0a2 13:18:18 INFO - using testdate: 1475353098 13:18:18 INFO - actual date: 1475353098 13:18:18 INFO - starting webserver on 'localhost:49271' 13:18:18 INFO - SUITE-START | Running 2 tests 13:18:18 INFO - TEST-START | dromaeo_css 13:18:18 INFO - operating with platform_type : mac_ 13:18:18 INFO - Initialising browser for dromaeo_css test... 13:18:18 INFO - TEST-INFO | started process 1728 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/tmpK8iMit/profile http://localhost:49271/getInfo.html) 13:18:20 INFO - PROCESS | 1728 | __metrics Screen width/height:1600/1200 13:18:20 INFO - PROCESS | 1728 | colorDepth:24 13:18:20 INFO - PROCESS | 1728 | Browser inner width/height: 1024/689 13:18:20 INFO - PROCESS | 1728 | __metrics 13:18:20 INFO - PROCESS | 1728 | 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" 13:18:20 INFO - PROCESS | 1728 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:18:21 INFO - TEST-INFO | 1728: exit 0 13:18:21 INFO - Browser initialized. 13:18:21 INFO - Running cycle 1/1 for dromaeo_css test... 13:18:21 INFO - TEST-INFO | started process 1732 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/tmpK8iMit/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:18:33 INFO - PROCESS | 1732 | RSS: Main: 218890240 13:18:33 INFO - PROCESS | 1732 | 13:19:24 INFO - PROCESS | 1732 | 1475353164967 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] 13:21:36 INFO - PROCESS | 1732 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 13:21:37 INFO - PROCESS | 1732 | RSS: Main: 328069120 13:21:37 INFO - PROCESS | 1732 | 13:24:40 INFO - PROCESS | 1732 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 13:24:41 INFO - PROCESS | 1732 | RSS: Main: 348631040 13:24:41 INFO - PROCESS | 1732 | 13:27:43 INFO - PROCESS | 1732 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 13:27:44 INFO - PROCESS | 1732 | RSS: Main: 351047680 13:27:44 INFO - PROCESS | 1732 | 13:30:46 INFO - PROCESS | 1732 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 13:30:47 INFO - PROCESS | 1732 | RSS: Main: 329383936 13:30:47 INFO - PROCESS | 1732 | 13:33:50 INFO - PROCESS | 1732 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 13:33:50 INFO - PROCESS | 1732 | RSS: Main: 311156736 13:33:50 INFO - PROCESS | 1732 | 13:36:54 INFO - PROCESS | 1732 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 13:36:54 INFO - PROCESS | 1732 | RSS: Main: 359936000 13:36:54 INFO - PROCESS | 1732 | 13:36:54 INFO - PROCESS | 1732 | __start_tp_report 13:36:54 INFO - PROCESS | 1732 | _x_x_mozilla_page_load 13:36:54 INFO - PROCESS | 1732 | _x_x_mozilla_page_load_details 13:36:54 INFO - PROCESS | 1732 | |i|pagename|runs| 13:36:54 INFO - PROCESS | 1732 | |0;dojo.html;3295.0938491914726;3312.3540909522644;3332.150301673073;3341.5655964724583;3375.9662403375974;4818.879528011801;5668.914966275509;5679.858003549903;5700.914486282709;5719.685417302052;5684.630499017561;5732.770689172438;5757.251557297556;5770.740316685748;5820.243368362107;5206.661566998143;5235.293235413227;5247.422783493813;5268.683878967255;5307.601929855257;4559.837241503412;5209.192575150858;5213.3743950725775;5233.79064837408;5360.597955153359;5106.668066575679;5311.73441327934;5316.680999140064;5316.867078323035;5343.17180836969;5309.150535914235;5321.866953326159;5327.786888524454;5339.866503337428;5354.9196762048605;5147.3308469898675;5157.613179011589;5247.658902171346;5253.369595648508;5264.473552644743;5648.943510564883;5663.461971112738;5737.942620573825;5743;5748.913766293467;6127.0673618518995;6175.7529698811995;6232.968835155795;6235.7505699771955;6247.031710084944;6205.937940620581;6242.750289988395;6251.624902505864;6267.905981410237;6282.277538083134;5614.719264036823;5743.62666426681;5764.279465066867;5817.592768506249;5858.8242352729485;6214.627122372672;6236.282827474808;6252.5935814171935;6257.0614407838275;6578.079068930354;6171.166892469549;6188.412100850412;6199.535034872402;6200.3179650238435;6204.875902481925;6102.51954821894;6147.0779383092895;6179.62922224659;6253.0620406938415;6254.280757712831;6228.28374736902;6233.501319894488;6250.749970001149;6255.249370075529;6259.2488901332135;6182.629042257389;6255.906161407583;6257.7184026718905;6269;6288.308286088527;4818.831340903052;4888.462269150391;4907.337509436252;4933.703977761345;4960.90078198434;4387.166438376698;4429.335599660012;4435.756033418193;4494.280915053576;4505.774711264424;4870.902581948412;5793;5810.477057064884;5812.099124635688;5835.824925252249;6127.0673618518995;6218.440340369389;6235.906461403082;6244.469220116341;6251.812445626639;5617.185508101385;5739.13912913058;5815.941840581625;5818.418158184148;5888.823335299948;5395.406505284415;5420.701861397661;5436.864078397993;5437.293151890229;5447.428020057916;6172.660503672341;6288.717007734572;6313.494920406357;6321.715522801577;6350.8412289692205;6203.96898015507;6211.81364559064;6258.311585725475;6265.154204182377;6279.403456671609;6274.403931626488;6284.057391391328;6287.717052732546;6288.591241569284;6302.117703521419;6201.844953876189;6222.222222222223;6225;6230.7507699691505;6267;5080.974595127001;6147.846303842261;6190.102435146969;6202.41077097675;6235.688215589294;6086.939130608637;6136.140940268277;6142.600730952474;6145.13968044483;6152.384761523812;5483.76615261563;6121.204243448501;6127.394760199908;6139.921477736919;6146.569740118328;5803.767849285981;5893.5874488785375;5910.822675319747;5924.822255332347;5944.9405505946115;6142.345304543789;6142.969285153546;6151.815445536641;6171.3828617139725;6188.257409110755;5941.465268125889;5946.97026514882;5953.404659534012;5977.22296101504;6016.699165041643 13:36:54 INFO - PROCESS | 1732 | |1;ext.html;444.89100170458244;532.4435964417183;532.8854296326289;544.202742981532;572.6678526454657;29783.55324670129;42199.94500137498;42942.35586466206;42948.78525607368;43058.56941430585;41790.791046044724;42207.78896105515;42285.94285142873;42292.78853605736;42547.14905701884;9660.420374777535;9851.852222216638;9856.655017074403;9874.456904870229;9876.851847222297;8578.485290882536;8801.163889430494;8811.735647930573;8941.95529022354;8944.64221431142;11764.823527647091;12046.397680116002;12070.758584828342;12285;12304.876951230463;11953.820692689573;12056.758864822743;12062.517499300018;12095.697607559794;12096.032317414585;8580.356473264468;8768.473891566526;8801.647934082628;8917.687880924137;11899.583514576949;32378.838105809555;38914.80542597297;39470.80264598687;41508.79245603783;41538.792306038275;3358.2108204571905;3361.7142542883885;3406.2846802171325;3406.8466918988456;3674.1549443628114;27427.725722742915;29641;30050.398992020037;30323.696763032527;31445.056648300586;3081.260497480611;3165.446046941776;3213.6786321367676;3245.334706385185;3322.850471728778;518431;518855;519705.4014729902;520254;520286;49883.50116498789;51169;59762;59947;60128.69935650294;48226.75886620545;59322;60148.59405623726;64411.355886440535;64506.354936450974;16321.020738755475;16435.424760133337;16465.506034818976;16482;16516.84382093242;12765.93617031909;12875.871241287654;12880.484780608671;12894.484220631257;12918.677033074247;13793.586192414243;14113.435462581587;15442.227888605525;15558.377664893278;15717.921410392875;7064.258252883476;7134.536255143399;7190.245024272481;7226;7264.309890560388;876.4565969099199;928.5821380378857;988.1156365053237;999.3204620857887;1041.9166466682648;26671.599926001127;27174.5923811143;29737.553936690965;29768.255793605334;30260.54609180864;1043.389617074005;1051.984220236697;1052.6578861869923;1090.334895713614;1116.9329840209614;13288.867111328957;14524.273786310641;14994.925025374803;15393;15696.293666785023;674101;679034;679777;680431;683413;56647.716761415926;56752;56799.86400271971;56932.861342772914;56991;1235.1292338901053;1271.554955765493;1361.2785223831386;1381.6407733989436;1391.4156054457153;28897.277568060126;30546.694533054386;30880.691193087783;30891.382172355978;31439.21401964969;38920;48296.5170348292;48337;48392.03215935732;48462.75768621134;468585;468675;470871;471840;474739;25407.237782866545;25945.481090378464;25980.090696825522;26895.865520672272;26911.86544067267;44655.51839464883;45977.720003776994;47430.28854567115;47651.52348476471;47822.28266576074;36565.634343656224;38270;38549.42175867308;38722.03194920037;39769.2046159081;34920.82539587387;36290.63709362873;36948.89153325404;38192.23615527729;38744.418833716954;37646.62353376431;37946.810265948494;38148.42777358397;38325.80837095908;38491.23017539577;30079.69920300769;32324.191895202806;33633.495497568045;33880.3223935515;34417.65582344145;23566.528669426858;25427.6185857216;25431.87284063568;25632.718364082095;25969.22092337233 13:36:54 INFO - PROCESS | 1732 | |2;jquery.html;337.9304501253533;356.687898089172;378.9943150852737;380.78105089573484;390.6054884566588;13489.460421583124;14581.854181458195;16025.278862451174;20452.181912723474;21000.36998890036;19498.512537186576;20489.282875099376;20599.38201853947;20634.761914285114;20891.582168356625;5681.602287839853;5956.821295361146;5975;5975.25309336333;5982.551308651847;5650.576206784487;6018.819435416923;6066.848328791772;6107.664078475682;6114.785982490592;5946.821595352147;5993.580449368546;6082.239720034996;6089.3910608939195;6092.390760923917;5014.348134742479;6140.754369825202;6140.815775526741;6141.877162456771;6143.32423433422;5087.592992560623;5310.761015754261;5370.624056316059;5913.704314784287;5926.911096333559;12594.181378210387;12835.48658053686;12848.100632955604;13067;24180.637290440656;2120.0989579428833;2403.903843846244;2454.9877250613813;2492.314613481289;2509.4479214572766;9372.578233979488;9863.654772083015;10105.292629515938;10113.544890479947;10201.642942496977;1770.672425601255;1825.3793710138616;1868.3834334669527;1874.756281683386;1897.9335723249758;113727;122660;123712;123818.38090809579;129247.70752292544;9089;9219.90780092204;10956.28784129029;11402.144839136932;11460.885391145981;14443.49447769323;14453.349599268058;14453.638659033608;14456.783148252785;14468.638284042772;7535;7842.882356764653;8181.918180818116;8469.026062002826;8523.275521580612;8329.250367466957;8330.8333833323;8336.458130221516;8481.745547633582;8491.278241349431;4402.361657559636;4413.7793110344355;4416.072624748775;4434.7560884151035;4501.07727915783;1880.8119188081082;1915.7413749143966;1917.118125662211;1920.0879582198345;1921.8366438852574;836.8451836410284;839.3620848155446;943.6084025129632;950.9904900950902;989.1394486796534;19742.60514789696;20654;20659.276925307542;20703.58592828135;21189.364319070453;849.3799526345679;903.6927444668844;945.9952700236593;951.3816019587185;963.8361478548663;9898.752531186634;10365.429901355497;10750.623728169476;10764.56941722338;10789.730256743644;240442;241055;614768;622046;628097;129102.35448822696;133525;134210;137692;137887;918.2241006349624;922.1239822168966;946.1768261612303;946.621351459408;948.7106432538142;18081.819181808012;18095.547611309823;18268.995205263836;18413.447596572125;18451.538711532317;52560.73719631377;53755.19367209573;55076;55561.722191388784;56261.43738562562;76796.61601692179;78998;80432;80580;80587.19412805796;7821.217878212134;7849.921500784919;7934.127246002819;8106.270435660819;8183.099859015622;11728.70678233051;12300.200486968319;12540;12629.2422454653;12843.935780321039;10397.32417392867;10599;10992.945035274772;11084.833727493933;11180.496877640688;9350.345475816628;10218.233632477446;10532.525446437352;10828.620998265023;10946.835797463204;10035.799284014425;10860.511276992396;10990.615328463466;11057.557697692002;11391.430428478709;7812.179721129427;7823.765287041398;7893.250141236574;8047.034355877332;8210.671573137246;8119.512829230265;9857.408555486694;10699.94650026745;10889.183311251529;11168.720781980515 13:36:54 INFO - PROCESS | 1732 | |3;mootools.html;1370.1915869636912;1522.4366984215837;1545.0189129902512;1703.4378655043836;1853.9907300463497;7951.602419879005;8464.703735369263;8743.125687431262;9014.414063085895;9014.90985090149;8919.955400223005;8970.192682658559;8978;8984.95507522463;8991.550422478882;2396.0535588442553;2427.599446091393;2428.5264373447185;2429.344077099182;2429.526242382736;2389.1279682915783;2416.7583241675866;2424.4302588891596;2425.3815277104313;2435.610302351624;2403.663487111806;2417.0090262992176;2427.1990243219784;2438.280707191374;2439;2368.0882860098814;2390.8087353011715;2394.341556072077;2404.0744313439277;2404.1224952892244;2360.3037104054347;2383.0229605861514;2386.22447704495;2388.665586817847;2391.8086553075887;8816.779580510474;8927.330450216195;8953.194212520839;9029.232515236214;9046.050164732675;5323.707196104213;5513.062779327483;5519.089350257203;5533.972330138324;5534.833954981357;3037.5747395364665;3586.605473397924;3642.981785091084;3712.628737126293;3720.2373513429684;1099.1261946752352;1105.6130354375985;1115.397685249964;1119.8824123467;1120.4733775125678;11819.704507387298;11910.523579056828;11928.58249961256;12012.759744805142;12055.21641093335;4454.3986561813745;4515.187266292033;4668.926146986212;4685.625149987993;4691.9530804692195;9269.90730092704;9305.11601397866;9307.581158847732;9343.626254949862;9375.5312234388;5284.7886084556185;5288.206768984606;5294.152935530296;5298.735063246822;5334.413214546396;4352.651787857028;4439.245328294133;4587.128445595326;4590.632749380042;4926.75366231687;3812.046988252937;3814.3515602347666;3870.9806450967567;3890.844366225376;3901.7268791184347;1173.4836671864352;1184.1054313098973;1186.839776630144;1200.4357951762659;1201;835.6740871060291;913.7761248494162;920.3097676742443;941.5245301122889;951.0917074194266;5741.1388291756575;5791.160281759206;5962.165296858443;6051.304100028553;6075.635461872302;428.6977680735074;432.71873282366715;452.5112878091653;453.3766071651479;458.1089780377201;3921.3529767588598;3957.604239576077;3994.0613955720382;4069.1658210066867;4094.8125043737577;10828.620998265023;10973.530955534941;11142.721431964266;11195.440227988567;11197.440127993568;10934.125269978382;11173.217874748852;11191.048760855256;11223.887761122447;11224.551017959353;8225.259726624512;8337;8344.541050242173;8416.03215630198;8419.705310314232;5766.221560089502;5785.739641716049;5958.731857066529;6036.9698151508965;6079.635221886701;10217.1826253901;10311.22665800053;10344;10359.015893490106;10372;8625.309975201842;9518.19095376873;9850.901490984998;10158.18734501253;10405.647265855692;5694.943050569607;6517.804465866032;7078.504504684829;7117.074780278531;7186.928130718626;8305.501669899826;8379.455335403423;8447.366447516339;8452.070272270168;8486.957565212135;6948.756793512202;7106.5736055836815;7626.00861887951;7627.046619172604;7822.608869556386;7437.107547094167;7476.626168691435;7494.175640679412;7548;7573.886391704019;7048.330408611174;7096.254893236136;7180.461465390013;7185.17370502378;7190.388816950409;5003.924941125813;5031.270465782514;5062.240663900445;5077.060743762416;5083.644144909968;4249.29886568725;5029.572486338702;5072.213806859942;5186.9221961669855;5206.843794686166 13:36:54 INFO - PROCESS | 1732 | |4;prototype.html;268.28234472785294;306.3123288217951;313.16072924562167;316.2410215482841;320.87165133946405;5331.747039445727;5416.052190866602;5446.91829622555;5454.263674403949;5500.477454641813;4307;5077.720725360104;5213.973930130353;5368.46315368463;5401.864953376167;4141.5237247716595;4155.771432571208;4170.812313445902;4171.645410140141;4200.474940632421;4159.854405095823;4165.396017577449;4190.895227619303;4206.831726730927;4210.873673789792;4028.6374226319626;4138.730982486144;4151.3150330195485;4163.854265100722;4191.140816132685;4125.690573207022;4138.91722165555;4159.272127377727;4166.708330416872;4194.266003449384;2945.9983605573993;3531.9293614127832;3621.9094522637147;3635.709143268532;3645.2891686121216;5093.516115968977;5242.614610352281;5243.947560524384;5296.655717378358;5325.7869685212545;4137.358709400048;4694.765261736899;4729.858104256878;4748.311494833264;4751.477337492873;4959.925601115986;5184.844454666366;5319.760610772524;5680.932296559853;5691.857703557403;3039.6808335124715;3610.548681414823;3633.8001409922445;3949.921001579981;3986.1828325193264;5958.970205149033;5962.880742385128;5966.522678185735;5977.521798256129;5997.970010149921;3859.6912247020173;3873.4964454620717;4013.6387725104296;4079.673626109904;4104.445899803548;3689.6494832990825;4105.3020986432375;4107.178564287155;4141.937870931938;4160.438340824011;4072.9389059163545;4293.844024641886;4532.954670453253;4587.564181402761;4602.631789456902;5147.422541333737;5282.52457278839;5679.744411501492;5704.144378343199;5716.628419152742;1117.8155604325357;1331.196229109562;1338.5716570697284;1360.9455621775019;1373.8282714660668;643.4755674125572;754.4077898849376;819.7335865843625;826.6858593734463;831.7274569908051;3749.369528632137;3779.5653499847867;3899.9665088751503;3984.4222587724616;4339.7830108494445;4161.9583804161575;4390.165868484977;4642.769666038503;4748.382710247714;4936.3829521309835;3495.213576945218;3623.456481527739;3787.450819631138;4333.959849636065;4480.663950203748;2232.944176395603;2391.572553857836;2395.9338094548107;2597.3117473641905;2605.0071695153224;4658.697184682985;4869.586085182728;5025.8137710096225;5072.746362681851;5093.898122037538;4539.455265368177;4967.658732142301;4975.776090075955;5029.823956161516;5060;4127.855525056609;4430.370263075094;4497.8425755098415;4781.42622885256;4870.566250793182;4057.634812866856;4202.705810593229;4364.406991448035;4386.363977223221;4864.878378040436;4076.673866090765;4117.91764164721;4134.2222844177295;4447.933281000853;4508.233600287894;4794.712317260975;4921.966387058757;5012.223105418666;5018.673786203885;5044.747762611928;2903.4773740726873;3352.446846270338;3390.203302224025;3404.2510647657477;3433.300516244475;4119.443875076826;4717.009428020017;4846.321514987834;4865.829695960624;5004.7228511028125;4142.772147531915;4251.341042138473;4376.846810361622;4736.360591320127;4845.3216549683775;4034.973769672745;4136.069384388488;4467.470698148556;4496.3471551784605;4604.523584693535;3916.8860755699857;4193;4506.651081706169;4512.165249428866;4553.61294289989;5149.845504634867;5299.143592917094;5372.785088596413;5646.491815736604;5677.460641239076;4929.827456039022;5322.095243808484;5532.834014979557;5537.224788529689;5541.833744987495 13:36:54 INFO - PROCESS | 1732 | |5;yui.html;697.5047716121551;745.6979923131132;754.6490881739992;779.83233604775;802.8514724775913;15201.923990380046;16126.274317655705;16166.595835104114;16180.83819161808;16199.433019844308;14366.78449823251;14450.205238711867;14480.565583032527;14483.637909052253;14489;665.3080795972184;686.1628812848317;686.8042607856762;817.3012074676126;824.7731873734726;832.675256649907;839.5844057191669;844.4300097434239;844.4679851693455;846.4371193156544;901.2249465459699;901.4275934781429;905.3210092430677;906.4833045164258;908.68650315641;899.5816945120484;899.9910000900005;900.6577500549782;903.1375036839868;903.1555495611624;511.2101802714777;519.7687029271975;646.3116780628616;662.374056516592;671.5601281160848;14942.40230390794;15043.548693539211;15056.096634201873;15060.397584096623;15065.76086141474;13732.313384330844;14019.299035048309;14129.222892740998;14187;14222.791062759574;12007.3395963222;12537.31044792536;12577.874221257762;12794.296313702742;12851.421686024058;4555.180067587833;4558.521355257716;4559.498455169929;4678.157931572316;4739.431268247798;92526;112909;113169;115661.42169289183;120751.3962430191;10642.201834862417;11081.722956926142;11178.21752477335;11262.436878156059;11536.826947595793;22222.222222222146;22324.888375558345;22352.776472235393;22508;22549.43626409353;7917.524948503108;7922.247386498273;7942.285194332538;7974.4417890748255;8039.67841286342;4247.511536173318;4302.65578753699;4331.328644060176;4332.285172946492;4413.7572433515825;3296.093574267096;3389.1018879996823;3395.8132302723093;3396.575428071491;3401.965980340165;597.4145337569206;624.7032659486707;704.1904289610711;715.9785206443815;717.4977515738899;513.9105097193898;620.1813606039984;625.9812205633838;675.5912672832964;682.5802331151193;9600.279979001603;9605.696979944276;9781.951090244504;9865.704028879145;9904.356216845881;525.7003508000403;576.0322657934627;607.7629724407485;669.5915491550151;691.8201267670441;4254.978725106416;4663.347131401607;4668.78990445424;4723.385959825201;4753.786079626425;91497;114603;150272.2486387583;159453;161877;101701;104756.42865357026;129974;130129;133160;94021.0597894026;108182.45908770406;110138.29031967686;111300.4434977836;112631.30002649735;8869.866951995855;9612.903870961482;9678.661246856327;9927.702168934944;10005.649802257178;48423.27365089456;55109.897802044536;58376.708116459144;59752.506187345665;61183;48978;57894.131588027056;63823.3617663836;66653;89918.55040724755;12457.937710311391;12987.740245195233;13075.542356017493;13101.672458188621;13427.19436833793;13807.86192138106;15158.090514569161;15200.923995379952;15875.603109922344;15878.52364429069;14072.085314454527;14113.435462581381;14547.781783273047;14701.852981470049;14724.042937209048;14198.503052393116;14280.35738391754;14294.213818239681;14472.131672099707;14890.702185956437;13906;13934.58196254114;14387;14476.420943162155;14515.709685806014;10867.619633312795;11046.502907369348;11576;11785.705357366134;11900.285982841056;11258.943705281421;11654.125940554663;11824.290542567473;11861.347625880315;11955.880441195824 13:36:54 INFO - PROCESS | 1732 | __end_tp_report 13:36:54 INFO - PROCESS | 1732 | __start_cc_report 13:36:54 INFO - PROCESS | 1732 | _x_x_mozilla_cycle_collect,1157 13:36:54 INFO - PROCESS | 1732 | __end_cc_report 13:36:54 INFO - PROCESS | 1732 | __startTimestamp1475354214308__endTimestamp 13:36:54 INFO - PROCESS | 1732 | 13:36:54 INFO - PROCESS | 1732 | ------- Summary: start ------- 13:36:54 INFO - PROCESS | 1732 | Number of tests: 6 13:36:54 INFO - PROCESS | 1732 | 13:36:54 INFO - PROCESS | 1732 | [#0] dojo.html Cycles:165 Average:5741.70 Median:5944.94 stddev:650.23 (10.9%) stddev-sans-first:623.25 13:36:54 INFO - PROCESS | 1732 | Values: 3295.1 3312.4 3332.2 3341.6 3376.0 4818.9 5668.9 5679.9 5700.9 5719.7 5684.6 5732.8 5757.3 5770.7 5820.2 5206.7 5235.3 5247.4 5268.7 5307.6 4559.8 5209.2 5213.4 5233.8 5360.6 5106.7 5311.7 5316.7 5316.9 5343.2 5309.2 5321.9 5327.8 5339.9 5354.9 5147.3 5157.6 5247.7 5253.4 5264.5 5648.9 5663.5 5737.9 5743.0 5748.9 6127.1 6175.8 6233.0 6235.8 6247.0 6205.9 6242.8 6251.6 6267.9 6282.3 5614.7 5743.6 5764.3 5817.6 5858.8 6214.6 6236.3 6252.6 6257.1 6578.1 6171.2 6188.4 6199.5 6200.3 6204.9 6102.5 6147.1 6179.6 6253.1 6254.3 6228.3 6233.5 6250.7 6255.2 6259.2 6182.6 6255.9 6257.7 6269.0 6288.3 4818.8 4888.5 4907.3 4933.7 4960.9 4387.2 4429.3 4435.8 4494.3 4505.8 4870.9 5793.0 5810.5 5812.1 5835.8 6127.1 6218.4 6235.9 6244.5 6251.8 5617.2 5739.1 5815.9 5818.4 5888.8 5395.4 5420.7 5436.9 5437.3 5447.4 6172.7 6288.7 6313.5 6321.7 6350.8 6204.0 6211.8 6258.3 6265.2 6279.4 6274.4 6284.1 6287.7 6288.6 6302.1 6201.8 6222.2 6225.0 6230.8 6267.0 5081.0 6147.8 6190.1 6202.4 6235.7 6086.9 6136.1 6142.6 6145.1 6152.4 5483.8 6121.2 6127.4 6139.9 6146.6 5803.8 5893.6 5910.8 5924.8 5944.9 6142.3 6143.0 6151.8 6171.4 6188.3 5941.5 5947.0 5953.4 5977.2 6016.7 13:36:54 INFO - PROCESS | 1732 | 13:36:54 INFO - PROCESS | 1732 | [#1] ext.html Cycles:180 Average:68673.27 Median:38170.33 stddev:150747.98 (394.9%) stddev-sans-first:151083.83 13:36:54 INFO - PROCESS | 1732 | Values: 444.9 532.4 532.9 544.2 572.7 29783.6 42199.9 42942.4 42948.8 43058.6 41790.8 42207.8 42285.9 42292.8 42547.1 9660.4 9851.9 9856.7 9874.5 9876.9 8578.5 8801.2 8811.7 8942.0 8944.6 11764.8 12046.4 12070.8 12285.0 12304.9 11953.8 12056.8 12062.5 12095.7 12096.0 8580.4 8768.5 8801.6 8917.7 11899.6 32378.8 38914.8 39470.8 41508.8 41538.8 3358.2 3361.7 3406.3 3406.8 3674.2 27427.7 29641.0 30050.4 30323.7 31445.1 3081.3 3165.4 3213.7 3245.3 3322.9 518431.0 518855.0 519705.4 520254.0 520286.0 49883.5 51169.0 59762.0 59947.0 60128.7 48226.8 59322.0 60148.6 64411.4 64506.4 16321.0 16435.4 16465.5 16482.0 16516.8 12765.9 12875.9 12880.5 12894.5 12918.7 13793.6 14113.4 15442.2 15558.4 15717.9 7064.3 7134.5 7190.2 7226.0 7264.3 876.5 928.6 988.1 999.3 1041.9 26671.6 27174.6 29737.6 29768.3 30260.5 1043.4 1052.0 1052.7 1090.3 1116.9 13288.9 14524.3 14994.9 15393.0 15696.3 674101.0 679034.0 679777.0 680431.0 683413.0 56647.7 56752.0 56799.9 56932.9 56991.0 1235.1 1271.6 1361.3 1381.6 1391.4 28897.3 30546.7 30880.7 30891.4 31439.2 38920.0 48296.5 48337.0 48392.0 48462.8 468585.0 468675.0 470871.0 471840.0 474739.0 25407.2 25945.5 25980.1 26895.9 26911.9 44655.5 45977.7 47430.3 47651.5 47822.3 36565.6 38270.0 38549.4 38722.0 39769.2 34920.8 36290.6 36948.9 38192.2 38744.4 37646.6 37946.8 38148.4 38325.8 38491.2 30079.7 32324.2 33633.5 33880.3 34417.7 23566.5 25427.6 25431.9 25632.7 25969.2 13:36:54 INFO - PROCESS | 1732 | 13:36:54 INFO - PROCESS | 1732 | [#2] jquery.html Cycles:180 Average:31320.51 Median:367.84 stddev:86124.07 (23413.4%) stddev-sans-first:86334.25 13:36:54 INFO - PROCESS | 1732 | Values: 337.9 356.7 379.0 380.8 390.6 13489.5 14581.9 16025.3 20452.2 21000.4 19498.5 20489.3 20599.4 20634.8 20891.6 5681.6 5956.8 5975.0 5975.3 5982.6 5650.6 6018.8 6066.8 6107.7 6114.8 5946.8 5993.6 6082.2 6089.4 6092.4 5014.3 6140.8 6140.8 6141.9 6143.3 5087.6 5310.8 5370.6 5913.7 5926.9 12594.2 12835.5 12848.1 13067.0 24180.6 2120.1 2403.9 2455.0 2492.3 2509.4 9372.6 9863.7 10105.3 10113.5 10201.6 1770.7 1825.4 1868.4 1874.8 1897.9 113727.0 122660.0 123712.0 123818.4 129247.7 9089.0 9219.9 10956.3 11402.1 11460.9 14443.5 14453.3 14453.6 14456.8 14468.6 7535.0 7842.9 8181.9 8469.0 8523.3 8329.3 8330.8 8336.5 8481.7 8491.3 4402.4 4413.8 4416.1 4434.8 4501.1 1880.8 1915.7 1917.1 1920.1 1921.8 836.8 839.4 943.6 951.0 989.1 19742.6 20654.0 20659.3 20703.6 21189.4 849.4 903.7 946.0 951.4 963.8 9898.8 10365.4 10750.6 10764.6 10789.7 240442.0 241055.0 614768.0 622046.0 628097.0 129102.4 133525.0 134210.0 137692.0 137887.0 918.2 922.1 946.2 946.6 948.7 18081.8 18095.5 18269.0 18413.4 18451.5 52560.7 53755.2 55076.0 55561.7 56261.4 76796.6 78998.0 80432.0 80580.0 80587.2 7821.2 7849.9 7934.1 8106.3 8183.1 11728.7 12300.2 12540.0 12629.2 12843.9 10397.3 10599.0 10992.9 11084.8 11180.5 9350.3 10218.2 10532.5 10828.6 10946.8 10035.8 10860.5 10990.6 11057.6 11391.4 7812.2 7823.8 7893.3 8047.0 8210.7 8119.5 9857.4 10699.9 10889.2 11168.7 13:36:54 INFO - PROCESS | 1732 | 13:36:54 INFO - PROCESS | 1732 | [#3] mootools.html Cycles:180 Average:5726.42 Median:4688.79 stddev:3260.79 (69.5%) stddev-sans-first:3253.51 13:36:54 INFO - PROCESS | 1732 | Values: 1370.2 1522.4 1545.0 1703.4 1854.0 7951.6 8464.7 8743.1 9014.4 9014.9 8920.0 8970.2 8978.0 8985.0 8991.6 2396.1 2427.6 2428.5 2429.3 2429.5 2389.1 2416.8 2424.4 2425.4 2435.6 2403.7 2417.0 2427.2 2438.3 2439.0 2368.1 2390.8 2394.3 2404.1 2404.1 2360.3 2383.0 2386.2 2388.7 2391.8 8816.8 8927.3 8953.2 9029.2 9046.1 5323.7 5513.1 5519.1 5534.0 5534.8 3037.6 3586.6 3643.0 3712.6 3720.2 1099.1 1105.6 1115.4 1119.9 1120.5 11819.7 11910.5 11928.6 12012.8 12055.2 4454.4 4515.2 4668.9 4685.6 4692.0 9269.9 9305.1 9307.6 9343.6 9375.5 5284.8 5288.2 5294.2 5298.7 5334.4 4352.7 4439.2 4587.1 4590.6 4926.8 3812.0 3814.4 3871.0 3890.8 3901.7 1173.5 1184.1 1186.8 1200.4 1201.0 835.7 913.8 920.3 941.5 951.1 5741.1 5791.2 5962.2 6051.3 6075.6 428.7 432.7 452.5 453.4 458.1 3921.4 3957.6 3994.1 4069.2 4094.8 10828.6 10973.5 11142.7 11195.4 11197.4 10934.1 11173.2 11191.0 11223.9 11224.6 8225.3 8337.0 8344.5 8416.0 8419.7 5766.2 5785.7 5958.7 6037.0 6079.6 10217.2 10311.2 10344.0 10359.0 10372.0 8625.3 9518.2 9850.9 10158.2 10405.6 5694.9 6517.8 7078.5 7117.1 7186.9 8305.5 8379.5 8447.4 8452.1 8487.0 6948.8 7106.6 7626.0 7627.0 7822.6 7437.1 7476.6 7494.2 7548.0 7573.9 7048.3 7096.3 7180.5 7185.2 7190.4 5003.9 5031.3 5062.2 5077.1 5083.6 4249.3 5029.6 5072.2 5186.9 5206.8 13:36:54 INFO - PROCESS | 1732 | 13:36:54 INFO - PROCESS | 1732 | [#4] prototype.html Cycles:180 Average:4185.27 Median:4410.27 stddev:1259.70 (28.6%) stddev-sans-first:1228.44 13:36:54 INFO - PROCESS | 1732 | Values: 268.3 306.3 313.2 316.2 320.9 5331.7 5416.1 5446.9 5454.3 5500.5 4307.0 5077.7 5214.0 5368.5 5401.9 4141.5 4155.8 4170.8 4171.6 4200.5 4159.9 4165.4 4190.9 4206.8 4210.9 4028.6 4138.7 4151.3 4163.9 4191.1 4125.7 4138.9 4159.3 4166.7 4194.3 2946.0 3531.9 3621.9 3635.7 3645.3 5093.5 5242.6 5243.9 5296.7 5325.8 4137.4 4694.8 4729.9 4748.3 4751.5 4959.9 5184.8 5319.8 5680.9 5691.9 3039.7 3610.5 3633.8 3949.9 3986.2 5959.0 5962.9 5966.5 5977.5 5998.0 3859.7 3873.5 4013.6 4079.7 4104.4 3689.6 4105.3 4107.2 4141.9 4160.4 4072.9 4293.8 4533.0 4587.6 4602.6 5147.4 5282.5 5679.7 5704.1 5716.6 1117.8 1331.2 1338.6 1360.9 1373.8 643.5 754.4 819.7 826.7 831.7 3749.4 3779.6 3900.0 3984.4 4339.8 4162.0 4390.2 4642.8 4748.4 4936.4 3495.2 3623.5 3787.5 4334.0 4480.7 2232.9 2391.6 2395.9 2597.3 2605.0 4658.7 4869.6 5025.8 5072.7 5093.9 4539.5 4967.7 4975.8 5029.8 5060.0 4127.9 4430.4 4497.8 4781.4 4870.6 4057.6 4202.7 4364.4 4386.4 4864.9 4076.7 4117.9 4134.2 4447.9 4508.2 4794.7 4922.0 5012.2 5018.7 5044.7 2903.5 3352.4 3390.2 3404.3 3433.3 4119.4 4717.0 4846.3 4865.8 5004.7 4142.8 4251.3 4376.8 4736.4 4845.3 4035.0 4136.1 4467.5 4496.3 4604.5 3916.9 4193.0 4506.7 4512.2 4553.6 5149.8 5299.1 5372.8 5646.5 5677.5 4929.8 5322.1 5532.8 5537.2 5541.8 13:36:54 INFO - PROCESS | 1732 | 13:36:54 INFO - PROCESS | 1732 | [#5] yui.html Cycles:180 Average:23520.24 Median:3396.19 stddev:36900.56 (1086.5%) stddev-sans-first:36964.28 13:36:54 INFO - PROCESS | 1732 | Values: 697.5 745.7 754.6 779.8 802.9 15201.9 16126.3 16166.6 16180.8 16199.4 14366.8 14450.2 14480.6 14483.6 14489.0 665.3 686.2 686.8 817.3 824.8 832.7 839.6 844.4 844.5 846.4 901.2 901.4 905.3 906.5 908.7 899.6 900.0 900.7 903.1 903.2 511.2 519.8 646.3 662.4 671.6 14942.4 15043.5 15056.1 15060.4 15065.8 13732.3 14019.3 14129.2 14187.0 14222.8 12007.3 12537.3 12577.9 12794.3 12851.4 4555.2 4558.5 4559.5 4678.2 4739.4 92526.0 112909.0 113169.0 115661.4 120751.4 10642.2 11081.7 11178.2 11262.4 11536.8 22222.2 22324.9 22352.8 22508.0 22549.4 7917.5 7922.2 7942.3 7974.4 8039.7 4247.5 4302.7 4331.3 4332.3 4413.8 3296.1 3389.1 3395.8 3396.6 3402.0 597.4 624.7 704.2 716.0 717.5 513.9 620.2 626.0 675.6 682.6 9600.3 9605.7 9782.0 9865.7 9904.4 525.7 576.0 607.8 669.6 691.8 4255.0 4663.3 4668.8 4723.4 4753.8 91497.0 114603.0 150272.2 159453.0 161877.0 101701.0 104756.4 129974.0 130129.0 133160.0 94021.1 108182.5 110138.3 111300.4 112631.3 8869.9 9612.9 9678.7 9927.7 10005.6 48423.3 55109.9 58376.7 59752.5 61183.0 48978.0 57894.1 63823.4 66653.0 89918.6 12457.9 12987.7 13075.5 13101.7 13427.2 13807.9 15158.1 15200.9 15875.6 15878.5 14072.1 14113.4 14547.8 14701.9 14724.0 14198.5 14280.4 14294.2 14472.1 14890.7 13906.0 13934.6 14387.0 14476.4 14515.7 10867.6 11046.5 11576.0 11785.7 11900.3 11258.9 11654.1 11824.3 11861.3 11955.9 13:36:54 INFO - PROCESS | 1732 | -------- Summary: end -------- 13:36:54 INFO - PROCESS | 1732 | 13:36:54 INFO - TEST-INFO | 1732: exit 0 13:36:54 INFO - TEST-OK | dromaeo_css | took 1116495ms 13:36:54 INFO - TEST-START | kraken 13:36:54 INFO - operating with platform_type : mac_ 13:36:54 INFO - Initialising browser for kraken test... 13:36:54 INFO - TEST-INFO | started process 1850 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/tmpiHD4kk/profile http://localhost:49271/getInfo.html) 13:36:57 INFO - PROCESS | 1850 | __metrics Screen width/height:1600/1200 13:36:57 INFO - PROCESS | 1850 | colorDepth:24 13:36:57 INFO - PROCESS | 1850 | Browser inner width/height: 1024/689 13:36:57 INFO - PROCESS | 1850 | __metrics 13:36:57 INFO - PROCESS | 1850 | 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" 13:36:57 INFO - PROCESS | 1850 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:36:58 INFO - TEST-INFO | 1850: exit 0 13:36:58 INFO - Browser initialized. 13:36:58 INFO - Running cycle 1/1 for kraken test... 13:36:58 INFO - TEST-INFO | started process 1851 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/tmpiHD4kk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:37:10 INFO - PROCESS | 1851 | RSS: Main: 219566080 13:37:10 INFO - PROCESS | 1851 | 13:37:12 INFO - PROCESS | 1851 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 13:37:13 INFO - PROCESS | 1851 | RSS: Main: 269234176 13:37:13 INFO - PROCESS | 1851 | 13:37:16 INFO - PROCESS | 1851 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 13:37:16 INFO - PROCESS | 1851 | RSS: Main: 279474176 13:37:16 INFO - PROCESS | 1851 | 13:37:20 INFO - PROCESS | 1851 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 13:37:20 INFO - PROCESS | 1851 | RSS: Main: 376872960 13:37:20 INFO - PROCESS | 1851 | 13:37:22 INFO - PROCESS | 1851 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 13:37:23 INFO - PROCESS | 1851 | RSS: Main: 278716416 13:37:23 INFO - PROCESS | 1851 | 13:37:25 INFO - PROCESS | 1851 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:37:26 INFO - PROCESS | 1851 | RSS: Main: 279363584 13:37:26 INFO - PROCESS | 1851 | 13:37:28 INFO - PROCESS | 1851 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 13:37:29 INFO - PROCESS | 1851 | RSS: Main: 316624896 13:37:29 INFO - PROCESS | 1851 | 13:37:32 INFO - PROCESS | 1851 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 13:37:33 INFO - PROCESS | 1851 | RSS: Main: 318627840 13:37:33 INFO - PROCESS | 1851 | 13:37:35 INFO - PROCESS | 1851 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 13:37:36 INFO - PROCESS | 1851 | RSS: Main: 317153280 13:37:36 INFO - PROCESS | 1851 | 13:37:37 INFO - PROCESS | 1851 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:37:38 INFO - PROCESS | 1851 | RSS: Main: 288497664 13:37:38 INFO - PROCESS | 1851 | 13:37:40 INFO - PROCESS | 1851 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:37:41 INFO - PROCESS | 1851 | RSS: Main: 294297600 13:37:41 INFO - PROCESS | 1851 | 13:37:43 INFO - PROCESS | 1851 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:37:44 INFO - PROCESS | 1851 | RSS: Main: 292622336 13:37:44 INFO - PROCESS | 1851 | 13:37:46 INFO - PROCESS | 1851 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:37:47 INFO - PROCESS | 1851 | RSS: Main: 310845440 13:37:47 INFO - PROCESS | 1851 | 13:37:50 INFO - PROCESS | 1851 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:37:51 INFO - PROCESS | 1851 | RSS: Main: 307081216 13:37:51 INFO - PROCESS | 1851 | 13:37:52 INFO - PROCESS | 1851 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 13:37:53 INFO - PROCESS | 1851 | RSS: Main: 350277632 13:37:53 INFO - PROCESS | 1851 | 13:37:53 INFO - PROCESS | 1851 | __start_tp_report 13:37:53 INFO - PROCESS | 1851 | _x_x_mozilla_page_load 13:37:53 INFO - PROCESS | 1851 | _x_x_mozilla_page_load_details 13:37:53 INFO - PROCESS | 1851 | |i|pagename|runs| 13:37:53 INFO - PROCESS | 1851 | |0;ai-astar;115;115;113;112;112;113;113;113;111;114 13:37:53 INFO - PROCESS | 1851 | |1;audio-beat-detection;141;110;109;143;119;134;139;109;143;108 13:37:53 INFO - PROCESS | 1851 | |2;audio-dft;187;183;184;185;183;184;183;182;183;184 13:37:53 INFO - PROCESS | 1851 | |3;audio-fft;82;59;61;90;76;84;49;74;100;81 13:37:53 INFO - PROCESS | 1851 | |4;audio-oscillator;84;71;97;70;66;68;92;68;68;90 13:37:53 INFO - PROCESS | 1851 | |5;imaging-gaussian-blur;87;84;87;84;86;83;88;83;93;125 13:37:53 INFO - PROCESS | 1851 | |6;imaging-darkroom;92;92;93;92;93;108;149;151;92;93 13:37:53 INFO - PROCESS | 1851 | |7;imaging-desaturate;84;84;83;83;86;83;84;84;85;84 13:37:53 INFO - PROCESS | 1851 | |8;json-parse-financial;57;53;52;53;55;58;58;57;58;56 13:37:53 INFO - PROCESS | 1851 | |9;json-stringify-tinderbox;72;67;75;72;72;68;69;68;73;70 13:37:53 INFO - PROCESS | 1851 | |10;stanford-crypto-aes;84;87;82;83;83;81;98;103;102;81 13:37:53 INFO - PROCESS | 1851 | |11;stanford-crypto-ccm;138;139;116;137;150;156;154;142;181;138 13:37:53 INFO - PROCESS | 1851 | |12;stanford-crypto-pbkdf2;166;164;162;163;165;167;224;173;163;165 13:37:53 INFO - PROCESS | 1851 | |13;stanford-crypto-sha256-iterative;66;65;67;64;67;67;65;66;66;66 13:37:53 INFO - PROCESS | 1851 | __end_tp_report 13:37:53 INFO - PROCESS | 1851 | __start_cc_report 13:37:53 INFO - PROCESS | 1851 | _x_x_mozilla_cycle_collect,1954 13:37:53 INFO - PROCESS | 1851 | __end_cc_report 13:37:53 INFO - PROCESS | 1851 | __startTimestamp1475354273025__endTimestamp 13:37:53 INFO - PROCESS | 1851 | 13:37:53 INFO - PROCESS | 1851 | ------- Summary: start ------- 13:37:53 INFO - PROCESS | 1851 | Number of tests: 14 13:37:53 INFO - PROCESS | 1851 | 13:37:53 INFO - PROCESS | 1851 | [#0] ai-astar Cycles:10 Average:113.10 Median:113.00 stddev:1.29 (1.1%) stddev-sans-first:1.17 13:37:53 INFO - PROCESS | 1851 | Values: 115.0 115.0 113.0 112.0 112.0 113.0 113.0 113.0 111.0 114.0 13:37:53 INFO - PROCESS | 1851 | 13:37:53 INFO - PROCESS | 1851 | [#1] audio-beat-detection Cycles:10 Average:125.50 Median:136.50 stddev:15.78 (11.6%) stddev-sans-first:15.71 13:37:53 INFO - PROCESS | 1851 | Values: 141.0 110.0 109.0 143.0 119.0 134.0 139.0 109.0 143.0 108.0 13:37:53 INFO - PROCESS | 1851 | 13:37:53 INFO - PROCESS | 1851 | [#2] audio-dft Cycles:10 Average:183.80 Median:184.00 stddev:1.40 (0.8%) stddev-sans-first:0.88 13:37:53 INFO - PROCESS | 1851 | Values: 187.0 183.0 184.0 185.0 183.0 184.0 183.0 182.0 183.0 184.0 13:37:53 INFO - PROCESS | 1851 | 13:37:53 INFO - PROCESS | 1851 | [#3] audio-fft Cycles:10 Average:75.60 Median:78.50 stddev:15.43 (19.7%) stddev-sans-first:16.19 13:37:53 INFO - PROCESS | 1851 | Values: 82.0 59.0 61.0 90.0 76.0 84.0 49.0 74.0 100.0 81.0 13:37:53 INFO - PROCESS | 1851 | 13:37:53 INFO - PROCESS | 1851 | [#4] audio-oscillator Cycles:10 Average:77.40 Median:77.50 stddev:11.97 (15.5%) stddev-sans-first:12.46 13:37:53 INFO - PROCESS | 1851 | Values: 84.0 71.0 97.0 70.0 66.0 68.0 92.0 68.0 68.0 90.0 13:37:53 INFO - PROCESS | 1851 | 13:37:53 INFO - PROCESS | 1851 | [#5] imaging-gaussian-blur Cycles:10 Average:90.00 Median:86.50 stddev:12.66 (14.6%) stddev-sans-first:13.38 13:37:53 INFO - PROCESS | 1851 | Values: 87.0 84.0 87.0 84.0 86.0 83.0 88.0 83.0 93.0 125.0 13:37:53 INFO - PROCESS | 1851 | 13:37:53 INFO - PROCESS | 1851 | [#6] imaging-darkroom Cycles:10 Average:105.50 Median:92.00 stddev:23.96 (26.0%) stddev-sans-first:24.91 13:37:53 INFO - PROCESS | 1851 | Values: 92.0 92.0 93.0 92.0 93.0 108.0 149.0 151.0 92.0 93.0 13:37:53 INFO - PROCESS | 1851 | 13:37:53 INFO - PROCESS | 1851 | [#7] imaging-desaturate Cycles:10 Average:84.00 Median:84.00 stddev:0.94 (1.1%) stddev-sans-first:1.00 13:37:53 INFO - PROCESS | 1851 | Values: 84.0 84.0 83.0 83.0 86.0 83.0 84.0 84.0 85.0 84.0 13:37:53 INFO - PROCESS | 1851 | 13:37:53 INFO - PROCESS | 1851 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:57.00 stddev:2.31 (4.1%) stddev-sans-first:2.40 13:37:53 INFO - PROCESS | 1851 | Values: 57.0 53.0 52.0 53.0 55.0 58.0 58.0 57.0 58.0 56.0 13:37:53 INFO - PROCESS | 1851 | 13:37:53 INFO - PROCESS | 1851 | [#9] json-stringify-tinderbox Cycles:10 Average:70.60 Median:72.00 stddev:2.59 (3.6%) stddev-sans-first:2.70 13:37:53 INFO - PROCESS | 1851 | Values: 72.0 67.0 75.0 72.0 72.0 68.0 69.0 68.0 73.0 70.0 13:37:53 INFO - PROCESS | 1851 | 13:37:53 INFO - PROCESS | 1851 | [#10] stanford-crypto-aes Cycles:10 Average:88.40 Median:83.00 stddev:8.95 (10.8%) stddev-sans-first:9.35 13:37:53 INFO - PROCESS | 1851 | Values: 84.0 87.0 82.0 83.0 83.0 81.0 98.0 103.0 102.0 81.0 13:37:53 INFO - PROCESS | 1851 | 13:37:53 INFO - PROCESS | 1851 | [#11] stanford-crypto-ccm Cycles:10 Average:145.10 Median:146.00 stddev:16.90 (11.6%) stddev-sans-first:17.73 13:37:53 INFO - PROCESS | 1851 | Values: 138.0 139.0 116.0 137.0 150.0 156.0 154.0 142.0 181.0 138.0 13:37:53 INFO - PROCESS | 1851 | 13:37:53 INFO - PROCESS | 1851 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.20 Median:165.50 stddev:18.81 (11.4%) stddev-sans-first:19.85 13:37:53 INFO - PROCESS | 1851 | Values: 166.0 164.0 162.0 163.0 165.0 167.0 224.0 173.0 163.0 165.0 13:37:53 INFO - PROCESS | 1851 | 13:37:53 INFO - PROCESS | 1851 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.00 stddev:0.99 (1.5%) stddev-sans-first:1.05 13:37:53 INFO - PROCESS | 1851 | Values: 66.0 65.0 67.0 64.0 67.0 67.0 65.0 66.0 66.0 66.0 13:37:53 INFO - PROCESS | 1851 | -------- Summary: end -------- 13:37:53 INFO - PROCESS | 1851 | 13:37:53 INFO - TEST-INFO | 1851: exit 0 13:37:53 INFO - TEST-OK | kraken | took 58988ms 13:37:53 INFO - SUITE-END | took 1175s 13:37:54 INFO - Completed test suite (00:19:35) 13:37:54 INFO - javascript benchmark 13:37:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3295.0938491914726, 3312.3540909522644, 3332.150301673073, 3341.5655964724583, 3375.9662403375974, 4818.879528011801, 5668.914966275509, 5679.858003549903, 5700.914486282709, 5719.685417302052, 5684.630499017561, 5732.770689172438, 5757.251557297556, 5770.740316685748, 5820.243368362107, 5206.661566998143, 5235.293235413227, 5247.422783493813, 5268.683878967255, 5307.601929855257, 4559.837241503412, 5209.192575150858, 5213.3743950725775, 5233.79064837408, 5360.597955153359, 5106.668066575679, 5311.73441327934, 5316.680999140064, 5316.867078323035, 5343.17180836969, 5309.150535914235, 5321.866953326159, 5327.786888524454, 5339.866503337428, 5354.9196762048605, 5147.3308469898675, 5157.613179011589, 5247.658902171346, 5253.369595648508, 5264.473552644743, 5648.943510564883, 5663.461971112738, 5737.942620573825, 5743.0, 5748.913766293467, 6127.0673618518995, 6175.7529698811995, 6232.968835155795, 6235.7505699771955, 6247.031710084944, 6205.937940620581, 6242.750289988395, 6251.624902505864, 6267.905981410237, 6282.277538083134, 5614.719264036823, 5743.62666426681, 5764.279465066867, 5817.592768506249, 5858.8242352729485, 6214.627122372672, 6236.282827474808, 6252.5935814171935, 6257.0614407838275, 6578.079068930354, 6171.166892469549, 6188.412100850412, 6199.535034872402, 6200.3179650238435, 6204.875902481925, 6102.51954821894, 6147.0779383092895, 6179.62922224659, 6253.0620406938415, 6254.280757712831, 6228.28374736902, 6233.501319894488, 6250.749970001149, 6255.249370075529, 6259.2488901332135, 6182.629042257389, 6255.906161407583, 6257.7184026718905, 6269.0, 6288.308286088527, 4818.831340903052, 4888.462269150391, 4907.337509436252, 4933.703977761345, 4960.90078198434, 4387.166438376698, 4429.335599660012, 4435.756033418193, 4494.280915053576, 4505.774711264424, 4870.902581948412, 5793.0, 5810.477057064884, 5812.099124635688, 5835.824925252249, 6127.0673618518995, 6218.440340369389, 6235.906461403082, 6244.469220116341, 6251.812445626639, 5617.185508101385, 5739.13912913058, 5815.941840581625, 5818.418158184148, 5888.823335299948, 5395.406505284415, 5420.701861397661, 5436.864078397993, 5437.293151890229, 5447.428020057916, 6172.660503672341, 6288.717007734572, 6313.494920406357, 6321.715522801577, 6350.8412289692205, 6203.96898015507, 6211.81364559064, 6258.311585725475, 6265.154204182377, 6279.403456671609, 6274.403931626488, 6284.057391391328, 6287.717052732546, 6288.591241569284, 6302.117703521419, 6201.844953876189, 6222.222222222223, 6225.0, 6230.7507699691505, 6267.0, 5080.974595127001, 6147.846303842261, 6190.102435146969, 6202.41077097675, 6235.688215589294, 6086.939130608637, 6136.140940268277, 6142.600730952474, 6145.13968044483, 6152.384761523812, 5483.76615261563, 6121.204243448501, 6127.394760199908, 6139.921477736919, 6146.569740118328, 5803.767849285981, 5893.5874488785375, 5910.822675319747, 5924.822255332347, 5944.9405505946115, 6142.345304543789, 6142.969285153546, 6151.815445536641, 6171.3828617139725, 6188.257409110755, 5941.465268125889, 5946.97026514882, 5953.404659534012, 5977.22296101504, 6016.699165041643], "value": 5699.9890484063235, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [444.89100170458244, 532.4435964417183, 532.8854296326289, 544.202742981532, 572.6678526454657, 29783.55324670129, 42199.94500137498, 42942.35586466206, 42948.78525607368, 43058.56941430585, 41790.791046044724, 42207.78896105515, 42285.94285142873, 42292.78853605736, 42547.14905701884, 9660.420374777535, 9851.852222216638, 9856.655017074403, 9874.456904870229, 9876.851847222297, 8578.485290882536, 8801.163889430494, 8811.735647930573, 8941.95529022354, 8944.64221431142, 11764.823527647091, 12046.397680116002, 12070.758584828342, 12285.0, 12304.876951230463, 11953.820692689573, 12056.758864822743, 12062.517499300018, 12095.697607559794, 12096.032317414585, 8580.356473264468, 8768.473891566526, 8801.647934082628, 8917.687880924137, 11899.583514576949, 32378.838105809555, 38914.80542597297, 39470.80264598687, 41508.79245603783, 41538.792306038275, 3358.2108204571905, 3361.7142542883885, 3406.2846802171325, 3406.8466918988456, 3674.1549443628114, 27427.725722742915, 29641.0, 30050.398992020037, 30323.696763032527, 31445.056648300586, 3081.260497480611, 3165.446046941776, 3213.6786321367676, 3245.334706385185, 3322.850471728778, 518431.0, 518855.0, 519705.4014729902, 520254.0, 520286.0, 49883.50116498789, 51169.0, 59762.0, 59947.0, 60128.69935650294, 48226.75886620545, 59322.0, 60148.59405623726, 64411.355886440535, 64506.354936450974, 16321.020738755475, 16435.424760133337, 16465.506034818976, 16482.0, 16516.84382093242, 12765.93617031909, 12875.871241287654, 12880.484780608671, 12894.484220631257, 12918.677033074247, 13793.586192414243, 14113.435462581587, 15442.227888605525, 15558.377664893278, 15717.921410392875, 7064.258252883476, 7134.536255143399, 7190.245024272481, 7226.0, 7264.309890560388, 876.4565969099199, 928.5821380378857, 988.1156365053237, 999.3204620857887, 1041.9166466682648, 26671.599926001127, 27174.5923811143, 29737.553936690965, 29768.255793605334, 30260.54609180864, 1043.389617074005, 1051.984220236697, 1052.6578861869923, 1090.334895713614, 1116.9329840209614, 13288.867111328957, 14524.273786310641, 14994.925025374803, 15393.0, 15696.293666785023, 674101.0, 679034.0, 679777.0, 680431.0, 683413.0, 56647.716761415926, 56752.0, 56799.86400271971, 56932.861342772914, 56991.0, 1235.1292338901053, 1271.554955765493, 1361.2785223831386, 1381.6407733989436, 1391.4156054457153, 28897.277568060126, 30546.694533054386, 30880.691193087783, 30891.382172355978, 31439.21401964969, 38920.0, 48296.5170348292, 48337.0, 48392.03215935732, 48462.75768621134, 468585.0, 468675.0, 470871.0, 471840.0, 474739.0, 25407.237782866545, 25945.481090378464, 25980.090696825522, 26895.865520672272, 26911.86544067267, 44655.51839464883, 45977.720003776994, 47430.28854567115, 47651.52348476471, 47822.28266576074, 36565.634343656224, 38270.0, 38549.42175867308, 38722.03194920037, 39769.2046159081, 34920.82539587387, 36290.63709362873, 36948.89153325404, 38192.23615527729, 38744.418833716954, 37646.62353376431, 37946.810265948494, 38148.42777358397, 38325.80837095908, 38491.23017539577, 30079.69920300769, 32324.191895202806, 33633.495497568045, 33880.3223935515, 34417.65582344145, 23566.528669426858, 25427.6185857216, 25431.87284063568, 25632.718364082095, 25969.22092337233], "value": 19753.02321763985, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.9304501253533, 356.687898089172, 378.9943150852737, 380.78105089573484, 390.6054884566588, 13489.460421583124, 14581.854181458195, 16025.278862451174, 20452.181912723474, 21000.36998890036, 19498.512537186576, 20489.282875099376, 20599.38201853947, 20634.761914285114, 20891.582168356625, 5681.602287839853, 5956.821295361146, 5975.0, 5975.25309336333, 5982.551308651847, 5650.576206784487, 6018.819435416923, 6066.848328791772, 6107.664078475682, 6114.785982490592, 5946.821595352147, 5993.580449368546, 6082.239720034996, 6089.3910608939195, 6092.390760923917, 5014.348134742479, 6140.754369825202, 6140.815775526741, 6141.877162456771, 6143.32423433422, 5087.592992560623, 5310.761015754261, 5370.624056316059, 5913.704314784287, 5926.911096333559, 12594.181378210387, 12835.48658053686, 12848.100632955604, 13067.0, 24180.637290440656, 2120.0989579428833, 2403.903843846244, 2454.9877250613813, 2492.314613481289, 2509.4479214572766, 9372.578233979488, 9863.654772083015, 10105.292629515938, 10113.544890479947, 10201.642942496977, 1770.672425601255, 1825.3793710138616, 1868.3834334669527, 1874.756281683386, 1897.9335723249758, 113727.0, 122660.0, 123712.0, 123818.38090809579, 129247.70752292544, 9089.0, 9219.90780092204, 10956.28784129029, 11402.144839136932, 11460.885391145981, 14443.49447769323, 14453.349599268058, 14453.638659033608, 14456.783148252785, 14468.638284042772, 7535.0, 7842.882356764653, 8181.918180818116, 8469.026062002826, 8523.275521580612, 8329.250367466957, 8330.8333833323, 8336.458130221516, 8481.745547633582, 8491.278241349431, 4402.361657559636, 4413.7793110344355, 4416.072624748775, 4434.7560884151035, 4501.07727915783, 1880.8119188081082, 1915.7413749143966, 1917.118125662211, 1920.0879582198345, 1921.8366438852574, 836.8451836410284, 839.3620848155446, 943.6084025129632, 950.9904900950902, 989.1394486796534, 19742.60514789696, 20654.0, 20659.276925307542, 20703.58592828135, 21189.364319070453, 849.3799526345679, 903.6927444668844, 945.9952700236593, 951.3816019587185, 963.8361478548663, 9898.752531186634, 10365.429901355497, 10750.623728169476, 10764.56941722338, 10789.730256743644, 240442.0, 241055.0, 614768.0, 622046.0, 628097.0, 129102.35448822696, 133525.0, 134210.0, 137692.0, 137887.0, 918.2241006349624, 922.1239822168966, 946.1768261612303, 946.621351459408, 948.7106432538142, 18081.819181808012, 18095.547611309823, 18268.995205263836, 18413.447596572125, 18451.538711532317, 52560.73719631377, 53755.19367209573, 55076.0, 55561.722191388784, 56261.43738562562, 76796.61601692179, 78998.0, 80432.0, 80580.0, 80587.19412805796, 7821.217878212134, 7849.921500784919, 7934.127246002819, 8106.270435660819, 8183.099859015622, 11728.70678233051, 12300.200486968319, 12540.0, 12629.2422454653, 12843.935780321039, 10397.32417392867, 10599.0, 10992.945035274772, 11084.833727493933, 11180.496877640688, 9350.345475816628, 10218.233632477446, 10532.525446437352, 10828.620998265023, 10946.835797463204, 10035.799284014425, 10860.511276992396, 10990.615328463466, 11057.557697692002, 11391.430428478709, 7812.179721129427, 7823.765287041398, 7893.250141236574, 8047.034355877332, 8210.671573137246, 8119.512829230265, 9857.408555486694, 10699.94650026745, 10889.183311251529, 11168.720781980515], "value": 9219.55709459859, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1370.1915869636912, 1522.4366984215837, 1545.0189129902512, 1703.4378655043836, 1853.9907300463497, 7951.602419879005, 8464.703735369263, 8743.125687431262, 9014.414063085895, 9014.90985090149, 8919.955400223005, 8970.192682658559, 8978.0, 8984.95507522463, 8991.550422478882, 2396.0535588442553, 2427.599446091393, 2428.5264373447185, 2429.344077099182, 2429.526242382736, 2389.1279682915783, 2416.7583241675866, 2424.4302588891596, 2425.3815277104313, 2435.610302351624, 2403.663487111806, 2417.0090262992176, 2427.1990243219784, 2438.280707191374, 2439.0, 2368.0882860098814, 2390.8087353011715, 2394.341556072077, 2404.0744313439277, 2404.1224952892244, 2360.3037104054347, 2383.0229605861514, 2386.22447704495, 2388.665586817847, 2391.8086553075887, 8816.779580510474, 8927.330450216195, 8953.194212520839, 9029.232515236214, 9046.050164732675, 5323.707196104213, 5513.062779327483, 5519.089350257203, 5533.972330138324, 5534.833954981357, 3037.5747395364665, 3586.605473397924, 3642.981785091084, 3712.628737126293, 3720.2373513429684, 1099.1261946752352, 1105.6130354375985, 1115.397685249964, 1119.8824123467, 1120.4733775125678, 11819.704507387298, 11910.523579056828, 11928.58249961256, 12012.759744805142, 12055.21641093335, 4454.3986561813745, 4515.187266292033, 4668.926146986212, 4685.625149987993, 4691.9530804692195, 9269.90730092704, 9305.11601397866, 9307.581158847732, 9343.626254949862, 9375.5312234388, 5284.7886084556185, 5288.206768984606, 5294.152935530296, 5298.735063246822, 5334.413214546396, 4352.651787857028, 4439.245328294133, 4587.128445595326, 4590.632749380042, 4926.75366231687, 3812.046988252937, 3814.3515602347666, 3870.9806450967567, 3890.844366225376, 3901.7268791184347, 1173.4836671864352, 1184.1054313098973, 1186.839776630144, 1200.4357951762659, 1201.0, 835.6740871060291, 913.7761248494162, 920.3097676742443, 941.5245301122889, 951.0917074194266, 5741.1388291756575, 5791.160281759206, 5962.165296858443, 6051.304100028553, 6075.635461872302, 428.6977680735074, 432.71873282366715, 452.5112878091653, 453.3766071651479, 458.1089780377201, 3921.3529767588598, 3957.604239576077, 3994.0613955720382, 4069.1658210066867, 4094.8125043737577, 10828.620998265023, 10973.530955534941, 11142.721431964266, 11195.440227988567, 11197.440127993568, 10934.125269978382, 11173.217874748852, 11191.048760855256, 11223.887761122447, 11224.551017959353, 8225.259726624512, 8337.0, 8344.541050242173, 8416.03215630198, 8419.705310314232, 5766.221560089502, 5785.739641716049, 5958.731857066529, 6036.9698151508965, 6079.635221886701, 10217.1826253901, 10311.22665800053, 10344.0, 10359.015893490106, 10372.0, 8625.309975201842, 9518.19095376873, 9850.901490984998, 10158.18734501253, 10405.647265855692, 5694.943050569607, 6517.804465866032, 7078.504504684829, 7117.074780278531, 7186.928130718626, 8305.501669899826, 8379.455335403423, 8447.366447516339, 8452.070272270168, 8486.957565212135, 6948.756793512202, 7106.5736055836815, 7626.00861887951, 7627.046619172604, 7822.608869556386, 7437.107547094167, 7476.626168691435, 7494.175640679412, 7548.0, 7573.886391704019, 7048.330408611174, 7096.254893236136, 7180.461465390013, 7185.17370502378, 7190.388816950409, 5003.924941125813, 5031.270465782514, 5062.240663900445, 5077.060743762416, 5083.644144909968, 4249.29886568725, 5029.572486338702, 5072.213806859942, 5186.9221961669855, 5206.843794686166], "value": 4514.669377649225, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [268.28234472785294, 306.3123288217951, 313.16072924562167, 316.2410215482841, 320.87165133946405, 5331.747039445727, 5416.052190866602, 5446.91829622555, 5454.263674403949, 5500.477454641813, 4307.0, 5077.720725360104, 5213.973930130353, 5368.46315368463, 5401.864953376167, 4141.5237247716595, 4155.771432571208, 4170.812313445902, 4171.645410140141, 4200.474940632421, 4159.854405095823, 4165.396017577449, 4190.895227619303, 4206.831726730927, 4210.873673789792, 4028.6374226319626, 4138.730982486144, 4151.3150330195485, 4163.854265100722, 4191.140816132685, 4125.690573207022, 4138.91722165555, 4159.272127377727, 4166.708330416872, 4194.266003449384, 2945.9983605573993, 3531.9293614127832, 3621.9094522637147, 3635.709143268532, 3645.2891686121216, 5093.516115968977, 5242.614610352281, 5243.947560524384, 5296.655717378358, 5325.7869685212545, 4137.358709400048, 4694.765261736899, 4729.858104256878, 4748.311494833264, 4751.477337492873, 4959.925601115986, 5184.844454666366, 5319.760610772524, 5680.932296559853, 5691.857703557403, 3039.6808335124715, 3610.548681414823, 3633.8001409922445, 3949.921001579981, 3986.1828325193264, 5958.970205149033, 5962.880742385128, 5966.522678185735, 5977.521798256129, 5997.970010149921, 3859.6912247020173, 3873.4964454620717, 4013.6387725104296, 4079.673626109904, 4104.445899803548, 3689.6494832990825, 4105.3020986432375, 4107.178564287155, 4141.937870931938, 4160.438340824011, 4072.9389059163545, 4293.844024641886, 4532.954670453253, 4587.564181402761, 4602.631789456902, 5147.422541333737, 5282.52457278839, 5679.744411501492, 5704.144378343199, 5716.628419152742, 1117.8155604325357, 1331.196229109562, 1338.5716570697284, 1360.9455621775019, 1373.8282714660668, 643.4755674125572, 754.4077898849376, 819.7335865843625, 826.6858593734463, 831.7274569908051, 3749.369528632137, 3779.5653499847867, 3899.9665088751503, 3984.4222587724616, 4339.7830108494445, 4161.9583804161575, 4390.165868484977, 4642.769666038503, 4748.382710247714, 4936.3829521309835, 3495.213576945218, 3623.456481527739, 3787.450819631138, 4333.959849636065, 4480.663950203748, 2232.944176395603, 2391.572553857836, 2395.9338094548107, 2597.3117473641905, 2605.0071695153224, 4658.697184682985, 4869.586085182728, 5025.8137710096225, 5072.746362681851, 5093.898122037538, 4539.455265368177, 4967.658732142301, 4975.776090075955, 5029.823956161516, 5060.0, 4127.855525056609, 4430.370263075094, 4497.8425755098415, 4781.42622885256, 4870.566250793182, 4057.634812866856, 4202.705810593229, 4364.406991448035, 4386.363977223221, 4864.878378040436, 4076.673866090765, 4117.91764164721, 4134.2222844177295, 4447.933281000853, 4508.233600287894, 4794.712317260975, 4921.966387058757, 5012.223105418666, 5018.673786203885, 5044.747762611928, 2903.4773740726873, 3352.446846270338, 3390.203302224025, 3404.2510647657477, 3433.300516244475, 4119.443875076826, 4717.009428020017, 4846.321514987834, 4865.829695960624, 5004.7228511028125, 4142.772147531915, 4251.341042138473, 4376.846810361622, 4736.360591320127, 4845.3216549683775, 4034.973769672745, 4136.069384388488, 4467.470698148556, 4496.3471551784605, 4604.523584693535, 3916.8860755699857, 4193.0, 4506.651081706169, 4512.165249428866, 4553.61294289989, 5149.845504634867, 5299.143592917094, 5372.785088596413, 5646.491815736604, 5677.460641239076, 4929.827456039022, 5322.095243808484, 5532.834014979557, 5537.224788529689, 5541.833744987495], "value": 3788.3430031377725, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [697.5047716121551, 745.6979923131132, 754.6490881739992, 779.83233604775, 802.8514724775913, 15201.923990380046, 16126.274317655705, 16166.595835104114, 16180.83819161808, 16199.433019844308, 14366.78449823251, 14450.205238711867, 14480.565583032527, 14483.637909052253, 14489.0, 665.3080795972184, 686.1628812848317, 686.8042607856762, 817.3012074676126, 824.7731873734726, 832.675256649907, 839.5844057191669, 844.4300097434239, 844.4679851693455, 846.4371193156544, 901.2249465459699, 901.4275934781429, 905.3210092430677, 906.4833045164258, 908.68650315641, 899.5816945120484, 899.9910000900005, 900.6577500549782, 903.1375036839868, 903.1555495611624, 511.2101802714777, 519.7687029271975, 646.3116780628616, 662.374056516592, 671.5601281160848, 14942.40230390794, 15043.548693539211, 15056.096634201873, 15060.397584096623, 15065.76086141474, 13732.313384330844, 14019.299035048309, 14129.222892740998, 14187.0, 14222.791062759574, 12007.3395963222, 12537.31044792536, 12577.874221257762, 12794.296313702742, 12851.421686024058, 4555.180067587833, 4558.521355257716, 4559.498455169929, 4678.157931572316, 4739.431268247798, 92526.0, 112909.0, 113169.0, 115661.42169289183, 120751.3962430191, 10642.201834862417, 11081.722956926142, 11178.21752477335, 11262.436878156059, 11536.826947595793, 22222.222222222146, 22324.888375558345, 22352.776472235393, 22508.0, 22549.43626409353, 7917.524948503108, 7922.247386498273, 7942.285194332538, 7974.4417890748255, 8039.67841286342, 4247.511536173318, 4302.65578753699, 4331.328644060176, 4332.285172946492, 4413.7572433515825, 3296.093574267096, 3389.1018879996823, 3395.8132302723093, 3396.575428071491, 3401.965980340165, 597.4145337569206, 624.7032659486707, 704.1904289610711, 715.9785206443815, 717.4977515738899, 513.9105097193898, 620.1813606039984, 625.9812205633838, 675.5912672832964, 682.5802331151193, 9600.279979001603, 9605.696979944276, 9781.951090244504, 9865.704028879145, 9904.356216845881, 525.7003508000403, 576.0322657934627, 607.7629724407485, 669.5915491550151, 691.8201267670441, 4254.978725106416, 4663.347131401607, 4668.78990445424, 4723.385959825201, 4753.786079626425, 91497.0, 114603.0, 150272.2486387583, 159453.0, 161877.0, 101701.0, 104756.42865357026, 129974.0, 130129.0, 133160.0, 94021.0597894026, 108182.45908770406, 110138.29031967686, 111300.4434977836, 112631.30002649735, 8869.866951995855, 9612.903870961482, 9678.661246856327, 9927.702168934944, 10005.649802257178, 48423.27365089456, 55109.897802044536, 58376.708116459144, 59752.506187345665, 61183.0, 48978.0, 57894.131588027056, 63823.3617663836, 66653.0, 89918.55040724755, 12457.937710311391, 12987.740245195233, 13075.542356017493, 13101.672458188621, 13427.19436833793, 13807.86192138106, 15158.090514569161, 15200.923995379952, 15875.603109922344, 15878.52364429069, 14072.085314454527, 14113.435462581381, 14547.781783273047, 14701.852981470049, 14724.042937209048, 14198.503052393116, 14280.35738391754, 14294.213818239681, 14472.131672099707, 14890.702185956437, 13906.0, 13934.58196254114, 14387.0, 14476.420943162155, 14515.709685806014, 10867.619633312795, 11046.502907369348, 11576.0, 11785.705357366134, 11900.285982841056, 11258.943705281421, 11654.125940554663, 11824.290542567473, 11861.347625880315, 11955.880441195824], "value": 7780.739321091805, "unit": "score"}], "name": "dromaeo_css", "value": 7189.972207897887, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 113.0, 112.0, 112.0, 113.0, 113.0, 113.0, 111.0, 114.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 110.0, 109.0, 143.0, 119.0, 134.0, 139.0, 109.0, 143.0, 108.0], "value": 125.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 183.0, 184.0, 185.0, 183.0, 184.0, 183.0, 182.0, 183.0, 184.0], "value": 183.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 59.0, 61.0, 90.0, 76.0, 84.0, 49.0, 74.0, 100.0, 81.0], "value": 75.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 71.0, 97.0, 70.0, 66.0, 68.0, 92.0, 68.0, 68.0, 90.0], "value": 77.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 87.0, 84.0, 86.0, 83.0, 88.0, 83.0, 93.0, 125.0], "value": 90.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 93.0, 92.0, 93.0, 108.0, 149.0, 151.0, 92.0, 93.0], "value": 105.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 83.0, 83.0, 86.0, 83.0, 84.0, 84.0, 85.0, 84.0], "value": 84.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 53.0, 52.0, 53.0, 55.0, 58.0, 58.0, 57.0, 58.0, 56.0], "value": 55.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 67.0, 75.0, 72.0, 72.0, 68.0, 69.0, 68.0, 73.0, 70.0], "value": 70.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 87.0, 82.0, 83.0, 83.0, 81.0, 98.0, 103.0, 102.0, 81.0], "value": 88.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 139.0, 116.0, 137.0, 150.0, 156.0, 154.0, 142.0, 181.0, 138.0], "value": 145.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 164.0, 162.0, 163.0, 165.0, 167.0, 224.0, 173.0, 163.0, 165.0], "value": 171.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 67.0, 64.0, 67.0, 67.0, 65.0, 66.0, 66.0, 66.0], "value": 65.9, "unit": "score"}], "name": "kraken", "value": 1451.8000000000002, "alertThreshold": 2.0}]} 13:37:54 INFO - Return code: 0 13:37:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:37:54 INFO - # TBPL SUCCESS # 13:37:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:37:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:37:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:37:54 INFO - 2016-10-01 13:37:54.358 screenresolution[1861:10835] starting screenresolution argv=screenresolution get 13:37:54 INFO - 2016-10-01 13:37:54.361 screenresolution[1861:10835] Display 0: 1600x1200x32@60 13:37:54 INFO - 2016-10-01 13:37:54.367 screenresolution[1862:10838] starting screenresolution argv=screenresolution list 13:37:54 INFO - Available Modes on Display 0 13:37:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:37:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:37:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:37:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:37:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:37:54 INFO - Intel Iris: 13:37:54 INFO - Chipset Model: Intel Iris 13:37:54 INFO - Type: GPU 13:37:54 INFO - Bus: Built-In 13:37:54 INFO - VRAM (Dynamic, Max): 1536 MB 13:37:54 INFO - Vendor: Intel (0x8086) 13:37:54 INFO - Device ID: 0x0a2e 13:37:54 INFO - Revision ID: 0x0009 13:37:54 INFO - Displays: 13:37:54 INFO - Display: 13:37:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:37:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:37:54 INFO - Display Serial Number: 1600x1200 60 13:37:54 INFO - Main Display: Yes 13:37:54 INFO - Mirror: Off 13:37:54 INFO - Online: Yes 13:37:54 INFO - Rotation: Supported 13:37:54 INFO - Return code: 0 13:37:54 INFO - Running post-action listener: _resource_record_post_action 13:37:54 INFO - [mozharness: 2016-10-01 20:37:54.603003Z] Finished run-tests step (success) 13:37:54 INFO - Running post-run listener: _resource_record_post_run 13:37:54 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 31980544; Write bytes: 668404224; Read time: 194; Write time: 1961 13:37:54 INFO - TinderboxPrint: CPU usage
53.6% 13:37:54 INFO - TinderboxPrint: I/O read bytes / time
31,980,544 / 194 13:37:54 INFO - TinderboxPrint: I/O write bytes / time
668,404,224 / 1,961 13:37:54 INFO - TinderboxPrint: CPU idle
2,240.5 (46.4%) 13:37:54 INFO - TinderboxPrint: CPU system
970.5 (20.1%) 13:37:54 INFO - TinderboxPrint: CPU user
1,622.5 (33.6%) 13:37:54 INFO - TinderboxPrint: Swap in / out
391,524,352 / 0 13:37:54 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 364005888; Write bytes: 364996096; Read time: 27540; Write time: 770 13:37:54 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 29191168; Write bytes: 297200640; Read time: 172; Write time: 1164 13:37:55 INFO - Running post-run listener: _upload_blobber_files 13:37:55 INFO - Blob upload gear active. 13:37:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:37:55 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 13:37:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:37:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:37:55 INFO - (blobuploader) - INFO - Open directory for files ... 13:37:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:37:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:37:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:37:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:37:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:37:56 INFO - (blobuploader) - INFO - Done attempting. 13:37:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:37:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:37:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:37:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:37:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:37:57 INFO - (blobuploader) - INFO - Done attempting. 13:37:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:37:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:37:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:37:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:37:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:37:59 INFO - (blobuploader) - INFO - Done attempting. 13:37:59 INFO - (blobuploader) - INFO - Iteration through files over. 13:37:59 INFO - Return code: 0 13:37:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:37:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:37:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/db21d99b255552d5092fbe2a86cd15bcdf31874c07a8dcaab3409af4030b943fe4fb8fe32f2d669840952c119cd9c143ff95b5401f3290e9a50989dfe91e3d1f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/04d5a37ed4e399d52f2d2c3274d7390b0c11af5faa3cdb24d81cc3ba537e282359fde6651f5ffc88295ad24b239e0c8377ada3497e1c0c2b7f68342fb6fb60a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4bb8b595c9f703409c49bba38cb518f08338728c92a5a2ba4db92d64399d98452b703dc0042af1c3a635a5f190cd6924023608b70a12b804d34f52ed42624815"} 13:37:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:37:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:37:59 INFO - Contents: 13:37:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/db21d99b255552d5092fbe2a86cd15bcdf31874c07a8dcaab3409af4030b943fe4fb8fe32f2d669840952c119cd9c143ff95b5401f3290e9a50989dfe91e3d1f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/04d5a37ed4e399d52f2d2c3274d7390b0c11af5faa3cdb24d81cc3ba537e282359fde6651f5ffc88295ad24b239e0c8377ada3497e1c0c2b7f68342fb6fb60a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4bb8b595c9f703409c49bba38cb518f08338728c92a5a2ba4db92d64399d98452b703dc0042af1c3a635a5f190cd6924023608b70a12b804d34f52ed42624815"} 13:37:59 INFO - Running post-run listener: copy_logs_to_upload_dir 13:37:59 INFO - Copying logs to upload dir... 13:37:59 INFO - mkdir: /builds/slave/test/build/upload/logs 13:37:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.402841 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-10-01 13:37:59.323587) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-01 13:37:59.327203) ========= 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.Sh5roUtZVQ/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.iBAqghRgCr/Listeners TMPDIR=/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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/Mozilla-Aurora/sha512/db21d99b255552d5092fbe2a86cd15bcdf31874c07a8dcaab3409af4030b943fe4fb8fe32f2d669840952c119cd9c143ff95b5401f3290e9a50989dfe91e3d1f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/04d5a37ed4e399d52f2d2c3274d7390b0c11af5faa3cdb24d81cc3ba537e282359fde6651f5ffc88295ad24b239e0c8377ada3497e1c0c2b7f68342fb6fb60a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4bb8b595c9f703409c49bba38cb518f08338728c92a5a2ba4db92d64399d98452b703dc0042af1c3a635a5f190cd6924023608b70a12b804d34f52ed42624815"} build_url:https://queue.taskcluster.net/v1/task/XR_z8aYQS-atyXYG_b8LCg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009953 build_url: 'https://queue.taskcluster.net/v1/task/XR_z8aYQS-atyXYG_b8LCg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/db21d99b255552d5092fbe2a86cd15bcdf31874c07a8dcaab3409af4030b943fe4fb8fe32f2d669840952c119cd9c143ff95b5401f3290e9a50989dfe91e3d1f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/04d5a37ed4e399d52f2d2c3274d7390b0c11af5faa3cdb24d81cc3ba537e282359fde6651f5ffc88295ad24b239e0c8377ada3497e1c0c2b7f68342fb6fb60a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4bb8b595c9f703409c49bba38cb518f08338728c92a5a2ba4db92d64399d98452b703dc0042af1c3a635a5f190cd6924023608b70a12b804d34f52ed42624815"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-01 13:37:59.357376) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 13:37:59.357710) ========= 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.Sh5roUtZVQ/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.iBAqghRgCr/Listeners TMPDIR=/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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.004765 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 13:37:59.406866) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-01 13:37:59.407183) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-01 13:37:59.407502) ========= ========= Total master_lag: 0.16 =========