builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0019 starttime: 1482323446.31 results: success (0) buildid: 20161221030226 builduid: 708b18f2d9924be8b193fce70bfac4c7 revision: c36fbe84042debef0a5d58b7fc88185b401762ce ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-21 04:30:46.305441) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-21 04:30:46.305885) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-21 04:30:46.306184) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-21 04:30:46.335311) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 04:30:46.335626) ========= 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.PNKZHq7HqN/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.lEPvIyOBsC/Listeners TMPDIR=/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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-12-21 04:30:46-- 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% 8.60M=0.001s 2016-12-21 04:30:46 (8.60 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.080556 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 04:30:46.439951) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 04:30:46.443307) ========= 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.PNKZHq7HqN/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.lEPvIyOBsC/Listeners TMPDIR=/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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.029546 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 04:30:46.494095) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-21 04:30:46.494452) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c36fbe84042debef0a5d58b7fc88185b401762ce --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev c36fbe84042debef0a5d58b7fc88185b401762ce --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.PNKZHq7HqN/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.lEPvIyOBsC/Listeners TMPDIR=/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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-12-21 04:30:46,578 truncating revision to first 12 chars 2016-12-21 04:30:46,579 Setting DEBUG logging. 2016-12-21 04:30:46,579 attempt 1/10 2016-12-21 04:30:46,579 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c36fbe84042d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-21 04:30:47,860 unpacking tar archive at: mozilla-central-c36fbe84042d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.557218 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-21 04:30:48.077947) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-21 04:30:48.078287) ========= script_repo_revision: c36fbe84042debef0a5d58b7fc88185b401762ce ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-21 04:30:48.078673) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-21 04:30:48.078946) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-21 04:30:48.101369) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-12-21 04:30:48.101680) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.PNKZHq7HqN/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.lEPvIyOBsC/Listeners TMPDIR=/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:30:48 INFO - MultiFileLogger online at 20161221 04:30:48 in /builds/slave/test 04:30:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:30:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:30:48 INFO - {'append_to_log': False, 04:30:48 INFO - 'base_work_dir': '/builds/slave/test', 04:30:48 INFO - 'blob_upload_branch': 'Firefox', 04:30:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:30:48 INFO - 'branch': 'Firefox', 04:30:48 INFO - 'buildbot_json_path': 'buildprops.json', 04:30:48 INFO - 'config_files': ('talos/mac_config.py',), 04:30:48 INFO - 'default_actions': ('clobber', 04:30:48 INFO - 'read-buildbot-config', 04:30:48 INFO - 'download-and-extract', 04:30:48 INFO - 'populate-webroot', 04:30:48 INFO - 'create-virtualenv', 04:30:48 INFO - 'install', 04:30:48 INFO - 'run-tests'), 04:30:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:30:48 INFO - 'download_minidump_stackwalk': True, 04:30:48 INFO - 'download_symbols': 'ondemand', 04:30:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:30:48 INFO - 'tooltool.py': '/tools/tooltool.py', 04:30:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:30:48 INFO - '/tools/misc-python/virtualenv.py')}, 04:30:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:30:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:30:48 INFO - 'installer_path': 'installer.exe', 04:30:48 INFO - 'log_level': 'info', 04:30:48 INFO - 'log_name': 'talos', 04:30:48 INFO - 'log_to_console': True, 04:30:48 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:30:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:30:48 INFO - 'opt_config_files': (), 04:30:48 INFO - 'pip_index': False, 04:30:48 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:30:48 INFO - 'cmd': ('bash', 04:30:48 INFO - '-c', 04:30:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:30:48 INFO - 'enabled': True, 04:30:48 INFO - 'halt_on_failure': False, 04:30:48 INFO - 'name': 'check_screen_resolution'},), 04:30:48 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:30:48 INFO - 'cmd': ('bash', 04:30:48 INFO - '-c', 04:30:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:30:48 INFO - 'enabled': True, 04:30:48 INFO - 'halt_on_failure': False, 04:30:48 INFO - 'name': 'check_screen_resolution'},), 04:30:48 INFO - 'run_cmd_checks_enabled': True, 04:30:48 INFO - 'sps_profile': False, 04:30:48 INFO - 'sps_profile_interval': 0, 04:30:48 INFO - 'suite': 'dromaeojs', 04:30:48 INFO - 'system_bits': '32', 04:30:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:30:48 INFO - 'title': 't-yosemite-r7-0019', 04:30:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:30:48 INFO - 'use_talos_json': True, 04:30:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:30:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:30:48 INFO - 'work_dir': 'build'} 04:30:48 INFO - [mozharness: 2016-12-21 12:30:48.299624Z] Running clobber step. 04:30:48 INFO - Running pre-action listener: _resource_record_pre_action 04:30:48 INFO - Running main action method: clobber 04:30:48 INFO - rmtree: /builds/slave/test/build 04:30:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:30:50 INFO - Running post-action listener: _resource_record_post_action 04:30:50 INFO - [mozharness: 2016-12-21 12:30:50.514839Z] Finished clobber step (success) 04:30:50 INFO - [mozharness: 2016-12-21 12:30:50.514985Z] Running read-buildbot-config step. 04:30:50 INFO - Running pre-action listener: _resource_record_pre_action 04:30:50 INFO - Running main action method: read_buildbot_config 04:30:50 INFO - Using buildbot properties: 04:30:50 INFO - { 04:30:50 INFO - "project": "", 04:30:50 INFO - "product": "firefox", 04:30:50 INFO - "script_repo_revision": "production", 04:30:50 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:30:50 INFO - "repository": "", 04:30:50 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:30:50 INFO - "buildid": "20161221030226", 04:30:50 INFO - "stage_platform": "macosx64", 04:30:50 INFO - "basedir": "/builds/slave/test", 04:30:50 INFO - "nightly_build": "True", 04:30:50 INFO - "buildnumber": 36, 04:30:50 INFO - "slavename": "t-yosemite-r7-0019", 04:30:50 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 04:30:50 INFO - "platform": "yosemite_r7", 04:30:50 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:30:50 INFO - "branch": "mozilla-central", 04:30:50 INFO - "repo_path": "mozilla-central", 04:30:50 INFO - "revision": "c36fbe84042debef0a5d58b7fc88185b401762ce", 04:30:50 INFO - "pgo_build": "False", 04:30:50 INFO - "builduid": "708b18f2d9924be8b193fce70bfac4c7", 04:30:50 INFO - "slavebuilddir": "test" 04:30:50 INFO - } 04:30:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/b_qIylNJRFOe1M43kocNSg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 04:30:50 INFO - Running post-action listener: _resource_record_post_action 04:30:50 INFO - [mozharness: 2016-12-21 12:30:50.518560Z] Finished read-buildbot-config step (success) 04:30:50 INFO - [mozharness: 2016-12-21 12:30:50.518682Z] Running download-and-extract step. 04:30:50 INFO - Running pre-action listener: _resource_record_pre_action 04:30:50 INFO - Running main action method: download_and_extract 04:30:50 INFO - mkdir: /builds/slave/test/build/tests 04:30:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:50 INFO - trying https://queue.taskcluster.net/v1/task/b_qIylNJRFOe1M43kocNSg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 04:30:50 INFO - Downloading https://queue.taskcluster.net/v1/task/b_qIylNJRFOe1M43kocNSg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 04:30:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b_qIylNJRFOe1M43kocNSg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 04:30:51 INFO - Downloaded 1199 bytes. 04:30:51 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 04:30:51 INFO - Using the following test package requirements: 04:30:51 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 04:30:51 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:30:51 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 04:30:51 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:30:51 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 04:30:51 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:30:51 INFO - u'jsshell-mac.zip'], 04:30:51 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:30:51 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 04:30:51 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 04:30:51 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:30:51 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 04:30:51 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:30:51 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 04:30:51 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:30:51 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 04:30:51 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:30:51 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 04:30:51 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:30:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/b_qIylNJRFOe1M43kocNSg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 04:30:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b_qIylNJRFOe1M43kocNSg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:30:51 INFO - Fetch https://queue.taskcluster.net/v1/task/b_qIylNJRFOe1M43kocNSg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 04:30:52 INFO - Expected file size: 16277834 04:30:52 INFO - Obtained file size: 16277834 04:30:59 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:30:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/b_qIylNJRFOe1M43kocNSg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 04:30:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b_qIylNJRFOe1M43kocNSg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:30:59 INFO - Fetch https://queue.taskcluster.net/v1/task/b_qIylNJRFOe1M43kocNSg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 04:31:00 INFO - Expected file size: 16277834 04:31:00 INFO - Obtained file size: 16277834 04:31:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/b_qIylNJRFOe1M43kocNSg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 04:31:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b_qIylNJRFOe1M43kocNSg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:31:06 INFO - Fetch https://queue.taskcluster.net/v1/task/b_qIylNJRFOe1M43kocNSg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 04:31:07 INFO - Expected file size: 14409734 04:31:07 INFO - Obtained file size: 14409734 04:31:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:08 INFO - trying https://queue.taskcluster.net/v1/task/b_qIylNJRFOe1M43kocNSg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 04:31:08 INFO - Downloading https://queue.taskcluster.net/v1/task/b_qIylNJRFOe1M43kocNSg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 04:31:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b_qIylNJRFOe1M43kocNSg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 04:31:10 INFO - Downloaded 69634748 bytes. 04:31:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/b_qIylNJRFOe1M43kocNSg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 04:31:10 INFO - mkdir: /builds/slave/test/properties 04:31:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:31:10 INFO - Writing to file /builds/slave/test/properties/build_url 04:31:10 INFO - Contents: 04:31:10 INFO - build_url:https://queue.taskcluster.net/v1/task/b_qIylNJRFOe1M43kocNSg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 04:31:11 INFO - Running post-action listener: _resource_record_post_action 04:31:11 INFO - Running post-action listener: set_extra_try_arguments 04:31:11 INFO - [mozharness: 2016-12-21 12:31:11.257251Z] Finished download-and-extract step (success) 04:31:11 INFO - [mozharness: 2016-12-21 12:31:11.257376Z] Running populate-webroot step. 04:31:11 INFO - Running pre-action listener: _resource_record_pre_action 04:31:11 INFO - Running main action method: populate_webroot 04:31:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:31:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:31:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:31:11 INFO - '--tppagecycles', 04:31:11 INFO - '7'], 04:31:11 INFO - 'tests': ['tsvgm']}}, 04:31:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:31:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:31:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:31:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:31:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:31:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:31:11 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:31:11 INFO - 'talos_options': ['--disable-e10s'], 04:31:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:31:11 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:31:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:31:11 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:31:11 INFO - 'talos_options': ['--disable-e10s'], 04:31:11 INFO - 'tests': ['damp', 'tps']}, 04:31:11 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:31:11 INFO - 'tests': ['damp', 'tps']}, 04:31:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:31:11 INFO - 'tests': ['dromaeo_dom']}, 04:31:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:31:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:31:11 INFO - 'tests': ['basic_compositor_video']}, 04:31:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:31:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:31:11 INFO - 'tests': ['a11yr', 04:31:11 INFO - 'ts_paint', 04:31:11 INFO - 'tpaint', 04:31:11 INFO - 'sessionrestore', 04:31:11 INFO - 'sessionrestore_no_auto_restore', 04:31:11 INFO - 'tabpaint']}, 04:31:11 INFO - 'other-e10s': {'tests': ['a11yr', 04:31:11 INFO - 'ts_paint', 04:31:11 INFO - 'tpaint', 04:31:11 INFO - 'sessionrestore', 04:31:11 INFO - 'sessionrestore_no_auto_restore', 04:31:11 INFO - 'tabpaint']}, 04:31:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:31:11 INFO - 'ts_paint', 04:31:11 INFO - 'tpaint', 04:31:11 INFO - 'sessionrestore', 04:31:11 INFO - 'sessionrestore_no_auto_restore', 04:31:11 INFO - 'tabpaint']}, 04:31:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:31:11 INFO - 'ts_paint', 04:31:11 INFO - 'tpaint', 04:31:11 INFO - 'sessionrestore', 04:31:11 INFO - 'sessionrestore_no_auto_restore', 04:31:11 INFO - 'tabpaint']}, 04:31:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:31:11 INFO - 'tests': ['a11yr', 04:31:11 INFO - 'ts_paint', 04:31:11 INFO - 'tpaint', 04:31:11 INFO - 'sessionrestore', 04:31:11 INFO - 'sessionrestore_no_auto_restore', 04:31:11 INFO - 'tabpaint']}, 04:31:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:31:11 INFO - 'tests': ['a11yr', 04:31:11 INFO - 'ts_paint', 04:31:11 INFO - 'tpaint', 04:31:11 INFO - 'sessionrestore', 04:31:11 INFO - 'sessionrestore_no_auto_restore', 04:31:11 INFO - 'tabpaint']}, 04:31:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:31:11 INFO - 'tests': ['tsvgx', 04:31:11 INFO - 'tsvgr_opacity', 04:31:11 INFO - 'tart', 04:31:11 INFO - 'tscrollx', 04:31:11 INFO - 'cart', 04:31:11 INFO - 'tsvg_static']}, 04:31:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:31:11 INFO - 'tsvgr_opacity', 04:31:11 INFO - 'tart', 04:31:11 INFO - 'tscrollx', 04:31:11 INFO - 'cart', 04:31:11 INFO - 'tsvg_static']}, 04:31:11 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:31:11 INFO - 'talos_options': ['--disable-e10s'], 04:31:11 INFO - 'tests': ['tp5o']}, 04:31:11 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:31:11 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:31:11 INFO - 'talos_options': ['--disable-e10s', 04:31:11 INFO - '--xperf_path', 04:31:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:31:11 INFO - 'tests': ['tp5n']}, 04:31:11 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:31:11 INFO - 'talos_options': ['--xperf_path', 04:31:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:31:11 INFO - 'tests': ['tp5n']}}, 04:31:11 INFO - 'talos.zip': {'path': '', 04:31:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:31:11 INFO - Running post-action listener: _resource_record_post_action 04:31:11 INFO - [mozharness: 2016-12-21 12:31:11.275870Z] Finished populate-webroot step (success) 04:31:11 INFO - [mozharness: 2016-12-21 12:31:11.276004Z] Running create-virtualenv step. 04:31:11 INFO - Running pre-action listener: _resource_record_pre_action 04:31:11 INFO - Running main action method: create_virtualenv 04:31:11 INFO - Creating virtualenv /builds/slave/test/build/venv 04:31:11 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:31:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:31:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:31:11 INFO - Using real prefix '/tools/python27' 04:31:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:31:12 INFO - Installing distribute.............................................................................................................................................................................................done. 04:31:14 INFO - Installing pip.................done. 04:31:14 INFO - Return code: 0 04:31:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:31:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:31:15 INFO - Reading from file tmpfile_stdout 04:31:15 INFO - Output received: 04:31:15 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:31:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:31:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:15 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 0x10b738b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b73b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92fa4c76a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b516d30>, '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 0x10b43ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b50bbe8>, '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.PNKZHq7HqN/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.lEPvIyOBsC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:31:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:31:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:31:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PNKZHq7HqN/Render', 04:31:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:31:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:31:15 INFO - 'HOME': '/Users/cltbld', 04:31:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:31:15 INFO - 'LOGNAME': 'cltbld', 04:31:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:15 INFO - 'MOZ_NO_REMOTE': '1', 04:31:15 INFO - 'NO_EM_RESTART': '1', 04:31:15 INFO - 'PAGER': '/bin/cat', 04:31:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:31:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:15 INFO - 'PWD': '/builds/slave/test', 04:31:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:31:15 INFO - 'SHELL': '/bin/bash', 04:31:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lEPvIyOBsC/Listeners', 04:31:15 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 04:31:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:31:15 INFO - 'USER': 'cltbld', 04:31:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:31:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:31:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:15 INFO - 'XPC_FLAGS': '0x0', 04:31:15 INFO - 'XPC_SERVICE_NAME': '0', 04:31:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:31:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:15 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:31:15 INFO - Cleaning up... 04:31:15 INFO - Return code: 0 04:31:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:31:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:15 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 0x10b738b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b73b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92fa4c76a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b516d30>, '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 0x10b43ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b50bbe8>, '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.PNKZHq7HqN/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.lEPvIyOBsC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:31:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:31:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:31:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PNKZHq7HqN/Render', 04:31:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:31:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:31:15 INFO - 'HOME': '/Users/cltbld', 04:31:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:31:15 INFO - 'LOGNAME': 'cltbld', 04:31:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:15 INFO - 'MOZ_NO_REMOTE': '1', 04:31:15 INFO - 'NO_EM_RESTART': '1', 04:31:15 INFO - 'PAGER': '/bin/cat', 04:31:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:31:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:15 INFO - 'PWD': '/builds/slave/test', 04:31:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:31:15 INFO - 'SHELL': '/bin/bash', 04:31:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lEPvIyOBsC/Listeners', 04:31:15 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 04:31:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:31:15 INFO - 'USER': 'cltbld', 04:31:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:31:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:31:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:15 INFO - 'XPC_FLAGS': '0x0', 04:31:15 INFO - 'XPC_SERVICE_NAME': '0', 04:31:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:31:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:15 INFO - Downloading/unpacking psutil>=3.1.1 04:31:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:31:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:31:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:31:19 INFO - Installing collected packages: psutil 04:31:19 INFO - Running setup.py install for psutil 04:31:19 INFO - building 'psutil._psutil_osx' extension 04:31:19 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:31:19 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:31:19 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:31:20 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:31:20 INFO - building 'psutil._psutil_posix' extension 04:31:20 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:31:20 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:31:20 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:31:20 INFO - ^ 04:31:20 INFO - 1 warning generated. 04:31:20 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:31:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:31:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:31:20 INFO - Successfully installed psutil 04:31:20 INFO - Cleaning up... 04:31:20 INFO - Return code: 0 04:31:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:31:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:20 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 0x10b738b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b73b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92fa4c76a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b516d30>, '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 0x10b43ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b50bbe8>, '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.PNKZHq7HqN/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.lEPvIyOBsC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:31:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:31:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:31:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PNKZHq7HqN/Render', 04:31:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:31:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:31:20 INFO - 'HOME': '/Users/cltbld', 04:31:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:31:20 INFO - 'LOGNAME': 'cltbld', 04:31:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:20 INFO - 'MOZ_NO_REMOTE': '1', 04:31:20 INFO - 'NO_EM_RESTART': '1', 04:31:20 INFO - 'PAGER': '/bin/cat', 04:31:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:31:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:20 INFO - 'PWD': '/builds/slave/test', 04:31:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:31:20 INFO - 'SHELL': '/bin/bash', 04:31:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lEPvIyOBsC/Listeners', 04:31:20 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 04:31:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:31:20 INFO - 'USER': 'cltbld', 04:31:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:31:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:31:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:20 INFO - 'XPC_FLAGS': '0x0', 04:31:20 INFO - 'XPC_SERVICE_NAME': '0', 04:31:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:31:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:31:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:31:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:31:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:31:23 INFO - Installing collected packages: mozsystemmonitor 04:31:23 INFO - Running setup.py install for mozsystemmonitor 04:31:23 INFO - Successfully installed mozsystemmonitor 04:31:23 INFO - Cleaning up... 04:31:23 INFO - Return code: 0 04:31:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:31:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b738b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b73b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92fa4c76a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b516d30>, '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 0x10b43ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b50bbe8>, '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.PNKZHq7HqN/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.lEPvIyOBsC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:31:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:31:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:31:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PNKZHq7HqN/Render', 04:31:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:31:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:31:23 INFO - 'HOME': '/Users/cltbld', 04:31:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:31:23 INFO - 'LOGNAME': 'cltbld', 04:31:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:23 INFO - 'MOZ_NO_REMOTE': '1', 04:31:23 INFO - 'NO_EM_RESTART': '1', 04:31:23 INFO - 'PAGER': '/bin/cat', 04:31:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:31:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:23 INFO - 'PWD': '/builds/slave/test', 04:31:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:31:23 INFO - 'SHELL': '/bin/bash', 04:31:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lEPvIyOBsC/Listeners', 04:31:23 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 04:31:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:31:23 INFO - 'USER': 'cltbld', 04:31:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:31:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:31:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:23 INFO - 'XPC_FLAGS': '0x0', 04:31:23 INFO - 'XPC_SERVICE_NAME': '0', 04:31:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:31:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:23 INFO - Downloading/unpacking jsonschema==2.5.1 04:31:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:31:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:31:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:26 INFO - Downloading functools32-3.2.3-2.tar.gz 04:31:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:31:27 INFO - warning: no files found matching '*.txt' 04:31:27 INFO - no previously-included directories found matching 'build' 04:31:27 INFO - no previously-included directories found matching 'dist' 04:31:27 INFO - no previously-included directories found matching '.git*' 04:31:27 INFO - Installing collected packages: jsonschema, functools32 04:31:27 INFO - Running setup.py install for functools32 04:31:27 INFO - warning: no files found matching '*.txt' 04:31:27 INFO - no previously-included directories found matching 'build' 04:31:27 INFO - no previously-included directories found matching 'dist' 04:31:27 INFO - no previously-included directories found matching '.git*' 04:31:27 INFO - Successfully installed jsonschema functools32 04:31:27 INFO - Cleaning up... 04:31:27 INFO - Return code: 0 04:31:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:31:27 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')]} 04:31:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:27 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')]} 04:31:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:27 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 0x10b738b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b73b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92fa4c76a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b516d30>, '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 0x10b43ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b50bbe8>, '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.PNKZHq7HqN/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.lEPvIyOBsC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:31:27 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 04:31:27 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 04:31:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PNKZHq7HqN/Render', 04:31:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:31:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:31:27 INFO - 'HOME': '/Users/cltbld', 04:31:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:31:27 INFO - 'LOGNAME': 'cltbld', 04:31:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:27 INFO - 'MOZ_NO_REMOTE': '1', 04:31:27 INFO - 'NO_EM_RESTART': '1', 04:31:27 INFO - 'PAGER': '/bin/cat', 04:31:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:31:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:27 INFO - 'PWD': '/builds/slave/test', 04:31:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:31:27 INFO - 'SHELL': '/bin/bash', 04:31:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lEPvIyOBsC/Listeners', 04:31:27 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 04:31:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:31:27 INFO - 'USER': 'cltbld', 04:31:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:31:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:31:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:27 INFO - 'XPC_FLAGS': '0x0', 04:31:27 INFO - 'XPC_SERVICE_NAME': '0', 04:31:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:31:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:31:27 INFO - Cleaning up... 04:31:27 INFO - Return code: 0 04:31:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:31:27 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')]} 04:31:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:27 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')]} 04:31:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:27 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 0x10b738b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b73b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92fa4c76a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b516d30>, '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 0x10b43ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b50bbe8>, '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.PNKZHq7HqN/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.lEPvIyOBsC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:31:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:31:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:31:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PNKZHq7HqN/Render', 04:31:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:31:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:31:27 INFO - 'HOME': '/Users/cltbld', 04:31:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:31:27 INFO - 'LOGNAME': 'cltbld', 04:31:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:27 INFO - 'MOZ_NO_REMOTE': '1', 04:31:27 INFO - 'NO_EM_RESTART': '1', 04:31:27 INFO - 'PAGER': '/bin/cat', 04:31:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:31:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:27 INFO - 'PWD': '/builds/slave/test', 04:31:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:31:27 INFO - 'SHELL': '/bin/bash', 04:31:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lEPvIyOBsC/Listeners', 04:31:27 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 04:31:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:31:27 INFO - 'USER': 'cltbld', 04:31:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:31:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:31:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:27 INFO - 'XPC_FLAGS': '0x0', 04:31:27 INFO - 'XPC_SERVICE_NAME': '0', 04:31:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:31:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:27 INFO - Downloading/unpacking blobuploader==1.2.4 04:31:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:30 INFO - Downloading blobuploader-1.2.4.tar.gz 04:31:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:31:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:31:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:31:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:31 INFO - Downloading docopt-0.6.1.tar.gz 04:31:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:31:31 INFO - Installing collected packages: blobuploader, requests, docopt 04:31:31 INFO - Running setup.py install for blobuploader 04:31:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:31:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:31:32 INFO - Running setup.py install for requests 04:31:32 INFO - Running setup.py install for docopt 04:31:32 INFO - Successfully installed blobuploader requests docopt 04:31:32 INFO - Cleaning up... 04:31:32 INFO - Return code: 0 04:31:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:31:32 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')]} 04:31:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:32 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')]} 04:31:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:32 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 0x10b738b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b73b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92fa4c76a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b516d30>, '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 0x10b43ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b50bbe8>, '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.PNKZHq7HqN/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.lEPvIyOBsC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:31:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:31:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:31:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PNKZHq7HqN/Render', 04:31:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:31:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:31:32 INFO - 'HOME': '/Users/cltbld', 04:31:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:31:32 INFO - 'LOGNAME': 'cltbld', 04:31:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:32 INFO - 'MOZ_NO_REMOTE': '1', 04:31:32 INFO - 'NO_EM_RESTART': '1', 04:31:32 INFO - 'PAGER': '/bin/cat', 04:31:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:31:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:32 INFO - 'PWD': '/builds/slave/test', 04:31:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:31:32 INFO - 'SHELL': '/bin/bash', 04:31:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lEPvIyOBsC/Listeners', 04:31:32 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 04:31:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:31:32 INFO - 'USER': 'cltbld', 04:31:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:31:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:31:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:32 INFO - 'XPC_FLAGS': '0x0', 04:31:32 INFO - 'XPC_SERVICE_NAME': '0', 04:31:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:31:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:31:33 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-dPuxtj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:31:33 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-u8mgO0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:31:33 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-o3OJQ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:31:33 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-Eb87wn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:31:33 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-a5i76N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:31:33 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-_osiHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:31:33 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-PX5j0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:31:33 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-s1mIoB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:31:33 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-N2bBsW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:31:33 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-V0ikcJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:31:34 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-QwCTsw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:31:34 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-E4Nx_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:31:34 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-WviOs7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:31:34 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-Gb41Uq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:34 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-y8Xls9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:31:34 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-sFfVqV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:31:34 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-nyTf9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:31:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:31:34 INFO - Running setup.py install for manifestparser 04:31:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:31:34 INFO - Running setup.py install for mozcrash 04:31:35 INFO - Running setup.py install for mozdebug 04:31:35 INFO - Running setup.py install for mozdevice 04:31:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:31:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:31:35 INFO - Running setup.py install for mozfile 04:31:35 INFO - Running setup.py install for mozhttpd 04:31:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:31:35 INFO - Running setup.py install for mozinfo 04:31:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:31:35 INFO - Running setup.py install for mozInstall 04:31:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:31:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:31:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:31:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:31:35 INFO - Running setup.py install for mozleak 04:31:36 INFO - Running setup.py install for mozlog 04:31:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:31:36 INFO - Running setup.py install for moznetwork 04:31:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:31:36 INFO - Running setup.py install for mozprocess 04:31:36 INFO - Running setup.py install for mozprofile 04:31:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:31:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:31:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:31:36 INFO - Running setup.py install for mozrunner 04:31:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:31:36 INFO - Running setup.py install for mozscreenshot 04:31:37 INFO - Running setup.py install for moztest 04:31:37 INFO - Running setup.py install for mozversion 04:31:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:31:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:31:37 INFO - Cleaning up... 04:31:37 INFO - Return code: 0 04:31:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:31: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')]} 04:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31: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')]} 04:31:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:37 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 0x10b738b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b73b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92fa4c76a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b516d30>, '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 0x10b43ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b50bbe8>, '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.PNKZHq7HqN/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.lEPvIyOBsC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:31:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:31:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:31:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PNKZHq7HqN/Render', 04:31:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:31:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:31:37 INFO - 'HOME': '/Users/cltbld', 04:31:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:31:37 INFO - 'LOGNAME': 'cltbld', 04:31:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:37 INFO - 'MOZ_NO_REMOTE': '1', 04:31:37 INFO - 'NO_EM_RESTART': '1', 04:31:37 INFO - 'PAGER': '/bin/cat', 04:31:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:31:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:37 INFO - 'PWD': '/builds/slave/test', 04:31:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:31:37 INFO - 'SHELL': '/bin/bash', 04:31:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lEPvIyOBsC/Listeners', 04:31:37 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 04:31:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:31:37 INFO - 'USER': 'cltbld', 04:31:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:31:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:31:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:37 INFO - 'XPC_FLAGS': '0x0', 04:31:37 INFO - 'XPC_SERVICE_NAME': '0', 04:31:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:31:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:31:37 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-gHAr9I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:31:37 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:31:37 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-3u3KHK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:31:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:31:37 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-Ypsqz_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:31:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:31:37 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-dJ0lKu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:31:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:31:38 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-kHgTrH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:31:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:31:38 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-0An3Ec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:31:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:31:38 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-mc9kAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:31:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:31:38 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-wfvaKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:31:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:31:38 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-bBuoD1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:31:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:31:38 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-VGTY6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:31:38 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)) 04:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:31:38 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-Qo4lzK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:31:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:31:38 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-PWfLr7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:31:38 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)) 04:31:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:31:38 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-NtMEsh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:31:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:31:39 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-UdxAOi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:31:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:39 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-oQDfRY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:31:39 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-hlkX_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:31:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:31:39 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-iM4mDs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:31:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:31:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:31:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:31:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:31:39 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:31:39 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:31:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:31:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:41 INFO - Downloading blessings-1.6.tar.gz 04:31:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:31:42 INFO - Installing collected packages: blessings 04:31:42 INFO - Running setup.py install for blessings 04:31:42 INFO - Successfully installed blessings 04:31:42 INFO - Cleaning up... 04:31:42 INFO - Return code: 0 04:31:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:31:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:31:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:31:42 INFO - Reading from file tmpfile_stdout 04:31:42 INFO - Current package versions: 04:31:42 INFO - blessings == 1.6 04:31:42 INFO - blobuploader == 1.2.4 04:31:42 INFO - docopt == 0.6.1 04:31:42 INFO - functools32 == 3.2.3-2 04:31:42 INFO - jsonschema == 2.5.1 04:31:42 INFO - manifestparser == 1.1 04:31:42 INFO - mozInstall == 1.12 04:31:42 INFO - mozcrash == 1.0 04:31:42 INFO - mozdebug == 0.1 04:31:42 INFO - mozdevice == 0.49 04:31:42 INFO - mozfile == 1.2 04:31:42 INFO - mozhttpd == 0.7 04:31:42 INFO - mozinfo == 0.9 04:31:42 INFO - mozleak == 0.1 04:31:42 INFO - mozlog == 3.4 04:31:42 INFO - moznetwork == 0.27 04:31:42 INFO - mozprocess == 0.23 04:31:42 INFO - mozprofile == 0.28 04:31:42 INFO - mozrunner == 6.13 04:31:42 INFO - mozscreenshot == 0.1 04:31:42 INFO - mozsystemmonitor == 0.3 04:31:42 INFO - moztest == 0.7 04:31:42 INFO - mozversion == 1.4 04:31:42 INFO - psutil == 3.1.1 04:31:42 INFO - requests == 1.2.3 04:31:42 INFO - wsgiref == 0.1.2 04:31:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:31: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')]} 04:31:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:43 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 0x10b738b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b73b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92fa4c76a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b516d30>, '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 0x10b43ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b50bbe8>, '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.PNKZHq7HqN/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.lEPvIyOBsC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:31:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:31:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:31:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PNKZHq7HqN/Render', 04:31:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:31:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:31:43 INFO - 'HOME': '/Users/cltbld', 04:31:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:31:43 INFO - 'LOGNAME': 'cltbld', 04:31:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:43 INFO - 'MOZ_NO_REMOTE': '1', 04:31:43 INFO - 'NO_EM_RESTART': '1', 04:31:43 INFO - 'PAGER': '/bin/cat', 04:31:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:31:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:43 INFO - 'PWD': '/builds/slave/test', 04:31:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:31:43 INFO - 'SHELL': '/bin/bash', 04:31:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lEPvIyOBsC/Listeners', 04:31:43 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 04:31:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:31:43 INFO - 'USER': 'cltbld', 04:31:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:31:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:31:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:43 INFO - 'XPC_FLAGS': '0x0', 04:31:43 INFO - 'XPC_SERVICE_NAME': '0', 04:31:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:31:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:31:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:31:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:31:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:31:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:31:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:31:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:31:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:31:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:31:43 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:31:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:31:43 INFO - Cleaning up... 04:31:43 INFO - Return code: 0 04:31:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:31:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:44 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 0x10b738b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b73b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92fa4c76a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b516d30>, '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 0x10b43ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b50bbe8>, '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.PNKZHq7HqN/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.lEPvIyOBsC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:31:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:31:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:31:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PNKZHq7HqN/Render', 04:31:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:31:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:31:44 INFO - 'HOME': '/Users/cltbld', 04:31:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:31:44 INFO - 'LOGNAME': 'cltbld', 04:31:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:44 INFO - 'MOZ_NO_REMOTE': '1', 04:31:44 INFO - 'NO_EM_RESTART': '1', 04:31:44 INFO - 'PAGER': '/bin/cat', 04:31:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:31:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:44 INFO - 'PWD': '/builds/slave/test', 04:31:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:31:44 INFO - 'SHELL': '/bin/bash', 04:31:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lEPvIyOBsC/Listeners', 04:31:44 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 04:31:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:31:44 INFO - 'USER': 'cltbld', 04:31:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:31:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:31:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:44 INFO - 'XPC_FLAGS': '0x0', 04:31:44 INFO - 'XPC_SERVICE_NAME': '0', 04:31:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:31:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:31:44 INFO - Cleaning up... 04:31:44 INFO - Return code: 0 04:31:44 INFO - Running post-action listener: _resource_record_post_action 04:31:44 INFO - Running post-action listener: _start_resource_monitoring 04:31:44 INFO - Starting resource monitoring. 04:31:44 INFO - [mozharness: 2016-12-21 12:31:44.323297Z] Finished create-virtualenv step (success) 04:31:44 INFO - [mozharness: 2016-12-21 12:31:44.324331Z] Running install step. 04:31:44 INFO - Running pre-action listener: _resource_record_pre_action 04:31:44 INFO - Running main action method: install 04:31:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:31:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:31:44 INFO - Reading from file tmpfile_stdout 04:31:44 INFO - Detecting whether we're running mozinstall >=1.0... 04:31:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:31:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:31:44 INFO - Reading from file tmpfile_stdout 04:31:44 INFO - Output received: 04:31:44 INFO - Usage: mozinstall [options] installer 04:31:44 INFO - Options: 04:31:44 INFO - -h, --help show this help message and exit 04:31:44 INFO - -d DEST, --destination=DEST 04:31:44 INFO - Directory to install application into. [default: 04:31:44 INFO - "/builds/slave/test"] 04:31:44 INFO - --app=APP Application being installed. [default: firefox] 04:31:44 INFO - mkdir: /builds/slave/test/build/application 04:31:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:31:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:32:06 INFO - Reading from file tmpfile_stdout 04:32:06 INFO - Output received: 04:32:06 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:32:06 INFO - Running post-action listener: _resource_record_post_action 04:32:06 INFO - [mozharness: 2016-12-21 12:32:06.084178Z] Finished install step (success) 04:32:06 INFO - [mozharness: 2016-12-21 12:32:06.084334Z] Running run-tests step. 04:32:06 INFO - Running pre-action listener: _resource_record_pre_action 04:32:06 INFO - Running main action method: run_tests 04:32:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:32:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:32:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:32:06 INFO - 2016-12-21 04:32:06.097 screenresolution[1629:7359] starting screenresolution argv=screenresolution get 04:32:06 INFO - 2016-12-21 04:32:06.099 screenresolution[1629:7359] Display 0: 1600x1200x32@60 04:32:06 INFO - 2016-12-21 04:32:06.104 screenresolution[1630:7362] starting screenresolution argv=screenresolution list 04:32:06 INFO - Available Modes on Display 0 04:32:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:32:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:32:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:32:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:32:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:32:06 INFO - Intel Iris: 04:32:06 INFO - Chipset Model: Intel Iris 04:32:06 INFO - Type: GPU 04:32:06 INFO - Bus: Built-In 04:32:06 INFO - VRAM (Dynamic, Max): 1536 MB 04:32:06 INFO - Vendor: Intel (0x8086) 04:32:06 INFO - Device ID: 0x0a2e 04:32:06 INFO - Revision ID: 0x0009 04:32:06 INFO - Displays: 04:32:06 INFO - Display: 04:32:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:32:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:32:06 INFO - Display Serial Number: 1600x1200 60 04:32:06 INFO - Main Display: Yes 04:32:06 INFO - Mirror: Off 04:32:06 INFO - Online: Yes 04:32:06 INFO - Rotation: Supported 04:32:06 INFO - Return code: 0 04:32:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:32:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:32:06 INFO - Python 2.7.3 04:32:06 INFO - Return code: 0 04:32:06 INFO - grabbing minidump binary from tooltool 04:32:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:06 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 0x10b516d30>, '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 0x10b43ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b50bbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:32:06 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:32:06 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:32:06 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:32:06 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:32:06 INFO - Return code: 0 04:32:06 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:32:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:32:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:32:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:32:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:32:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/b_qIylNJRFOe1M43kocNSg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:32:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/b_qIylNJRFOe1M43kocNSg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0019 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:32:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PNKZHq7HqN/Render', 04:32:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:06 INFO - 'HOME': '/Users/cltbld', 04:32:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:06 INFO - 'LOGNAME': 'cltbld', 04:32:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:32:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:32:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:06 INFO - 'MOZ_NO_REMOTE': '1', 04:32:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:32:06 INFO - 'NO_EM_RESTART': '1', 04:32:06 INFO - 'PAGER': '/bin/cat', 04:32:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:06 INFO - 'PWD': '/builds/slave/test', 04:32:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:32:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:06 INFO - 'SHELL': '/bin/bash', 04:32:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lEPvIyOBsC/Listeners', 04:32:06 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 04:32:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:06 INFO - 'USER': 'cltbld', 04:32:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:06 INFO - 'XPC_FLAGS': '0x0', 04:32:06 INFO - 'XPC_SERVICE_NAME': '0', 04:32:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/b_qIylNJRFOe1M43kocNSg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:32:06 INFO - mozversion application_buildid: 20161221030226 04:32:06 INFO - mozversion application_changeset: c36fbe84042debef0a5d58b7fc88185b401762ce 04:32:06 INFO - mozversion application_display_name: Nightly 04:32:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:32:06 INFO - mozversion application_name: Firefox 04:32:06 INFO - mozversion application_remotingname: firefox 04:32:06 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:32:06 INFO - mozversion application_vendor: Mozilla 04:32:06 INFO - mozversion application_version: 53.0a1 04:32:06 INFO - mozversion platform_buildid: 20161221030226 04:32:06 INFO - mozversion platform_changeset: c36fbe84042debef0a5d58b7fc88185b401762ce 04:32:06 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:32:06 INFO - mozversion platform_version: 53.0a1 04:32:06 INFO - using testdate: 1482323526 04:32:06 INFO - actual date: 1482323526 04:32:06 INFO - starting webserver on 'localhost:49249' 04:32:06 INFO - SUITE-START | Running 2 tests 04:32:06 INFO - TEST-START | dromaeo_css 04:32:06 INFO - operating with platform_type : mac_ 04:32:06 INFO - Initialising browser for dromaeo_css test... 04:32:06 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/tmpsJxR6K/profile http://localhost:49249/getInfo.html) 04:32:09 INFO - PROCESS | 1640 | __metrics Screen width/height:1600/1200 04:32:09 INFO - PROCESS | 1640 | colorDepth:24 04:32:09 INFO - PROCESS | 1640 | Browser inner width/height: 1024/689 04:32:09 INFO - PROCESS | 1640 | __metrics 04:32:09 INFO - PROCESS | 1640 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:32:09 INFO - PROCESS | 1640 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:32:10 INFO - TEST-INFO | 1640: exit 0 04:32:10 INFO - Browser initialized. 04:32:10 INFO - Running cycle 1/1 for dromaeo_css test... 04:32:10 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/tmpsJxR6K/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:32:22 INFO - PROCESS | 1643 | RSS: Main: 228388864 04:32:22 INFO - PROCESS | 1643 | 04:33:12 INFO - PROCESS | 1643 | 1482323592813 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:35:26 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49249/tests/dromaeo/cssquery-ext.html) 04:35:28 INFO - PROCESS | 1643 | RSS: Main: 378109952 04:35:28 INFO - PROCESS | 1643 | 04:38:31 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-ext.html (next: http://localhost:49249/tests/dromaeo/cssquery-jquery.html) 04:38:32 INFO - PROCESS | 1643 | RSS: Main: 370323456 04:38:32 INFO - PROCESS | 1643 | 04:41:34 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49249/tests/dromaeo/cssquery-mootools.html) 04:41:35 INFO - PROCESS | 1643 | RSS: Main: 350830592 04:41:35 INFO - PROCESS | 1643 | 04:44:37 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49249/tests/dromaeo/cssquery-prototype.html) 04:44:38 INFO - PROCESS | 1643 | RSS: Main: 345190400 04:44:38 INFO - PROCESS | 1643 | 04:47:41 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49249/tests/dromaeo/cssquery-yui.html) 04:47:42 INFO - PROCESS | 1643 | RSS: Main: 338051072 04:47:42 INFO - PROCESS | 1643 | 04:50:45 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-yui.html (next: http://localhost:49249/tests/dromaeo/cssquery-dojo.html) 04:50:46 INFO - PROCESS | 1643 | RSS: Main: 432553984 04:50:46 INFO - PROCESS | 1643 | 04:50:46 INFO - PROCESS | 1643 | __start_tp_report 04:50:46 INFO - PROCESS | 1643 | _x_x_mozilla_page_load 04:50:46 INFO - PROCESS | 1643 | _x_x_mozilla_page_load_details 04:50:46 INFO - PROCESS | 1643 | |i|pagename|runs| 04:50:46 INFO - PROCESS | 1643 | |0;dojo.html;3139.4035133324664;3250.2037000934774;3291.7202037826783;3296;3302.306515631718;5500.009998200322;5544.916826247604;5570.303712035996;5625.5499560035205;5627.268455100836;4505.639548836093;5331.733413329328;5578.581606379527;5634;5672.574556908227;4393.604575588196;5113.437521872591;5129.358830146231;5130.948690513103;5135.332406787131;5188.662736922107;5270.9736451317685;5282.260483532308;5288.471152884719;5322.042032434179;5219.269302297681;5235.633505654606;5265.341832270966;5276.709780962045;5302.125149350352;5049.394072711261;5073.2643766654;5103.719295438749;5111.667741596784;5150.3047088642925;4507.661925355578;4944.87637809054;5141.53726164647;5147.202183661501;5194.506521880453;5596.692181929992;5599.720013999284;5610.719464026783;5637.774489020434;5686.260786097822;5955.196048533436;6022.488088512438;6035.064564992434;6195.132681424604;6195.81412557624;6117.583823141527;6139.293981192175;6192.071189321593;6221.253449586034;6240.687965601747;5672.914906276409;5723.370429252821;5734.2258795062135;5742.942570574241;5784.971075144639;6158.291796443376;6272.655003974825;6277.52918531112;6285.779997700059;6295.024271237966;4802.495737947535;5906.49794767441;5909.3795151508475;5969.343372229051;6001.489873360726;6192.504599632019;6196.81409557714;6197.876042479215;6198.473129783929;6202.472789812917;6102.755889764359;6103.664298463538;6108.5418593605655;6121.357257487989;6128.66710217266;5979.671118088547;6023.909641355383;6042.939570604326;6120.204373431426;6157.72290246931;4146.896327591774;4807.855764327076;4845.9757701211265;4853.999999999929;4861.538153875376;4329.28566786483;4382.9342559861625;4416.470023597189;4431.313146462304;4438.423005009328;5590.329160500684;5635.323761148688;5644.915326270109;5662.207290979266;5665.235193248941;6105.004892149239;6119.289302195972;6123.923256659767;6150.50795936324;6174.166487524217;5737.995850726106;5751.511121554715;5756.5682573807135;5777.19119323295;5801.680907550125;5292.338457692788;5336.62643614951;5340.786368545292;5342.091844386464;5355.678659280456;5108.259302401131;6230.408111229426;6235.781747638811;6273.96863015682;6280.183576135073;6130.856783744145;6180.66006369636;6202.100695399052;6224.284207316216;6230.376962303733;6215.81352559424;6223.657698826608;6225.221847269091;6226.283977342482;6244.250689917239;5956.940430595639;6029.78895738647;6075.574709770273;6092.025275955826;6103;5040.395152581714;6107.816765497042;6175.413335733098;6179.104029915727;6203.596766210182;6059.545534085049;6071.119687645179;6078.483328917092;6084.665343405978;6094.695265236632;5887.852803679771;5889.646621202742;5984.102384642164;6075.544334174866;6089.269287685506;5477.260569823023;5573.7459071708545;5757.0788673811985;5808.82573522795;5996.280446346466;6022.2171117754415;6068.939310607014;6071.39286071407;6072.483838873745;6076.453119219114;5264.894702106013;5703.173039909273;5797.536197104306;5871.911921321098;5881.852953676193 04:50:46 INFO - PROCESS | 1643 | |1;ext.html;441.41512495942885;448.5380058539704;458.3354136502073;485.5193358575012;510.50226029621126;30255.54616680749;38961.831145065655;40960.79519602398;41029.79485102578;41171.79414102933;41834.58165418345;42326.36510452346;42373.88130593466;42402.57597424025;42418;8346.83306333873;9343.76640583984;9525.285603579725;9551.140397364235;9571;8436.957815210915;11108.55565777372;11296.943515282412;11389.373584452851;11499.367534785584;11394;11431.314121152758;11451.484683189236;11455.828162577527;11481.138914581397;11260.155488338367;11327.716807079807;11341.659750207466;11348.319100853974;11351.886481135165;11179.888201117967;11263.943680281629;11266.605668801552;11282.097432205404;11284.605038823684;39839.40240896389;40348.39477407841;40351.59648403508;40356;40359.99100022494;2888.812227205246;3293.96706032939;3538.433850583894;3633.291508155911;3705.4441833724886;27058;28640.713592864013;28691.28271793201;28736.137915862557;28773.712262877314;3088.3977624363256;3199.2641692410875;3227.9838005241168;3293.0450169450833;3299.884504042347;492749;495418;495957;496168;496989;54338;54841.24166962491;54865;54934.72532637391;55161;57098.714506427204;57173.42826571681;57272.854542908906;57320.14019789707;57433;12709.618711438672;14837.480688175861;15089.24553772307;15091.924540377227;15122.39510419593;10522.947385263025;10789.83815242772;11627;11733.76532469363;11789.587364442375;15245.847541524443;16499.336436982456;20627.58744825095;20708.585828283653;21054.578908421747;8207.917920820835;8370.916290837014;8390.622421991025;8402.663893444316;8503.574821258911;888.8089060851819;964.8793900762405;1040.9323393979366;1045.210865796334;1105.8783533811275;29921.850390747906;30057.248568785955;30193.245168870515;30650.69349306523;30775.69224307773;1029.984550231747;1063.8351055586397;1096.5832983466391;1103.9944800275948;1115.8214685650257;15552;15582.987105838085;15589.220538973006;15691.215439227994;15951.521454356387;544706.2764686152;647456;648931;650711;651522.6205772468;58190.4180958185;58724.4127558719;58824.70587647035;58827;58828.11757823636;1212.2181193130382;1398.985735341869;1402.1797248609678;1410.9082909610843;1421.7583010888382;28657.856710716314;29390.706092939654;29605.703942960296;30110.548341774454;30239.395212095194;50558.92175095563;50822;50900;51029;51086.23370649369;523390;523545;524189;525720;528311;32022.03933881987;33589;34405.655943440244;41267.7936610315;41835.7908210457;35635.46546801852;44312;46204.30693539667;46452;46457.30314045224;38457.807710961264;38473.807630961666;38746.80626596849;39757.80121099376;39965;37920.81039594785;38126.23747525089;38401.80799095987;39271.82184534468;39604.80197598993;34088.65911340855;35355.64644353523;35367;37875.05312367213;38362.23275534529;28745;29561.704382956756;31310;31439.21401964969;31643.614442172384;23595.646065309378;23992.40018999539;24461.633075504236;24565.508689825747;25072.498550028533 04:50:46 INFO - PROCESS | 1643 | |2;jquery.html;373.376461309613;374.503782488203;383.42677696843214;398.9806045553613;411.3911411111555;18533.53666158347;19224.42326730197;19773.209071637135;20038.799612003877;20051.997400130007;19540.120694568745;19637.214511419526;20223.797762022376;20654.17383304666;20917.267895623656;5372;5549.223108764776;5752.597318187729;6001.939980600204;6013.36859629737;5908.88182236355;5929.991901376777;5974.940250597504;5979.192808970777;5985.6408615483;5619.213310136584;5782.479576838084;5863.941360586404;5869.207656966319;5924.466797988181;5758.251427314464;5798.275215598051;5852.239208902858;5854.531637469014;5857.4435428634215;4546.863284178955;5053.620978426596;5119.56483698886;5125.538701516844;5125.974370128126;24988;24995.87502062496;24996.625050624254;25048.624270635955;25285.241442756746;1979.4457551885496;2271.432141964509;2297.5060362022077;2410.5781488239663;3020.3808219315206;15124.848751512454;15305;15820.683586328325;15910.124943128123;16116.516504504883;1736.782902137233;1757.8242175782448;1877.220953304377;1888.725110550373;1968.5472341361567;103447.96552034534;107061.46469267603;107076;107352.46323768332;107738;10388.42863642507;10512.269478734446;10605.73485662849;10914.126869850394;11146.609868654557;13750.86249137516;13789.103708258932;13792.172469651852;13797.585422551014;13808;8128.268455839003;8406.915930840612;8442.409031367868;8569.228769410784;8583.699570515002;7225.458090643223;8231;8363.803472596888;8387.664493420194;8507.361947853811;6520.576162549419;6616.503762217853;6652.873149619671;6670.599764014175;6697.330266973361;1686.8650507959335;1818.2363407368937;1847.7136043913215;1880.5016670582306;1882.1718443884647;750.4109274219711;802.6508468816083;970.9465230225144;1005.5424781724298;1026.045777427;17767.911160444117;19939;21842;22645.980930857822;22720.2047928325;857.811281518065;904.9457382149722;929.1823195587839;966.1161433122124;1003.3327836988321;10943.781124377469;11091.212929937927;11208.27146235492;11248.94375528117;11420.486078126503;483530;490149;494727;506414;507027;102492;116445;118895;121371;126938;997.1701926963957;1023.488255872064;1029.6499190275342;1029.8455231715152;1055.7413433708637;9195.54022298869;10129.290949633454;11210.159238057342;11558.133140014701;12560.183588066746;48707.18099466148;51489.22766158586;53470.19794703161;53824.46175538195;54584.727076365954;77579.61210193913;78537;79202;79494.602526987;79996;7134.464915131282;9718.514074296398;11473.36896470702;11765;12234.449449774604;11947.880521195024;13092.410841511964;13173.736525269633;13608.591742247749;13663.360396752454;9721.611135554498;11594.536218551164;11677.88322116768;11738;11798.646040618794;10383.273170877967;10624.415657138932;11326.83009754871;11571.363575003119;11845.993090587397;11447.427628618703;11596.710082248012;11915.285082895054;11928.76142477163;12040.578579749666;9965.750856228362;11253.15601329887;11837.526498940291;11920.880791191978;12084.368610237505;11411.657650270505;11428.25716328436;11704;11829.940850295694;11880.940595296968 04:50:46 INFO - PROCESS | 1643 | |3;mootools.html;1478.7781832725093;1513.583764464772;1711.8887272327297;1817.2549254805533;1897.079916240623;7988.640511176996;8447.23974842264;8450.98588169419;8458.407911446202;8471.110533393998;7410.703571857132;7641.541507509553;7648.5028473149205;7741.806454838617;8234.176582341763;2074.3776866939897;2116.43914362694;2219.4673278413225;2305.7694230576976;2307.411610039446;2339.836211465198;2343.6836027136374;2349.0955981946986;2350.976490235101;2352.2472808701223;2015.8185763281301;2237.925795618104;2307.699999000136;2311.2719493359537;2312.722473303206;2272.420532764151;2275.5107651854846;2279.3275983584717;2283.4177284792436;2305.723313202418;2201.4936564590075;2266.354089084603;2291.1522736587567;2311.237291693737;2315.2822624986306;7278.344948954619;8243.876341854877;8316.542590157538;8398.538080405575;8409.831803363959;4670.019295947855;4942.9258561121615;4992.301077849068;5161.561267292284;5167.018266529348;2997.7002299770065;3393.4400823864034;3440.4667276572172;3523.5067090607336;3527.171114788023;1010.6412223660568;1023.9692809215661;1029.269218854614;1035.6323505155713;1040.8126537223297;10709.839352409721;10825.945870270676;10829.29609575375;10843.07833834125;10872.967068128515;4383.298672212431;4508.368828364031;4599.402077729874;4607.677462577587;4673;9326.347155699035;9329;9335.90664093364;9339.57971891253;9346.813063738688;5155.355580552431;5158.200478925773;5160.535551800356;5167.302414174038;5169.06956747789;4577.931331030038;4619.745913974763;4708.246680531099;4734.573888350065;4740.525947405232;3509.3858574749315;3600.765950213228;3606.062423769839;3706.8887933362043;3739.139997800521;1257.2393701810272;1259.0997436832708;1281.7180220351509;1281.7885048966816;1287.6845172932692;775.8331958628922;842.4987132656059;911.4759013567225;912.9224015958717;915.6795121707349;5487.259220005328;5548.250986116904;5667;5779.768809247583;5889.823305300848;938.6104766521953;957.2820384711466;958.9232861371073;959.6785076999143;994.786120983992;3738.3084129436143;3755.9812200938823;3800.1449673823167;3911.1004468972296;3931.6264954829244;9679.128878400978;9846.704598862045;9990.550425230882;10121.595136194617;10144.797104057878;10086.596536138471;10090.747731306776;10096.44469554167;10097;10103.14123299513;6796.878515044962;7476.775696729215;7651.961740191264;7814.882776758353;7831.9818423604565;5649.435056494318;5859.267591551056;5916.31962324321;5939.821805345847;5948.405159484017;8842;8930.508822014592;9347.439153650803;9356.95321523388;9359;7826.647800848861;9226.677066302647;9236.353455258068;9416.10546998034;9448.196903263299;7035.788926332219;7134.536255143399;7188;7206.315400036988;7216.8917466237;7049.118860142482;7311.926880731337;7724.536527808349;7752.18602046777;7808.648610812641;6528.738850445929;6991.40573051276;7089.61007144612;7140.46446516503;7167.928320716726;6902.206246281742;6990.370866622028;6998.720051198099;7017.859642807218;7072.504924655224;6509.641969691713;6662.666866656551;6663.666816659244;6666.566673166229;6687.732490700512;4700.905981880275;4838.177509823268;4848.151573474698;4897.632677549127;4995.8001679932395;4321.351797230441;4757.405324334458;4834.492378300228;4866.416030076413;4975.0547395994645 04:50:46 INFO - PROCESS | 1643 | |4;prototype.html;322.55326372973434;352.8623836703685;353.86022521104167;374.10588693023664;376.14239533862803;4854.927176092361;5000.299898034667;5385.838424847256;5386.518707355479;5416.566674666027;4231.915361692772;5058.962912602917;5135.996961185131;5232.659877107995;5404.6486978346475;3743.5320584926885;4000.2599519089063;4237.364395340708;4259.76571288579;4270.636995855356;3730.7388482806214;4211.010412553048;4221.704480686353;4224.458072803435;4290.506591741942;4131.710780245384;4180.512595005966;4191.622753952143;4202.684798640099;4208.326667733163;3870.974191839165;3928.332183528807;4189.790510474464;4205.747655140671;4219.409282700424;3713.7002049282537;3716.9070773230887;3744.812759362021;3754.2116155607355;3779.225258821935;4589.613401031445;4956.975215123937;5318.547923426513;5340.839774806762;5347.786088556453;3911.550171730259;4747.145513807513;4857.611391088704;4862.927056094161;4901.240307752304;5343.336063772414;5558.833235002957;5596.552275817966;5672;5709.857253568653;3891.416287556889;4097.385392191195;4110.841808050767;4127.772972486512;4141.585841415835;5059.772310246085;5154.963789303204;5369.704666243355;5728.768314812293;5983.444304480823;3550.857965681344;4120.207709646314;4139.840844563527;4181;4192.993681516475;4261.232978063917;4266.701330906869;4268.615824575803;4280.272353699878;4281.871543853689;3875.124875124875;4432.578905004019;4623.8844028898875;4632.888106854398;4807.230843065093;4788.664793464424;4856.975715121402;5170.276161337416;5624.746886390122;5645.181448689917;1208.7824191645589;1260.4517035089766;1261.5521489871146;1319.7822359310799;1368.3090039530173;856.5931182688173;868.4051424773924;884.8938826466916;904.882470149365;905.6422713028317;4538.954610453853;4891.260893899428;4983.103041452573;5032.175546584622;5054.49455054499;4570.840020599329;4801.807927682854;5246.7638956247065;5481.835544933659;5486.780528778884;4342.630876375543;4342.848000320037;4747.501512341154;4838.782254798542;4877.561019508261;2623.842569445839;2721.360480287131;2817.29567608098;2895.869685864141;2898.7536059435183;4729.69256998294;5010.5240002199735;5523.696196709139;5558.581472394449;5677;4718.787654555554;4955.695601545299;5998.310194327708;6046.3070340304785;6101.803350793711;5178.482151784867;5743.185838938974;5953.821385358447;5998.580099393001;6103.267607887082;4778.832740854054;4893;5640.85897852557;5872.853178670567;5919.822405327847;5120.462351453193;5337.665583604099;5817.301923769175;5824.621399609012;5910.586258961831;5847.532197424111;5910.970445147746;6021.969890150521;6075.969620151871;6164.907526387197;3408.6420925803427;3797.962020379761;3903.106993108397;3923.92152156961;3928.8428462861166;4641.791119399568;5056.924146137737;5344.732763361894;5890.617109887844;5895.20414744004;5053.772580233825;5271.286831779764;5445.727713614224;5617.988762022876;5719.971400142973;4566.840160594364;4664.370310008106;5697.601167918206;5780.075187969905;5800.4489573490455;5380.757865895966;5609.4390560943575;5616.522595579421;5647.20939068539;5660.37735849048;5332.9466705334;5610.102383618601;5614.214010038516;5626.005536069437;5717.1995920570325;5458.61789674719;5642.689652069175;5643.2787999660495;5645.463680950304;5666.979943610189 04:50:46 INFO - PROCESS | 1643 | |5;yui.html;706.8550947055854;713.2724620886696;725.1986554856883;741.6403044523405;789.8775689768088;14783.556493305192;15772.44796432125;15774.605634859134;15800.288986995583;15803.209839508036;14087.29563521825;14259.643508912282;14267.71464570708;14299.785503217434;14311.499097531589;677.2211956250302;701.6772284749021;704.3344039882313;853.1724227499346;861.0872475176318;784.4626430894855;871.372611719561;876.548577482597;892.7054072156172;894.727108231989;918.9724308270729;943.2972435535536;945.9527023648825;947.4646824544111;947.7156852944123;699.5138378826717;940.2712897504455;942.1097063275207;943.4622265308777;944.1974321826495;536.1528784520449;541.2260467531429;542.1677724692618;542.668971927128;659.8515334049848;14616.415343386358;15110.244487775568;15122.395104195819;15141.394344226217;15146.01550899199;13584.660383490393;13606.523771668044;13681.931590342085;13684.31578421075;13769.173849568957;12614.306213158272;12791.936040319832;12795.936020319932;12848.357582120856;12927.741445171137;3620.31214069326;4348.667271888455;4364.4980827204645;4489.528599497038;4542.250528662767;102981.01360442533;103505;105074.94925050728;105222.47388763084;107443;10715.410652414192;10803.351798892092;10805.297655652357;11140.721481963015;11193.27243729155;19547.60904781925;20540.897295513427;20575.485612859797;21100;21725.456863578536;7875.015623047119;7878.212178782191;7921.762347129596;7949.483283586548;7985.880211796828;4323.546027667113;4421.093675796518;4434.5343738907595;4462.152191083748;4579.519150489217;3598.442241452579;3663.9450408243897;3670.953778173208;3677.816109194583;3703.277860817169;662.7481557008306;665.8568407792347;669.4042302350912;681.2063945503432;689.899964505144;574.22192928582;580.5500736928914;639.2776162935945;662.9834254143685;673.8483841135803;8248.298894594027;8515.759197858766;9290;9307.488088155082;9502.90497095034;585.2128886647453;596.4602035158189;676.3236763236763;682.3210905149408;693.1681981622073;4261.062566235485;4402.163588918095;4550.590446859798;4631.0506346198945;4661.510541393172;78132;96929.5153524228;111706.44146779214;113457.86542134637;114540;76449.23550764422;78352;82811.5859420711;94049.58925616121;97207;77841.61079194568;78380.60809695916;79602;79933.20066799373;80490.79263811048;9681.419114853132;9765.48514142489;9836.927150216354;9921.454320012468;10127.088562029452;48982.510174899224;51792;52412.42597361247;53782;54387.640308992595;63164.68417657882;67576.6621166891;69000;72508;74428;12895.097343185887;12947.935260323638;13124.146930449871;13134.737305254033;13150.408231629792;14729.26353682333;14801.18593477369;14842.76226694195;15368;15441.768373474182;13459.259740714355;13796.655083622589;13965.930170349084;13991.40520860262;14246;11018.338899666045;11377.2604780689;13391.397387117408;13434.992375571675;13455.259960702255;13457.798133027816;13484.325783710972;13559.237697168654;13641.317934103454;13646.86353136456;11132.554697811996;11482.138839586898;11554.191206615793;11564.826527602261;11765;11328.37693926809;11414.372209528223;11419.60031398897;11536.538538458703;11557.24877882935 04:50:46 INFO - PROCESS | 1643 | __end_tp_report 04:50:46 INFO - PROCESS | 1643 | __start_cc_report 04:50:46 INFO - PROCESS | 1643 | _x_x_mozilla_cycle_collect,1528 04:50:46 INFO - PROCESS | 1643 | __end_cc_report 04:50:46 INFO - PROCESS | 1643 | __startTimestamp1482324646023__endTimestamp 04:50:46 INFO - PROCESS | 1643 | 04:50:46 INFO - PROCESS | 1643 | ------- Summary: start ------- 04:50:46 INFO - PROCESS | 1643 | Number of tests: 6 04:50:46 INFO - PROCESS | 1643 | 04:50:46 INFO - PROCESS | 1643 | [#0] dojo.html Cycles:165 Average:5627.52 Median:5797.54 stddev:660.60 (11.4%) stddev-sans-first:633.13 04:50:46 INFO - PROCESS | 1643 | Values: 3139.4 3250.2 3291.7 3296.0 3302.3 5500.0 5544.9 5570.3 5625.5 5627.3 4505.6 5331.7 5578.6 5634.0 5672.6 4393.6 5113.4 5129.4 5130.9 5135.3 5188.7 5271.0 5282.3 5288.5 5322.0 5219.3 5235.6 5265.3 5276.7 5302.1 5049.4 5073.3 5103.7 5111.7 5150.3 4507.7 4944.9 5141.5 5147.2 5194.5 5596.7 5599.7 5610.7 5637.8 5686.3 5955.2 6022.5 6035.1 6195.1 6195.8 6117.6 6139.3 6192.1 6221.3 6240.7 5672.9 5723.4 5734.2 5742.9 5785.0 6158.3 6272.7 6277.5 6285.8 6295.0 4802.5 5906.5 5909.4 5969.3 6001.5 6192.5 6196.8 6197.9 6198.5 6202.5 6102.8 6103.7 6108.5 6121.4 6128.7 5979.7 6023.9 6042.9 6120.2 6157.7 4146.9 4807.9 4846.0 4854.0 4861.5 4329.3 4382.9 4416.5 4431.3 4438.4 5590.3 5635.3 5644.9 5662.2 5665.2 6105.0 6119.3 6123.9 6150.5 6174.2 5738.0 5751.5 5756.6 5777.2 5801.7 5292.3 5336.6 5340.8 5342.1 5355.7 5108.3 6230.4 6235.8 6274.0 6280.2 6130.9 6180.7 6202.1 6224.3 6230.4 6215.8 6223.7 6225.2 6226.3 6244.3 5956.9 6029.8 6075.6 6092.0 6103.0 5040.4 6107.8 6175.4 6179.1 6203.6 6059.5 6071.1 6078.5 6084.7 6094.7 5887.9 5889.6 5984.1 6075.5 6089.3 5477.3 5573.7 5757.1 5808.8 5996.3 6022.2 6068.9 6071.4 6072.5 6076.5 5264.9 5703.2 5797.5 5871.9 5881.9 04:50:46 INFO - PROCESS | 1643 | 04:50:46 INFO - PROCESS | 1643 | [#1] ext.html Cycles:180 Average:68408.48 Median:19452.72 stddev:147632.07 (758.9%) stddev-sans-first:147958.02 04:50:46 INFO - PROCESS | 1643 | Values: 441.4 448.5 458.3 485.5 510.5 30255.5 38961.8 40960.8 41029.8 41171.8 41834.6 42326.4 42373.9 42402.6 42418.0 8346.8 9343.8 9525.3 9551.1 9571.0 8437.0 11108.6 11296.9 11389.4 11499.4 11394.0 11431.3 11451.5 11455.8 11481.1 11260.2 11327.7 11341.7 11348.3 11351.9 11179.9 11263.9 11266.6 11282.1 11284.6 39839.4 40348.4 40351.6 40356.0 40360.0 2888.8 3294.0 3538.4 3633.3 3705.4 27058.0 28640.7 28691.3 28736.1 28773.7 3088.4 3199.3 3228.0 3293.0 3299.9 492749.0 495418.0 495957.0 496168.0 496989.0 54338.0 54841.2 54865.0 54934.7 55161.0 57098.7 57173.4 57272.9 57320.1 57433.0 12709.6 14837.5 15089.2 15091.9 15122.4 10522.9 10789.8 11627.0 11733.8 11789.6 15245.8 16499.3 20627.6 20708.6 21054.6 8207.9 8370.9 8390.6 8402.7 8503.6 888.8 964.9 1040.9 1045.2 1105.9 29921.9 30057.2 30193.2 30650.7 30775.7 1030.0 1063.8 1096.6 1104.0 1115.8 15552.0 15583.0 15589.2 15691.2 15951.5 544706.3 647456.0 648931.0 650711.0 651522.6 58190.4 58724.4 58824.7 58827.0 58828.1 1212.2 1399.0 1402.2 1410.9 1421.8 28657.9 29390.7 29605.7 30110.5 30239.4 50558.9 50822.0 50900.0 51029.0 51086.2 523390.0 523545.0 524189.0 525720.0 528311.0 32022.0 33589.0 34405.7 41267.8 41835.8 35635.5 44312.0 46204.3 46452.0 46457.3 38457.8 38473.8 38746.8 39757.8 39965.0 37920.8 38126.2 38401.8 39271.8 39604.8 34088.7 35355.6 35367.0 37875.1 38362.2 28745.0 29561.7 31310.0 31439.2 31643.6 23595.6 23992.4 24461.6 24565.5 25072.5 04:50:46 INFO - PROCESS | 1643 | 04:50:46 INFO - PROCESS | 1643 | [#2] jquery.html Cycles:180 Average:31701.68 Median:20045.40 stddev:83297.11 (415.5%) stddev-sans-first:83497.57 04:50:46 INFO - PROCESS | 1643 | Values: 373.4 374.5 383.4 399.0 411.4 18533.5 19224.4 19773.2 20038.8 20052.0 19540.1 19637.2 20223.8 20654.2 20917.3 5372.0 5549.2 5752.6 6001.9 6013.4 5908.9 5930.0 5974.9 5979.2 5985.6 5619.2 5782.5 5863.9 5869.2 5924.5 5758.3 5798.3 5852.2 5854.5 5857.4 4546.9 5053.6 5119.6 5125.5 5126.0 24988.0 24995.9 24996.6 25048.6 25285.2 1979.4 2271.4 2297.5 2410.6 3020.4 15124.8 15305.0 15820.7 15910.1 16116.5 1736.8 1757.8 1877.2 1888.7 1968.5 103448.0 107061.5 107076.0 107352.5 107738.0 10388.4 10512.3 10605.7 10914.1 11146.6 13750.9 13789.1 13792.2 13797.6 13808.0 8128.3 8406.9 8442.4 8569.2 8583.7 7225.5 8231.0 8363.8 8387.7 8507.4 6520.6 6616.5 6652.9 6670.6 6697.3 1686.9 1818.2 1847.7 1880.5 1882.2 750.4 802.7 970.9 1005.5 1026.0 17767.9 19939.0 21842.0 22646.0 22720.2 857.8 904.9 929.2 966.1 1003.3 10943.8 11091.2 11208.3 11248.9 11420.5 483530.0 490149.0 494727.0 506414.0 507027.0 102492.0 116445.0 118895.0 121371.0 126938.0 997.2 1023.5 1029.6 1029.8 1055.7 9195.5 10129.3 11210.2 11558.1 12560.2 48707.2 51489.2 53470.2 53824.5 54584.7 77579.6 78537.0 79202.0 79494.6 79996.0 7134.5 9718.5 11473.4 11765.0 12234.4 11947.9 13092.4 13173.7 13608.6 13663.4 9721.6 11594.5 11677.9 11738.0 11798.6 10383.3 10624.4 11326.8 11571.4 11846.0 11447.4 11596.7 11915.3 11928.8 12040.6 9965.8 11253.2 11837.5 11920.9 12084.4 11411.7 11428.3 11704.0 11829.9 11880.9 04:50:46 INFO - PROCESS | 1643 | 04:50:46 INFO - PROCESS | 1643 | [#3] mootools.html Cycles:180 Average:5388.20 Median:5156.78 stddev:2933.05 (56.9%) stddev-sans-first:2926.57 04:50:46 INFO - PROCESS | 1643 | Values: 1478.8 1513.6 1711.9 1817.3 1897.1 7988.6 8447.2 8451.0 8458.4 8471.1 7410.7 7641.5 7648.5 7741.8 8234.2 2074.4 2116.4 2219.5 2305.8 2307.4 2339.8 2343.7 2349.1 2351.0 2352.2 2015.8 2237.9 2307.7 2311.3 2312.7 2272.4 2275.5 2279.3 2283.4 2305.7 2201.5 2266.4 2291.2 2311.2 2315.3 7278.3 8243.9 8316.5 8398.5 8409.8 4670.0 4942.9 4992.3 5161.6 5167.0 2997.7 3393.4 3440.5 3523.5 3527.2 1010.6 1024.0 1029.3 1035.6 1040.8 10709.8 10825.9 10829.3 10843.1 10873.0 4383.3 4508.4 4599.4 4607.7 4673.0 9326.3 9329.0 9335.9 9339.6 9346.8 5155.4 5158.2 5160.5 5167.3 5169.1 4577.9 4619.7 4708.2 4734.6 4740.5 3509.4 3600.8 3606.1 3706.9 3739.1 1257.2 1259.1 1281.7 1281.8 1287.7 775.8 842.5 911.5 912.9 915.7 5487.3 5548.3 5667.0 5779.8 5889.8 938.6 957.3 958.9 959.7 994.8 3738.3 3756.0 3800.1 3911.1 3931.6 9679.1 9846.7 9990.6 10121.6 10144.8 10086.6 10090.7 10096.4 10097.0 10103.1 6796.9 7476.8 7652.0 7814.9 7832.0 5649.4 5859.3 5916.3 5939.8 5948.4 8842.0 8930.5 9347.4 9357.0 9359.0 7826.6 9226.7 9236.4 9416.1 9448.2 7035.8 7134.5 7188.0 7206.3 7216.9 7049.1 7311.9 7724.5 7752.2 7808.6 6528.7 6991.4 7089.6 7140.5 7167.9 6902.2 6990.4 6998.7 7017.9 7072.5 6509.6 6662.7 6663.7 6666.6 6687.7 4700.9 4838.2 4848.2 4897.6 4995.8 4321.4 4757.4 4834.5 4866.4 4975.1 04:50:46 INFO - PROCESS | 1643 | 04:50:46 INFO - PROCESS | 1643 | [#4] prototype.html Cycles:180 Average:4545.82 Median:4928.47 stddev:1360.99 (27.6%) stddev-sans-first:1327.38 04:50:46 INFO - PROCESS | 1643 | Values: 322.6 352.9 353.9 374.1 376.1 4854.9 5000.3 5385.8 5386.5 5416.6 4231.9 5059.0 5136.0 5232.7 5404.6 3743.5 4000.3 4237.4 4259.8 4270.6 3730.7 4211.0 4221.7 4224.5 4290.5 4131.7 4180.5 4191.6 4202.7 4208.3 3871.0 3928.3 4189.8 4205.7 4219.4 3713.7 3716.9 3744.8 3754.2 3779.2 4589.6 4957.0 5318.5 5340.8 5347.8 3911.6 4747.1 4857.6 4862.9 4901.2 5343.3 5558.8 5596.6 5672.0 5709.9 3891.4 4097.4 4110.8 4127.8 4141.6 5059.8 5155.0 5369.7 5728.8 5983.4 3550.9 4120.2 4139.8 4181.0 4193.0 4261.2 4266.7 4268.6 4280.3 4281.9 3875.1 4432.6 4623.9 4632.9 4807.2 4788.7 4857.0 5170.3 5624.7 5645.2 1208.8 1260.5 1261.6 1319.8 1368.3 856.6 868.4 884.9 904.9 905.6 4539.0 4891.3 4983.1 5032.2 5054.5 4570.8 4801.8 5246.8 5481.8 5486.8 4342.6 4342.8 4747.5 4838.8 4877.6 2623.8 2721.4 2817.3 2895.9 2898.8 4729.7 5010.5 5523.7 5558.6 5677.0 4718.8 4955.7 5998.3 6046.3 6101.8 5178.5 5743.2 5953.8 5998.6 6103.3 4778.8 4893.0 5640.9 5872.9 5919.8 5120.5 5337.7 5817.3 5824.6 5910.6 5847.5 5911.0 6022.0 6076.0 6164.9 3408.6 3798.0 3903.1 3923.9 3928.8 4641.8 5056.9 5344.7 5890.6 5895.2 5053.8 5271.3 5445.7 5618.0 5720.0 4566.8 4664.4 5697.6 5780.1 5800.4 5380.8 5609.4 5616.5 5647.2 5660.4 5332.9 5610.1 5614.2 5626.0 5717.2 5458.6 5642.7 5643.3 5645.5 5667.0 04:50:46 INFO - PROCESS | 1643 | 04:50:46 INFO - PROCESS | 1643 | [#5] yui.html Cycles:180 Average:20520.81 Median:4427.81 stddev:29417.32 (664.4%) stddev-sans-first:29462.22 04:50:46 INFO - PROCESS | 1643 | Values: 706.9 713.3 725.2 741.6 789.9 14783.6 15772.4 15774.6 15800.3 15803.2 14087.3 14259.6 14267.7 14299.8 14311.5 677.2 701.7 704.3 853.2 861.1 784.5 871.4 876.5 892.7 894.7 919.0 943.3 946.0 947.5 947.7 699.5 940.3 942.1 943.5 944.2 536.2 541.2 542.2 542.7 659.9 14616.4 15110.2 15122.4 15141.4 15146.0 13584.7 13606.5 13681.9 13684.3 13769.2 12614.3 12791.9 12795.9 12848.4 12927.7 3620.3 4348.7 4364.5 4489.5 4542.3 102981.0 103505.0 105074.9 105222.5 107443.0 10715.4 10803.4 10805.3 11140.7 11193.3 19547.6 20540.9 20575.5 21100.0 21725.5 7875.0 7878.2 7921.8 7949.5 7985.9 4323.5 4421.1 4434.5 4462.2 4579.5 3598.4 3663.9 3671.0 3677.8 3703.3 662.7 665.9 669.4 681.2 689.9 574.2 580.6 639.3 663.0 673.8 8248.3 8515.8 9290.0 9307.5 9502.9 585.2 596.5 676.3 682.3 693.2 4261.1 4402.2 4550.6 4631.1 4661.5 78132.0 96929.5 111706.4 113457.9 114540.0 76449.2 78352.0 82811.6 94049.6 97207.0 77841.6 78380.6 79602.0 79933.2 80490.8 9681.4 9765.5 9836.9 9921.5 10127.1 48982.5 51792.0 52412.4 53782.0 54387.6 63164.7 67576.7 69000.0 72508.0 74428.0 12895.1 12947.9 13124.1 13134.7 13150.4 14729.3 14801.2 14842.8 15368.0 15441.8 13459.3 13796.7 13965.9 13991.4 14246.0 11018.3 11377.3 13391.4 13435.0 13455.3 13457.8 13484.3 13559.2 13641.3 13646.9 11132.6 11482.1 11554.2 11564.8 11765.0 11328.4 11414.4 11419.6 11536.5 11557.2 04:50:46 INFO - PROCESS | 1643 | -------- Summary: end -------- 04:50:46 INFO - PROCESS | 1643 | 04:50:46 INFO - TEST-INFO | 1643: exit 0 04:50:46 INFO - TEST-OK | dromaeo_css | took 1120003ms 04:50:46 INFO - TEST-START | kraken 04:50:46 INFO - operating with platform_type : mac_ 04:50:46 INFO - Initialising browser for kraken test... 04:50:46 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/tmpGSYEGU/profile http://localhost:49249/getInfo.html) 04:50:48 INFO - PROCESS | 1654 | __metrics Screen width/height:1600/1200 04:50:48 INFO - PROCESS | 1654 | colorDepth:24 04:50:48 INFO - PROCESS | 1654 | Browser inner width/height: 1024/689 04:50:48 INFO - PROCESS | 1654 | __metrics 04:50:49 INFO - PROCESS | 1654 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:50:49 INFO - PROCESS | 1654 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:50:49 INFO - TEST-INFO | 1654: exit 0 04:50:49 INFO - Browser initialized. 04:50:49 INFO - Running cycle 1/1 for kraken test... 04:50:49 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/tmpGSYEGU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:51:01 INFO - PROCESS | 1656 | RSS: Main: 235704320 04:51:01 INFO - PROCESS | 1656 | 04:51:04 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-beat-detection) 04:51:05 INFO - PROCESS | 1656 | RSS: Main: 289042432 04:51:05 INFO - PROCESS | 1656 | 04:51:08 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-dft) 04:51:08 INFO - PROCESS | 1656 | RSS: Main: 288989184 04:51:08 INFO - PROCESS | 1656 | 04:51:12 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-fft) 04:51:12 INFO - PROCESS | 1656 | RSS: Main: 380968960 04:51:12 INFO - PROCESS | 1656 | 04:51:14 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-oscillator) 04:51:15 INFO - PROCESS | 1656 | RSS: Main: 281911296 04:51:15 INFO - PROCESS | 1656 | 04:51:17 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:51:17 INFO - PROCESS | 1656 | RSS: Main: 285310976 04:51:17 INFO - PROCESS | 1656 | 04:51:20 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-darkroom) 04:51:21 INFO - PROCESS | 1656 | RSS: Main: 326983680 04:51:21 INFO - PROCESS | 1656 | 04:51:24 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-desaturate) 04:51:24 INFO - PROCESS | 1656 | RSS: Main: 328548352 04:51:24 INFO - PROCESS | 1656 | 04:51:27 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49249/tests/kraken/driver.html?testName=json-parse-financial) 04:51:28 INFO - PROCESS | 1656 | RSS: Main: 325951488 04:51:28 INFO - PROCESS | 1656 | 04:51:30 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49249/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:51:30 INFO - PROCESS | 1656 | RSS: Main: 302825472 04:51:30 INFO - PROCESS | 1656 | 04:51:32 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:51:33 INFO - PROCESS | 1656 | RSS: Main: 308117504 04:51:33 INFO - PROCESS | 1656 | 04:51:35 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:51:36 INFO - PROCESS | 1656 | RSS: Main: 308670464 04:51:36 INFO - PROCESS | 1656 | 04:51:39 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:51:39 INFO - PROCESS | 1656 | RSS: Main: 323153920 04:51:39 INFO - PROCESS | 1656 | 04:51:42 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:51:43 INFO - PROCESS | 1656 | RSS: Main: 321699840 04:51:43 INFO - PROCESS | 1656 | 04:51:45 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49249/tests/kraken/driver.html?testName=ai-astar) 04:51:45 INFO - PROCESS | 1656 | RSS: Main: 365776896 04:51:45 INFO - PROCESS | 1656 | 04:51:45 INFO - PROCESS | 1656 | __start_tp_report 04:51:45 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 04:51:45 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 04:51:45 INFO - PROCESS | 1656 | |i|pagename|runs| 04:51:45 INFO - PROCESS | 1656 | |0;ai-astar;116;163;166;113;114;113;114;114;113;114 04:51:45 INFO - PROCESS | 1656 | |1;audio-beat-detection;141;107;138;149;109;112;108;110;128;110 04:51:45 INFO - PROCESS | 1656 | |2;audio-dft;195;185;184;186;185;181;181;182;184;186 04:51:45 INFO - PROCESS | 1656 | |3;audio-fft;77;58;59;88;61;57;58;59;85;81 04:51:45 INFO - PROCESS | 1656 | |4;audio-oscillator;84;71;85;69;68;68;81;67;67;84 04:51:45 INFO - PROCESS | 1656 | |5;imaging-gaussian-blur;87;86;87;85;87;84;87;85;87;84 04:51:45 INFO - PROCESS | 1656 | |6;imaging-darkroom;94;93;93;94;110;148;104;93;102;144 04:51:45 INFO - PROCESS | 1656 | |7;imaging-desaturate;84;87;85;88;86;85;86;87;86;85 04:51:45 INFO - PROCESS | 1656 | |8;json-parse-financial;54;55;56;79;71;57;56;55;55;54 04:51:45 INFO - PROCESS | 1656 | |9;json-stringify-tinderbox;68;68;69;81;78;71;70;69;71;70 04:51:45 INFO - PROCESS | 1656 | |10;stanford-crypto-aes;88;96;104;105;81;87;84;87;96;105 04:51:45 INFO - PROCESS | 1656 | |11;stanford-crypto-ccm;142;141;138;139;139;138;139;139;237;168 04:51:45 INFO - PROCESS | 1656 | |12;stanford-crypto-pbkdf2;169;172;172;171;171;168;167;170;170;170 04:51:45 INFO - PROCESS | 1656 | |13;stanford-crypto-sha256-iterative;67;66;68;67;67;67;66;66;66;67 04:51:45 INFO - PROCESS | 1656 | __end_tp_report 04:51:45 INFO - PROCESS | 1656 | __start_cc_report 04:51:45 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,2062 04:51:45 INFO - PROCESS | 1656 | __end_cc_report 04:51:45 INFO - PROCESS | 1656 | __startTimestamp1482324705394__endTimestamp 04:51:45 INFO - PROCESS | 1656 | 04:51:45 INFO - PROCESS | 1656 | ------- Summary: start ------- 04:51:45 INFO - PROCESS | 1656 | Number of tests: 14 04:51:45 INFO - PROCESS | 1656 | 04:51:45 INFO - PROCESS | 1656 | [#0] ai-astar Cycles:10 Average:124.00 Median:114.00 stddev:21.37 (18.7%) stddev-sans-first:22.47 04:51:45 INFO - PROCESS | 1656 | Values: 116.0 163.0 166.0 113.0 114.0 113.0 114.0 114.0 113.0 114.0 04:51:45 INFO - PROCESS | 1656 | 04:51:45 INFO - PROCESS | 1656 | [#1] audio-beat-detection Cycles:10 Average:121.20 Median:120.00 stddev:16.17 (13.5%) stddev-sans-first:15.48 04:51:45 INFO - PROCESS | 1656 | Values: 141.0 107.0 138.0 149.0 109.0 112.0 108.0 110.0 128.0 110.0 04:51:45 INFO - PROCESS | 1656 | 04:51:45 INFO - PROCESS | 1656 | [#2] audio-dft Cycles:10 Average:184.90 Median:185.00 stddev:4.01 (2.2%) stddev-sans-first:1.99 04:51:45 INFO - PROCESS | 1656 | Values: 195.0 185.0 184.0 186.0 185.0 181.0 181.0 182.0 184.0 186.0 04:51:45 INFO - PROCESS | 1656 | 04:51:45 INFO - PROCESS | 1656 | [#3] audio-fft Cycles:10 Average:68.30 Median:69.00 stddev:12.78 (18.5%) stddev-sans-first:13.16 04:51:45 INFO - PROCESS | 1656 | Values: 77.0 58.0 59.0 88.0 61.0 57.0 58.0 59.0 85.0 81.0 04:51:45 INFO - PROCESS | 1656 | 04:51:45 INFO - PROCESS | 1656 | [#4] audio-oscillator Cycles:10 Average:74.40 Median:76.00 stddev:7.97 (10.5%) stddev-sans-first:7.66 04:51:45 INFO - PROCESS | 1656 | Values: 84.0 71.0 85.0 69.0 68.0 68.0 81.0 67.0 67.0 84.0 04:51:45 INFO - PROCESS | 1656 | 04:51:45 INFO - PROCESS | 1656 | [#5] imaging-gaussian-blur Cycles:10 Average:85.90 Median:87.00 stddev:1.29 (1.5%) stddev-sans-first:1.30 04:51:45 INFO - PROCESS | 1656 | Values: 87.0 86.0 87.0 85.0 87.0 84.0 87.0 85.0 87.0 84.0 04:51:45 INFO - PROCESS | 1656 | 04:51:45 INFO - PROCESS | 1656 | [#6] imaging-darkroom Cycles:10 Average:107.50 Median:93.00 stddev:21.13 (22.7%) stddev-sans-first:21.83 04:51:45 INFO - PROCESS | 1656 | Values: 94.0 93.0 93.0 94.0 110.0 148.0 104.0 93.0 102.0 144.0 04:51:45 INFO - PROCESS | 1656 | 04:51:45 INFO - PROCESS | 1656 | [#7] imaging-desaturate Cycles:10 Average:85.90 Median:86.00 stddev:1.20 (1.4%) stddev-sans-first:1.05 04:51:45 INFO - PROCESS | 1656 | Values: 84.0 87.0 85.0 88.0 86.0 85.0 86.0 87.0 86.0 85.0 04:51:45 INFO - PROCESS | 1656 | 04:51:45 INFO - PROCESS | 1656 | [#8] json-parse-financial Cycles:10 Average:59.20 Median:56.00 stddev:8.59 (15.3%) stddev-sans-first:8.90 04:51:45 INFO - PROCESS | 1656 | Values: 54.0 55.0 56.0 79.0 71.0 57.0 56.0 55.0 55.0 54.0 04:51:45 INFO - PROCESS | 1656 | 04:51:45 INFO - PROCESS | 1656 | [#9] json-stringify-tinderbox Cycles:10 Average:71.50 Median:70.50 stddev:4.40 (6.2%) stddev-sans-first:4.48 04:51:45 INFO - PROCESS | 1656 | Values: 68.0 68.0 69.0 81.0 78.0 71.0 70.0 69.0 71.0 70.0 04:51:45 INFO - PROCESS | 1656 | 04:51:45 INFO - PROCESS | 1656 | [#10] stanford-crypto-aes Cycles:10 Average:93.30 Median:87.00 stddev:9.12 (10.5%) stddev-sans-first:9.47 04:51:45 INFO - PROCESS | 1656 | Values: 88.0 96.0 104.0 105.0 81.0 87.0 84.0 87.0 96.0 105.0 04:51:45 INFO - PROCESS | 1656 | 04:51:45 INFO - PROCESS | 1656 | [#11] stanford-crypto-ccm Cycles:10 Average:152.00 Median:140.00 stddev:31.22 (22.3%) stddev-sans-first:32.90 04:51:45 INFO - PROCESS | 1656 | Values: 142.0 141.0 138.0 139.0 139.0 138.0 139.0 139.0 237.0 168.0 04:51:45 INFO - PROCESS | 1656 | 04:51:45 INFO - PROCESS | 1656 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.00 Median:170.50 stddev:1.63 (1.0%) stddev-sans-first:1.69 04:51:45 INFO - PROCESS | 1656 | Values: 169.0 172.0 172.0 171.0 171.0 168.0 167.0 170.0 170.0 170.0 04:51:45 INFO - PROCESS | 1656 | 04:51:45 INFO - PROCESS | 1656 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 04:51:45 INFO - PROCESS | 1656 | Values: 67.0 66.0 68.0 67.0 67.0 67.0 66.0 66.0 66.0 67.0 04:51:45 INFO - PROCESS | 1656 | -------- Summary: end -------- 04:51:45 INFO - PROCESS | 1656 | 04:51:46 INFO - TEST-INFO | 1656: exit 0 04:51:46 INFO - TEST-OK | kraken | took 59597ms 04:51:46 INFO - SUITE-END | took 1179s 04:51:46 INFO - Completed test suite (00:19:39) 04:51:46 INFO - javascript benchmark 04:51:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3139.4035133324664, 3250.2037000934774, 3291.7202037826783, 3296.0, 3302.306515631718, 5500.009998200322, 5544.916826247604, 5570.303712035996, 5625.5499560035205, 5627.268455100836, 4505.639548836093, 5331.733413329328, 5578.581606379527, 5634.0, 5672.574556908227, 4393.604575588196, 5113.437521872591, 5129.358830146231, 5130.948690513103, 5135.332406787131, 5188.662736922107, 5270.9736451317685, 5282.260483532308, 5288.471152884719, 5322.042032434179, 5219.269302297681, 5235.633505654606, 5265.341832270966, 5276.709780962045, 5302.125149350352, 5049.394072711261, 5073.2643766654, 5103.719295438749, 5111.667741596784, 5150.3047088642925, 4507.661925355578, 4944.87637809054, 5141.53726164647, 5147.202183661501, 5194.506521880453, 5596.692181929992, 5599.720013999284, 5610.719464026783, 5637.774489020434, 5686.260786097822, 5955.196048533436, 6022.488088512438, 6035.064564992434, 6195.132681424604, 6195.81412557624, 6117.583823141527, 6139.293981192175, 6192.071189321593, 6221.253449586034, 6240.687965601747, 5672.914906276409, 5723.370429252821, 5734.2258795062135, 5742.942570574241, 5784.971075144639, 6158.291796443376, 6272.655003974825, 6277.52918531112, 6285.779997700059, 6295.024271237966, 4802.495737947535, 5906.49794767441, 5909.3795151508475, 5969.343372229051, 6001.489873360726, 6192.504599632019, 6196.81409557714, 6197.876042479215, 6198.473129783929, 6202.472789812917, 6102.755889764359, 6103.664298463538, 6108.5418593605655, 6121.357257487989, 6128.66710217266, 5979.671118088547, 6023.909641355383, 6042.939570604326, 6120.204373431426, 6157.72290246931, 4146.896327591774, 4807.855764327076, 4845.9757701211265, 4853.999999999929, 4861.538153875376, 4329.28566786483, 4382.9342559861625, 4416.470023597189, 4431.313146462304, 4438.423005009328, 5590.329160500684, 5635.323761148688, 5644.915326270109, 5662.207290979266, 5665.235193248941, 6105.004892149239, 6119.289302195972, 6123.923256659767, 6150.50795936324, 6174.166487524217, 5737.995850726106, 5751.511121554715, 5756.5682573807135, 5777.19119323295, 5801.680907550125, 5292.338457692788, 5336.62643614951, 5340.786368545292, 5342.091844386464, 5355.678659280456, 5108.259302401131, 6230.408111229426, 6235.781747638811, 6273.96863015682, 6280.183576135073, 6130.856783744145, 6180.66006369636, 6202.100695399052, 6224.284207316216, 6230.376962303733, 6215.81352559424, 6223.657698826608, 6225.221847269091, 6226.283977342482, 6244.250689917239, 5956.940430595639, 6029.78895738647, 6075.574709770273, 6092.025275955826, 6103.0, 5040.395152581714, 6107.816765497042, 6175.413335733098, 6179.104029915727, 6203.596766210182, 6059.545534085049, 6071.119687645179, 6078.483328917092, 6084.665343405978, 6094.695265236632, 5887.852803679771, 5889.646621202742, 5984.102384642164, 6075.544334174866, 6089.269287685506, 5477.260569823023, 5573.7459071708545, 5757.0788673811985, 5808.82573522795, 5996.280446346466, 6022.2171117754415, 6068.939310607014, 6071.39286071407, 6072.483838873745, 6076.453119219114, 5264.894702106013, 5703.173039909273, 5797.536197104306, 5871.911921321098, 5881.852953676193], "value": 5585.283365122255, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [441.41512495942885, 448.5380058539704, 458.3354136502073, 485.5193358575012, 510.50226029621126, 30255.54616680749, 38961.831145065655, 40960.79519602398, 41029.79485102578, 41171.79414102933, 41834.58165418345, 42326.36510452346, 42373.88130593466, 42402.57597424025, 42418.0, 8346.83306333873, 9343.76640583984, 9525.285603579725, 9551.140397364235, 9571.0, 8436.957815210915, 11108.55565777372, 11296.943515282412, 11389.373584452851, 11499.367534785584, 11394.0, 11431.314121152758, 11451.484683189236, 11455.828162577527, 11481.138914581397, 11260.155488338367, 11327.716807079807, 11341.659750207466, 11348.319100853974, 11351.886481135165, 11179.888201117967, 11263.943680281629, 11266.605668801552, 11282.097432205404, 11284.605038823684, 39839.40240896389, 40348.39477407841, 40351.59648403508, 40356.0, 40359.99100022494, 2888.812227205246, 3293.96706032939, 3538.433850583894, 3633.291508155911, 3705.4441833724886, 27058.0, 28640.713592864013, 28691.28271793201, 28736.137915862557, 28773.712262877314, 3088.3977624363256, 3199.2641692410875, 3227.9838005241168, 3293.0450169450833, 3299.884504042347, 492749.0, 495418.0, 495957.0, 496168.0, 496989.0, 54338.0, 54841.24166962491, 54865.0, 54934.72532637391, 55161.0, 57098.714506427204, 57173.42826571681, 57272.854542908906, 57320.14019789707, 57433.0, 12709.618711438672, 14837.480688175861, 15089.24553772307, 15091.924540377227, 15122.39510419593, 10522.947385263025, 10789.83815242772, 11627.0, 11733.76532469363, 11789.587364442375, 15245.847541524443, 16499.336436982456, 20627.58744825095, 20708.585828283653, 21054.578908421747, 8207.917920820835, 8370.916290837014, 8390.622421991025, 8402.663893444316, 8503.574821258911, 888.8089060851819, 964.8793900762405, 1040.9323393979366, 1045.210865796334, 1105.8783533811275, 29921.850390747906, 30057.248568785955, 30193.245168870515, 30650.69349306523, 30775.69224307773, 1029.984550231747, 1063.8351055586397, 1096.5832983466391, 1103.9944800275948, 1115.8214685650257, 15552.0, 15582.987105838085, 15589.220538973006, 15691.215439227994, 15951.521454356387, 544706.2764686152, 647456.0, 648931.0, 650711.0, 651522.6205772468, 58190.4180958185, 58724.4127558719, 58824.70587647035, 58827.0, 58828.11757823636, 1212.2181193130382, 1398.985735341869, 1402.1797248609678, 1410.9082909610843, 1421.7583010888382, 28657.856710716314, 29390.706092939654, 29605.703942960296, 30110.548341774454, 30239.395212095194, 50558.92175095563, 50822.0, 50900.0, 51029.0, 51086.23370649369, 523390.0, 523545.0, 524189.0, 525720.0, 528311.0, 32022.03933881987, 33589.0, 34405.655943440244, 41267.7936610315, 41835.7908210457, 35635.46546801852, 44312.0, 46204.30693539667, 46452.0, 46457.30314045224, 38457.807710961264, 38473.807630961666, 38746.80626596849, 39757.80121099376, 39965.0, 37920.81039594785, 38126.23747525089, 38401.80799095987, 39271.82184534468, 39604.80197598993, 34088.65911340855, 35355.64644353523, 35367.0, 37875.05312367213, 38362.23275534529, 28745.0, 29561.704382956756, 31310.0, 31439.21401964969, 31643.614442172384, 23595.646065309378, 23992.40018999539, 24461.633075504236, 24565.508689825747, 25072.498550028533], "value": 20058.14518113145, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.376461309613, 374.503782488203, 383.42677696843214, 398.9806045553613, 411.3911411111555, 18533.53666158347, 19224.42326730197, 19773.209071637135, 20038.799612003877, 20051.997400130007, 19540.120694568745, 19637.214511419526, 20223.797762022376, 20654.17383304666, 20917.267895623656, 5372.0, 5549.223108764776, 5752.597318187729, 6001.939980600204, 6013.36859629737, 5908.88182236355, 5929.991901376777, 5974.940250597504, 5979.192808970777, 5985.6408615483, 5619.213310136584, 5782.479576838084, 5863.941360586404, 5869.207656966319, 5924.466797988181, 5758.251427314464, 5798.275215598051, 5852.239208902858, 5854.531637469014, 5857.4435428634215, 4546.863284178955, 5053.620978426596, 5119.56483698886, 5125.538701516844, 5125.974370128126, 24988.0, 24995.87502062496, 24996.625050624254, 25048.624270635955, 25285.241442756746, 1979.4457551885496, 2271.432141964509, 2297.5060362022077, 2410.5781488239663, 3020.3808219315206, 15124.848751512454, 15305.0, 15820.683586328325, 15910.124943128123, 16116.516504504883, 1736.782902137233, 1757.8242175782448, 1877.220953304377, 1888.725110550373, 1968.5472341361567, 103447.96552034534, 107061.46469267603, 107076.0, 107352.46323768332, 107738.0, 10388.42863642507, 10512.269478734446, 10605.73485662849, 10914.126869850394, 11146.609868654557, 13750.86249137516, 13789.103708258932, 13792.172469651852, 13797.585422551014, 13808.0, 8128.268455839003, 8406.915930840612, 8442.409031367868, 8569.228769410784, 8583.699570515002, 7225.458090643223, 8231.0, 8363.803472596888, 8387.664493420194, 8507.361947853811, 6520.576162549419, 6616.503762217853, 6652.873149619671, 6670.599764014175, 6697.330266973361, 1686.8650507959335, 1818.2363407368937, 1847.7136043913215, 1880.5016670582306, 1882.1718443884647, 750.4109274219711, 802.6508468816083, 970.9465230225144, 1005.5424781724298, 1026.045777427, 17767.911160444117, 19939.0, 21842.0, 22645.980930857822, 22720.2047928325, 857.811281518065, 904.9457382149722, 929.1823195587839, 966.1161433122124, 1003.3327836988321, 10943.781124377469, 11091.212929937927, 11208.27146235492, 11248.94375528117, 11420.486078126503, 483530.0, 490149.0, 494727.0, 506414.0, 507027.0, 102492.0, 116445.0, 118895.0, 121371.0, 126938.0, 997.1701926963957, 1023.488255872064, 1029.6499190275342, 1029.8455231715152, 1055.7413433708637, 9195.54022298869, 10129.290949633454, 11210.159238057342, 11558.133140014701, 12560.183588066746, 48707.18099466148, 51489.22766158586, 53470.19794703161, 53824.46175538195, 54584.727076365954, 77579.61210193913, 78537.0, 79202.0, 79494.602526987, 79996.0, 7134.464915131282, 9718.514074296398, 11473.36896470702, 11765.0, 12234.449449774604, 11947.880521195024, 13092.410841511964, 13173.736525269633, 13608.591742247749, 13663.360396752454, 9721.611135554498, 11594.536218551164, 11677.88322116768, 11738.0, 11798.646040618794, 10383.273170877967, 10624.415657138932, 11326.83009754871, 11571.363575003119, 11845.993090587397, 11447.427628618703, 11596.710082248012, 11915.285082895054, 11928.76142477163, 12040.578579749666, 9965.750856228362, 11253.15601329887, 11837.526498940291, 11920.880791191978, 12084.368610237505, 11411.657650270505, 11428.25716328436, 11704.0, 11829.940850295694, 11880.940595296968], "value": 9665.822262248523, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1478.7781832725093, 1513.583764464772, 1711.8887272327297, 1817.2549254805533, 1897.079916240623, 7988.640511176996, 8447.23974842264, 8450.98588169419, 8458.407911446202, 8471.110533393998, 7410.703571857132, 7641.541507509553, 7648.5028473149205, 7741.806454838617, 8234.176582341763, 2074.3776866939897, 2116.43914362694, 2219.4673278413225, 2305.7694230576976, 2307.411610039446, 2339.836211465198, 2343.6836027136374, 2349.0955981946986, 2350.976490235101, 2352.2472808701223, 2015.8185763281301, 2237.925795618104, 2307.699999000136, 2311.2719493359537, 2312.722473303206, 2272.420532764151, 2275.5107651854846, 2279.3275983584717, 2283.4177284792436, 2305.723313202418, 2201.4936564590075, 2266.354089084603, 2291.1522736587567, 2311.237291693737, 2315.2822624986306, 7278.344948954619, 8243.876341854877, 8316.542590157538, 8398.538080405575, 8409.831803363959, 4670.019295947855, 4942.9258561121615, 4992.301077849068, 5161.561267292284, 5167.018266529348, 2997.7002299770065, 3393.4400823864034, 3440.4667276572172, 3523.5067090607336, 3527.171114788023, 1010.6412223660568, 1023.9692809215661, 1029.269218854614, 1035.6323505155713, 1040.8126537223297, 10709.839352409721, 10825.945870270676, 10829.29609575375, 10843.07833834125, 10872.967068128515, 4383.298672212431, 4508.368828364031, 4599.402077729874, 4607.677462577587, 4673.0, 9326.347155699035, 9329.0, 9335.90664093364, 9339.57971891253, 9346.813063738688, 5155.355580552431, 5158.200478925773, 5160.535551800356, 5167.302414174038, 5169.06956747789, 4577.931331030038, 4619.745913974763, 4708.246680531099, 4734.573888350065, 4740.525947405232, 3509.3858574749315, 3600.765950213228, 3606.062423769839, 3706.8887933362043, 3739.139997800521, 1257.2393701810272, 1259.0997436832708, 1281.7180220351509, 1281.7885048966816, 1287.6845172932692, 775.8331958628922, 842.4987132656059, 911.4759013567225, 912.9224015958717, 915.6795121707349, 5487.259220005328, 5548.250986116904, 5667.0, 5779.768809247583, 5889.823305300848, 938.6104766521953, 957.2820384711466, 958.9232861371073, 959.6785076999143, 994.786120983992, 3738.3084129436143, 3755.9812200938823, 3800.1449673823167, 3911.1004468972296, 3931.6264954829244, 9679.128878400978, 9846.704598862045, 9990.550425230882, 10121.595136194617, 10144.797104057878, 10086.596536138471, 10090.747731306776, 10096.44469554167, 10097.0, 10103.14123299513, 6796.878515044962, 7476.775696729215, 7651.961740191264, 7814.882776758353, 7831.9818423604565, 5649.435056494318, 5859.267591551056, 5916.31962324321, 5939.821805345847, 5948.405159484017, 8842.0, 8930.508822014592, 9347.439153650803, 9356.95321523388, 9359.0, 7826.647800848861, 9226.677066302647, 9236.353455258068, 9416.10546998034, 9448.196903263299, 7035.788926332219, 7134.536255143399, 7188.0, 7206.315400036988, 7216.8917466237, 7049.118860142482, 7311.926880731337, 7724.536527808349, 7752.18602046777, 7808.648610812641, 6528.738850445929, 6991.40573051276, 7089.61007144612, 7140.46446516503, 7167.928320716726, 6902.206246281742, 6990.370866622028, 6998.720051198099, 7017.859642807218, 7072.504924655224, 6509.641969691713, 6662.666866656551, 6663.666816659244, 6666.566673166229, 6687.732490700512, 4700.905981880275, 4838.177509823268, 4848.151573474698, 4897.632677549127, 4995.8001679932395, 4321.351797230441, 4757.405324334458, 4834.492378300228, 4866.416030076413, 4975.0547395994645], "value": 4383.831384757535, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.55326372973434, 352.8623836703685, 353.86022521104167, 374.10588693023664, 376.14239533862803, 4854.927176092361, 5000.299898034667, 5385.838424847256, 5386.518707355479, 5416.566674666027, 4231.915361692772, 5058.962912602917, 5135.996961185131, 5232.659877107995, 5404.6486978346475, 3743.5320584926885, 4000.2599519089063, 4237.364395340708, 4259.76571288579, 4270.636995855356, 3730.7388482806214, 4211.010412553048, 4221.704480686353, 4224.458072803435, 4290.506591741942, 4131.710780245384, 4180.512595005966, 4191.622753952143, 4202.684798640099, 4208.326667733163, 3870.974191839165, 3928.332183528807, 4189.790510474464, 4205.747655140671, 4219.409282700424, 3713.7002049282537, 3716.9070773230887, 3744.812759362021, 3754.2116155607355, 3779.225258821935, 4589.613401031445, 4956.975215123937, 5318.547923426513, 5340.839774806762, 5347.786088556453, 3911.550171730259, 4747.145513807513, 4857.611391088704, 4862.927056094161, 4901.240307752304, 5343.336063772414, 5558.833235002957, 5596.552275817966, 5672.0, 5709.857253568653, 3891.416287556889, 4097.385392191195, 4110.841808050767, 4127.772972486512, 4141.585841415835, 5059.772310246085, 5154.963789303204, 5369.704666243355, 5728.768314812293, 5983.444304480823, 3550.857965681344, 4120.207709646314, 4139.840844563527, 4181.0, 4192.993681516475, 4261.232978063917, 4266.701330906869, 4268.615824575803, 4280.272353699878, 4281.871543853689, 3875.124875124875, 4432.578905004019, 4623.8844028898875, 4632.888106854398, 4807.230843065093, 4788.664793464424, 4856.975715121402, 5170.276161337416, 5624.746886390122, 5645.181448689917, 1208.7824191645589, 1260.4517035089766, 1261.5521489871146, 1319.7822359310799, 1368.3090039530173, 856.5931182688173, 868.4051424773924, 884.8938826466916, 904.882470149365, 905.6422713028317, 4538.954610453853, 4891.260893899428, 4983.103041452573, 5032.175546584622, 5054.49455054499, 4570.840020599329, 4801.807927682854, 5246.7638956247065, 5481.835544933659, 5486.780528778884, 4342.630876375543, 4342.848000320037, 4747.501512341154, 4838.782254798542, 4877.561019508261, 2623.842569445839, 2721.360480287131, 2817.29567608098, 2895.869685864141, 2898.7536059435183, 4729.69256998294, 5010.5240002199735, 5523.696196709139, 5558.581472394449, 5677.0, 4718.787654555554, 4955.695601545299, 5998.310194327708, 6046.3070340304785, 6101.803350793711, 5178.482151784867, 5743.185838938974, 5953.821385358447, 5998.580099393001, 6103.267607887082, 4778.832740854054, 4893.0, 5640.85897852557, 5872.853178670567, 5919.822405327847, 5120.462351453193, 5337.665583604099, 5817.301923769175, 5824.621399609012, 5910.586258961831, 5847.532197424111, 5910.970445147746, 6021.969890150521, 6075.969620151871, 6164.907526387197, 3408.6420925803427, 3797.962020379761, 3903.106993108397, 3923.92152156961, 3928.8428462861166, 4641.791119399568, 5056.924146137737, 5344.732763361894, 5890.617109887844, 5895.20414744004, 5053.772580233825, 5271.286831779764, 5445.727713614224, 5617.988762022876, 5719.971400142973, 4566.840160594364, 4664.370310008106, 5697.601167918206, 5780.075187969905, 5800.4489573490455, 5380.757865895966, 5609.4390560943575, 5616.522595579421, 5647.20939068539, 5660.37735849048, 5332.9466705334, 5610.102383618601, 5614.214010038516, 5626.005536069437, 5717.1995920570325, 5458.61789674719, 5642.689652069175, 5643.2787999660495, 5645.463680950304, 5666.979943610189], "value": 4123.172058368076, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [706.8550947055854, 713.2724620886696, 725.1986554856883, 741.6403044523405, 789.8775689768088, 14783.556493305192, 15772.44796432125, 15774.605634859134, 15800.288986995583, 15803.209839508036, 14087.29563521825, 14259.643508912282, 14267.71464570708, 14299.785503217434, 14311.499097531589, 677.2211956250302, 701.6772284749021, 704.3344039882313, 853.1724227499346, 861.0872475176318, 784.4626430894855, 871.372611719561, 876.548577482597, 892.7054072156172, 894.727108231989, 918.9724308270729, 943.2972435535536, 945.9527023648825, 947.4646824544111, 947.7156852944123, 699.5138378826717, 940.2712897504455, 942.1097063275207, 943.4622265308777, 944.1974321826495, 536.1528784520449, 541.2260467531429, 542.1677724692618, 542.668971927128, 659.8515334049848, 14616.415343386358, 15110.244487775568, 15122.395104195819, 15141.394344226217, 15146.01550899199, 13584.660383490393, 13606.523771668044, 13681.931590342085, 13684.31578421075, 13769.173849568957, 12614.306213158272, 12791.936040319832, 12795.936020319932, 12848.357582120856, 12927.741445171137, 3620.31214069326, 4348.667271888455, 4364.4980827204645, 4489.528599497038, 4542.250528662767, 102981.01360442533, 103505.0, 105074.94925050728, 105222.47388763084, 107443.0, 10715.410652414192, 10803.351798892092, 10805.297655652357, 11140.721481963015, 11193.27243729155, 19547.60904781925, 20540.897295513427, 20575.485612859797, 21100.0, 21725.456863578536, 7875.015623047119, 7878.212178782191, 7921.762347129596, 7949.483283586548, 7985.880211796828, 4323.546027667113, 4421.093675796518, 4434.5343738907595, 4462.152191083748, 4579.519150489217, 3598.442241452579, 3663.9450408243897, 3670.953778173208, 3677.816109194583, 3703.277860817169, 662.7481557008306, 665.8568407792347, 669.4042302350912, 681.2063945503432, 689.899964505144, 574.22192928582, 580.5500736928914, 639.2776162935945, 662.9834254143685, 673.8483841135803, 8248.298894594027, 8515.759197858766, 9290.0, 9307.488088155082, 9502.90497095034, 585.2128886647453, 596.4602035158189, 676.3236763236763, 682.3210905149408, 693.1681981622073, 4261.062566235485, 4402.163588918095, 4550.590446859798, 4631.0506346198945, 4661.510541393172, 78132.0, 96929.5153524228, 111706.44146779214, 113457.86542134637, 114540.0, 76449.23550764422, 78352.0, 82811.5859420711, 94049.58925616121, 97207.0, 77841.61079194568, 78380.60809695916, 79602.0, 79933.20066799373, 80490.79263811048, 9681.419114853132, 9765.48514142489, 9836.927150216354, 9921.454320012468, 10127.088562029452, 48982.510174899224, 51792.0, 52412.42597361247, 53782.0, 54387.640308992595, 63164.68417657882, 67576.6621166891, 69000.0, 72508.0, 74428.0, 12895.097343185887, 12947.935260323638, 13124.146930449871, 13134.737305254033, 13150.408231629792, 14729.26353682333, 14801.18593477369, 14842.76226694195, 15368.0, 15441.768373474182, 13459.259740714355, 13796.655083622589, 13965.930170349084, 13991.40520860262, 14246.0, 11018.338899666045, 11377.2604780689, 13391.397387117408, 13434.992375571675, 13455.259960702255, 13457.798133027816, 13484.325783710972, 13559.237697168654, 13641.317934103454, 13646.86353136456, 11132.554697811996, 11482.138839586898, 11554.191206615793, 11564.826527602261, 11765.0, 11328.37693926809, 11414.372209528223, 11419.60031398897, 11536.538538458703, 11557.24877882935], "value": 7485.781314708688, "unit": "score"}], "name": "dromaeo_css", "value": 7260.906556629357, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 163.0, 166.0, 113.0, 114.0, 113.0, 114.0, 114.0, 113.0, 114.0], "value": 124.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 107.0, 138.0, 149.0, 109.0, 112.0, 108.0, 110.0, 128.0, 110.0], "value": 121.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 185.0, 184.0, 186.0, 185.0, 181.0, 181.0, 182.0, 184.0, 186.0], "value": 184.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 58.0, 59.0, 88.0, 61.0, 57.0, 58.0, 59.0, 85.0, 81.0], "value": 68.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 71.0, 85.0, 69.0, 68.0, 68.0, 81.0, 67.0, 67.0, 84.0], "value": 74.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 87.0, 85.0, 87.0, 84.0, 87.0, 85.0, 87.0, 84.0], "value": 85.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 93.0, 94.0, 110.0, 148.0, 104.0, 93.0, 102.0, 144.0], "value": 107.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 87.0, 85.0, 88.0, 86.0, 85.0, 86.0, 87.0, 86.0, 85.0], "value": 85.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 56.0, 79.0, 71.0, 57.0, 56.0, 55.0, 55.0, 54.0], "value": 59.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 69.0, 81.0, 78.0, 71.0, 70.0, 69.0, 71.0, 70.0], "value": 71.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 96.0, 104.0, 105.0, 81.0, 87.0, 84.0, 87.0, 96.0, 105.0], "value": 93.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 141.0, 138.0, 139.0, 139.0, 138.0, 139.0, 139.0, 237.0, 168.0], "value": 152.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 172.0, 172.0, 171.0, 171.0, 168.0, 167.0, 170.0, 170.0, 170.0], "value": 170.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 68.0, 67.0, 67.0, 67.0, 66.0, 66.0, 66.0, 67.0], "value": 66.7, "unit": "score"}], "name": "kraken", "value": 1464.8000000000002, "alertThreshold": 2.0}]} 04:51:46 INFO - Return code: 0 04:51:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:51:46 INFO - # TBPL SUCCESS # 04:51:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:51:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:51:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:51:46 INFO - 2016-12-21 04:51:46.727 screenresolution[1660:9911] starting screenresolution argv=screenresolution get 04:51:46 INFO - 2016-12-21 04:51:46.730 screenresolution[1660:9911] Display 0: 1600x1200x32@60 04:51:46 INFO - 2016-12-21 04:51:46.736 screenresolution[1661:9914] starting screenresolution argv=screenresolution list 04:51:46 INFO - Available Modes on Display 0 04:51:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:51:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:51:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:51:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:51:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:51:46 INFO - Intel Iris: 04:51:46 INFO - Chipset Model: Intel Iris 04:51:46 INFO - Type: GPU 04:51:46 INFO - Bus: Built-In 04:51:46 INFO - VRAM (Dynamic, Max): 1536 MB 04:51:46 INFO - Vendor: Intel (0x8086) 04:51:46 INFO - Device ID: 0x0a2e 04:51:46 INFO - Revision ID: 0x0009 04:51:46 INFO - Displays: 04:51:46 INFO - Display: 04:51:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:51:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:51:46 INFO - Display Serial Number: 1600x1200 60 04:51:46 INFO - Main Display: Yes 04:51:46 INFO - Mirror: Off 04:51:46 INFO - Online: Yes 04:51:46 INFO - Rotation: Supported 04:51:46 INFO - Return code: 0 04:51:46 INFO - Running post-action listener: _resource_record_post_action 04:51:46 INFO - [mozharness: 2016-12-21 12:51:46.969894Z] Finished run-tests step (success) 04:51:46 INFO - Running post-run listener: _resource_record_post_run 04:51:47 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 50182144; Write bytes: 559733760; Read time: 548; Write time: 1658 04:51:47 INFO - TinderboxPrint: CPU usage
53.8% 04:51:47 INFO - TinderboxPrint: I/O read bytes / time
50,182,144 / 548 04:51:47 INFO - TinderboxPrint: I/O write bytes / time
559,733,760 / 1,658 04:51:47 INFO - TinderboxPrint: CPU idle
2,220.8 (46.2%) 04:51:47 INFO - TinderboxPrint: CPU system
967.7 (20.1%) 04:51:47 INFO - TinderboxPrint: CPU user
1,621.2 (33.7%) 04:51:47 INFO - TinderboxPrint: Swap in / out
292,581,376 / 0 04:51:47 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 232903168; Write bytes: 225157120; Read time: 16470; Write time: 400 04:51:47 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 49235968; Write bytes: 309525504; Read time: 529; Write time: 1207 04:51:47 INFO - Running post-run listener: _upload_blobber_files 04:51:47 INFO - Blob upload gear active. 04:51:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:51:47 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:51:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:51:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:51:47 INFO - (blobuploader) - INFO - Open directory for files ... 04:51:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:51:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:51:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:51:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:51:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:51:48 INFO - (blobuploader) - INFO - Done attempting. 04:51:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:51:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:51:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:51:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:51:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:51:49 INFO - (blobuploader) - INFO - Done attempting. 04:51:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:51:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:51:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:51:52 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:51:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:51:52 INFO - (blobuploader) - INFO - Done attempting. 04:51:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:51:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:51:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:51:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:51:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:51:54 INFO - (blobuploader) - INFO - Done attempting. 04:51:54 INFO - (blobuploader) - INFO - Iteration through files over. 04:51:54 INFO - Return code: 0 04:51:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:51:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:51:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c7bc0dcc2f77e084363c79d4e1618336307a5b3ec966926a4e8a4b0b2be2736a7632192046150e3e2706b78563ac2cf93c83ca4fd332ff5e8be74fe6a7f6a84", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bcd7b0927f23e3bd4d4572567b870bde0525f5ffd080a24c8648e65adbfee76a32929cd28bd40eb9fa5e9e12983aa65b42d316da32374b83da8927ecfa1357ad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a5415568931fa5fb041765f5ed420befc22bd3df18dfdde7c4b855dcf2b361fc618fe82ff4e8b09aa795e1bcba7291b67cdf16e6ecd6bc15186249d81037ff4e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8cd2ea1de1151b2f8f2b56739cf33f8ff05458e8085daf9bfb39b7b930e3a67c359abf5c9102de5e308d1c237669e1735b0a2bde83a72239288d246847186348"} 04:51:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:51:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:51:54 INFO - Contents: 04:51:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c7bc0dcc2f77e084363c79d4e1618336307a5b3ec966926a4e8a4b0b2be2736a7632192046150e3e2706b78563ac2cf93c83ca4fd332ff5e8be74fe6a7f6a84", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bcd7b0927f23e3bd4d4572567b870bde0525f5ffd080a24c8648e65adbfee76a32929cd28bd40eb9fa5e9e12983aa65b42d316da32374b83da8927ecfa1357ad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a5415568931fa5fb041765f5ed420befc22bd3df18dfdde7c4b855dcf2b361fc618fe82ff4e8b09aa795e1bcba7291b67cdf16e6ecd6bc15186249d81037ff4e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8cd2ea1de1151b2f8f2b56739cf33f8ff05458e8085daf9bfb39b7b930e3a67c359abf5c9102de5e308d1c237669e1735b0a2bde83a72239288d246847186348"} 04:51:54 INFO - Running post-run listener: copy_logs_to_upload_dir 04:51:54 INFO - Copying logs to upload dir... 04:51:54 INFO - mkdir: /builds/slave/test/build/upload/logs 04:51:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.454052 ========= master_lag: -0.20 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-12-21 04:51:54.352815) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-21 04:51:54.359203) ========= 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.PNKZHq7HqN/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.lEPvIyOBsC/Listeners TMPDIR=/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c7bc0dcc2f77e084363c79d4e1618336307a5b3ec966926a4e8a4b0b2be2736a7632192046150e3e2706b78563ac2cf93c83ca4fd332ff5e8be74fe6a7f6a84", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bcd7b0927f23e3bd4d4572567b870bde0525f5ffd080a24c8648e65adbfee76a32929cd28bd40eb9fa5e9e12983aa65b42d316da32374b83da8927ecfa1357ad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a5415568931fa5fb041765f5ed420befc22bd3df18dfdde7c4b855dcf2b361fc618fe82ff4e8b09aa795e1bcba7291b67cdf16e6ecd6bc15186249d81037ff4e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8cd2ea1de1151b2f8f2b56739cf33f8ff05458e8085daf9bfb39b7b930e3a67c359abf5c9102de5e308d1c237669e1735b0a2bde83a72239288d246847186348"} build_url:https://queue.taskcluster.net/v1/task/b_qIylNJRFOe1M43kocNSg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010892 build_url: 'https://queue.taskcluster.net/v1/task/b_qIylNJRFOe1M43kocNSg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c7bc0dcc2f77e084363c79d4e1618336307a5b3ec966926a4e8a4b0b2be2736a7632192046150e3e2706b78563ac2cf93c83ca4fd332ff5e8be74fe6a7f6a84", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bcd7b0927f23e3bd4d4572567b870bde0525f5ffd080a24c8648e65adbfee76a32929cd28bd40eb9fa5e9e12983aa65b42d316da32374b83da8927ecfa1357ad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a5415568931fa5fb041765f5ed420befc22bd3df18dfdde7c4b855dcf2b361fc618fe82ff4e8b09aa795e1bcba7291b67cdf16e6ecd6bc15186249d81037ff4e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8cd2ea1de1151b2f8f2b56739cf33f8ff05458e8085daf9bfb39b7b930e3a67c359abf5c9102de5e308d1c237669e1735b0a2bde83a72239288d246847186348"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-21 04:51:54.393007) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 04:51:54.396301) ========= 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.PNKZHq7HqN/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.lEPvIyOBsC/Listeners TMPDIR=/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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.005271 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 04:51:54.444506) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-21 04:51:54.444781) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-21 04:51:54.448073) ========= ========= Total master_lag: -0.07 =========