builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0249 starttime: 1478820420.72 results: success (0) buildid: 20161110135120 builduid: b2f24454e3b943c3999117423d0854fe revision: 36f095d0dbfa344f551901b70437c88bee147e30 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-10 15:27:00.717569) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-10 15:27:00.718032) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-10 15:27:00.718306) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-10 15:27:00.743408) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 15:27:00.743788) ========= 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.hNMiWHWTGV/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.fEUpP6dGqU/Listeners TMPDIR=/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-10 15:27:00-- 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% 30.1M=0s 2016-11-10 15:27:00 (30.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.080829 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 15:27:00.846923) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 15:27:00.847232) ========= 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.hNMiWHWTGV/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.fEUpP6dGqU/Listeners TMPDIR=/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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.029260 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 15:27:00.897619) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-10 15:27:00.897972) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 36f095d0dbfa344f551901b70437c88bee147e30 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 36f095d0dbfa344f551901b70437c88bee147e30 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.hNMiWHWTGV/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.fEUpP6dGqU/Listeners TMPDIR=/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-10 15:27:00,983 truncating revision to first 12 chars 2016-11-10 15:27:00,983 Setting DEBUG logging. 2016-11-10 15:27:00,983 attempt 1/10 2016-11-10 15:27:00,983 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/36f095d0dbfa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-10 15:27:02,461 unpacking tar archive at: mozilla-aurora-36f095d0dbfa/testing/mozharness/ program finished with exit code 0 elapsedTime=1.764335 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-10 15:27:02.684638) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-10 15:27:02.684972) ========= script_repo_revision: 36f095d0dbfa344f551901b70437c88bee147e30 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-10 15:27:02.685345) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-10 15:27:02.685608) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-10 15:27:02.703746) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-11-10 15:27:02.704128) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.hNMiWHWTGV/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.fEUpP6dGqU/Listeners TMPDIR=/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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 15:27:02 INFO - MultiFileLogger online at 20161110 15:27:02 in /builds/slave/test 15:27:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 15:27:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:27:02 INFO - {'append_to_log': False, 15:27:02 INFO - 'base_work_dir': '/builds/slave/test', 15:27:02 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 15:27:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:27:02 INFO - 'branch': 'Mozilla-Aurora', 15:27:02 INFO - 'buildbot_json_path': 'buildprops.json', 15:27:02 INFO - 'config_files': ('talos/mac_config.py',), 15:27:02 INFO - 'default_actions': ('clobber', 15:27:02 INFO - 'read-buildbot-config', 15:27:02 INFO - 'download-and-extract', 15:27:02 INFO - 'populate-webroot', 15:27:02 INFO - 'create-virtualenv', 15:27:02 INFO - 'install', 15:27:02 INFO - 'run-tests'), 15:27:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:27:02 INFO - 'download_minidump_stackwalk': True, 15:27:02 INFO - 'download_symbols': 'ondemand', 15:27:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:27:02 INFO - 'tooltool.py': '/tools/tooltool.py', 15:27:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:27:02 INFO - '/tools/misc-python/virtualenv.py')}, 15:27:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:27:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:27:02 INFO - 'installer_path': 'installer.exe', 15:27:02 INFO - 'log_level': 'info', 15:27:02 INFO - 'log_name': 'talos', 15:27:02 INFO - 'log_to_console': True, 15:27:02 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:27:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:27:02 INFO - 'opt_config_files': (), 15:27:02 INFO - 'pip_index': False, 15:27:02 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:27:02 INFO - 'cmd': ('bash', 15:27:02 INFO - '-c', 15:27:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:27:02 INFO - 'enabled': True, 15:27:02 INFO - 'halt_on_failure': False, 15:27:02 INFO - 'name': 'check_screen_resolution'},), 15:27:02 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:27:02 INFO - 'cmd': ('bash', 15:27:02 INFO - '-c', 15:27:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:27:02 INFO - 'enabled': True, 15:27:02 INFO - 'halt_on_failure': False, 15:27:02 INFO - 'name': 'check_screen_resolution'},), 15:27:02 INFO - 'run_cmd_checks_enabled': True, 15:27:02 INFO - 'sps_profile': False, 15:27:02 INFO - 'sps_profile_interval': 0, 15:27:02 INFO - 'suite': 'dromaeojs', 15:27:02 INFO - 'system_bits': '32', 15:27:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:27:02 INFO - 'title': 't-yosemite-r7-0249', 15:27:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:27:02 INFO - 'use_talos_json': True, 15:27:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:27:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:27:02 INFO - 'work_dir': 'build'} 15:27:02 INFO - [mozharness: 2016-11-10 23:27:02.901268Z] Running clobber step. 15:27:02 INFO - Running pre-action listener: _resource_record_pre_action 15:27:02 INFO - Running main action method: clobber 15:27:02 INFO - rmtree: /builds/slave/test/build 15:27:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:27:05 INFO - Running post-action listener: _resource_record_post_action 15:27:05 INFO - [mozharness: 2016-11-10 23:27:05.048625Z] Finished clobber step (success) 15:27:05 INFO - [mozharness: 2016-11-10 23:27:05.048749Z] Running read-buildbot-config step. 15:27:05 INFO - Running pre-action listener: _resource_record_pre_action 15:27:05 INFO - Running main action method: read_buildbot_config 15:27:05 INFO - Using buildbot properties: 15:27:05 INFO - { 15:27:05 INFO - "project": "", 15:27:05 INFO - "product": "firefox", 15:27:05 INFO - "script_repo_revision": "production", 15:27:05 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 15:27:05 INFO - "repository": "", 15:27:05 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 15:27:05 INFO - "buildid": "20161110135120", 15:27:05 INFO - "pgo_build": "False", 15:27:05 INFO - "basedir": "/builds/slave/test", 15:27:05 INFO - "buildnumber": 71, 15:27:05 INFO - "slavename": "t-yosemite-r7-0249", 15:27:05 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 15:27:05 INFO - "platform": "yosemite_r7", 15:27:05 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 15:27:05 INFO - "branch": "mozilla-aurora", 15:27:05 INFO - "repo_path": "releases/mozilla-aurora", 15:27:05 INFO - "revision": "36f095d0dbfa344f551901b70437c88bee147e30", 15:27:05 INFO - "stage_platform": "macosx64", 15:27:05 INFO - "builduid": "b2f24454e3b943c3999117423d0854fe", 15:27:05 INFO - "slavebuilddir": "test" 15:27:05 INFO - } 15:27:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/AoX9P31hQKu8mG-gXEyHPQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 15:27:05 INFO - Running post-action listener: _resource_record_post_action 15:27:05 INFO - [mozharness: 2016-11-10 23:27:05.052050Z] Finished read-buildbot-config step (success) 15:27:05 INFO - [mozharness: 2016-11-10 23:27:05.052281Z] Running download-and-extract step. 15:27:05 INFO - Running pre-action listener: _resource_record_pre_action 15:27:05 INFO - Running main action method: download_and_extract 15:27:05 INFO - mkdir: /builds/slave/test/build/tests 15:27:05 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')]} 15:27:05 INFO - trying https://queue.taskcluster.net/v1/task/AoX9P31hQKu8mG-gXEyHPQ/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 15:27:05 INFO - Downloading https://queue.taskcluster.net/v1/task/AoX9P31hQKu8mG-gXEyHPQ/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 15:27:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AoX9P31hQKu8mG-gXEyHPQ/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 15:27:06 INFO - Downloaded 1199 bytes. 15:27:06 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 15:27:06 INFO - Using the following test package requirements: 15:27:06 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 15:27:06 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 15:27:06 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 15:27:06 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 15:27:06 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 15:27:06 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 15:27:06 INFO - u'jsshell-mac.zip'], 15:27:06 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 15:27:06 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 15:27:06 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 15:27:06 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 15:27:06 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 15:27:06 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 15:27:06 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 15:27:06 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 15:27:06 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 15:27:06 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 15:27:06 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 15:27:06 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 15:27:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AoX9P31hQKu8mG-gXEyHPQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 15:27:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AoX9P31hQKu8mG-gXEyHPQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 15:27:06 INFO - Fetch https://queue.taskcluster.net/v1/task/AoX9P31hQKu8mG-gXEyHPQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 15:27:06 INFO - Expected file size: 16423286 15:27:13 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 15:27:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AoX9P31hQKu8mG-gXEyHPQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 15:27:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AoX9P31hQKu8mG-gXEyHPQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 15:27:13 INFO - Fetch https://queue.taskcluster.net/v1/task/AoX9P31hQKu8mG-gXEyHPQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 15:27:14 INFO - Expected file size: 16423286 15:27:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AoX9P31hQKu8mG-gXEyHPQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 15:27:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AoX9P31hQKu8mG-gXEyHPQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 15:27:20 INFO - Fetch https://queue.taskcluster.net/v1/task/AoX9P31hQKu8mG-gXEyHPQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 15:27:21 INFO - Expected file size: 14414089 15:27:22 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')]} 15:27:22 INFO - trying https://queue.taskcluster.net/v1/task/AoX9P31hQKu8mG-gXEyHPQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 15:27:22 INFO - Downloading https://queue.taskcluster.net/v1/task/AoX9P31hQKu8mG-gXEyHPQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 15:27:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AoX9P31hQKu8mG-gXEyHPQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 15:27:25 INFO - Downloaded 115547884 bytes. 15:27:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AoX9P31hQKu8mG-gXEyHPQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 15:27:25 INFO - mkdir: /builds/slave/test/properties 15:27:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:27:25 INFO - Writing to file /builds/slave/test/properties/build_url 15:27:25 INFO - Contents: 15:27:25 INFO - build_url:https://queue.taskcluster.net/v1/task/AoX9P31hQKu8mG-gXEyHPQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 15:27:26 INFO - Running post-action listener: _resource_record_post_action 15:27:26 INFO - Running post-action listener: set_extra_try_arguments 15:27:26 INFO - [mozharness: 2016-11-10 23:27:26.544213Z] Finished download-and-extract step (success) 15:27:26 INFO - [mozharness: 2016-11-10 23:27:26.544347Z] Running populate-webroot step. 15:27:26 INFO - Running pre-action listener: _resource_record_pre_action 15:27:26 INFO - Running main action method: populate_webroot 15:27:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:27:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:27:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:27:26 INFO - '--tppagecycles', 15:27:26 INFO - '7'], 15:27:26 INFO - 'tests': ['tsvgm']}}, 15:27:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:27:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:27:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:27:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:27:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:27:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:27:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:27:26 INFO - 'talos_options': ['--disable-e10s'], 15:27:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:27:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:27:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:27:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:27:26 INFO - 'talos_options': ['--disable-e10s'], 15:27:26 INFO - 'tests': ['damp', 'tps']}, 15:27:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:27:26 INFO - 'tests': ['damp', 'tps']}, 15:27:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:27:26 INFO - 'tests': ['dromaeo_dom']}, 15:27:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:27:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:27:26 INFO - 'tests': ['basic_compositor_video']}, 15:27:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:27:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:27:26 INFO - 'tests': ['a11yr', 15:27:26 INFO - 'ts_paint', 15:27:26 INFO - 'tpaint', 15:27:26 INFO - 'sessionrestore', 15:27:26 INFO - 'sessionrestore_no_auto_restore', 15:27:26 INFO - 'tabpaint']}, 15:27:26 INFO - 'other-e10s': {'tests': ['a11yr', 15:27:26 INFO - 'ts_paint', 15:27:26 INFO - 'tpaint', 15:27:26 INFO - 'sessionrestore', 15:27:26 INFO - 'sessionrestore_no_auto_restore', 15:27:26 INFO - 'tabpaint']}, 15:27:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:27:26 INFO - 'ts_paint', 15:27:26 INFO - 'tpaint', 15:27:26 INFO - 'sessionrestore', 15:27:26 INFO - 'sessionrestore_no_auto_restore', 15:27:26 INFO - 'tabpaint']}, 15:27:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:27:26 INFO - 'ts_paint', 15:27:26 INFO - 'tpaint', 15:27:26 INFO - 'sessionrestore', 15:27:26 INFO - 'sessionrestore_no_auto_restore', 15:27:26 INFO - 'tabpaint']}, 15:27:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:27:26 INFO - 'tests': ['a11yr', 15:27:26 INFO - 'ts_paint', 15:27:26 INFO - 'tpaint', 15:27:26 INFO - 'sessionrestore', 15:27:26 INFO - 'sessionrestore_no_auto_restore', 15:27:26 INFO - 'tabpaint']}, 15:27:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:27:26 INFO - 'tests': ['a11yr', 15:27:26 INFO - 'ts_paint', 15:27:26 INFO - 'tpaint', 15:27:26 INFO - 'sessionrestore', 15:27:26 INFO - 'sessionrestore_no_auto_restore', 15:27:26 INFO - 'tabpaint']}, 15:27:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:27:26 INFO - 'tests': ['tsvgx', 15:27:26 INFO - 'tsvgr_opacity', 15:27:26 INFO - 'tart', 15:27:26 INFO - 'tscrollx', 15:27:26 INFO - 'cart']}, 15:27:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:27:26 INFO - 'tsvgr_opacity', 15:27:26 INFO - 'tart', 15:27:26 INFO - 'tscrollx', 15:27:26 INFO - 'cart']}, 15:27:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:27:26 INFO - 'talos_options': ['--disable-e10s'], 15:27:26 INFO - 'tests': ['tp5o']}, 15:27:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:27:26 INFO - 'tests': ['tp5o']}, 15:27:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:27:26 INFO - 'talos_options': ['--disable-e10s', 15:27:26 INFO - '--xperf_path', 15:27:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:27:26 INFO - 'tests': ['tp5n']}, 15:27:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:27:26 INFO - 'talos_options': ['--xperf_path', 15:27:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:27:26 INFO - 'tests': ['tp5n']}}, 15:27:26 INFO - 'talos.zip': {'path': '', 15:27:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:27:26 INFO - Running post-action listener: _resource_record_post_action 15:27:26 INFO - [mozharness: 2016-11-10 23:27:26.563033Z] Finished populate-webroot step (success) 15:27:26 INFO - [mozharness: 2016-11-10 23:27:26.563120Z] Running create-virtualenv step. 15:27:26 INFO - Running pre-action listener: _resource_record_pre_action 15:27:26 INFO - Running main action method: create_virtualenv 15:27:26 INFO - Creating virtualenv /builds/slave/test/build/venv 15:27:26 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:27:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:27:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:27:26 INFO - Using real prefix '/tools/python27' 15:27:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:27:27 INFO - Installing distribute.............................................................................................................................................................................................done. 15:27:30 INFO - Installing pip.................done. 15:27:30 INFO - Return code: 0 15:27:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:27:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:27:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:27:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101dcb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d41570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ee25c3890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bdfd30>, '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 0x101a45db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bd7b20>, '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.hNMiWHWTGV/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.fEUpP6dGqU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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 15:27:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:27:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:27:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hNMiWHWTGV/Render', 15:27:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:27:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:27:30 INFO - 'HOME': '/Users/cltbld', 15:27:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:27:30 INFO - 'LOGNAME': 'cltbld', 15:27:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:30 INFO - 'MOZ_NO_REMOTE': '1', 15:27:30 INFO - 'NO_EM_RESTART': '1', 15:27:30 INFO - 'PAGER': '/bin/cat', 15:27:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:27:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:30 INFO - 'PWD': '/builds/slave/test', 15:27:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:27:30 INFO - 'SHELL': '/bin/bash', 15:27:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fEUpP6dGqU/Listeners', 15:27:30 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 15:27:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:27:30 INFO - 'USER': 'cltbld', 15:27:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:27:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:27:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:30 INFO - 'XPC_FLAGS': '0x0', 15:27:30 INFO - 'XPC_SERVICE_NAME': '0', 15:27:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:27:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:30 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:27:30 INFO - Cleaning up... 15:27:30 INFO - Return code: 0 15:27:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:27:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:27:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:27:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101dcb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d41570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ee25c3890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bdfd30>, '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 0x101a45db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bd7b20>, '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.hNMiWHWTGV/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.fEUpP6dGqU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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 15:27:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:27:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:27:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hNMiWHWTGV/Render', 15:27:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:27:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:27:30 INFO - 'HOME': '/Users/cltbld', 15:27:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:27:30 INFO - 'LOGNAME': 'cltbld', 15:27:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:30 INFO - 'MOZ_NO_REMOTE': '1', 15:27:30 INFO - 'NO_EM_RESTART': '1', 15:27:30 INFO - 'PAGER': '/bin/cat', 15:27:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:27:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:30 INFO - 'PWD': '/builds/slave/test', 15:27:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:27:30 INFO - 'SHELL': '/bin/bash', 15:27:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fEUpP6dGqU/Listeners', 15:27:30 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 15:27:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:27:30 INFO - 'USER': 'cltbld', 15:27:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:27:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:27:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:30 INFO - 'XPC_FLAGS': '0x0', 15:27:30 INFO - 'XPC_SERVICE_NAME': '0', 15:27:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:27:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:30 INFO - Downloading/unpacking psutil>=3.1.1 15:27: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 15:27: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 15:27: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 15:27: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 15:27: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 15:27: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 15:27:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:27:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:27:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:27:33 INFO - Installing collected packages: psutil 15:27:33 INFO - Running setup.py install for psutil 15:27:34 INFO - building 'psutil._psutil_osx' extension 15:27:34 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 15:27:34 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 15:27:34 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 15:27:34 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 15:27:34 INFO - building 'psutil._psutil_posix' extension 15:27:34 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 15:27:34 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:27:34 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:27:34 INFO - ^ 15:27:34 INFO - 1 warning generated. 15:27:34 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 15:27:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:27:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:27:35 INFO - Successfully installed psutil 15:27:35 INFO - Cleaning up... 15:27:35 INFO - Return code: 0 15:27:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:27:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:27:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:27:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:35 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 0x101dcb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d41570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ee25c3890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bdfd30>, '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 0x101a45db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bd7b20>, '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.hNMiWHWTGV/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.fEUpP6dGqU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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 15:27:35 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 15:27:35 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 15:27:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hNMiWHWTGV/Render', 15:27:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:27:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:27:35 INFO - 'HOME': '/Users/cltbld', 15:27:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:27:35 INFO - 'LOGNAME': 'cltbld', 15:27:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:35 INFO - 'MOZ_NO_REMOTE': '1', 15:27:35 INFO - 'NO_EM_RESTART': '1', 15:27:35 INFO - 'PAGER': '/bin/cat', 15:27:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:27:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:35 INFO - 'PWD': '/builds/slave/test', 15:27:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:27:35 INFO - 'SHELL': '/bin/bash', 15:27:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fEUpP6dGqU/Listeners', 15:27:35 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 15:27:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:27:35 INFO - 'USER': 'cltbld', 15:27:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:27:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:27:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:35 INFO - 'XPC_FLAGS': '0x0', 15:27:35 INFO - 'XPC_SERVICE_NAME': '0', 15:27:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:27:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:27:35 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 15:27:35 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 15:27:35 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 15:27:35 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 15:27:35 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 15:27:35 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 15:27:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:27:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:27:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:27:37 INFO - Installing collected packages: mozsystemmonitor 15:27:37 INFO - Running setup.py install for mozsystemmonitor 15:27:38 INFO - Successfully installed mozsystemmonitor 15:27:38 INFO - Cleaning up... 15:27:38 INFO - Return code: 0 15:27:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:27:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:27:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:27:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101dcb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d41570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ee25c3890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bdfd30>, '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 0x101a45db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bd7b20>, '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.hNMiWHWTGV/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.fEUpP6dGqU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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 15:27:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:27:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:27:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hNMiWHWTGV/Render', 15:27:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:27:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:27:38 INFO - 'HOME': '/Users/cltbld', 15:27:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:27:38 INFO - 'LOGNAME': 'cltbld', 15:27:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:38 INFO - 'MOZ_NO_REMOTE': '1', 15:27:38 INFO - 'NO_EM_RESTART': '1', 15:27:38 INFO - 'PAGER': '/bin/cat', 15:27:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:27:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:38 INFO - 'PWD': '/builds/slave/test', 15:27:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:27:38 INFO - 'SHELL': '/bin/bash', 15:27:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fEUpP6dGqU/Listeners', 15:27:38 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 15:27:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:27:38 INFO - 'USER': 'cltbld', 15:27:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:27:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:27:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:38 INFO - 'XPC_FLAGS': '0x0', 15:27:38 INFO - 'XPC_SERVICE_NAME': '0', 15:27:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:27:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:38 INFO - Downloading/unpacking jsonschema==2.5.1 15:27:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:27:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:27:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:41 INFO - Downloading functools32-3.2.3-2.tar.gz 15:27:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:27:41 INFO - warning: no files found matching '*.txt' 15:27:41 INFO - no previously-included directories found matching 'build' 15:27:41 INFO - no previously-included directories found matching 'dist' 15:27:41 INFO - no previously-included directories found matching '.git*' 15:27:41 INFO - Installing collected packages: jsonschema, functools32 15:27:41 INFO - Running setup.py install for functools32 15:27:41 INFO - warning: no files found matching '*.txt' 15:27:41 INFO - no previously-included directories found matching 'build' 15:27:41 INFO - no previously-included directories found matching 'dist' 15:27:41 INFO - no previously-included directories found matching '.git*' 15:27:41 INFO - Successfully installed jsonschema functools32 15:27:41 INFO - Cleaning up... 15:27:41 INFO - Return code: 0 15:27:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:27:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:27:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:27:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101dcb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d41570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ee25c3890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bdfd30>, '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 0x101a45db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bd7b20>, '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.hNMiWHWTGV/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.fEUpP6dGqU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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 15:27:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:27:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:27:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hNMiWHWTGV/Render', 15:27:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:27:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:27:41 INFO - 'HOME': '/Users/cltbld', 15:27:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:27:41 INFO - 'LOGNAME': 'cltbld', 15:27:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:41 INFO - 'MOZ_NO_REMOTE': '1', 15:27:41 INFO - 'NO_EM_RESTART': '1', 15:27:41 INFO - 'PAGER': '/bin/cat', 15:27:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:27:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:41 INFO - 'PWD': '/builds/slave/test', 15:27:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:27:41 INFO - 'SHELL': '/bin/bash', 15:27:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fEUpP6dGqU/Listeners', 15:27:41 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 15:27:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:27:41 INFO - 'USER': 'cltbld', 15:27:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:27:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:27:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:41 INFO - 'XPC_FLAGS': '0x0', 15:27:41 INFO - 'XPC_SERVICE_NAME': '0', 15:27:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:27:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:27:41 INFO - Cleaning up... 15:27:41 INFO - Return code: 0 15:27:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:27:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:27:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:27:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101dcb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d41570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ee25c3890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bdfd30>, '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 0x101a45db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bd7b20>, '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.hNMiWHWTGV/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.fEUpP6dGqU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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 15:27:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:27:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:27:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hNMiWHWTGV/Render', 15:27:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:27:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:27:41 INFO - 'HOME': '/Users/cltbld', 15:27:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:27:41 INFO - 'LOGNAME': 'cltbld', 15:27:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:41 INFO - 'MOZ_NO_REMOTE': '1', 15:27:41 INFO - 'NO_EM_RESTART': '1', 15:27:41 INFO - 'PAGER': '/bin/cat', 15:27:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:27:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:41 INFO - 'PWD': '/builds/slave/test', 15:27:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:27:41 INFO - 'SHELL': '/bin/bash', 15:27:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fEUpP6dGqU/Listeners', 15:27:41 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 15:27:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:27:41 INFO - 'USER': 'cltbld', 15:27:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:27:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:27:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:41 INFO - 'XPC_FLAGS': '0x0', 15:27:41 INFO - 'XPC_SERVICE_NAME': '0', 15:27:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:27:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:42 INFO - Downloading/unpacking blobuploader==1.2.4 15:27:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:44 INFO - Downloading blobuploader-1.2.4.tar.gz 15:27:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:27:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:27:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:27:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:27:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:46 INFO - Downloading docopt-0.6.1.tar.gz 15:27:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:27:46 INFO - Installing collected packages: blobuploader, requests, docopt 15:27:46 INFO - Running setup.py install for blobuploader 15:27:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:27:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:27:46 INFO - Running setup.py install for requests 15:27:46 INFO - Running setup.py install for docopt 15:27:46 INFO - Successfully installed blobuploader requests docopt 15:27:46 INFO - Cleaning up... 15:27:47 INFO - Return code: 0 15:27:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:27:47 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')]} 15:27:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:47 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')]} 15:27:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:47 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 0x101dcb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d41570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ee25c3890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bdfd30>, '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 0x101a45db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bd7b20>, '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.hNMiWHWTGV/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.fEUpP6dGqU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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 15:27:47 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 15:27:47 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 15:27:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hNMiWHWTGV/Render', 15:27:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:27:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:27:47 INFO - 'HOME': '/Users/cltbld', 15:27:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:27:47 INFO - 'LOGNAME': 'cltbld', 15:27:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:47 INFO - 'MOZ_NO_REMOTE': '1', 15:27:47 INFO - 'NO_EM_RESTART': '1', 15:27:47 INFO - 'PAGER': '/bin/cat', 15:27:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:27:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:47 INFO - 'PWD': '/builds/slave/test', 15:27:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:27:47 INFO - 'SHELL': '/bin/bash', 15:27:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fEUpP6dGqU/Listeners', 15:27:47 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 15:27:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:27:47 INFO - 'USER': 'cltbld', 15:27:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:27:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:27:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:47 INFO - 'XPC_FLAGS': '0x0', 15:27:47 INFO - 'XPC_SERVICE_NAME': '0', 15:27:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:27:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:27:47 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-lDcUsa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:27:47 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-elwUH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:27:47 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-IAgoPe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:27:47 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-8hIuqu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:27:47 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-VcyI49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:27:47 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-JzATfo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:27:47 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-ShY_wx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:27:48 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-jTRmJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:27:48 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-cqKlNx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:27:48 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-nvFPmt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:27:48 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-9ybwfp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:27:48 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-Tkjvtn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:27:48 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-6kjgTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:27:48 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-I2f3vb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:27:48 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-PrCGuU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:27:48 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-9DaFwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:27:48 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-ptPjFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:27:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:27:49 INFO - Running setup.py install for manifestparser 15:27:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:27:49 INFO - Running setup.py install for mozcrash 15:27:49 INFO - Running setup.py install for mozdebug 15:27:49 INFO - Running setup.py install for mozdevice 15:27:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:27:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:27:49 INFO - Running setup.py install for mozfile 15:27:49 INFO - Running setup.py install for mozhttpd 15:27:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:27:49 INFO - Running setup.py install for mozinfo 15:27:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:27:50 INFO - Running setup.py install for mozInstall 15:27:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:27:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:27:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:27:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:27:50 INFO - Running setup.py install for mozleak 15:27:50 INFO - Running setup.py install for mozlog 15:27:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:27:50 INFO - Running setup.py install for moznetwork 15:27:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:27:50 INFO - Running setup.py install for mozprocess 15:27:50 INFO - Running setup.py install for mozprofile 15:27:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:27:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:27:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:27:51 INFO - Running setup.py install for mozrunner 15:27:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:27:51 INFO - Running setup.py install for mozscreenshot 15:27:51 INFO - Running setup.py install for moztest 15:27:51 INFO - Running setup.py install for mozversion 15:27:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:27:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:27:51 INFO - Cleaning up... 15:27:51 INFO - Return code: 0 15:27:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:27:51 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')]} 15:27:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:51 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')]} 15:27:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:51 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 0x101dcb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d41570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ee25c3890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bdfd30>, '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 0x101a45db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bd7b20>, '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.hNMiWHWTGV/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.fEUpP6dGqU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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 15:27:51 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 15:27:51 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 15:27:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hNMiWHWTGV/Render', 15:27:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:27:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:27:51 INFO - 'HOME': '/Users/cltbld', 15:27:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:27:51 INFO - 'LOGNAME': 'cltbld', 15:27:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:51 INFO - 'MOZ_NO_REMOTE': '1', 15:27:51 INFO - 'NO_EM_RESTART': '1', 15:27:51 INFO - 'PAGER': '/bin/cat', 15:27:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:27:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:51 INFO - 'PWD': '/builds/slave/test', 15:27:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:27:51 INFO - 'SHELL': '/bin/bash', 15:27:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fEUpP6dGqU/Listeners', 15:27:51 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 15:27:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:27:51 INFO - 'USER': 'cltbld', 15:27:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:27:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:27:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:51 INFO - 'XPC_FLAGS': '0x0', 15:27:51 INFO - 'XPC_SERVICE_NAME': '0', 15:27:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:27:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:27:51 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-s8U7FZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:27:52 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)) 15:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:27:52 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-NY11qS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:27:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:27:52 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-uApKnB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:27:52 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)) 15:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:27:52 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-_MGtGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:27:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:27:52 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-bj6vA0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:27:52 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)) 15:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:27:52 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-pcq_Qq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:27:52 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)) 15:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:27:52 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-N_dte2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:27:52 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)) 15:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:27:52 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-VHlhI3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:27:52 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)) 15:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:27:52 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-UJHmRF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:27:52 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)) 15:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:27:52 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-omTAmE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:27:53 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)) 15:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:27:53 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-2hYRwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:27:53 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)) 15:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:27:53 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-SLGhR0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:27:53 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)) 15:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:27:53 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-WUukv8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:27:53 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)) 15:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:27:53 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-iksmJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:27:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:27:53 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-RX5e5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:27:53 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)) 15:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:27:53 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-KzC9GN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:27:53 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)) 15:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:27:53 INFO - Running setup.py (path:/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/pip-jp6MRT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:27:53 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)) 15:27:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:27:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:27:53 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)) 15:27:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:27:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:27:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:56 INFO - Downloading blessings-1.6.tar.gz 15:27:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:27:56 INFO - Installing collected packages: blessings 15:27:56 INFO - Running setup.py install for blessings 15:27:56 INFO - Successfully installed blessings 15:27:56 INFO - Cleaning up... 15:27:56 INFO - Return code: 0 15:27:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:27:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:27:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:27:56 INFO - Reading from file tmpfile_stdout 15:27:56 INFO - Current package versions: 15:27:56 INFO - blessings == 1.6 15:27:56 INFO - blobuploader == 1.2.4 15:27:56 INFO - docopt == 0.6.1 15:27:56 INFO - functools32 == 3.2.3-2 15:27:56 INFO - jsonschema == 2.5.1 15:27:56 INFO - manifestparser == 1.1 15:27:56 INFO - mozInstall == 1.12 15:27:56 INFO - mozcrash == 0.17 15:27:56 INFO - mozdebug == 0.1 15:27:56 INFO - mozdevice == 0.48 15:27:56 INFO - mozfile == 1.2 15:27:56 INFO - mozhttpd == 0.7 15:27:56 INFO - mozinfo == 0.9 15:27:56 INFO - mozleak == 0.1 15:27:56 INFO - mozlog == 3.4 15:27:56 INFO - moznetwork == 0.27 15:27:56 INFO - mozprocess == 0.23 15:27:56 INFO - mozprofile == 0.28 15:27:56 INFO - mozrunner == 6.12 15:27:56 INFO - mozscreenshot == 0.1 15:27:56 INFO - mozsystemmonitor == 0.3 15:27:56 INFO - moztest == 0.7 15:27:56 INFO - mozversion == 1.4 15:27:56 INFO - psutil == 3.1.1 15:27:56 INFO - requests == 1.2.3 15:27:56 INFO - wsgiref == 0.1.2 15:27:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:27:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:27:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:27:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:56 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 0x101dcb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d41570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ee25c3890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bdfd30>, '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 0x101a45db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bd7b20>, '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.hNMiWHWTGV/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.fEUpP6dGqU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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 15:27:56 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 15:27:56 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 15:27:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hNMiWHWTGV/Render', 15:27:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:27:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:27:56 INFO - 'HOME': '/Users/cltbld', 15:27:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:27:56 INFO - 'LOGNAME': 'cltbld', 15:27:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:56 INFO - 'MOZ_NO_REMOTE': '1', 15:27:56 INFO - 'NO_EM_RESTART': '1', 15:27:56 INFO - 'PAGER': '/bin/cat', 15:27:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:27:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:56 INFO - 'PWD': '/builds/slave/test', 15:27:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:27:56 INFO - 'SHELL': '/bin/bash', 15:27:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fEUpP6dGqU/Listeners', 15:27:56 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 15:27:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:27:56 INFO - 'USER': 'cltbld', 15:27:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:27:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:27:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:56 INFO - 'XPC_FLAGS': '0x0', 15:27:56 INFO - 'XPC_SERVICE_NAME': '0', 15:27:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:27:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:57 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)) 15:27:57 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)) 15:27:57 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)) 15:27:57 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)) 15:27:57 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)) 15:27:57 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)) 15:27:57 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)) 15:27:57 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)) 15:27:57 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)) 15:27:57 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)) 15:27:57 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)) 15:27:57 INFO - Cleaning up... 15:27:57 INFO - Return code: 0 15:27:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:27:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:27:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:27:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101dcb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d41570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ee25c3890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bdfd30>, '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 0x101a45db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bd7b20>, '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.hNMiWHWTGV/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.fEUpP6dGqU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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 15:27:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:27:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:27:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hNMiWHWTGV/Render', 15:27:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:27:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:27:57 INFO - 'HOME': '/Users/cltbld', 15:27:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:27:57 INFO - 'LOGNAME': 'cltbld', 15:27:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:57 INFO - 'MOZ_NO_REMOTE': '1', 15:27:57 INFO - 'NO_EM_RESTART': '1', 15:27:57 INFO - 'PAGER': '/bin/cat', 15:27:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:27:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:57 INFO - 'PWD': '/builds/slave/test', 15:27:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:27:57 INFO - 'SHELL': '/bin/bash', 15:27:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fEUpP6dGqU/Listeners', 15:27:57 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 15:27:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:27:57 INFO - 'USER': 'cltbld', 15:27:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:27:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:27:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:57 INFO - 'XPC_FLAGS': '0x0', 15:27:57 INFO - 'XPC_SERVICE_NAME': '0', 15:27:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:27:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:27:58 INFO - Cleaning up... 15:27:58 INFO - Return code: 0 15:27:58 INFO - Running post-action listener: _resource_record_post_action 15:27:58 INFO - Running post-action listener: _start_resource_monitoring 15:27:58 INFO - Starting resource monitoring. 15:27:58 INFO - [mozharness: 2016-11-10 23:27:58.290239Z] Finished create-virtualenv step (success) 15:27:58 INFO - [mozharness: 2016-11-10 23:27:58.291214Z] Running install step. 15:27:58 INFO - Running pre-action listener: _resource_record_pre_action 15:27:58 INFO - Running main action method: install 15:27:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:27:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:27:58 INFO - Reading from file tmpfile_stdout 15:27:58 INFO - Detecting whether we're running mozinstall >=1.0... 15:27:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:27:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:27:58 INFO - Reading from file tmpfile_stdout 15:27:58 INFO - Output received: 15:27:58 INFO - Usage: mozinstall [options] installer 15:27:58 INFO - Options: 15:27:58 INFO - -h, --help show this help message and exit 15:27:58 INFO - -d DEST, --destination=DEST 15:27:58 INFO - Directory to install application into. [default: 15:27:58 INFO - "/builds/slave/test"] 15:27:58 INFO - --app=APP Application being installed. [default: firefox] 15:27:58 INFO - mkdir: /builds/slave/test/build/application 15:27:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 15:27:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 15:28:30 INFO - Reading from file tmpfile_stdout 15:28:30 INFO - Output received: 15:28:30 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 15:28:30 INFO - Running post-action listener: _resource_record_post_action 15:28:30 INFO - [mozharness: 2016-11-10 23:28:30.805161Z] Finished install step (success) 15:28:30 INFO - [mozharness: 2016-11-10 23:28:30.805294Z] Running run-tests step. 15:28:30 INFO - Running pre-action listener: _resource_record_pre_action 15:28:30 INFO - Running main action method: run_tests 15:28:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:28:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:28:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:28:30 INFO - 2016-11-10 15:28:30.819 screenresolution[1635:7623] starting screenresolution argv=screenresolution get 15:28:30 INFO - 2016-11-10 15:28:30.822 screenresolution[1635:7623] Display 0: 1600x1200x32@60 15:28:30 INFO - 2016-11-10 15:28:30.828 screenresolution[1636:7626] starting screenresolution argv=screenresolution list 15:28:30 INFO - Available Modes on Display 0 15:28:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:28:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:28:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:28:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:28:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:28:31 INFO - Intel Iris: 15:28:31 INFO - Chipset Model: Intel Iris 15:28:31 INFO - Type: GPU 15:28:31 INFO - Bus: Built-In 15:28:31 INFO - VRAM (Dynamic, Max): 1536 MB 15:28:31 INFO - Vendor: Intel (0x8086) 15:28:31 INFO - Device ID: 0x0a2e 15:28:31 INFO - Revision ID: 0x0009 15:28:31 INFO - Displays: 15:28:31 INFO - Display: 15:28:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:28:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:28:31 INFO - Display Serial Number: 1600x1200 60 15:28:31 INFO - Main Display: Yes 15:28:31 INFO - Mirror: Off 15:28:31 INFO - Online: Yes 15:28:31 INFO - Rotation: Supported 15:28:31 INFO - Return code: 0 15:28:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:28:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:28:31 INFO - Python 2.7.3 15:28:31 INFO - Return code: 0 15:28:31 INFO - grabbing minidump binary from tooltool 15:28:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:28:31 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bdfd30>, '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 0x101a45db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bd7b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:28:31 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:28:31 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 15:28:31 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:28:31 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:28:31 INFO - Return code: 0 15:28:31 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:28:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:28:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:28:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:28:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:28:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AoX9P31hQKu8mG-gXEyHPQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0249', '--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 15:28:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AoX9P31hQKu8mG-gXEyHPQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0249 --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 15:28:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hNMiWHWTGV/Render', 15:28:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:28:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:28:31 INFO - 'HOME': '/Users/cltbld', 15:28:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:28:31 INFO - 'LOGNAME': 'cltbld', 15:28:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:28:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:28:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:31 INFO - 'MOZ_NO_REMOTE': '1', 15:28:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:28:31 INFO - 'NO_EM_RESTART': '1', 15:28:31 INFO - 'PAGER': '/bin/cat', 15:28:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:28:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:28:31 INFO - 'PWD': '/builds/slave/test', 15:28:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:28:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:28:31 INFO - 'SHELL': '/bin/bash', 15:28:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fEUpP6dGqU/Listeners', 15:28:31 INFO - 'TMPDIR': '/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/', 15:28:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:28:31 INFO - 'USER': 'cltbld', 15:28:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:28:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:28:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:31 INFO - 'XPC_FLAGS': '0x0', 15:28:31 INFO - 'XPC_SERVICE_NAME': '0', 15:28:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:28:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AoX9P31hQKu8mG-gXEyHPQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0249', '--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 15:28:31 INFO - mozversion application_buildid: 20161110135120 15:28:31 INFO - mozversion application_changeset: 36f095d0dbfa344f551901b70437c88bee147e30 15:28:31 INFO - mozversion application_display_name: FirefoxDeveloperEdition 15:28:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:28:31 INFO - mozversion application_name: Firefox 15:28:31 INFO - mozversion application_remotingname: firefox-dev 15:28:31 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:28:31 INFO - mozversion application_vendor: Mozilla 15:28:31 INFO - mozversion application_version: 51.0a2 15:28:31 INFO - mozversion platform_buildid: 20161110135120 15:28:31 INFO - mozversion platform_changeset: 36f095d0dbfa344f551901b70437c88bee147e30 15:28:31 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:28:31 INFO - mozversion platform_version: 51.0a2 15:28:31 INFO - using testdate: 1478820511 15:28:31 INFO - actual date: 1478820511 15:28:31 INFO - starting webserver on 'localhost:49277' 15:28:31 INFO - SUITE-START | Running 2 tests 15:28:31 INFO - TEST-START | dromaeo_css 15:28:31 INFO - operating with platform_type : mac_ 15:28:31 INFO - Initialising browser for dromaeo_css test... 15:28:31 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/tmpgeGexL/profile http://localhost:49277/getInfo.html) 15:28:33 INFO - PROCESS | 1646 | __metrics Screen width/height:1600/1200 15:28:33 INFO - PROCESS | 1646 | colorDepth:24 15:28:33 INFO - PROCESS | 1646 | Browser inner width/height: 1024/689 15:28:33 INFO - PROCESS | 1646 | __metrics 15:28:33 INFO - PROCESS | 1646 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:28:33 INFO - PROCESS | 1646 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:28:34 INFO - TEST-INFO | 1646: exit 0 15:28:34 INFO - Browser initialized. 15:28:34 INFO - Running cycle 1/1 for dromaeo_css test... 15:28:34 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/tmpgeGexL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:28:46 INFO - PROCESS | 1648 | RSS: Main: 220340224 15:28:46 INFO - PROCESS | 1648 | 15:29:37 INFO - PROCESS | 1648 | 1478820577756 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] 15:31:49 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49277/tests/dromaeo/cssquery-ext.html) 15:31:51 INFO - PROCESS | 1648 | RSS: Main: 376745984 15:31:51 INFO - PROCESS | 1648 | 15:34:54 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-ext.html (next: http://localhost:49277/tests/dromaeo/cssquery-jquery.html) 15:34:55 INFO - PROCESS | 1648 | RSS: Main: 353447936 15:34:55 INFO - PROCESS | 1648 | 15:37:57 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49277/tests/dromaeo/cssquery-mootools.html) 15:37:58 INFO - PROCESS | 1648 | RSS: Main: 330547200 15:37:58 INFO - PROCESS | 1648 | 15:41:00 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49277/tests/dromaeo/cssquery-prototype.html) 15:41:01 INFO - PROCESS | 1648 | RSS: Main: 310702080 15:41:01 INFO - PROCESS | 1648 | 15:44:04 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49277/tests/dromaeo/cssquery-yui.html) 15:44:05 INFO - PROCESS | 1648 | RSS: Main: 310120448 15:44:05 INFO - PROCESS | 1648 | 15:47:08 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-yui.html (next: http://localhost:49277/tests/dromaeo/cssquery-dojo.html) 15:47:08 INFO - PROCESS | 1648 | RSS: Main: 388423680 15:47:08 INFO - PROCESS | 1648 | 15:47:08 INFO - PROCESS | 1648 | __start_tp_report 15:47:08 INFO - PROCESS | 1648 | _x_x_mozilla_page_load 15:47:08 INFO - PROCESS | 1648 | _x_x_mozilla_page_load_details 15:47:08 INFO - PROCESS | 1648 | |i|pagename|runs| 15:47:08 INFO - PROCESS | 1648 | |0;dojo.html;2829.872655730492;3327.7670563060587;3377.5271461995308;3385.424477838767;3430.965690343096;5620.128880023598;5637.098064309711;5732.312122545301;5736.569757268206;5755.683437410946;5703.914441283384;5791.21818554495;5795.797147099853;5805.593608447411;5819.185314056035;5215.452377500345;5232.4767523247565;5232.529072383475;5268.236105764662;5288.92066619001;5136.357955255593;5154.433012368655;5171.715555644438;5327.174287985368;5329.307190065286;5162.638615296931;5176.767045482962;5216.426193118773;5270.209468579706;5298.682079075248;5132.743362831843;5216.8695782605355;5217.3999990000875;5238.109521381336;5238.68567885928;4324.35134729793;5124.538791508782;5151.072806894757;5172.767225474862;5232.790688372461;5584.274044374246;5591;5599.216109744639;5643.379228284885;5649.4633009864;6149.723262453201;6172.4136207060255;6189.783357582508;6197.969010154966;6213.658248796314;6269.498440124779;6312.368763123651;6324.3359447257835;6330;6338.524610654219;5643.097104463266;5670.291213598301;5743.569232307594;5768.798092066758;5818;6249.875042485486;6251.4061164189325;6271.3415091414745;6282.308946015934;6302.306746257908;6183.628982261079;6194.845128871724;6203.410675985774;6207.410296021871;6207.96896015517;6110.194261626863;6161.075838624152;6178.536609754196;6212.689365531705;6220.813375598739;6066.393360663987;6251.9687401562705;6254.15568898202;6261.060840873905;6267.185265915402;6212.0371342441995;6236.532260080512;6280.466160376419;6285.497160227171;6295.213098362705;4851.417829860368;4886.877828054327;4890.217565189624;4957.454679985199;4981.12830254704;4382.715123516961;4420.049689316812;4426.291793313055;4456.197884380777;4499.505054444008;5737.08206686928;5745;5749.8275051748515;5760.135979603093;5761.711914404347;6121;6289.088082228142;6293.087502312231;6304;6324.3043265240785;5686.3744988051285;5707.1724599933605;5776.653400795965;5784.987627165229;5795.652260864362;5397.78408863641;5452.26394436746;5468.070428027245;5500.697461639568;5502.862428439321;6311.589746666452;6319.968400158154;6332.1135041094285;6335.968320158369;6341.524385671001;6137.346341658419;6245.594036387621;6280.166767118704;6293.992961126198;6330.430261276507;6215.564910456224;6264.624122552661;6272.905906411316;6273.62358258506;6561.081448597105;6213.844653883689;6251.281102673251;6263.843403914939;6278.058291256348;6283.528735344776;6155.4767844731905;6265.8746825062335;6308.053791931247;6320.494360451245;6325.873482530232;5933.110033495011;6057.757689692363;6066.363031881765;6145.324014358328;6211.130441738251;5306.602004849575;6109.389061093855;6213.37866213375;6217.875642487034;6230.43926046658;5007.349044624176;6017.277926648655;6080;6091.725872335667;6092.268927728701;5961.910571341346;5984.251968503937;6083.6045657032155;6128.846778830565;6135.07955838608;6058.757649694139;6067.848303792441;6100.267967843887;6107.4197951194565;6140.20177376956 15:47:08 INFO - PROCESS | 1648 | |1;ext.html;465.91147681940436;530.2311648110241;534.7005676820978;538.3378444513249;548.4159370270659;30011;40179.59820401795;40749.79625101878;41028.38457423137;41096;42336;43371.56628433715;43686.56313436873;43816.78091609546;43865;9786.972367901357;9957.253206009542;9972.002799720007;9983.75040623983;9983.800323993515;9847.015298470167;9959.950200249024;9969.900300997006;9972.551235194434;9978.60085596579;8974.967878693968;9515.524223788818;9934.850977235312;9994.250431217652;10001.0499002595;9892.85160722586;9961.302708810386;9961.551730172087;9964.95017524915;9975.002499750004;9817.214622830157;9902.603895844157;9910.20718342538;9917.65288214909;9920.45437500937;40446.79776601098;40760.388594170814;40817.387739183934;40915;40927;3465.982670086659;3941.684665226775;3978.622030907059;3983.1237127831832;4023.456833327522;30928.8453557733;31253.593588288582;32002.519962200586;32988.50517242243;33029.17427064318;3122.9063128106195;3193.8403079845916;3206.1022913584234;3256.6417694053634;3293.1931676739114;501116;521950;523781;524029;524319;33368.833155834065;64218;64888.02667959985;64967.35032649613;65052.67473662602;33985.32029359399;35257;35496.645033549335;35568.64431355705;35635.465468018;15153.62115947088;15194.924025380024;15251.923740381228;15256.38974441032;15259.313330900137;12931.870681293067;13001.609951701465;13008.089433739548;13017.153884997444;13062.608121756362;7749.845003100019;7770.572618506037;7772.8056798579355;7841.137474877759;7848.13670496245;3190.1865024418626;3241.9675803241666;3248.561444205049;3254.08885512057;3294.7199488043784;918.8346097702344;984.9556769945369;1024.7643042100358;1059.6397224943555;1127.689885281554;26035.739642603712;30179.698203018128;30438.84780576083;30988;31162.68837311643;1091.8635170603675;1106.9723256918642;1134.631244845412;1151.5566506894738;1169.8362229287907;15159.393624254906;15501.534953951399;15790.052596844225;15814.76277855833;16210.67578648444;670557;673513;674649;679615;680591;58650;59020;59138;59185.11222331668;59193.11210331848;1209.9032077433785;1238.207547169812;1308.3131356037966;1355.5052405871588;1358.9728205435836;30569.23576910595;30990.69009309968;31636;31669.524957125202;32488.350232994733;49599.00801983868;50089.74775630638;50216.49783502118;50294.49705502898;50378.740531487005;508832;509811;513002.43498782266;513186;818271;23426.18008369699;23683.64474532918;23699.17052903209;23741.169059082848;26170.476590467704;45798.25289537173;46375.76812115918;46739;47957.52042479531;48508.5149148504;38576.614233858425;39427;39485.210295794495;39559.80220098881;41126.79436602798;38658.6134138655;39451;40256;40494;40968.79515602522;37566.248675026894;38068;38233.80883095567;38348.42477362786;38524.6147538521;31927.840360798047;34731.82634086813;35555;35576.822115889256;35688;22732.545349093256;23077.76922230756;25137.120200792884;26000.47999039971;26691.33271668224 15:47:08 INFO - PROCESS | 1648 | |2;jquery.html;356.5097990263388;372.9687414299461;377.9357509223432;384.6711062041954;403.2660557784831;11806.114541409397;15381.769273460894;16226.269817858196;20892.05985730642;21370;20252;20869.91300869912;21316.4670883228;21498.89250553745;21767.782322176772;5760.193572899798;5786.276715410574;5994.250718660168;6026.939730602704;6051.788187413442;6031.909521357183;6171.876562468748;6180.1965744453155;6186.969065154668;6200.751969921198;3874.651281384675;4105.774182419966;5835.533157347402;6132.325444201134;6178.536609754264;5927.73325200367;6205.31741508436;6207.162033125515;6215.09881067245;6245.3442388549;5945.881082378328;5997.250343707036;6001.969990150022;6013.669248191348;6019.789307374264;13295.73408531824;13313.334333283297;13403.731925361535;13510.527131550349;13540.322983850867;2320.280712978982;2474.9133780317784;2524.394145405108;2723.774301564284;2785.0183159311264;9950.054744799305;10167.389956602554;10190.643327483576;10564.524596393105;10665.413402262873;1845.723141528768;1901.6386886491523;1928.3732786844332;1940.1075505267595;1991.3926252492984;115971;117360;124518;126835;129515;9578.66474673397;11143.554257829595;11374.260673056226;11477.368744718953;11627.244229125079;14504.637384065272;14510.1293922365;14510.492132775302;14519;14523.927380363031;7831.569263690438;8079.434439589172;8455.492670439793;8798.648054077765;8823.867641985375;8717.215450609476;8729.996050454152;8740.125987401208;8886.555672216493;8902.510361930026;4472.172648060119;4515.367848501212;4539.818407263739;4597.080583883237;4633.6524760642415;1751.702210624197;1898.3071179019557;1926.5280006398523;1927.6988033077616;1947.7175809507826;760.4638729695552;787.9330256928225;861.6294993153004;890.9777255568533;977.2914636888199;21019;21898.343049708536;21939.451513711967;21960.780392195873;22051.33845984623;924.1728652855791;926.4904302633524;967.8354679704468;1005.8893521712606;1055.889131641182;9451.858222126673;10067.74153230846;10683.465826708634;10890.40102794338;11293;521820;597229.013854928;603133;614710;615305;113421;128794;129014;133809;140239;980.5832521178471;1004.4124187350482;1016.4765145949842;1017.2624846985876;1018.3024628129755;18228.45314640563;19597;20121;20121.295754648516;20167.394978150678;54888;58321.708391457774;59144;59285.70357148186;60519.78960420679;79185;83716;84781.57609212161;88864.5556772212;93625.4243134728;8017.759467215759;8035.83928321442;8115.634796434293;8373.74878753614;8427.494350338999;12071.766723156245;13128.803067953797;13151.53969611059;13654.317284135555;13659.248741319323;9898.812142542942;11180.440977950908;11500.654980350602;11593.130515211224;11695.660867826298;11204.93553112453;11365.261258018532;11411.315321080761;11736.413179341169;11757.823632645688;5851.414858514285;8913.707512410794;9311;11319.547218111184;11725.003374713246;8178.223068808454;8326.250637442417;8355.95822020886;8420.4947703138;8434.283085937765;9553.570089345858;9705.854412183682;10626.574937002433;11351.943240284076;11762.764744704888 15:47:08 INFO - PROCESS | 1648 | |3;mootools.html;1491.6270932266934;1533.5322726568397;1699.3797263998636;1842.309134074722;1870.2145099058393;8608.655653773842;9178.449293042422;9191.54042297885;9196.63213471462;9197.264218862492;7856.685732570691;8123.593820308991;8164.550949697779;8672.13278672134;8877.822443551126;2407.2657839358944;2437.4150203951103;2441.2554170977846;2445.7065152181763;2445.8899349529315;2410.2648692148887;2419.5644783938974;2439.42673471734;2442.9144979925704;2445.0097710427217;2418.697662792151;2430.222328854767;2440.792532634728;2443.3525115844313;2450.068973789966;2399.5800734871327;2409.5542324669905;2416.6254230594286;2421.2494126820566;2423.842450240729;2076.532780124475;2396.35298469414;2413.2880800163816;2415.7946574541184;2419.9153029644053;8997.145271199226;9029.142231487998;9118.908810911938;9122.635094596208;9156.313276504223;4548.431446069241;5498.505134537871;5514.228008078872;5515.338159420855;5522.199281104217;3444.50054742061;3515.701165400944;3627.2382799612114;3680.1535646801117;3716.6655001050035;1015.7917626886544;1076.3595660582018;1101.1796211822243;1123.528118190362;1127.774445110973;12109.636710898687;12129.454174562166;12147.08896832741;12182.878171218263;12191.146619736623;4724.718632354467;4771.809127634856;4775.140474714584;4884.3161957326;4892.902141957141;10165.085142337226;10171.440570768531;10181.592736290466;10183.287169898183;10189.74525636865;5423.457654234624;5424.593155513352;5425.13197888336;5430.647007944471;5433.728313584305;4413.360062790877;4566.086782643418;4582.289745089516;4938.333325001151;4940.382452193476;3967.107400834847;3997.7601343918877;4077.408775727503;4097.078157414558;4114.321137012419;1115.6708770912437;1284.5825106840314;1290.4967062845499;1296.714722760991;1299.1036185032297;877.2718643525858;883.1654086887958;886.2732559301311;894.8299823033602;913.6254135804288;5710.71446427677;5871.588988770831;5878.647281163144;6085.878282434415;6184.752609895554;450.34025153150793;454.1484716157205;460.34400978605356;994.1003391930315;1010.2877471382805;3676.860173346271;3699.8335074921692;3997.360422332471;3998.6001399859783;4177.310743727312;10857.83713244286;11063.502142403611;11168.832467512993;11177.385243811668;11207.327560346404;10740.409277489656;11057.391843448688;11195.72010699739;11210.439478026066;11213.775724485464;8296.668133274723;8305.169483051768;8409.95795021021;8428.915710842935;8483.151684831591;5889.028310328919;5972.25346831646;6064.3935606439;6071.392860713893;6147.047207682816;8141.9185808141165;9796.608135674493;9928.453935033642;10150.695479135638;10239.027292407209;9862.309638325536;10343.896561034293;10519.842202366817;10671.35971841692;10704.785904282027;7188.101487314086;7446.218147094477;7731.420143489148;7832.451728378959;7963.283304502623;8704.521251330983;8776.517291549026;8808.735737927873;8812.471251724917;8855.512946787989;7554.962225188839;7811.4922530035365;7821.530708157528;7840.960795195988;7960.044794624682;7549.1695913448375;7626.161122276656;7645.388368930583;7716.8456630868195;7798.454108212598;7179.138503379628;7219.241979592067;7306.196318405077;7309.744158954411;7316.634168291671;4529.297958816389;4980.252962055721;5055.216441451581;5207.140821764367;5341.172118321666;4869.9026019480125;5072.1123803335;5196.506331898464;5350.946490535201;5389 15:47:08 INFO - PROCESS | 1648 | |4;prototype.html;298.52683496657795;304.50365903577165;307.5202683813251;310.8601129491728;312.7966821565983;5397.51422371987;5402.37872644646;5433.1578605316145;5445.48267914548;5446.291982042334;5347.46525347466;5349.732513374335;5365.570754339653;5374.543163831079;5379.359295414897;3818.3890577507605;3930.272899513585;3972.2849887020325;4002.8198731057173;4070.7991142613;3750.7374483786148;4059.451973983504;4089.897752556195;4104.363823607346;4109.753414795122;3887.4168874668744;4024.476818013669;4029.697772667047;4078.2659121358142;4111.979440102796;3798.240351929625;3972.741771784825;4069.7151199416203;4075.982388717604;4099.975006248438;3459.221675123102;3460.377132116218;3467.8959631211105;3469.2194256292387;3497.8600855965733;5118.309028281209;5143;5162.535371816554;5177.352830896138;5238.764255608468;4389.934150987738;4590.862274131781;4596.080783843211;4605.700629459075;4621.884452888671;5479.753301146511;5525.060739674265;5540.229885057472;5568.832935011957;5583.637063590853;3374.561307030095;3766.7551609145316;3807.447920051577;3823.2926908522013;3841.5966323536186;5636.408177141423;5895.35151133375;5924.971019706598;5977;5977.625146216351;3537.920934115068;3627.474016267626;3827.6794505895423;3847.634474724897;3889.144388234584;3378.7634865559176;3653.5203242686753;3783.45139954705;3876.379779235309;3925.2345792570177;4541.704789188692;4574.947762014755;4575.771211439414;4585.564371384713;4593.104344652761;4948.901021979612;5363.356397232279;5456.645318054314;5596.656802367484;5692.203091567184;1108.634150730257;1259.9101776962862;1342.8052932324758;1343.2075075705382;1345.5088892554147;769.3575864153382;800.8358286551243;819.2749416766205;821.8124809649998;824.6330382979517;4668.393108895822;4978.551930326288;5107.361579802525;5108.540231379194;5116.850922612512;4911;5803.47768700819;5843.298804143445;5847.795327163614;5894.823155305347;4880.926786098212;5270.894582108336;5284.260203571503;5305.257263983045;5329.520343169133;2998.835064071497;3024.7882648214413;3045.1473587395567;3051.4965030769677;3052.252198211408;5304.045271851027;5313.601479889024;5373.462653734595;5516.9448305516435;5812.738426770806;5514.558835293167;5897.7935772247765;5900.409959004065;5993.610415323077;6024.433647251746;4615.815367385267;5194.376674798973;5330.653507521999;5886.352501224947;5914.822555323347;5370.275012873212;5728.966216993074;5775.884482310246;5792.247007888947;5828.0184737187865;4965.950340496549;5344.888768936326;5683.744231509675;5729.255196824386;5788.82633520995;6012.969935150471;6023.759049638141;6027.432867454581;6103.3591472894705;6144.754209831735;3200.4079245339685;3265.37957788029;3848.730588858753;3872.2449122421986;3925.4504369387737;5459.607800010972;5797.246357973437;5804.5356371491025;5825.3592104867585;5831.883362332815;5281.260623512634;5564.805231816867;5675.899917030725;5732.455416735404;5742.942570574241;5307.4692530746615;5542.307211598551;5668.971655141698;5672.319321681424;5781.8554536136935;4953.72754498506;5516;5533.363663178786;5583.581231407742;5594.244776955059;4735.195016847213;4797.592204662643;5462.453754624506;5569.886022795376;5601.075822489406;5519.847259568691;5527.8894422110525;5528.474794894479;5538.6399884007415;5561.304836895388 15:47:08 INFO - PROCESS | 1648 | |5;yui.html;713.5005496152693;742.4283301857573;792.8691765858633;800.3324001068429;803.4094940218936;13072.542461013867;14785.408583656654;15590;16087.51737447877;16089.678206435865;14628;14713.411463541446;14878.25608719565;14882.925585372084;14901.850981490208;687.2371667449128;826.0005393473889;835.8370117827026;836.8284501677172;839.1063517353998;700.2052670219313;704.1303989572873;705.4145059600519;707.0419581467115;707.27857585263;879.2965627498008;899.3165194452198;899.4783025845027;909.2316992141663;910.4901255297021;901.0944001278739;903.4353529044347;904.3940559824933;906.9954650226707;907.7276816954887;532.3053415293041;671.1576970901536;672.6737532296833;674.1404708996021;675.4663815585682;12392.81410778839;14679.266036698122;15228.162451065187;15266.923665381602;15343.616409589738;14300.85699143016;14552;14585.343659535347;14746.778798318033;14818.851811481854;11059.612913548068;11559.43947567076;11645.010174135208;11871.643850684493;12190.695232619168;3789.3368660484307;3877.495925529663;3901.49280593521;4008.1382502762044;4013.6989725770686;115941;116640.41679791547;117503;118040.40979795132;122474.38762806218;10861.83707244392;11113;11221.438928053565;11227.438628068563;11411.372374519315;22740.886295568416;22986.655200172012;23006.309810705705;23006.884965575064;23413.882930585238;7680.385569154454;7796.766097017098;7996.440249182501;8197.71308004217;8328.167183281623;4448.154850578379;4490.39379683745;4661.953380466152;4722.9763851181215;4810.6632535722865;3539.150603855056;3622.168626768474;3624.7281453891064;3660.084978755311;3661.395869681526;655.5116438253532;658.1312667279145;659.172738213539;669.6116252573496;673.4208580620663;592.6769910398843;664.727461740684;667.2177021819026;681.271039987209;701.1025886864821;9345.579448924815;9568.234541236685;9655.324127311022;9688.70933871985;9690.12788849007;578.6210032428766;626.9749210031639;645.9741610335628;654.1365397675023;662.453475882399;4652.441706995114;4673.112108699336;4679.3916790816975;4681.344611754357;4681.859544213679;93743;93998.53000734953;96642.55036174462;146125.26937365244;161484;112123;143513;146696;148131;148168;72452;76676.61661691655;77222.45555088867;77395.61302193454;121782;7492.9625351875075;8977.910220897707;8980.101989800967;8982.505962172143;8992.82014359696;53480.73259633677;64853.37866553374;65532.0170197457;65843.67078164578;67452.662736686;91167.54416227876;98375.50812245892;99908.50045749724;101868.4906575492;108019;11884.643460696192;12064.155509114278;12099;12115.515379385079;12387.256764594153;12896.355182240663;12986.415611297325;13127.081104322606;13155.802662960255;13211.471541138631;11998.940005299917;13208.933955330162;13805.861941380457;14048.929755351157;15122.773158402413;13348.399322030726;14133.858661413255;14329.140251584939;14406.85593144097;14416.207108609127;13340.466381344637;13535.729285414434;13840;14507.057041292705;14633.634159146106;11307.378094204898;11419.942900285445;11769.293842369485;12048.397580120783;12114.15200935926;11278.661640150809;11566.016888564567;11712.648620541397;11886.108541859223;11916.285022898654 15:47:08 INFO - PROCESS | 1648 | __end_tp_report 15:47:08 INFO - PROCESS | 1648 | __start_cc_report 15:47:08 INFO - PROCESS | 1648 | _x_x_mozilla_cycle_collect,1568 15:47:08 INFO - PROCESS | 1648 | __end_cc_report 15:47:08 INFO - PROCESS | 1648 | __startTimestamp1478821628356__endTimestamp 15:47:08 INFO - PROCESS | 1648 | 15:47:08 INFO - PROCESS | 1648 | ------- Summary: start ------- 15:47:08 INFO - PROCESS | 1648 | Number of tests: 6 15:47:08 INFO - PROCESS | 1648 | 15:47:08 INFO - PROCESS | 1648 | [#0] dojo.html Cycles:165 Average:5750.17 Median:6058.76 stddev:668.63 (11.0%) stddev-sans-first:630.22 15:47:08 INFO - PROCESS | 1648 | Values: 2829.9 3327.8 3377.5 3385.4 3431.0 5620.1 5637.1 5732.3 5736.6 5755.7 5703.9 5791.2 5795.8 5805.6 5819.2 5215.5 5232.5 5232.5 5268.2 5288.9 5136.4 5154.4 5171.7 5327.2 5329.3 5162.6 5176.8 5216.4 5270.2 5298.7 5132.7 5216.9 5217.4 5238.1 5238.7 4324.4 5124.5 5151.1 5172.8 5232.8 5584.3 5591.0 5599.2 5643.4 5649.5 6149.7 6172.4 6189.8 6198.0 6213.7 6269.5 6312.4 6324.3 6330.0 6338.5 5643.1 5670.3 5743.6 5768.8 5818.0 6249.9 6251.4 6271.3 6282.3 6302.3 6183.6 6194.8 6203.4 6207.4 6208.0 6110.2 6161.1 6178.5 6212.7 6220.8 6066.4 6252.0 6254.2 6261.1 6267.2 6212.0 6236.5 6280.5 6285.5 6295.2 4851.4 4886.9 4890.2 4957.5 4981.1 4382.7 4420.0 4426.3 4456.2 4499.5 5737.1 5745.0 5749.8 5760.1 5761.7 6121.0 6289.1 6293.1 6304.0 6324.3 5686.4 5707.2 5776.7 5785.0 5795.7 5397.8 5452.3 5468.1 5500.7 5502.9 6311.6 6320.0 6332.1 6336.0 6341.5 6137.3 6245.6 6280.2 6294.0 6330.4 6215.6 6264.6 6272.9 6273.6 6561.1 6213.8 6251.3 6263.8 6278.1 6283.5 6155.5 6265.9 6308.1 6320.5 6325.9 5933.1 6057.8 6066.4 6145.3 6211.1 5306.6 6109.4 6213.4 6217.9 6230.4 5007.3 6017.3 6080.0 6091.7 6092.3 5961.9 5984.3 6083.6 6128.8 6135.1 6058.8 6067.8 6100.3 6107.4 6140.2 15:47:08 INFO - PROCESS | 1648 | 15:47:08 INFO - PROCESS | 1648 | [#1] ext.html Cycles:180 Average:70838.69 Median:22081.36 stddev:160113.12 (725.1%) stddev-sans-first:160475.10 15:47:08 INFO - PROCESS | 1648 | Values: 465.9 530.2 534.7 538.3 548.4 30011.0 40179.6 40749.8 41028.4 41096.0 42336.0 43371.6 43686.6 43816.8 43865.0 9787.0 9957.3 9972.0 9983.8 9983.8 9847.0 9960.0 9969.9 9972.6 9978.6 8975.0 9515.5 9934.9 9994.3 10001.0 9892.9 9961.3 9961.6 9965.0 9975.0 9817.2 9902.6 9910.2 9917.7 9920.5 40446.8 40760.4 40817.4 40915.0 40927.0 3466.0 3941.7 3978.6 3983.1 4023.5 30928.8 31253.6 32002.5 32988.5 33029.2 3122.9 3193.8 3206.1 3256.6 3293.2 501116.0 521950.0 523781.0 524029.0 524319.0 33368.8 64218.0 64888.0 64967.4 65052.7 33985.3 35257.0 35496.6 35568.6 35635.5 15153.6 15194.9 15251.9 15256.4 15259.3 12931.9 13001.6 13008.1 13017.2 13062.6 7749.8 7770.6 7772.8 7841.1 7848.1 3190.2 3242.0 3248.6 3254.1 3294.7 918.8 985.0 1024.8 1059.6 1127.7 26035.7 30179.7 30438.8 30988.0 31162.7 1091.9 1107.0 1134.6 1151.6 1169.8 15159.4 15501.5 15790.1 15814.8 16210.7 670557.0 673513.0 674649.0 679615.0 680591.0 58650.0 59020.0 59138.0 59185.1 59193.1 1209.9 1238.2 1308.3 1355.5 1359.0 30569.2 30990.7 31636.0 31669.5 32488.4 49599.0 50089.7 50216.5 50294.5 50378.7 508832.0 509811.0 513002.4 513186.0 818271.0 23426.2 23683.6 23699.2 23741.2 26170.5 45798.3 46375.8 46739.0 47957.5 48508.5 38576.6 39427.0 39485.2 39559.8 41126.8 38658.6 39451.0 40256.0 40494.0 40968.8 37566.2 38068.0 38233.8 38348.4 38524.6 31927.8 34731.8 35555.0 35576.8 35688.0 22732.5 23077.8 25137.1 26000.5 26691.3 15:47:08 INFO - PROCESS | 1648 | 15:47:08 INFO - PROCESS | 1648 | [#2] jquery.html Cycles:180 Average:34983.69 Median:2754.40 stddev:99152.52 (3599.8%) stddev-sans-first:99396.58 15:47:08 INFO - PROCESS | 1648 | Values: 356.5 373.0 377.9 384.7 403.3 11806.1 15381.8 16226.3 20892.1 21370.0 20252.0 20869.9 21316.5 21498.9 21767.8 5760.2 5786.3 5994.3 6026.9 6051.8 6031.9 6171.9 6180.2 6187.0 6200.8 3874.7 4105.8 5835.5 6132.3 6178.5 5927.7 6205.3 6207.2 6215.1 6245.3 5945.9 5997.3 6002.0 6013.7 6019.8 13295.7 13313.3 13403.7 13510.5 13540.3 2320.3 2474.9 2524.4 2723.8 2785.0 9950.1 10167.4 10190.6 10564.5 10665.4 1845.7 1901.6 1928.4 1940.1 1991.4 115971.0 117360.0 124518.0 126835.0 129515.0 9578.7 11143.6 11374.3 11477.4 11627.2 14504.6 14510.1 14510.5 14519.0 14523.9 7831.6 8079.4 8455.5 8798.6 8823.9 8717.2 8730.0 8740.1 8886.6 8902.5 4472.2 4515.4 4539.8 4597.1 4633.7 1751.7 1898.3 1926.5 1927.7 1947.7 760.5 787.9 861.6 891.0 977.3 21019.0 21898.3 21939.5 21960.8 22051.3 924.2 926.5 967.8 1005.9 1055.9 9451.9 10067.7 10683.5 10890.4 11293.0 521820.0 597229.0 603133.0 614710.0 615305.0 113421.0 128794.0 129014.0 133809.0 140239.0 980.6 1004.4 1016.5 1017.3 1018.3 18228.5 19597.0 20121.0 20121.3 20167.4 54888.0 58321.7 59144.0 59285.7 60519.8 79185.0 83716.0 84781.6 88864.6 93625.4 8017.8 8035.8 8115.6 8373.7 8427.5 12071.8 13128.8 13151.5 13654.3 13659.2 9898.8 11180.4 11500.7 11593.1 11695.7 11204.9 11365.3 11411.3 11736.4 11757.8 5851.4 8913.7 9311.0 11319.5 11725.0 8178.2 8326.3 8356.0 8420.5 8434.3 9553.6 9705.9 10626.6 11351.9 11762.8 15:47:08 INFO - PROCESS | 1648 | 15:47:08 INFO - PROCESS | 1648 | [#3] mootools.html Cycles:180 Average:5840.43 Median:4748.26 stddev:3310.65 (69.7%) stddev-sans-first:3303.81 15:47:08 INFO - PROCESS | 1648 | Values: 1491.6 1533.5 1699.4 1842.3 1870.2 8608.7 9178.4 9191.5 9196.6 9197.3 7856.7 8123.6 8164.6 8672.1 8877.8 2407.3 2437.4 2441.3 2445.7 2445.9 2410.3 2419.6 2439.4 2442.9 2445.0 2418.7 2430.2 2440.8 2443.4 2450.1 2399.6 2409.6 2416.6 2421.2 2423.8 2076.5 2396.4 2413.3 2415.8 2419.9 8997.1 9029.1 9118.9 9122.6 9156.3 4548.4 5498.5 5514.2 5515.3 5522.2 3444.5 3515.7 3627.2 3680.2 3716.7 1015.8 1076.4 1101.2 1123.5 1127.8 12109.6 12129.5 12147.1 12182.9 12191.1 4724.7 4771.8 4775.1 4884.3 4892.9 10165.1 10171.4 10181.6 10183.3 10189.7 5423.5 5424.6 5425.1 5430.6 5433.7 4413.4 4566.1 4582.3 4938.3 4940.4 3967.1 3997.8 4077.4 4097.1 4114.3 1115.7 1284.6 1290.5 1296.7 1299.1 877.3 883.2 886.3 894.8 913.6 5710.7 5871.6 5878.6 6085.9 6184.8 450.3 454.1 460.3 994.1 1010.3 3676.9 3699.8 3997.4 3998.6 4177.3 10857.8 11063.5 11168.8 11177.4 11207.3 10740.4 11057.4 11195.7 11210.4 11213.8 8296.7 8305.2 8410.0 8428.9 8483.2 5889.0 5972.3 6064.4 6071.4 6147.0 8141.9 9796.6 9928.5 10150.7 10239.0 9862.3 10343.9 10519.8 10671.4 10704.8 7188.1 7446.2 7731.4 7832.5 7963.3 8704.5 8776.5 8808.7 8812.5 8855.5 7555.0 7811.5 7821.5 7841.0 7960.0 7549.2 7626.2 7645.4 7716.8 7798.5 7179.1 7219.2 7306.2 7309.7 7316.6 4529.3 4980.3 5055.2 5207.1 5341.2 4869.9 5072.1 5196.5 5350.9 5389.0 15:47:08 INFO - PROCESS | 1648 | 15:47:08 INFO - PROCESS | 1648 | [#4] prototype.html Cycles:180 Average:4573.49 Median:5282.76 stddev:1420.86 (26.9%) stddev-sans-first:1388.15 15:47:08 INFO - PROCESS | 1648 | Values: 298.5 304.5 307.5 310.9 312.8 5397.5 5402.4 5433.2 5445.5 5446.3 5347.5 5349.7 5365.6 5374.5 5379.4 3818.4 3930.3 3972.3 4002.8 4070.8 3750.7 4059.5 4089.9 4104.4 4109.8 3887.4 4024.5 4029.7 4078.3 4112.0 3798.2 3972.7 4069.7 4076.0 4100.0 3459.2 3460.4 3467.9 3469.2 3497.9 5118.3 5143.0 5162.5 5177.4 5238.8 4389.9 4590.9 4596.1 4605.7 4621.9 5479.8 5525.1 5540.2 5568.8 5583.6 3374.6 3766.8 3807.4 3823.3 3841.6 5636.4 5895.4 5925.0 5977.0 5977.6 3537.9 3627.5 3827.7 3847.6 3889.1 3378.8 3653.5 3783.5 3876.4 3925.2 4541.7 4574.9 4575.8 4585.6 4593.1 4948.9 5363.4 5456.6 5596.7 5692.2 1108.6 1259.9 1342.8 1343.2 1345.5 769.4 800.8 819.3 821.8 824.6 4668.4 4978.6 5107.4 5108.5 5116.9 4911.0 5803.5 5843.3 5847.8 5894.8 4880.9 5270.9 5284.3 5305.3 5329.5 2998.8 3024.8 3045.1 3051.5 3052.3 5304.0 5313.6 5373.5 5516.9 5812.7 5514.6 5897.8 5900.4 5993.6 6024.4 4615.8 5194.4 5330.7 5886.4 5914.8 5370.3 5729.0 5775.9 5792.2 5828.0 4966.0 5344.9 5683.7 5729.3 5788.8 6013.0 6023.8 6027.4 6103.4 6144.8 3200.4 3265.4 3848.7 3872.2 3925.5 5459.6 5797.2 5804.5 5825.4 5831.9 5281.3 5564.8 5675.9 5732.5 5742.9 5307.5 5542.3 5669.0 5672.3 5781.9 4953.7 5516.0 5533.4 5583.6 5594.2 4735.2 4797.6 5462.5 5569.9 5601.1 5519.8 5527.9 5528.5 5538.6 5561.3 15:47:08 INFO - PROCESS | 1648 | 15:47:08 INFO - PROCESS | 1648 | [#5] yui.html Cycles:180 Average:24159.73 Median:3833.42 stddev:38230.84 (997.3%) stddev-sans-first:38297.55 15:47:08 INFO - PROCESS | 1648 | Values: 713.5 742.4 792.9 800.3 803.4 13072.5 14785.4 15590.0 16087.5 16089.7 14628.0 14713.4 14878.3 14882.9 14901.9 687.2 826.0 835.8 836.8 839.1 700.2 704.1 705.4 707.0 707.3 879.3 899.3 899.5 909.2 910.5 901.1 903.4 904.4 907.0 907.7 532.3 671.2 672.7 674.1 675.5 12392.8 14679.3 15228.2 15266.9 15343.6 14300.9 14552.0 14585.3 14746.8 14818.9 11059.6 11559.4 11645.0 11871.6 12190.7 3789.3 3877.5 3901.5 4008.1 4013.7 115941.0 116640.4 117503.0 118040.4 122474.4 10861.8 11113.0 11221.4 11227.4 11411.4 22740.9 22986.7 23006.3 23006.9 23413.9 7680.4 7796.8 7996.4 8197.7 8328.2 4448.2 4490.4 4662.0 4723.0 4810.7 3539.2 3622.2 3624.7 3660.1 3661.4 655.5 658.1 659.2 669.6 673.4 592.7 664.7 667.2 681.3 701.1 9345.6 9568.2 9655.3 9688.7 9690.1 578.6 627.0 646.0 654.1 662.5 4652.4 4673.1 4679.4 4681.3 4681.9 93743.0 93998.5 96642.6 146125.3 161484.0 112123.0 143513.0 146696.0 148131.0 148168.0 72452.0 76676.6 77222.5 77395.6 121782.0 7493.0 8977.9 8980.1 8982.5 8992.8 53480.7 64853.4 65532.0 65843.7 67452.7 91167.5 98375.5 99908.5 101868.5 108019.0 11884.6 12064.2 12099.0 12115.5 12387.3 12896.4 12986.4 13127.1 13155.8 13211.5 11998.9 13208.9 13805.9 14048.9 15122.8 13348.4 14133.9 14329.1 14406.9 14416.2 13340.5 13535.7 13840.0 14507.1 14633.6 11307.4 11419.9 11769.3 12048.4 12114.2 11278.7 11566.0 11712.6 11886.1 11916.3 15:47:08 INFO - PROCESS | 1648 | -------- Summary: end -------- 15:47:08 INFO - PROCESS | 1648 | 15:47:08 INFO - TEST-INFO | 1648: exit 0 15:47:08 INFO - TEST-OK | dromaeo_css | took 1117587ms 15:47:08 INFO - TEST-START | kraken 15:47:08 INFO - operating with platform_type : mac_ 15:47:08 INFO - Initialising browser for kraken test... 15:47:09 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/tmpCvGG8N/profile http://localhost:49277/getInfo.html) 15:47:11 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 15:47:11 INFO - PROCESS | 1658 | colorDepth:24 15:47:11 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 15:47:11 INFO - PROCESS | 1658 | __metrics 15:47:11 INFO - PROCESS | 1658 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:47:11 INFO - PROCESS | 1658 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:47:12 INFO - TEST-INFO | 1658: exit 0 15:47:12 INFO - Browser initialized. 15:47:12 INFO - Running cycle 1/1 for kraken test... 15:47:12 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/tmpCvGG8N/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:47:24 INFO - PROCESS | 1659 | RSS: Main: 220499968 15:47:24 INFO - PROCESS | 1659 | 15:47:26 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection) 15:47:27 INFO - PROCESS | 1659 | RSS: Main: 270098432 15:47:27 INFO - PROCESS | 1659 | 15:47:30 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-dft) 15:47:31 INFO - PROCESS | 1659 | RSS: Main: 280539136 15:47:31 INFO - PROCESS | 1659 | 15:47:34 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-fft) 15:47:34 INFO - PROCESS | 1659 | RSS: Main: 377204736 15:47:34 INFO - PROCESS | 1659 | 15:47:37 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator) 15:47:37 INFO - PROCESS | 1659 | RSS: Main: 280920064 15:47:37 INFO - PROCESS | 1659 | 15:47:39 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:47:40 INFO - PROCESS | 1659 | RSS: Main: 281448448 15:47:40 INFO - PROCESS | 1659 | 15:47:42 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom) 15:47:43 INFO - PROCESS | 1659 | RSS: Main: 318369792 15:47:43 INFO - PROCESS | 1659 | 15:47:46 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate) 15:47:46 INFO - PROCESS | 1659 | RSS: Main: 319848448 15:47:46 INFO - PROCESS | 1659 | 15:47:49 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial) 15:47:50 INFO - PROCESS | 1659 | RSS: Main: 318574592 15:47:50 INFO - PROCESS | 1659 | 15:47:51 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:47:52 INFO - PROCESS | 1659 | RSS: Main: 291663872 15:47:52 INFO - PROCESS | 1659 | 15:47:54 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:47:55 INFO - PROCESS | 1659 | RSS: Main: 298061824 15:47:55 INFO - PROCESS | 1659 | 15:47:57 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:47:57 INFO - PROCESS | 1659 | RSS: Main: 300425216 15:47:57 INFO - PROCESS | 1659 | 15:48:00 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:48:01 INFO - PROCESS | 1659 | RSS: Main: 310792192 15:48:01 INFO - PROCESS | 1659 | 15:48:04 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:48:05 INFO - PROCESS | 1659 | RSS: Main: 310370304 15:48:05 INFO - PROCESS | 1659 | 15:48:06 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49277/tests/kraken/driver.html?testName=ai-astar) 15:48:07 INFO - PROCESS | 1659 | RSS: Main: 354816000 15:48:07 INFO - PROCESS | 1659 | 15:48:07 INFO - PROCESS | 1659 | __start_tp_report 15:48:07 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 15:48:07 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 15:48:07 INFO - PROCESS | 1659 | |i|pagename|runs| 15:48:07 INFO - PROCESS | 1659 | |0;ai-astar;113;114;112;114;115;114;114;114;111;116 15:48:07 INFO - PROCESS | 1659 | |1;audio-beat-detection;143;111;112;144;137;139;108;108;140;108 15:48:07 INFO - PROCESS | 1659 | |2;audio-dft;184;183;180;187;184;184;184;184;185;183 15:48:07 INFO - PROCESS | 1659 | |3;audio-fft;81;59;59;90;80;85;49;72;126;81 15:48:07 INFO - PROCESS | 1659 | |4;audio-oscillator;87;69;94;69;67;69;91;67;69;90 15:48:07 INFO - PROCESS | 1659 | |5;imaging-gaussian-blur;94;84;86;84;86;83;87;83;86;83 15:48:07 INFO - PROCESS | 1659 | |6;imaging-darkroom;92;94;93;92;93;93;93;94;93;93 15:48:07 INFO - PROCESS | 1659 | |7;imaging-desaturate;84;85;85;84;86;84;83;84;84;85 15:48:07 INFO - PROCESS | 1659 | |8;json-parse-financial;55;51;51;51;55;56;55;55;56;56 15:48:07 INFO - PROCESS | 1659 | |9;json-stringify-tinderbox;75;74;75;72;73;71;70;70;71;71 15:48:07 INFO - PROCESS | 1659 | |10;stanford-crypto-aes;83;86;81;85;85;83;80;89;102;80 15:48:07 INFO - PROCESS | 1659 | |11;stanford-crypto-ccm;139;137;137;139;137;142;140;156;254;131 15:48:07 INFO - PROCESS | 1659 | |12;stanford-crypto-pbkdf2;164;164;165;165;162;164;164;163;164;164 15:48:07 INFO - PROCESS | 1659 | |13;stanford-crypto-sha256-iterative;66;66;67;66;66;66;67;66;65;67 15:48:07 INFO - PROCESS | 1659 | __end_tp_report 15:48:07 INFO - PROCESS | 1659 | __start_cc_report 15:48:07 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,2089 15:48:07 INFO - PROCESS | 1659 | __end_cc_report 15:48:07 INFO - PROCESS | 1659 | __startTimestamp1478821687010__endTimestamp 15:48:07 INFO - PROCESS | 1659 | 15:48:07 INFO - PROCESS | 1659 | ------- Summary: start ------- 15:48:07 INFO - PROCESS | 1659 | Number of tests: 14 15:48:07 INFO - PROCESS | 1659 | 15:48:07 INFO - PROCESS | 1659 | [#0] ai-astar Cycles:10 Average:113.70 Median:114.00 stddev:1.42 (1.2%) stddev-sans-first:1.48 15:48:07 INFO - PROCESS | 1659 | Values: 113.0 114.0 112.0 114.0 115.0 114.0 114.0 114.0 111.0 116.0 15:48:07 INFO - PROCESS | 1659 | 15:48:07 INFO - PROCESS | 1659 | [#1] audio-beat-detection Cycles:10 Average:125.00 Median:138.00 stddev:16.61 (12.0%) stddev-sans-first:16.29 15:48:07 INFO - PROCESS | 1659 | Values: 143.0 111.0 112.0 144.0 137.0 139.0 108.0 108.0 140.0 108.0 15:48:07 INFO - PROCESS | 1659 | 15:48:07 INFO - PROCESS | 1659 | [#2] audio-dft Cycles:10 Average:183.80 Median:184.00 stddev:1.75 (1.0%) stddev-sans-first:1.86 15:48:07 INFO - PROCESS | 1659 | Values: 184.0 183.0 180.0 187.0 184.0 184.0 184.0 184.0 185.0 183.0 15:48:07 INFO - PROCESS | 1659 | 15:48:07 INFO - PROCESS | 1659 | [#3] audio-fft Cycles:10 Average:78.20 Median:80.50 stddev:21.39 (26.6%) stddev-sans-first:22.66 15:48:07 INFO - PROCESS | 1659 | Values: 81.0 59.0 59.0 90.0 80.0 85.0 49.0 72.0 126.0 81.0 15:48:07 INFO - PROCESS | 1659 | 15:48:07 INFO - PROCESS | 1659 | [#4] audio-oscillator Cycles:10 Average:77.20 Median:78.00 stddev:11.59 (14.9%) stddev-sans-first:11.74 15:48:07 INFO - PROCESS | 1659 | Values: 87.0 69.0 94.0 69.0 67.0 69.0 91.0 67.0 69.0 90.0 15:48:07 INFO - PROCESS | 1659 | 15:48:07 INFO - PROCESS | 1659 | [#5] imaging-gaussian-blur Cycles:10 Average:85.60 Median:86.00 stddev:3.31 (3.8%) stddev-sans-first:1.58 15:48:07 INFO - PROCESS | 1659 | Values: 94.0 84.0 86.0 84.0 86.0 83.0 87.0 83.0 86.0 83.0 15:48:07 INFO - PROCESS | 1659 | 15:48:07 INFO - PROCESS | 1659 | [#6] imaging-darkroom Cycles:10 Average:93.00 Median:93.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 15:48:07 INFO - PROCESS | 1659 | Values: 92.0 94.0 93.0 92.0 93.0 93.0 93.0 94.0 93.0 93.0 15:48:07 INFO - PROCESS | 1659 | 15:48:07 INFO - PROCESS | 1659 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.50 stddev:0.84 (1.0%) stddev-sans-first:0.88 15:48:07 INFO - PROCESS | 1659 | Values: 84.0 85.0 85.0 84.0 86.0 84.0 83.0 84.0 84.0 85.0 15:48:07 INFO - PROCESS | 1659 | 15:48:07 INFO - PROCESS | 1659 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:55.00 stddev:2.18 (4.0%) stddev-sans-first:2.29 15:48:07 INFO - PROCESS | 1659 | Values: 55.0 51.0 51.0 51.0 55.0 56.0 55.0 55.0 56.0 56.0 15:48:07 INFO - PROCESS | 1659 | 15:48:07 INFO - PROCESS | 1659 | [#9] json-stringify-tinderbox Cycles:10 Average:72.20 Median:72.50 stddev:1.93 (2.7%) stddev-sans-first:1.76 15:48:07 INFO - PROCESS | 1659 | Values: 75.0 74.0 75.0 72.0 73.0 71.0 70.0 70.0 71.0 71.0 15:48:07 INFO - PROCESS | 1659 | 15:48:07 INFO - PROCESS | 1659 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:84.00 stddev:6.48 (7.7%) stddev-sans-first:6.82 15:48:07 INFO - PROCESS | 1659 | Values: 83.0 86.0 81.0 85.0 85.0 83.0 80.0 89.0 102.0 80.0 15:48:07 INFO - PROCESS | 1659 | 15:48:07 INFO - PROCESS | 1659 | [#11] stanford-crypto-ccm Cycles:10 Average:151.20 Median:139.50 stddev:36.68 (26.3%) stddev-sans-first:38.64 15:48:07 INFO - PROCESS | 1659 | Values: 139.0 137.0 137.0 139.0 137.0 142.0 140.0 156.0 254.0 131.0 15:48:07 INFO - PROCESS | 1659 | 15:48:07 INFO - PROCESS | 1659 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.90 Median:164.00 stddev:0.88 (0.5%) stddev-sans-first:0.93 15:48:07 INFO - PROCESS | 1659 | Values: 164.0 164.0 165.0 165.0 162.0 164.0 164.0 163.0 164.0 164.0 15:48:07 INFO - PROCESS | 1659 | 15:48:07 INFO - PROCESS | 1659 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 15:48:07 INFO - PROCESS | 1659 | Values: 66.0 66.0 67.0 66.0 66.0 66.0 67.0 66.0 65.0 67.0 15:48:07 INFO - PROCESS | 1659 | -------- Summary: end -------- 15:48:07 INFO - PROCESS | 1659 | 15:48:07 INFO - TEST-INFO | 1659: exit 0 15:48:07 INFO - TEST-OK | kraken | took 58852ms 15:48:07 INFO - SUITE-END | took 1176s 15:48:08 INFO - Completed test suite (00:19:36) 15:48:08 INFO - javascript benchmark 15:48:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2829.872655730492, 3327.7670563060587, 3377.5271461995308, 3385.424477838767, 3430.965690343096, 5620.128880023598, 5637.098064309711, 5732.312122545301, 5736.569757268206, 5755.683437410946, 5703.914441283384, 5791.21818554495, 5795.797147099853, 5805.593608447411, 5819.185314056035, 5215.452377500345, 5232.4767523247565, 5232.529072383475, 5268.236105764662, 5288.92066619001, 5136.357955255593, 5154.433012368655, 5171.715555644438, 5327.174287985368, 5329.307190065286, 5162.638615296931, 5176.767045482962, 5216.426193118773, 5270.209468579706, 5298.682079075248, 5132.743362831843, 5216.8695782605355, 5217.3999990000875, 5238.109521381336, 5238.68567885928, 4324.35134729793, 5124.538791508782, 5151.072806894757, 5172.767225474862, 5232.790688372461, 5584.274044374246, 5591.0, 5599.216109744639, 5643.379228284885, 5649.4633009864, 6149.723262453201, 6172.4136207060255, 6189.783357582508, 6197.969010154966, 6213.658248796314, 6269.498440124779, 6312.368763123651, 6324.3359447257835, 6330.0, 6338.524610654219, 5643.097104463266, 5670.291213598301, 5743.569232307594, 5768.798092066758, 5818.0, 6249.875042485486, 6251.4061164189325, 6271.3415091414745, 6282.308946015934, 6302.306746257908, 6183.628982261079, 6194.845128871724, 6203.410675985774, 6207.410296021871, 6207.96896015517, 6110.194261626863, 6161.075838624152, 6178.536609754196, 6212.689365531705, 6220.813375598739, 6066.393360663987, 6251.9687401562705, 6254.15568898202, 6261.060840873905, 6267.185265915402, 6212.0371342441995, 6236.532260080512, 6280.466160376419, 6285.497160227171, 6295.213098362705, 4851.417829860368, 4886.877828054327, 4890.217565189624, 4957.454679985199, 4981.12830254704, 4382.715123516961, 4420.049689316812, 4426.291793313055, 4456.197884380777, 4499.505054444008, 5737.08206686928, 5745.0, 5749.8275051748515, 5760.135979603093, 5761.711914404347, 6121.0, 6289.088082228142, 6293.087502312231, 6304.0, 6324.3043265240785, 5686.3744988051285, 5707.1724599933605, 5776.653400795965, 5784.987627165229, 5795.652260864362, 5397.78408863641, 5452.26394436746, 5468.070428027245, 5500.697461639568, 5502.862428439321, 6311.589746666452, 6319.968400158154, 6332.1135041094285, 6335.968320158369, 6341.524385671001, 6137.346341658419, 6245.594036387621, 6280.166767118704, 6293.992961126198, 6330.430261276507, 6215.564910456224, 6264.624122552661, 6272.905906411316, 6273.62358258506, 6561.081448597105, 6213.844653883689, 6251.281102673251, 6263.843403914939, 6278.058291256348, 6283.528735344776, 6155.4767844731905, 6265.8746825062335, 6308.053791931247, 6320.494360451245, 6325.873482530232, 5933.110033495011, 6057.757689692363, 6066.363031881765, 6145.324014358328, 6211.130441738251, 5306.602004849575, 6109.389061093855, 6213.37866213375, 6217.875642487034, 6230.43926046658, 5007.349044624176, 6017.277926648655, 6080.0, 6091.725872335667, 6092.268927728701, 5961.910571341346, 5984.251968503937, 6083.6045657032155, 6128.846778830565, 6135.07955838608, 6058.757649694139, 6067.848303792441, 6100.267967843887, 6107.4197951194565, 6140.20177376956], "value": 5705.358509474878, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [465.91147681940436, 530.2311648110241, 534.7005676820978, 538.3378444513249, 548.4159370270659, 30011.0, 40179.59820401795, 40749.79625101878, 41028.38457423137, 41096.0, 42336.0, 43371.56628433715, 43686.56313436873, 43816.78091609546, 43865.0, 9786.972367901357, 9957.253206009542, 9972.002799720007, 9983.75040623983, 9983.800323993515, 9847.015298470167, 9959.950200249024, 9969.900300997006, 9972.551235194434, 9978.60085596579, 8974.967878693968, 9515.524223788818, 9934.850977235312, 9994.250431217652, 10001.0499002595, 9892.85160722586, 9961.302708810386, 9961.551730172087, 9964.95017524915, 9975.002499750004, 9817.214622830157, 9902.603895844157, 9910.20718342538, 9917.65288214909, 9920.45437500937, 40446.79776601098, 40760.388594170814, 40817.387739183934, 40915.0, 40927.0, 3465.982670086659, 3941.684665226775, 3978.622030907059, 3983.1237127831832, 4023.456833327522, 30928.8453557733, 31253.593588288582, 32002.519962200586, 32988.50517242243, 33029.17427064318, 3122.9063128106195, 3193.8403079845916, 3206.1022913584234, 3256.6417694053634, 3293.1931676739114, 501116.0, 521950.0, 523781.0, 524029.0, 524319.0, 33368.833155834065, 64218.0, 64888.02667959985, 64967.35032649613, 65052.67473662602, 33985.32029359399, 35257.0, 35496.645033549335, 35568.64431355705, 35635.465468018, 15153.62115947088, 15194.924025380024, 15251.923740381228, 15256.38974441032, 15259.313330900137, 12931.870681293067, 13001.609951701465, 13008.089433739548, 13017.153884997444, 13062.608121756362, 7749.845003100019, 7770.572618506037, 7772.8056798579355, 7841.137474877759, 7848.13670496245, 3190.1865024418626, 3241.9675803241666, 3248.561444205049, 3254.08885512057, 3294.7199488043784, 918.8346097702344, 984.9556769945369, 1024.7643042100358, 1059.6397224943555, 1127.689885281554, 26035.739642603712, 30179.698203018128, 30438.84780576083, 30988.0, 31162.68837311643, 1091.8635170603675, 1106.9723256918642, 1134.631244845412, 1151.5566506894738, 1169.8362229287907, 15159.393624254906, 15501.534953951399, 15790.052596844225, 15814.76277855833, 16210.67578648444, 670557.0, 673513.0, 674649.0, 679615.0, 680591.0, 58650.0, 59020.0, 59138.0, 59185.11222331668, 59193.11210331848, 1209.9032077433785, 1238.207547169812, 1308.3131356037966, 1355.5052405871588, 1358.9728205435836, 30569.23576910595, 30990.69009309968, 31636.0, 31669.524957125202, 32488.350232994733, 49599.00801983868, 50089.74775630638, 50216.49783502118, 50294.49705502898, 50378.740531487005, 508832.0, 509811.0, 513002.43498782266, 513186.0, 818271.0, 23426.18008369699, 23683.64474532918, 23699.17052903209, 23741.169059082848, 26170.476590467704, 45798.25289537173, 46375.76812115918, 46739.0, 47957.52042479531, 48508.5149148504, 38576.614233858425, 39427.0, 39485.210295794495, 39559.80220098881, 41126.79436602798, 38658.6134138655, 39451.0, 40256.0, 40494.0, 40968.79515602522, 37566.248675026894, 38068.0, 38233.80883095567, 38348.42477362786, 38524.6147538521, 31927.840360798047, 34731.82634086813, 35555.0, 35576.822115889256, 35688.0, 22732.545349093256, 23077.76922230756, 25137.120200792884, 26000.47999039971, 26691.33271668224], "value": 18995.985325369675, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.5097990263388, 372.9687414299461, 377.9357509223432, 384.6711062041954, 403.2660557784831, 11806.114541409397, 15381.769273460894, 16226.269817858196, 20892.05985730642, 21370.0, 20252.0, 20869.91300869912, 21316.4670883228, 21498.89250553745, 21767.782322176772, 5760.193572899798, 5786.276715410574, 5994.250718660168, 6026.939730602704, 6051.788187413442, 6031.909521357183, 6171.876562468748, 6180.1965744453155, 6186.969065154668, 6200.751969921198, 3874.651281384675, 4105.774182419966, 5835.533157347402, 6132.325444201134, 6178.536609754264, 5927.73325200367, 6205.31741508436, 6207.162033125515, 6215.09881067245, 6245.3442388549, 5945.881082378328, 5997.250343707036, 6001.969990150022, 6013.669248191348, 6019.789307374264, 13295.73408531824, 13313.334333283297, 13403.731925361535, 13510.527131550349, 13540.322983850867, 2320.280712978982, 2474.9133780317784, 2524.394145405108, 2723.774301564284, 2785.0183159311264, 9950.054744799305, 10167.389956602554, 10190.643327483576, 10564.524596393105, 10665.413402262873, 1845.723141528768, 1901.6386886491523, 1928.3732786844332, 1940.1075505267595, 1991.3926252492984, 115971.0, 117360.0, 124518.0, 126835.0, 129515.0, 9578.66474673397, 11143.554257829595, 11374.260673056226, 11477.368744718953, 11627.244229125079, 14504.637384065272, 14510.1293922365, 14510.492132775302, 14519.0, 14523.927380363031, 7831.569263690438, 8079.434439589172, 8455.492670439793, 8798.648054077765, 8823.867641985375, 8717.215450609476, 8729.996050454152, 8740.125987401208, 8886.555672216493, 8902.510361930026, 4472.172648060119, 4515.367848501212, 4539.818407263739, 4597.080583883237, 4633.6524760642415, 1751.702210624197, 1898.3071179019557, 1926.5280006398523, 1927.6988033077616, 1947.7175809507826, 760.4638729695552, 787.9330256928225, 861.6294993153004, 890.9777255568533, 977.2914636888199, 21019.0, 21898.343049708536, 21939.451513711967, 21960.780392195873, 22051.33845984623, 924.1728652855791, 926.4904302633524, 967.8354679704468, 1005.8893521712606, 1055.889131641182, 9451.858222126673, 10067.74153230846, 10683.465826708634, 10890.40102794338, 11293.0, 521820.0, 597229.013854928, 603133.0, 614710.0, 615305.0, 113421.0, 128794.0, 129014.0, 133809.0, 140239.0, 980.5832521178471, 1004.4124187350482, 1016.4765145949842, 1017.2624846985876, 1018.3024628129755, 18228.45314640563, 19597.0, 20121.0, 20121.295754648516, 20167.394978150678, 54888.0, 58321.708391457774, 59144.0, 59285.70357148186, 60519.78960420679, 79185.0, 83716.0, 84781.57609212161, 88864.5556772212, 93625.4243134728, 8017.759467215759, 8035.83928321442, 8115.634796434293, 8373.74878753614, 8427.494350338999, 12071.766723156245, 13128.803067953797, 13151.53969611059, 13654.317284135555, 13659.248741319323, 9898.812142542942, 11180.440977950908, 11500.654980350602, 11593.130515211224, 11695.660867826298, 11204.93553112453, 11365.261258018532, 11411.315321080761, 11736.413179341169, 11757.823632645688, 5851.414858514285, 8913.707512410794, 9311.0, 11319.547218111184, 11725.003374713246, 8178.223068808454, 8326.250637442417, 8355.95822020886, 8420.4947703138, 8434.283085937765, 9553.570089345858, 9705.854412183682, 10626.574937002433, 11351.943240284076, 11762.764744704888], "value": 9464.586017144477, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1491.6270932266934, 1533.5322726568397, 1699.3797263998636, 1842.309134074722, 1870.2145099058393, 8608.655653773842, 9178.449293042422, 9191.54042297885, 9196.63213471462, 9197.264218862492, 7856.685732570691, 8123.593820308991, 8164.550949697779, 8672.13278672134, 8877.822443551126, 2407.2657839358944, 2437.4150203951103, 2441.2554170977846, 2445.7065152181763, 2445.8899349529315, 2410.2648692148887, 2419.5644783938974, 2439.42673471734, 2442.9144979925704, 2445.0097710427217, 2418.697662792151, 2430.222328854767, 2440.792532634728, 2443.3525115844313, 2450.068973789966, 2399.5800734871327, 2409.5542324669905, 2416.6254230594286, 2421.2494126820566, 2423.842450240729, 2076.532780124475, 2396.35298469414, 2413.2880800163816, 2415.7946574541184, 2419.9153029644053, 8997.145271199226, 9029.142231487998, 9118.908810911938, 9122.635094596208, 9156.313276504223, 4548.431446069241, 5498.505134537871, 5514.228008078872, 5515.338159420855, 5522.199281104217, 3444.50054742061, 3515.701165400944, 3627.2382799612114, 3680.1535646801117, 3716.6655001050035, 1015.7917626886544, 1076.3595660582018, 1101.1796211822243, 1123.528118190362, 1127.774445110973, 12109.636710898687, 12129.454174562166, 12147.08896832741, 12182.878171218263, 12191.146619736623, 4724.718632354467, 4771.809127634856, 4775.140474714584, 4884.3161957326, 4892.902141957141, 10165.085142337226, 10171.440570768531, 10181.592736290466, 10183.287169898183, 10189.74525636865, 5423.457654234624, 5424.593155513352, 5425.13197888336, 5430.647007944471, 5433.728313584305, 4413.360062790877, 4566.086782643418, 4582.289745089516, 4938.333325001151, 4940.382452193476, 3967.107400834847, 3997.7601343918877, 4077.408775727503, 4097.078157414558, 4114.321137012419, 1115.6708770912437, 1284.5825106840314, 1290.4967062845499, 1296.714722760991, 1299.1036185032297, 877.2718643525858, 883.1654086887958, 886.2732559301311, 894.8299823033602, 913.6254135804288, 5710.71446427677, 5871.588988770831, 5878.647281163144, 6085.878282434415, 6184.752609895554, 450.34025153150793, 454.1484716157205, 460.34400978605356, 994.1003391930315, 1010.2877471382805, 3676.860173346271, 3699.8335074921692, 3997.360422332471, 3998.6001399859783, 4177.310743727312, 10857.83713244286, 11063.502142403611, 11168.832467512993, 11177.385243811668, 11207.327560346404, 10740.409277489656, 11057.391843448688, 11195.72010699739, 11210.439478026066, 11213.775724485464, 8296.668133274723, 8305.169483051768, 8409.95795021021, 8428.915710842935, 8483.151684831591, 5889.028310328919, 5972.25346831646, 6064.3935606439, 6071.392860713893, 6147.047207682816, 8141.9185808141165, 9796.608135674493, 9928.453935033642, 10150.695479135638, 10239.027292407209, 9862.309638325536, 10343.896561034293, 10519.842202366817, 10671.35971841692, 10704.785904282027, 7188.101487314086, 7446.218147094477, 7731.420143489148, 7832.451728378959, 7963.283304502623, 8704.521251330983, 8776.517291549026, 8808.735737927873, 8812.471251724917, 8855.512946787989, 7554.962225188839, 7811.4922530035365, 7821.530708157528, 7840.960795195988, 7960.044794624682, 7549.1695913448375, 7626.161122276656, 7645.388368930583, 7716.8456630868195, 7798.454108212598, 7179.138503379628, 7219.241979592067, 7306.196318405077, 7309.744158954411, 7316.634168291671, 4529.297958816389, 4980.252962055721, 5055.216441451581, 5207.140821764367, 5341.172118321666, 4869.9026019480125, 5072.1123803335, 5196.506331898464, 5350.946490535201, 5389.0], "value": 4642.818781625443, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.52683496657795, 304.50365903577165, 307.5202683813251, 310.8601129491728, 312.7966821565983, 5397.51422371987, 5402.37872644646, 5433.1578605316145, 5445.48267914548, 5446.291982042334, 5347.46525347466, 5349.732513374335, 5365.570754339653, 5374.543163831079, 5379.359295414897, 3818.3890577507605, 3930.272899513585, 3972.2849887020325, 4002.8198731057173, 4070.7991142613, 3750.7374483786148, 4059.451973983504, 4089.897752556195, 4104.363823607346, 4109.753414795122, 3887.4168874668744, 4024.476818013669, 4029.697772667047, 4078.2659121358142, 4111.979440102796, 3798.240351929625, 3972.741771784825, 4069.7151199416203, 4075.982388717604, 4099.975006248438, 3459.221675123102, 3460.377132116218, 3467.8959631211105, 3469.2194256292387, 3497.8600855965733, 5118.309028281209, 5143.0, 5162.535371816554, 5177.352830896138, 5238.764255608468, 4389.934150987738, 4590.862274131781, 4596.080783843211, 4605.700629459075, 4621.884452888671, 5479.753301146511, 5525.060739674265, 5540.229885057472, 5568.832935011957, 5583.637063590853, 3374.561307030095, 3766.7551609145316, 3807.447920051577, 3823.2926908522013, 3841.5966323536186, 5636.408177141423, 5895.35151133375, 5924.971019706598, 5977.0, 5977.625146216351, 3537.920934115068, 3627.474016267626, 3827.6794505895423, 3847.634474724897, 3889.144388234584, 3378.7634865559176, 3653.5203242686753, 3783.45139954705, 3876.379779235309, 3925.2345792570177, 4541.704789188692, 4574.947762014755, 4575.771211439414, 4585.564371384713, 4593.104344652761, 4948.901021979612, 5363.356397232279, 5456.645318054314, 5596.656802367484, 5692.203091567184, 1108.634150730257, 1259.9101776962862, 1342.8052932324758, 1343.2075075705382, 1345.5088892554147, 769.3575864153382, 800.8358286551243, 819.2749416766205, 821.8124809649998, 824.6330382979517, 4668.393108895822, 4978.551930326288, 5107.361579802525, 5108.540231379194, 5116.850922612512, 4911.0, 5803.47768700819, 5843.298804143445, 5847.795327163614, 5894.823155305347, 4880.926786098212, 5270.894582108336, 5284.260203571503, 5305.257263983045, 5329.520343169133, 2998.835064071497, 3024.7882648214413, 3045.1473587395567, 3051.4965030769677, 3052.252198211408, 5304.045271851027, 5313.601479889024, 5373.462653734595, 5516.9448305516435, 5812.738426770806, 5514.558835293167, 5897.7935772247765, 5900.409959004065, 5993.610415323077, 6024.433647251746, 4615.815367385267, 5194.376674798973, 5330.653507521999, 5886.352501224947, 5914.822555323347, 5370.275012873212, 5728.966216993074, 5775.884482310246, 5792.247007888947, 5828.0184737187865, 4965.950340496549, 5344.888768936326, 5683.744231509675, 5729.255196824386, 5788.82633520995, 6012.969935150471, 6023.759049638141, 6027.432867454581, 6103.3591472894705, 6144.754209831735, 3200.4079245339685, 3265.37957788029, 3848.730588858753, 3872.2449122421986, 3925.4504369387737, 5459.607800010972, 5797.246357973437, 5804.5356371491025, 5825.3592104867585, 5831.883362332815, 5281.260623512634, 5564.805231816867, 5675.899917030725, 5732.455416735404, 5742.942570574241, 5307.4692530746615, 5542.307211598551, 5668.971655141698, 5672.319321681424, 5781.8554536136935, 4953.72754498506, 5516.0, 5533.363663178786, 5583.581231407742, 5594.244776955059, 4735.195016847213, 4797.592204662643, 5462.453754624506, 5569.886022795376, 5601.075822489406, 5519.847259568691, 5527.8894422110525, 5528.474794894479, 5538.6399884007415, 5561.304836895388], "value": 4107.580683200623, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [713.5005496152693, 742.4283301857573, 792.8691765858633, 800.3324001068429, 803.4094940218936, 13072.542461013867, 14785.408583656654, 15590.0, 16087.51737447877, 16089.678206435865, 14628.0, 14713.411463541446, 14878.25608719565, 14882.925585372084, 14901.850981490208, 687.2371667449128, 826.0005393473889, 835.8370117827026, 836.8284501677172, 839.1063517353998, 700.2052670219313, 704.1303989572873, 705.4145059600519, 707.0419581467115, 707.27857585263, 879.2965627498008, 899.3165194452198, 899.4783025845027, 909.2316992141663, 910.4901255297021, 901.0944001278739, 903.4353529044347, 904.3940559824933, 906.9954650226707, 907.7276816954887, 532.3053415293041, 671.1576970901536, 672.6737532296833, 674.1404708996021, 675.4663815585682, 12392.81410778839, 14679.266036698122, 15228.162451065187, 15266.923665381602, 15343.616409589738, 14300.85699143016, 14552.0, 14585.343659535347, 14746.778798318033, 14818.851811481854, 11059.612913548068, 11559.43947567076, 11645.010174135208, 11871.643850684493, 12190.695232619168, 3789.3368660484307, 3877.495925529663, 3901.49280593521, 4008.1382502762044, 4013.6989725770686, 115941.0, 116640.41679791547, 117503.0, 118040.40979795132, 122474.38762806218, 10861.83707244392, 11113.0, 11221.438928053565, 11227.438628068563, 11411.372374519315, 22740.886295568416, 22986.655200172012, 23006.309810705705, 23006.884965575064, 23413.882930585238, 7680.385569154454, 7796.766097017098, 7996.440249182501, 8197.71308004217, 8328.167183281623, 4448.154850578379, 4490.39379683745, 4661.953380466152, 4722.9763851181215, 4810.6632535722865, 3539.150603855056, 3622.168626768474, 3624.7281453891064, 3660.084978755311, 3661.395869681526, 655.5116438253532, 658.1312667279145, 659.172738213539, 669.6116252573496, 673.4208580620663, 592.6769910398843, 664.727461740684, 667.2177021819026, 681.271039987209, 701.1025886864821, 9345.579448924815, 9568.234541236685, 9655.324127311022, 9688.70933871985, 9690.12788849007, 578.6210032428766, 626.9749210031639, 645.9741610335628, 654.1365397675023, 662.453475882399, 4652.441706995114, 4673.112108699336, 4679.3916790816975, 4681.344611754357, 4681.859544213679, 93743.0, 93998.53000734953, 96642.55036174462, 146125.26937365244, 161484.0, 112123.0, 143513.0, 146696.0, 148131.0, 148168.0, 72452.0, 76676.61661691655, 77222.45555088867, 77395.61302193454, 121782.0, 7492.9625351875075, 8977.910220897707, 8980.101989800967, 8982.505962172143, 8992.82014359696, 53480.73259633677, 64853.37866553374, 65532.0170197457, 65843.67078164578, 67452.662736686, 91167.54416227876, 98375.50812245892, 99908.50045749724, 101868.4906575492, 108019.0, 11884.643460696192, 12064.155509114278, 12099.0, 12115.515379385079, 12387.256764594153, 12896.355182240663, 12986.415611297325, 13127.081104322606, 13155.802662960255, 13211.471541138631, 11998.940005299917, 13208.933955330162, 13805.861941380457, 14048.929755351157, 15122.773158402413, 13348.399322030726, 14133.858661413255, 14329.140251584939, 14406.85593144097, 14416.207108609127, 13340.466381344637, 13535.729285414434, 13840.0, 14507.057041292705, 14633.634159146106, 11307.378094204898, 11419.942900285445, 11769.293842369485, 12048.397580120783, 12114.15200935926, 11278.661640150809, 11566.016888564567, 11712.648620541397, 11886.108541859223, 11916.285022898654], "value": 7774.304968076275, "unit": "score"}], "name": "dromaeo_css", "value": 7306.115304650662, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 112.0, 114.0, 115.0, 114.0, 114.0, 114.0, 111.0, 116.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 111.0, 112.0, 144.0, 137.0, 139.0, 108.0, 108.0, 140.0, 108.0], "value": 125.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 183.0, 180.0, 187.0, 184.0, 184.0, 184.0, 184.0, 185.0, 183.0], "value": 183.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 59.0, 90.0, 80.0, 85.0, 49.0, 72.0, 126.0, 81.0], "value": 78.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 69.0, 94.0, 69.0, 67.0, 69.0, 91.0, 67.0, 69.0, 90.0], "value": 77.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 84.0, 86.0, 84.0, 86.0, 83.0, 87.0, 83.0, 86.0, 83.0], "value": 85.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 94.0, 93.0, 92.0, 93.0, 93.0, 93.0, 94.0, 93.0, 93.0], "value": 93.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 85.0, 84.0, 86.0, 84.0, 83.0, 84.0, 84.0, 85.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 51.0, 51.0, 51.0, 55.0, 56.0, 55.0, 55.0, 56.0, 56.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 72.0, 73.0, 71.0, 70.0, 70.0, 71.0, 71.0], "value": 72.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 86.0, 81.0, 85.0, 85.0, 83.0, 80.0, 89.0, 102.0, 80.0], "value": 85.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 137.0, 137.0, 139.0, 137.0, 142.0, 140.0, 156.0, 254.0, 131.0], "value": 151.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 165.0, 165.0, 162.0, 164.0, 164.0, 163.0, 164.0, 164.0], "value": 163.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 66.0, 66.0, 66.0, 67.0, 66.0, 65.0, 67.0], "value": 66.2, "unit": "score"}], "name": "kraken", "value": 1433.9000000000003, "alertThreshold": 2.0}]} 15:48:08 INFO - Return code: 0 15:48:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:48:08 INFO - # TBPL SUCCESS # 15:48:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:48:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:48:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:48:08 INFO - 2016-11-10 15:48:08.323 screenresolution[1663:10001] starting screenresolution argv=screenresolution get 15:48:08 INFO - 2016-11-10 15:48:08.325 screenresolution[1663:10001] Display 0: 1600x1200x32@60 15:48:08 INFO - 2016-11-10 15:48:08.331 screenresolution[1664:10004] starting screenresolution argv=screenresolution list 15:48:08 INFO - Available Modes on Display 0 15:48:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:48:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:48:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:48:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:48:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:48:08 INFO - Intel Iris: 15:48:08 INFO - Chipset Model: Intel Iris 15:48:08 INFO - Type: GPU 15:48:08 INFO - Bus: Built-In 15:48:08 INFO - VRAM (Dynamic, Max): 1536 MB 15:48:08 INFO - Vendor: Intel (0x8086) 15:48:08 INFO - Device ID: 0x0a2e 15:48:08 INFO - Revision ID: 0x0009 15:48:08 INFO - Displays: 15:48:08 INFO - Display: 15:48:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:48:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:48:08 INFO - Display Serial Number: 1600x1200 60 15:48:08 INFO - Main Display: Yes 15:48:08 INFO - Mirror: Off 15:48:08 INFO - Online: Yes 15:48:08 INFO - Rotation: Supported 15:48:08 INFO - Return code: 0 15:48:08 INFO - Running post-action listener: _resource_record_post_action 15:48:08 INFO - [mozharness: 2016-11-10 23:48:08.564756Z] Finished run-tests step (success) 15:48:08 INFO - Running post-run listener: _resource_record_post_run 15:48:08 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 42570752; Write bytes: 664532992; Read time: 371; Write time: 1905 15:48:08 INFO - TinderboxPrint: CPU usage
53.4% 15:48:08 INFO - TinderboxPrint: I/O read bytes / time
42,570,752 / 371 15:48:08 INFO - TinderboxPrint: I/O write bytes / time
664,532,992 / 1,905 15:48:08 INFO - TinderboxPrint: CPU idle
2,252.9 (46.6%) 15:48:08 INFO - TinderboxPrint: CPU system
967.5 (20.0%) 15:48:08 INFO - TinderboxPrint: CPU user
1,617.3 (33.4%) 15:48:08 INFO - TinderboxPrint: Swap in / out
406,216,704 / 0 15:48:08 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 358877696; Write bytes: 355956736; Read time: 27516; Write time: 744 15:48:08 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 40592384; Write bytes: 297570304; Read time: 351; Write time: 1125 15:48:09 INFO - Running post-run listener: _upload_blobber_files 15:48:09 INFO - Blob upload gear active. 15:48:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:48:09 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 15:48:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:48:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:48:09 INFO - (blobuploader) - INFO - Open directory for files ... 15:48:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:48:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:48:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:48:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:48:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:48:10 INFO - (blobuploader) - INFO - Done attempting. 15:48:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:48:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:48:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:48:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:48:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:48:11 INFO - (blobuploader) - INFO - Done attempting. 15:48:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:48:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:48:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:48:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:48:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:48:13 INFO - (blobuploader) - INFO - Done attempting. 15:48:13 INFO - (blobuploader) - INFO - Iteration through files over. 15:48:13 INFO - Return code: 0 15:48:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:48:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:48:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d998d65749369d9ecdbd1838f64a24d0217bdb544b6dc0d5b8937cf92ff42dd453733889b8aff2a04bee42340ef4a694ea948a1f4650da8d202ca52ad3f23279", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6b7aadefcb271b28e539689563fb339f7aeee38f9869eb575c3ee26e908d7c404f206088a98b1306ba3f3e48f30277d107ec979da6eb0225bd85b716c93b7937", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dab3d2ae5ab514cc8c3f2e7ec6d1652d8669a3a71d56e06b7ef93c2a4e8c0fe3bf4632b5e778e4042742eb265011325cadcda232785b50fbfa7283f257782f8b"} 15:48:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:48:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:48:13 INFO - Contents: 15:48:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d998d65749369d9ecdbd1838f64a24d0217bdb544b6dc0d5b8937cf92ff42dd453733889b8aff2a04bee42340ef4a694ea948a1f4650da8d202ca52ad3f23279", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6b7aadefcb271b28e539689563fb339f7aeee38f9869eb575c3ee26e908d7c404f206088a98b1306ba3f3e48f30277d107ec979da6eb0225bd85b716c93b7937", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dab3d2ae5ab514cc8c3f2e7ec6d1652d8669a3a71d56e06b7ef93c2a4e8c0fe3bf4632b5e778e4042742eb265011325cadcda232785b50fbfa7283f257782f8b"} 15:48:13 INFO - Running post-run listener: copy_logs_to_upload_dir 15:48:13 INFO - Copying logs to upload dir... 15:48:13 INFO - mkdir: /builds/slave/test/build/upload/logs 15:48:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.832345 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-11-10 15:48:13.573147) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-10 15:48:13.578312) ========= 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.hNMiWHWTGV/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.fEUpP6dGqU/Listeners TMPDIR=/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d998d65749369d9ecdbd1838f64a24d0217bdb544b6dc0d5b8937cf92ff42dd453733889b8aff2a04bee42340ef4a694ea948a1f4650da8d202ca52ad3f23279", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6b7aadefcb271b28e539689563fb339f7aeee38f9869eb575c3ee26e908d7c404f206088a98b1306ba3f3e48f30277d107ec979da6eb0225bd85b716c93b7937", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dab3d2ae5ab514cc8c3f2e7ec6d1652d8669a3a71d56e06b7ef93c2a4e8c0fe3bf4632b5e778e4042742eb265011325cadcda232785b50fbfa7283f257782f8b"} build_url:https://queue.taskcluster.net/v1/task/AoX9P31hQKu8mG-gXEyHPQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011172 build_url: 'https://queue.taskcluster.net/v1/task/AoX9P31hQKu8mG-gXEyHPQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d998d65749369d9ecdbd1838f64a24d0217bdb544b6dc0d5b8937cf92ff42dd453733889b8aff2a04bee42340ef4a694ea948a1f4650da8d202ca52ad3f23279", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6b7aadefcb271b28e539689563fb339f7aeee38f9869eb575c3ee26e908d7c404f206088a98b1306ba3f3e48f30277d107ec979da6eb0225bd85b716c93b7937", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dab3d2ae5ab514cc8c3f2e7ec6d1652d8669a3a71d56e06b7ef93c2a4e8c0fe3bf4632b5e778e4042742eb265011325cadcda232785b50fbfa7283f257782f8b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-10 15:48:13.610968) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 15:48:13.611279) ========= 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.hNMiWHWTGV/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.fEUpP6dGqU/Listeners TMPDIR=/var/folders/21/x9hp61sd3dbffkp44n32rd1c00000w/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.004952 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 15:48:13.659626) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-10 15:48:13.659938) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-10 15:48:13.660237) ========= ========= Total master_lag: 0.17 =========