builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0005 starttime: 1475231930.47 results: success (0) buildid: 20160930013320 builduid: aa5c9bca12eb4c9481f5747ff57287d7 revision: 805d5fc3d66c4fa585a3de407b1e0b055f78eb58 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-30 03:38:50.470898) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-30 03:38:50.471465) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-30 03:38:50.471739) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-30 03:38:50.585968) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 03:38:50.586264) ========= 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.Vw31ccZC9o/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.ivLl4S0GyV/Listeners TMPDIR=/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-09-30 03:38:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 16.4M=0.001s 2016-09-30 03:38:51 (16.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.556280 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 03:38:51.165404) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 03:38:51.165721) ========= 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.Vw31ccZC9o/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.ivLl4S0GyV/Listeners TMPDIR=/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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.036687 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 03:38:51.222359) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-30 03:38:51.222694) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 805d5fc3d66c4fa585a3de407b1e0b055f78eb58 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 805d5fc3d66c4fa585a3de407b1e0b055f78eb58 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Vw31ccZC9o/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.ivLl4S0GyV/Listeners TMPDIR=/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-09-30 03:38:51,276 truncating revision to first 12 chars 2016-09-30 03:38:51,276 Setting DEBUG logging. 2016-09-30 03:38:51,276 attempt 1/10 2016-09-30 03:38:51,276 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/805d5fc3d66c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-30 03:38:52,376 unpacking tar archive at: mozilla-aurora-805d5fc3d66c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.377240 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-30 03:38:52.622168) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-30 03:38:52.622475) ========= script_repo_revision: 805d5fc3d66c4fa585a3de407b1e0b055f78eb58 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-30 03:38:52.622853) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-30 03:38:52.623152) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-30 03:38:52.641628) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-09-30 03:38:52.642156) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Vw31ccZC9o/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.ivLl4S0GyV/Listeners TMPDIR=/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 03:38:52 INFO - MultiFileLogger online at 20160930 03:38:52 in /builds/slave/test 03:38:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:38:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:38:52 INFO - {'append_to_log': False, 03:38:52 INFO - 'base_work_dir': '/builds/slave/test', 03:38:52 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:38:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:38:52 INFO - 'branch': 'Mozilla-Aurora', 03:38:52 INFO - 'buildbot_json_path': 'buildprops.json', 03:38:52 INFO - 'config_files': ('talos/mac_config.py',), 03:38:52 INFO - 'default_actions': ('clobber', 03:38:52 INFO - 'read-buildbot-config', 03:38:52 INFO - 'download-and-extract', 03:38:52 INFO - 'populate-webroot', 03:38:52 INFO - 'create-virtualenv', 03:38:52 INFO - 'install', 03:38:52 INFO - 'run-tests'), 03:38:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:38:52 INFO - 'download_minidump_stackwalk': True, 03:38:52 INFO - 'download_symbols': 'ondemand', 03:38:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:38:52 INFO - 'tooltool.py': '/tools/tooltool.py', 03:38:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:38:52 INFO - '/tools/misc-python/virtualenv.py')}, 03:38:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:38:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:38:52 INFO - 'installer_path': 'installer.exe', 03:38:52 INFO - 'log_level': 'info', 03:38:52 INFO - 'log_name': 'talos', 03:38:52 INFO - 'log_to_console': True, 03:38:52 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:38:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:38:52 INFO - 'opt_config_files': (), 03:38:52 INFO - 'pip_index': False, 03:38:52 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:38:52 INFO - 'cmd': ('bash', 03:38:52 INFO - '-c', 03:38:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:38:52 INFO - 'enabled': True, 03:38:52 INFO - 'halt_on_failure': False, 03:38:52 INFO - 'name': 'check_screen_resolution'},), 03:38:52 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:38:52 INFO - 'cmd': ('bash', 03:38:52 INFO - '-c', 03:38:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:38:52 INFO - 'enabled': True, 03:38:52 INFO - 'halt_on_failure': False, 03:38:52 INFO - 'name': 'check_screen_resolution'},), 03:38:52 INFO - 'run_cmd_checks_enabled': True, 03:38:52 INFO - 'sps_profile': False, 03:38:52 INFO - 'sps_profile_interval': 0, 03:38:52 INFO - 'suite': 'dromaeojs', 03:38:52 INFO - 'system_bits': '32', 03:38:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:38:52 INFO - 'title': 't-yosemite-r7-0005', 03:38:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:38:52 INFO - 'use_talos_json': True, 03:38:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:38:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:38:52 INFO - 'work_dir': 'build'} 03:38:52 INFO - [mozharness: 2016-09-30 10:38:52.820247Z] Running clobber step. 03:38:52 INFO - Running pre-action listener: _resource_record_pre_action 03:38:52 INFO - Running main action method: clobber 03:38:52 INFO - rmtree: /builds/slave/test/build 03:38:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:38:54 INFO - Running post-action listener: _resource_record_post_action 03:38:54 INFO - [mozharness: 2016-09-30 10:38:54.911226Z] Finished clobber step (success) 03:38:54 INFO - [mozharness: 2016-09-30 10:38:54.911348Z] Running read-buildbot-config step. 03:38:54 INFO - Running pre-action listener: _resource_record_pre_action 03:38:54 INFO - Running main action method: read_buildbot_config 03:38:54 INFO - Using buildbot properties: 03:38:54 INFO - { 03:38:54 INFO - "project": "", 03:38:54 INFO - "product": "firefox", 03:38:54 INFO - "script_repo_revision": "production", 03:38:54 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 03:38:54 INFO - "repository": "", 03:38:54 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 03:38:54 INFO - "buildid": "20160930013320", 03:38:54 INFO - "pgo_build": "False", 03:38:54 INFO - "basedir": "/builds/slave/test", 03:38:54 INFO - "buildnumber": 53, 03:38:54 INFO - "slavename": "t-yosemite-r7-0005", 03:38:54 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 03:38:54 INFO - "platform": "yosemite_r7", 03:38:54 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 03:38:54 INFO - "branch": "mozilla-aurora", 03:38:54 INFO - "repo_path": "releases/mozilla-aurora", 03:38:54 INFO - "revision": "805d5fc3d66c4fa585a3de407b1e0b055f78eb58", 03:38:54 INFO - "stage_platform": "macosx64", 03:38:54 INFO - "builduid": "aa5c9bca12eb4c9481f5747ff57287d7", 03:38:54 INFO - "slavebuilddir": "test" 03:38:54 INFO - } 03:38:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 03:38:54 INFO - Running post-action listener: _resource_record_post_action 03:38:54 INFO - [mozharness: 2016-09-30 10:38:54.914337Z] Finished read-buildbot-config step (success) 03:38:54 INFO - [mozharness: 2016-09-30 10:38:54.914447Z] Running download-and-extract step. 03:38:54 INFO - Running pre-action listener: _resource_record_pre_action 03:38:54 INFO - Running main action method: download_and_extract 03:38:54 INFO - mkdir: /builds/slave/test/build/tests 03:38:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:38:54 INFO - trying https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 03:38:54 INFO - Downloading https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 03:38:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 03:38:55 INFO - Downloaded 1199 bytes. 03:38:55 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 03:38:55 INFO - Using the following test package requirements: 03:38:55 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 03:38:55 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:38:55 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 03:38:55 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:38:55 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 03:38:55 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:38:55 INFO - u'jsshell-mac.zip'], 03:38:55 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:38:55 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 03:38:55 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 03:38:55 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:38:55 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 03:38:55 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:38:55 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 03:38:55 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:38:55 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 03:38:55 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:38:55 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 03:38:55 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 03:38:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 03:38:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:38:55 INFO - Fetch https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 03:38:56 INFO - Expected file size: 16433807 03:39:03 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 03:39:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 03:39:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:39:03 INFO - Fetch https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 03:39:04 INFO - Expected file size: 16433807 03:39:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 03:39:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 03:39:10 INFO - Fetch https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 03:39:12 INFO - Expected file size: 14414059 03:39:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:12 INFO - trying https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:39:12 INFO - Downloading https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 03:39:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 03:39:15 INFO - Downloaded 115275136 bytes. 03:39:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:39:15 INFO - mkdir: /builds/slave/test/properties 03:39:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:39:15 INFO - Writing to file /builds/slave/test/properties/build_url 03:39:15 INFO - Contents: 03:39:15 INFO - build_url:https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:39:16 INFO - Running post-action listener: _resource_record_post_action 03:39:16 INFO - Running post-action listener: set_extra_try_arguments 03:39:16 INFO - [mozharness: 2016-09-30 10:39:16.346068Z] Finished download-and-extract step (success) 03:39:16 INFO - [mozharness: 2016-09-30 10:39:16.346169Z] Running populate-webroot step. 03:39:16 INFO - Running pre-action listener: _resource_record_pre_action 03:39:16 INFO - Running main action method: populate_webroot 03:39:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:39:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:39:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:39:16 INFO - '--tppagecycles', 03:39:16 INFO - '7'], 03:39:16 INFO - 'tests': ['tsvgm']}}, 03:39:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:39:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:39:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:39:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:39:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:39:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:39:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:39:16 INFO - 'talos_options': ['--disable-e10s'], 03:39:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:39:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:39:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:39:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:39:16 INFO - 'talos_options': ['--disable-e10s'], 03:39:16 INFO - 'tests': ['damp', 'tps']}, 03:39:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:39:16 INFO - 'tests': ['damp', 'tps']}, 03:39:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:39:16 INFO - 'tests': ['dromaeo_dom']}, 03:39:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:39:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:39:16 INFO - 'tests': ['basic_compositor_video']}, 03:39:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:39:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:39:16 INFO - 'tests': ['a11yr', 03:39:16 INFO - 'ts_paint', 03:39:16 INFO - 'tpaint', 03:39:16 INFO - 'sessionrestore', 03:39:16 INFO - 'sessionrestore_no_auto_restore', 03:39:16 INFO - 'tabpaint']}, 03:39:16 INFO - 'other-e10s': {'tests': ['a11yr', 03:39:16 INFO - 'ts_paint', 03:39:16 INFO - 'tpaint', 03:39:16 INFO - 'sessionrestore', 03:39:16 INFO - 'sessionrestore_no_auto_restore', 03:39:16 INFO - 'tabpaint']}, 03:39:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:39:16 INFO - 'ts_paint', 03:39:16 INFO - 'tpaint', 03:39:16 INFO - 'sessionrestore', 03:39:16 INFO - 'sessionrestore_no_auto_restore', 03:39:16 INFO - 'tabpaint']}, 03:39:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:39:16 INFO - 'ts_paint', 03:39:16 INFO - 'tpaint', 03:39:16 INFO - 'sessionrestore', 03:39:16 INFO - 'sessionrestore_no_auto_restore', 03:39:16 INFO - 'tabpaint']}, 03:39:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:39:16 INFO - 'tests': ['a11yr', 03:39:16 INFO - 'ts_paint', 03:39:16 INFO - 'tpaint', 03:39:16 INFO - 'sessionrestore', 03:39:16 INFO - 'sessionrestore_no_auto_restore', 03:39:16 INFO - 'tabpaint']}, 03:39:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:39:16 INFO - 'tests': ['a11yr', 03:39:16 INFO - 'ts_paint', 03:39:16 INFO - 'tpaint', 03:39:16 INFO - 'sessionrestore', 03:39:16 INFO - 'sessionrestore_no_auto_restore', 03:39:16 INFO - 'tabpaint']}, 03:39:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:39:16 INFO - 'tests': ['tsvgx', 03:39:16 INFO - 'tsvgr_opacity', 03:39:16 INFO - 'tart', 03:39:16 INFO - 'tscrollx', 03:39:16 INFO - 'cart']}, 03:39:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:39:16 INFO - 'tsvgr_opacity', 03:39:16 INFO - 'tart', 03:39:16 INFO - 'tscrollx', 03:39:16 INFO - 'cart']}, 03:39:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:39:16 INFO - 'talos_options': ['--disable-e10s'], 03:39:16 INFO - 'tests': ['tp5o']}, 03:39:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:39:16 INFO - 'tests': ['tp5o']}, 03:39:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:39:16 INFO - 'talos_options': ['--disable-e10s', 03:39:16 INFO - '--xperf_path', 03:39:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:39:16 INFO - 'tests': ['tp5n']}, 03:39:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:39:16 INFO - 'talos_options': ['--xperf_path', 03:39:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:39:16 INFO - 'tests': ['tp5n']}}, 03:39:16 INFO - 'talos.zip': {'path': '', 03:39:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:39:16 INFO - Running post-action listener: _resource_record_post_action 03:39:16 INFO - [mozharness: 2016-09-30 10:39:16.365009Z] Finished populate-webroot step (success) 03:39:16 INFO - [mozharness: 2016-09-30 10:39:16.365140Z] Running create-virtualenv step. 03:39:16 INFO - Running pre-action listener: _resource_record_pre_action 03:39:16 INFO - Running main action method: create_virtualenv 03:39:16 INFO - Creating virtualenv /builds/slave/test/build/venv 03:39:16 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:39:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:39:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:39:16 INFO - Using real prefix '/tools/python27' 03:39:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:39:17 INFO - Installing distribute.............................................................................................................................................................................................done. 03:39:20 INFO - Installing pip.................done. 03:39:20 INFO - Return code: 0 03:39:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:39:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10aa6c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9e2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e685cd3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a880d30>, '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 0x10a6e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a878b20>, '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.Vw31ccZC9o/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.ivLl4S0GyV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:39:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:39:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:39:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Vw31ccZC9o/Render', 03:39:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:39:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:39:20 INFO - 'HOME': '/Users/cltbld', 03:39:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:39:20 INFO - 'LOGNAME': 'cltbld', 03:39:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:20 INFO - 'MOZ_NO_REMOTE': '1', 03:39:20 INFO - 'NO_EM_RESTART': '1', 03:39:20 INFO - 'PAGER': '/bin/cat', 03:39:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:39:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:20 INFO - 'PWD': '/builds/slave/test', 03:39:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:39:20 INFO - 'SHELL': '/bin/bash', 03:39:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ivLl4S0GyV/Listeners', 03:39:20 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 03:39:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:39:20 INFO - 'USER': 'cltbld', 03:39:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:39:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:39:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:20 INFO - 'XPC_FLAGS': '0x0', 03:39:20 INFO - 'XPC_SERVICE_NAME': '0', 03:39:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:39:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:20 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:39:20 INFO - Cleaning up... 03:39:20 INFO - Return code: 0 03:39:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:39:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10aa6c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9e2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e685cd3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a880d30>, '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 0x10a6e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a878b20>, '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.Vw31ccZC9o/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.ivLl4S0GyV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:39:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:39:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:39:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Vw31ccZC9o/Render', 03:39:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:39:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:39:20 INFO - 'HOME': '/Users/cltbld', 03:39:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:39:20 INFO - 'LOGNAME': 'cltbld', 03:39:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:20 INFO - 'MOZ_NO_REMOTE': '1', 03:39:20 INFO - 'NO_EM_RESTART': '1', 03:39:20 INFO - 'PAGER': '/bin/cat', 03:39:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:39:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:20 INFO - 'PWD': '/builds/slave/test', 03:39:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:39:20 INFO - 'SHELL': '/bin/bash', 03:39:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ivLl4S0GyV/Listeners', 03:39:20 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 03:39:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:39:20 INFO - 'USER': 'cltbld', 03:39:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:39:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:39:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:20 INFO - 'XPC_FLAGS': '0x0', 03:39:20 INFO - 'XPC_SERVICE_NAME': '0', 03:39:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:39:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:20 INFO - Downloading/unpacking psutil>=3.1.1 03:39:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:39:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:39:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:39:24 INFO - Installing collected packages: psutil 03:39:24 INFO - Running setup.py install for psutil 03:39:24 INFO - building 'psutil._psutil_osx' extension 03:39:24 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 03:39:24 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 03:39:24 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 03:39:24 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 03:39:24 INFO - building 'psutil._psutil_posix' extension 03:39:24 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 03:39:25 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:39:25 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:39:25 INFO - ^ 03:39:25 INFO - 1 warning generated. 03:39:25 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 03:39:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:39:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:39:25 INFO - Successfully installed psutil 03:39:25 INFO - Cleaning up... 03:39:25 INFO - Return code: 0 03:39:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:39:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:25 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 0x10aa6c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9e2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e685cd3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a880d30>, '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 0x10a6e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a878b20>, '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.Vw31ccZC9o/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.ivLl4S0GyV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:39:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:39:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:39:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Vw31ccZC9o/Render', 03:39:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:39:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:39:25 INFO - 'HOME': '/Users/cltbld', 03:39:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:39:25 INFO - 'LOGNAME': 'cltbld', 03:39:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:25 INFO - 'MOZ_NO_REMOTE': '1', 03:39:25 INFO - 'NO_EM_RESTART': '1', 03:39:25 INFO - 'PAGER': '/bin/cat', 03:39:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:39:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:25 INFO - 'PWD': '/builds/slave/test', 03:39:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:39:25 INFO - 'SHELL': '/bin/bash', 03:39:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ivLl4S0GyV/Listeners', 03:39:25 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 03:39:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:39:25 INFO - 'USER': 'cltbld', 03:39:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:39:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:39:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:25 INFO - 'XPC_FLAGS': '0x0', 03:39:25 INFO - 'XPC_SERVICE_NAME': '0', 03:39:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:39:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:39:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:39:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:39:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:39:28 INFO - Installing collected packages: mozsystemmonitor 03:39:28 INFO - Running setup.py install for mozsystemmonitor 03:39:28 INFO - Successfully installed mozsystemmonitor 03:39:28 INFO - Cleaning up... 03:39:28 INFO - Return code: 0 03:39:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:39: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')]} 03:39:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39: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')]} 03:39:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:28 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 0x10aa6c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9e2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e685cd3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a880d30>, '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 0x10a6e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a878b20>, '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.Vw31ccZC9o/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.ivLl4S0GyV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:39:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:39:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:39:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Vw31ccZC9o/Render', 03:39:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:39:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:39:28 INFO - 'HOME': '/Users/cltbld', 03:39:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:39:28 INFO - 'LOGNAME': 'cltbld', 03:39:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:28 INFO - 'MOZ_NO_REMOTE': '1', 03:39:28 INFO - 'NO_EM_RESTART': '1', 03:39:28 INFO - 'PAGER': '/bin/cat', 03:39:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:39:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:28 INFO - 'PWD': '/builds/slave/test', 03:39:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:39:28 INFO - 'SHELL': '/bin/bash', 03:39:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ivLl4S0GyV/Listeners', 03:39:28 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 03:39:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:39:28 INFO - 'USER': 'cltbld', 03:39:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:39:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:39:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:28 INFO - 'XPC_FLAGS': '0x0', 03:39:28 INFO - 'XPC_SERVICE_NAME': '0', 03:39:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:39:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:28 INFO - Downloading/unpacking jsonschema==2.5.1 03:39:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:39:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:39:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:31 INFO - Downloading functools32-3.2.3-2.tar.gz 03:39:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:39:31 INFO - warning: no files found matching '*.txt' 03:39:31 INFO - no previously-included directories found matching 'build' 03:39:31 INFO - no previously-included directories found matching 'dist' 03:39:31 INFO - no previously-included directories found matching '.git*' 03:39:31 INFO - Installing collected packages: jsonschema, functools32 03:39:31 INFO - Running setup.py install for functools32 03:39:31 INFO - warning: no files found matching '*.txt' 03:39:31 INFO - no previously-included directories found matching 'build' 03:39:31 INFO - no previously-included directories found matching 'dist' 03:39:31 INFO - no previously-included directories found matching '.git*' 03:39:31 INFO - Successfully installed jsonschema functools32 03:39:31 INFO - Cleaning up... 03:39:31 INFO - Return code: 0 03:39:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:39:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:31 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 0x10aa6c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9e2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e685cd3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a880d30>, '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 0x10a6e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a878b20>, '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.Vw31ccZC9o/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.ivLl4S0GyV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:39:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:39:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:39:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Vw31ccZC9o/Render', 03:39:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:39:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:39:31 INFO - 'HOME': '/Users/cltbld', 03:39:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:39:31 INFO - 'LOGNAME': 'cltbld', 03:39:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:31 INFO - 'MOZ_NO_REMOTE': '1', 03:39:31 INFO - 'NO_EM_RESTART': '1', 03:39:31 INFO - 'PAGER': '/bin/cat', 03:39:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:39:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:31 INFO - 'PWD': '/builds/slave/test', 03:39:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:39:31 INFO - 'SHELL': '/bin/bash', 03:39:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ivLl4S0GyV/Listeners', 03:39:31 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 03:39:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:39:31 INFO - 'USER': 'cltbld', 03:39:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:39:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:39:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:31 INFO - 'XPC_FLAGS': '0x0', 03:39:31 INFO - 'XPC_SERVICE_NAME': '0', 03:39:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:39:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:39:32 INFO - Cleaning up... 03:39:32 INFO - Return code: 0 03:39:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:39:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:32 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 0x10aa6c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9e2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e685cd3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a880d30>, '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 0x10a6e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a878b20>, '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.Vw31ccZC9o/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.ivLl4S0GyV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:39:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:39:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:39:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Vw31ccZC9o/Render', 03:39:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:39:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:39:32 INFO - 'HOME': '/Users/cltbld', 03:39:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:39:32 INFO - 'LOGNAME': 'cltbld', 03:39:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:32 INFO - 'MOZ_NO_REMOTE': '1', 03:39:32 INFO - 'NO_EM_RESTART': '1', 03:39:32 INFO - 'PAGER': '/bin/cat', 03:39:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:39:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:32 INFO - 'PWD': '/builds/slave/test', 03:39:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:39:32 INFO - 'SHELL': '/bin/bash', 03:39:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ivLl4S0GyV/Listeners', 03:39:32 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 03:39:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:39:32 INFO - 'USER': 'cltbld', 03:39:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:39:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:39:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:32 INFO - 'XPC_FLAGS': '0x0', 03:39:32 INFO - 'XPC_SERVICE_NAME': '0', 03:39:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:39:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:32 INFO - Downloading/unpacking blobuploader==1.2.4 03:39:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:34 INFO - Downloading blobuploader-1.2.4.tar.gz 03:39:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:39:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:39:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:39:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:39:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:36 INFO - Downloading docopt-0.6.1.tar.gz 03:39:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:39:36 INFO - Installing collected packages: blobuploader, requests, docopt 03:39:36 INFO - Running setup.py install for blobuploader 03:39:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:39:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:39:36 INFO - Running setup.py install for requests 03:39:36 INFO - Running setup.py install for docopt 03:39:36 INFO - Successfully installed blobuploader requests docopt 03:39:36 INFO - Cleaning up... 03:39:37 INFO - Return code: 0 03:39:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:39:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:37 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 0x10aa6c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9e2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e685cd3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a880d30>, '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 0x10a6e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a878b20>, '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.Vw31ccZC9o/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.ivLl4S0GyV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:39:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:39:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:39:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Vw31ccZC9o/Render', 03:39:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:39:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:39:37 INFO - 'HOME': '/Users/cltbld', 03:39:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:39:37 INFO - 'LOGNAME': 'cltbld', 03:39:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:37 INFO - 'MOZ_NO_REMOTE': '1', 03:39:37 INFO - 'NO_EM_RESTART': '1', 03:39:37 INFO - 'PAGER': '/bin/cat', 03:39:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:39:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:37 INFO - 'PWD': '/builds/slave/test', 03:39:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:39:37 INFO - 'SHELL': '/bin/bash', 03:39:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ivLl4S0GyV/Listeners', 03:39:37 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 03:39:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:39:37 INFO - 'USER': 'cltbld', 03:39:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:39:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:39:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:37 INFO - 'XPC_FLAGS': '0x0', 03:39:37 INFO - 'XPC_SERVICE_NAME': '0', 03:39:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:39:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:39:37 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-Dg48a6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:39:37 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-wJR4gN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:39:37 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-JqWq0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:39:37 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-pkRwnG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:39:37 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-3Fu9mV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:39:37 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-6LcCf4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:39:37 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-tQDCew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:39:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:39:38 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-f1oWYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:39:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:39:38 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-ncoTYB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:39:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:39:38 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-vzyjkU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:39:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:39:38 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-IR9oys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:39:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:39:38 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-acSiM0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:39:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:39:38 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-o2oeMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:39:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:39:38 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-9WrB4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:39:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:39:38 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-zHsAB0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:39:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:39:38 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-u2KMSW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:39:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:39:39 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-Pw19yI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:39:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:39:39 INFO - Running setup.py install for manifestparser 03:39:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:39:39 INFO - Running setup.py install for mozcrash 03:39:39 INFO - Running setup.py install for mozdebug 03:39:39 INFO - Running setup.py install for mozdevice 03:39:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:39:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:39:39 INFO - Running setup.py install for mozfile 03:39:39 INFO - Running setup.py install for mozhttpd 03:39:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:39:40 INFO - Running setup.py install for mozinfo 03:39:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:39:40 INFO - Running setup.py install for mozInstall 03:39:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:39:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:39:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:39:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:39:40 INFO - Running setup.py install for mozleak 03:39:40 INFO - Running setup.py install for mozlog 03:39:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:39:40 INFO - Running setup.py install for moznetwork 03:39:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:39:40 INFO - Running setup.py install for mozprocess 03:39:40 INFO - Running setup.py install for mozprofile 03:39:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:39:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:39:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:39:41 INFO - Running setup.py install for mozrunner 03:39:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:39:41 INFO - Running setup.py install for mozscreenshot 03:39:41 INFO - Running setup.py install for moztest 03:39:41 INFO - Running setup.py install for mozversion 03:39:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:39:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:39:41 INFO - Cleaning up... 03:39:41 INFO - Return code: 0 03:39:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:39: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')]} 03:39:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39: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')]} 03:39:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:41 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 0x10aa6c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9e2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e685cd3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a880d30>, '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 0x10a6e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a878b20>, '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.Vw31ccZC9o/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.ivLl4S0GyV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:39:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:39:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:39:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Vw31ccZC9o/Render', 03:39:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:39:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:39:41 INFO - 'HOME': '/Users/cltbld', 03:39:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:39:41 INFO - 'LOGNAME': 'cltbld', 03:39:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:41 INFO - 'MOZ_NO_REMOTE': '1', 03:39:41 INFO - 'NO_EM_RESTART': '1', 03:39:41 INFO - 'PAGER': '/bin/cat', 03:39:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:39:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:41 INFO - 'PWD': '/builds/slave/test', 03:39:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:39:41 INFO - 'SHELL': '/bin/bash', 03:39:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ivLl4S0GyV/Listeners', 03:39:41 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 03:39:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:39:41 INFO - 'USER': 'cltbld', 03:39:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:39:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:39:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:41 INFO - 'XPC_FLAGS': '0x0', 03:39:41 INFO - 'XPC_SERVICE_NAME': '0', 03:39:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:39:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:39:41 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-TKqRMv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:39:42 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:39:42 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-jQMwpu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:39:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:39:42 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-7Q4V5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:39:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:39:42 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-0oYJPV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:39:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:39:42 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-xbP_Zj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:39:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:39:42 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-uHeQQE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:39:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:39:42 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-SwJNN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:39:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:39:42 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-7jRasR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:39:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:39:42 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-ODpYcd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:39:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:39:42 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-Rc0b8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:39:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:39:43 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-iHg7ez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:39:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:39:43 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-hi_F4K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:39:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:39:43 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-JAQqBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:39:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:39:43 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-msg3bB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:39:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:39:43 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-fAMQLj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:39:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:39:43 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-62jCFo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:39:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:39:43 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-cy2WMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:39:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:39:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:39:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:39:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:39:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:39:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:39:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:39:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:46 INFO - Downloading blessings-1.6.tar.gz 03:39:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:39:46 INFO - Installing collected packages: blessings 03:39:46 INFO - Running setup.py install for blessings 03:39:46 INFO - Successfully installed blessings 03:39:46 INFO - Cleaning up... 03:39:46 INFO - Return code: 0 03:39:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:39:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:39:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:39:46 INFO - Reading from file tmpfile_stdout 03:39:46 INFO - Current package versions: 03:39:46 INFO - blessings == 1.6 03:39:46 INFO - blobuploader == 1.2.4 03:39:46 INFO - docopt == 0.6.1 03:39:46 INFO - functools32 == 3.2.3-2 03:39:46 INFO - jsonschema == 2.5.1 03:39:46 INFO - manifestparser == 1.1 03:39:46 INFO - mozInstall == 1.12 03:39:46 INFO - mozcrash == 0.17 03:39:46 INFO - mozdebug == 0.1 03:39:46 INFO - mozdevice == 0.48 03:39:46 INFO - mozfile == 1.2 03:39:46 INFO - mozhttpd == 0.7 03:39:46 INFO - mozinfo == 0.9 03:39:46 INFO - mozleak == 0.1 03:39:46 INFO - mozlog == 3.4 03:39:46 INFO - moznetwork == 0.27 03:39:46 INFO - mozprocess == 0.23 03:39:46 INFO - mozprofile == 0.28 03:39:46 INFO - mozrunner == 6.12 03:39:46 INFO - mozscreenshot == 0.1 03:39:46 INFO - mozsystemmonitor == 0.3 03:39:46 INFO - moztest == 0.7 03:39:46 INFO - mozversion == 1.4 03:39:46 INFO - psutil == 3.1.1 03:39:46 INFO - requests == 1.2.3 03:39:46 INFO - wsgiref == 0.1.2 03:39:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:39:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:46 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 0x10aa6c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9e2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e685cd3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a880d30>, '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 0x10a6e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a878b20>, '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.Vw31ccZC9o/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.ivLl4S0GyV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:39:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:39:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:39:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Vw31ccZC9o/Render', 03:39:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:39:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:39:46 INFO - 'HOME': '/Users/cltbld', 03:39:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:39:46 INFO - 'LOGNAME': 'cltbld', 03:39:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:46 INFO - 'MOZ_NO_REMOTE': '1', 03:39:46 INFO - 'NO_EM_RESTART': '1', 03:39:46 INFO - 'PAGER': '/bin/cat', 03:39:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:39:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:46 INFO - 'PWD': '/builds/slave/test', 03:39:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:39:46 INFO - 'SHELL': '/bin/bash', 03:39:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ivLl4S0GyV/Listeners', 03:39:46 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 03:39:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:39:46 INFO - 'USER': 'cltbld', 03:39:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:39:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:39:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:46 INFO - 'XPC_FLAGS': '0x0', 03:39:46 INFO - 'XPC_SERVICE_NAME': '0', 03:39:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:39:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:39:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:39:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:39:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:39:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:39:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:39:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:39:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:39:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:39:47 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:39:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:39:47 INFO - Cleaning up... 03:39:47 INFO - Return code: 0 03:39:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:39: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')]} 03:39:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39: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')]} 03:39:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10aa6c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9e2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e685cd3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a880d30>, '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 0x10a6e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a878b20>, '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.Vw31ccZC9o/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.ivLl4S0GyV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:39: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', 'jsonschema'] in /builds/slave/test/build 03:39: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 jsonschema 03:39:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Vw31ccZC9o/Render', 03:39:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:39:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:39:47 INFO - 'HOME': '/Users/cltbld', 03:39:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:39:47 INFO - 'LOGNAME': 'cltbld', 03:39:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:47 INFO - 'MOZ_NO_REMOTE': '1', 03:39:47 INFO - 'NO_EM_RESTART': '1', 03:39:47 INFO - 'PAGER': '/bin/cat', 03:39:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:39:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:47 INFO - 'PWD': '/builds/slave/test', 03:39:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:39:47 INFO - 'SHELL': '/bin/bash', 03:39:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ivLl4S0GyV/Listeners', 03:39:47 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 03:39:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:39:47 INFO - 'USER': 'cltbld', 03:39:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:39:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:39:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:47 INFO - 'XPC_FLAGS': '0x0', 03:39:47 INFO - 'XPC_SERVICE_NAME': '0', 03:39:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:39:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:39:47 INFO - Cleaning up... 03:39:47 INFO - Return code: 0 03:39:47 INFO - Running post-action listener: _resource_record_post_action 03:39:47 INFO - Running post-action listener: _start_resource_monitoring 03:39:47 INFO - Starting resource monitoring. 03:39:47 INFO - [mozharness: 2016-09-30 10:39:47.473531Z] Finished create-virtualenv step (success) 03:39:47 INFO - [mozharness: 2016-09-30 10:39:47.474557Z] Running install step. 03:39:47 INFO - Running pre-action listener: _resource_record_pre_action 03:39:47 INFO - Running main action method: install 03:39:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:39:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:39:47 INFO - Reading from file tmpfile_stdout 03:39:47 INFO - Detecting whether we're running mozinstall >=1.0... 03:39:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:39:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:39:47 INFO - Reading from file tmpfile_stdout 03:39:47 INFO - Output received: 03:39:47 INFO - Usage: mozinstall [options] installer 03:39:47 INFO - Options: 03:39:47 INFO - -h, --help show this help message and exit 03:39:47 INFO - -d DEST, --destination=DEST 03:39:47 INFO - Directory to install application into. [default: 03:39:47 INFO - "/builds/slave/test"] 03:39:47 INFO - --app=APP Application being installed. [default: firefox] 03:39:47 INFO - mkdir: /builds/slave/test/build/application 03:39:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:39:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 03:40:20 INFO - Reading from file tmpfile_stdout 03:40:20 INFO - Output received: 03:40:20 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 03:40:20 INFO - Running post-action listener: _resource_record_post_action 03:40:20 INFO - [mozharness: 2016-09-30 10:40:20.077693Z] Finished install step (success) 03:40:20 INFO - [mozharness: 2016-09-30 10:40:20.077859Z] Running run-tests step. 03:40:20 INFO - Running pre-action listener: _resource_record_pre_action 03:40:20 INFO - Running main action method: run_tests 03:40:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:40:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:40:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:40:20 INFO - 2016-09-30 03:40:20.092 screenresolution[1665:7975] starting screenresolution argv=screenresolution get 03:40:20 INFO - 2016-09-30 03:40:20.095 screenresolution[1665:7975] Display 0: 1600x1200x32@60 03:40:20 INFO - 2016-09-30 03:40:20.100 screenresolution[1666:7978] starting screenresolution argv=screenresolution list 03:40:20 INFO - Available Modes on Display 0 03:40:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:40:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:40:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:40:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:40:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:40:20 INFO - Intel Iris: 03:40:20 INFO - Chipset Model: Intel Iris 03:40:20 INFO - Type: GPU 03:40:20 INFO - Bus: Built-In 03:40:20 INFO - VRAM (Dynamic, Max): 1536 MB 03:40:20 INFO - Vendor: Intel (0x8086) 03:40:20 INFO - Device ID: 0x0a2e 03:40:20 INFO - Revision ID: 0x0009 03:40:20 INFO - Displays: 03:40:20 INFO - Display: 03:40:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:40:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:40:20 INFO - Display Serial Number: 1600x1200 60 03:40:20 INFO - Main Display: Yes 03:40:20 INFO - Mirror: Off 03:40:20 INFO - Online: Yes 03:40:20 INFO - Rotation: Supported 03:40:20 INFO - Return code: 0 03:40:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:40:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:40:20 INFO - Python 2.7.3 03:40:20 INFO - Return code: 0 03:40:20 INFO - grabbing minidump binary from tooltool 03:40:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:40:20 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 0x10a880d30>, '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 0x10a6e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a878b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:40:20 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:40:20 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 03:40:20 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:40:20 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:40:20 INFO - Return code: 0 03:40:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:40:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:40:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:40:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:40:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:40:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:40:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0005 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:40:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Vw31ccZC9o/Render', 03:40:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:40:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:40:20 INFO - 'HOME': '/Users/cltbld', 03:40:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:40:20 INFO - 'LOGNAME': 'cltbld', 03:40:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:40:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:40:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:20 INFO - 'MOZ_NO_REMOTE': '1', 03:40:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:40:20 INFO - 'NO_EM_RESTART': '1', 03:40:20 INFO - 'PAGER': '/bin/cat', 03:40:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:40:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:20 INFO - 'PWD': '/builds/slave/test', 03:40:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:40:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:40:20 INFO - 'SHELL': '/bin/bash', 03:40:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ivLl4S0GyV/Listeners', 03:40:20 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 03:40:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:40:20 INFO - 'USER': 'cltbld', 03:40:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:40:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:40:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:20 INFO - 'XPC_FLAGS': '0x0', 03:40:20 INFO - 'XPC_SERVICE_NAME': '0', 03:40:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:40:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:40:20 INFO - mozversion application_buildid: 20160930013320 03:40:20 INFO - mozversion application_changeset: 805d5fc3d66c4fa585a3de407b1e0b055f78eb58 03:40:20 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:40:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:40:20 INFO - mozversion application_name: Firefox 03:40:20 INFO - mozversion application_remotingname: firefox-dev 03:40:20 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:40:20 INFO - mozversion application_vendor: Mozilla 03:40:20 INFO - mozversion application_version: 51.0a2 03:40:20 INFO - mozversion platform_buildid: 20160930013320 03:40:20 INFO - mozversion platform_changeset: 805d5fc3d66c4fa585a3de407b1e0b055f78eb58 03:40:20 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:40:20 INFO - mozversion platform_version: 51.0a2 03:40:20 INFO - using testdate: 1475232020 03:40:20 INFO - actual date: 1475232020 03:40:20 INFO - starting webserver on 'localhost:49272' 03:40:20 INFO - SUITE-START | Running 2 tests 03:40:20 INFO - TEST-START | dromaeo_css 03:40:20 INFO - operating with platform_type : mac_ 03:40:20 INFO - Initialising browser for dromaeo_css test... 03:40:20 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/tmpZzCIHs/profile http://localhost:49272/getInfo.html) 03:40:23 INFO - PROCESS | 1676 | __metrics Screen width/height:1600/1200 03:40:23 INFO - PROCESS | 1676 | colorDepth:24 03:40:23 INFO - PROCESS | 1676 | Browser inner width/height: 1024/689 03:40:23 INFO - PROCESS | 1676 | __metrics 03:40:23 INFO - PROCESS | 1676 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:40:23 INFO - PROCESS | 1676 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:40:23 INFO - TEST-INFO | 1676: exit 0 03:40:23 INFO - Browser initialized. 03:40:23 INFO - Running cycle 1/1 for dromaeo_css test... 03:40:23 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/tmpZzCIHs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:40:35 INFO - PROCESS | 1679 | RSS: Main: 219484160 03:40:35 INFO - PROCESS | 1679 | 03:41:26 INFO - PROCESS | 1679 | 1475232086988 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:43:38 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 03:43:40 INFO - PROCESS | 1679 | RSS: Main: 372862976 03:43:40 INFO - PROCESS | 1679 | 03:46:43 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 03:46:44 INFO - PROCESS | 1679 | RSS: Main: 351502336 03:46:44 INFO - PROCESS | 1679 | 03:49:46 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 03:49:46 INFO - PROCESS | 1679 | RSS: Main: 315518976 03:49:46 INFO - PROCESS | 1679 | 03:52:49 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 03:52:49 INFO - PROCESS | 1679 | RSS: Main: 338350080 03:52:49 INFO - PROCESS | 1679 | 03:55:53 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 03:55:53 INFO - PROCESS | 1679 | RSS: Main: 316096512 03:55:53 INFO - PROCESS | 1679 | 03:58:56 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 03:58:56 INFO - PROCESS | 1679 | RSS: Main: 363651072 03:58:56 INFO - PROCESS | 1679 | 03:58:56 INFO - PROCESS | 1679 | __start_tp_report 03:58:56 INFO - PROCESS | 1679 | _x_x_mozilla_page_load 03:58:56 INFO - PROCESS | 1679 | _x_x_mozilla_page_load_details 03:58:56 INFO - PROCESS | 1679 | |i|pagename|runs| 03:58:56 INFO - PROCESS | 1679 | |0;dojo.html;3328.6837750413715;3357.5467311912894;3367.292868497617;3384.712299454546;3408.863645454182;5670.177824215486;5716.657000579969;5724.62789918655;5759.992001399754;5794.82615521534;5663.546916246691;5673.914891276634;5744.856378590537;5751.884962300752;5772.509336706375;5206.009074238809;5219.921701174486;5239.502247286521;5268.762905669254;5275.024120537693;5175.8188463403785;5178.766955487012;5186.377634683824;5327.973360133194;5337.733113344337;5203.635745497817;5248.21276808478;5249.42256351801;5273.997940391313;5283;5256.1852912798195;5268.841934741945;5296.576273898079;5307.893842123136;5314.335708036496;5137.357830271216;5186.403563590197;5248.6588371755715;5249.632525723201;5252.789888404459;5600.775968961237;5645.181448689917;5675.829725108253;5679.716014199274;5712.57155713319;6182.381761823826;6222.719977601018;6230.470410015108;6253.718582663745;6298.307186209513;6278.246610406734;6330.525210609223;6332.493400527993;6335.30311665721;6337.7781777637565;5477.589180811455;5516.034693928546;5646.97176514123;5713.885722285531;5802.883942321172;6106.794380079898;6138.202033735586;6144.2319710036245;6144.662043587646;6167.722452489649;5774.566907481955;5783.132530120515;5785.855353616109;5789.189513468118;5794.942050579524;5916.171735956969;6126.142340072393;6131.14164017038;6171.1668924694595;6173;5133.974330128325;6233.407826256498;6260.092286618415;6266.436020758154;6273.278572964076;6242.687865606701;6276.717547710364;6294.244690637152;6296.590721603081;6297.905531417033;4816.277558366273;4817.614590832795;4970.105381031377;4973.502649734997;4976.651634385631;4421.159979603865;4427.889302767392;4457.487388950312;4458.286674132123;4524.276115821453;5745.942540574624;5765.596408251466;5772.567057470623;5776.855578610568;5786.594938354359;6335.954567496311;6339.524535659844;6355.237371515448;6357.968210159012;6360.204974378203;5584.776608935678;5664.886702266014;5692.857678558069;5693.4021927696995;5733.827985160452;5380.542653874386;5385.676859388449;5407.053765591085;5432.239486471897;5437.864053398617;6323.462505686976;6336.936630633819;6348.238211414568;6370.1718776558755;6372.7132279047555;6114.206128133634;6240.656763878031;6254.874902502015;6295.3704629538515;6306.274778400542;6305.337939516285;6343.619382837044;6355.237371515448;6363.077353783768;6371.681415929278;6173.32093469727;6190.81427557174;6191.19514463117;6193.938060619516;6202.968985155046;5514.841883204412;6206.348333425106;6210.4100110489435;6243.032329988859;6275.654838983717;5735.197072409783;5979.671118088547;6039.245094363205;6069.787557435468;6122.816315510364;6101.067587332183;6127.556056270569;6132.569672417391;6133.457080270946;6159.260888693386;5781.508571771446;5946.405359464019;5955.821325360246;5962.16529685853;5973.1637570741;5894.6757928314355;5965;5993.340732519332;6006.969965150146;6127.295361033538;5315.415304316445;5872.265966754156;5878.147668588116;5880.441358070976;5882.852928676817 03:58:56 INFO - PROCESS | 1679 | |1;ext.html;482.6331987689356;528.2287859724801;530.8672831792052;538.7037129578731;544.6813614035789;30866.845665771667;31595.52606710898;31617.20956976077;31637.367252654964;41789;41150;44236.11527769443;44268.11463770723;44365.7781711091;44433.33349999745;9697.709068727949;9836.06557377048;9856.50717464124;9858.901410985905;9878.802423951516;8726.650933962634;8870.11298870111;9684.273679474067;9783.46190959497;9791.755206119833;8910.732678019669;8966.551672416386;8983.371164018521;11959;12206.816897746541;12082.033437325037;12160.817587736192;12162.5134994601;12169.391530423443;12185.20796148252;10123.29136960413;11949.820752688716;12047.879521204763;12062.215955962922;12157.209781364183;40770.59229407727;41039.58960410387;41145.76562703124;41221.38167927483;41221.793891030655;3345.698887100148;3409.727221822273;3442.242706604543;3469.757117001811;3804.2771873344254;29809;29847.70152298471;29907.102786916428;30865.061520670013;31050.53424198639;3144.842757862121;3182.586263785693;3378.2398960233995;3387.339468803584;3394.35507253621;516797;517525;518529.40735296457;518812;521561.9999999962;61464.38535614587;61718.0742288866;61818.38181618126;61874.69062654658;61972.07041894375;64016;64139.35860641427;64158.679206603665;64175.679121604095;64310;16374.426895058616;16580;16596.17019149038;16605.83394166067;16607.335706571845;12684.873151268554;12799.232046077079;12804.551840685717;12808.80786788199;12811.935940320238;14617.853821461862;14975.251237438084;16999.74500382495;17078.658426831393;17087.316507339816;5564.4713752193475;6381.64900930444;6409.391107844747;6420.967895160587;6458.5479016469335;852.9019162796358;956.8277710012126;994.8109859126743;1008.4554340655964;1110.0675432636624;29192;29376;29557;29725.108246752632;30566.54150187749;883.5979629268796;1028.3058935218698;1058.349115294104;1130.3387518301722;1141.345539389789;14875.505532810406;15363.92318038425;15443.382264709286;15690.372385104696;15849;619055;625810;629837;630186;630528;49943.75028124836;50605;57252.713736431884;57500.56248593735;58567;1295.4947570447532;1327.8141060251573;1339.7674139791416;1356.3015047250872;1357.9932100339634;30128.800823366324;31159.442027898967;31572.526412103376;31810.840945795124;32098.67901320957;50201.748991256274;50575.49424505708;50617.74691126521;50878.74560627321;50947;595647;608398;608958;814170;814227;25824.8708756455;26111.608325875506;26153.476930461664;26166;26227.475450491263;46333.76833115813;46405;46741.29888051614;46956;47350.526494734615;38389;38591.6140838588;39252.803735981135;39562.80218598888;40539.18921621492;36784.81607592052;38166.80916595399;39771;40225;40258.396124058745;37135.25729485449;37468.43797343096;38092.2381552373;38488.2302353957;38628.6137138625;33115.50326745149;34915.65084349226;36021.45967810432;36065.737699180405;36769.63230367662;25946.048613228406;26045;26136.8693156533;26445;26747.930082797247 03:58:56 INFO - PROCESS | 1679 | |2;jquery.html;354.95385599872014;371.65436144385717;376.23171095849494;384.9326367885619;403.5581038762556;14938.5518434447;15412.768808467868;16853.073080980557;20193.697094543557;20857.165713371483;19585.804141958575;20229.393118206477;20421.693674594855;20475.771453712787;20644;4834.879128021792;4989.3513843200335;5243.187305967581;5256.658317209388;5268.868278293055;5459.235707001023;5786.421357864222;5838.5329173666005;5848.239728835246;5870.324912635037;5043.5965122790085;5632.746526406321;5802.303723553158;5804.65172089676;5806.82579522615;4373.846915357979;5034.597232221414;5059.49405059493;5109.080365534202;5110.923336149961;4833.975830120827;4919.483454237289;4963.1810751226;4976.87557811054;4979.352684151074;12367.319797411139;12635.368231588383;12647.683807904785;12654.493820247179;12657.177283476545;2219.5671843990426;2323.744388117306;2474.8391354562077;2955.3941442004552;2967.4510215609967;9459.952700236523;9614.855777163279;9688.031196880325;9779.755506112404;10034.799304013879;1828.9725654115198;1846.4829847642682;1852.0647073228067;1864.8414884734814;1904.628597423503;125666;127811.72188278091;132234;133078;134940;10428.582856685647;10787.244892857581;10844.403557804397;10925.399103049409;11037;13340.332983350794;13375.398107085204;13377.33113344329;13381.063325567311;13425.39585718645;8209.630566624517;8443.451175673561;8443.788905277417;8523.105073967268;8604.827903442021;8460.492370457792;8487.618057187441;8510.872336914952;8626;8650.134986501425;4127.607877251657;4245.3844192591905;4249.745015299092;4320.675949303814;4421.690481666253;1775.8046614872353;1823.8569680625212;1829.6798060339388;1837.595728939631;1853.7312089747181;885.1590988560893;894.592960203119;905.456725964416;967.3470407474927;970.815545046439;20549.89725051365;21209.89395053015;22941.558766184873;23141.884290578775;23530.529389412117;915.5020383062828;935.9110884465965;941.8022215334856;961.4471678784587;1014.442056868734;11087.279326843729;11481.425928703698;11483.36841473727;11488.88511114895;11489;640755;647213;648950;656982;658253;100634.49682751686;121511;131494;135924;144108;962.5812771444444;980.127686359141;991.0188912976101;992.3053862296422;994.100339193017;19031.238750449826;19522.414327570197;19935.10292036833;20028.799712003278;20054.398368048984;37047.8147609271;56135.71932140313;57562;57601.423985759604;60880.695596521735;76737.84893226718;82362.17637823545;84131;85955;87734;7787.532748035136;7788.415868809749;7826.804329891798;7877.133515313197;8147.307478864363;9235.676751313671;12453.439595218055;12493.500259989862;12932.288724119888;13049;10642.680719578426;11004.39475828837;11078.279911805706;11186.664400068012;11290.49192786343;10314.381137131797;10596.31123976939;10847.349159050482;10925.83611245816;10946.56213751473;10711;10869.29349592274;10964.616238431616;11020.173486988348;11090.057345125755;5936.910946335895;6312.526560508072;7083.468739844429;7208.96395518019;7265.20082790882;8075.83848323042;10707.250492465453;10713.303635263683;10889.673309800719;11166 03:58:56 INFO - PROCESS | 1679 | |3;mootools.html;1515.6817068415635;1542.344503585976;1724.241333813122;1869.5232715657505;1886.094674556214;7862.724804631839;8105.878411823827;8390.20293072158;8862.689805856788;8870.334724895627;7997.720079797208;8082.353411727063;8092.959535202316;8454.239118479336;8662.350323725714;2321.1527792355837;2348.3189874936247;2349.6710460535537;2350.8236882233814;2352.12971200656;2327.453048533593;2337.9532409351887;2349.259983105316;2370.0401337458356;2376.4771750214927;2347.2371479269304;2355.9175428859994;2369.7393286738443;2372.395039264985;2384.1178763857397;2318.8840557972035;2329.6621989811465;2339.9532009359887;2340.0639744102496;2340.941476463085;2324.360800779799;2330.0679728108894;2331.4521087544413;2335.9065637374483;2338.6375111857687;8737.995130560003;8827.823443531093;8836.8674469883;8852.734417967471;8881.289496840238;5108.948910510921;5273.3935597406025;5274.525292723673;5278.630495865291;5280.656757310762;3358.261182539837;3446.913827154316;3550.609432962372;3556.0931962349696;3567.94648080279;948.7201275623638;954.2175416158752;955.0783493928393;961.8509131084624;967.8354679704468;11567.248128871597;11590.536378544848;11601.535938562447;11604.361760103191;11641.883581164164;4550.772461376918;4591.104734576726;4648.48866624671;4679.368285281512;4738.763061846963;9991.650292239738;9995.900040999497;10007.649732259482;10025.448600327052;10032.69901902944;5257.737113144328;5263.894722105613;5277.472252774692;5285.127953887642;5288.915772266676;4248.957510424856;4546.1135078659345;4792.9281060784115;4833.250846118787;4839.516048395203;3400.8607116616213;3910.4329872168946;3915.686745060388;4002.6397624213378;4040.2525532775944;1270.5668644545592;1282.7178020835402;1288.8066789981578;1292.5476083370745;1298.266479439114;778.8481246156945;874.3136637739344;887.8535041718044;914.7392992996964;929.3587424676952;5575.944240557624;5601.159826026129;5619.915701264485;5790;5976.760929562769;419.7418587568623;422.38753806980003;429.9656027517791;431.0301820902968;431.8035293941249;3822.694184465236;3835.9424608630893;3890.513685789276;4001.9399709004388;4033.233685599727;10054.74863128413;10662.893371066346;10679.626213082505;10748.355098694103;10893.782124357469;9073.77315567116;10276.332038417479;10713.035826775627;10749.83875241872;10758.462076896123;6298.874022519615;7841;8068.596570171585;8113.959430202811;8135.79660508492;5726.2269593606;5830.300363956352;5898.233229680286;5968.253968253968;6008.339082700812;9447.102525260365;9693.030696930251;9850.753731156492;9877.50612469388;9907.752306192402;9809.901900980898;10076.193904487476;10121.544530495998;10122.240831937486;10241.283110182216;6851.109355783717;7295.562266264041;7446;7545.886811697938;7598.392128629807;8350.749477515441;8441.535715535705;8446.95776521138;8458.281046110904;8491.320694344562;7293.4894557382595;7418.406527477681;7452.217517160837;7478.326950574475;7529.774106776806;7227.530210536298;7296.7810965671115;7325.890111648223;7423.740169094056;7447.329740323397;6969.372756451944;6988.860222795617;7025.2272250053475;7036.612986285803;7060.6116663584;4879.707217566957;4895.877603059952;4911.312416261655;4949.232868905326;4951.801927922987;4831.227003679394;4856.514348565256;4879.634027447884;5009.949900500948;5026.899462010812 03:58:56 INFO - PROCESS | 1679 | |4;prototype.html;293.75618236863403;294.52728370964604;301.1252312033542;305.4623862002877;308.53257315167514;5412.61711430356;5414.269073675053;5445.210444485548;5502.147167189092;5514.558835293177;4260.552641972595;5062.493750624935;5219.895602087956;5254.369475662917;5329.920051199235;3333;3493.7205023598176;4064.9187016259657;4070.6336429721246;4073.226087043467;3732.3841566141555;4119.6704263658985;4129.6283334499885;4132.73137246078;4157.792110394468;3809.5999920008417;4058;4073.6372903715774;4084.326086195774;4145.191687620915;4043.9191216175805;4077.1845630873945;4096.877093687194;4130.153318569686;4136.131412403399;3045.4670432674416;3444.225049363873;3457.2566898116775;3460.602030766469;3465.7696517736094;5000.649954503187;5165.63840531163;5350.3312085989255;5399.839034607539;5412.972935135299;4533.727976321431;4599.29825964392;4635.450502223797;4642.466116396624;4657.324687920266;5013.373328333958;5252.923150754086;5619.157126431027;5738.020382967869;5775.16260142277;3505.754597178173;3593.568771747381;3843.846246150151;3853.7109716771074;3879.642125256166;5433.75023744537;5441.530786687651;5872.853178670524;5933.792317268875;5974.4921681657115;3469.826508674556;3635.8727444539313;3833.15670552478;3838.2364697417815;3846.769193848378;3889.3388124018984;3927.5286965563746;3930;3930.3514920038447;3938.15329704115;4094.5905409458815;4207.852725154605;4504.1216962692615;4609.400777898919;4631.930521042187;4993.675411098267;5700.686462244616;5703.948387612607;5744.626599271118;5823.82528524145;1059.9894001060045;1129.5877004893155;1249.3503378243263;1313.3498918035634;1357.762391581489;810.1776696652902;849.3884403229665;868.4224990381452;895.5298468304062;901.7204666553389;4548.613367863769;5224.346956630421;5412.648177868426;5432.782688692487;5512.9678676727635;5522.282103326542;5876.324222714357;5877.941220587825;5983.252093488314;6001.729922153513;5293.470652934676;5306.8407947761625;5328.307320048369;5330.733463326818;5346.492083252085;2500.8374455660323;2554.1698947842024;2653.893844246247;2995.876546295139;3055.334842510837;5094.363204599425;5196.376434827845;5488.53347465462;5537.529310008695;5789.652620842763;4943.454121127622;5325.627206095536;5374.650647707965;5482.7115627827425;5840.970795146082;5324.227986941949;5637.943620563742;5684.8863022739315;5878.677297608089;6081.138477067006;5228.45101264377;5369.865753356197;5886.205362276038;5941.881162376815;5943.81123775238;5723.996601189717;5806.332271788629;5873.324567674772;5889.293284805851;5910.276525788726;5518.558515318685;5700.68884156638;5876.853078673067;5991.370906054802;6099.298580663103;3975.9523845219155;4011.6590089841525;4019.9397009045474;4037.475128233311;4039.434479172977;5216.93052924142;5432.18517222404;5946.710516451111;5965.850853728692;5991.940080599138;4740.1230772307235;4797.4482934461585;5209.270702101633;5879;5879.794207202727;4861;5294.643883471818;5668.234788303526;5688.943110568841;5741.827745167651;5307.601929855354;5505.550030236506;5508.807191748269;5520.227168196376;5607.299087614048;4706.093942028177;5154.561862241751;5795.275590551181;5811.883762324815;5841.452015216056;4907.484714104968;5480.808171713971;5632.408597097246;5645.943540564542;5692.48767610917 03:58:56 INFO - PROCESS | 1679 | |5;yui.html;600.1837500998641;769.0041396391672;787.6967367563486;798.6805277888848;837.1712005114935;14667.119972801625;15398.538043858674;15748.448804291853;16146.111963841984;16554;14524.201168935704;14920.850791492081;14936.327865246063;14937.402503899832;14942.10347379158;681.111149949316;694.6283738200063;699;841.1336323586701;864.8097418567936;843.1147295339869;855.1405837133672;869.5478351257342;870.503812826689;873.2010210657241;919.7240827751681;920.6409500294857;920.9493477858715;922.1516205091299;923.7921467669754;703.0403499223574;722.1478655186877;911.813078318943;913.5158366065996;913.8172365526888;656.2584279763836;672.2370109925221;672.4284358295458;672.5729161982127;674.0731494195481;15124.319405626664;15170.544883653509;15191.620209494851;15192;15192.772108418383;11752.882471175264;13216.405261763244;13775;13935.303234838319;14240.287985600678;10672.519736611872;11037.668869933916;11161.27451715644;12543.435545400478;12747.980161587051;4572.679912406133;4602;4676.485586585472;4739.265413860857;4762.738049407281;114133.42933285363;114669;117368;118504;118979.40510297393;10509;10639.521221545048;10789.892101079045;10804.027637512661;10870;20422.489437763878;20462.87454190004;20484.46366522487;20500.17999280042;20501.17995280172;7612.543247405173;7615.048118985127;7739.690412383442;7806.414518911104;7886.44794864354;4208.91582168361;4339.609435150788;4361.934570981438;4375.649948004152;4508.864734057984;3362.176266814646;3481.338545676364;3482.564679415073;3490.3891818931584;3492.301539692072;598.2730981856978;606.5026678123896;617.5337620096798;627.6453803601042;629.2669040567687;516.8811173430057;580.8141394753723;624.2166081567603;626.4862812493711;642.2004604267623;8898.243649289754;9103.772405689911;9270.119338662817;9353.251739860794;9450;546.7266366816592;603.915970832357;621.3196549777986;628.4281304013417;648.9935100649028;4500.437445319335;4510.819567217274;4524.638028957741;4536.591706746409;4573.56551127649;162229.18885405498;162940.18529907273;165921;168593;169929;93340;134901.3254933719;138866;140711.29644351712;142925.8561121584;120855;123593.38203309105;123960;124122;127697;7151.962965370096;8731.65073397057;8750.518721470125;8774.824503510023;9044.547772611211;67433.3256667427;67995;68133.65933170501;68689.31310686829;69593;102663.4866825691;103483.4825825866;104014.47992759988;106819;107355;10831.187660925305;11179;11211.943940280247;11430.714232144262;11644.53421863116;11981.64055078349;12082.637520874388;12474.563390281297;12649.430775614936;12831.935840320739;11625.476853541442;11915.987141093105;11981.865931717728;12062.276263424223;12187.51249949992;11919.642410727693;11975.323454716521;12022.813954301942;12087.335196564274;12119.81820272679;10167.593296268067;11702.122340824302;11705.180637355303;11711.941440292743;11758.82361764557;9900.801983960424;10024.198064154703;10063.647772327933;10249.84625230637;10376.429296388771;9934.503274836374;10164.440955747505;10168.440735759308;10184.949075254874;10205 03:58:56 INFO - PROCESS | 1679 | __end_tp_report 03:58:56 INFO - PROCESS | 1679 | __start_cc_report 03:58:56 INFO - PROCESS | 1679 | _x_x_mozilla_cycle_collect,1436 03:58:56 INFO - PROCESS | 1679 | __end_cc_report 03:58:56 INFO - PROCESS | 1679 | __startTimestamp1475233136924__endTimestamp 03:58:56 INFO - PROCESS | 1679 | 03:58:56 INFO - PROCESS | 1679 | ------- Summary: start ------- 03:58:56 INFO - PROCESS | 1679 | Number of tests: 6 03:58:56 INFO - PROCESS | 1679 | 03:58:56 INFO - PROCESS | 1679 | [#0] dojo.html Cycles:165 Average:5723.04 Median:5794.83 stddev:629.12 (10.9%) stddev-sans-first:602.36 03:58:56 INFO - PROCESS | 1679 | Values: 3328.7 3357.5 3367.3 3384.7 3408.9 5670.2 5716.7 5724.6 5760.0 5794.8 5663.5 5673.9 5744.9 5751.9 5772.5 5206.0 5219.9 5239.5 5268.8 5275.0 5175.8 5178.8 5186.4 5328.0 5337.7 5203.6 5248.2 5249.4 5274.0 5283.0 5256.2 5268.8 5296.6 5307.9 5314.3 5137.4 5186.4 5248.7 5249.6 5252.8 5600.8 5645.2 5675.8 5679.7 5712.6 6182.4 6222.7 6230.5 6253.7 6298.3 6278.2 6330.5 6332.5 6335.3 6337.8 5477.6 5516.0 5647.0 5713.9 5802.9 6106.8 6138.2 6144.2 6144.7 6167.7 5774.6 5783.1 5785.9 5789.2 5794.9 5916.2 6126.1 6131.1 6171.2 6173.0 5134.0 6233.4 6260.1 6266.4 6273.3 6242.7 6276.7 6294.2 6296.6 6297.9 4816.3 4817.6 4970.1 4973.5 4976.7 4421.2 4427.9 4457.5 4458.3 4524.3 5745.9 5765.6 5772.6 5776.9 5786.6 6336.0 6339.5 6355.2 6358.0 6360.2 5584.8 5664.9 5692.9 5693.4 5733.8 5380.5 5385.7 5407.1 5432.2 5437.9 6323.5 6336.9 6348.2 6370.2 6372.7 6114.2 6240.7 6254.9 6295.4 6306.3 6305.3 6343.6 6355.2 6363.1 6371.7 6173.3 6190.8 6191.2 6193.9 6203.0 5514.8 6206.3 6210.4 6243.0 6275.7 5735.2 5979.7 6039.2 6069.8 6122.8 6101.1 6127.6 6132.6 6133.5 6159.3 5781.5 5946.4 5955.8 5962.2 5973.2 5894.7 5965.0 5993.3 6007.0 6127.3 5315.4 5872.3 5878.1 5880.4 5882.9 03:58:56 INFO - PROCESS | 1679 | 03:58:56 INFO - PROCESS | 1679 | [#1] ext.html Cycles:180 Average:73800.35 Median:38129.52 stddev:165656.68 (434.5%) stddev-sans-first:166029.93 03:58:56 INFO - PROCESS | 1679 | Values: 482.6 528.2 530.9 538.7 544.7 30866.8 31595.5 31617.2 31637.4 41789.0 41150.0 44236.1 44268.1 44365.8 44433.3 9697.7 9836.1 9856.5 9858.9 9878.8 8726.7 8870.1 9684.3 9783.5 9791.8 8910.7 8966.6 8983.4 11959.0 12206.8 12082.0 12160.8 12162.5 12169.4 12185.2 10123.3 11949.8 12047.9 12062.2 12157.2 40770.6 41039.6 41145.8 41221.4 41221.8 3345.7 3409.7 3442.2 3469.8 3804.3 29809.0 29847.7 29907.1 30865.1 31050.5 3144.8 3182.6 3378.2 3387.3 3394.4 516797.0 517525.0 518529.4 518812.0 521562.0 61464.4 61718.1 61818.4 61874.7 61972.1 64016.0 64139.4 64158.7 64175.7 64310.0 16374.4 16580.0 16596.2 16605.8 16607.3 12684.9 12799.2 12804.6 12808.8 12811.9 14617.9 14975.3 16999.7 17078.7 17087.3 5564.5 6381.6 6409.4 6421.0 6458.5 852.9 956.8 994.8 1008.5 1110.1 29192.0 29376.0 29557.0 29725.1 30566.5 883.6 1028.3 1058.3 1130.3 1141.3 14875.5 15363.9 15443.4 15690.4 15849.0 619055.0 625810.0 629837.0 630186.0 630528.0 49943.8 50605.0 57252.7 57500.6 58567.0 1295.5 1327.8 1339.8 1356.3 1358.0 30128.8 31159.4 31572.5 31810.8 32098.7 50201.7 50575.5 50617.7 50878.7 50947.0 595647.0 608398.0 608958.0 814170.0 814227.0 25824.9 26111.6 26153.5 26166.0 26227.5 46333.8 46405.0 46741.3 46956.0 47350.5 38389.0 38591.6 39252.8 39562.8 40539.2 36784.8 38166.8 39771.0 40225.0 40258.4 37135.3 37468.4 38092.2 38488.2 38628.6 33115.5 34915.7 36021.5 36065.7 36769.6 25946.0 26045.0 26136.9 26445.0 26747.9 03:58:56 INFO - PROCESS | 1679 | 03:58:56 INFO - PROCESS | 1679 | [#2] jquery.html Cycles:180 Average:36382.91 Median:18701.38 stddev:108585.52 (580.6%) stddev-sans-first:108856.44 03:58:56 INFO - PROCESS | 1679 | Values: 355.0 371.7 376.2 384.9 403.6 14938.6 15412.8 16853.1 20193.7 20857.2 19585.8 20229.4 20421.7 20475.8 20644.0 4834.9 4989.4 5243.2 5256.7 5268.9 5459.2 5786.4 5838.5 5848.2 5870.3 5043.6 5632.7 5802.3 5804.7 5806.8 4373.8 5034.6 5059.5 5109.1 5110.9 4834.0 4919.5 4963.2 4976.9 4979.4 12367.3 12635.4 12647.7 12654.5 12657.2 2219.6 2323.7 2474.8 2955.4 2967.5 9460.0 9614.9 9688.0 9779.8 10034.8 1829.0 1846.5 1852.1 1864.8 1904.6 125666.0 127811.7 132234.0 133078.0 134940.0 10428.6 10787.2 10844.4 10925.4 11037.0 13340.3 13375.4 13377.3 13381.1 13425.4 8209.6 8443.5 8443.8 8523.1 8604.8 8460.5 8487.6 8510.9 8626.0 8650.1 4127.6 4245.4 4249.7 4320.7 4421.7 1775.8 1823.9 1829.7 1837.6 1853.7 885.2 894.6 905.5 967.3 970.8 20549.9 21209.9 22941.6 23141.9 23530.5 915.5 935.9 941.8 961.4 1014.4 11087.3 11481.4 11483.4 11488.9 11489.0 640755.0 647213.0 648950.0 656982.0 658253.0 100634.5 121511.0 131494.0 135924.0 144108.0 962.6 980.1 991.0 992.3 994.1 19031.2 19522.4 19935.1 20028.8 20054.4 37047.8 56135.7 57562.0 57601.4 60880.7 76737.8 82362.2 84131.0 85955.0 87734.0 7787.5 7788.4 7826.8 7877.1 8147.3 9235.7 12453.4 12493.5 12932.3 13049.0 10642.7 11004.4 11078.3 11186.7 11290.5 10314.4 10596.3 10847.3 10925.8 10946.6 10711.0 10869.3 10964.6 11020.2 11090.1 5936.9 6312.5 7083.5 7209.0 7265.2 8075.8 10707.3 10713.3 10889.7 11166.0 03:58:56 INFO - PROCESS | 1679 | 03:58:56 INFO - PROCESS | 1679 | [#3] mootools.html Cycles:180 Average:5628.86 Median:4903.60 stddev:3178.20 (64.8%) stddev-sans-first:3172.09 03:58:56 INFO - PROCESS | 1679 | Values: 1515.7 1542.3 1724.2 1869.5 1886.1 7862.7 8105.9 8390.2 8862.7 8870.3 7997.7 8082.4 8093.0 8454.2 8662.4 2321.2 2348.3 2349.7 2350.8 2352.1 2327.5 2338.0 2349.3 2370.0 2376.5 2347.2 2355.9 2369.7 2372.4 2384.1 2318.9 2329.7 2340.0 2340.1 2340.9 2324.4 2330.1 2331.5 2335.9 2338.6 8738.0 8827.8 8836.9 8852.7 8881.3 5108.9 5273.4 5274.5 5278.6 5280.7 3358.3 3446.9 3550.6 3556.1 3567.9 948.7 954.2 955.1 961.9 967.8 11567.2 11590.5 11601.5 11604.4 11641.9 4550.8 4591.1 4648.5 4679.4 4738.8 9991.7 9995.9 10007.6 10025.4 10032.7 5257.7 5263.9 5277.5 5285.1 5288.9 4249.0 4546.1 4792.9 4833.3 4839.5 3400.9 3910.4 3915.7 4002.6 4040.3 1270.6 1282.7 1288.8 1292.5 1298.3 778.8 874.3 887.9 914.7 929.4 5575.9 5601.2 5619.9 5790.0 5976.8 419.7 422.4 430.0 431.0 431.8 3822.7 3835.9 3890.5 4001.9 4033.2 10054.7 10662.9 10679.6 10748.4 10893.8 9073.8 10276.3 10713.0 10749.8 10758.5 6298.9 7841.0 8068.6 8114.0 8135.8 5726.2 5830.3 5898.2 5968.3 6008.3 9447.1 9693.0 9850.8 9877.5 9907.8 9809.9 10076.2 10121.5 10122.2 10241.3 6851.1 7295.6 7446.0 7545.9 7598.4 8350.7 8441.5 8447.0 8458.3 8491.3 7293.5 7418.4 7452.2 7478.3 7529.8 7227.5 7296.8 7325.9 7423.7 7447.3 6969.4 6988.9 7025.2 7036.6 7060.6 4879.7 4895.9 4911.3 4949.2 4951.8 4831.2 4856.5 4879.6 5009.9 5026.9 03:58:56 INFO - PROCESS | 1679 | 03:58:56 INFO - PROCESS | 1679 | [#4] prototype.html Cycles:180 Average:4573.83 Median:5240.69 stddev:1428.25 (27.3%) stddev-sans-first:1395.66 03:58:56 INFO - PROCESS | 1679 | Values: 293.8 294.5 301.1 305.5 308.5 5412.6 5414.3 5445.2 5502.1 5514.6 4260.6 5062.5 5219.9 5254.4 5329.9 3333.0 3493.7 4064.9 4070.6 4073.2 3732.4 4119.7 4129.6 4132.7 4157.8 3809.6 4058.0 4073.6 4084.3 4145.2 4043.9 4077.2 4096.9 4130.2 4136.1 3045.5 3444.2 3457.3 3460.6 3465.8 5000.6 5165.6 5350.3 5399.8 5413.0 4533.7 4599.3 4635.5 4642.5 4657.3 5013.4 5252.9 5619.2 5738.0 5775.2 3505.8 3593.6 3843.8 3853.7 3879.6 5433.8 5441.5 5872.9 5933.8 5974.5 3469.8 3635.9 3833.2 3838.2 3846.8 3889.3 3927.5 3930.0 3930.4 3938.2 4094.6 4207.9 4504.1 4609.4 4631.9 4993.7 5700.7 5703.9 5744.6 5823.8 1060.0 1129.6 1249.4 1313.3 1357.8 810.2 849.4 868.4 895.5 901.7 4548.6 5224.3 5412.6 5432.8 5513.0 5522.3 5876.3 5877.9 5983.3 6001.7 5293.5 5306.8 5328.3 5330.7 5346.5 2500.8 2554.2 2653.9 2995.9 3055.3 5094.4 5196.4 5488.5 5537.5 5789.7 4943.5 5325.6 5374.7 5482.7 5841.0 5324.2 5637.9 5684.9 5878.7 6081.1 5228.5 5369.9 5886.2 5941.9 5943.8 5724.0 5806.3 5873.3 5889.3 5910.3 5518.6 5700.7 5876.9 5991.4 6099.3 3976.0 4011.7 4019.9 4037.5 4039.4 5216.9 5432.2 5946.7 5965.9 5991.9 4740.1 4797.4 5209.3 5879.0 5879.8 4861.0 5294.6 5668.2 5688.9 5741.8 5307.6 5505.6 5508.8 5520.2 5607.3 4706.1 5154.6 5795.3 5811.9 5841.5 4907.5 5480.8 5632.4 5645.9 5692.5 03:58:56 INFO - PROCESS | 1679 | 03:58:56 INFO - PROCESS | 1679 | [#5] yui.html Cycles:180 Average:26122.66 Median:20500.68 stddev:43487.24 (212.1%) stddev-sans-first:43567.01 03:58:56 INFO - PROCESS | 1679 | Values: 600.2 769.0 787.7 798.7 837.2 14667.1 15398.5 15748.4 16146.1 16554.0 14524.2 14920.9 14936.3 14937.4 14942.1 681.1 694.6 699.0 841.1 864.8 843.1 855.1 869.5 870.5 873.2 919.7 920.6 920.9 922.2 923.8 703.0 722.1 911.8 913.5 913.8 656.3 672.2 672.4 672.6 674.1 15124.3 15170.5 15191.6 15192.0 15192.8 11752.9 13216.4 13775.0 13935.3 14240.3 10672.5 11037.7 11161.3 12543.4 12748.0 4572.7 4602.0 4676.5 4739.3 4762.7 114133.4 114669.0 117368.0 118504.0 118979.4 10509.0 10639.5 10789.9 10804.0 10870.0 20422.5 20462.9 20484.5 20500.2 20501.2 7612.5 7615.0 7739.7 7806.4 7886.4 4208.9 4339.6 4361.9 4375.6 4508.9 3362.2 3481.3 3482.6 3490.4 3492.3 598.3 606.5 617.5 627.6 629.3 516.9 580.8 624.2 626.5 642.2 8898.2 9103.8 9270.1 9353.3 9450.0 546.7 603.9 621.3 628.4 649.0 4500.4 4510.8 4524.6 4536.6 4573.6 162229.2 162940.2 165921.0 168593.0 169929.0 93340.0 134901.3 138866.0 140711.3 142925.9 120855.0 123593.4 123960.0 124122.0 127697.0 7152.0 8731.7 8750.5 8774.8 9044.5 67433.3 67995.0 68133.7 68689.3 69593.0 102663.5 103483.5 104014.5 106819.0 107355.0 10831.2 11179.0 11211.9 11430.7 11644.5 11981.6 12082.6 12474.6 12649.4 12831.9 11625.5 11916.0 11981.9 12062.3 12187.5 11919.6 11975.3 12022.8 12087.3 12119.8 10167.6 11702.1 11705.2 11711.9 11758.8 9900.8 10024.2 10063.6 10249.8 10376.4 9934.5 10164.4 10168.4 10184.9 10205.0 03:58:56 INFO - PROCESS | 1679 | -------- Summary: end -------- 03:58:56 INFO - PROCESS | 1679 | 03:58:57 INFO - TEST-INFO | 1679: exit 0 03:58:57 INFO - TEST-OK | dromaeo_css | took 1116868ms 03:58:57 INFO - TEST-START | kraken 03:58:57 INFO - operating with platform_type : mac_ 03:58:57 INFO - Initialising browser for kraken test... 03:58:57 INFO - TEST-INFO | started process 1688 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/tmpoIbW8t/profile http://localhost:49272/getInfo.html) 03:59:00 INFO - PROCESS | 1688 | __metrics Screen width/height:1600/1200 03:59:00 INFO - PROCESS | 1688 | colorDepth:24 03:59:00 INFO - PROCESS | 1688 | Browser inner width/height: 1024/689 03:59:00 INFO - PROCESS | 1688 | __metrics 03:59:00 INFO - PROCESS | 1688 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:59:00 INFO - PROCESS | 1688 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:59:00 INFO - TEST-INFO | 1688: exit 0 03:59:00 INFO - Browser initialized. 03:59:00 INFO - Running cycle 1/1 for kraken test... 03:59:00 INFO - TEST-INFO | started process 1689 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/tmpoIbW8t/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:59:12 INFO - PROCESS | 1689 | RSS: Main: 218673152 03:59:12 INFO - PROCESS | 1689 | 03:59:15 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 03:59:16 INFO - PROCESS | 1689 | RSS: Main: 269082624 03:59:16 INFO - PROCESS | 1689 | 03:59:19 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 03:59:19 INFO - PROCESS | 1689 | RSS: Main: 281444352 03:59:19 INFO - PROCESS | 1689 | 03:59:22 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 03:59:23 INFO - PROCESS | 1689 | RSS: Main: 378535936 03:59:23 INFO - PROCESS | 1689 | 03:59:25 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 03:59:26 INFO - PROCESS | 1689 | RSS: Main: 279838720 03:59:26 INFO - PROCESS | 1689 | 03:59:28 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:59:28 INFO - PROCESS | 1689 | RSS: Main: 280395776 03:59:28 INFO - PROCESS | 1689 | 03:59:31 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 03:59:32 INFO - PROCESS | 1689 | RSS: Main: 317542400 03:59:32 INFO - PROCESS | 1689 | 03:59:34 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 03:59:35 INFO - PROCESS | 1689 | RSS: Main: 319741952 03:59:35 INFO - PROCESS | 1689 | 03:59:38 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 03:59:38 INFO - PROCESS | 1689 | RSS: Main: 319610880 03:59:38 INFO - PROCESS | 1689 | 03:59:40 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:59:41 INFO - PROCESS | 1689 | RSS: Main: 289652736 03:59:41 INFO - PROCESS | 1689 | 03:59:43 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:59:43 INFO - PROCESS | 1689 | RSS: Main: 296034304 03:59:43 INFO - PROCESS | 1689 | 03:59:45 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:59:46 INFO - PROCESS | 1689 | RSS: Main: 300040192 03:59:46 INFO - PROCESS | 1689 | 03:59:49 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:59:49 INFO - PROCESS | 1689 | RSS: Main: 312029184 03:59:49 INFO - PROCESS | 1689 | 03:59:52 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:59:53 INFO - PROCESS | 1689 | RSS: Main: 307736576 03:59:53 INFO - PROCESS | 1689 | 03:59:55 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 03:59:55 INFO - PROCESS | 1689 | RSS: Main: 350846976 03:59:55 INFO - PROCESS | 1689 | 03:59:55 INFO - PROCESS | 1689 | __start_tp_report 03:59:55 INFO - PROCESS | 1689 | _x_x_mozilla_page_load 03:59:55 INFO - PROCESS | 1689 | _x_x_mozilla_page_load_details 03:59:55 INFO - PROCESS | 1689 | |i|pagename|runs| 03:59:55 INFO - PROCESS | 1689 | |0;ai-astar;115;115;115;114;113;115;113;113;114;114 03:59:55 INFO - PROCESS | 1689 | |1;audio-beat-detection;132;105;108;137;111;87;112;135;169;125 03:59:55 INFO - PROCESS | 1689 | |2;audio-dft;182;183;184;186;183;184;182;182;184;184 03:59:55 INFO - PROCESS | 1689 | |3;audio-fft;83;58;58;88;64;60;58;59;82;57 03:59:55 INFO - PROCESS | 1689 | |4;audio-oscillator;91;65;93;71;67;70;111;98;100;107 03:59:55 INFO - PROCESS | 1689 | |5;imaging-gaussian-blur;87;85;88;85;87;88;92;86;89;84 03:59:55 INFO - PROCESS | 1689 | |6;imaging-darkroom;95;96;97;96;102;95;96;96;95;95 03:59:55 INFO - PROCESS | 1689 | |7;imaging-desaturate;86;85;85;85;85;83;83;86;86;87 03:59:55 INFO - PROCESS | 1689 | |8;json-parse-financial;56;55;53;52;54;55;57;56;56;57 03:59:55 INFO - PROCESS | 1689 | |9;json-stringify-tinderbox;64;71;75;74;72;68;67;67;69;93 03:59:55 INFO - PROCESS | 1689 | |10;stanford-crypto-aes;83;85;84;85;80;81;83;87;94;103 03:59:55 INFO - PROCESS | 1689 | |11;stanford-crypto-ccm;137;136;136;134;135;141;145;139;177;133 03:59:55 INFO - PROCESS | 1689 | |12;stanford-crypto-pbkdf2;166;168;163;167;147;207;221;219;164;163 03:59:55 INFO - PROCESS | 1689 | |13;stanford-crypto-sha256-iterative;68;66;66;66;66;69;65;66;67;64 03:59:55 INFO - PROCESS | 1689 | __end_tp_report 03:59:55 INFO - PROCESS | 1689 | __start_cc_report 03:59:55 INFO - PROCESS | 1689 | _x_x_mozilla_cycle_collect,1970 03:59:55 INFO - PROCESS | 1689 | __end_cc_report 03:59:55 INFO - PROCESS | 1689 | __startTimestamp1475233195550__endTimestamp 03:59:55 INFO - PROCESS | 1689 | 03:59:55 INFO - PROCESS | 1689 | ------- Summary: start ------- 03:59:55 INFO - PROCESS | 1689 | Number of tests: 14 03:59:55 INFO - PROCESS | 1689 | 03:59:55 INFO - PROCESS | 1689 | [#0] ai-astar Cycles:10 Average:114.10 Median:114.50 stddev:0.88 (0.8%) stddev-sans-first:0.87 03:59:55 INFO - PROCESS | 1689 | Values: 115.0 115.0 115.0 114.0 113.0 115.0 113.0 113.0 114.0 114.0 03:59:55 INFO - PROCESS | 1689 | 03:59:55 INFO - PROCESS | 1689 | [#1] audio-beat-detection Cycles:10 Average:122.10 Median:133.50 stddev:22.71 (17.0%) stddev-sans-first:23.81 03:59:55 INFO - PROCESS | 1689 | Values: 132.0 105.0 108.0 137.0 111.0 87.0 112.0 135.0 169.0 125.0 03:59:55 INFO - PROCESS | 1689 | 03:59:55 INFO - PROCESS | 1689 | [#2] audio-dft Cycles:10 Average:183.40 Median:184.00 stddev:1.26 (0.7%) stddev-sans-first:1.24 03:59:55 INFO - PROCESS | 1689 | Values: 182.0 183.0 184.0 186.0 183.0 184.0 182.0 182.0 184.0 184.0 03:59:55 INFO - PROCESS | 1689 | 03:59:55 INFO - PROCESS | 1689 | [#3] audio-fft Cycles:10 Average:66.70 Median:62.00 stddev:12.41 (20.0%) stddev-sans-first:11.68 03:59:55 INFO - PROCESS | 1689 | Values: 83.0 58.0 58.0 88.0 64.0 60.0 58.0 59.0 82.0 57.0 03:59:55 INFO - PROCESS | 1689 | 03:59:55 INFO - PROCESS | 1689 | [#4] audio-oscillator Cycles:10 Average:87.30 Median:70.50 stddev:17.47 (24.8%) stddev-sans-first:18.48 03:59:55 INFO - PROCESS | 1689 | Values: 91.0 65.0 93.0 71.0 67.0 70.0 111.0 98.0 100.0 107.0 03:59:55 INFO - PROCESS | 1689 | 03:59:55 INFO - PROCESS | 1689 | [#5] imaging-gaussian-blur Cycles:10 Average:87.10 Median:87.50 stddev:2.33 (2.7%) stddev-sans-first:2.47 03:59:55 INFO - PROCESS | 1689 | Values: 87.0 85.0 88.0 85.0 87.0 88.0 92.0 86.0 89.0 84.0 03:59:55 INFO - PROCESS | 1689 | 03:59:55 INFO - PROCESS | 1689 | [#6] imaging-darkroom Cycles:10 Average:96.30 Median:96.00 stddev:2.11 (2.2%) stddev-sans-first:2.19 03:59:55 INFO - PROCESS | 1689 | Values: 95.0 96.0 97.0 96.0 102.0 95.0 96.0 96.0 95.0 95.0 03:59:55 INFO - PROCESS | 1689 | 03:59:55 INFO - PROCESS | 1689 | [#7] imaging-desaturate Cycles:10 Average:85.10 Median:85.50 stddev:1.29 (1.5%) stddev-sans-first:1.32 03:59:55 INFO - PROCESS | 1689 | Values: 86.0 85.0 85.0 85.0 85.0 83.0 83.0 86.0 86.0 87.0 03:59:55 INFO - PROCESS | 1689 | 03:59:55 INFO - PROCESS | 1689 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:56.00 stddev:1.66 (3.0%) stddev-sans-first:1.73 03:59:55 INFO - PROCESS | 1689 | Values: 56.0 55.0 53.0 52.0 54.0 55.0 57.0 56.0 56.0 57.0 03:59:55 INFO - PROCESS | 1689 | 03:59:55 INFO - PROCESS | 1689 | [#9] json-stringify-tinderbox Cycles:10 Average:72.00 Median:71.50 stddev:8.12 (11.4%) stddev-sans-first:8.08 03:59:55 INFO - PROCESS | 1689 | Values: 64.0 71.0 75.0 74.0 72.0 68.0 67.0 67.0 69.0 93.0 03:59:55 INFO - PROCESS | 1689 | 03:59:55 INFO - PROCESS | 1689 | [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:84.50 stddev:6.96 (8.2%) stddev-sans-first:7.27 03:59:55 INFO - PROCESS | 1689 | Values: 83.0 85.0 84.0 85.0 80.0 81.0 83.0 87.0 94.0 103.0 03:59:55 INFO - PROCESS | 1689 | 03:59:55 INFO - PROCESS | 1689 | [#11] stanford-crypto-ccm Cycles:10 Average:141.30 Median:138.00 stddev:13.04 (9.4%) stddev-sans-first:13.74 03:59:55 INFO - PROCESS | 1689 | Values: 137.0 136.0 136.0 134.0 135.0 141.0 145.0 139.0 177.0 133.0 03:59:55 INFO - PROCESS | 1689 | 03:59:55 INFO - PROCESS | 1689 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.50 Median:167.50 stddev:26.54 (15.8%) stddev-sans-first:27.76 03:59:55 INFO - PROCESS | 1689 | Values: 166.0 168.0 163.0 167.0 147.0 207.0 221.0 219.0 164.0 163.0 03:59:55 INFO - PROCESS | 1689 | 03:59:55 INFO - PROCESS | 1689 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.00 stddev:1.42 (2.1%) stddev-sans-first:1.36 03:59:55 INFO - PROCESS | 1689 | Values: 68.0 66.0 66.0 66.0 66.0 69.0 65.0 66.0 67.0 64.0 03:59:55 INFO - PROCESS | 1689 | -------- Summary: end -------- 03:59:55 INFO - PROCESS | 1689 | 03:59:56 INFO - TEST-INFO | 1689: exit 0 03:59:56 INFO - TEST-OK | kraken | took 58858ms 03:59:56 INFO - SUITE-END | took 1175s 03:59:56 INFO - Completed test suite (00:19:36) 03:59:56 INFO - javascript benchmark 03:59:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3328.6837750413715, 3357.5467311912894, 3367.292868497617, 3384.712299454546, 3408.863645454182, 5670.177824215486, 5716.657000579969, 5724.62789918655, 5759.992001399754, 5794.82615521534, 5663.546916246691, 5673.914891276634, 5744.856378590537, 5751.884962300752, 5772.509336706375, 5206.009074238809, 5219.921701174486, 5239.502247286521, 5268.762905669254, 5275.024120537693, 5175.8188463403785, 5178.766955487012, 5186.377634683824, 5327.973360133194, 5337.733113344337, 5203.635745497817, 5248.21276808478, 5249.42256351801, 5273.997940391313, 5283.0, 5256.1852912798195, 5268.841934741945, 5296.576273898079, 5307.893842123136, 5314.335708036496, 5137.357830271216, 5186.403563590197, 5248.6588371755715, 5249.632525723201, 5252.789888404459, 5600.775968961237, 5645.181448689917, 5675.829725108253, 5679.716014199274, 5712.57155713319, 6182.381761823826, 6222.719977601018, 6230.470410015108, 6253.718582663745, 6298.307186209513, 6278.246610406734, 6330.525210609223, 6332.493400527993, 6335.30311665721, 6337.7781777637565, 5477.589180811455, 5516.034693928546, 5646.97176514123, 5713.885722285531, 5802.883942321172, 6106.794380079898, 6138.202033735586, 6144.2319710036245, 6144.662043587646, 6167.722452489649, 5774.566907481955, 5783.132530120515, 5785.855353616109, 5789.189513468118, 5794.942050579524, 5916.171735956969, 6126.142340072393, 6131.14164017038, 6171.1668924694595, 6173.0, 5133.974330128325, 6233.407826256498, 6260.092286618415, 6266.436020758154, 6273.278572964076, 6242.687865606701, 6276.717547710364, 6294.244690637152, 6296.590721603081, 6297.905531417033, 4816.277558366273, 4817.614590832795, 4970.105381031377, 4973.502649734997, 4976.651634385631, 4421.159979603865, 4427.889302767392, 4457.487388950312, 4458.286674132123, 4524.276115821453, 5745.942540574624, 5765.596408251466, 5772.567057470623, 5776.855578610568, 5786.594938354359, 6335.954567496311, 6339.524535659844, 6355.237371515448, 6357.968210159012, 6360.204974378203, 5584.776608935678, 5664.886702266014, 5692.857678558069, 5693.4021927696995, 5733.827985160452, 5380.542653874386, 5385.676859388449, 5407.053765591085, 5432.239486471897, 5437.864053398617, 6323.462505686976, 6336.936630633819, 6348.238211414568, 6370.1718776558755, 6372.7132279047555, 6114.206128133634, 6240.656763878031, 6254.874902502015, 6295.3704629538515, 6306.274778400542, 6305.337939516285, 6343.619382837044, 6355.237371515448, 6363.077353783768, 6371.681415929278, 6173.32093469727, 6190.81427557174, 6191.19514463117, 6193.938060619516, 6202.968985155046, 5514.841883204412, 6206.348333425106, 6210.4100110489435, 6243.032329988859, 6275.654838983717, 5735.197072409783, 5979.671118088547, 6039.245094363205, 6069.787557435468, 6122.816315510364, 6101.067587332183, 6127.556056270569, 6132.569672417391, 6133.457080270946, 6159.260888693386, 5781.508571771446, 5946.405359464019, 5955.821325360246, 5962.16529685853, 5973.1637570741, 5894.6757928314355, 5965.0, 5993.340732519332, 6006.969965150146, 6127.295361033538, 5315.415304316445, 5872.265966754156, 5878.147668588116, 5880.441358070976, 5882.852928676817], "value": 5683.4578621877645, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [482.6331987689356, 528.2287859724801, 530.8672831792052, 538.7037129578731, 544.6813614035789, 30866.845665771667, 31595.52606710898, 31617.20956976077, 31637.367252654964, 41789.0, 41150.0, 44236.11527769443, 44268.11463770723, 44365.7781711091, 44433.33349999745, 9697.709068727949, 9836.06557377048, 9856.50717464124, 9858.901410985905, 9878.802423951516, 8726.650933962634, 8870.11298870111, 9684.273679474067, 9783.46190959497, 9791.755206119833, 8910.732678019669, 8966.551672416386, 8983.371164018521, 11959.0, 12206.816897746541, 12082.033437325037, 12160.817587736192, 12162.5134994601, 12169.391530423443, 12185.20796148252, 10123.29136960413, 11949.820752688716, 12047.879521204763, 12062.215955962922, 12157.209781364183, 40770.59229407727, 41039.58960410387, 41145.76562703124, 41221.38167927483, 41221.793891030655, 3345.698887100148, 3409.727221822273, 3442.242706604543, 3469.757117001811, 3804.2771873344254, 29809.0, 29847.70152298471, 29907.102786916428, 30865.061520670013, 31050.53424198639, 3144.842757862121, 3182.586263785693, 3378.2398960233995, 3387.339468803584, 3394.35507253621, 516797.0, 517525.0, 518529.40735296457, 518812.0, 521561.9999999962, 61464.38535614587, 61718.0742288866, 61818.38181618126, 61874.69062654658, 61972.07041894375, 64016.0, 64139.35860641427, 64158.679206603665, 64175.679121604095, 64310.0, 16374.426895058616, 16580.0, 16596.17019149038, 16605.83394166067, 16607.335706571845, 12684.873151268554, 12799.232046077079, 12804.551840685717, 12808.80786788199, 12811.935940320238, 14617.853821461862, 14975.251237438084, 16999.74500382495, 17078.658426831393, 17087.316507339816, 5564.4713752193475, 6381.64900930444, 6409.391107844747, 6420.967895160587, 6458.5479016469335, 852.9019162796358, 956.8277710012126, 994.8109859126743, 1008.4554340655964, 1110.0675432636624, 29192.0, 29376.0, 29557.0, 29725.108246752632, 30566.54150187749, 883.5979629268796, 1028.3058935218698, 1058.349115294104, 1130.3387518301722, 1141.345539389789, 14875.505532810406, 15363.92318038425, 15443.382264709286, 15690.372385104696, 15849.0, 619055.0, 625810.0, 629837.0, 630186.0, 630528.0, 49943.75028124836, 50605.0, 57252.713736431884, 57500.56248593735, 58567.0, 1295.4947570447532, 1327.8141060251573, 1339.7674139791416, 1356.3015047250872, 1357.9932100339634, 30128.800823366324, 31159.442027898967, 31572.526412103376, 31810.840945795124, 32098.67901320957, 50201.748991256274, 50575.49424505708, 50617.74691126521, 50878.74560627321, 50947.0, 595647.0, 608398.0, 608958.0, 814170.0, 814227.0, 25824.8708756455, 26111.608325875506, 26153.476930461664, 26166.0, 26227.475450491263, 46333.76833115813, 46405.0, 46741.29888051614, 46956.0, 47350.526494734615, 38389.0, 38591.6140838588, 39252.803735981135, 39562.80218598888, 40539.18921621492, 36784.81607592052, 38166.80916595399, 39771.0, 40225.0, 40258.396124058745, 37135.25729485449, 37468.43797343096, 38092.2381552373, 38488.2302353957, 38628.6137138625, 33115.50326745149, 34915.65084349226, 36021.45967810432, 36065.737699180405, 36769.63230367662, 25946.048613228406, 26045.0, 26136.8693156533, 26445.0, 26747.930082797247], "value": 20216.9785616535, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.95385599872014, 371.65436144385717, 376.23171095849494, 384.9326367885619, 403.5581038762556, 14938.5518434447, 15412.768808467868, 16853.073080980557, 20193.697094543557, 20857.165713371483, 19585.804141958575, 20229.393118206477, 20421.693674594855, 20475.771453712787, 20644.0, 4834.879128021792, 4989.3513843200335, 5243.187305967581, 5256.658317209388, 5268.868278293055, 5459.235707001023, 5786.421357864222, 5838.5329173666005, 5848.239728835246, 5870.324912635037, 5043.5965122790085, 5632.746526406321, 5802.303723553158, 5804.65172089676, 5806.82579522615, 4373.846915357979, 5034.597232221414, 5059.49405059493, 5109.080365534202, 5110.923336149961, 4833.975830120827, 4919.483454237289, 4963.1810751226, 4976.87557811054, 4979.352684151074, 12367.319797411139, 12635.368231588383, 12647.683807904785, 12654.493820247179, 12657.177283476545, 2219.5671843990426, 2323.744388117306, 2474.8391354562077, 2955.3941442004552, 2967.4510215609967, 9459.952700236523, 9614.855777163279, 9688.031196880325, 9779.755506112404, 10034.799304013879, 1828.9725654115198, 1846.4829847642682, 1852.0647073228067, 1864.8414884734814, 1904.628597423503, 125666.0, 127811.72188278091, 132234.0, 133078.0, 134940.0, 10428.582856685647, 10787.244892857581, 10844.403557804397, 10925.399103049409, 11037.0, 13340.332983350794, 13375.398107085204, 13377.33113344329, 13381.063325567311, 13425.39585718645, 8209.630566624517, 8443.451175673561, 8443.788905277417, 8523.105073967268, 8604.827903442021, 8460.492370457792, 8487.618057187441, 8510.872336914952, 8626.0, 8650.134986501425, 4127.607877251657, 4245.3844192591905, 4249.745015299092, 4320.675949303814, 4421.690481666253, 1775.8046614872353, 1823.8569680625212, 1829.6798060339388, 1837.595728939631, 1853.7312089747181, 885.1590988560893, 894.592960203119, 905.456725964416, 967.3470407474927, 970.815545046439, 20549.89725051365, 21209.89395053015, 22941.558766184873, 23141.884290578775, 23530.529389412117, 915.5020383062828, 935.9110884465965, 941.8022215334856, 961.4471678784587, 1014.442056868734, 11087.279326843729, 11481.425928703698, 11483.36841473727, 11488.88511114895, 11489.0, 640755.0, 647213.0, 648950.0, 656982.0, 658253.0, 100634.49682751686, 121511.0, 131494.0, 135924.0, 144108.0, 962.5812771444444, 980.127686359141, 991.0188912976101, 992.3053862296422, 994.100339193017, 19031.238750449826, 19522.414327570197, 19935.10292036833, 20028.799712003278, 20054.398368048984, 37047.8147609271, 56135.71932140313, 57562.0, 57601.423985759604, 60880.695596521735, 76737.84893226718, 82362.17637823545, 84131.0, 85955.0, 87734.0, 7787.532748035136, 7788.415868809749, 7826.804329891798, 7877.133515313197, 8147.307478864363, 9235.676751313671, 12453.439595218055, 12493.500259989862, 12932.288724119888, 13049.0, 10642.680719578426, 11004.39475828837, 11078.279911805706, 11186.664400068012, 11290.49192786343, 10314.381137131797, 10596.31123976939, 10847.349159050482, 10925.83611245816, 10946.56213751473, 10711.0, 10869.29349592274, 10964.616238431616, 11020.173486988348, 11090.057345125755, 5936.910946335895, 6312.526560508072, 7083.468739844429, 7208.96395518019, 7265.20082790882, 8075.83848323042, 10707.250492465453, 10713.303635263683, 10889.673309800719, 11166.0], "value": 9187.93539351374, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1515.6817068415635, 1542.344503585976, 1724.241333813122, 1869.5232715657505, 1886.094674556214, 7862.724804631839, 8105.878411823827, 8390.20293072158, 8862.689805856788, 8870.334724895627, 7997.720079797208, 8082.353411727063, 8092.959535202316, 8454.239118479336, 8662.350323725714, 2321.1527792355837, 2348.3189874936247, 2349.6710460535537, 2350.8236882233814, 2352.12971200656, 2327.453048533593, 2337.9532409351887, 2349.259983105316, 2370.0401337458356, 2376.4771750214927, 2347.2371479269304, 2355.9175428859994, 2369.7393286738443, 2372.395039264985, 2384.1178763857397, 2318.8840557972035, 2329.6621989811465, 2339.9532009359887, 2340.0639744102496, 2340.941476463085, 2324.360800779799, 2330.0679728108894, 2331.4521087544413, 2335.9065637374483, 2338.6375111857687, 8737.995130560003, 8827.823443531093, 8836.8674469883, 8852.734417967471, 8881.289496840238, 5108.948910510921, 5273.3935597406025, 5274.525292723673, 5278.630495865291, 5280.656757310762, 3358.261182539837, 3446.913827154316, 3550.609432962372, 3556.0931962349696, 3567.94648080279, 948.7201275623638, 954.2175416158752, 955.0783493928393, 961.8509131084624, 967.8354679704468, 11567.248128871597, 11590.536378544848, 11601.535938562447, 11604.361760103191, 11641.883581164164, 4550.772461376918, 4591.104734576726, 4648.48866624671, 4679.368285281512, 4738.763061846963, 9991.650292239738, 9995.900040999497, 10007.649732259482, 10025.448600327052, 10032.69901902944, 5257.737113144328, 5263.894722105613, 5277.472252774692, 5285.127953887642, 5288.915772266676, 4248.957510424856, 4546.1135078659345, 4792.9281060784115, 4833.250846118787, 4839.516048395203, 3400.8607116616213, 3910.4329872168946, 3915.686745060388, 4002.6397624213378, 4040.2525532775944, 1270.5668644545592, 1282.7178020835402, 1288.8066789981578, 1292.5476083370745, 1298.266479439114, 778.8481246156945, 874.3136637739344, 887.8535041718044, 914.7392992996964, 929.3587424676952, 5575.944240557624, 5601.159826026129, 5619.915701264485, 5790.0, 5976.760929562769, 419.7418587568623, 422.38753806980003, 429.9656027517791, 431.0301820902968, 431.8035293941249, 3822.694184465236, 3835.9424608630893, 3890.513685789276, 4001.9399709004388, 4033.233685599727, 10054.74863128413, 10662.893371066346, 10679.626213082505, 10748.355098694103, 10893.782124357469, 9073.77315567116, 10276.332038417479, 10713.035826775627, 10749.83875241872, 10758.462076896123, 6298.874022519615, 7841.0, 8068.596570171585, 8113.959430202811, 8135.79660508492, 5726.2269593606, 5830.300363956352, 5898.233229680286, 5968.253968253968, 6008.339082700812, 9447.102525260365, 9693.030696930251, 9850.753731156492, 9877.50612469388, 9907.752306192402, 9809.901900980898, 10076.193904487476, 10121.544530495998, 10122.240831937486, 10241.283110182216, 6851.109355783717, 7295.562266264041, 7446.0, 7545.886811697938, 7598.392128629807, 8350.749477515441, 8441.535715535705, 8446.95776521138, 8458.281046110904, 8491.320694344562, 7293.4894557382595, 7418.406527477681, 7452.217517160837, 7478.326950574475, 7529.774106776806, 7227.530210536298, 7296.7810965671115, 7325.890111648223, 7423.740169094056, 7447.329740323397, 6969.372756451944, 6988.860222795617, 7025.2272250053475, 7036.612986285803, 7060.6116663584, 4879.707217566957, 4895.877603059952, 4911.312416261655, 4949.232868905326, 4951.801927922987, 4831.227003679394, 4856.514348565256, 4879.634027447884, 5009.949900500948, 5026.899462010812], "value": 4439.654313167767, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.75618236863403, 294.52728370964604, 301.1252312033542, 305.4623862002877, 308.53257315167514, 5412.61711430356, 5414.269073675053, 5445.210444485548, 5502.147167189092, 5514.558835293177, 4260.552641972595, 5062.493750624935, 5219.895602087956, 5254.369475662917, 5329.920051199235, 3333.0, 3493.7205023598176, 4064.9187016259657, 4070.6336429721246, 4073.226087043467, 3732.3841566141555, 4119.6704263658985, 4129.6283334499885, 4132.73137246078, 4157.792110394468, 3809.5999920008417, 4058.0, 4073.6372903715774, 4084.326086195774, 4145.191687620915, 4043.9191216175805, 4077.1845630873945, 4096.877093687194, 4130.153318569686, 4136.131412403399, 3045.4670432674416, 3444.225049363873, 3457.2566898116775, 3460.602030766469, 3465.7696517736094, 5000.649954503187, 5165.63840531163, 5350.3312085989255, 5399.839034607539, 5412.972935135299, 4533.727976321431, 4599.29825964392, 4635.450502223797, 4642.466116396624, 4657.324687920266, 5013.373328333958, 5252.923150754086, 5619.157126431027, 5738.020382967869, 5775.16260142277, 3505.754597178173, 3593.568771747381, 3843.846246150151, 3853.7109716771074, 3879.642125256166, 5433.75023744537, 5441.530786687651, 5872.853178670524, 5933.792317268875, 5974.4921681657115, 3469.826508674556, 3635.8727444539313, 3833.15670552478, 3838.2364697417815, 3846.769193848378, 3889.3388124018984, 3927.5286965563746, 3930.0, 3930.3514920038447, 3938.15329704115, 4094.5905409458815, 4207.852725154605, 4504.1216962692615, 4609.400777898919, 4631.930521042187, 4993.675411098267, 5700.686462244616, 5703.948387612607, 5744.626599271118, 5823.82528524145, 1059.9894001060045, 1129.5877004893155, 1249.3503378243263, 1313.3498918035634, 1357.762391581489, 810.1776696652902, 849.3884403229665, 868.4224990381452, 895.5298468304062, 901.7204666553389, 4548.613367863769, 5224.346956630421, 5412.648177868426, 5432.782688692487, 5512.9678676727635, 5522.282103326542, 5876.324222714357, 5877.941220587825, 5983.252093488314, 6001.729922153513, 5293.470652934676, 5306.8407947761625, 5328.307320048369, 5330.733463326818, 5346.492083252085, 2500.8374455660323, 2554.1698947842024, 2653.893844246247, 2995.876546295139, 3055.334842510837, 5094.363204599425, 5196.376434827845, 5488.53347465462, 5537.529310008695, 5789.652620842763, 4943.454121127622, 5325.627206095536, 5374.650647707965, 5482.7115627827425, 5840.970795146082, 5324.227986941949, 5637.943620563742, 5684.8863022739315, 5878.677297608089, 6081.138477067006, 5228.45101264377, 5369.865753356197, 5886.205362276038, 5941.881162376815, 5943.81123775238, 5723.996601189717, 5806.332271788629, 5873.324567674772, 5889.293284805851, 5910.276525788726, 5518.558515318685, 5700.68884156638, 5876.853078673067, 5991.370906054802, 6099.298580663103, 3975.9523845219155, 4011.6590089841525, 4019.9397009045474, 4037.475128233311, 4039.434479172977, 5216.93052924142, 5432.18517222404, 5946.710516451111, 5965.850853728692, 5991.940080599138, 4740.1230772307235, 4797.4482934461585, 5209.270702101633, 5879.0, 5879.794207202727, 4861.0, 5294.643883471818, 5668.234788303526, 5688.943110568841, 5741.827745167651, 5307.601929855354, 5505.550030236506, 5508.807191748269, 5520.227168196376, 5607.299087614048, 4706.093942028177, 5154.561862241751, 5795.275590551181, 5811.883762324815, 5841.452015216056, 4907.484714104968, 5480.808171713971, 5632.408597097246, 5645.943540564542, 5692.48767610917], "value": 4106.821049080138, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [600.1837500998641, 769.0041396391672, 787.6967367563486, 798.6805277888848, 837.1712005114935, 14667.119972801625, 15398.538043858674, 15748.448804291853, 16146.111963841984, 16554.0, 14524.201168935704, 14920.850791492081, 14936.327865246063, 14937.402503899832, 14942.10347379158, 681.111149949316, 694.6283738200063, 699.0, 841.1336323586701, 864.8097418567936, 843.1147295339869, 855.1405837133672, 869.5478351257342, 870.503812826689, 873.2010210657241, 919.7240827751681, 920.6409500294857, 920.9493477858715, 922.1516205091299, 923.7921467669754, 703.0403499223574, 722.1478655186877, 911.813078318943, 913.5158366065996, 913.8172365526888, 656.2584279763836, 672.2370109925221, 672.4284358295458, 672.5729161982127, 674.0731494195481, 15124.319405626664, 15170.544883653509, 15191.620209494851, 15192.0, 15192.772108418383, 11752.882471175264, 13216.405261763244, 13775.0, 13935.303234838319, 14240.287985600678, 10672.519736611872, 11037.668869933916, 11161.27451715644, 12543.435545400478, 12747.980161587051, 4572.679912406133, 4602.0, 4676.485586585472, 4739.265413860857, 4762.738049407281, 114133.42933285363, 114669.0, 117368.0, 118504.0, 118979.40510297393, 10509.0, 10639.521221545048, 10789.892101079045, 10804.027637512661, 10870.0, 20422.489437763878, 20462.87454190004, 20484.46366522487, 20500.17999280042, 20501.17995280172, 7612.543247405173, 7615.048118985127, 7739.690412383442, 7806.414518911104, 7886.44794864354, 4208.91582168361, 4339.609435150788, 4361.934570981438, 4375.649948004152, 4508.864734057984, 3362.176266814646, 3481.338545676364, 3482.564679415073, 3490.3891818931584, 3492.301539692072, 598.2730981856978, 606.5026678123896, 617.5337620096798, 627.6453803601042, 629.2669040567687, 516.8811173430057, 580.8141394753723, 624.2166081567603, 626.4862812493711, 642.2004604267623, 8898.243649289754, 9103.772405689911, 9270.119338662817, 9353.251739860794, 9450.0, 546.7266366816592, 603.915970832357, 621.3196549777986, 628.4281304013417, 648.9935100649028, 4500.437445319335, 4510.819567217274, 4524.638028957741, 4536.591706746409, 4573.56551127649, 162229.18885405498, 162940.18529907273, 165921.0, 168593.0, 169929.0, 93340.0, 134901.3254933719, 138866.0, 140711.29644351712, 142925.8561121584, 120855.0, 123593.38203309105, 123960.0, 124122.0, 127697.0, 7151.962965370096, 8731.65073397057, 8750.518721470125, 8774.824503510023, 9044.547772611211, 67433.3256667427, 67995.0, 68133.65933170501, 68689.31310686829, 69593.0, 102663.4866825691, 103483.4825825866, 104014.47992759988, 106819.0, 107355.0, 10831.187660925305, 11179.0, 11211.943940280247, 11430.714232144262, 11644.53421863116, 11981.64055078349, 12082.637520874388, 12474.563390281297, 12649.430775614936, 12831.935840320739, 11625.476853541442, 11915.987141093105, 11981.865931717728, 12062.276263424223, 12187.51249949992, 11919.642410727693, 11975.323454716521, 12022.813954301942, 12087.335196564274, 12119.81820272679, 10167.593296268067, 11702.122340824302, 11705.180637355303, 11711.941440292743, 11758.82361764557, 9900.801983960424, 10024.198064154703, 10063.647772327933, 10249.84625230637, 10376.429296388771, 9934.503274836374, 10164.440955747505, 10168.440735759308, 10184.949075254874, 10205.0], "value": 7669.21107012255, "unit": "score"}], "name": "dromaeo_css", "value": 7269.980218907278, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 115.0, 114.0, 113.0, 115.0, 113.0, 113.0, 114.0, 114.0], "value": 114.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 105.0, 108.0, 137.0, 111.0, 87.0, 112.0, 135.0, 169.0, 125.0], "value": 122.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 183.0, 184.0, 186.0, 183.0, 184.0, 182.0, 182.0, 184.0, 184.0], "value": 183.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 58.0, 58.0, 88.0, 64.0, 60.0, 58.0, 59.0, 82.0, 57.0], "value": 66.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 65.0, 93.0, 71.0, 67.0, 70.0, 111.0, 98.0, 100.0, 107.0], "value": 87.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 88.0, 85.0, 87.0, 88.0, 92.0, 86.0, 89.0, 84.0], "value": 87.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 97.0, 96.0, 102.0, 95.0, 96.0, 96.0, 95.0, 95.0], "value": 96.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 85.0, 85.0, 85.0, 83.0, 83.0, 86.0, 86.0, 87.0], "value": 85.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 53.0, 52.0, 54.0, 55.0, 57.0, 56.0, 56.0, 57.0], "value": 55.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 71.0, 75.0, 74.0, 72.0, 68.0, 67.0, 67.0, 69.0, 93.0], "value": 72.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 84.0, 85.0, 80.0, 81.0, 83.0, 87.0, 94.0, 103.0], "value": 86.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 136.0, 136.0, 134.0, 135.0, 141.0, 145.0, 139.0, 177.0, 133.0], "value": 141.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 168.0, 163.0, 167.0, 147.0, 207.0, 221.0, 219.0, 164.0, 163.0], "value": 178.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 66.0, 66.0, 66.0, 69.0, 65.0, 66.0, 67.0, 64.0], "value": 66.3, "unit": "score"}], "name": "kraken", "value": 1441.8, "alertThreshold": 2.0}]} 03:59:56 INFO - Return code: 0 03:59:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:59:56 INFO - # TBPL SUCCESS # 03:59:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:59:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:59:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:59:56 INFO - 2016-09-30 03:59:56.878 screenresolution[1693:10098] starting screenresolution argv=screenresolution get 03:59:56 INFO - 2016-09-30 03:59:56.880 screenresolution[1693:10098] Display 0: 1600x1200x32@60 03:59:56 INFO - 2016-09-30 03:59:56.886 screenresolution[1694:10101] starting screenresolution argv=screenresolution list 03:59:56 INFO - Available Modes on Display 0 03:59:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:59:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:59:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:59:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:59:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:59:57 INFO - Intel Iris: 03:59:57 INFO - Chipset Model: Intel Iris 03:59:57 INFO - Type: GPU 03:59:57 INFO - Bus: Built-In 03:59:57 INFO - VRAM (Dynamic, Max): 1536 MB 03:59:57 INFO - Vendor: Intel (0x8086) 03:59:57 INFO - Device ID: 0x0a2e 03:59:57 INFO - Revision ID: 0x0009 03:59:57 INFO - Displays: 03:59:57 INFO - Display: 03:59:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:59:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:59:57 INFO - Display Serial Number: 1600x1200 60 03:59:57 INFO - Main Display: Yes 03:59:57 INFO - Mirror: Off 03:59:57 INFO - Online: Yes 03:59:57 INFO - Rotation: Supported 03:59:57 INFO - Return code: 0 03:59:57 INFO - Running post-action listener: _resource_record_post_action 03:59:57 INFO - [mozharness: 2016-09-30 10:59:57.120873Z] Finished run-tests step (success) 03:59:57 INFO - Running post-run listener: _resource_record_post_run 03:59:57 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 33311744; Write bytes: 664483840; Read time: 309; Write time: 2343 03:59:57 INFO - TinderboxPrint: CPU usage
53.4% 03:59:57 INFO - TinderboxPrint: I/O read bytes / time
33,311,744 / 309 03:59:57 INFO - TinderboxPrint: I/O write bytes / time
664,483,840 / 2,343 03:59:57 INFO - TinderboxPrint: CPU idle
2,255.6 (46.6%) 03:59:57 INFO - TinderboxPrint: CPU system
967.0 (20.0%) 03:59:57 INFO - TinderboxPrint: CPU user
1,615.1 (33.4%) 03:59:57 INFO - TinderboxPrint: Swap in / out
392,171,520 / 0 03:59:57 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 358134272; Write bytes: 355341824; Read time: 27503; Write time: 634 03:59:57 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 31546368; Write bytes: 298123776; Read time: 293; Write time: 1673 03:59:57 INFO - Running post-run listener: _upload_blobber_files 03:59:57 INFO - Blob upload gear active. 03:59:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:59:57 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:59:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:59:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:59:58 INFO - (blobuploader) - INFO - Open directory for files ... 03:59:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:59:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:59:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:59:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:59:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:59:59 INFO - (blobuploader) - INFO - Done attempting. 03:59:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:59:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:59:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:00:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:00:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:00:00 INFO - (blobuploader) - INFO - Done attempting. 04:00:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:00:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:00:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:00:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:00:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:00:06 INFO - (blobuploader) - INFO - Done attempting. 04:00:06 INFO - (blobuploader) - INFO - Iteration through files over. 04:00:06 INFO - Return code: 0 04:00:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:00:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:00:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/03bfd278b40cbbd4a6b1e0a7b8fa2f936d1f690d4632119737f49491a64742f62037ebf6b4d624edf2148b331a555398b9d87ec6e79ed0e55da6ed616be8598b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e464386058b45ce81979cb3470749d57b81588be0debab36691c726873de315fda40b69de95875cdd94caeb5d233b78b86f57e80d446bad63954bd15d43f3932", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b91847870e755a8ce0d9b4befc97d547e14e003eb090a70e05618cf22f570fe6bdf88709dff64848c935cd56e570bc1b404206f324007c53c5aab030781697ab"} 04:00:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:00:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:00:06 INFO - Contents: 04:00:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/03bfd278b40cbbd4a6b1e0a7b8fa2f936d1f690d4632119737f49491a64742f62037ebf6b4d624edf2148b331a555398b9d87ec6e79ed0e55da6ed616be8598b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e464386058b45ce81979cb3470749d57b81588be0debab36691c726873de315fda40b69de95875cdd94caeb5d233b78b86f57e80d446bad63954bd15d43f3932", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b91847870e755a8ce0d9b4befc97d547e14e003eb090a70e05618cf22f570fe6bdf88709dff64848c935cd56e570bc1b404206f324007c53c5aab030781697ab"} 04:00:06 INFO - Running post-run listener: copy_logs_to_upload_dir 04:00:06 INFO - Copying logs to upload dir... 04:00:06 INFO - mkdir: /builds/slave/test/build/upload/logs 04:00:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.730565 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-09-30 04:00:06.433599) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-30 04:00:06.438330) ========= 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.Vw31ccZC9o/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.ivLl4S0GyV/Listeners TMPDIR=/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/03bfd278b40cbbd4a6b1e0a7b8fa2f936d1f690d4632119737f49491a64742f62037ebf6b4d624edf2148b331a555398b9d87ec6e79ed0e55da6ed616be8598b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e464386058b45ce81979cb3470749d57b81588be0debab36691c726873de315fda40b69de95875cdd94caeb5d233b78b86f57e80d446bad63954bd15d43f3932", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b91847870e755a8ce0d9b4befc97d547e14e003eb090a70e05618cf22f570fe6bdf88709dff64848c935cd56e570bc1b404206f324007c53c5aab030781697ab"} build_url:https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011008 build_url: 'https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/03bfd278b40cbbd4a6b1e0a7b8fa2f936d1f690d4632119737f49491a64742f62037ebf6b4d624edf2148b331a555398b9d87ec6e79ed0e55da6ed616be8598b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e464386058b45ce81979cb3470749d57b81588be0debab36691c726873de315fda40b69de95875cdd94caeb5d233b78b86f57e80d446bad63954bd15d43f3932", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b91847870e755a8ce0d9b4befc97d547e14e003eb090a70e05618cf22f570fe6bdf88709dff64848c935cd56e570bc1b404206f324007c53c5aab030781697ab"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-30 04:00:06.474865) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 04:00:06.478273) ========= 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.Vw31ccZC9o/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.ivLl4S0GyV/Listeners TMPDIR=/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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.005294 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 04:00:06.526739) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-30 04:00:06.530126) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-30 04:00:06.530495) ========= ========= Total master_lag: 0.19 =========