builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0208 starttime: 1492522607.04 results: success (0) buildid: 20170418051525 builduid: 9860153f86ef4ee181fee8134d41b8b8 revision: d57aa49c39484782cdd91cde6c10c343eb0d557e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-18 06:36:47.042037) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-18 06:36:47.042763) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-18 06:36:47.043044) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-18 06:36:47.887348) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 06:36:47.887727) ========= 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.G0iT8WWeJa/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.U4g41Jq9uQ/Listeners TMPDIR=/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/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 --2017-04-18 06:36:47-- 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% 166M=0s 2017-04-18 06:36:48 (166 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.162578 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 06:36:48.079025) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 06:36:48.079336) ========= 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.G0iT8WWeJa/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.U4g41Jq9uQ/Listeners TMPDIR=/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/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.021157 ========= master_lag: 0.30 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 06:36:48.404202) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-18 06:36:48.404646) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev d57aa49c39484782cdd91cde6c10c343eb0d557e --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-beta --rev d57aa49c39484782cdd91cde6c10c343eb0d557e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.G0iT8WWeJa/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.U4g41Jq9uQ/Listeners TMPDIR=/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/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 2017-04-18 06:36:48,497 truncating revision to first 12 chars 2017-04-18 06:36:48,497 Setting DEBUG logging. 2017-04-18 06:36:48,497 attempt 1/10 2017-04-18 06:36:48,497 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/d57aa49c3948?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-18 06:36:49,581 unpacking tar archive at: mozilla-beta-d57aa49c3948/testing/mozharness/ program finished with exit code 0 elapsedTime=1.361539 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-18 06:36:49.793423) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-18 06:36:49.793911) ========= script_repo_revision: d57aa49c39484782cdd91cde6c10c343eb0d557e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-18 06:36:49.794528) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-18 06:36:49.794898) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-18 06:36:49.840758) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2017-04-18 06:36:49.841076) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.G0iT8WWeJa/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.U4g41Jq9uQ/Listeners TMPDIR=/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/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 06:36:50 INFO - MultiFileLogger online at 20170418 06:36:50 in /builds/slave/test 06:36:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 06:36:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:36:50 INFO - {'append_to_log': False, 06:36:50 INFO - 'base_work_dir': '/builds/slave/test', 06:36:50 INFO - 'blob_upload_branch': 'Mozilla-Beta', 06:36:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:36:50 INFO - 'branch': 'Mozilla-Beta', 06:36:50 INFO - 'buildbot_json_path': 'buildprops.json', 06:36:50 INFO - 'config_files': ('talos/mac_config.py',), 06:36:50 INFO - 'default_actions': ('clobber', 06:36:50 INFO - 'read-buildbot-config', 06:36:50 INFO - 'download-and-extract', 06:36:50 INFO - 'populate-webroot', 06:36:50 INFO - 'create-virtualenv', 06:36:50 INFO - 'install', 06:36:50 INFO - 'run-tests'), 06:36:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:36:50 INFO - 'download_minidump_stackwalk': True, 06:36:50 INFO - 'download_symbols': 'ondemand', 06:36:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:36:50 INFO - 'tooltool.py': '/tools/tooltool.py', 06:36:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:36:50 INFO - '/tools/misc-python/virtualenv.py')}, 06:36:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:36:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:36:50 INFO - 'gecko_profile': False, 06:36:50 INFO - 'gecko_profile_interval': 0, 06:36:50 INFO - 'installer_path': 'installer.exe', 06:36:50 INFO - 'log_level': 'info', 06:36:50 INFO - 'log_name': 'talos', 06:36:50 INFO - 'log_to_console': True, 06:36:50 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:36:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:36:50 INFO - 'opt_config_files': (), 06:36:50 INFO - 'pip_index': False, 06:36:50 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:36:50 INFO - 'cmd': ('bash', 06:36:50 INFO - '-c', 06:36:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:36:50 INFO - 'enabled': True, 06:36:50 INFO - 'halt_on_failure': False, 06:36:50 INFO - 'name': 'check_screen_resolution'},), 06:36:50 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:36:50 INFO - 'cmd': ('bash', 06:36:50 INFO - '-c', 06:36:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:36:50 INFO - 'enabled': True, 06:36:50 INFO - 'halt_on_failure': False, 06:36:50 INFO - 'name': 'check_screen_resolution'},), 06:36:50 INFO - 'run_cmd_checks_enabled': True, 06:36:50 INFO - 'suite': 'dromaeojs', 06:36:50 INFO - 'system_bits': '32', 06:36:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:36:50 INFO - 'title': 't-yosemite-r7-0208', 06:36:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:36:50 INFO - 'use_talos_json': True, 06:36:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:36:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:36:50 INFO - 'work_dir': 'build'} 06:36:50 INFO - [mozharness: 2017-04-18 13:36:50.048490Z] Running clobber step. 06:36:50 INFO - Running pre-action listener: _resource_record_pre_action 06:36:50 INFO - Running main action method: clobber 06:36:50 INFO - rmtree: /builds/slave/test/build 06:36:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:36:52 INFO - Running post-action listener: _resource_record_post_action 06:36:52 INFO - [mozharness: 2017-04-18 13:36:52.159993Z] Finished clobber step (success) 06:36:52 INFO - [mozharness: 2017-04-18 13:36:52.160198Z] Running read-buildbot-config step. 06:36:52 INFO - Running pre-action listener: _resource_record_pre_action 06:36:52 INFO - Running main action method: read_buildbot_config 06:36:52 INFO - Using buildbot properties: 06:36:52 INFO - { 06:36:52 INFO - "project": "", 06:36:52 INFO - "product": "firefox", 06:36:52 INFO - "script_repo_revision": "production", 06:36:52 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 06:36:52 INFO - "repository": "", 06:36:52 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 06:36:52 INFO - "buildid": "20170418051525", 06:36:52 INFO - "pgo_build": "False", 06:36:52 INFO - "basedir": "/builds/slave/test", 06:36:52 INFO - "buildnumber": 0, 06:36:52 INFO - "slavename": "t-yosemite-r7-0208", 06:36:52 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 06:36:52 INFO - "platform": "yosemite_r7", 06:36:52 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 06:36:52 INFO - "branch": "mozilla-beta", 06:36:52 INFO - "repo_path": "releases/mozilla-beta", 06:36:52 INFO - "revision": "d57aa49c39484782cdd91cde6c10c343eb0d557e", 06:36:52 INFO - "stage_platform": "macosx64", 06:36:52 INFO - "builduid": "9860153f86ef4ee181fee8134d41b8b8", 06:36:52 INFO - "slavebuilddir": "test" 06:36:52 INFO - } 06:36:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/dLMeDEC3SDeVkxnwKZo2mQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 06:36:52 INFO - Running post-action listener: _resource_record_post_action 06:36:52 INFO - [mozharness: 2017-04-18 13:36:52.164088Z] Finished read-buildbot-config step (success) 06:36:52 INFO - [mozharness: 2017-04-18 13:36:52.164242Z] Running download-and-extract step. 06:36:52 INFO - Running pre-action listener: _resource_record_pre_action 06:36:52 INFO - Running main action method: download_and_extract 06:36:52 INFO - mkdir: /builds/slave/test/build/tests 06:36:52 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')]} 06:36:52 INFO - trying https://queue.taskcluster.net/v1/task/dLMeDEC3SDeVkxnwKZo2mQ/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 06:36:52 INFO - Downloading https://queue.taskcluster.net/v1/task/dLMeDEC3SDeVkxnwKZo2mQ/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 06:36:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dLMeDEC3SDeVkxnwKZo2mQ/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json'}, attempt #1 06:36:53 INFO - Downloaded 1165 bytes. 06:36:53 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 06:36:53 INFO - Using the following test package requirements: 06:36:53 INFO - {u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 06:36:53 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 06:36:53 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 06:36:53 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 06:36:53 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 06:36:53 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 06:36:53 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 06:36:53 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 06:36:53 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 06:36:53 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 06:36:53 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 06:36:53 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 06:36:53 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 06:36:53 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 06:36:53 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 06:36:53 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 06:36:53 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 06:36:53 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 06:36:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dLMeDEC3SDeVkxnwKZo2mQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 06:36:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dLMeDEC3SDeVkxnwKZo2mQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 06:36:53 INFO - Fetch https://queue.taskcluster.net/v1/task/dLMeDEC3SDeVkxnwKZo2mQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 06:36:54 INFO - Expected file size: 51220717 06:36:54 INFO - Obtained file size: 51220717 06:37:10 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip', u'firefox-54.0.en-US.mac.talos.tests.zip'] for test suite category: talos 06:37:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dLMeDEC3SDeVkxnwKZo2mQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 06:37:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dLMeDEC3SDeVkxnwKZo2mQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 06:37:10 INFO - Fetch https://queue.taskcluster.net/v1/task/dLMeDEC3SDeVkxnwKZo2mQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 06:37:12 INFO - Expected file size: 51220717 06:37:12 INFO - Obtained file size: 51220717 06:37:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dLMeDEC3SDeVkxnwKZo2mQ/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 06:37:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dLMeDEC3SDeVkxnwKZo2mQ/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 06:37:27 INFO - Fetch https://queue.taskcluster.net/v1/task/dLMeDEC3SDeVkxnwKZo2mQ/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 06:37:28 INFO - Expected file size: 14404424 06:37:28 INFO - Obtained file size: 14404424 06:37:28 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')]} 06:37:28 INFO - trying https://queue.taskcluster.net/v1/task/dLMeDEC3SDeVkxnwKZo2mQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg 06:37:28 INFO - Downloading https://queue.taskcluster.net/v1/task/dLMeDEC3SDeVkxnwKZo2mQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 06:37:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dLMeDEC3SDeVkxnwKZo2mQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg'}, attempt #1 06:37:30 INFO - Downloaded 59193837 bytes. 06:37:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dLMeDEC3SDeVkxnwKZo2mQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg 06:37:30 INFO - mkdir: /builds/slave/test/properties 06:37:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:37:30 INFO - Writing to file /builds/slave/test/properties/build_url 06:37:30 INFO - Contents: 06:37:30 INFO - build_url:https://queue.taskcluster.net/v1/task/dLMeDEC3SDeVkxnwKZo2mQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg 06:37:31 INFO - Running post-action listener: _resource_record_post_action 06:37:31 INFO - Running post-action listener: set_extra_try_arguments 06:37:31 INFO - [mozharness: 2017-04-18 13:37:31.275260Z] Finished download-and-extract step (success) 06:37:31 INFO - [mozharness: 2017-04-18 13:37:31.275392Z] Running populate-webroot step. 06:37:31 INFO - Running pre-action listener: _resource_record_pre_action 06:37:31 INFO - Running main action method: populate_webroot 06:37:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:37:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:37:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:37:31 INFO - '--tppagecycles', 06:37:31 INFO - '7'], 06:37:31 INFO - 'tests': ['tsvgm']}}, 06:37:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:37:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:37:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:37:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:37:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:37:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:37:31 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 06:37:31 INFO - 'talos_options': ['--disable-e10s'], 06:37:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:37:31 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:37:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:37:31 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 06:37:31 INFO - 'talos_options': ['--disable-e10s'], 06:37:31 INFO - 'tests': ['damp', 'tps']}, 06:37:31 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:37:31 INFO - 'tests': ['damp', 'tps']}, 06:37:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:37:31 INFO - 'tests': ['dromaeo_dom']}, 06:37:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:37:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:37:31 INFO - 'tests': ['basic_compositor_video']}, 06:37:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:37:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:37:31 INFO - 'tests': ['a11yr', 06:37:31 INFO - 'ts_paint', 06:37:31 INFO - 'tpaint', 06:37:31 INFO - 'sessionrestore', 06:37:31 INFO - 'sessionrestore_no_auto_restore', 06:37:31 INFO - 'tabpaint']}, 06:37:31 INFO - 'other-e10s': {'tests': ['a11yr', 06:37:31 INFO - 'ts_paint', 06:37:31 INFO - 'tpaint', 06:37:31 INFO - 'sessionrestore', 06:37:31 INFO - 'sessionrestore_no_auto_restore', 06:37:31 INFO - 'tabpaint']}, 06:37:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:37:31 INFO - 'ts_paint', 06:37:31 INFO - 'tpaint', 06:37:31 INFO - 'sessionrestore', 06:37:31 INFO - 'sessionrestore_no_auto_restore', 06:37:31 INFO - 'tabpaint']}, 06:37:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:37:31 INFO - 'ts_paint', 06:37:31 INFO - 'tpaint', 06:37:31 INFO - 'sessionrestore', 06:37:31 INFO - 'sessionrestore_no_auto_restore', 06:37:31 INFO - 'tabpaint']}, 06:37:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:37:31 INFO - 'tests': ['a11yr', 06:37:31 INFO - 'ts_paint', 06:37:31 INFO - 'tpaint', 06:37:31 INFO - 'sessionrestore', 06:37:31 INFO - 'sessionrestore_no_auto_restore', 06:37:31 INFO - 'tabpaint']}, 06:37:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:37:31 INFO - 'tests': ['a11yr', 06:37:31 INFO - 'ts_paint', 06:37:31 INFO - 'tpaint', 06:37:31 INFO - 'sessionrestore', 06:37:31 INFO - 'sessionrestore_no_auto_restore', 06:37:31 INFO - 'tabpaint']}, 06:37:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:37:31 INFO - 'tests': ['tsvgx', 06:37:31 INFO - 'tsvgr_opacity', 06:37:31 INFO - 'tart', 06:37:31 INFO - 'tscrollx', 06:37:31 INFO - 'cart', 06:37:31 INFO - 'tsvg_static']}, 06:37:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:37:31 INFO - 'tsvgr_opacity', 06:37:31 INFO - 'tart', 06:37:31 INFO - 'tscrollx', 06:37:31 INFO - 'cart', 06:37:31 INFO - 'tsvg_static']}, 06:37:31 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 06:37:31 INFO - 'talos_options': ['--disable-e10s'], 06:37:31 INFO - 'tests': ['tp5o']}, 06:37:31 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:37:31 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 06:37:31 INFO - 'talos_options': ['--disable-e10s', 06:37:31 INFO - '--xperf_path', 06:37:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:37:31 INFO - 'tests': ['tp5n']}, 06:37:31 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:37:31 INFO - 'talos_options': ['--xperf_path', 06:37:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:37:31 INFO - 'tests': ['tp5n']}}, 06:37:31 INFO - 'talos.zip': {'path': '', 06:37:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:37:31 INFO - Running post-action listener: _resource_record_post_action 06:37:31 INFO - [mozharness: 2017-04-18 13:37:31.293908Z] Finished populate-webroot step (success) 06:37:31 INFO - [mozharness: 2017-04-18 13:37:31.294001Z] Running create-virtualenv step. 06:37:31 INFO - Running pre-action listener: _resource_record_pre_action 06:37:31 INFO - Running main action method: create_virtualenv 06:37:31 INFO - Creating virtualenv /builds/slave/test/build/venv 06:37:31 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 06:37:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:37:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:37:31 INFO - Using real prefix '/tools/python27' 06:37:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:37:32 INFO - Installing distribute.............................................................................................................................................................................................done. 06:37:35 INFO - Installing pip.................done. 06:37:35 INFO - Return code: 0 06:37:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:37:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:37:35 INFO - Reading from file tmpfile_stdout 06:37:35 INFO - Output received: 06:37:35 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 06:37:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:37: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')]} 06:37:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37: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')]} 06:37:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c32db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c330768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81bb5a2aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c10bd30>, '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 0x10c032db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c100be8>, '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.G0iT8WWeJa/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.U4g41Jq9uQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/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 06:37: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', 'pip>=1.5'] in /builds/slave/test/build 06:37: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 pip>=1.5 06:37:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G0iT8WWeJa/Render', 06:37:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:37:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:37:35 INFO - 'HOME': '/Users/cltbld', 06:37:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:37:35 INFO - 'LOGNAME': 'cltbld', 06:37:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:35 INFO - 'MOZ_NO_REMOTE': '1', 06:37:35 INFO - 'NO_EM_RESTART': '1', 06:37:35 INFO - 'PAGER': '/bin/cat', 06:37:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:37:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:35 INFO - 'PWD': '/builds/slave/test', 06:37:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:37:35 INFO - 'SHELL': '/bin/bash', 06:37:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U4g41Jq9uQ/Listeners', 06:37:35 INFO - 'TMPDIR': '/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/', 06:37:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:37:35 INFO - 'USER': 'cltbld', 06:37:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:37:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:37:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:35 INFO - 'XPC_FLAGS': '0x0', 06:37:35 INFO - 'XPC_SERVICE_NAME': '0', 06:37:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:37:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:35 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 06:37:35 INFO - Cleaning up... 06:37:35 INFO - Return code: 0 06:37:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:37: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')]} 06:37:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37: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')]} 06:37:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37: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', '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 0x10c32db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c330768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81bb5a2aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c10bd30>, '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 0x10c032db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c100be8>, '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.G0iT8WWeJa/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.U4g41Jq9uQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/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 06:37: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', 'psutil>=3.1.1'] in /builds/slave/test/build 06:37: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 psutil>=3.1.1 06:37:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G0iT8WWeJa/Render', 06:37:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:37:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:37:35 INFO - 'HOME': '/Users/cltbld', 06:37:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:37:35 INFO - 'LOGNAME': 'cltbld', 06:37:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:35 INFO - 'MOZ_NO_REMOTE': '1', 06:37:35 INFO - 'NO_EM_RESTART': '1', 06:37:35 INFO - 'PAGER': '/bin/cat', 06:37:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:37:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:35 INFO - 'PWD': '/builds/slave/test', 06:37:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:37:35 INFO - 'SHELL': '/bin/bash', 06:37:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U4g41Jq9uQ/Listeners', 06:37:35 INFO - 'TMPDIR': '/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/', 06:37:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:37:35 INFO - 'USER': 'cltbld', 06:37:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:37:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:37:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:35 INFO - 'XPC_FLAGS': '0x0', 06:37:35 INFO - 'XPC_SERVICE_NAME': '0', 06:37:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:37:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:36 INFO - Downloading/unpacking psutil>=3.1.1 06:37:36 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 06:37:36 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 06:37:36 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 06:37:36 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 06:37:36 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 06:37:36 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 06:37:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:37:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:37:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:37:40 INFO - Installing collected packages: psutil 06:37:40 INFO - Running setup.py install for psutil 06:37:40 INFO - building 'psutil._psutil_osx' extension 06:37:40 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 06:37:40 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 06:37:40 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 06:37:40 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 06:37:40 INFO - building 'psutil._psutil_posix' extension 06:37:40 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 06:37:40 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:37:40 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:37:40 INFO - ^ 06:37:40 INFO - 1 warning generated. 06:37:40 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 06:37:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:37:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:37:40 INFO - Successfully installed psutil 06:37:40 INFO - Cleaning up... 06:37:41 INFO - Return code: 0 06:37:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:37: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')]} 06:37:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37: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')]} 06:37:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c32db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c330768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81bb5a2aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c10bd30>, '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 0x10c032db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c100be8>, '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.G0iT8WWeJa/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.U4g41Jq9uQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/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 06:37: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:37: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 mozsystemmonitor==0.3 06:37:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G0iT8WWeJa/Render', 06:37:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:37:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:37:41 INFO - 'HOME': '/Users/cltbld', 06:37:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:37:41 INFO - 'LOGNAME': 'cltbld', 06:37:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:41 INFO - 'MOZ_NO_REMOTE': '1', 06:37:41 INFO - 'NO_EM_RESTART': '1', 06:37:41 INFO - 'PAGER': '/bin/cat', 06:37:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:37:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:41 INFO - 'PWD': '/builds/slave/test', 06:37:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:37:41 INFO - 'SHELL': '/bin/bash', 06:37:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U4g41Jq9uQ/Listeners', 06:37:41 INFO - 'TMPDIR': '/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/', 06:37:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:37:41 INFO - 'USER': 'cltbld', 06:37:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:37:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:37:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:41 INFO - 'XPC_FLAGS': '0x0', 06:37:41 INFO - 'XPC_SERVICE_NAME': '0', 06:37:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:37:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:37:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:37:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:37:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:37:43 INFO - Installing collected packages: mozsystemmonitor 06:37:43 INFO - Running setup.py install for mozsystemmonitor 06:37:44 INFO - Successfully installed mozsystemmonitor 06:37:44 INFO - Cleaning up... 06:37:44 INFO - Return code: 0 06:37:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:37:44 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')]} 06:37:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:44 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')]} 06:37:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c32db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c330768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81bb5a2aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c10bd30>, '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 0x10c032db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c100be8>, '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.G0iT8WWeJa/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.U4g41Jq9uQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/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 06:37:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:37:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:37:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G0iT8WWeJa/Render', 06:37:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:37:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:37:44 INFO - 'HOME': '/Users/cltbld', 06:37:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:37:44 INFO - 'LOGNAME': 'cltbld', 06:37:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:44 INFO - 'MOZ_NO_REMOTE': '1', 06:37:44 INFO - 'NO_EM_RESTART': '1', 06:37:44 INFO - 'PAGER': '/bin/cat', 06:37:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:37:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:44 INFO - 'PWD': '/builds/slave/test', 06:37:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:37:44 INFO - 'SHELL': '/bin/bash', 06:37:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U4g41Jq9uQ/Listeners', 06:37:44 INFO - 'TMPDIR': '/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/', 06:37:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:37:44 INFO - 'USER': 'cltbld', 06:37:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:37:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:37:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:44 INFO - 'XPC_FLAGS': '0x0', 06:37:44 INFO - 'XPC_SERVICE_NAME': '0', 06:37:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:37:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:44 INFO - Downloading/unpacking jsonschema==2.5.1 06:37: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 06:37: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 06:37: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 06:37: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 06:37: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 06:37: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 06:37:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:37:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:37:47 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 06:37:47 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 06:37:47 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 06:37:47 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 06:37:47 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 06:37:47 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 06:37:47 INFO - Downloading functools32-3.2.3-2.tar.gz 06:37:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:37:47 INFO - warning: no files found matching '*.txt' 06:37:47 INFO - no previously-included directories found matching 'build' 06:37:47 INFO - no previously-included directories found matching 'dist' 06:37:47 INFO - no previously-included directories found matching '.git*' 06:37:47 INFO - Installing collected packages: jsonschema, functools32 06:37:47 INFO - Running setup.py install for functools32 06:37:47 INFO - warning: no files found matching '*.txt' 06:37:47 INFO - no previously-included directories found matching 'build' 06:37:47 INFO - no previously-included directories found matching 'dist' 06:37:47 INFO - no previously-included directories found matching '.git*' 06:37:47 INFO - Successfully installed jsonschema functools32 06:37:47 INFO - Cleaning up... 06:37:47 INFO - Return code: 0 06:37:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:37: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')]} 06:37:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37: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')]} 06:37:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:47 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 0x10c32db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c330768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81bb5a2aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c10bd30>, '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 0x10c032db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c100be8>, '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.G0iT8WWeJa/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.U4g41Jq9uQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/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 06:37:47 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 06:37:47 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 06:37:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G0iT8WWeJa/Render', 06:37:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:37:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:37:47 INFO - 'HOME': '/Users/cltbld', 06:37:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:37:47 INFO - 'LOGNAME': 'cltbld', 06:37:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:47 INFO - 'MOZ_NO_REMOTE': '1', 06:37:47 INFO - 'NO_EM_RESTART': '1', 06:37:47 INFO - 'PAGER': '/bin/cat', 06:37:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:37:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:47 INFO - 'PWD': '/builds/slave/test', 06:37:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:37:47 INFO - 'SHELL': '/bin/bash', 06:37:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U4g41Jq9uQ/Listeners', 06:37:47 INFO - 'TMPDIR': '/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/', 06:37:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:37:47 INFO - 'USER': 'cltbld', 06:37:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:37:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:37:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:47 INFO - 'XPC_FLAGS': '0x0', 06:37:47 INFO - 'XPC_SERVICE_NAME': '0', 06:37:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:37:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:37:48 INFO - Cleaning up... 06:37:48 INFO - Return code: 0 06:37:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:37:48 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')]} 06:37:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:48 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')]} 06:37:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:48 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 0x10c32db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c330768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81bb5a2aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c10bd30>, '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 0x10c032db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c100be8>, '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.G0iT8WWeJa/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.U4g41Jq9uQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/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 06:37:48 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 06:37:48 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 06:37:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G0iT8WWeJa/Render', 06:37:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:37:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:37:48 INFO - 'HOME': '/Users/cltbld', 06:37:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:37:48 INFO - 'LOGNAME': 'cltbld', 06:37:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:48 INFO - 'MOZ_NO_REMOTE': '1', 06:37:48 INFO - 'NO_EM_RESTART': '1', 06:37:48 INFO - 'PAGER': '/bin/cat', 06:37:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:37:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:48 INFO - 'PWD': '/builds/slave/test', 06:37:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:37:48 INFO - 'SHELL': '/bin/bash', 06:37:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U4g41Jq9uQ/Listeners', 06:37:48 INFO - 'TMPDIR': '/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/', 06:37:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:37:48 INFO - 'USER': 'cltbld', 06:37:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:37:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:37:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:48 INFO - 'XPC_FLAGS': '0x0', 06:37:48 INFO - 'XPC_SERVICE_NAME': '0', 06:37:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:37:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:48 INFO - Downloading/unpacking blobuploader==1.2.4 06:37:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:37:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:37:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:37:50 INFO - Downloading blobuploader-1.2.4.tar.gz 06:37:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:37:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:37:51 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 06:37:51 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 06:37:51 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 06:37:51 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 06:37:51 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 06:37:51 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 06:37:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:37:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:37:51 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 06:37:51 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 06:37:51 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 06:37:51 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 06:37:51 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 06:37:51 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 06:37:52 INFO - Downloading docopt-0.6.1.tar.gz 06:37:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:37:52 INFO - Installing collected packages: blobuploader, requests, docopt 06:37:52 INFO - Running setup.py install for blobuploader 06:37:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:37:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:37:52 INFO - Running setup.py install for requests 06:37:52 INFO - Running setup.py install for docopt 06:37:53 INFO - Successfully installed blobuploader requests docopt 06:37:53 INFO - Cleaning up... 06:37:53 INFO - Return code: 0 06:37:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:37:53 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')]} 06:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:53 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')]} 06:37:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:53 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 0x10c32db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c330768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81bb5a2aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c10bd30>, '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 0x10c032db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c100be8>, '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.G0iT8WWeJa/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.U4g41Jq9uQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/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 06:37:53 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 06:37:53 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 06:37:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G0iT8WWeJa/Render', 06:37:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:37:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:37:53 INFO - 'HOME': '/Users/cltbld', 06:37:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:37:53 INFO - 'LOGNAME': 'cltbld', 06:37:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:53 INFO - 'MOZ_NO_REMOTE': '1', 06:37:53 INFO - 'NO_EM_RESTART': '1', 06:37:53 INFO - 'PAGER': '/bin/cat', 06:37:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:37:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:53 INFO - 'PWD': '/builds/slave/test', 06:37:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:37:53 INFO - 'SHELL': '/bin/bash', 06:37:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U4g41Jq9uQ/Listeners', 06:37:53 INFO - 'TMPDIR': '/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/', 06:37:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:37:53 INFO - 'USER': 'cltbld', 06:37:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:37:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:37:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:53 INFO - 'XPC_FLAGS': '0x0', 06:37:53 INFO - 'XPC_SERVICE_NAME': '0', 06:37:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:37:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:37:53 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-BhJYms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:37:53 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-YilBDR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:37:53 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-qDGZhH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:37:53 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-HxYr9q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:37:53 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-qMQhxT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:37:53 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-pl1vMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:37:54 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-xUewu8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:37:54 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-sb8Wte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:37:54 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-W8KqmK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:37:54 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-Gxg62A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:37:54 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-WzACGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:37:54 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-lA4zt6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:37:54 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-u703cr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:37:54 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-bPajox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:37:54 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-jogICB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:37:54 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-0J_Xxl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:37:55 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-Y1tEVS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:37:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:37:55 INFO - Running setup.py install for manifestparser 06:37:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:37:55 INFO - Running setup.py install for mozcrash 06:37:55 INFO - Running setup.py install for mozdebug 06:37:55 INFO - Running setup.py install for mozdevice 06:37:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:37:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:37:55 INFO - Running setup.py install for mozfile 06:37:55 INFO - Running setup.py install for mozhttpd 06:37:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:37:56 INFO - Running setup.py install for mozinfo 06:37:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:37:56 INFO - Running setup.py install for mozInstall 06:37:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:37:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:37:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:37:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:37:56 INFO - Running setup.py install for mozleak 06:37:56 INFO - Running setup.py install for mozlog 06:37:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:37:56 INFO - Running setup.py install for moznetwork 06:37:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:37:56 INFO - Running setup.py install for mozprocess 06:37:57 INFO - Running setup.py install for mozprofile 06:37:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:37:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:37:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:37:57 INFO - Running setup.py install for mozrunner 06:37:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:37:57 INFO - Running setup.py install for mozscreenshot 06:37:57 INFO - Running setup.py install for moztest 06:37:57 INFO - Running setup.py install for mozversion 06:37:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:37:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:37:57 INFO - Cleaning up... 06:37:57 INFO - Return code: 0 06:37:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:37: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')]} 06:37:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37: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')]} 06:37:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:57 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 0x10c32db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c330768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81bb5a2aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c10bd30>, '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 0x10c032db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c100be8>, '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.G0iT8WWeJa/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.U4g41Jq9uQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/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 06:37:57 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 06:37:57 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 06:37:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G0iT8WWeJa/Render', 06:37:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:37:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:37:57 INFO - 'HOME': '/Users/cltbld', 06:37:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:37:57 INFO - 'LOGNAME': 'cltbld', 06:37:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:57 INFO - 'MOZ_NO_REMOTE': '1', 06:37:57 INFO - 'NO_EM_RESTART': '1', 06:37:57 INFO - 'PAGER': '/bin/cat', 06:37:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:37:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:57 INFO - 'PWD': '/builds/slave/test', 06:37:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:37:57 INFO - 'SHELL': '/bin/bash', 06:37:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U4g41Jq9uQ/Listeners', 06:37:57 INFO - 'TMPDIR': '/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/', 06:37:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:37:57 INFO - 'USER': 'cltbld', 06:37:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:37:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:37:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:57 INFO - 'XPC_FLAGS': '0x0', 06:37:57 INFO - 'XPC_SERVICE_NAME': '0', 06:37:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:37:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:37:58 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-gM89tY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:37:58 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)) 06:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:37:58 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-2IWVP4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:37:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:37:58 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-1Zoluu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:37:58 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)) 06:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:37:58 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-qjtEVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:37:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:37:58 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-L4v3GJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:37:58 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)) 06:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:37:58 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-BLxHK0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:37:58 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)) 06:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:37:58 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-ZIEM82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:37:58 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)) 06:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:37:58 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-uwTHSK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:37:58 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)) 06:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:37:58 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-NYaTvL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:37:59 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)) 06:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:37:59 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-JwY9ri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:37:59 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)) 06:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:37:59 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-mbbDNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:37:59 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)) 06:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:37:59 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-kYnBuC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 06:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:37:59 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-_u5BFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:37:59 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)) 06:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:37:59 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-azsJCs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:37:59 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-2vP3Sw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:37:59 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)) 06:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:37:59 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-634b5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 06:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:37:59 INFO - Running setup.py (path:/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/pip-cA9Efe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:37:59 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)) 06:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:37:59 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)) 06:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:37:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:37:59 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 06:37:59 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 06:37:59 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 06:37:59 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 06:37:59 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 06:37:59 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 06:38:02 INFO - Downloading blessings-1.6.tar.gz 06:38:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:38:02 INFO - Installing collected packages: blessings 06:38:02 INFO - Running setup.py install for blessings 06:38:02 INFO - Successfully installed blessings 06:38:02 INFO - Cleaning up... 06:38:02 INFO - Return code: 0 06:38:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:38:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:38:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:38:03 INFO - Reading from file tmpfile_stdout 06:38:03 INFO - Current package versions: 06:38:03 INFO - blessings == 1.6 06:38:03 INFO - blobuploader == 1.2.4 06:38:03 INFO - docopt == 0.6.1 06:38:03 INFO - functools32 == 3.2.3-2 06:38:03 INFO - jsonschema == 2.5.1 06:38:03 INFO - manifestparser == 1.1 06:38:03 INFO - mozInstall == 1.12 06:38:03 INFO - mozcrash == 1.0 06:38:03 INFO - mozdebug == 0.1 06:38:03 INFO - mozdevice == 0.49 06:38:03 INFO - mozfile == 1.2 06:38:03 INFO - mozhttpd == 0.7 06:38:03 INFO - mozinfo == 0.9 06:38:03 INFO - mozleak == 0.1 06:38:03 INFO - mozlog == 3.4 06:38:03 INFO - moznetwork == 0.27 06:38:03 INFO - mozprocess == 0.25 06:38:03 INFO - mozprofile == 0.28 06:38:03 INFO - mozrunner == 6.13 06:38:03 INFO - mozscreenshot == 0.1 06:38:03 INFO - mozsystemmonitor == 0.3 06:38:03 INFO - moztest == 0.8 06:38:03 INFO - mozversion == 1.4 06:38:03 INFO - psutil == 3.1.1 06:38:03 INFO - requests == 1.2.3 06:38:03 INFO - wsgiref == 0.1.2 06:38:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:38:03 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')]} 06:38:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:03 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')]} 06:38:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:03 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 0x10c32db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c330768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81bb5a2aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c10bd30>, '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 0x10c032db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c100be8>, '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.G0iT8WWeJa/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.U4g41Jq9uQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/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 06:38:03 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 06:38:03 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 06:38:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G0iT8WWeJa/Render', 06:38:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:38:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:38:03 INFO - 'HOME': '/Users/cltbld', 06:38:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:38:03 INFO - 'LOGNAME': 'cltbld', 06:38:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:03 INFO - 'MOZ_NO_REMOTE': '1', 06:38:03 INFO - 'NO_EM_RESTART': '1', 06:38:03 INFO - 'PAGER': '/bin/cat', 06:38:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:38:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:03 INFO - 'PWD': '/builds/slave/test', 06:38:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:38:03 INFO - 'SHELL': '/bin/bash', 06:38:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U4g41Jq9uQ/Listeners', 06:38:03 INFO - 'TMPDIR': '/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/', 06:38:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:38:03 INFO - 'USER': 'cltbld', 06:38:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:38:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:38:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:03 INFO - 'XPC_FLAGS': '0x0', 06:38:03 INFO - 'XPC_SERVICE_NAME': '0', 06:38:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:38:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:03 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)) 06:38:03 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)) 06:38:03 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)) 06:38:03 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)) 06:38:03 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)) 06:38:03 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)) 06:38:03 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)) 06:38:03 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)) 06:38:03 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)) 06:38:03 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)) 06:38:03 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)) 06:38:03 INFO - Cleaning up... 06:38:03 INFO - Return code: 0 06:38:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:38:03 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')]} 06:38:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:03 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')]} 06:38:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:03 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 0x10c32db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c330768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81bb5a2aa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c10bd30>, '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 0x10c032db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c100be8>, '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.G0iT8WWeJa/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.U4g41Jq9uQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/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 06:38:03 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 06:38:03 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 06:38:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G0iT8WWeJa/Render', 06:38:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:38:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:38:03 INFO - 'HOME': '/Users/cltbld', 06:38:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:38:03 INFO - 'LOGNAME': 'cltbld', 06:38:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:03 INFO - 'MOZ_NO_REMOTE': '1', 06:38:03 INFO - 'NO_EM_RESTART': '1', 06:38:03 INFO - 'PAGER': '/bin/cat', 06:38:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:38:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:03 INFO - 'PWD': '/builds/slave/test', 06:38:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:38:03 INFO - 'SHELL': '/bin/bash', 06:38:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U4g41Jq9uQ/Listeners', 06:38:03 INFO - 'TMPDIR': '/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/', 06:38:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:38:03 INFO - 'USER': 'cltbld', 06:38:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:38:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:38:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:03 INFO - 'XPC_FLAGS': '0x0', 06:38:03 INFO - 'XPC_SERVICE_NAME': '0', 06:38:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:38:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:38:03 INFO - Cleaning up... 06:38:03 INFO - Return code: 0 06:38:03 INFO - Running post-action listener: _resource_record_post_action 06:38:03 INFO - Running post-action listener: _start_resource_monitoring 06:38:03 INFO - Starting resource monitoring. 06:38:03 INFO - [mozharness: 2017-04-18 13:38:03.724890Z] Finished create-virtualenv step (success) 06:38:03 INFO - [mozharness: 2017-04-18 13:38:03.725885Z] Running install step. 06:38:03 INFO - Running pre-action listener: _resource_record_pre_action 06:38:03 INFO - Running main action method: install 06:38:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:38:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:38:03 INFO - Reading from file tmpfile_stdout 06:38:03 INFO - Detecting whether we're running mozinstall >=1.0... 06:38:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:38:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:38:04 INFO - Reading from file tmpfile_stdout 06:38:04 INFO - Output received: 06:38:04 INFO - Usage: mozinstall [options] installer 06:38:04 INFO - Options: 06:38:04 INFO - -h, --help show this help message and exit 06:38:04 INFO - -d DEST, --destination=DEST 06:38:04 INFO - Directory to install application into. [default: 06:38:04 INFO - "/builds/slave/test"] 06:38:04 INFO - --app=APP Application being installed. [default: firefox] 06:38:04 INFO - mkdir: /builds/slave/test/build/application 06:38:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:38:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0.en-US.mac.dmg --destination /builds/slave/test/build/application 06:38:18 INFO - Reading from file tmpfile_stdout 06:38:18 INFO - Output received: 06:38:18 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 06:38:18 INFO - Running post-action listener: _resource_record_post_action 06:38:18 INFO - [mozharness: 2017-04-18 13:38:18.735026Z] Finished install step (success) 06:38:18 INFO - [mozharness: 2017-04-18 13:38:18.735170Z] Running run-tests step. 06:38:18 INFO - Running pre-action listener: _resource_record_pre_action 06:38:18 INFO - Running main action method: run_tests 06:38:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:38:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:38:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:38:18 INFO - 2017-04-18 06:38:18.749 screenresolution[2190:15332] starting screenresolution argv=screenresolution get 06:38:18 INFO - 2017-04-18 06:38:18.752 screenresolution[2190:15332] Display 0: 1600x1200x32@60 06:38:18 INFO - 2017-04-18 06:38:18.758 screenresolution[2191:15334] starting screenresolution argv=screenresolution list 06:38:18 INFO - Available Modes on Display 0 06:38:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:38:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:38:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:38:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:38:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:38:18 INFO - Intel Iris: 06:38:18 INFO - Chipset Model: Intel Iris 06:38:18 INFO - Type: GPU 06:38:18 INFO - Bus: Built-In 06:38:18 INFO - VRAM (Dynamic, Max): 1536 MB 06:38:18 INFO - Vendor: Intel (0x8086) 06:38:18 INFO - Device ID: 0x0a2e 06:38:18 INFO - Revision ID: 0x0009 06:38:18 INFO - Displays: 06:38:18 INFO - Display: 06:38:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:38:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:38:18 INFO - Display Serial Number: 1600x1200 60 06:38:18 INFO - Main Display: Yes 06:38:18 INFO - Mirror: Off 06:38:18 INFO - Online: Yes 06:38:18 INFO - Rotation: Supported 06:38:18 INFO - Return code: 0 06:38:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:38:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:38:18 INFO - Python 2.7.3 06:38:18 INFO - Return code: 0 06:38:18 INFO - grabbing minidump binary from tooltool 06:38:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:38:18 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c10bd30>, '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 0x10c032db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c100be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:38:18 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:38:18 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 06:38:18 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 06:38:19 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:38:19 INFO - Return code: 0 06:38:19 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:38:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:38:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:38:19 INFO - ENV: RUST_BACKTRACE is now 1 06:38:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:38:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:38:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dLMeDEC3SDeVkxnwKZo2mQ/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0208', '--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 06:38:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dLMeDEC3SDeVkxnwKZo2mQ/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0208 --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 06:38:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.G0iT8WWeJa/Render', 06:38:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:38:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:38:19 INFO - 'HOME': '/Users/cltbld', 06:38:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:38:19 INFO - 'LOGNAME': 'cltbld', 06:38:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:38:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:38:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:19 INFO - 'MOZ_NO_REMOTE': '1', 06:38:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:38:19 INFO - 'NO_EM_RESTART': '1', 06:38:19 INFO - 'PAGER': '/bin/cat', 06:38:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:38:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:19 INFO - 'PWD': '/builds/slave/test', 06:38:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:38:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:38:19 INFO - 'RUST_BACKTRACE': '1', 06:38:19 INFO - 'SHELL': '/bin/bash', 06:38:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U4g41Jq9uQ/Listeners', 06:38:19 INFO - 'TMPDIR': '/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/', 06:38:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:38:19 INFO - 'USER': 'cltbld', 06:38:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:38:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:38:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:19 INFO - 'XPC_FLAGS': '0x0', 06:38:19 INFO - 'XPC_SERVICE_NAME': '0', 06:38:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:38:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dLMeDEC3SDeVkxnwKZo2mQ/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0208', '--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 06:38:19 INFO - mozversion application_buildid: 20170418051525 06:38:19 INFO - mozversion application_changeset: d57aa49c39484782cdd91cde6c10c343eb0d557e 06:38:19 INFO - mozversion application_display_name: Firefox 06:38:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:38:19 INFO - mozversion application_name: Firefox 06:38:19 INFO - mozversion application_remotingname: firefox 06:38:19 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 06:38:19 INFO - mozversion application_vendor: Mozilla 06:38:19 INFO - mozversion application_version: 54.0 06:38:19 INFO - mozversion platform_buildid: 20170418051525 06:38:19 INFO - mozversion platform_changeset: d57aa49c39484782cdd91cde6c10c343eb0d557e 06:38:19 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 06:38:19 INFO - mozversion platform_version: 54.0 06:38:19 INFO - using testdate: 1492522699 06:38:19 INFO - actual date: 1492522699 06:38:19 INFO - starting webserver on 'localhost:49649' 06:38:19 INFO - SUITE-START | Running 2 tests 06:38:19 INFO - TEST-START | dromaeo_css 06:38:19 INFO - operating with platform_type : mac_ 06:38:19 INFO - Initialising browser for dromaeo_css test... 06:38:19 INFO - TEST-INFO | started process 2201 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/tmpByWzUl/profile http://localhost:49649/getInfo.html) 06:38:21 INFO - PROCESS | 2201 | __metrics Screen width/height:1600/1200 06:38:21 INFO - PROCESS | 2201 | colorDepth:24 06:38:21 INFO - PROCESS | 2201 | Browser inner width/height: 1024/689 06:38:21 INFO - PROCESS | 2201 | __metrics 06:38:21 INFO - PROCESS | 2201 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:38:21 INFO - PROCESS | 2201 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:38:22 INFO - TEST-INFO | 2201: exit 0 06:38:22 INFO - Browser initialized. 06:38:22 INFO - Running cycle 1/1 for dromaeo_css test... 06:38:22 INFO - TEST-INFO | started process 2204 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/tmpByWzUl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:38:34 INFO - PROCESS | 2204 | RSS: Main: 164896768 06:38:34 INFO - PROCESS | 2204 | 06:41:38 INFO - PROCESS | 2204 | Cycle 1(1): loaded http://localhost:49649/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49649/tests/dromaeo/cssquery-ext.html) 06:41:40 INFO - PROCESS | 2204 | RSS: Main: 292175872 06:41:40 INFO - PROCESS | 2204 | 06:44:43 INFO - PROCESS | 2204 | Cycle 1(1): loaded http://localhost:49649/tests/dromaeo/cssquery-ext.html (next: http://localhost:49649/tests/dromaeo/cssquery-jquery.html) 06:44:43 INFO - PROCESS | 2204 | RSS: Main: 301080576 06:44:43 INFO - PROCESS | 2204 | 06:47:46 INFO - PROCESS | 2204 | Cycle 1(1): loaded http://localhost:49649/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49649/tests/dromaeo/cssquery-mootools.html) 06:47:46 INFO - PROCESS | 2204 | RSS: Main: 271745024 06:47:46 INFO - PROCESS | 2204 | 06:50:49 INFO - PROCESS | 2204 | Cycle 1(1): loaded http://localhost:49649/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49649/tests/dromaeo/cssquery-prototype.html) 06:50:49 INFO - PROCESS | 2204 | RSS: Main: 263839744 06:50:49 INFO - PROCESS | 2204 | 06:53:53 INFO - PROCESS | 2204 | Cycle 1(1): loaded http://localhost:49649/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49649/tests/dromaeo/cssquery-yui.html) 06:53:54 INFO - PROCESS | 2204 | RSS: Main: 268021760 06:53:54 INFO - PROCESS | 2204 | 06:56:57 INFO - PROCESS | 2204 | Cycle 1(1): loaded http://localhost:49649/tests/dromaeo/cssquery-yui.html (next: http://localhost:49649/tests/dromaeo/cssquery-dojo.html) 06:56:57 INFO - PROCESS | 2204 | RSS: Main: 474279936 06:56:57 INFO - PROCESS | 2204 | 06:56:57 INFO - PROCESS | 2204 | __start_tp_report 06:56:57 INFO - PROCESS | 2204 | _x_x_mozilla_page_load 06:56:57 INFO - PROCESS | 2204 | _x_x_mozilla_page_load_details 06:56:57 INFO - PROCESS | 2204 | |i|pagename|runs| 06:56:57 INFO - PROCESS | 2204 | |0;dojo.html;3541.7874927504354;3548.0774998500383;3574.9642503574973;3589.5154154189177;3595.514605528253;6251.906221406677;6256.718447669854;6279.560430769837;6303.180586523751;6311.62130272184;6280.617638737919;6311.968440157804;6314.0844577536345;6320.115183874262;6324.905126423096;5578.219049333096;5600.747966341504;5606.467385598372;5635.3237611486475;5707.3721890592005;4921.114199444099;5399.352077750676;5444.292242008533;5507.311586051744;5709.457601527848;5572.331320241577;5584.497395234428;5591.608587398884;5597.944020559783;5642.887142257153;5622.522085622727;5623.550115990732;5655.3779084300695;5664.150377443375;5668.291463567054;5471.945280547223;5540.058190107691;5561.388247292794;5620.662760234399;5623.775048998076;6109.908351374733;6136.355682653302;6136.478399336062;6160.476359509447;6167.629942203482;5557.472040156179;6535.444487218592;6568.146141001687;6597.670116494156;6602.93397066028;6615.867682646368;6624.635645039521;6665.766698165541;6678.933210667879;6685.832854178636;6145.600535965148;6185.752569897244;6283.748650054038;6329.05064240363;6393.8401539961405;6222.0355844844125;6591.011348297794;6592.373724496261;6615.437687796495;6715.496337774686;6016.789412370546;6485.805425837232;6490.902636460457;6499.252585952581;6504.38208370204;6585.9012114818315;6645.966770166215;6661.600303981777;6668.766593169215;6690.565113267622;6275.6548389839;6309.33751956038;6561.80314590563;6571.2771595124495;6577.6711164441585;6445.065465507475;6452.903206451907;6477;6491.870162596816;6497.740090396425;5277.709725965109;5312.867178320573;5326.201069839555;5336.813211537577;5344.091504444254;4755.976220118877;4761.142994261067;4765.642576806753;4766.856994290177;4805.735684537314;6104.7926496150985;6161.630302181883;6194.969025154845;6213.813585592439;6216.53375996793;6547.214334279822;6551.80344589663;6658.96670516654;6672.799816005528;6684.598924064571;6237.4698150657705;6328.778492752732;6330.715117819709;6339.4611458025665;6344.841378965562;5657.57568182388;5801;5877.177195192677;5892.94107058924;5894.734736936848;5620.353659329147;6680.933190668031;6700.6984685688285;6703.93296067033;6706.865862682622;6450.645214513059;6458.192725909262;6465.515086368635;6475.125858009297;6550;5632.746526406239;6923.515353925379;6926.376626103473;6939.6877140529805;6950.687219075053;6602.60384376939;6609.702563384563;6617.735290588515;6621.867562648817;6622.933770662425;6365.809025729235;6586.077949087227;6682.2649508555;6699.129113215251;6701.296363881917;6327.96836015817;6451.483881289391;6505.024246362894;6512.511561632991;6521.869562608626;6484.1246431731115;6493.740250389931;6495.675216239264;6511.446527045065;6520.706568204537;6258.561900666909;6296.244450665767;6355.713992870239;6367.93632063692;6380;6310.432061114522;6352.841178970562;6370.458511026614;6372.58578192416;6389.808305750835;6317.557770955989;6326.051092336186;6336.271328797247;6345.682715864281;6349.4920406366455 06:56:57 INFO - PROCESS | 2204 | |1;ext.html;823.3577809308739;915.5056269614408;926.1664501948246;926.527470989795;1012.0132870451315;38389.61610383899;38920.80539597302;40699;40735.18529629409;40873.386899196536;38948.22103557927;39071.804640976756;39098.80450597743;39136.41295380572;39162.020949476275;8016.118226995026;8145.633446494922;8285.088640249583;8385.6226469809;8388.496690198577;11627.244229125123;11854.170208085437;12052.457639406204;12071.034317254642;12071.879281207208;11886.46510907007;11892.821607675893;11903;11920.701982450422;11942.582009629665;11822.054235661126;11863.406829658483;11865.288082715064;11871.821922671166;11881.930626243637;11618.825717614243;11667.124965627612;11679.883201167964;11687.590934317343;11687.766244675144;33406.3318733624;40501;40764.592354076376;40807.97980050493;40838.79580602108;3991.6607088397523;4044.534878488982;4046.6964977626794;4056.7565946043333;4075.205334959684;28466;28650.14049578516;29884.8505757472;30745.92389266387;30792.84603576968;3121.4693502104697;3282.4748040313675;3305.058058453329;3313.5692359993045;3378.6621337866263;345275;349570;349629;349773.99999999744;349943;45097;45231.54768452339;53865;53947.46052539503;56757.7162114195;54137.72931135319;54305.72847135739;57284.85430291371;57326;57419;15856.048637081813;15935.203239837962;15938.521844344688;15940.760888586681;15968.041917484989;13362.532311369056;13387.263700496565;13402.396892139877;13439;13451.730965380637;11164.497597608128;13516.189028658311;13593.252371119683;13653.453861845614;13719.657008574866;5533.474319939599;5936.376680448577;6154.323024467305;6157.199564056644;6201.7519299228425;1135.9095268542126;1136.465861045324;1143.7598104398169;1147.6384938744436;1190.5118901250446;26343;27143.728562714514;27480.58779118315;27635.30911727223;28024.71975280221;1086.858798261822;1271.6185144456626;1274.6494713953737;1280.8783165599252;1326.1446367093172;14076.366563504667;14218;14569.490067847575;14586.978911476306;14598.63503412402;522704;529861;533487;651768;655123.724381375;50788.23817642738;51210.74394628003;51255.7437212819;51260;51343.66266192686;1428.7713965765427;1479.667074908137;1485.0198868746575;1486.8884833637303;1494.3873012065;27491;27610.585841211996;28225.717742822308;28460.857695711387;28642;42220.57779422167;42513.5748642522;42520.78739606282;42616;42630.57369426266;436514;438981;439469;440334;440907.79546102067;25664.23007309784;26033.349166270236;26797.330066748487;28370.769810273192;30493.390132197677;32543.511847321835;34018.3196336067;37602.435963460026;39859.20281594294;39901.40147897842;28387;28762;29142;29257.26856828511;29525.852370738008;27974.44051119007;29192.27019324449;29304.853475732485;29324.706752933052;29365.559516607696;32493.837530812194;33453;33456;33502.497462538566;33523.664763352055;28286;28299.717002829708;28724.712752873038;29371.7062829369;29922;22896.885515572314;23254.418639534146;23269.53460930806;23788.405289867893;24001.15995940134 06:56:57 INFO - PROCESS | 2204 | |2;jquery.html;407.4743580780793;433.9435873336466;441.05834044315395;445.47959267670274;453.7254960748745;19480.31818886341;20598.691019634698;21673;21923.561528769416;22001;22309.44226394341;23853.880730596367;23873.761262387372;23976.681282529455;24124;6502.674866256668;6503.6667483166075;6605.943049112155;6951.930480695204;7302.81742956425;7511.248875112499;7576.696932122709;7623.733169339074;7625.885611715801;7626.008618879538;7446;8016.879746803803;8079.95960020202;8153.836923261531;8175.264226219639;7913.485623434487;7918.0498340198965;7977.720779772709;7993.840123197532;8026.638801253957;7290.927090729131;7372.336489715952;7471.9626401867645;7479;7599.582022988733;21870.89064554683;27226.31934201661;27989.720102798914;28055.43889122206;28096.15711528637;3010.473167195754;3015.6833532479213;3028.8939887104066;3033.848307584612;3107.860146293422;16318.592035199097;16610;16629.584260393465;17232.913835430743;17827.643447131115;2130.744310682728;2136.284344744497;2158.7301587301586;2164.4480657432255;2277.7608351123226;95975.56036659455;118974.81025189724;152123;160782.3921760779;172140;16155.515334539983;18761.81238187628;20171.798282017284;20389.49026274355;20421.285255016002;30778.846105769328;31099.378012439625;31184.68815311818;31322.843385782926;31366.372672546422;9783.266255030901;10041.397516149054;10216.233782466345;10226.888247586736;10370.948145259375;8482.279006284412;8491;8629.697960571475;8661.263792577702;8687.044425113232;7624.733134340271;9156.932427636682;9435.339526233098;9545.236381089497;9549.474778887088;4044.919101617951;4092.6930480214105;4108.732932359387;4111.444954931046;4112.465379500705;1084.766775143332;1094.578587243917;1095.424901926495;1108.5676586131415;1155.445386214605;22366.776332236794;22570.661440078413;24018.75981240165;24763.380915477257;24854.254372368858;1084.479449864054;1110.3282514079028;1136.4315451883383;1144.416347662698;1151.5048529132387;10198.847017294747;11608.767824643628;11697.356645384416;11801;11835.88164118365;826194;832217;832807;835465;849214;169592;172109;172754;172882;179758;1166.055495049013;1261.0542093429929;1292.1730092740654;1323.0407954233103;1323.9606908576914;18477.81522184815;19289.8071019288;19565.70651440258;19654.8207107574;19977.800221997593;63993;64177.03734443893;65050.34949650443;65157.34842651513;65597.34402656103;93671;94544;94547;94946.52526737322;95874;8683.82632347337;9209.86185207209;11536.94231528837;11588.768224635629;11925.940370298093;11219.326840389604;12762.872371276168;12836.743265134459;12897.161684490478;13163.802542962056;10898.346099234072;11291.66125016218;11337.659870203906;11604.07167426587;11614.825777613512;9767.072128147815;10486.685399438029;10560.84158737635;10663.840042399526;10687.946560267148;11616.535338586362;11628.88371116278;11676.770288885928;11830.763384732085;12023.27860328383;10455.68632941013;10808.081313088476;11258.324500529994;11495.54017839277;11685.941570292094;10425.270231083752;11419.257748246337;11482.655520334403;11659.53361865516;11744.471498782405 06:56:57 INFO - PROCESS | 2204 | |3;mootools.html;1244.390248778099;1627.422265095891;1649.8515133637975;1655.875809314301;1667.316400275887;8529.744107676772;10014.949925250372;10018.949905250473;10173;10180.64367747129;9932.006799320065;10999;11401.885981140185;11409.48657310421;11416.828747568794;2410.95178096438;2468.1978357034036;2471.950560988779;2477.2568229531157;2477.677901872754;2370.849529687549;2469.814763892706;2472.072972635262;2476.6780318558654;2477.5044991001782;2090.446031801574;2167.219800871685;2394.8802559872024;2474.7896428803483;2482.143660437155;2431.8662473563945;2453.276283496373;2453.4847681986716;2460.1020627470934;2462.482878595479;2440.5362981033545;2445.9266222013366;2449.7672721091467;2450.191436825843;2455.4107014316437;11198.496067676893;11317.981381675607;11345;11511.827322590168;11621.593244236496;5982;6134.4172303631085;6138.8772224555705;6142.969285153546;6147.969260153671;3507.1232191952013;3600.4959305697225;3800.7339486235974;3803.2963901678277;3810.161764411825;1207.3963018490754;1255.0273538008116;1275.5726831511454;1281.3465132782255;1297.0985165310112;15744.68510629781;15953.282102305424;16038.117903515302;16056.11691356975;16064.678706425922;4747.931715364016;4975.751212439363;5019.7239151847;5025.773840177201;5078.847634570895;12901.935490322488;12907.161034532724;12910.354482275849;12946.935265323613;12964.740705186032;5965.612235204698;6022.57841951068;6037.72830222641;6059.272887253558;6086.3000754913755;3993.9201215975518;4311.719738217006;5070.4929507049;5376.677399356051;5471.644343117685;3617.764845285101;4074.124063326399;4179.874603761892;4207.97896010518;4246.893827654333;1132.1545880215197;1141.1897552737482;1147.73602071524;1156.919015668895;1157.6353448663644;945.5414124149781;978.7944531648434;985.0641890204334;995.3878364805593;1002.4586723169407;5820.796272130539;6720.32796720324;6841.17905851301;6988.720451181895;7016.719331226694;999.3454287441738;1023.2274632652449;1029.696239609317;1033.7777377863795;1036.9274150809522;4159.896002599899;4167.1457351242925;4168.520620128664;4184.518780340239;4277.379779931893;13792.034557581073;14175.362108705132;14317;14333.283335833166;14365.856341436453;14182.574522764333;14198.716025679636;14202.218877961604;14224.573262802132;14234.288285585679;10073.445960472098;10408.167346612252;10420.68737937863;10616.097631701392;10622.575096996034;6892.965535172292;6904.378605925491;6938.27148149437;7062.71749130029;7149.928500715135;12163.878361216628;12510.874891251335;12581.056420768662;12834.16577922432;12911.935440322739;12641.178323408949;12817.1668841525;13005.674858128623;13050.869491304966;13099.869001309866;8349.54077525742;9092.454452732858;9466.668666596635;9484.383515071499;9620.903790962;10706.785864282827;10776.407297598707;10876.836847447137;10890.237683362406;10997.780044399227;9120.589573469342;9169.770755730893;9171;9206.309526785652;9232.492212928353;8758.47449153053;8879.778005549913;8953.462792232487;8967.192952634294;9000.189982901571;8071.23323284287;8098.595070246346;8148.103708592169;8213.876791848246;8223.79440513968;5874.735636896436;5919.763209471573;5939.732712027882;6161.907571386343;6169.629822210682;6038.3357830637715;6134.907976380268;6186.443220110212;6197.349278325711;6386.616802991835 06:56:57 INFO - PROCESS | 2204 | |4;prototype.html;334.2429397414857;358.3299230439079;369.698695563116;393.39810090561434;404.67221550544053;4861.295112208728;5009.499050094989;5092.516210959962;5097.915760964619;5106.489351064892;4575.839845605405;5037.798488060474;5101.515356041179;5109.897802043957;5196.907839835301;3511.9824400878088;4095.4471146395153;4173.226378789018;4249.298865687158;4258.701096165668;3583.94624080639;3618.3486972344967;4244.813920830775;4260.147970405916;4345.565443455661;3656.3235801376695;4187.183499217654;4187.932077320294;4332.913341733163;4342.917657402048;3768.8492460301554;4044.6562042226446;4096.303628383182;4335.956640433603;4376.6936314458;3407.4377727674905;3756.718246131551;3935.9139655982376;3938.0548668319684;3950.249452603996;5029.874253143664;5032.018756342514;5036.32009678696;5046.2178362353525;5091.770870310808;4248.787560621957;4377.03705184862;4545.454545454533;4903.8528844134735;5010.398752149729;5363.249145119687;5569.359523654791;5585.994520986221;5593.147494777652;5614.9157762633595;4310.779948326614;4556.5215652356355;4558.794854231567;4568.149899290793;4608.893865472296;5137.201979307212;5200.583953283728;5268.262443257947;5525.972370138164;5748.310202775694;4053.8986525336513;4297.72064815786;4432.711873728197;4483.50681425043;4493.6854420190275;3922.627350401707;4056.3554729834173;4340.435743353407;4566.634669226454;4621.815127394867;4717.78264215818;4741.502142275081;4825.445073816486;4855.344528488608;4961.6526843121355;4925.7783399747095;5192.714400707997;5381.596380271495;5391.757370918318;5405.702686352289;1295.4818072770968;1552.332497026267;1559.5711179425748;1562.8200708465035;1571.4185751272103;1016.9593216271267;1076.9946150269197;1164.1967042740482;1192.5766352944754;1198.298995087866;4388.71473354231;4402.493713222956;4608.953910460852;5119.517034238392;5145.691258524501;4941.925871111936;5204.609654275944;5276.023935571931;5547;5615.721222051258;4545.1366338611915;4765.642576806753;4991.5258050485145;4994.675346102565;5226.8954620908125;2724.5206861755705;2758.8620568971473;2844.208148866201;2848.643919510061;2899.623049003616;5461.863453413617;5490.497791810757;5690.065377771578;5821.767129314865;5840.94159058404;5063.291139240509;5215.713135777492;5245.931130288824;5502.963903355784;5514.228008078872;4699.976500117615;5201.2953264303105;5800.970995145081;5804.970975145097;5849.6782676952325;5299.49654782795;5437.673739575638;5562.16567514876;5608.719564021864;5646.689432081275;4936.506349365035;5345.919811202913;5539.639923405127;5560.833175004756;5578.60949733531;5200.739963001759;5453.400125986059;5734.2258795062135;5739.799107031234;5821.301443826768;4654.906097067254;4723.669343145947;4866.537678920497;5007.843489903445;5034.597232221487;5357.1696387060065;5433.510984011458;5531.557475401878;5667.1782591524825;5734.856628584319;4866.756662166948;4892.951070489249;5196.506331898464;5451.809186678447;5474.014677358114;4846.854594362175;4873.561379475864;5453;5479.629962636559;5514.476124768141;4844.449776071623;5060.873478163076;5215.426303106731;5280.313559237275;5296.907721450083;4566.680332376702;5126;5129.999650068201;5469.316335458067;5485.040117979258;4688.226442637063;4849.442314133919;5146.511081447256;5224.399194092728;5336.946630533645 06:56:57 INFO - PROCESS | 2204 | |5;yui.html;792.0099875156055;817.1134319263595;851.8509260879345;898.5821592959275;899.5007770687268;16616.584585385357;17661.91169044156;17706.20322085506;17829.7325540117;17847.55381115473;16275.59311017225;16316.673666526662;16355.182240887938;16400.75398869015;17145.657086858257;793.4128744728916;995.1242906242533;998.990010099897;999.9800003999916;1000.2098342309566;999.5901680311074;1027.825269704152;1028.8456731490262;1029.8918613545582;1030.721705139612;1053.2785042246087;1053.8682664666917;1054.7890421915647;1056.281728424671;1059.5285098131335;875.4922145155795;1049.1449468683038;1049.7847941172042;1051.0067985753467;1051.984220236697;774.3804956035206;775.5889378629336;777;777.6928113395177;781.3007358414187;16245.91877040619;17213.913930430394;17305.7404138938;18381.356652517232;18726.344577939843;14550.854491455162;14845;14971.401143954228;15027.09837409748;15216.923915380463;11824.785515708923;12202;12328;12393.62819115428;12648.873511264861;3798.9810050949845;3813;3829.6936245100324;3914.197589494147;3928.4500169976227;120651.3967430166;124240.9999999991;126382;129295;132160.33919830338;11219.439028048564;11298.435078246219;11306.94346528262;11379.943100284445;11712.824307635392;22091.889540552515;22822.65766013511;24043;24452;24491.38771530726;8066.908946084603;8094.190580941977;8170.959145204236;8180.059293181242;8427.367947403847;4608.953910460919;4613.169629466661;4699.154152252628;4721.480637129913;4781.330613714083;3255.7720959532603;3345.5985281766343;3413.965860341365;3424.6917777400154;3427.4516077427493;627.9529035322369;630.7350912616712;643.5945354426775;644.458654730029;649.422014407178;698.7100353353403;718.4288490649841;739.4343327354578;743.3384287983699;744.408195484591;10343.37939723619;10481.37111773296;10521.248933087181;10559.683209503728;10952.780944381228;697.8674051930117;706.6820379991382;714.4712912444858;744.6686224629988;750.3471979377977;4789.114013907439;5027.82402615914;5066.189409694432;5066.569341606005;5087.923681144785;97346.02653973369;100466;104134;105051;108147.91852081536;83148.58425707833;87287.56356218306;97480.51259743657;99221.5116773249;99387.50306248422;80134.59932700299;81869;82750.58624706838;84097.99999999878;86353.5682321597;9751.609935602497;9795.314327996972;9850.655227067306;9851.901480985385;9852.064053914866;49457.752711237656;55433;56034;56369;57488.71255643695;62214.68892655689;62635.6868215656;72579;73322.63338683272;76833.84749228878;13104.475820967436;13377.933110334387;13435.462581496631;13821.654458638615;14038.78941815894;15704.764428533352;15958.441454549034;16193;16336.918315408348;16589.75115373246;14143.363548640542;14591.489297874523;14592.124472531683;14852;15478.226088695745;13758.380872860545;13885.791713124108;14530.782038269223;14548.781768273697;14624.70750584961;13478.528251511543;14233.217173055167;14588.635284117981;14978.325975330918;15118.924405377902;9953.601855925683;10021.298509104292;10358.223133264884;10456.006679365448;10780.838287425539;9975;10989.835152472879;12345;12353;12638.55765048219 06:56:57 INFO - PROCESS | 2204 | __end_tp_report 06:56:57 INFO - PROCESS | 2204 | __start_cc_report 06:56:57 INFO - PROCESS | 2204 | _x_x_mozilla_cycle_collect,1662 06:56:57 INFO - PROCESS | 2204 | __end_cc_report 06:56:57 INFO - PROCESS | 2204 | __startTimestamp1492523817307__endTimestamp 06:56:57 INFO - PROCESS | 2204 | 06:56:57 INFO - PROCESS | 2204 | ------- Summary: start ------- 06:56:57 INFO - PROCESS | 2204 | Number of tests: 6 06:56:57 INFO - PROCESS | 2204 | 06:56:57 INFO - PROCESS | 2204 | [#0] dojo.html Cycles:165 Average:6116.35 Median:6328.78 stddev:663.34 (10.5%) stddev-sans-first:633.89 06:56:57 INFO - PROCESS | 2204 | Values: 3541.8 3548.1 3575.0 3589.5 3595.5 6251.9 6256.7 6279.6 6303.2 6311.6 6280.6 6312.0 6314.1 6320.1 6324.9 5578.2 5600.7 5606.5 5635.3 5707.4 4921.1 5399.4 5444.3 5507.3 5709.5 5572.3 5584.5 5591.6 5597.9 5642.9 5622.5 5623.6 5655.4 5664.2 5668.3 5471.9 5540.1 5561.4 5620.7 5623.8 6109.9 6136.4 6136.5 6160.5 6167.6 5557.5 6535.4 6568.1 6597.7 6602.9 6615.9 6624.6 6665.8 6678.9 6685.8 6145.6 6185.8 6283.7 6329.1 6393.8 6222.0 6591.0 6592.4 6615.4 6715.5 6016.8 6485.8 6490.9 6499.3 6504.4 6585.9 6646.0 6661.6 6668.8 6690.6 6275.7 6309.3 6561.8 6571.3 6577.7 6445.1 6452.9 6477.0 6491.9 6497.7 5277.7 5312.9 5326.2 5336.8 5344.1 4756.0 4761.1 4765.6 4766.9 4805.7 6104.8 6161.6 6195.0 6213.8 6216.5 6547.2 6551.8 6659.0 6672.8 6684.6 6237.5 6328.8 6330.7 6339.5 6344.8 5657.6 5801.0 5877.2 5892.9 5894.7 5620.4 6680.9 6700.7 6703.9 6706.9 6450.6 6458.2 6465.5 6475.1 6550.0 5632.7 6923.5 6926.4 6939.7 6950.7 6602.6 6609.7 6617.7 6621.9 6622.9 6365.8 6586.1 6682.3 6699.1 6701.3 6328.0 6451.5 6505.0 6512.5 6521.9 6484.1 6493.7 6495.7 6511.4 6520.7 6258.6 6296.2 6355.7 6367.9 6380.0 6310.4 6352.8 6370.5 6372.6 6389.8 6317.6 6326.1 6336.3 6345.7 6349.5 06:56:57 INFO - PROCESS | 2204 | 06:56:57 INFO - PROCESS | 2204 | [#1] ext.html Cycles:180 Average:58593.48 Median:29705.35 stddev:124470.55 (419.0%) stddev-sans-first:124744.15 06:56:57 INFO - PROCESS | 2204 | Values: 823.4 915.5 926.2 926.5 1012.0 38389.6 38920.8 40699.0 40735.2 40873.4 38948.2 39071.8 39098.8 39136.4 39162.0 8016.1 8145.6 8285.1 8385.6 8388.5 11627.2 11854.2 12052.5 12071.0 12071.9 11886.5 11892.8 11903.0 11920.7 11942.6 11822.1 11863.4 11865.3 11871.8 11881.9 11618.8 11667.1 11679.9 11687.6 11687.8 33406.3 40501.0 40764.6 40808.0 40838.8 3991.7 4044.5 4046.7 4056.8 4075.2 28466.0 28650.1 29884.9 30745.9 30792.8 3121.5 3282.5 3305.1 3313.6 3378.7 345275.0 349570.0 349629.0 349774.0 349943.0 45097.0 45231.5 53865.0 53947.5 56757.7 54137.7 54305.7 57284.9 57326.0 57419.0 15856.0 15935.2 15938.5 15940.8 15968.0 13362.5 13387.3 13402.4 13439.0 13451.7 11164.5 13516.2 13593.3 13653.5 13719.7 5533.5 5936.4 6154.3 6157.2 6201.8 1135.9 1136.5 1143.8 1147.6 1190.5 26343.0 27143.7 27480.6 27635.3 28024.7 1086.9 1271.6 1274.6 1280.9 1326.1 14076.4 14218.0 14569.5 14587.0 14598.6 522704.0 529861.0 533487.0 651768.0 655123.7 50788.2 51210.7 51255.7 51260.0 51343.7 1428.8 1479.7 1485.0 1486.9 1494.4 27491.0 27610.6 28225.7 28460.9 28642.0 42220.6 42513.6 42520.8 42616.0 42630.6 436514.0 438981.0 439469.0 440334.0 440907.8 25664.2 26033.3 26797.3 28370.8 30493.4 32543.5 34018.3 37602.4 39859.2 39901.4 28387.0 28762.0 29142.0 29257.3 29525.9 27974.4 29192.3 29304.9 29324.7 29365.6 32493.8 33453.0 33456.0 33502.5 33523.7 28286.0 28299.7 28724.7 29371.7 29922.0 22896.9 23254.4 23269.5 23788.4 24001.2 06:56:57 INFO - PROCESS | 2204 | 06:56:57 INFO - PROCESS | 2204 | [#2] jquery.html Cycles:180 Average:46091.09 Median:22338.11 stddev:138896.52 (621.8%) stddev-sans-first:139243.80 06:56:57 INFO - PROCESS | 2204 | Values: 407.5 433.9 441.1 445.5 453.7 19480.3 20598.7 21673.0 21923.6 22001.0 22309.4 23853.9 23873.8 23976.7 24124.0 6502.7 6503.7 6605.9 6951.9 7302.8 7511.2 7576.7 7623.7 7625.9 7626.0 7446.0 8016.9 8080.0 8153.8 8175.3 7913.5 7918.0 7977.7 7993.8 8026.6 7290.9 7372.3 7472.0 7479.0 7599.6 21870.9 27226.3 27989.7 28055.4 28096.2 3010.5 3015.7 3028.9 3033.8 3107.9 16318.6 16610.0 16629.6 17232.9 17827.6 2130.7 2136.3 2158.7 2164.4 2277.8 95975.6 118974.8 152123.0 160782.4 172140.0 16155.5 18761.8 20171.8 20389.5 20421.3 30778.8 31099.4 31184.7 31322.8 31366.4 9783.3 10041.4 10216.2 10226.9 10370.9 8482.3 8491.0 8629.7 8661.3 8687.0 7624.7 9156.9 9435.3 9545.2 9549.5 4044.9 4092.7 4108.7 4111.4 4112.5 1084.8 1094.6 1095.4 1108.6 1155.4 22366.8 22570.7 24018.8 24763.4 24854.3 1084.5 1110.3 1136.4 1144.4 1151.5 10198.8 11608.8 11697.4 11801.0 11835.9 826194.0 832217.0 832807.0 835465.0 849214.0 169592.0 172109.0 172754.0 172882.0 179758.0 1166.1 1261.1 1292.2 1323.0 1324.0 18477.8 19289.8 19565.7 19654.8 19977.8 63993.0 64177.0 65050.3 65157.3 65597.3 93671.0 94544.0 94547.0 94946.5 95874.0 8683.8 9209.9 11536.9 11588.8 11925.9 11219.3 12762.9 12836.7 12897.2 13163.8 10898.3 11291.7 11337.7 11604.1 11614.8 9767.1 10486.7 10560.8 10663.8 10687.9 11616.5 11628.9 11676.8 11830.8 12023.3 10455.7 10808.1 11258.3 11495.5 11685.9 10425.3 11419.3 11482.7 11659.5 11744.5 06:56:57 INFO - PROCESS | 2204 | 06:56:57 INFO - PROCESS | 2204 | [#3] mootools.html Cycles:180 Average:6935.41 Median:2472.01 stddev:4373.66 (176.9%) stddev-sans-first:4365.02 06:56:57 INFO - PROCESS | 2204 | Values: 1244.4 1627.4 1649.9 1655.9 1667.3 8529.7 10014.9 10018.9 10173.0 10180.6 9932.0 10999.0 11401.9 11409.5 11416.8 2411.0 2468.2 2472.0 2477.3 2477.7 2370.8 2469.8 2472.1 2476.7 2477.5 2090.4 2167.2 2394.9 2474.8 2482.1 2431.9 2453.3 2453.5 2460.1 2462.5 2440.5 2445.9 2449.8 2450.2 2455.4 11198.5 11318.0 11345.0 11511.8 11621.6 5982.0 6134.4 6138.9 6143.0 6148.0 3507.1 3600.5 3800.7 3803.3 3810.2 1207.4 1255.0 1275.6 1281.3 1297.1 15744.7 15953.3 16038.1 16056.1 16064.7 4747.9 4975.8 5019.7 5025.8 5078.8 12901.9 12907.2 12910.4 12946.9 12964.7 5965.6 6022.6 6037.7 6059.3 6086.3 3993.9 4311.7 5070.5 5376.7 5471.6 3617.8 4074.1 4179.9 4208.0 4246.9 1132.2 1141.2 1147.7 1156.9 1157.6 945.5 978.8 985.1 995.4 1002.5 5820.8 6720.3 6841.2 6988.7 7016.7 999.3 1023.2 1029.7 1033.8 1036.9 4159.9 4167.1 4168.5 4184.5 4277.4 13792.0 14175.4 14317.0 14333.3 14365.9 14182.6 14198.7 14202.2 14224.6 14234.3 10073.4 10408.2 10420.7 10616.1 10622.6 6893.0 6904.4 6938.3 7062.7 7149.9 12163.9 12510.9 12581.1 12834.2 12911.9 12641.2 12817.2 13005.7 13050.9 13099.9 8349.5 9092.5 9466.7 9484.4 9620.9 10706.8 10776.4 10876.8 10890.2 10997.8 9120.6 9169.8 9171.0 9206.3 9232.5 8758.5 8879.8 8953.5 8967.2 9000.2 8071.2 8098.6 8148.1 8213.9 8223.8 5874.7 5919.8 5939.7 6161.9 6169.6 6038.3 6134.9 6186.4 6197.3 6386.6 06:56:57 INFO - PROCESS | 2204 | 06:56:57 INFO - PROCESS | 2204 | [#4] prototype.html Cycles:180 Average:4552.24 Median:4976.59 stddev:1258.26 (25.3%) stddev-sans-first:1221.31 06:56:57 INFO - PROCESS | 2204 | Values: 334.2 358.3 369.7 393.4 404.7 4861.3 5009.5 5092.5 5097.9 5106.5 4575.8 5037.8 5101.5 5109.9 5196.9 3512.0 4095.4 4173.2 4249.3 4258.7 3583.9 3618.3 4244.8 4260.1 4345.6 3656.3 4187.2 4187.9 4332.9 4342.9 3768.8 4044.7 4096.3 4336.0 4376.7 3407.4 3756.7 3935.9 3938.1 3950.2 5029.9 5032.0 5036.3 5046.2 5091.8 4248.8 4377.0 4545.5 4903.9 5010.4 5363.2 5569.4 5586.0 5593.1 5614.9 4310.8 4556.5 4558.8 4568.1 4608.9 5137.2 5200.6 5268.3 5526.0 5748.3 4053.9 4297.7 4432.7 4483.5 4493.7 3922.6 4056.4 4340.4 4566.6 4621.8 4717.8 4741.5 4825.4 4855.3 4961.7 4925.8 5192.7 5381.6 5391.8 5405.7 1295.5 1552.3 1559.6 1562.8 1571.4 1017.0 1077.0 1164.2 1192.6 1198.3 4388.7 4402.5 4609.0 5119.5 5145.7 4941.9 5204.6 5276.0 5547.0 5615.7 4545.1 4765.6 4991.5 4994.7 5226.9 2724.5 2758.9 2844.2 2848.6 2899.6 5461.9 5490.5 5690.1 5821.8 5840.9 5063.3 5215.7 5245.9 5503.0 5514.2 4700.0 5201.3 5801.0 5805.0 5849.7 5299.5 5437.7 5562.2 5608.7 5646.7 4936.5 5345.9 5539.6 5560.8 5578.6 5200.7 5453.4 5734.2 5739.8 5821.3 4654.9 4723.7 4866.5 5007.8 5034.6 5357.2 5433.5 5531.6 5667.2 5734.9 4866.8 4893.0 5196.5 5451.8 5474.0 4846.9 4873.6 5453.0 5479.6 5514.5 4844.4 5060.9 5215.4 5280.3 5296.9 4566.7 5126.0 5130.0 5469.3 5485.0 4688.2 4849.4 5146.5 5224.4 5336.9 06:56:57 INFO - PROCESS | 2204 | 06:56:57 INFO - PROCESS | 2204 | [#5] yui.html Cycles:180 Average:22016.88 Median:20409.12 stddev:31878.34 (156.2%) stddev-sans-first:31927.93 06:56:57 INFO - PROCESS | 2204 | Values: 792.0 817.1 851.9 898.6 899.5 16616.6 17661.9 17706.2 17829.7 17847.6 16275.6 16316.7 16355.2 16400.8 17145.7 793.4 995.1 999.0 1000.0 1000.2 999.6 1027.8 1028.8 1029.9 1030.7 1053.3 1053.9 1054.8 1056.3 1059.5 875.5 1049.1 1049.8 1051.0 1052.0 774.4 775.6 777.0 777.7 781.3 16245.9 17213.9 17305.7 18381.4 18726.3 14550.9 14845.0 14971.4 15027.1 15216.9 11824.8 12202.0 12328.0 12393.6 12648.9 3799.0 3813.0 3829.7 3914.2 3928.5 120651.4 124241.0 126382.0 129295.0 132160.3 11219.4 11298.4 11306.9 11379.9 11712.8 22091.9 22822.7 24043.0 24452.0 24491.4 8066.9 8094.2 8171.0 8180.1 8427.4 4609.0 4613.2 4699.2 4721.5 4781.3 3255.8 3345.6 3414.0 3424.7 3427.5 628.0 630.7 643.6 644.5 649.4 698.7 718.4 739.4 743.3 744.4 10343.4 10481.4 10521.2 10559.7 10952.8 697.9 706.7 714.5 744.7 750.3 4789.1 5027.8 5066.2 5066.6 5087.9 97346.0 100466.0 104134.0 105051.0 108147.9 83148.6 87287.6 97480.5 99221.5 99387.5 80134.6 81869.0 82750.6 84098.0 86353.6 9751.6 9795.3 9850.7 9851.9 9852.1 49457.8 55433.0 56034.0 56369.0 57488.7 62214.7 62635.7 72579.0 73322.6 76833.8 13104.5 13377.9 13435.5 13821.7 14038.8 15704.8 15958.4 16193.0 16336.9 16589.8 14143.4 14591.5 14592.1 14852.0 15478.2 13758.4 13885.8 14530.8 14548.8 14624.7 13478.5 14233.2 14588.6 14978.3 15118.9 9953.6 10021.3 10358.2 10456.0 10780.8 9975.0 10989.8 12345.0 12353.0 12638.6 06:56:57 INFO - PROCESS | 2204 | -------- Summary: end -------- 06:56:57 INFO - PROCESS | 2204 | 06:56:57 INFO - TEST-INFO | 2204: exit 0 06:56:57 INFO - TEST-OK | dromaeo_css | took 1118541ms 06:56:57 INFO - TEST-START | kraken 06:56:57 INFO - operating with platform_type : mac_ 06:56:57 INFO - Initialising browser for kraken test... 06:56:57 INFO - TEST-INFO | started process 2208 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/tmp6V4dbo/profile http://localhost:49649/getInfo.html) 06:57:00 INFO - PROCESS | 2208 | __metrics Screen width/height:1600/1200 06:57:00 INFO - PROCESS | 2208 | colorDepth:24 06:57:00 INFO - PROCESS | 2208 | Browser inner width/height: 1024/689 06:57:00 INFO - PROCESS | 2208 | __metrics 06:57:00 INFO - PROCESS | 2208 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:57:00 INFO - PROCESS | 2208 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:57:01 INFO - TEST-INFO | 2208: exit 0 06:57:01 INFO - Browser initialized. 06:57:01 INFO - Running cycle 1/1 for kraken test... 06:57:01 INFO - TEST-INFO | started process 2210 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/T/tmp6V4dbo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:57:13 INFO - PROCESS | 2210 | RSS: Main: 164933632 06:57:13 INFO - PROCESS | 2210 | 06:57:15 INFO - PROCESS | 2210 | Cycle 1(1): loaded http://localhost:49649/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49649/tests/kraken/driver.html?testName=audio-beat-detection) 06:57:16 INFO - PROCESS | 2210 | RSS: Main: 216133632 06:57:16 INFO - PROCESS | 2210 | 06:57:19 INFO - PROCESS | 2210 | Cycle 1(1): loaded http://localhost:49649/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49649/tests/kraken/driver.html?testName=audio-dft) 06:57:19 INFO - PROCESS | 2210 | RSS: Main: 231129088 06:57:19 INFO - PROCESS | 2210 | 06:57:23 INFO - PROCESS | 2210 | Cycle 1(1): loaded http://localhost:49649/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49649/tests/kraken/driver.html?testName=audio-fft) 06:57:23 INFO - PROCESS | 2210 | RSS: Main: 327483392 06:57:23 INFO - PROCESS | 2210 | 06:57:25 INFO - PROCESS | 2210 | Cycle 1(1): loaded http://localhost:49649/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49649/tests/kraken/driver.html?testName=audio-oscillator) 06:57:26 INFO - PROCESS | 2210 | RSS: Main: 231309312 06:57:26 INFO - PROCESS | 2210 | 06:57:28 INFO - PROCESS | 2210 | Cycle 1(1): loaded http://localhost:49649/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49649/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:57:28 INFO - PROCESS | 2210 | RSS: Main: 232996864 06:57:28 INFO - PROCESS | 2210 | 06:57:31 INFO - PROCESS | 2210 | Cycle 1(1): loaded http://localhost:49649/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49649/tests/kraken/driver.html?testName=imaging-darkroom) 06:57:32 INFO - PROCESS | 2210 | RSS: Main: 273727488 06:57:32 INFO - PROCESS | 2210 | 06:57:35 INFO - PROCESS | 2210 | Cycle 1(1): loaded http://localhost:49649/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49649/tests/kraken/driver.html?testName=imaging-desaturate) 06:57:36 INFO - PROCESS | 2210 | RSS: Main: 274788352 06:57:36 INFO - PROCESS | 2210 | 06:57:38 INFO - PROCESS | 2210 | Cycle 1(1): loaded http://localhost:49649/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49649/tests/kraken/driver.html?testName=json-parse-financial) 06:57:39 INFO - PROCESS | 2210 | RSS: Main: 269778944 06:57:39 INFO - PROCESS | 2210 | 06:57:41 INFO - PROCESS | 2210 | Cycle 1(1): loaded http://localhost:49649/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49649/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:57:41 INFO - PROCESS | 2210 | RSS: Main: 246423552 06:57:41 INFO - PROCESS | 2210 | 06:57:43 INFO - PROCESS | 2210 | Cycle 1(1): loaded http://localhost:49649/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49649/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:57:44 INFO - PROCESS | 2210 | RSS: Main: 250920960 06:57:44 INFO - PROCESS | 2210 | 06:57:46 INFO - PROCESS | 2210 | Cycle 1(1): loaded http://localhost:49649/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49649/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:57:47 INFO - PROCESS | 2210 | RSS: Main: 255373312 06:57:47 INFO - PROCESS | 2210 | 06:57:50 INFO - PROCESS | 2210 | Cycle 1(1): loaded http://localhost:49649/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49649/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:57:51 INFO - PROCESS | 2210 | RSS: Main: 272465920 06:57:51 INFO - PROCESS | 2210 | 06:57:53 INFO - PROCESS | 2210 | Cycle 1(1): loaded http://localhost:49649/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49649/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:57:54 INFO - PROCESS | 2210 | RSS: Main: 265936896 06:57:54 INFO - PROCESS | 2210 | 06:57:56 INFO - PROCESS | 2210 | Cycle 1(1): loaded http://localhost:49649/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49649/tests/kraken/driver.html?testName=ai-astar) 06:57:56 INFO - PROCESS | 2210 | RSS: Main: 310267904 06:57:56 INFO - PROCESS | 2210 | 06:57:56 INFO - PROCESS | 2210 | __start_tp_report 06:57:56 INFO - PROCESS | 2210 | _x_x_mozilla_page_load 06:57:56 INFO - PROCESS | 2210 | _x_x_mozilla_page_load_details 06:57:56 INFO - PROCESS | 2210 | |i|pagename|runs| 06:57:56 INFO - PROCESS | 2210 | |0;ai-astar;105;114;114;113;113;114;113;113;114;114 06:57:56 INFO - PROCESS | 2210 | |1;audio-beat-detection;143;107;113;177;139;126;109;109;126;106 06:57:56 INFO - PROCESS | 2210 | |2;audio-dft;183;182;184;183;183;183;182;182;182;191 06:57:56 INFO - PROCESS | 2210 | |3;audio-fft;82;59;59;93;63;60;60;59;74;60 06:57:56 INFO - PROCESS | 2210 | |4;audio-oscillator;91;69;86;68;69;68;81;69;68;82 06:57:56 INFO - PROCESS | 2210 | |5;imaging-gaussian-blur;86;86;86;87;86;86;86;85;86;86 06:57:56 INFO - PROCESS | 2210 | |6;imaging-darkroom;106;147;93;93;93;105;150;93;94;93 06:57:56 INFO - PROCESS | 2210 | |7;imaging-desaturate;84;86;83;84;83;83;83;83;82;80 06:57:56 INFO - PROCESS | 2210 | |8;json-parse-financial;63;59;58;58;58;63;63;64;63;65 06:57:56 INFO - PROCESS | 2210 | |9;json-stringify-tinderbox;60;68;74;65;63;62;83;84;83;59 06:57:56 INFO - PROCESS | 2210 | |10;stanford-crypto-aes;83;81;85;87;100;97;97;85;80;84 06:57:56 INFO - PROCESS | 2210 | |11;stanford-crypto-ccm;133;137;145;148;132;137;140;148;167;159 06:57:56 INFO - PROCESS | 2210 | |12;stanford-crypto-pbkdf2;141;207;210;161;163;160;201;187;160;162 06:57:56 INFO - PROCESS | 2210 | |13;stanford-crypto-sha256-iterative;63;66;58;63;64;63;63;64;63;60 06:57:56 INFO - PROCESS | 2210 | __end_tp_report 06:57:56 INFO - PROCESS | 2210 | __start_cc_report 06:57:56 INFO - PROCESS | 2210 | _x_x_mozilla_cycle_collect,2196 06:57:56 INFO - PROCESS | 2210 | __end_cc_report 06:57:56 INFO - PROCESS | 2210 | __startTimestamp1492523876545__endTimestamp 06:57:56 INFO - PROCESS | 2210 | 06:57:56 INFO - PROCESS | 2210 | ------- Summary: start ------- 06:57:56 INFO - PROCESS | 2210 | Number of tests: 14 06:57:56 INFO - PROCESS | 2210 | 06:57:56 INFO - PROCESS | 2210 | [#0] ai-astar Cycles:10 Average:112.70 Median:114.00 stddev:2.75 (2.4%) stddev-sans-first:0.53 06:57:56 INFO - PROCESS | 2210 | Values: 105.0 114.0 114.0 113.0 113.0 114.0 113.0 113.0 114.0 114.0 06:57:56 INFO - PROCESS | 2210 | 06:57:56 INFO - PROCESS | 2210 | [#1] audio-beat-detection Cycles:10 Average:125.50 Median:126.00 stddev:22.52 (17.9%) stddev-sans-first:22.98 06:57:56 INFO - PROCESS | 2210 | Values: 143.0 107.0 113.0 177.0 139.0 126.0 109.0 109.0 126.0 106.0 06:57:56 INFO - PROCESS | 2210 | 06:57:56 INFO - PROCESS | 2210 | [#2] audio-dft Cycles:10 Average:183.50 Median:183.00 stddev:2.72 (1.5%) stddev-sans-first:2.88 06:57:56 INFO - PROCESS | 2210 | Values: 183.0 182.0 184.0 183.0 183.0 183.0 182.0 182.0 182.0 191.0 06:57:56 INFO - PROCESS | 2210 | 06:57:56 INFO - PROCESS | 2210 | [#3] audio-fft Cycles:10 Average:66.90 Median:61.50 stddev:12.04 (19.6%) stddev-sans-first:11.46 06:57:56 INFO - PROCESS | 2210 | Values: 82.0 59.0 59.0 93.0 63.0 60.0 60.0 59.0 74.0 60.0 06:57:56 INFO - PROCESS | 2210 | 06:57:56 INFO - PROCESS | 2210 | [#4] audio-oscillator Cycles:10 Average:75.10 Median:75.00 stddev:8.92 (11.9%) stddev-sans-first:7.38 06:57:56 INFO - PROCESS | 2210 | Values: 91.0 69.0 86.0 68.0 69.0 68.0 81.0 69.0 68.0 82.0 06:57:56 INFO - PROCESS | 2210 | 06:57:56 INFO - PROCESS | 2210 | [#5] imaging-gaussian-blur Cycles:10 Average:86.00 Median:86.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 06:57:56 INFO - PROCESS | 2210 | Values: 86.0 86.0 86.0 87.0 86.0 86.0 86.0 85.0 86.0 86.0 06:57:56 INFO - PROCESS | 2210 | 06:57:56 INFO - PROCESS | 2210 | [#6] imaging-darkroom Cycles:10 Average:106.70 Median:93.00 stddev:22.61 (24.3%) stddev-sans-first:23.98 06:57:56 INFO - PROCESS | 2210 | Values: 106.0 147.0 93.0 93.0 93.0 105.0 150.0 93.0 94.0 93.0 06:57:56 INFO - PROCESS | 2210 | 06:57:56 INFO - PROCESS | 2210 | [#7] imaging-desaturate Cycles:10 Average:83.10 Median:83.00 stddev:1.52 (1.8%) stddev-sans-first:1.58 06:57:56 INFO - PROCESS | 2210 | Values: 84.0 86.0 83.0 84.0 83.0 83.0 83.0 83.0 82.0 80.0 06:57:56 INFO - PROCESS | 2210 | 06:57:56 INFO - PROCESS | 2210 | [#8] json-parse-financial Cycles:10 Average:61.40 Median:63.00 stddev:2.80 (4.4%) stddev-sans-first:2.91 06:57:56 INFO - PROCESS | 2210 | Values: 63.0 59.0 58.0 58.0 58.0 63.0 63.0 64.0 63.0 65.0 06:57:56 INFO - PROCESS | 2210 | 06:57:56 INFO - PROCESS | 2210 | [#9] json-stringify-tinderbox Cycles:10 Average:70.10 Median:71.00 stddev:10.07 (14.2%) stddev-sans-first:10.00 06:57:56 INFO - PROCESS | 2210 | Values: 60.0 68.0 74.0 65.0 63.0 62.0 83.0 84.0 83.0 59.0 06:57:56 INFO - PROCESS | 2210 | 06:57:56 INFO - PROCESS | 2210 | [#10] stanford-crypto-aes Cycles:10 Average:87.90 Median:85.00 stddev:7.29 (8.6%) stddev-sans-first:7.52 06:57:56 INFO - PROCESS | 2210 | Values: 83.0 81.0 85.0 87.0 100.0 97.0 97.0 85.0 80.0 84.0 06:57:56 INFO - PROCESS | 2210 | 06:57:56 INFO - PROCESS | 2210 | [#11] stanford-crypto-ccm Cycles:10 Average:144.60 Median:146.50 stddev:11.36 (7.8%) stddev-sans-first:11.25 06:57:56 INFO - PROCESS | 2210 | Values: 133.0 137.0 145.0 148.0 132.0 137.0 140.0 148.0 167.0 159.0 06:57:56 INFO - PROCESS | 2210 | 06:57:56 INFO - PROCESS | 2210 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.20 Median:175.00 stddev:24.00 (13.7%) stddev-sans-first:22.03 06:57:56 INFO - PROCESS | 2210 | Values: 141.0 207.0 210.0 161.0 163.0 160.0 201.0 187.0 160.0 162.0 06:57:56 INFO - PROCESS | 2210 | 06:57:56 INFO - PROCESS | 2210 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:63.00 stddev:2.21 (3.5%) stddev-sans-first:2.35 06:57:56 INFO - PROCESS | 2210 | Values: 63.0 66.0 58.0 63.0 64.0 63.0 63.0 64.0 63.0 60.0 06:57:56 INFO - PROCESS | 2210 | -------- Summary: end -------- 06:57:56 INFO - PROCESS | 2210 | 06:57:57 INFO - TEST-INFO | 2210: exit 0 06:57:57 INFO - TEST-OK | kraken | took 59527ms 06:57:57 INFO - SUITE-END | took 1178s 06:57:57 INFO - Completed test suite (00:19:38) 06:57:57 INFO - javascript benchmark 06:57:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7938.320378909564, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3541.7874927504354, 3548.0774998500383, 3574.9642503574973, 3589.5154154189177, 3595.514605528253, 6251.906221406677, 6256.718447669854, 6279.560430769837, 6303.180586523751, 6311.62130272184, 6280.617638737919, 6311.968440157804, 6314.0844577536345, 6320.115183874262, 6324.905126423096, 5578.219049333096, 5600.747966341504, 5606.467385598372, 5635.3237611486475, 5707.3721890592005, 4921.114199444099, 5399.352077750676, 5444.292242008533, 5507.311586051744, 5709.457601527848, 5572.331320241577, 5584.497395234428, 5591.608587398884, 5597.944020559783, 5642.887142257153, 5622.522085622727, 5623.550115990732, 5655.3779084300695, 5664.150377443375, 5668.291463567054, 5471.945280547223, 5540.058190107691, 5561.388247292794, 5620.662760234399, 5623.775048998076, 6109.908351374733, 6136.355682653302, 6136.478399336062, 6160.476359509447, 6167.629942203482, 5557.472040156179, 6535.444487218592, 6568.146141001687, 6597.670116494156, 6602.93397066028, 6615.867682646368, 6624.635645039521, 6665.766698165541, 6678.933210667879, 6685.832854178636, 6145.600535965148, 6185.752569897244, 6283.748650054038, 6329.05064240363, 6393.8401539961405, 6222.0355844844125, 6591.011348297794, 6592.373724496261, 6615.437687796495, 6715.496337774686, 6016.789412370546, 6485.805425837232, 6490.902636460457, 6499.252585952581, 6504.38208370204, 6585.9012114818315, 6645.966770166215, 6661.600303981777, 6668.766593169215, 6690.565113267622, 6275.6548389839, 6309.33751956038, 6561.80314590563, 6571.2771595124495, 6577.6711164441585, 6445.065465507475, 6452.903206451907, 6477.0, 6491.870162596816, 6497.740090396425, 5277.709725965109, 5312.867178320573, 5326.201069839555, 5336.813211537577, 5344.091504444254, 4755.976220118877, 4761.142994261067, 4765.642576806753, 4766.856994290177, 4805.735684537314, 6104.7926496150985, 6161.630302181883, 6194.969025154845, 6213.813585592439, 6216.53375996793, 6547.214334279822, 6551.80344589663, 6658.96670516654, 6672.799816005528, 6684.598924064571, 6237.4698150657705, 6328.778492752732, 6330.715117819709, 6339.4611458025665, 6344.841378965562, 5657.57568182388, 5801.0, 5877.177195192677, 5892.94107058924, 5894.734736936848, 5620.353659329147, 6680.933190668031, 6700.6984685688285, 6703.93296067033, 6706.865862682622, 6450.645214513059, 6458.192725909262, 6465.515086368635, 6475.125858009297, 6550.0, 5632.746526406239, 6923.515353925379, 6926.376626103473, 6939.6877140529805, 6950.687219075053, 6602.60384376939, 6609.702563384563, 6617.735290588515, 6621.867562648817, 6622.933770662425, 6365.809025729235, 6586.077949087227, 6682.2649508555, 6699.129113215251, 6701.296363881917, 6327.96836015817, 6451.483881289391, 6505.024246362894, 6512.511561632991, 6521.869562608626, 6484.1246431731115, 6493.740250389931, 6495.675216239264, 6511.446527045065, 6520.706568204537, 6258.561900666909, 6296.244450665767, 6355.713992870239, 6367.93632063692, 6380.0, 6310.432061114522, 6352.841178970562, 6370.458511026614, 6372.58578192416, 6389.808305750835, 6317.557770955989, 6326.051092336186, 6336.271328797247, 6345.682715864281, 6349.4920406366455], "value": 6075.370206652005, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [823.3577809308739, 915.5056269614408, 926.1664501948246, 926.527470989795, 1012.0132870451315, 38389.61610383899, 38920.80539597302, 40699.0, 40735.18529629409, 40873.386899196536, 38948.22103557927, 39071.804640976756, 39098.80450597743, 39136.41295380572, 39162.020949476275, 8016.118226995026, 8145.633446494922, 8285.088640249583, 8385.6226469809, 8388.496690198577, 11627.244229125123, 11854.170208085437, 12052.457639406204, 12071.034317254642, 12071.879281207208, 11886.46510907007, 11892.821607675893, 11903.0, 11920.701982450422, 11942.582009629665, 11822.054235661126, 11863.406829658483, 11865.288082715064, 11871.821922671166, 11881.930626243637, 11618.825717614243, 11667.124965627612, 11679.883201167964, 11687.590934317343, 11687.766244675144, 33406.3318733624, 40501.0, 40764.592354076376, 40807.97980050493, 40838.79580602108, 3991.6607088397523, 4044.534878488982, 4046.6964977626794, 4056.7565946043333, 4075.205334959684, 28466.0, 28650.14049578516, 29884.8505757472, 30745.92389266387, 30792.84603576968, 3121.4693502104697, 3282.4748040313675, 3305.058058453329, 3313.5692359993045, 3378.6621337866263, 345275.0, 349570.0, 349629.0, 349773.99999999744, 349943.0, 45097.0, 45231.54768452339, 53865.0, 53947.46052539503, 56757.7162114195, 54137.72931135319, 54305.72847135739, 57284.85430291371, 57326.0, 57419.0, 15856.048637081813, 15935.203239837962, 15938.521844344688, 15940.760888586681, 15968.041917484989, 13362.532311369056, 13387.263700496565, 13402.396892139877, 13439.0, 13451.730965380637, 11164.497597608128, 13516.189028658311, 13593.252371119683, 13653.453861845614, 13719.657008574866, 5533.474319939599, 5936.376680448577, 6154.323024467305, 6157.199564056644, 6201.7519299228425, 1135.9095268542126, 1136.465861045324, 1143.7598104398169, 1147.6384938744436, 1190.5118901250446, 26343.0, 27143.728562714514, 27480.58779118315, 27635.30911727223, 28024.71975280221, 1086.858798261822, 1271.6185144456626, 1274.6494713953737, 1280.8783165599252, 1326.1446367093172, 14076.366563504667, 14218.0, 14569.490067847575, 14586.978911476306, 14598.63503412402, 522704.0, 529861.0, 533487.0, 651768.0, 655123.724381375, 50788.23817642738, 51210.74394628003, 51255.7437212819, 51260.0, 51343.66266192686, 1428.7713965765427, 1479.667074908137, 1485.0198868746575, 1486.8884833637303, 1494.3873012065, 27491.0, 27610.585841211996, 28225.717742822308, 28460.857695711387, 28642.0, 42220.57779422167, 42513.5748642522, 42520.78739606282, 42616.0, 42630.57369426266, 436514.0, 438981.0, 439469.0, 440334.0, 440907.79546102067, 25664.23007309784, 26033.349166270236, 26797.330066748487, 28370.769810273192, 30493.390132197677, 32543.511847321835, 34018.3196336067, 37602.435963460026, 39859.20281594294, 39901.40147897842, 28387.0, 28762.0, 29142.0, 29257.26856828511, 29525.852370738008, 27974.44051119007, 29192.27019324449, 29304.853475732485, 29324.706752933052, 29365.559516607696, 32493.837530812194, 33453.0, 33456.0, 33502.497462538566, 33523.664763352055, 28286.0, 28299.717002829708, 28724.712752873038, 29371.7062829369, 29922.0, 22896.885515572314, 23254.418639534146, 23269.53460930806, 23788.405289867893, 24001.15995940134], "value": 19175.314612214665, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [407.4743580780793, 433.9435873336466, 441.05834044315395, 445.47959267670274, 453.7254960748745, 19480.31818886341, 20598.691019634698, 21673.0, 21923.561528769416, 22001.0, 22309.44226394341, 23853.880730596367, 23873.761262387372, 23976.681282529455, 24124.0, 6502.674866256668, 6503.6667483166075, 6605.943049112155, 6951.930480695204, 7302.81742956425, 7511.248875112499, 7576.696932122709, 7623.733169339074, 7625.885611715801, 7626.008618879538, 7446.0, 8016.879746803803, 8079.95960020202, 8153.836923261531, 8175.264226219639, 7913.485623434487, 7918.0498340198965, 7977.720779772709, 7993.840123197532, 8026.638801253957, 7290.927090729131, 7372.336489715952, 7471.9626401867645, 7479.0, 7599.582022988733, 21870.89064554683, 27226.31934201661, 27989.720102798914, 28055.43889122206, 28096.15711528637, 3010.473167195754, 3015.6833532479213, 3028.8939887104066, 3033.848307584612, 3107.860146293422, 16318.592035199097, 16610.0, 16629.584260393465, 17232.913835430743, 17827.643447131115, 2130.744310682728, 2136.284344744497, 2158.7301587301586, 2164.4480657432255, 2277.7608351123226, 95975.56036659455, 118974.81025189724, 152123.0, 160782.3921760779, 172140.0, 16155.515334539983, 18761.81238187628, 20171.798282017284, 20389.49026274355, 20421.285255016002, 30778.846105769328, 31099.378012439625, 31184.68815311818, 31322.843385782926, 31366.372672546422, 9783.266255030901, 10041.397516149054, 10216.233782466345, 10226.888247586736, 10370.948145259375, 8482.279006284412, 8491.0, 8629.697960571475, 8661.263792577702, 8687.044425113232, 7624.733134340271, 9156.932427636682, 9435.339526233098, 9545.236381089497, 9549.474778887088, 4044.919101617951, 4092.6930480214105, 4108.732932359387, 4111.444954931046, 4112.465379500705, 1084.766775143332, 1094.578587243917, 1095.424901926495, 1108.5676586131415, 1155.445386214605, 22366.776332236794, 22570.661440078413, 24018.75981240165, 24763.380915477257, 24854.254372368858, 1084.479449864054, 1110.3282514079028, 1136.4315451883383, 1144.416347662698, 1151.5048529132387, 10198.847017294747, 11608.767824643628, 11697.356645384416, 11801.0, 11835.88164118365, 826194.0, 832217.0, 832807.0, 835465.0, 849214.0, 169592.0, 172109.0, 172754.0, 172882.0, 179758.0, 1166.055495049013, 1261.0542093429929, 1292.1730092740654, 1323.0407954233103, 1323.9606908576914, 18477.81522184815, 19289.8071019288, 19565.70651440258, 19654.8207107574, 19977.800221997593, 63993.0, 64177.03734443893, 65050.34949650443, 65157.34842651513, 65597.34402656103, 93671.0, 94544.0, 94547.0, 94946.52526737322, 95874.0, 8683.82632347337, 9209.86185207209, 11536.94231528837, 11588.768224635629, 11925.940370298093, 11219.326840389604, 12762.872371276168, 12836.743265134459, 12897.161684490478, 13163.802542962056, 10898.346099234072, 11291.66125016218, 11337.659870203906, 11604.07167426587, 11614.825777613512, 9767.072128147815, 10486.685399438029, 10560.84158737635, 10663.840042399526, 10687.946560267148, 11616.535338586362, 11628.88371116278, 11676.770288885928, 11830.763384732085, 12023.27860328383, 10455.68632941013, 10808.081313088476, 11258.324500529994, 11495.54017839277, 11685.941570292094, 10425.270231083752, 11419.257748246337, 11482.655520334403, 11659.53361865516, 11744.471498782405], "value": 12016.281834226018, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1244.390248778099, 1627.422265095891, 1649.8515133637975, 1655.875809314301, 1667.316400275887, 8529.744107676772, 10014.949925250372, 10018.949905250473, 10173.0, 10180.64367747129, 9932.006799320065, 10999.0, 11401.885981140185, 11409.48657310421, 11416.828747568794, 2410.95178096438, 2468.1978357034036, 2471.950560988779, 2477.2568229531157, 2477.677901872754, 2370.849529687549, 2469.814763892706, 2472.072972635262, 2476.6780318558654, 2477.5044991001782, 2090.446031801574, 2167.219800871685, 2394.8802559872024, 2474.7896428803483, 2482.143660437155, 2431.8662473563945, 2453.276283496373, 2453.4847681986716, 2460.1020627470934, 2462.482878595479, 2440.5362981033545, 2445.9266222013366, 2449.7672721091467, 2450.191436825843, 2455.4107014316437, 11198.496067676893, 11317.981381675607, 11345.0, 11511.827322590168, 11621.593244236496, 5982.0, 6134.4172303631085, 6138.8772224555705, 6142.969285153546, 6147.969260153671, 3507.1232191952013, 3600.4959305697225, 3800.7339486235974, 3803.2963901678277, 3810.161764411825, 1207.3963018490754, 1255.0273538008116, 1275.5726831511454, 1281.3465132782255, 1297.0985165310112, 15744.68510629781, 15953.282102305424, 16038.117903515302, 16056.11691356975, 16064.678706425922, 4747.931715364016, 4975.751212439363, 5019.7239151847, 5025.773840177201, 5078.847634570895, 12901.935490322488, 12907.161034532724, 12910.354482275849, 12946.935265323613, 12964.740705186032, 5965.612235204698, 6022.57841951068, 6037.72830222641, 6059.272887253558, 6086.3000754913755, 3993.9201215975518, 4311.719738217006, 5070.4929507049, 5376.677399356051, 5471.644343117685, 3617.764845285101, 4074.124063326399, 4179.874603761892, 4207.97896010518, 4246.893827654333, 1132.1545880215197, 1141.1897552737482, 1147.73602071524, 1156.919015668895, 1157.6353448663644, 945.5414124149781, 978.7944531648434, 985.0641890204334, 995.3878364805593, 1002.4586723169407, 5820.796272130539, 6720.32796720324, 6841.17905851301, 6988.720451181895, 7016.719331226694, 999.3454287441738, 1023.2274632652449, 1029.696239609317, 1033.7777377863795, 1036.9274150809522, 4159.896002599899, 4167.1457351242925, 4168.520620128664, 4184.518780340239, 4277.379779931893, 13792.034557581073, 14175.362108705132, 14317.0, 14333.283335833166, 14365.856341436453, 14182.574522764333, 14198.716025679636, 14202.218877961604, 14224.573262802132, 14234.288285585679, 10073.445960472098, 10408.167346612252, 10420.68737937863, 10616.097631701392, 10622.575096996034, 6892.965535172292, 6904.378605925491, 6938.27148149437, 7062.71749130029, 7149.928500715135, 12163.878361216628, 12510.874891251335, 12581.056420768662, 12834.16577922432, 12911.935440322739, 12641.178323408949, 12817.1668841525, 13005.674858128623, 13050.869491304966, 13099.869001309866, 8349.54077525742, 9092.454452732858, 9466.668666596635, 9484.383515071499, 9620.903790962, 10706.785864282827, 10776.407297598707, 10876.836847447137, 10890.237683362406, 10997.780044399227, 9120.589573469342, 9169.770755730893, 9171.0, 9206.309526785652, 9232.492212928353, 8758.47449153053, 8879.778005549913, 8953.462792232487, 8967.192952634294, 9000.189982901571, 8071.23323284287, 8098.595070246346, 8148.103708592169, 8213.876791848246, 8223.79440513968, 5874.735636896436, 5919.763209471573, 5939.732712027882, 6161.907571386343, 6169.629822210682, 6038.3357830637715, 6134.907976380268, 6186.443220110212, 6197.349278325711, 6386.616802991835], "value": 5287.394416062182, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.2429397414857, 358.3299230439079, 369.698695563116, 393.39810090561434, 404.67221550544053, 4861.295112208728, 5009.499050094989, 5092.516210959962, 5097.915760964619, 5106.489351064892, 4575.839845605405, 5037.798488060474, 5101.515356041179, 5109.897802043957, 5196.907839835301, 3511.9824400878088, 4095.4471146395153, 4173.226378789018, 4249.298865687158, 4258.701096165668, 3583.94624080639, 3618.3486972344967, 4244.813920830775, 4260.147970405916, 4345.565443455661, 3656.3235801376695, 4187.183499217654, 4187.932077320294, 4332.913341733163, 4342.917657402048, 3768.8492460301554, 4044.6562042226446, 4096.303628383182, 4335.956640433603, 4376.6936314458, 3407.4377727674905, 3756.718246131551, 3935.9139655982376, 3938.0548668319684, 3950.249452603996, 5029.874253143664, 5032.018756342514, 5036.32009678696, 5046.2178362353525, 5091.770870310808, 4248.787560621957, 4377.03705184862, 4545.454545454533, 4903.8528844134735, 5010.398752149729, 5363.249145119687, 5569.359523654791, 5585.994520986221, 5593.147494777652, 5614.9157762633595, 4310.779948326614, 4556.5215652356355, 4558.794854231567, 4568.149899290793, 4608.893865472296, 5137.201979307212, 5200.583953283728, 5268.262443257947, 5525.972370138164, 5748.310202775694, 4053.8986525336513, 4297.72064815786, 4432.711873728197, 4483.50681425043, 4493.6854420190275, 3922.627350401707, 4056.3554729834173, 4340.435743353407, 4566.634669226454, 4621.815127394867, 4717.78264215818, 4741.502142275081, 4825.445073816486, 4855.344528488608, 4961.6526843121355, 4925.7783399747095, 5192.714400707997, 5381.596380271495, 5391.757370918318, 5405.702686352289, 1295.4818072770968, 1552.332497026267, 1559.5711179425748, 1562.8200708465035, 1571.4185751272103, 1016.9593216271267, 1076.9946150269197, 1164.1967042740482, 1192.5766352944754, 1198.298995087866, 4388.71473354231, 4402.493713222956, 4608.953910460852, 5119.517034238392, 5145.691258524501, 4941.925871111936, 5204.609654275944, 5276.023935571931, 5547.0, 5615.721222051258, 4545.1366338611915, 4765.642576806753, 4991.5258050485145, 4994.675346102565, 5226.8954620908125, 2724.5206861755705, 2758.8620568971473, 2844.208148866201, 2848.643919510061, 2899.623049003616, 5461.863453413617, 5490.497791810757, 5690.065377771578, 5821.767129314865, 5840.94159058404, 5063.291139240509, 5215.713135777492, 5245.931130288824, 5502.963903355784, 5514.228008078872, 4699.976500117615, 5201.2953264303105, 5800.970995145081, 5804.970975145097, 5849.6782676952325, 5299.49654782795, 5437.673739575638, 5562.16567514876, 5608.719564021864, 5646.689432081275, 4936.506349365035, 5345.919811202913, 5539.639923405127, 5560.833175004756, 5578.60949733531, 5200.739963001759, 5453.400125986059, 5734.2258795062135, 5739.799107031234, 5821.301443826768, 4654.906097067254, 4723.669343145947, 4866.537678920497, 5007.843489903445, 5034.597232221487, 5357.1696387060065, 5433.510984011458, 5531.557475401878, 5667.1782591524825, 5734.856628584319, 4866.756662166948, 4892.951070489249, 5196.506331898464, 5451.809186678447, 5474.014677358114, 4846.854594362175, 4873.561379475864, 5453.0, 5479.629962636559, 5514.476124768141, 4844.449776071623, 5060.873478163076, 5215.426303106731, 5280.313559237275, 5296.907721450083, 4566.680332376702, 5126.0, 5129.999650068201, 5469.316335458067, 5485.040117979258, 4688.226442637063, 4849.442314133919, 5146.511081447256, 5224.399194092728, 5336.946630533645], "value": 4181.563689103195, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [792.0099875156055, 817.1134319263595, 851.8509260879345, 898.5821592959275, 899.5007770687268, 16616.584585385357, 17661.91169044156, 17706.20322085506, 17829.7325540117, 17847.55381115473, 16275.59311017225, 16316.673666526662, 16355.182240887938, 16400.75398869015, 17145.657086858257, 793.4128744728916, 995.1242906242533, 998.990010099897, 999.9800003999916, 1000.2098342309566, 999.5901680311074, 1027.825269704152, 1028.8456731490262, 1029.8918613545582, 1030.721705139612, 1053.2785042246087, 1053.8682664666917, 1054.7890421915647, 1056.281728424671, 1059.5285098131335, 875.4922145155795, 1049.1449468683038, 1049.7847941172042, 1051.0067985753467, 1051.984220236697, 774.3804956035206, 775.5889378629336, 777.0, 777.6928113395177, 781.3007358414187, 16245.91877040619, 17213.913930430394, 17305.7404138938, 18381.356652517232, 18726.344577939843, 14550.854491455162, 14845.0, 14971.401143954228, 15027.09837409748, 15216.923915380463, 11824.785515708923, 12202.0, 12328.0, 12393.62819115428, 12648.873511264861, 3798.9810050949845, 3813.0, 3829.6936245100324, 3914.197589494147, 3928.4500169976227, 120651.3967430166, 124240.9999999991, 126382.0, 129295.0, 132160.33919830338, 11219.439028048564, 11298.435078246219, 11306.94346528262, 11379.943100284445, 11712.824307635392, 22091.889540552515, 22822.65766013511, 24043.0, 24452.0, 24491.38771530726, 8066.908946084603, 8094.190580941977, 8170.959145204236, 8180.059293181242, 8427.367947403847, 4608.953910460919, 4613.169629466661, 4699.154152252628, 4721.480637129913, 4781.330613714083, 3255.7720959532603, 3345.5985281766343, 3413.965860341365, 3424.6917777400154, 3427.4516077427493, 627.9529035322369, 630.7350912616712, 643.5945354426775, 644.458654730029, 649.422014407178, 698.7100353353403, 718.4288490649841, 739.4343327354578, 743.3384287983699, 744.408195484591, 10343.37939723619, 10481.37111773296, 10521.248933087181, 10559.683209503728, 10952.780944381228, 697.8674051930117, 706.6820379991382, 714.4712912444858, 744.6686224629988, 750.3471979377977, 4789.114013907439, 5027.82402615914, 5066.189409694432, 5066.569341606005, 5087.923681144785, 97346.02653973369, 100466.0, 104134.0, 105051.0, 108147.91852081536, 83148.58425707833, 87287.56356218306, 97480.51259743657, 99221.5116773249, 99387.50306248422, 80134.59932700299, 81869.0, 82750.58624706838, 84097.99999999878, 86353.5682321597, 9751.609935602497, 9795.314327996972, 9850.655227067306, 9851.901480985385, 9852.064053914866, 49457.752711237656, 55433.0, 56034.0, 56369.0, 57488.71255643695, 62214.68892655689, 62635.6868215656, 72579.0, 73322.63338683272, 76833.84749228878, 13104.475820967436, 13377.933110334387, 13435.462581496631, 13821.654458638615, 14038.78941815894, 15704.764428533352, 15958.441454549034, 16193.0, 16336.918315408348, 16589.75115373246, 14143.363548640542, 14591.489297874523, 14592.124472531683, 14852.0, 15478.226088695745, 13758.380872860545, 13885.791713124108, 14530.782038269223, 14548.781768273697, 14624.70750584961, 13478.528251511543, 14233.217173055167, 14588.635284117981, 14978.325975330918, 15118.924405377902, 9953.601855925683, 10021.298509104292, 10358.223133264884, 10456.006679365448, 10780.838287425539, 9975.0, 10989.835152472879, 12345.0, 12353.0, 12638.55765048219], "value": 8084.706001139632, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1441.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 114.0, 113.0, 113.0, 114.0, 113.0, 113.0, 114.0, 114.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 107.0, 113.0, 177.0, 139.0, 126.0, 109.0, 109.0, 126.0, 106.0], "value": 125.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 182.0, 184.0, 183.0, 183.0, 183.0, 182.0, 182.0, 182.0, 191.0], "value": 183.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 59.0, 59.0, 93.0, 63.0, 60.0, 60.0, 59.0, 74.0, 60.0], "value": 66.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 69.0, 86.0, 68.0, 69.0, 68.0, 81.0, 69.0, 68.0, 82.0], "value": 75.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 86.0, 87.0, 86.0, 86.0, 86.0, 85.0, 86.0, 86.0], "value": 86.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 147.0, 93.0, 93.0, 93.0, 105.0, 150.0, 93.0, 94.0, 93.0], "value": 106.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 83.0, 84.0, 83.0, 83.0, 83.0, 83.0, 82.0, 80.0], "value": 83.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 59.0, 58.0, 58.0, 58.0, 63.0, 63.0, 64.0, 63.0, 65.0], "value": 61.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 68.0, 74.0, 65.0, 63.0, 62.0, 83.0, 84.0, 83.0, 59.0], "value": 70.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 85.0, 87.0, 100.0, 97.0, 97.0, 85.0, 80.0, 84.0], "value": 87.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 137.0, 145.0, 148.0, 132.0, 137.0, 140.0, 148.0, 167.0, 159.0], "value": 144.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 207.0, 210.0, 161.0, 163.0, 160.0, 201.0, 187.0, 160.0, 162.0], "value": 175.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 58.0, 63.0, 64.0, 63.0, 63.0, 64.0, 63.0, 60.0], "value": 62.7, "unit": "score"}]}]} 06:57:57 INFO - Return code: 0 06:57:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:57:57 INFO - # TBPL SUCCESS # 06:57:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:57:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:57:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:57:57 INFO - 2017-04-18 06:57:57.876 screenresolution[2214:17649] starting screenresolution argv=screenresolution get 06:57:57 INFO - 2017-04-18 06:57:57.879 screenresolution[2214:17649] Display 0: 1600x1200x32@60 06:57:57 INFO - 2017-04-18 06:57:57.885 screenresolution[2215:17652] starting screenresolution argv=screenresolution list 06:57:57 INFO - Available Modes on Display 0 06:57:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:57:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:57:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:57:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:57:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:57:58 INFO - Intel Iris: 06:57:58 INFO - Chipset Model: Intel Iris 06:57:58 INFO - Type: GPU 06:57:58 INFO - Bus: Built-In 06:57:58 INFO - VRAM (Dynamic, Max): 1536 MB 06:57:58 INFO - Vendor: Intel (0x8086) 06:57:58 INFO - Device ID: 0x0a2e 06:57:58 INFO - Revision ID: 0x0009 06:57:58 INFO - Displays: 06:57:58 INFO - Display: 06:57:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:57:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:57:58 INFO - Display Serial Number: 1600x1200 60 06:57:58 INFO - Main Display: Yes 06:57:58 INFO - Mirror: Off 06:57:58 INFO - Online: Yes 06:57:58 INFO - Rotation: Supported 06:57:58 INFO - Return code: 0 06:57:58 INFO - Running post-action listener: _resource_record_post_action 06:57:58 INFO - [mozharness: 2017-04-18 13:57:58.110733Z] Finished run-tests step (success) 06:57:58 INFO - Running post-run listener: _resource_record_post_run 06:57:58 INFO - Total resource usage - Wall time: 1193s; CPU: 54.0%; Read bytes: 1040384; Write bytes: 424147968; Read time: 12; Write time: 1399 06:57:58 INFO - TinderboxPrint: CPU usage
53.8% 06:57:58 INFO - TinderboxPrint: I/O read bytes / time
1,040,384 / 12 06:57:58 INFO - TinderboxPrint: I/O write bytes / time
424,147,968 / 1,399 06:57:58 INFO - TinderboxPrint: CPU idle
2,207.7 (46.2%) 06:57:58 INFO - TinderboxPrint: CPU system
951.0 (19.9%) 06:57:58 INFO - TinderboxPrint: CPU user
1,615.0 (33.8%) 06:57:58 INFO - TinderboxPrint: Swap in / out
122,740,736 / 0 06:57:58 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 0; Write bytes: 126371840; Read time: 0; Write time: 301 06:57:58 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 942080; Write bytes: 296375296; Read time: 10; Write time: 1087 06:57:58 INFO - Running post-run listener: _upload_blobber_files 06:57:58 INFO - Blob upload gear active. 06:57:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:57:58 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 06:57:58 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:57:58 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:57:58 INFO - (blobuploader) - INFO - Open directory for files ... 06:57:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:57:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:57:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:57:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:57:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:57:59 INFO - (blobuploader) - INFO - Done attempting. 06:57:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:57:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:57:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:58:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:58:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:58:00 INFO - (blobuploader) - INFO - Done attempting. 06:58:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:58:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:58:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:58:01 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:58:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:58:01 INFO - (blobuploader) - INFO - Done attempting. 06:58:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:58:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:58:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:58:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:58:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:58:03 INFO - (blobuploader) - INFO - Done attempting. 06:58:03 INFO - (blobuploader) - INFO - Iteration through files over. 06:58:03 INFO - Return code: 0 06:58:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:58:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:58:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/90e3868ae6668d1e781d6d4462881430e09e502d38cb70e3937e61bfcc0e8a92e85604263c692c4b48397f1f8276e2481c74bbc3237febad09b960c6b0ff9845", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/473d5934e0bb2d680d52325790bb73e64d1edc71cd1991ed922b07b29fe8869955576ce61dedd28c18afa43813e46636107ce7c1e042255e8bce14ff6e36d5cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0448367b0d8f25000cfaa516734c34eacf6486ba98960cc4335329cfdf460c39b1dcac82d4630ff7aa554d9440c1dd7a938692c0e403f05f7469d7aa85ef11f6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fc6c54d6a51a9125b9f7dafe79b6a46afbb3b925ef9cabc6247b78be3276ee7694380ef7b2613487692ff0a8c3bf762a5b03df034a1e879a1fd7938eaa89648f"} 06:58:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:58:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:58:03 INFO - Contents: 06:58:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/90e3868ae6668d1e781d6d4462881430e09e502d38cb70e3937e61bfcc0e8a92e85604263c692c4b48397f1f8276e2481c74bbc3237febad09b960c6b0ff9845", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/473d5934e0bb2d680d52325790bb73e64d1edc71cd1991ed922b07b29fe8869955576ce61dedd28c18afa43813e46636107ce7c1e042255e8bce14ff6e36d5cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0448367b0d8f25000cfaa516734c34eacf6486ba98960cc4335329cfdf460c39b1dcac82d4630ff7aa554d9440c1dd7a938692c0e403f05f7469d7aa85ef11f6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fc6c54d6a51a9125b9f7dafe79b6a46afbb3b925ef9cabc6247b78be3276ee7694380ef7b2613487692ff0a8c3bf762a5b03df034a1e879a1fd7938eaa89648f"} 06:58:03 INFO - Running post-run listener: copy_logs_to_upload_dir 06:58:03 INFO - Copying logs to upload dir... 06:58:03 INFO - mkdir: /builds/slave/test/build/upload/logs 06:58:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.016657 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2017-04-18 06:58:03.896642) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-18 06:58:03.899754) ========= 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.G0iT8WWeJa/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.U4g41Jq9uQ/Listeners TMPDIR=/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/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-Beta/sha512/90e3868ae6668d1e781d6d4462881430e09e502d38cb70e3937e61bfcc0e8a92e85604263c692c4b48397f1f8276e2481c74bbc3237febad09b960c6b0ff9845", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/473d5934e0bb2d680d52325790bb73e64d1edc71cd1991ed922b07b29fe8869955576ce61dedd28c18afa43813e46636107ce7c1e042255e8bce14ff6e36d5cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0448367b0d8f25000cfaa516734c34eacf6486ba98960cc4335329cfdf460c39b1dcac82d4630ff7aa554d9440c1dd7a938692c0e403f05f7469d7aa85ef11f6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fc6c54d6a51a9125b9f7dafe79b6a46afbb3b925ef9cabc6247b78be3276ee7694380ef7b2613487692ff0a8c3bf762a5b03df034a1e879a1fd7938eaa89648f"} build_url:https://queue.taskcluster.net/v1/task/dLMeDEC3SDeVkxnwKZo2mQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011163 build_url: 'https://queue.taskcluster.net/v1/task/dLMeDEC3SDeVkxnwKZo2mQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/90e3868ae6668d1e781d6d4462881430e09e502d38cb70e3937e61bfcc0e8a92e85604263c692c4b48397f1f8276e2481c74bbc3237febad09b960c6b0ff9845", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/473d5934e0bb2d680d52325790bb73e64d1edc71cd1991ed922b07b29fe8869955576ce61dedd28c18afa43813e46636107ce7c1e042255e8bce14ff6e36d5cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0448367b0d8f25000cfaa516734c34eacf6486ba98960cc4335329cfdf460c39b1dcac82d4630ff7aa554d9440c1dd7a938692c0e403f05f7469d7aa85ef11f6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fc6c54d6a51a9125b9f7dafe79b6a46afbb3b925ef9cabc6247b78be3276ee7694380ef7b2613487692ff0a8c3bf762a5b03df034a1e879a1fd7938eaa89648f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-18 06:58:03.933900) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 06:58:03.934215) ========= 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.G0iT8WWeJa/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.U4g41Jq9uQ/Listeners TMPDIR=/var/folders/wq/f5xgyhbd75545ndpjmyvls7c00000w/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.005245 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 06:58:03.982132) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-18 06:58:03.982438) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-18 06:58:03.982747) ========= ========= Total master_lag: 0.46 =========