builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0227 starttime: 1478690764.8 results: success (0) buildid: 20161108173621 builduid: 083c302c289d4fffa60edb78cf695dbd revision: ae3b6bfb810476141647ad681b796ed118062412 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-09 03:26:04.797748) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-09 03:26:04.798241) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-09 03:26:04.798550) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-09 03:26:04.827094) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-09 03:26:04.827407) ========= 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.vy8KqcmGC9/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.5HtjpL18B6/Listeners TMPDIR=/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/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-11-09 03:26:04-- 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: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 24.7M=0s 2016-11-09 03:26:05 (24.7 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.627264 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-09 03:26:05.483588) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-09 03:26:05.483879) ========= 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.vy8KqcmGC9/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.5HtjpL18B6/Listeners TMPDIR=/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/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.025260 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-09 03:26:05.533684) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-09 03:26:05.534012) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ae3b6bfb810476141647ad681b796ed118062412 --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 ae3b6bfb810476141647ad681b796ed118062412 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.vy8KqcmGC9/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.5HtjpL18B6/Listeners TMPDIR=/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/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-11-09 03:26:05,623 truncating revision to first 12 chars 2016-11-09 03:26:05,623 Setting DEBUG logging. 2016-11-09 03:26:05,624 attempt 1/10 2016-11-09 03:26:05,624 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ae3b6bfb8104?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-09 03:26:06,696 unpacking tar archive at: mozilla-aurora-ae3b6bfb8104/testing/mozharness/ program finished with exit code 0 elapsedTime=1.366357 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-09 03:26:06.925697) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-09 03:26:06.926065) ========= script_repo_revision: ae3b6bfb810476141647ad681b796ed118062412 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-09 03:26:06.926540) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-09 03:26:06.926830) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-09 03:26:06.946302) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-11-09 03:26:06.946731) ========= /tools/buildbot/bin/python -u 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', '-u', '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.vy8KqcmGC9/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.5HtjpL18B6/Listeners TMPDIR=/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/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 03:26:07 INFO - MultiFileLogger online at 20161109 03:26:07 in /builds/slave/test 03:26:07 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 03:26:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:26:07 INFO - {'append_to_log': False, 03:26:07 INFO - 'base_work_dir': '/builds/slave/test', 03:26:07 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:26:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:26:07 INFO - 'branch': 'Mozilla-Aurora', 03:26:07 INFO - 'buildbot_json_path': 'buildprops.json', 03:26:07 INFO - 'config_files': ('talos/mac_config.py',), 03:26:07 INFO - 'default_actions': ('clobber', 03:26:07 INFO - 'read-buildbot-config', 03:26:07 INFO - 'download-and-extract', 03:26:07 INFO - 'populate-webroot', 03:26:07 INFO - 'create-virtualenv', 03:26:07 INFO - 'install', 03:26:07 INFO - 'run-tests'), 03:26:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:26:07 INFO - 'download_minidump_stackwalk': True, 03:26:07 INFO - 'download_symbols': 'ondemand', 03:26:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:26:07 INFO - 'tooltool.py': '/tools/tooltool.py', 03:26:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:26:07 INFO - '/tools/misc-python/virtualenv.py')}, 03:26:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:26:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:26:07 INFO - 'installer_path': 'installer.exe', 03:26:07 INFO - 'log_level': 'info', 03:26:07 INFO - 'log_name': 'talos', 03:26:07 INFO - 'log_to_console': True, 03:26:07 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:26:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:26:07 INFO - 'opt_config_files': (), 03:26:07 INFO - 'pip_index': False, 03:26:07 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:26:07 INFO - 'cmd': ('bash', 03:26:07 INFO - '-c', 03:26:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:26:07 INFO - 'enabled': True, 03:26:07 INFO - 'halt_on_failure': False, 03:26:07 INFO - 'name': 'check_screen_resolution'},), 03:26:07 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:26:07 INFO - 'cmd': ('bash', 03:26:07 INFO - '-c', 03:26:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:26:07 INFO - 'enabled': True, 03:26:07 INFO - 'halt_on_failure': False, 03:26:07 INFO - 'name': 'check_screen_resolution'},), 03:26:07 INFO - 'run_cmd_checks_enabled': True, 03:26:07 INFO - 'sps_profile': False, 03:26:07 INFO - 'sps_profile_interval': 0, 03:26:07 INFO - 'suite': 'dromaeojs', 03:26:07 INFO - 'system_bits': '32', 03:26:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:26:07 INFO - 'title': 't-yosemite-r7-0227', 03:26:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:26:07 INFO - 'use_talos_json': True, 03:26:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:26:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:26:07 INFO - 'work_dir': 'build'} 03:26:07 INFO - [mozharness: 2016-11-09 11:26:07.159065Z] Running clobber step. 03:26:07 INFO - Running pre-action listener: _resource_record_pre_action 03:26:07 INFO - Running main action method: clobber 03:26:07 INFO - rmtree: /builds/slave/test/build 03:26:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:26:09 INFO - Running post-action listener: _resource_record_post_action 03:26:09 INFO - [mozharness: 2016-11-09 11:26:09.534893Z] Finished clobber step (success) 03:26:09 INFO - [mozharness: 2016-11-09 11:26:09.535024Z] Running read-buildbot-config step. 03:26:09 INFO - Running pre-action listener: _resource_record_pre_action 03:26:09 INFO - Running main action method: read_buildbot_config 03:26:09 INFO - Using buildbot properties: 03:26:09 INFO - { 03:26:09 INFO - "project": "", 03:26:09 INFO - "product": "firefox", 03:26:09 INFO - "script_repo_revision": "production", 03:26:09 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 03:26:09 INFO - "repository": "", 03:26:09 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 03:26:09 INFO - "buildid": "20161108173621", 03:26:09 INFO - "pgo_build": "False", 03:26:09 INFO - "basedir": "/builds/slave/test", 03:26:09 INFO - "buildnumber": 26, 03:26:09 INFO - "slavename": "t-yosemite-r7-0227", 03:26:09 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 03:26:09 INFO - "platform": "yosemite_r7", 03:26:09 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 03:26:09 INFO - "branch": "mozilla-aurora", 03:26:09 INFO - "repo_path": "releases/mozilla-aurora", 03:26:09 INFO - "revision": "ae3b6bfb810476141647ad681b796ed118062412", 03:26:09 INFO - "stage_platform": "macosx64", 03:26:09 INFO - "builduid": "083c302c289d4fffa60edb78cf695dbd", 03:26:09 INFO - "slavebuilddir": "test" 03:26:09 INFO - } 03:26:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 03:26:09 INFO - Running post-action listener: _resource_record_post_action 03:26:09 INFO - [mozharness: 2016-11-09 11:26:09.538449Z] Finished read-buildbot-config step (success) 03:26:09 INFO - [mozharness: 2016-11-09 11:26:09.538554Z] Running download-and-extract step. 03:26:09 INFO - Running pre-action listener: _resource_record_pre_action 03:26:09 INFO - Running main action method: download_and_extract 03:26:09 INFO - mkdir: /builds/slave/test/build/tests 03:26:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:09 INFO - trying https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 03:26:09 INFO - Downloading https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/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 03:26:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/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 03:26:10 INFO - Downloaded 1199 bytes. 03:26:10 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 03:26:10 INFO - Using the following test package requirements: 03:26:10 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 03:26:10 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:26:10 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 03:26:10 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:26:10 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 03:26:10 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:26:10 INFO - u'jsshell-mac.zip'], 03:26:10 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:26:10 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 03:26:10 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 03:26:10 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:26:10 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 03:26:10 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:26:10 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 03:26:10 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:26:10 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 03:26:10 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:26:10 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 03:26:10 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 03:26:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 03:26:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:26:10 INFO - Fetch https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 03:26:11 INFO - Expected file size: 16423395 03:26:18 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 03:26:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 03:26:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:26:18 INFO - Fetch https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 03:26:18 INFO - Expected file size: 16423395 03:26:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 03:26:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 03:26:25 INFO - Fetch https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 03:26:26 INFO - Expected file size: 14414089 03:26: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')]} 03:26:26 INFO - trying https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:26:26 INFO - Downloading https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 03:26:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/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 03:26:33 INFO - Downloaded 115464056 bytes. 03:26:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:26:33 INFO - mkdir: /builds/slave/test/properties 03:26:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:26:33 INFO - Writing to file /builds/slave/test/properties/build_url 03:26:33 INFO - Contents: 03:26:33 INFO - build_url:https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:26:34 INFO - Running post-action listener: _resource_record_post_action 03:26:34 INFO - Running post-action listener: set_extra_try_arguments 03:26:34 INFO - [mozharness: 2016-11-09 11:26:34.046012Z] Finished download-and-extract step (success) 03:26:34 INFO - [mozharness: 2016-11-09 11:26:34.046131Z] Running populate-webroot step. 03:26:34 INFO - Running pre-action listener: _resource_record_pre_action 03:26:34 INFO - Running main action method: populate_webroot 03:26:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:26:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:26:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:26:34 INFO - '--tppagecycles', 03:26:34 INFO - '7'], 03:26:34 INFO - 'tests': ['tsvgm']}}, 03:26:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:26:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:26:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:26:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:26:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:26:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:26:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:34 INFO - 'talos_options': ['--disable-e10s'], 03:26:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:26:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:26:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:34 INFO - 'talos_options': ['--disable-e10s'], 03:26:34 INFO - 'tests': ['damp', 'tps']}, 03:26:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:34 INFO - 'tests': ['damp', 'tps']}, 03:26:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:26:34 INFO - 'tests': ['dromaeo_dom']}, 03:26:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:26:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:26:34 INFO - 'tests': ['basic_compositor_video']}, 03:26:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:26:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:26:34 INFO - 'tests': ['a11yr', 03:26:34 INFO - 'ts_paint', 03:26:34 INFO - 'tpaint', 03:26:34 INFO - 'sessionrestore', 03:26:34 INFO - 'sessionrestore_no_auto_restore', 03:26:34 INFO - 'tabpaint']}, 03:26:34 INFO - 'other-e10s': {'tests': ['a11yr', 03:26:34 INFO - 'ts_paint', 03:26:34 INFO - 'tpaint', 03:26:34 INFO - 'sessionrestore', 03:26:34 INFO - 'sessionrestore_no_auto_restore', 03:26:34 INFO - 'tabpaint']}, 03:26:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:26:34 INFO - 'ts_paint', 03:26:34 INFO - 'tpaint', 03:26:34 INFO - 'sessionrestore', 03:26:34 INFO - 'sessionrestore_no_auto_restore', 03:26:34 INFO - 'tabpaint']}, 03:26:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:26:34 INFO - 'ts_paint', 03:26:34 INFO - 'tpaint', 03:26:34 INFO - 'sessionrestore', 03:26:34 INFO - 'sessionrestore_no_auto_restore', 03:26:34 INFO - 'tabpaint']}, 03:26:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:26:34 INFO - 'tests': ['a11yr', 03:26:34 INFO - 'ts_paint', 03:26:34 INFO - 'tpaint', 03:26:34 INFO - 'sessionrestore', 03:26:34 INFO - 'sessionrestore_no_auto_restore', 03:26:34 INFO - 'tabpaint']}, 03:26:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:26:34 INFO - 'tests': ['a11yr', 03:26:34 INFO - 'ts_paint', 03:26:34 INFO - 'tpaint', 03:26:34 INFO - 'sessionrestore', 03:26:34 INFO - 'sessionrestore_no_auto_restore', 03:26:34 INFO - 'tabpaint']}, 03:26:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:26:34 INFO - 'tests': ['tsvgx', 03:26:34 INFO - 'tsvgr_opacity', 03:26:34 INFO - 'tart', 03:26:34 INFO - 'tscrollx', 03:26:34 INFO - 'cart']}, 03:26:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:26:34 INFO - 'tsvgr_opacity', 03:26:34 INFO - 'tart', 03:26:34 INFO - 'tscrollx', 03:26:34 INFO - 'cart']}, 03:26:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:34 INFO - 'talos_options': ['--disable-e10s'], 03:26:34 INFO - 'tests': ['tp5o']}, 03:26:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:34 INFO - 'tests': ['tp5o']}, 03:26:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:34 INFO - 'talos_options': ['--disable-e10s', 03:26:34 INFO - '--xperf_path', 03:26:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:26:34 INFO - 'tests': ['tp5n']}, 03:26:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:34 INFO - 'talos_options': ['--xperf_path', 03:26:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:26:34 INFO - 'tests': ['tp5n']}}, 03:26:34 INFO - 'talos.zip': {'path': '', 03:26:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:26:34 INFO - Running post-action listener: _resource_record_post_action 03:26:34 INFO - [mozharness: 2016-11-09 11:26:34.065085Z] Finished populate-webroot step (success) 03:26:34 INFO - [mozharness: 2016-11-09 11:26:34.065200Z] Running create-virtualenv step. 03:26:34 INFO - Running pre-action listener: _resource_record_pre_action 03:26:34 INFO - Running main action method: create_virtualenv 03:26:34 INFO - Creating virtualenv /builds/slave/test/build/venv 03:26:34 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 03:26:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:26:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:26:34 INFO - Using real prefix '/tools/python27' 03:26:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:26:34 INFO - Installing distribute.............................................................................................................................................................................................done. 03:26:37 INFO - Installing pip.................done. 03:26:37 INFO - Return code: 0 03:26:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:26:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1102a6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11021c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85e9d96fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100bad30>, '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 0x10ff20db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100b2b20>, '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.vy8KqcmGC9/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.5HtjpL18B6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/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 03:26:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:26:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:26:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vy8KqcmGC9/Render', 03:26:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:26:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:26:37 INFO - 'HOME': '/Users/cltbld', 03:26:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:26:37 INFO - 'LOGNAME': 'cltbld', 03:26:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:37 INFO - 'MOZ_NO_REMOTE': '1', 03:26:37 INFO - 'NO_EM_RESTART': '1', 03:26:37 INFO - 'PAGER': '/bin/cat', 03:26:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:26:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:37 INFO - 'PWD': '/builds/slave/test', 03:26:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:26:37 INFO - 'SHELL': '/bin/bash', 03:26:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5HtjpL18B6/Listeners', 03:26:37 INFO - 'TMPDIR': '/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/', 03:26:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:26:37 INFO - 'USER': 'cltbld', 03:26:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:26:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:26:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:37 INFO - 'XPC_FLAGS': '0x0', 03:26:37 INFO - 'XPC_SERVICE_NAME': '0', 03:26:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:26:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:38 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 03:26:38 INFO - Cleaning up... 03:26:38 INFO - Return code: 0 03:26:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:26:38 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')]} 03:26:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:38 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')]} 03:26:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:38 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 0x1102a6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11021c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85e9d96fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100bad30>, '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 0x10ff20db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100b2b20>, '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.vy8KqcmGC9/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.5HtjpL18B6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/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 03:26:38 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 03:26:38 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 03:26:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vy8KqcmGC9/Render', 03:26:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:26:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:26:38 INFO - 'HOME': '/Users/cltbld', 03:26:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:26:38 INFO - 'LOGNAME': 'cltbld', 03:26:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:38 INFO - 'MOZ_NO_REMOTE': '1', 03:26:38 INFO - 'NO_EM_RESTART': '1', 03:26:38 INFO - 'PAGER': '/bin/cat', 03:26:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:26:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:38 INFO - 'PWD': '/builds/slave/test', 03:26:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:26:38 INFO - 'SHELL': '/bin/bash', 03:26:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5HtjpL18B6/Listeners', 03:26:38 INFO - 'TMPDIR': '/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/', 03:26:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:26:38 INFO - 'USER': 'cltbld', 03:26:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:26:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:26:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:38 INFO - 'XPC_FLAGS': '0x0', 03:26:38 INFO - 'XPC_SERVICE_NAME': '0', 03:26:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:26:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:38 INFO - Downloading/unpacking psutil>=3.1.1 03:26:38 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 03:26:38 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 03:26:38 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 03:26:38 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 03:26:38 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 03:26:38 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 03:26:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:26:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:26:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:26:41 INFO - Installing collected packages: psutil 03:26:41 INFO - Running setup.py install for psutil 03:26:41 INFO - building 'psutil._psutil_osx' extension 03:26:41 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 03:26:42 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 03:26:42 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 03:26:42 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 03:26:42 INFO - building 'psutil._psutil_posix' extension 03:26:42 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 03:26:42 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:26:42 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:26:42 INFO - ^ 03:26:42 INFO - 1 warning generated. 03:26:42 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 03:26:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:26:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:26:42 INFO - Successfully installed psutil 03:26:42 INFO - Cleaning up... 03:26:42 INFO - Return code: 0 03:26:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:26:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:42 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 0x1102a6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11021c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85e9d96fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100bad30>, '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 0x10ff20db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100b2b20>, '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.vy8KqcmGC9/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.5HtjpL18B6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/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 03:26:42 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 03:26:42 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 03:26:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vy8KqcmGC9/Render', 03:26:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:26:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:26:42 INFO - 'HOME': '/Users/cltbld', 03:26:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:26:42 INFO - 'LOGNAME': 'cltbld', 03:26:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:42 INFO - 'MOZ_NO_REMOTE': '1', 03:26:42 INFO - 'NO_EM_RESTART': '1', 03:26:42 INFO - 'PAGER': '/bin/cat', 03:26:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:26:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:42 INFO - 'PWD': '/builds/slave/test', 03:26:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:26:42 INFO - 'SHELL': '/bin/bash', 03:26:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5HtjpL18B6/Listeners', 03:26:42 INFO - 'TMPDIR': '/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/', 03:26:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:26:42 INFO - 'USER': 'cltbld', 03:26:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:26:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:26:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:42 INFO - 'XPC_FLAGS': '0x0', 03:26:42 INFO - 'XPC_SERVICE_NAME': '0', 03:26:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:26:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:26: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 03:26: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 03:26: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 03:26: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 03:26: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 03:26: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 03:26:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:26:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:26:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:26:45 INFO - Installing collected packages: mozsystemmonitor 03:26:45 INFO - Running setup.py install for mozsystemmonitor 03:26:45 INFO - Successfully installed mozsystemmonitor 03:26:45 INFO - Cleaning up... 03:26:45 INFO - Return code: 0 03:26:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:26: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')]} 03:26:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26: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')]} 03:26:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1102a6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11021c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85e9d96fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100bad30>, '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 0x10ff20db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100b2b20>, '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.vy8KqcmGC9/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.5HtjpL18B6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/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 03:26: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==2.5.1'] in /builds/slave/test/build 03:26: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==2.5.1 03:26:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vy8KqcmGC9/Render', 03:26:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:26:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:26:45 INFO - 'HOME': '/Users/cltbld', 03:26:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:26:45 INFO - 'LOGNAME': 'cltbld', 03:26:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:45 INFO - 'MOZ_NO_REMOTE': '1', 03:26:45 INFO - 'NO_EM_RESTART': '1', 03:26:45 INFO - 'PAGER': '/bin/cat', 03:26:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:26:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:45 INFO - 'PWD': '/builds/slave/test', 03:26:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:26:45 INFO - 'SHELL': '/bin/bash', 03:26:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5HtjpL18B6/Listeners', 03:26:45 INFO - 'TMPDIR': '/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/', 03:26:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:26:45 INFO - 'USER': 'cltbld', 03:26:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:26:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:26:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:45 INFO - 'XPC_FLAGS': '0x0', 03:26:45 INFO - 'XPC_SERVICE_NAME': '0', 03:26:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:26:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:45 INFO - Downloading/unpacking jsonschema==2.5.1 03:26:45 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 03:26:45 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 03:26:45 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 03:26:45 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 03:26:45 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 03:26:45 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 03:26:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:26:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:26:48 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 03:26:48 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 03:26:48 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 03:26:48 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 03:26:48 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 03:26:48 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 03:26:48 INFO - Downloading functools32-3.2.3-2.tar.gz 03:26:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:26:48 INFO - warning: no files found matching '*.txt' 03:26:48 INFO - no previously-included directories found matching 'build' 03:26:48 INFO - no previously-included directories found matching 'dist' 03:26:48 INFO - no previously-included directories found matching '.git*' 03:26:49 INFO - Installing collected packages: jsonschema, functools32 03:26:49 INFO - Running setup.py install for functools32 03:26:49 INFO - warning: no files found matching '*.txt' 03:26:49 INFO - no previously-included directories found matching 'build' 03:26:49 INFO - no previously-included directories found matching 'dist' 03:26:49 INFO - no previously-included directories found matching '.git*' 03:26:49 INFO - Successfully installed jsonschema functools32 03:26:49 INFO - Cleaning up... 03:26:49 INFO - Return code: 0 03:26:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:26:49 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')]} 03:26:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:49 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')]} 03:26:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:49 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 0x1102a6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11021c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85e9d96fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100bad30>, '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 0x10ff20db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100b2b20>, '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.vy8KqcmGC9/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.5HtjpL18B6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/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 03:26:49 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 03:26:49 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 03:26:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vy8KqcmGC9/Render', 03:26:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:26:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:26:49 INFO - 'HOME': '/Users/cltbld', 03:26:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:26:49 INFO - 'LOGNAME': 'cltbld', 03:26:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:49 INFO - 'MOZ_NO_REMOTE': '1', 03:26:49 INFO - 'NO_EM_RESTART': '1', 03:26:49 INFO - 'PAGER': '/bin/cat', 03:26:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:26:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:49 INFO - 'PWD': '/builds/slave/test', 03:26:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:26:49 INFO - 'SHELL': '/bin/bash', 03:26:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5HtjpL18B6/Listeners', 03:26:49 INFO - 'TMPDIR': '/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/', 03:26:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:26:49 INFO - 'USER': 'cltbld', 03:26:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:26:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:26:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:49 INFO - 'XPC_FLAGS': '0x0', 03:26:49 INFO - 'XPC_SERVICE_NAME': '0', 03:26:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:26:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:26:49 INFO - Cleaning up... 03:26:49 INFO - Return code: 0 03:26:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:26:49 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')]} 03:26:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:49 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')]} 03:26:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:49 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 0x1102a6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11021c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85e9d96fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100bad30>, '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 0x10ff20db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100b2b20>, '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.vy8KqcmGC9/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.5HtjpL18B6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/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 03:26:49 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 03:26:49 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 03:26:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vy8KqcmGC9/Render', 03:26:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:26:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:26:49 INFO - 'HOME': '/Users/cltbld', 03:26:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:26:49 INFO - 'LOGNAME': 'cltbld', 03:26:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:49 INFO - 'MOZ_NO_REMOTE': '1', 03:26:49 INFO - 'NO_EM_RESTART': '1', 03:26:49 INFO - 'PAGER': '/bin/cat', 03:26:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:26:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:49 INFO - 'PWD': '/builds/slave/test', 03:26:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:26:49 INFO - 'SHELL': '/bin/bash', 03:26:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5HtjpL18B6/Listeners', 03:26:49 INFO - 'TMPDIR': '/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/', 03:26:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:26:49 INFO - 'USER': 'cltbld', 03:26:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:26:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:26:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:49 INFO - 'XPC_FLAGS': '0x0', 03:26:49 INFO - 'XPC_SERVICE_NAME': '0', 03:26:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:26:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:49 INFO - Downloading/unpacking blobuploader==1.2.4 03:26:49 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 03:26:49 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 03:26:49 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 03:26:49 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 03:26:49 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 03:26:49 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 03:26:52 INFO - Downloading blobuploader-1.2.4.tar.gz 03:26:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:26:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:26:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:26:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:26:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:53 INFO - Downloading docopt-0.6.1.tar.gz 03:26:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:26:53 INFO - Installing collected packages: blobuploader, requests, docopt 03:26:53 INFO - Running setup.py install for blobuploader 03:26:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:26:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:26:53 INFO - Running setup.py install for requests 03:26:54 INFO - Running setup.py install for docopt 03:26:54 INFO - Successfully installed blobuploader requests docopt 03:26:54 INFO - Cleaning up... 03:26:54 INFO - Return code: 0 03:26:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:26: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')]} 03:26:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26: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')]} 03:26:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:54 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 0x1102a6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11021c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85e9d96fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100bad30>, '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 0x10ff20db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100b2b20>, '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.vy8KqcmGC9/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.5HtjpL18B6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/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 03:26:54 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 03:26:54 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 03:26:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vy8KqcmGC9/Render', 03:26:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:26:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:26:54 INFO - 'HOME': '/Users/cltbld', 03:26:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:26:54 INFO - 'LOGNAME': 'cltbld', 03:26:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:54 INFO - 'MOZ_NO_REMOTE': '1', 03:26:54 INFO - 'NO_EM_RESTART': '1', 03:26:54 INFO - 'PAGER': '/bin/cat', 03:26:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:26:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:54 INFO - 'PWD': '/builds/slave/test', 03:26:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:26:54 INFO - 'SHELL': '/bin/bash', 03:26:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5HtjpL18B6/Listeners', 03:26:54 INFO - 'TMPDIR': '/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/', 03:26:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:26:54 INFO - 'USER': 'cltbld', 03:26:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:26:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:26:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:54 INFO - 'XPC_FLAGS': '0x0', 03:26:54 INFO - 'XPC_SERVICE_NAME': '0', 03:26:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:26:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:26:54 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-wWdeja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:26:54 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-1gfF7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:26:55 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-hm90p6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:26:55 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-SxTtLz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:26:55 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-OWPPBi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:26:55 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-1Pzsuo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:26:55 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-DhwByG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:26:55 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-YEVHCH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:26:55 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-gRYDm1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:26:55 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-U7nnKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:26:55 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-tpQvkD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:26:56 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-y6D9se-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:26:56 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-bXNIB8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:26:56 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-CHijsz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:56 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-3wnpIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:26:56 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-e2LAnn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:26:56 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-40l3G1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:26:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:26:56 INFO - Running setup.py install for manifestparser 03:26:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:26:56 INFO - Running setup.py install for mozcrash 03:26:56 INFO - Running setup.py install for mozdebug 03:26:57 INFO - Running setup.py install for mozdevice 03:26:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:26:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:26:57 INFO - Running setup.py install for mozfile 03:26:57 INFO - Running setup.py install for mozhttpd 03:26:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:26:57 INFO - Running setup.py install for mozinfo 03:26:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:26:57 INFO - Running setup.py install for mozInstall 03:26:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:26:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:26:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:26:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:26:57 INFO - Running setup.py install for mozleak 03:26:57 INFO - Running setup.py install for mozlog 03:26:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:26:58 INFO - Running setup.py install for moznetwork 03:26:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:26:58 INFO - Running setup.py install for mozprocess 03:26:58 INFO - Running setup.py install for mozprofile 03:26:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:26:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:26:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:26:58 INFO - Running setup.py install for mozrunner 03:26:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:26:58 INFO - Running setup.py install for mozscreenshot 03:26:58 INFO - Running setup.py install for moztest 03:26:59 INFO - Running setup.py install for mozversion 03:26:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:26:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:26:59 INFO - Cleaning up... 03:26:59 INFO - Return code: 0 03:26:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:26:59 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')]} 03:26:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:59 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')]} 03:26:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:59 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 0x1102a6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11021c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85e9d96fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100bad30>, '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 0x10ff20db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100b2b20>, '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.vy8KqcmGC9/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.5HtjpL18B6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/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 03:26:59 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 03:26:59 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 03:26:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vy8KqcmGC9/Render', 03:26:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:26:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:26:59 INFO - 'HOME': '/Users/cltbld', 03:26:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:26:59 INFO - 'LOGNAME': 'cltbld', 03:26:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:59 INFO - 'MOZ_NO_REMOTE': '1', 03:26:59 INFO - 'NO_EM_RESTART': '1', 03:26:59 INFO - 'PAGER': '/bin/cat', 03:26:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:26:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:59 INFO - 'PWD': '/builds/slave/test', 03:26:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:26:59 INFO - 'SHELL': '/bin/bash', 03:26:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5HtjpL18B6/Listeners', 03:26:59 INFO - 'TMPDIR': '/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/', 03:26:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:26:59 INFO - 'USER': 'cltbld', 03:26:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:26:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:26:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:59 INFO - 'XPC_FLAGS': '0x0', 03:26:59 INFO - 'XPC_SERVICE_NAME': '0', 03:26:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:26:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:26:59 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-5jhJyP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:26:59 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)) 03:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:26:59 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-1n_Ktf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:26:59 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)) 03:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:26:59 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-cOhm9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:26:59 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)) 03:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:26:59 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-RO7Nor-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:26:59 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)) 03:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:26:59 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-bi6Ing-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:27:00 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)) 03:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:27:00 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-55015q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:27:00 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)) 03:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:27:00 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-iARr8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:27:00 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)) 03:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:27:00 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-5m8STk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:27:00 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)) 03:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:27:00 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-jvL6V9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:27:00 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)) 03:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:27:00 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-wkVhAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:27:00 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)) 03:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:27:00 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-pFVSVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:27:00 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)) 03:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:27:00 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-BjMa5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:27:00 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)) 03:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:27:00 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-fFsPyW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:27:00 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)) 03:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:27:00 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-dgmPzt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:27:01 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)) 03:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:27:01 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-lEw2f_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:27:01 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)) 03:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:27:01 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-6Xg5e9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:27:01 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)) 03:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:27:01 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-bReCwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:27:01 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)) 03:27:01 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)) 03:27:01 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)) 03:27:01 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)) 03:27:01 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)) 03:27:01 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)) 03:27:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:03 INFO - Downloading blessings-1.6.tar.gz 03:27:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:27:03 INFO - Installing collected packages: blessings 03:27:03 INFO - Running setup.py install for blessings 03:27:04 INFO - Successfully installed blessings 03:27:04 INFO - Cleaning up... 03:27:04 INFO - Return code: 0 03:27:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:27:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:27:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:27:04 INFO - Reading from file tmpfile_stdout 03:27:04 INFO - Current package versions: 03:27:04 INFO - blessings == 1.6 03:27:04 INFO - blobuploader == 1.2.4 03:27:04 INFO - docopt == 0.6.1 03:27:04 INFO - functools32 == 3.2.3-2 03:27:04 INFO - jsonschema == 2.5.1 03:27:04 INFO - manifestparser == 1.1 03:27:04 INFO - mozInstall == 1.12 03:27:04 INFO - mozcrash == 0.17 03:27:04 INFO - mozdebug == 0.1 03:27:04 INFO - mozdevice == 0.48 03:27:04 INFO - mozfile == 1.2 03:27:04 INFO - mozhttpd == 0.7 03:27:04 INFO - mozinfo == 0.9 03:27:04 INFO - mozleak == 0.1 03:27:04 INFO - mozlog == 3.4 03:27:04 INFO - moznetwork == 0.27 03:27:04 INFO - mozprocess == 0.23 03:27:04 INFO - mozprofile == 0.28 03:27:04 INFO - mozrunner == 6.12 03:27:04 INFO - mozscreenshot == 0.1 03:27:04 INFO - mozsystemmonitor == 0.3 03:27:04 INFO - moztest == 0.7 03:27:04 INFO - mozversion == 1.4 03:27:04 INFO - psutil == 3.1.1 03:27:04 INFO - requests == 1.2.3 03:27:04 INFO - wsgiref == 0.1.2 03:27:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:27:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:27:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:27:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:04 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 0x1102a6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11021c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85e9d96fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100bad30>, '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 0x10ff20db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100b2b20>, '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.vy8KqcmGC9/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.5HtjpL18B6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/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 03:27:04 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 03:27:04 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 03:27:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vy8KqcmGC9/Render', 03:27:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:27:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:27:04 INFO - 'HOME': '/Users/cltbld', 03:27:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:27:04 INFO - 'LOGNAME': 'cltbld', 03:27:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:04 INFO - 'MOZ_NO_REMOTE': '1', 03:27:04 INFO - 'NO_EM_RESTART': '1', 03:27:04 INFO - 'PAGER': '/bin/cat', 03:27:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:27:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:04 INFO - 'PWD': '/builds/slave/test', 03:27:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:27:04 INFO - 'SHELL': '/bin/bash', 03:27:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5HtjpL18B6/Listeners', 03:27:04 INFO - 'TMPDIR': '/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/', 03:27:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:27:04 INFO - 'USER': 'cltbld', 03:27:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:27:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:27:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:04 INFO - 'XPC_FLAGS': '0x0', 03:27:04 INFO - 'XPC_SERVICE_NAME': '0', 03:27:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:27:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:04 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)) 03:27:04 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)) 03:27:04 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)) 03:27:04 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)) 03:27:04 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)) 03:27:04 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)) 03:27:04 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)) 03:27:04 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)) 03:27:04 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)) 03:27:04 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)) 03:27:04 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)) 03:27:04 INFO - Cleaning up... 03:27:04 INFO - Return code: 0 03:27:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:27:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:27:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:27:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:04 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 0x1102a6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11021c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85e9d96fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100bad30>, '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 0x10ff20db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100b2b20>, '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.vy8KqcmGC9/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.5HtjpL18B6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/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 03:27:04 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 03:27:04 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 03:27:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vy8KqcmGC9/Render', 03:27:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:27:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:27:04 INFO - 'HOME': '/Users/cltbld', 03:27:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:27:04 INFO - 'LOGNAME': 'cltbld', 03:27:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:04 INFO - 'MOZ_NO_REMOTE': '1', 03:27:04 INFO - 'NO_EM_RESTART': '1', 03:27:04 INFO - 'PAGER': '/bin/cat', 03:27:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:27:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:04 INFO - 'PWD': '/builds/slave/test', 03:27:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:27:04 INFO - 'SHELL': '/bin/bash', 03:27:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5HtjpL18B6/Listeners', 03:27:04 INFO - 'TMPDIR': '/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/', 03:27:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:27:04 INFO - 'USER': 'cltbld', 03:27:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:27:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:27:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:04 INFO - 'XPC_FLAGS': '0x0', 03:27:04 INFO - 'XPC_SERVICE_NAME': '0', 03:27:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:27:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:27:05 INFO - Cleaning up... 03:27:05 INFO - Return code: 0 03:27:05 INFO - Running post-action listener: _resource_record_post_action 03:27:05 INFO - Running post-action listener: _start_resource_monitoring 03:27:05 INFO - Starting resource monitoring. 03:27:05 INFO - [mozharness: 2016-11-09 11:27:05.050988Z] Finished create-virtualenv step (success) 03:27:05 INFO - [mozharness: 2016-11-09 11:27:05.051951Z] Running install step. 03:27:05 INFO - Running pre-action listener: _resource_record_pre_action 03:27:05 INFO - Running main action method: install 03:27:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:27:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:27:05 INFO - Reading from file tmpfile_stdout 03:27:05 INFO - Detecting whether we're running mozinstall >=1.0... 03:27:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:27:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:27:05 INFO - Reading from file tmpfile_stdout 03:27:05 INFO - Output received: 03:27:05 INFO - Usage: mozinstall [options] installer 03:27:05 INFO - Options: 03:27:05 INFO - -h, --help show this help message and exit 03:27:05 INFO - -d DEST, --destination=DEST 03:27:05 INFO - Directory to install application into. [default: 03:27:05 INFO - "/builds/slave/test"] 03:27:05 INFO - --app=APP Application being installed. [default: firefox] 03:27:05 INFO - mkdir: /builds/slave/test/build/application 03:27:05 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'] 03:27:05 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 03:27:38 INFO - Reading from file tmpfile_stdout 03:27:38 INFO - Output received: 03:27:38 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 03:27:38 INFO - Running post-action listener: _resource_record_post_action 03:27:38 INFO - [mozharness: 2016-11-09 11:27:38.038497Z] Finished install step (success) 03:27:38 INFO - [mozharness: 2016-11-09 11:27:38.038624Z] Running run-tests step. 03:27:38 INFO - Running pre-action listener: _resource_record_pre_action 03:27:38 INFO - Running main action method: run_tests 03:27:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:27:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:27:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:27:38 INFO - 2016-11-09 03:27:38.051 screenresolution[1650:8616] starting screenresolution argv=screenresolution get 03:27:38 INFO - 2016-11-09 03:27:38.053 screenresolution[1650:8616] Display 0: 1600x1200x32@60 03:27:38 INFO - 2016-11-09 03:27:38.058 screenresolution[1651:8618] starting screenresolution argv=screenresolution list 03:27:38 INFO - Available Modes on Display 0 03:27:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:27:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:27:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:27:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:27:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:27:38 INFO - Intel Iris: 03:27:38 INFO - Chipset Model: Intel Iris 03:27:38 INFO - Type: GPU 03:27:38 INFO - Bus: Built-In 03:27:38 INFO - VRAM (Dynamic, Max): 1536 MB 03:27:38 INFO - Vendor: Intel (0x8086) 03:27:38 INFO - Device ID: 0x0a2e 03:27:38 INFO - Revision ID: 0x0009 03:27:38 INFO - Displays: 03:27:38 INFO - Display: 03:27:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:27:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:27:38 INFO - Display Serial Number: 1600x1200 60 03:27:38 INFO - Main Display: Yes 03:27:38 INFO - Mirror: Off 03:27:38 INFO - Online: Yes 03:27:38 INFO - Rotation: Supported 03:27:38 INFO - Return code: 0 03:27:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:27:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:27:38 INFO - Python 2.7.3 03:27:38 INFO - Return code: 0 03:27:38 INFO - grabbing minidump binary from tooltool 03:27:38 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')]} 03:27:38 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 0x1100bad30>, '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 0x10ff20db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100b2b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:27:38 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 03:27:38 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 03:27:38 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 03:27:38 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:27:38 INFO - Return code: 0 03:27:38 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:27:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:27:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:27:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:27:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:27:38 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/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0227', '--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 03:27:38 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/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0227 --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 03:27:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vy8KqcmGC9/Render', 03:27:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:27:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:27:38 INFO - 'HOME': '/Users/cltbld', 03:27:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:27:38 INFO - 'LOGNAME': 'cltbld', 03:27:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:27:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:27:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:38 INFO - 'MOZ_NO_REMOTE': '1', 03:27:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:27:38 INFO - 'NO_EM_RESTART': '1', 03:27:38 INFO - 'PAGER': '/bin/cat', 03:27:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:27:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:38 INFO - 'PWD': '/builds/slave/test', 03:27:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:27:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:27:38 INFO - 'SHELL': '/bin/bash', 03:27:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5HtjpL18B6/Listeners', 03:27:38 INFO - 'TMPDIR': '/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/', 03:27:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:27:38 INFO - 'USER': 'cltbld', 03:27:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:27:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:27:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:38 INFO - 'XPC_FLAGS': '0x0', 03:27:38 INFO - 'XPC_SERVICE_NAME': '0', 03:27:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:27:38 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/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0227', '--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 03:27:38 INFO - mozversion application_buildid: 20161108173621 03:27:38 INFO - mozversion application_changeset: ae3b6bfb810476141647ad681b796ed118062412 03:27:38 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:27:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:27:38 INFO - mozversion application_name: Firefox 03:27:38 INFO - mozversion application_remotingname: firefox-dev 03:27:38 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:27:38 INFO - mozversion application_vendor: Mozilla 03:27:38 INFO - mozversion application_version: 51.0a2 03:27:38 INFO - mozversion platform_buildid: 20161108173621 03:27:38 INFO - mozversion platform_changeset: ae3b6bfb810476141647ad681b796ed118062412 03:27:38 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:27:38 INFO - mozversion platform_version: 51.0a2 03:27:38 INFO - using testdate: 1478690858 03:27:38 INFO - actual date: 1478690858 03:27:38 INFO - starting webserver on 'localhost:49284' 03:27:38 INFO - SUITE-START | Running 2 tests 03:27:38 INFO - TEST-START | dromaeo_css 03:27:38 INFO - operating with platform_type : mac_ 03:27:38 INFO - Initialising browser for dromaeo_css test... 03:27:38 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/tmp3sd9lE/profile http://localhost:49284/getInfo.html) 03:27:41 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 03:27:41 INFO - PROCESS | 1661 | colorDepth:24 03:27:41 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 03:27:41 INFO - PROCESS | 1661 | __metrics 03:27:41 INFO - PROCESS | 1661 | 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" 03:27:41 INFO - PROCESS | 1661 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:27:42 INFO - TEST-INFO | 1661: exit 0 03:27:42 INFO - Browser initialized. 03:27:42 INFO - Running cycle 1/1 for dromaeo_css test... 03:27:42 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/tmp3sd9lE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:27:54 INFO - PROCESS | 1665 | RSS: Main: 219570176 03:27:54 INFO - PROCESS | 1665 | 03:28:44 INFO - PROCESS | 1665 | 1478690924990 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] 03:30:57 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49284/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49284/tests/dromaeo/cssquery-ext.html) 03:30:58 INFO - PROCESS | 1665 | RSS: Main: 363134976 03:30:58 INFO - PROCESS | 1665 | 03:34:01 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49284/tests/dromaeo/cssquery-ext.html (next: http://localhost:49284/tests/dromaeo/cssquery-jquery.html) 03:34:02 INFO - PROCESS | 1665 | RSS: Main: 351002624 03:34:02 INFO - PROCESS | 1665 | 03:37:04 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49284/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49284/tests/dromaeo/cssquery-mootools.html) 03:37:05 INFO - PROCESS | 1665 | RSS: Main: 328630272 03:37:05 INFO - PROCESS | 1665 | 03:40:07 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49284/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49284/tests/dromaeo/cssquery-prototype.html) 03:40:08 INFO - PROCESS | 1665 | RSS: Main: 326316032 03:40:08 INFO - PROCESS | 1665 | 03:43:11 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49284/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49284/tests/dromaeo/cssquery-yui.html) 03:43:12 INFO - PROCESS | 1665 | RSS: Main: 313729024 03:43:12 INFO - PROCESS | 1665 | 03:46:15 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49284/tests/dromaeo/cssquery-yui.html (next: http://localhost:49284/tests/dromaeo/cssquery-dojo.html) 03:46:15 INFO - PROCESS | 1665 | RSS: Main: 404307968 03:46:15 INFO - PROCESS | 1665 | 03:46:15 INFO - PROCESS | 1665 | __start_tp_report 03:46:15 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 03:46:15 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 03:46:15 INFO - PROCESS | 1665 | |i|pagename|runs| 03:46:15 INFO - PROCESS | 1665 | |0;dojo.html;2554.7189809120982;2774.5144599695054;3347.581552305962;3379;3397.388470075387;5653.943460565393;5754.079347304432;5757.539396848252;5769.509591684707;5784.623999440033;5658.151277308406;5745.770169193227;5757.078867381219;5760.539156867451;5785.450382213683;5188.16989281715;5213.2701421800975;5235;5235.978984098102;5297.47025297471;5177.223416487519;5187.714675692835;5189.377274727038;5344.732763361836;5383.703896285702;4294.5490723473895;5215.295935048758;5221.347331583552;5235.476452354772;5261.053010458116;5270.130428479296;5272.789088436458;5273.077211487975;5296.103986792135;5310.150375939869;5173.767180476888;5204.531592156724;5240.6069544784295;5256.053910296145;5283;5603.2715746953045;5634.521065709419;5653.293338332708;5655.5475561954945;5661.2357331760095;6117.825149509779;6204.348543402968;6205.913965056097;6212.943799554087;6232.158658581079;6206.25524937006;6302.684865756693;6309.4636955858805;6315.8736825263695;6316.715747791361;5658;5691.9146212806845;5716;5788.710564471759;5819.854503637401;6272.655003974825;6292.339304373067;6294.842628934313;6300.779472718433;6314.842128946813;6149.5080393568405;6174.25908890927;6184.165137706442;6188.690565471708;6196.411340922605;5226.425093239741;6110.388961103854;6175.795719834679;6183.227096612924;6269.373062693694;6142.692865356715;6147.66187859663;6149.985252433298;6153.2616086069065;6156.846078848064;5163.690178589297;6102.428659372087;6211.472024877936;6230.875382492325;6263.279722831932;4880.560749532488;4887.828925987574;4888.877778055577;4908.092002979461;4922.409310882717;4430.42404487421;4462.977685111554;4482.574155455227;4500.797464114123;4534.818607255739;5700.686462244616;5707.543396528268;5762;5772.3938986406665;5801.593888427769;6258.311585725566;6263.404976527223;6275.3724627536885;6280.685965701697;6291.748330066837;5725.770969161187;5736.569757268222;5746.02317606008;5753.741081651336;5762.135679648086;5321.893562128813;5365.356157261153;5369.5167434931045;5382.892342153135;5385.569154467633;6257.311695713559;6270.059491076284;6289.9371006291185;6305.873882522415;6324.367563243639;6236.875262494634;6253.593516421418;6264.248290205022;6264.279607844974;6270.968645156745;6209.813705588839;6226.906596401148;6278.843028924313;6292.716827742671;6296.811095667137;6079.240094988127;6097.7865774697675;6111.37903775109;6202.100695399232;6207.689615519296;6257.906131408124;6271.937280627135;6272.247330320391;6273.749050037947;6304.810855674337;5881.588288819741;6054.303755068224;6105.9084113737445;6114.847128821815;6126.479249263684;4834.951650483591;5928.703564821655;6031.4270144336215;6051.062085376773;6051.243594550681;5840.123981402823;5852.502537284208;5882.205902203148;5950.464458198783;5959.106134079922;6151.861905547488;6175.876482470415;6183.474404675473;6187.721552530057;6189.876202476015;6006.399360063959;6006.639601623917;6017.729202185999;6043.214382130295;6062.605930614496 03:46:15 INFO - PROCESS | 1665 | |1;ext.html;505.2169137836354;519.3974989012746;521.0932976620679;523.7171927159334;525.9737013149341;30274;31068;31463.52804707931;40307.19385612286;41164.588354116524;42274.67489288088;43209.567904320946;43705.34441983365;43730.34404483927;43799.56200437995;9659.227261819055;9800;9800.852987205197;9815.116639502443;9829.361091529063;8676.566171691422;8880.822383552326;9742.366746161477;9884.654037108703;11876.10929180315;11820.58627948022;12135.635930922086;12142.696432589211;12150.817737733942;12169.513219471255;12152.331621760799;12221.63335099944;12231.082668799787;12240.755184896252;12272.570460033945;8660.004099528573;8863.601137948743;11577.9579837815;11866.228695134874;11924.105692073043;41244.79377603093;41516.584834151574;41568.752937411926;41627;41676;3333.4833100869405;3385.4075536780965;3539.557555305587;3922.3920292354733;4001.4998125234347;29278.70721292781;29780.851095744598;30550.847245763627;32210.87261945844;32308.676913230804;3156.6054243219596;3253.268014696698;3264.967350326514;3300.14196308959;3414.96585034149;520044;523555;524381;524909;527488.3625581848;62587.68706156531;62697.05954410687;62782.372176277655;62908;62949.68525157345;64786.02820957689;64924.675376622814;64982.67508662521;64996.35003649998;65002.67498662571;16345.346186152421;16920.57698557521;16937.576560585836;16948.74576881348;16955.152242388078;12989.116578096124;13065.738685226432;13070.803937940938;13090.280034598189;13145.73708525824;15073.623159420882;16322.34710611586;16752.078635675156;18563.72154417685;18572.97848618339;7744.922550774533;7933.801654958672;7935.404844636675;7941.205879412013;8004.839903201903;835.9874601880977;997.3118548201862;1006.5973610555836;1078.2021304234809;1091.9789996353436;27556.03553875605;27693.446131077264;30353.69646303509;30785.230369240948;30913.072607821803;1051.1433181956681;1062.9255952083436;1067.492940853104;1094.3324572011068;1137.8577677790277;15446.5366039019;15747.921260393625;15763.290651920692;15801.051936883823;16140.273687684083;689284;693665;704304;705656;706724;58845.41154588485;59337;59363.40636593665;59476;59837.70081149566;1214.40494157862;1243.800991841319;1325.1452812935795;1353.1948490648049;1361.5983284931167;30596.84701576478;30953.845230773702;31582;31705.841470792497;32517.512237315987;48878;49318.50681493139;49457.50542494529;49495.75252123716;49545.522723862945;566635;568546;569110;853432;890347;41662.37506437345;42117.57882421136;42196;42404.787976059924;42534;46707;46933.59199224029;47932.281015784094;48459;50210.74894625504;38758.6124138755;39848.40227396534;40059;40125.799371002955;41535.261826435766;39494.2101157981;39507.802460987514;39646.405303919884;40739;40825.38761918633;38487;39193.628223012056;39213.2157356857;39323.213535729694;39374.2125157501;34019.4897076549;34887;35374.646253538165;35503.11242218965;35700.107497312776;25969.35076623024;26064.609030864172;26093.73906260913;26417.867910660323;26577.069802556816 03:46:15 INFO - PROCESS | 1665 | |2;jquery.html;289.892739686316;348.5364465261203;367.3809630772148;370.8182990334737;401.04151078921365;15121.01713388629;15237.933344665878;15750.133742644164;16979.91510042448;20942.790572094276;19413.32053378132;19940.900295498537;21143.259985900495;21275.36173914785;21394.786052139472;5865.17887495752;6173.166622505972;6187;6191.938080619204;6198.3801619838105;5728.455796699328;5735.9962006648875;6110.877782444349;6171.660558669271;6188.907166392485;5897.764089436418;6129.080637904305;6143.907841382383;6158.04550294705;6186.319504854462;5992.250968628921;6099.878002439927;6111.2055432793895;6120.663363515027;6131.754729810802;5044.54599086084;5178.533931946143;5258.789648414059;5293.920591191135;5321.920171197435;25180.24459266225;25437.98248070075;25829.74170258292;25870.676363708466;26161.345966350804;2286.3598192506124;2389.51015041916;2429.7706654982544;2795.412963277714;3111.71994520492;12674.80987785184;15071.321790519452;15481.225938703132;15596.220188990505;16188.838111618968;1820.6085691576375;1884.6513395021964;1891.3002189190088;1899.6580615489206;1901.6006638605909;112818;113757.43121284424;116891.59187175962;118223.90656560633;119066;8923.955380223057;9747.001864617736;9911.603535858629;11548.133889958286;11670.241434306743;14699.338529766186;14715.705685886222;14728.631784205481;14768.483103091556;14785.630359241106;8531;8634.352423568258;8663.610137543825;8701.825963480695;8702.695405660772;8602.698905538276;8634.740957771277;8644.740657780276;8776.78058048554;8847.159519845605;4385.101054283864;4524.298733696282;4557.749323787158;4558.085604046309;4617.307403889444;1635.8936669116708;1886.5377982394402;1911.7897031326543;1920.4142736465512;1924.2495426783566;370.5460810507161;379.2812620084924;409.31644154262455;825.8389614025208;908.9818203636022;11644;11725.530978760924;11740.354280514483;11864.584739534075;12064.457099430547;428.9335153051282;429.75933477252215;435.6623616697085;440.7003237798328;462.9930551041737;5087.23691446286;6000.489958353502;6004.459598636144;6028.0355143176885;6199.969000154971;621252;633471;633854;634600;638319;136807;140954;147260;148716;149094.25452872665;435.9106383191438;444.1516703097069;446.26812028273656;447.5502120369008;448.3655627287352;8936.553172341228;10827.296225745617;11293.153013523854;11487.827682584935;11498.597549085742;48910.26634600555;52548;53552.19671705006;54764.452355475936;56688.43311566996;83740;84750;85629.1437085646;86407.13592864243;86924.69612955685;6833.58998460094;8165.591720414074;8245.340372770044;8441.788955276168;8453;11015.889841101807;12947.417366218355;12968.15706979081;13359.732805344032;13427.26150061756;11095.382139504285;11595.942020289845;11624.011958983581;11638.6508404748;11639.359835209145;10787;11094.112471002461;11241.831372529256;11336.773264534828;11589.24669896454;11255.04332131778;11299.209055366046;11473.541058357907;11653.88346116528;11734;8213.342932565261;8222.218889205516;8304.211099945496;8377.706780262906;8382.16178382157;9671.468069256258;11327.207095503236;11333.716657083309;11337.093032557541;11381 03:46:15 INFO - PROCESS | 1665 | |3;mootools.html;1277.9233246005247;1495.3271028037386;1532.4176812811131;1733.6619359224949;1914.081241004317;6299.685015749212;8494.980602327721;8497.235248827605;8510.574471276426;8526.87209691855;7417.480776345658;8315.41792074555;8397.91602083979;8908.732738017854;8926.196642302191;2409.3494756415757;2433.8661373624445;2438.2685194441597;2444.987775061122;2451.2891261534132;2391.4021494626345;2431.2827715823873;2441.8534887906694;2449.767272109156;2453.031052734169;2430.598951173063;2434.47658753368;2443.499082688045;2450.4486490539575;2451.44842410458;2204.1844517528616;2416.4562973331035;2424.6726691896633;2434.610462326037;2442.5725498037773;2156.1698745982753;2263.5359751250953;2415.685960825099;2422.4912768318673;2429.1133736186343;8942.731718048404;9006.909930900738;9062;9077.500737459502;9089.454632722058;5325.121354976424;5349.251104845324;5522.5581953443625;5526.309211348582;5534.501894829485;3624.7643903146213;3715.20123173519;3792.829322680486;3801;3803.220339830328;1112.8108221602265;1116;1118.7706520163347;1143.022715578177;1144.3305666185292;11907.761844763143;11958.760824783543;12013.879861201363;12105.97099246565;12120.333381664004;4539.909201816011;4577.633789296849;4736.5973892219545;4738.502457242009;4758.452777930513;9347.766305842273;9358.251339892793;9362.765930851647;9380.624775009059;9406.341556091145;5362.1420572708175;5386.703731294817;5388.46115388458;5389.8113566025;5390.029794637003;4158.1760159944615;4519.18654642161;4689;5044.470330615232;5118.769655365518;3857.324968130566;3920.941185882214;3934.2131573684806;3964.8810535683974;3977.9204415911518;1177.1818586082761;1179.3985067615406;1189.5539172810197;1195.4441184849086;1204.127007919269;747.517850986111;846.1411667157839;851.8126012277289;873.1835733589114;924.7641851327868;5738;5905.586608937333;5995.190649262294;6111.022236442148;6186.783462578788;433.2677774560982;435.8953851075719;454.43876812136983;454.57724316386077;460.6015796336145;4007.539132999684;4026.1746342000406;4073.551909289976;4082.6733861291027;4088.7546747195265;10785.29895556802;11170.944145279222;11237.157213208879;11238.269512481662;11284.943575282236;11182.384968826793;11186;11186.776264474665;11199.776004479865;11216.55133794639;8041.3164880984605;8444.873326900102;8527.317814574819;8534.189252021048;8537.957310213409;5992.760289588542;6069.939300606938;6081.878362432815;6196.318404975359;6220.813375598739;10107.64623238183;10425.791484170122;10474.371537707762;10574.8413773795;10588.788224235626;9414.15272625467;10115.39307641544;10462.68611941643;10708;10749.570017199225;6558;7027;7412.703491860265;7764.61176941162;7847.5683837387205;8426.283765879969;8454.788630284293;8489.702860400104;8518.70184543538;8596.613152408281;6917.27368626287;6985.615791131333;7010.579365238102;7026.859462810818;7045.542039767399;7430.256974302527;7511.474196806171;7514.624268786648;7587.658555364911;7599.126100498514;7184.497085203986;7195.2085270619145;7292.927070729437;7309.817254568678;7358.190599033995;5002.449730529712;5066.290719299227;5146.073706732824;5186.58507319406;5286.022085914118;5092.134337162765;5120.359955005624;5176.948230517647;5237.790488380422;5385.084535629031 03:46:15 INFO - PROCESS | 1665 | |4;prototype.html;296.3347285344401;298.215692728125;305.30695321619925;308.5941986288031;310.4876953027506;4584.381108550345;4999.500049994998;5038.823641172559;5177.249298851669;5262.236975638531;4192.993681516437;4925.335079764231;5066.417362003371;5126.538611524962;5128.871778205546;3452.896413107611;3836.0601652595155;3912.2371137628174;3948.2103579284117;4046.1185548719914;3736.4208547675153;3956.3867600521967;3991.44119823225;3995.9200815983663;4024.605359810908;3954.5056867891512;3957.377475235154;3959.4558122332314;3963.9603603964024;3979.363301871701;3095.8761649534104;3246.951295730566;3765.152840610854;3939.980300098481;3992.960070399288;3413.044347582681;3444.9492904664066;3462.9653703462895;3464.873915977292;3473.7568370214094;3999.960000399988;4197.845592462098;5022.874428139289;5042.773075211588;5121.28302037715;4478.776061196927;4485.865424037284;4532.138893610204;4541.9545804542195;4565.908681826345;5409.99660251415;5435.287884316428;5437.102878025121;5445.1832225166145;5507;3157.8894738684266;3486.646513603333;3756.1594818538993;3756.1782535470275;3758.5113935188524;5187.792488300463;5586.916196257019;5636.379998200195;5650.1296611821035;5658.783361577281;3767.87115279866;3775.86784462548;3777.981110094432;3795.6394142556414;3803.3154032274456;3863.1887303666545;3865.439511270906;3872.728908976401;3874.7287689862;3891.3968334908136;4243.7029407941145;4424.690271680952;4434.911301773946;4466.665000124939;4594.287885377772;5431.83704488866;5437.646552974044;5461.399246082928;5473;5549.944500554942;1151.2804497189256;1235.90622299264;1245.302630526908;1271.7265787855656;1292.584619841291;829.2371018662844;829.5396055189307;882.3514716683233;885.4952676974192;889.7731078575051;4153.480814898137;5121.923171152435;5151.974240128776;5174.353205849269;5188.22176673502;4657.510961349078;5317.766538054027;5478.287822583118;5610.242617246619;5698.6580805151825;4460.553944605514;4702.294655801657;4849.0420843285565;4962.03999420227;5153.742312884341;2026.422469596158;2119.4277545062746;2218.966715499269;2254.6618007298707;2447.9143229986867;4160.750354978711;4197.4753155855515;4332.830135863363;4703.905921881543;4737.763111844394;4159.812808423628;4470.998456381521;4517.944335327418;4657.439757681214;4660.720356778605;4560.566746159109;4715.7877895494785;4733.455652599926;4784.378030856036;4794.520547945178;3888.8833334999995;3903.453516507748;4165.58344165581;4503.459584849839;4536.72779633223;4019.7789121598594;4170.666346692196;4534.417809930118;4543.45478542577;4549.5905368517;4133.586641335963;4374.650027997689;4487.663425243185;4707.435107787088;4744.501827308221;2920.8101473404163;3119.457642021745;3146.3392687535875;3221.436248656523;3263.2657652028106;4620.75893191795;4672.439307283148;4677.929831052469;5051.595872330278;5783.363829978614;4862.270659401118;5259.8422047338645;5554.638948468337;5555.583331250092;5585.207396301849;5547.778088876561;5550.972245138749;5601.243832082617;5652.236948011966;5678.517326027334;4822.903541929071;5007.874803129951;5372.5433338166695;5417.756200970887;5451;4648.7443190624845;4839.491853355347;5478.260434841245;5526.778928842801;5545.279113715191;5242.737863106753;5448.139726643544;5463.48096930791;5484.533814625642;5499.50504454601 03:46:15 INFO - PROCESS | 1665 | |5;yui.html;673.9258681545031;708.029998901505;724.1455083002058;742.6286856571714;805.4482679364636;15020.399184032625;16283.674326513477;16331.83668163318;16821.663566728657;17384.304627814905;15170.544883653509;15186.696266074672;15189.696206075872;15208;15309.311081001353;668.7391917152314;832.7585000349891;862.3230763850379;862.4394143806513;863.1799790199304;690.1511141296209;695.2769120115074;831.2103501673404;848.7453763870845;864.7967727584013;891.777055736066;895.5969813583881;895.6551727584895;896.1486587741639;897.5422534507416;888.5557221389305;889.0265159650173;889.8175873945826;890.6214858685065;891.8662200669886;516.5867306155061;534.6311045378715;640.9134766806468;656.2125449460666;661.8146918862678;14764.557063288119;15378.692426151414;15409.998350107207;15424.22878856064;15424.76862847047;13415.329233538381;13705.670036093888;13818.239996800172;14021.298935053308;14338;10631.468426578718;11092.33445993235;12340.814887776602;13280.07039507235;13350.773578029293;4356.390105385249;4403.163398954221;4651.697639653446;4691.859244222679;4746.359241502388;86791.13208867893;95586;120361;126007.47985040248;129261;10170.593176273014;10911.018008379284;10955.397453139994;10982.725431864108;11010.669679909455;21255.893720531607;21270.893645531673;21303.573928521342;21303.68044479334;21336.466588335417;7681;7863.842723145505;7898.960505197552;8122.75631731049;8175;4276.636485898671;4280.186764514732;4433.224185767478;4444.799984000728;4464.196444639931;3512.8594856205464;3626.673599376069;3630.346537623253;3632.3461776879885;3645.9453108203397;655.6787174284566;660.4815220052332;667.8697653957431;692.4391243093111;694.1427337238506;580.6080895395592;618.0358640520802;621.6580880515698;627.6830200748593;630.8202162383699;7148.428125749928;8116.675332986614;9053.411528250643;9088.182063614306;9131.223845973167;521.7495602111007;607.3198018219534;623.1307326279905;636.424036247197;651.794684674326;3810.580836108026;4286.357046442996;4442.4669039715445;4497.190505709003;4565.406497155349;105271.4736426313;126115;153661;164430.17784911237;167468;79553.20446795458;82560.17439825645;105743.41384879233;129567.98672112975;139659.90510142356;105078;107379.926200737;109782.45108774405;111704;112845;8072.798180045545;10106.696799096038;10124.544395502367;10146.695599132037;10151.390916545031;58588.70705646615;62210;64436.35563644491;65736.67131664311;66749.33002679839;61343.693281533306;63371.683141584;84764.57617711872;90131.64802528099;90289.54855225682;12065.907717306127;12399.194052386567;12551.686207844878;13375.799363009368;13496.122752021087;11875.287482751062;14194.290285485891;14952.626184345478;15660.608484787972;15739;11476.368799715761;12639.747205056032;13557.525486607921;13774.173549587056;13976.951728620597;13373.799393008918;13694.315284235947;13709.383077761724;13878.861211387757;14690.779638305221;13026.54407095747;13223.471061157446;13763.174209547458;14274.571762847132;14329.996900216885;10707.464626768786;10753.672355729883;11100.944495277472;11481.96662300397;11558.47986840611;10350.792984140426;11378.829317560409;11520.27296671747;11703.063754899418;11769.293842369485 03:46:15 INFO - PROCESS | 1665 | __end_tp_report 03:46:15 INFO - PROCESS | 1665 | __start_cc_report 03:46:15 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,1398 03:46:15 INFO - PROCESS | 1665 | __end_cc_report 03:46:15 INFO - PROCESS | 1665 | __startTimestamp1478691975699__endTimestamp 03:46:15 INFO - PROCESS | 1665 | 03:46:15 INFO - PROCESS | 1665 | ------- Summary: start ------- 03:46:15 INFO - PROCESS | 1665 | Number of tests: 6 03:46:15 INFO - PROCESS | 1665 | 03:46:15 INFO - PROCESS | 1665 | [#0] dojo.html Cycles:165 Average:5720.47 Median:5928.70 stddev:676.89 (11.4%) stddev-sans-first:631.77 03:46:15 INFO - PROCESS | 1665 | Values: 2554.7 2774.5 3347.6 3379.0 3397.4 5653.9 5754.1 5757.5 5769.5 5784.6 5658.2 5745.8 5757.1 5760.5 5785.5 5188.2 5213.3 5235.0 5236.0 5297.5 5177.2 5187.7 5189.4 5344.7 5383.7 4294.5 5215.3 5221.3 5235.5 5261.1 5270.1 5272.8 5273.1 5296.1 5310.2 5173.8 5204.5 5240.6 5256.1 5283.0 5603.3 5634.5 5653.3 5655.5 5661.2 6117.8 6204.3 6205.9 6212.9 6232.2 6206.3 6302.7 6309.5 6315.9 6316.7 5658.0 5691.9 5716.0 5788.7 5819.9 6272.7 6292.3 6294.8 6300.8 6314.8 6149.5 6174.3 6184.2 6188.7 6196.4 5226.4 6110.4 6175.8 6183.2 6269.4 6142.7 6147.7 6150.0 6153.3 6156.8 5163.7 6102.4 6211.5 6230.9 6263.3 4880.6 4887.8 4888.9 4908.1 4922.4 4430.4 4463.0 4482.6 4500.8 4534.8 5700.7 5707.5 5762.0 5772.4 5801.6 6258.3 6263.4 6275.4 6280.7 6291.7 5725.8 5736.6 5746.0 5753.7 5762.1 5321.9 5365.4 5369.5 5382.9 5385.6 6257.3 6270.1 6289.9 6305.9 6324.4 6236.9 6253.6 6264.2 6264.3 6271.0 6209.8 6226.9 6278.8 6292.7 6296.8 6079.2 6097.8 6111.4 6202.1 6207.7 6257.9 6271.9 6272.2 6273.7 6304.8 5881.6 6054.3 6105.9 6114.8 6126.5 4835.0 5928.7 6031.4 6051.1 6051.2 5840.1 5852.5 5882.2 5950.5 5959.1 6151.9 6175.9 6183.5 6187.7 6189.9 6006.4 6006.6 6017.7 6043.2 6062.6 03:46:15 INFO - PROCESS | 1665 | 03:46:15 INFO - PROCESS | 1665 | [#1] ext.html Cycles:180 Average:76895.90 Median:39501.01 stddev:173994.09 (440.5%) stddev-sans-first:174387.65 03:46:15 INFO - PROCESS | 1665 | Values: 505.2 519.4 521.1 523.7 526.0 30274.0 31068.0 31463.5 40307.2 41164.6 42274.7 43209.6 43705.3 43730.3 43799.6 9659.2 9800.0 9800.9 9815.1 9829.4 8676.6 8880.8 9742.4 9884.7 11876.1 11820.6 12135.6 12142.7 12150.8 12169.5 12152.3 12221.6 12231.1 12240.8 12272.6 8660.0 8863.6 11578.0 11866.2 11924.1 41244.8 41516.6 41568.8 41627.0 41676.0 3333.5 3385.4 3539.6 3922.4 4001.5 29278.7 29780.9 30550.8 32210.9 32308.7 3156.6 3253.3 3265.0 3300.1 3415.0 520044.0 523555.0 524381.0 524909.0 527488.4 62587.7 62697.1 62782.4 62908.0 62949.7 64786.0 64924.7 64982.7 64996.4 65002.7 16345.3 16920.6 16937.6 16948.7 16955.2 12989.1 13065.7 13070.8 13090.3 13145.7 15073.6 16322.3 16752.1 18563.7 18573.0 7744.9 7933.8 7935.4 7941.2 8004.8 836.0 997.3 1006.6 1078.2 1092.0 27556.0 27693.4 30353.7 30785.2 30913.1 1051.1 1062.9 1067.5 1094.3 1137.9 15446.5 15747.9 15763.3 15801.1 16140.3 689284.0 693665.0 704304.0 705656.0 706724.0 58845.4 59337.0 59363.4 59476.0 59837.7 1214.4 1243.8 1325.1 1353.2 1361.6 30596.8 30953.8 31582.0 31705.8 32517.5 48878.0 49318.5 49457.5 49495.8 49545.5 566635.0 568546.0 569110.0 853432.0 890347.0 41662.4 42117.6 42196.0 42404.8 42534.0 46707.0 46933.6 47932.3 48459.0 50210.7 38758.6 39848.4 40059.0 40125.8 41535.3 39494.2 39507.8 39646.4 40739.0 40825.4 38487.0 39193.6 39213.2 39323.2 39374.2 34019.5 34887.0 35374.6 35503.1 35700.1 25969.4 26064.6 26093.7 26417.9 26577.1 03:46:15 INFO - PROCESS | 1665 | 03:46:15 INFO - PROCESS | 1665 | [#2] jquery.html Cycles:180 Average:36038.01 Median:390.16 stddev:105841.38 (27127.6%) stddev-sans-first:106104.25 03:46:15 INFO - PROCESS | 1665 | Values: 289.9 348.5 367.4 370.8 401.0 15121.0 15237.9 15750.1 16979.9 20942.8 19413.3 19940.9 21143.3 21275.4 21394.8 5865.2 6173.2 6187.0 6191.9 6198.4 5728.5 5736.0 6110.9 6171.7 6188.9 5897.8 6129.1 6143.9 6158.0 6186.3 5992.3 6099.9 6111.2 6120.7 6131.8 5044.5 5178.5 5258.8 5293.9 5321.9 25180.2 25438.0 25829.7 25870.7 26161.3 2286.4 2389.5 2429.8 2795.4 3111.7 12674.8 15071.3 15481.2 15596.2 16188.8 1820.6 1884.7 1891.3 1899.7 1901.6 112818.0 113757.4 116891.6 118223.9 119066.0 8924.0 9747.0 9911.6 11548.1 11670.2 14699.3 14715.7 14728.6 14768.5 14785.6 8531.0 8634.4 8663.6 8701.8 8702.7 8602.7 8634.7 8644.7 8776.8 8847.2 4385.1 4524.3 4557.7 4558.1 4617.3 1635.9 1886.5 1911.8 1920.4 1924.2 370.5 379.3 409.3 825.8 909.0 11644.0 11725.5 11740.4 11864.6 12064.5 428.9 429.8 435.7 440.7 463.0 5087.2 6000.5 6004.5 6028.0 6200.0 621252.0 633471.0 633854.0 634600.0 638319.0 136807.0 140954.0 147260.0 148716.0 149094.3 435.9 444.2 446.3 447.6 448.4 8936.6 10827.3 11293.2 11487.8 11498.6 48910.3 52548.0 53552.2 54764.5 56688.4 83740.0 84750.0 85629.1 86407.1 86924.7 6833.6 8165.6 8245.3 8441.8 8453.0 11015.9 12947.4 12968.2 13359.7 13427.3 11095.4 11595.9 11624.0 11638.7 11639.4 10787.0 11094.1 11241.8 11336.8 11589.2 11255.0 11299.2 11473.5 11653.9 11734.0 8213.3 8222.2 8304.2 8377.7 8382.2 9671.5 11327.2 11333.7 11337.1 11381.0 03:46:15 INFO - PROCESS | 1665 | 03:46:15 INFO - PROCESS | 1665 | [#3] mootools.html Cycles:180 Average:5766.68 Median:4748.48 stddev:3275.13 (69.0%) stddev-sans-first:3266.95 03:46:15 INFO - PROCESS | 1665 | Values: 1277.9 1495.3 1532.4 1733.7 1914.1 6299.7 8495.0 8497.2 8510.6 8526.9 7417.5 8315.4 8397.9 8908.7 8926.2 2409.3 2433.9 2438.3 2445.0 2451.3 2391.4 2431.3 2441.9 2449.8 2453.0 2430.6 2434.5 2443.5 2450.4 2451.4 2204.2 2416.5 2424.7 2434.6 2442.6 2156.2 2263.5 2415.7 2422.5 2429.1 8942.7 9006.9 9062.0 9077.5 9089.5 5325.1 5349.3 5522.6 5526.3 5534.5 3624.8 3715.2 3792.8 3801.0 3803.2 1112.8 1116.0 1118.8 1143.0 1144.3 11907.8 11958.8 12013.9 12106.0 12120.3 4539.9 4577.6 4736.6 4738.5 4758.5 9347.8 9358.3 9362.8 9380.6 9406.3 5362.1 5386.7 5388.5 5389.8 5390.0 4158.2 4519.2 4689.0 5044.5 5118.8 3857.3 3920.9 3934.2 3964.9 3977.9 1177.2 1179.4 1189.6 1195.4 1204.1 747.5 846.1 851.8 873.2 924.8 5738.0 5905.6 5995.2 6111.0 6186.8 433.3 435.9 454.4 454.6 460.6 4007.5 4026.2 4073.6 4082.7 4088.8 10785.3 11170.9 11237.2 11238.3 11284.9 11182.4 11186.0 11186.8 11199.8 11216.6 8041.3 8444.9 8527.3 8534.2 8538.0 5992.8 6069.9 6081.9 6196.3 6220.8 10107.6 10425.8 10474.4 10574.8 10588.8 9414.2 10115.4 10462.7 10708.0 10749.6 6558.0 7027.0 7412.7 7764.6 7847.6 8426.3 8454.8 8489.7 8518.7 8596.6 6917.3 6985.6 7010.6 7026.9 7045.5 7430.3 7511.5 7514.6 7587.7 7599.1 7184.5 7195.2 7292.9 7309.8 7358.2 5002.4 5066.3 5146.1 5186.6 5286.0 5092.1 5120.4 5176.9 5237.8 5385.1 03:46:15 INFO - PROCESS | 1665 | 03:46:15 INFO - PROCESS | 1665 | [#4] prototype.html Cycles:180 Average:4205.50 Median:4546.52 stddev:1301.25 (28.6%) stddev-sans-first:1271.39 03:46:15 INFO - PROCESS | 1665 | Values: 296.3 298.2 305.3 308.6 310.5 4584.4 4999.5 5038.8 5177.2 5262.2 4193.0 4925.3 5066.4 5126.5 5128.9 3452.9 3836.1 3912.2 3948.2 4046.1 3736.4 3956.4 3991.4 3995.9 4024.6 3954.5 3957.4 3959.5 3964.0 3979.4 3095.9 3247.0 3765.2 3940.0 3993.0 3413.0 3444.9 3463.0 3464.9 3473.8 4000.0 4197.8 5022.9 5042.8 5121.3 4478.8 4485.9 4532.1 4542.0 4565.9 5410.0 5435.3 5437.1 5445.2 5507.0 3157.9 3486.6 3756.2 3756.2 3758.5 5187.8 5586.9 5636.4 5650.1 5658.8 3767.9 3775.9 3778.0 3795.6 3803.3 3863.2 3865.4 3872.7 3874.7 3891.4 4243.7 4424.7 4434.9 4466.7 4594.3 5431.8 5437.6 5461.4 5473.0 5549.9 1151.3 1235.9 1245.3 1271.7 1292.6 829.2 829.5 882.4 885.5 889.8 4153.5 5121.9 5152.0 5174.4 5188.2 4657.5 5317.8 5478.3 5610.2 5698.7 4460.6 4702.3 4849.0 4962.0 5153.7 2026.4 2119.4 2219.0 2254.7 2447.9 4160.8 4197.5 4332.8 4703.9 4737.8 4159.8 4471.0 4517.9 4657.4 4660.7 4560.6 4715.8 4733.5 4784.4 4794.5 3888.9 3903.5 4165.6 4503.5 4536.7 4019.8 4170.7 4534.4 4543.5 4549.6 4133.6 4374.7 4487.7 4707.4 4744.5 2920.8 3119.5 3146.3 3221.4 3263.3 4620.8 4672.4 4677.9 5051.6 5783.4 4862.3 5259.8 5554.6 5555.6 5585.2 5547.8 5551.0 5601.2 5652.2 5678.5 4822.9 5007.9 5372.5 5417.8 5451.0 4648.7 4839.5 5478.3 5526.8 5545.3 5242.7 5448.1 5463.5 5484.5 5499.5 03:46:15 INFO - PROCESS | 1665 | 03:46:15 INFO - PROCESS | 1665 | [#5] yui.html Cycles:180 Average:23842.54 Median:3569.77 stddev:37721.26 (1056.7%) stddev-sans-first:37786.96 03:46:15 INFO - PROCESS | 1665 | Values: 673.9 708.0 724.1 742.6 805.4 15020.4 16283.7 16331.8 16821.7 17384.3 15170.5 15186.7 15189.7 15208.0 15309.3 668.7 832.8 862.3 862.4 863.2 690.2 695.3 831.2 848.7 864.8 891.8 895.6 895.7 896.1 897.5 888.6 889.0 889.8 890.6 891.9 516.6 534.6 640.9 656.2 661.8 14764.6 15378.7 15410.0 15424.2 15424.8 13415.3 13705.7 13818.2 14021.3 14338.0 10631.5 11092.3 12340.8 13280.1 13350.8 4356.4 4403.2 4651.7 4691.9 4746.4 86791.1 95586.0 120361.0 126007.5 129261.0 10170.6 10911.0 10955.4 10982.7 11010.7 21255.9 21270.9 21303.6 21303.7 21336.5 7681.0 7863.8 7899.0 8122.8 8175.0 4276.6 4280.2 4433.2 4444.8 4464.2 3512.9 3626.7 3630.3 3632.3 3645.9 655.7 660.5 667.9 692.4 694.1 580.6 618.0 621.7 627.7 630.8 7148.4 8116.7 9053.4 9088.2 9131.2 521.7 607.3 623.1 636.4 651.8 3810.6 4286.4 4442.5 4497.2 4565.4 105271.5 126115.0 153661.0 164430.2 167468.0 79553.2 82560.2 105743.4 129568.0 139659.9 105078.0 107379.9 109782.5 111704.0 112845.0 8072.8 10106.7 10124.5 10146.7 10151.4 58588.7 62210.0 64436.4 65736.7 66749.3 61343.7 63371.7 84764.6 90131.6 90289.5 12065.9 12399.2 12551.7 13375.8 13496.1 11875.3 14194.3 14952.6 15660.6 15739.0 11476.4 12639.7 13557.5 13774.2 13977.0 13373.8 13694.3 13709.4 13878.9 14690.8 13026.5 13223.5 13763.2 14274.6 14330.0 10707.5 10753.7 11100.9 11482.0 11558.5 10350.8 11378.8 11520.3 11703.1 11769.3 03:46:15 INFO - PROCESS | 1665 | -------- Summary: end -------- 03:46:15 INFO - PROCESS | 1665 | 03:46:16 INFO - TEST-INFO | 1665: exit 0 03:46:16 INFO - TEST-OK | dromaeo_css | took 1117656ms 03:46:16 INFO - TEST-START | kraken 03:46:16 INFO - operating with platform_type : mac_ 03:46:16 INFO - Initialising browser for kraken test... 03:46:16 INFO - TEST-INFO | started process 1695 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/tmpXTiOwf/profile http://localhost:49284/getInfo.html) 03:46:18 INFO - PROCESS | 1695 | __metrics Screen width/height:1600/1200 03:46:18 INFO - PROCESS | 1695 | colorDepth:24 03:46:18 INFO - PROCESS | 1695 | Browser inner width/height: 1024/689 03:46:18 INFO - PROCESS | 1695 | __metrics 03:46:18 INFO - PROCESS | 1695 | 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" 03:46:18 INFO - PROCESS | 1695 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:46:19 INFO - TEST-INFO | 1695: exit 0 03:46:19 INFO - Browser initialized. 03:46:19 INFO - Running cycle 1/1 for kraken test... 03:46:19 INFO - TEST-INFO | started process 1696 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/tmpXTiOwf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:46:31 INFO - PROCESS | 1696 | RSS: Main: 219754496 03:46:31 INFO - PROCESS | 1696 | 03:46:33 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49284/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49284/tests/kraken/driver.html?testName=audio-beat-detection) 03:46:34 INFO - PROCESS | 1696 | RSS: Main: 269815808 03:46:34 INFO - PROCESS | 1696 | 03:46:37 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49284/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49284/tests/kraken/driver.html?testName=audio-dft) 03:46:38 INFO - PROCESS | 1696 | RSS: Main: 281149440 03:46:38 INFO - PROCESS | 1696 | 03:46:41 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49284/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49284/tests/kraken/driver.html?testName=audio-fft) 03:46:41 INFO - PROCESS | 1696 | RSS: Main: 379785216 03:46:41 INFO - PROCESS | 1696 | 03:46:43 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49284/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49284/tests/kraken/driver.html?testName=audio-oscillator) 03:46:44 INFO - PROCESS | 1696 | RSS: Main: 280555520 03:46:44 INFO - PROCESS | 1696 | 03:46:46 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49284/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49284/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:46:47 INFO - PROCESS | 1696 | RSS: Main: 281419776 03:46:47 INFO - PROCESS | 1696 | 03:46:49 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49284/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49284/tests/kraken/driver.html?testName=imaging-darkroom) 03:46:50 INFO - PROCESS | 1696 | RSS: Main: 318300160 03:46:50 INFO - PROCESS | 1696 | 03:46:53 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49284/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49284/tests/kraken/driver.html?testName=imaging-desaturate) 03:46:54 INFO - PROCESS | 1696 | RSS: Main: 320339968 03:46:54 INFO - PROCESS | 1696 | 03:46:56 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49284/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49284/tests/kraken/driver.html?testName=json-parse-financial) 03:46:57 INFO - PROCESS | 1696 | RSS: Main: 316563456 03:46:57 INFO - PROCESS | 1696 | 03:46:58 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49284/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49284/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:46:59 INFO - PROCESS | 1696 | RSS: Main: 291737600 03:46:59 INFO - PROCESS | 1696 | 03:47:01 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49284/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49284/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:47:02 INFO - PROCESS | 1696 | RSS: Main: 295780352 03:47:02 INFO - PROCESS | 1696 | 03:47:04 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49284/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49284/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:47:04 INFO - PROCESS | 1696 | RSS: Main: 304758784 03:47:04 INFO - PROCESS | 1696 | 03:47:07 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49284/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49284/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:47:08 INFO - PROCESS | 1696 | RSS: Main: 313069568 03:47:08 INFO - PROCESS | 1696 | 03:47:11 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49284/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49284/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:47:12 INFO - PROCESS | 1696 | RSS: Main: 312500224 03:47:12 INFO - PROCESS | 1696 | 03:47:13 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49284/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49284/tests/kraken/driver.html?testName=ai-astar) 03:47:14 INFO - PROCESS | 1696 | RSS: Main: 356704256 03:47:14 INFO - PROCESS | 1696 | 03:47:14 INFO - PROCESS | 1696 | __start_tp_report 03:47:14 INFO - PROCESS | 1696 | _x_x_mozilla_page_load 03:47:14 INFO - PROCESS | 1696 | _x_x_mozilla_page_load_details 03:47:14 INFO - PROCESS | 1696 | |i|pagename|runs| 03:47:14 INFO - PROCESS | 1696 | |0;ai-astar;114;113;113;112;114;112;112;111;112;116 03:47:14 INFO - PROCESS | 1696 | |1;audio-beat-detection;142;114;138;174;110;109;108;111;131;108 03:47:14 INFO - PROCESS | 1696 | |2;audio-dft;182;181;184;182;183;181;182;183;182;186 03:47:14 INFO - PROCESS | 1696 | |3;audio-fft;82;60;58;97;86;82;80;61;84;58 03:47:14 INFO - PROCESS | 1696 | |4;audio-oscillator;89;72;94;70;68;69;93;67;69;91 03:47:14 INFO - PROCESS | 1696 | |5;imaging-gaussian-blur;91;87;91;88;91;87;91;88;90;87 03:47:14 INFO - PROCESS | 1696 | |6;imaging-darkroom;95;97;96;97;95;97;96;97;96;96 03:47:14 INFO - PROCESS | 1696 | |7;imaging-desaturate;84;84;83;82;83;83;84;83;84;84 03:47:14 INFO - PROCESS | 1696 | |8;json-parse-financial;58;55;55;55;57;58;57;58;58;56 03:47:14 INFO - PROCESS | 1696 | |9;json-stringify-tinderbox;66;68;75;76;72;70;69;71;74;71 03:47:14 INFO - PROCESS | 1696 | |10;stanford-crypto-aes;81;82;82;84;84;85;85;83;98;102 03:47:14 INFO - PROCESS | 1696 | |11;stanford-crypto-ccm;138;138;140;142;154;130;147;155;195;138 03:47:14 INFO - PROCESS | 1696 | |12;stanford-crypto-pbkdf2;165;168;163;163;165;165;162;165;165;164 03:47:14 INFO - PROCESS | 1696 | |13;stanford-crypto-sha256-iterative;69;67;67;68;66;67;66;66;65;78 03:47:14 INFO - PROCESS | 1696 | __end_tp_report 03:47:14 INFO - PROCESS | 1696 | __start_cc_report 03:47:14 INFO - PROCESS | 1696 | _x_x_mozilla_cycle_collect,1974 03:47:14 INFO - PROCESS | 1696 | __end_cc_report 03:47:14 INFO - PROCESS | 1696 | __startTimestamp1478692034096__endTimestamp 03:47:14 INFO - PROCESS | 1696 | 03:47:14 INFO - PROCESS | 1696 | ------- Summary: start ------- 03:47:14 INFO - PROCESS | 1696 | Number of tests: 14 03:47:14 INFO - PROCESS | 1696 | 03:47:14 INFO - PROCESS | 1696 | [#0] ai-astar Cycles:10 Average:112.90 Median:113.00 stddev:1.45 (1.3%) stddev-sans-first:1.48 03:47:14 INFO - PROCESS | 1696 | Values: 114.0 113.0 113.0 112.0 114.0 112.0 112.0 111.0 112.0 116.0 03:47:14 INFO - PROCESS | 1696 | 03:47:14 INFO - PROCESS | 1696 | [#1] audio-beat-detection Cycles:10 Average:124.50 Median:122.50 stddev:21.78 (17.8%) stddev-sans-first:22.16 03:47:14 INFO - PROCESS | 1696 | Values: 142.0 114.0 138.0 174.0 110.0 109.0 108.0 111.0 131.0 108.0 03:47:14 INFO - PROCESS | 1696 | 03:47:14 INFO - PROCESS | 1696 | [#2] audio-dft Cycles:10 Average:182.60 Median:182.50 stddev:1.51 (0.8%) stddev-sans-first:1.58 03:47:14 INFO - PROCESS | 1696 | Values: 182.0 181.0 184.0 182.0 183.0 181.0 182.0 183.0 182.0 186.0 03:47:14 INFO - PROCESS | 1696 | 03:47:14 INFO - PROCESS | 1696 | [#3] audio-fft Cycles:10 Average:74.80 Median:82.00 stddev:14.17 (17.3%) stddev-sans-first:14.79 03:47:14 INFO - PROCESS | 1696 | Values: 82.0 60.0 58.0 97.0 86.0 82.0 80.0 61.0 84.0 58.0 03:47:14 INFO - PROCESS | 1696 | 03:47:14 INFO - PROCESS | 1696 | [#4] audio-oscillator Cycles:10 Average:78.20 Median:80.50 stddev:11.80 (14.7%) stddev-sans-first:11.85 03:47:14 INFO - PROCESS | 1696 | Values: 89.0 72.0 94.0 70.0 68.0 69.0 93.0 67.0 69.0 91.0 03:47:14 INFO - PROCESS | 1696 | 03:47:14 INFO - PROCESS | 1696 | [#5] imaging-gaussian-blur Cycles:10 Average:89.10 Median:90.50 stddev:1.85 (2.0%) stddev-sans-first:1.83 03:47:14 INFO - PROCESS | 1696 | Values: 91.0 87.0 91.0 88.0 91.0 87.0 91.0 88.0 90.0 87.0 03:47:14 INFO - PROCESS | 1696 | 03:47:14 INFO - PROCESS | 1696 | [#6] imaging-darkroom Cycles:10 Average:96.20 Median:96.50 stddev:0.79 (0.8%) stddev-sans-first:0.71 03:47:14 INFO - PROCESS | 1696 | Values: 95.0 97.0 96.0 97.0 95.0 97.0 96.0 97.0 96.0 96.0 03:47:14 INFO - PROCESS | 1696 | 03:47:14 INFO - PROCESS | 1696 | [#7] imaging-desaturate Cycles:10 Average:83.40 Median:84.00 stddev:0.70 (0.8%) stddev-sans-first:0.71 03:47:14 INFO - PROCESS | 1696 | Values: 84.0 84.0 83.0 82.0 83.0 83.0 84.0 83.0 84.0 84.0 03:47:14 INFO - PROCESS | 1696 | 03:47:14 INFO - PROCESS | 1696 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:57.50 stddev:1.34 (2.3%) stddev-sans-first:1.33 03:47:14 INFO - PROCESS | 1696 | Values: 58.0 55.0 55.0 55.0 57.0 58.0 57.0 58.0 58.0 56.0 03:47:14 INFO - PROCESS | 1696 | 03:47:14 INFO - PROCESS | 1696 | [#9] json-stringify-tinderbox Cycles:10 Average:71.20 Median:71.50 stddev:3.16 (4.4%) stddev-sans-first:2.73 03:47:14 INFO - PROCESS | 1696 | Values: 66.0 68.0 75.0 76.0 72.0 70.0 69.0 71.0 74.0 71.0 03:47:14 INFO - PROCESS | 1696 | 03:47:14 INFO - PROCESS | 1696 | [#10] stanford-crypto-aes Cycles:10 Average:86.60 Median:84.00 stddev:7.24 (8.6%) stddev-sans-first:7.40 03:47:14 INFO - PROCESS | 1696 | Values: 81.0 82.0 82.0 84.0 84.0 85.0 85.0 83.0 98.0 102.0 03:47:14 INFO - PROCESS | 1696 | 03:47:14 INFO - PROCESS | 1696 | [#11] stanford-crypto-ccm Cycles:10 Average:147.70 Median:144.50 stddev:18.31 (12.7%) stddev-sans-first:19.08 03:47:14 INFO - PROCESS | 1696 | Values: 138.0 138.0 140.0 142.0 154.0 130.0 147.0 155.0 195.0 138.0 03:47:14 INFO - PROCESS | 1696 | 03:47:14 INFO - PROCESS | 1696 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.50 Median:165.00 stddev:1.65 (1.0%) stddev-sans-first:1.74 03:47:14 INFO - PROCESS | 1696 | Values: 165.0 168.0 163.0 163.0 165.0 165.0 162.0 165.0 165.0 164.0 03:47:14 INFO - PROCESS | 1696 | 03:47:14 INFO - PROCESS | 1696 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:67.00 stddev:3.73 (5.6%) stddev-sans-first:3.93 03:47:14 INFO - PROCESS | 1696 | Values: 69.0 67.0 67.0 68.0 66.0 67.0 66.0 66.0 65.0 78.0 03:47:14 INFO - PROCESS | 1696 | -------- Summary: end -------- 03:47:14 INFO - PROCESS | 1696 | 03:47:14 INFO - TEST-INFO | 1696: exit 0 03:47:14 INFO - TEST-OK | kraken | took 58677ms 03:47:14 INFO - SUITE-END | took 1176s 03:47:15 INFO - Completed test suite (00:19:36) 03:47:15 INFO - javascript benchmark 03:47:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2554.7189809120982, 2774.5144599695054, 3347.581552305962, 3379.0, 3397.388470075387, 5653.943460565393, 5754.079347304432, 5757.539396848252, 5769.509591684707, 5784.623999440033, 5658.151277308406, 5745.770169193227, 5757.078867381219, 5760.539156867451, 5785.450382213683, 5188.16989281715, 5213.2701421800975, 5235.0, 5235.978984098102, 5297.47025297471, 5177.223416487519, 5187.714675692835, 5189.377274727038, 5344.732763361836, 5383.703896285702, 4294.5490723473895, 5215.295935048758, 5221.347331583552, 5235.476452354772, 5261.053010458116, 5270.130428479296, 5272.789088436458, 5273.077211487975, 5296.103986792135, 5310.150375939869, 5173.767180476888, 5204.531592156724, 5240.6069544784295, 5256.053910296145, 5283.0, 5603.2715746953045, 5634.521065709419, 5653.293338332708, 5655.5475561954945, 5661.2357331760095, 6117.825149509779, 6204.348543402968, 6205.913965056097, 6212.943799554087, 6232.158658581079, 6206.25524937006, 6302.684865756693, 6309.4636955858805, 6315.8736825263695, 6316.715747791361, 5658.0, 5691.9146212806845, 5716.0, 5788.710564471759, 5819.854503637401, 6272.655003974825, 6292.339304373067, 6294.842628934313, 6300.779472718433, 6314.842128946813, 6149.5080393568405, 6174.25908890927, 6184.165137706442, 6188.690565471708, 6196.411340922605, 5226.425093239741, 6110.388961103854, 6175.795719834679, 6183.227096612924, 6269.373062693694, 6142.692865356715, 6147.66187859663, 6149.985252433298, 6153.2616086069065, 6156.846078848064, 5163.690178589297, 6102.428659372087, 6211.472024877936, 6230.875382492325, 6263.279722831932, 4880.560749532488, 4887.828925987574, 4888.877778055577, 4908.092002979461, 4922.409310882717, 4430.42404487421, 4462.977685111554, 4482.574155455227, 4500.797464114123, 4534.818607255739, 5700.686462244616, 5707.543396528268, 5762.0, 5772.3938986406665, 5801.593888427769, 6258.311585725566, 6263.404976527223, 6275.3724627536885, 6280.685965701697, 6291.748330066837, 5725.770969161187, 5736.569757268222, 5746.02317606008, 5753.741081651336, 5762.135679648086, 5321.893562128813, 5365.356157261153, 5369.5167434931045, 5382.892342153135, 5385.569154467633, 6257.311695713559, 6270.059491076284, 6289.9371006291185, 6305.873882522415, 6324.367563243639, 6236.875262494634, 6253.593516421418, 6264.248290205022, 6264.279607844974, 6270.968645156745, 6209.813705588839, 6226.906596401148, 6278.843028924313, 6292.716827742671, 6296.811095667137, 6079.240094988127, 6097.7865774697675, 6111.37903775109, 6202.100695399232, 6207.689615519296, 6257.906131408124, 6271.937280627135, 6272.247330320391, 6273.749050037947, 6304.810855674337, 5881.588288819741, 6054.303755068224, 6105.9084113737445, 6114.847128821815, 6126.479249263684, 4834.951650483591, 5928.703564821655, 6031.4270144336215, 6051.062085376773, 6051.243594550681, 5840.123981402823, 5852.502537284208, 5882.205902203148, 5950.464458198783, 5959.106134079922, 6151.861905547488, 6175.876482470415, 6183.474404675473, 6187.721552530057, 6189.876202476015, 6006.399360063959, 6006.639601623917, 6017.729202185999, 6043.214382130295, 6062.605930614496], "value": 5673.794001497877, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [505.2169137836354, 519.3974989012746, 521.0932976620679, 523.7171927159334, 525.9737013149341, 30274.0, 31068.0, 31463.52804707931, 40307.19385612286, 41164.588354116524, 42274.67489288088, 43209.567904320946, 43705.34441983365, 43730.34404483927, 43799.56200437995, 9659.227261819055, 9800.0, 9800.852987205197, 9815.116639502443, 9829.361091529063, 8676.566171691422, 8880.822383552326, 9742.366746161477, 9884.654037108703, 11876.10929180315, 11820.58627948022, 12135.635930922086, 12142.696432589211, 12150.817737733942, 12169.513219471255, 12152.331621760799, 12221.63335099944, 12231.082668799787, 12240.755184896252, 12272.570460033945, 8660.004099528573, 8863.601137948743, 11577.9579837815, 11866.228695134874, 11924.105692073043, 41244.79377603093, 41516.584834151574, 41568.752937411926, 41627.0, 41676.0, 3333.4833100869405, 3385.4075536780965, 3539.557555305587, 3922.3920292354733, 4001.4998125234347, 29278.70721292781, 29780.851095744598, 30550.847245763627, 32210.87261945844, 32308.676913230804, 3156.6054243219596, 3253.268014696698, 3264.967350326514, 3300.14196308959, 3414.96585034149, 520044.0, 523555.0, 524381.0, 524909.0, 527488.3625581848, 62587.68706156531, 62697.05954410687, 62782.372176277655, 62908.0, 62949.68525157345, 64786.02820957689, 64924.675376622814, 64982.67508662521, 64996.35003649998, 65002.67498662571, 16345.346186152421, 16920.57698557521, 16937.576560585836, 16948.74576881348, 16955.152242388078, 12989.116578096124, 13065.738685226432, 13070.803937940938, 13090.280034598189, 13145.73708525824, 15073.623159420882, 16322.34710611586, 16752.078635675156, 18563.72154417685, 18572.97848618339, 7744.922550774533, 7933.801654958672, 7935.404844636675, 7941.205879412013, 8004.839903201903, 835.9874601880977, 997.3118548201862, 1006.5973610555836, 1078.2021304234809, 1091.9789996353436, 27556.03553875605, 27693.446131077264, 30353.69646303509, 30785.230369240948, 30913.072607821803, 1051.1433181956681, 1062.9255952083436, 1067.492940853104, 1094.3324572011068, 1137.8577677790277, 15446.5366039019, 15747.921260393625, 15763.290651920692, 15801.051936883823, 16140.273687684083, 689284.0, 693665.0, 704304.0, 705656.0, 706724.0, 58845.41154588485, 59337.0, 59363.40636593665, 59476.0, 59837.70081149566, 1214.40494157862, 1243.800991841319, 1325.1452812935795, 1353.1948490648049, 1361.5983284931167, 30596.84701576478, 30953.845230773702, 31582.0, 31705.841470792497, 32517.512237315987, 48878.0, 49318.50681493139, 49457.50542494529, 49495.75252123716, 49545.522723862945, 566635.0, 568546.0, 569110.0, 853432.0, 890347.0, 41662.37506437345, 42117.57882421136, 42196.0, 42404.787976059924, 42534.0, 46707.0, 46933.59199224029, 47932.281015784094, 48459.0, 50210.74894625504, 38758.6124138755, 39848.40227396534, 40059.0, 40125.799371002955, 41535.261826435766, 39494.2101157981, 39507.802460987514, 39646.405303919884, 40739.0, 40825.38761918633, 38487.0, 39193.628223012056, 39213.2157356857, 39323.213535729694, 39374.2125157501, 34019.4897076549, 34887.0, 35374.646253538165, 35503.11242218965, 35700.107497312776, 25969.35076623024, 26064.609030864172, 26093.73906260913, 26417.867910660323, 26577.069802556816], "value": 20988.76347473229, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [289.892739686316, 348.5364465261203, 367.3809630772148, 370.8182990334737, 401.04151078921365, 15121.01713388629, 15237.933344665878, 15750.133742644164, 16979.91510042448, 20942.790572094276, 19413.32053378132, 19940.900295498537, 21143.259985900495, 21275.36173914785, 21394.786052139472, 5865.17887495752, 6173.166622505972, 6187.0, 6191.938080619204, 6198.3801619838105, 5728.455796699328, 5735.9962006648875, 6110.877782444349, 6171.660558669271, 6188.907166392485, 5897.764089436418, 6129.080637904305, 6143.907841382383, 6158.04550294705, 6186.319504854462, 5992.250968628921, 6099.878002439927, 6111.2055432793895, 6120.663363515027, 6131.754729810802, 5044.54599086084, 5178.533931946143, 5258.789648414059, 5293.920591191135, 5321.920171197435, 25180.24459266225, 25437.98248070075, 25829.74170258292, 25870.676363708466, 26161.345966350804, 2286.3598192506124, 2389.51015041916, 2429.7706654982544, 2795.412963277714, 3111.71994520492, 12674.80987785184, 15071.321790519452, 15481.225938703132, 15596.220188990505, 16188.838111618968, 1820.6085691576375, 1884.6513395021964, 1891.3002189190088, 1899.6580615489206, 1901.6006638605909, 112818.0, 113757.43121284424, 116891.59187175962, 118223.90656560633, 119066.0, 8923.955380223057, 9747.001864617736, 9911.603535858629, 11548.133889958286, 11670.241434306743, 14699.338529766186, 14715.705685886222, 14728.631784205481, 14768.483103091556, 14785.630359241106, 8531.0, 8634.352423568258, 8663.610137543825, 8701.825963480695, 8702.695405660772, 8602.698905538276, 8634.740957771277, 8644.740657780276, 8776.78058048554, 8847.159519845605, 4385.101054283864, 4524.298733696282, 4557.749323787158, 4558.085604046309, 4617.307403889444, 1635.8936669116708, 1886.5377982394402, 1911.7897031326543, 1920.4142736465512, 1924.2495426783566, 370.5460810507161, 379.2812620084924, 409.31644154262455, 825.8389614025208, 908.9818203636022, 11644.0, 11725.530978760924, 11740.354280514483, 11864.584739534075, 12064.457099430547, 428.9335153051282, 429.75933477252215, 435.6623616697085, 440.7003237798328, 462.9930551041737, 5087.23691446286, 6000.489958353502, 6004.459598636144, 6028.0355143176885, 6199.969000154971, 621252.0, 633471.0, 633854.0, 634600.0, 638319.0, 136807.0, 140954.0, 147260.0, 148716.0, 149094.25452872665, 435.9106383191438, 444.1516703097069, 446.26812028273656, 447.5502120369008, 448.3655627287352, 8936.553172341228, 10827.296225745617, 11293.153013523854, 11487.827682584935, 11498.597549085742, 48910.26634600555, 52548.0, 53552.19671705006, 54764.452355475936, 56688.43311566996, 83740.0, 84750.0, 85629.1437085646, 86407.13592864243, 86924.69612955685, 6833.58998460094, 8165.591720414074, 8245.340372770044, 8441.788955276168, 8453.0, 11015.889841101807, 12947.417366218355, 12968.15706979081, 13359.732805344032, 13427.26150061756, 11095.382139504285, 11595.942020289845, 11624.011958983581, 11638.6508404748, 11639.359835209145, 10787.0, 11094.112471002461, 11241.831372529256, 11336.773264534828, 11589.24669896454, 11255.04332131778, 11299.209055366046, 11473.541058357907, 11653.88346116528, 11734.0, 8213.342932565261, 8222.218889205516, 8304.211099945496, 8377.706780262906, 8382.16178382157, 9671.468069256258, 11327.207095503236, 11333.716657083309, 11337.093032557541, 11381.0], "value": 8777.414444844968, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1277.9233246005247, 1495.3271028037386, 1532.4176812811131, 1733.6619359224949, 1914.081241004317, 6299.685015749212, 8494.980602327721, 8497.235248827605, 8510.574471276426, 8526.87209691855, 7417.480776345658, 8315.41792074555, 8397.91602083979, 8908.732738017854, 8926.196642302191, 2409.3494756415757, 2433.8661373624445, 2438.2685194441597, 2444.987775061122, 2451.2891261534132, 2391.4021494626345, 2431.2827715823873, 2441.8534887906694, 2449.767272109156, 2453.031052734169, 2430.598951173063, 2434.47658753368, 2443.499082688045, 2450.4486490539575, 2451.44842410458, 2204.1844517528616, 2416.4562973331035, 2424.6726691896633, 2434.610462326037, 2442.5725498037773, 2156.1698745982753, 2263.5359751250953, 2415.685960825099, 2422.4912768318673, 2429.1133736186343, 8942.731718048404, 9006.909930900738, 9062.0, 9077.500737459502, 9089.454632722058, 5325.121354976424, 5349.251104845324, 5522.5581953443625, 5526.309211348582, 5534.501894829485, 3624.7643903146213, 3715.20123173519, 3792.829322680486, 3801.0, 3803.220339830328, 1112.8108221602265, 1116.0, 1118.7706520163347, 1143.022715578177, 1144.3305666185292, 11907.761844763143, 11958.760824783543, 12013.879861201363, 12105.97099246565, 12120.333381664004, 4539.909201816011, 4577.633789296849, 4736.5973892219545, 4738.502457242009, 4758.452777930513, 9347.766305842273, 9358.251339892793, 9362.765930851647, 9380.624775009059, 9406.341556091145, 5362.1420572708175, 5386.703731294817, 5388.46115388458, 5389.8113566025, 5390.029794637003, 4158.1760159944615, 4519.18654642161, 4689.0, 5044.470330615232, 5118.769655365518, 3857.324968130566, 3920.941185882214, 3934.2131573684806, 3964.8810535683974, 3977.9204415911518, 1177.1818586082761, 1179.3985067615406, 1189.5539172810197, 1195.4441184849086, 1204.127007919269, 747.517850986111, 846.1411667157839, 851.8126012277289, 873.1835733589114, 924.7641851327868, 5738.0, 5905.586608937333, 5995.190649262294, 6111.022236442148, 6186.783462578788, 433.2677774560982, 435.8953851075719, 454.43876812136983, 454.57724316386077, 460.6015796336145, 4007.539132999684, 4026.1746342000406, 4073.551909289976, 4082.6733861291027, 4088.7546747195265, 10785.29895556802, 11170.944145279222, 11237.157213208879, 11238.269512481662, 11284.943575282236, 11182.384968826793, 11186.0, 11186.776264474665, 11199.776004479865, 11216.55133794639, 8041.3164880984605, 8444.873326900102, 8527.317814574819, 8534.189252021048, 8537.957310213409, 5992.760289588542, 6069.939300606938, 6081.878362432815, 6196.318404975359, 6220.813375598739, 10107.64623238183, 10425.791484170122, 10474.371537707762, 10574.8413773795, 10588.788224235626, 9414.15272625467, 10115.39307641544, 10462.68611941643, 10708.0, 10749.570017199225, 6558.0, 7027.0, 7412.703491860265, 7764.61176941162, 7847.5683837387205, 8426.283765879969, 8454.788630284293, 8489.702860400104, 8518.70184543538, 8596.613152408281, 6917.27368626287, 6985.615791131333, 7010.579365238102, 7026.859462810818, 7045.542039767399, 7430.256974302527, 7511.474196806171, 7514.624268786648, 7587.658555364911, 7599.126100498514, 7184.497085203986, 7195.2085270619145, 7292.927070729437, 7309.817254568678, 7358.190599033995, 5002.449730529712, 5066.290719299227, 5146.073706732824, 5186.58507319406, 5286.022085914118, 5092.134337162765, 5120.359955005624, 5176.948230517647, 5237.790488380422, 5385.084535629031], "value": 4541.886274923101, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.3347285344401, 298.215692728125, 305.30695321619925, 308.5941986288031, 310.4876953027506, 4584.381108550345, 4999.500049994998, 5038.823641172559, 5177.249298851669, 5262.236975638531, 4192.993681516437, 4925.335079764231, 5066.417362003371, 5126.538611524962, 5128.871778205546, 3452.896413107611, 3836.0601652595155, 3912.2371137628174, 3948.2103579284117, 4046.1185548719914, 3736.4208547675153, 3956.3867600521967, 3991.44119823225, 3995.9200815983663, 4024.605359810908, 3954.5056867891512, 3957.377475235154, 3959.4558122332314, 3963.9603603964024, 3979.363301871701, 3095.8761649534104, 3246.951295730566, 3765.152840610854, 3939.980300098481, 3992.960070399288, 3413.044347582681, 3444.9492904664066, 3462.9653703462895, 3464.873915977292, 3473.7568370214094, 3999.960000399988, 4197.845592462098, 5022.874428139289, 5042.773075211588, 5121.28302037715, 4478.776061196927, 4485.865424037284, 4532.138893610204, 4541.9545804542195, 4565.908681826345, 5409.99660251415, 5435.287884316428, 5437.102878025121, 5445.1832225166145, 5507.0, 3157.8894738684266, 3486.646513603333, 3756.1594818538993, 3756.1782535470275, 3758.5113935188524, 5187.792488300463, 5586.916196257019, 5636.379998200195, 5650.1296611821035, 5658.783361577281, 3767.87115279866, 3775.86784462548, 3777.981110094432, 3795.6394142556414, 3803.3154032274456, 3863.1887303666545, 3865.439511270906, 3872.728908976401, 3874.7287689862, 3891.3968334908136, 4243.7029407941145, 4424.690271680952, 4434.911301773946, 4466.665000124939, 4594.287885377772, 5431.83704488866, 5437.646552974044, 5461.399246082928, 5473.0, 5549.944500554942, 1151.2804497189256, 1235.90622299264, 1245.302630526908, 1271.7265787855656, 1292.584619841291, 829.2371018662844, 829.5396055189307, 882.3514716683233, 885.4952676974192, 889.7731078575051, 4153.480814898137, 5121.923171152435, 5151.974240128776, 5174.353205849269, 5188.22176673502, 4657.510961349078, 5317.766538054027, 5478.287822583118, 5610.242617246619, 5698.6580805151825, 4460.553944605514, 4702.294655801657, 4849.0420843285565, 4962.03999420227, 5153.742312884341, 2026.422469596158, 2119.4277545062746, 2218.966715499269, 2254.6618007298707, 2447.9143229986867, 4160.750354978711, 4197.4753155855515, 4332.830135863363, 4703.905921881543, 4737.763111844394, 4159.812808423628, 4470.998456381521, 4517.944335327418, 4657.439757681214, 4660.720356778605, 4560.566746159109, 4715.7877895494785, 4733.455652599926, 4784.378030856036, 4794.520547945178, 3888.8833334999995, 3903.453516507748, 4165.58344165581, 4503.459584849839, 4536.72779633223, 4019.7789121598594, 4170.666346692196, 4534.417809930118, 4543.45478542577, 4549.5905368517, 4133.586641335963, 4374.650027997689, 4487.663425243185, 4707.435107787088, 4744.501827308221, 2920.8101473404163, 3119.457642021745, 3146.3392687535875, 3221.436248656523, 3263.2657652028106, 4620.75893191795, 4672.439307283148, 4677.929831052469, 5051.595872330278, 5783.363829978614, 4862.270659401118, 5259.8422047338645, 5554.638948468337, 5555.583331250092, 5585.207396301849, 5547.778088876561, 5550.972245138749, 5601.243832082617, 5652.236948011966, 5678.517326027334, 4822.903541929071, 5007.874803129951, 5372.5433338166695, 5417.756200970887, 5451.0, 4648.7443190624845, 4839.491853355347, 5478.260434841245, 5526.778928842801, 5545.279113715191, 5242.737863106753, 5448.139726643544, 5463.48096930791, 5484.533814625642, 5499.50504454601], "value": 3798.102639380497, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [673.9258681545031, 708.029998901505, 724.1455083002058, 742.6286856571714, 805.4482679364636, 15020.399184032625, 16283.674326513477, 16331.83668163318, 16821.663566728657, 17384.304627814905, 15170.544883653509, 15186.696266074672, 15189.696206075872, 15208.0, 15309.311081001353, 668.7391917152314, 832.7585000349891, 862.3230763850379, 862.4394143806513, 863.1799790199304, 690.1511141296209, 695.2769120115074, 831.2103501673404, 848.7453763870845, 864.7967727584013, 891.777055736066, 895.5969813583881, 895.6551727584895, 896.1486587741639, 897.5422534507416, 888.5557221389305, 889.0265159650173, 889.8175873945826, 890.6214858685065, 891.8662200669886, 516.5867306155061, 534.6311045378715, 640.9134766806468, 656.2125449460666, 661.8146918862678, 14764.557063288119, 15378.692426151414, 15409.998350107207, 15424.22878856064, 15424.76862847047, 13415.329233538381, 13705.670036093888, 13818.239996800172, 14021.298935053308, 14338.0, 10631.468426578718, 11092.33445993235, 12340.814887776602, 13280.07039507235, 13350.773578029293, 4356.390105385249, 4403.163398954221, 4651.697639653446, 4691.859244222679, 4746.359241502388, 86791.13208867893, 95586.0, 120361.0, 126007.47985040248, 129261.0, 10170.593176273014, 10911.018008379284, 10955.397453139994, 10982.725431864108, 11010.669679909455, 21255.893720531607, 21270.893645531673, 21303.573928521342, 21303.68044479334, 21336.466588335417, 7681.0, 7863.842723145505, 7898.960505197552, 8122.75631731049, 8175.0, 4276.636485898671, 4280.186764514732, 4433.224185767478, 4444.799984000728, 4464.196444639931, 3512.8594856205464, 3626.673599376069, 3630.346537623253, 3632.3461776879885, 3645.9453108203397, 655.6787174284566, 660.4815220052332, 667.8697653957431, 692.4391243093111, 694.1427337238506, 580.6080895395592, 618.0358640520802, 621.6580880515698, 627.6830200748593, 630.8202162383699, 7148.428125749928, 8116.675332986614, 9053.411528250643, 9088.182063614306, 9131.223845973167, 521.7495602111007, 607.3198018219534, 623.1307326279905, 636.424036247197, 651.794684674326, 3810.580836108026, 4286.357046442996, 4442.4669039715445, 4497.190505709003, 4565.406497155349, 105271.4736426313, 126115.0, 153661.0, 164430.17784911237, 167468.0, 79553.20446795458, 82560.17439825645, 105743.41384879233, 129567.98672112975, 139659.90510142356, 105078.0, 107379.926200737, 109782.45108774405, 111704.0, 112845.0, 8072.798180045545, 10106.696799096038, 10124.544395502367, 10146.695599132037, 10151.390916545031, 58588.70705646615, 62210.0, 64436.35563644491, 65736.67131664311, 66749.33002679839, 61343.693281533306, 63371.683141584, 84764.57617711872, 90131.64802528099, 90289.54855225682, 12065.907717306127, 12399.194052386567, 12551.686207844878, 13375.799363009368, 13496.122752021087, 11875.287482751062, 14194.290285485891, 14952.626184345478, 15660.608484787972, 15739.0, 11476.368799715761, 12639.747205056032, 13557.525486607921, 13774.173549587056, 13976.951728620597, 13373.799393008918, 13694.315284235947, 13709.383077761724, 13878.861211387757, 14690.779638305221, 13026.54407095747, 13223.471061157446, 13763.174209547458, 14274.571762847132, 14329.996900216885, 10707.464626768786, 10753.672355729883, 11100.944495277472, 11481.96662300397, 11558.47986840611, 10350.792984140426, 11378.829317560409, 11520.27296671747, 11703.063754899418, 11769.293842369485], "value": 7729.56018854881, "unit": "score"}], "name": "dromaeo_css", "value": 7200.665253619193, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 113.0, 112.0, 114.0, 112.0, 112.0, 111.0, 112.0, 116.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 114.0, 138.0, 174.0, 110.0, 109.0, 108.0, 111.0, 131.0, 108.0], "value": 124.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 181.0, 184.0, 182.0, 183.0, 181.0, 182.0, 183.0, 182.0, 186.0], "value": 182.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 60.0, 58.0, 97.0, 86.0, 82.0, 80.0, 61.0, 84.0, 58.0], "value": 74.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 72.0, 94.0, 70.0, 68.0, 69.0, 93.0, 67.0, 69.0, 91.0], "value": 78.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 87.0, 91.0, 88.0, 91.0, 87.0, 91.0, 88.0, 90.0, 87.0], "value": 89.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 96.0, 97.0, 95.0, 97.0, 96.0, 97.0, 96.0, 96.0], "value": 96.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 83.0, 82.0, 83.0, 83.0, 84.0, 83.0, 84.0, 84.0], "value": 83.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 55.0, 55.0, 55.0, 57.0, 58.0, 57.0, 58.0, 58.0, 56.0], "value": 56.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 75.0, 76.0, 72.0, 70.0, 69.0, 71.0, 74.0, 71.0], "value": 71.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 82.0, 84.0, 84.0, 85.0, 85.0, 83.0, 98.0, 102.0], "value": 86.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 138.0, 140.0, 142.0, 154.0, 130.0, 147.0, 155.0, 195.0, 138.0], "value": 147.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 168.0, 163.0, 163.0, 165.0, 165.0, 162.0, 165.0, 165.0, 164.0], "value": 164.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 67.0, 68.0, 66.0, 67.0, 66.0, 66.0, 65.0, 78.0], "value": 67.9, "unit": "score"}], "name": "kraken", "value": 1436.3000000000002, "alertThreshold": 2.0}]} 03:47:15 INFO - Return code: 0 03:47:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:47:15 INFO - # TBPL SUCCESS # 03:47:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:47:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:47:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:47:15 INFO - 2016-11-09 03:47:15.424 screenresolution[1700:11063] starting screenresolution argv=screenresolution get 03:47:15 INFO - 2016-11-09 03:47:15.427 screenresolution[1700:11063] Display 0: 1600x1200x32@60 03:47:15 INFO - 2016-11-09 03:47:15.433 screenresolution[1701:11066] starting screenresolution argv=screenresolution list 03:47:15 INFO - Available Modes on Display 0 03:47:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:47:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:47:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:47:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:47:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:47:15 INFO - Intel Iris: 03:47:15 INFO - Chipset Model: Intel Iris 03:47:15 INFO - Type: GPU 03:47:15 INFO - Bus: Built-In 03:47:15 INFO - VRAM (Dynamic, Max): 1536 MB 03:47:15 INFO - Vendor: Intel (0x8086) 03:47:15 INFO - Device ID: 0x0a2e 03:47:15 INFO - Revision ID: 0x0009 03:47:15 INFO - Displays: 03:47:15 INFO - Display: 03:47:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:47:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:47:15 INFO - Display Serial Number: 1600x1200 60 03:47:15 INFO - Main Display: Yes 03:47:15 INFO - Mirror: Off 03:47:15 INFO - Online: Yes 03:47:15 INFO - Rotation: Supported 03:47:15 INFO - Return code: 0 03:47:15 INFO - Running post-action listener: _resource_record_post_action 03:47:15 INFO - [mozharness: 2016-11-09 11:47:15.668446Z] Finished run-tests step (success) 03:47:15 INFO - Running post-run listener: _resource_record_post_run 03:47:15 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 31484928; Write bytes: 667085824; Read time: 198; Write time: 1874 03:47:15 INFO - TinderboxPrint: CPU usage
53.6% 03:47:15 INFO - TinderboxPrint: I/O read bytes / time
31,484,928 / 198 03:47:15 INFO - TinderboxPrint: I/O write bytes / time
667,085,824 / 1,874 03:47:15 INFO - TinderboxPrint: CPU idle
2,248.0 (46.4%) 03:47:15 INFO - TinderboxPrint: CPU system
975.5 (20.1%) 03:47:15 INFO - TinderboxPrint: CPU user
1,618.2 (33.4%) 03:47:15 INFO - TinderboxPrint: Swap in / out
405,561,344 / 0 03:47:15 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 351928832; Write bytes: 347203584; Read time: 27323; Write time: 697 03:47:15 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 30559232; Write bytes: 299713536; Read time: 185; Write time: 1116 03:47:16 INFO - Running post-run listener: _upload_blobber_files 03:47:16 INFO - Blob upload gear active. 03:47:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:47:16 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 03:47:16 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'] 03:47:16 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 03:47:16 INFO - (blobuploader) - INFO - Open directory for files ... 03:47:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:47:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:47:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:47:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:47:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:47:18 INFO - (blobuploader) - INFO - Done attempting. 03:47:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:47:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:47:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:47:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:47:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:47:18 INFO - (blobuploader) - INFO - Done attempting. 03:47:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:47:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:47:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:47:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:47:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:47:21 INFO - (blobuploader) - INFO - Done attempting. 03:47:21 INFO - (blobuploader) - INFO - Iteration through files over. 03:47:21 INFO - Return code: 0 03:47:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:47:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:47:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eb84b2a65dc8e4cc2a1dc300ae594de5bce720b6d340a98b25332bb1b84d098f09e570db2dd49af30d3544354f71b4ed2a500399799a839cc9749efed7e37aa2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/376d12025174d052746a0e7971259962092ab9f95671b600cbcb72077c88bc0baf28c933c6595a4822f9c20a17e68877b78e8da072eaabd93d627f3f7acc1fa7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/920498fed9283eaf2723e59787346c2e7466da34e3bbb71d4310cc0cbe3a10b63841217e7a6d6808353f3080ee7e2df67bd4f2f5f9913eb265c1cde4c3b5ad6d"} 03:47:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:47:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:47:21 INFO - Contents: 03:47:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eb84b2a65dc8e4cc2a1dc300ae594de5bce720b6d340a98b25332bb1b84d098f09e570db2dd49af30d3544354f71b4ed2a500399799a839cc9749efed7e37aa2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/376d12025174d052746a0e7971259962092ab9f95671b600cbcb72077c88bc0baf28c933c6595a4822f9c20a17e68877b78e8da072eaabd93d627f3f7acc1fa7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/920498fed9283eaf2723e59787346c2e7466da34e3bbb71d4310cc0cbe3a10b63841217e7a6d6808353f3080ee7e2df67bd4f2f5f9913eb265c1cde4c3b5ad6d"} 03:47:21 INFO - Running post-run listener: copy_logs_to_upload_dir 03:47:21 INFO - Copying logs to upload dir... 03:47:21 INFO - mkdir: /builds/slave/test/build/upload/logs 03:47:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.757555 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-11-09 03:47:21.742532) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-09 03:47:21.745972) ========= 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.vy8KqcmGC9/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.5HtjpL18B6/Listeners TMPDIR=/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/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/eb84b2a65dc8e4cc2a1dc300ae594de5bce720b6d340a98b25332bb1b84d098f09e570db2dd49af30d3544354f71b4ed2a500399799a839cc9749efed7e37aa2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/376d12025174d052746a0e7971259962092ab9f95671b600cbcb72077c88bc0baf28c933c6595a4822f9c20a17e68877b78e8da072eaabd93d627f3f7acc1fa7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/920498fed9283eaf2723e59787346c2e7466da34e3bbb71d4310cc0cbe3a10b63841217e7a6d6808353f3080ee7e2df67bd4f2f5f9913eb265c1cde4c3b5ad6d"} build_url:https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011286 build_url: 'https://queue.taskcluster.net/v1/task/MeZ56M-CRPeAGb0r2CMghg/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/eb84b2a65dc8e4cc2a1dc300ae594de5bce720b6d340a98b25332bb1b84d098f09e570db2dd49af30d3544354f71b4ed2a500399799a839cc9749efed7e37aa2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/376d12025174d052746a0e7971259962092ab9f95671b600cbcb72077c88bc0baf28c933c6595a4822f9c20a17e68877b78e8da072eaabd93d627f3f7acc1fa7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/920498fed9283eaf2723e59787346c2e7466da34e3bbb71d4310cc0cbe3a10b63841217e7a6d6808353f3080ee7e2df67bd4f2f5f9913eb265c1cde4c3b5ad6d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-09 03:47:21.778753) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-09 03:47:21.779140) ========= 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.vy8KqcmGC9/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.5HtjpL18B6/Listeners TMPDIR=/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/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.005261 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-09 03:47:21.827191) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-09 03:47:21.827488) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-09 03:47:21.827817) ========= ========= Total master_lag: 0.18 =========