builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0353 starttime: 1479114132.97 results: success (0) buildid: 20161114000520 builduid: 0c1a43545c3a4fae9cc95fa2aecee008 revision: 263190e20543fc7f39c6d41c8fd31cedccdbffd8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 01:02:12.970271) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 01:02:12.970895) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 01:02:12.971183) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 01:02:13.017273) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 01:02:13.017531) ========= 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.qkVivZqcSh/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.qNptwxkgUj/Listeners TMPDIR=/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-14 01:02:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 17.5M=0.001s 2016-11-14 01:02:13 (17.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.594834 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 01:02:13.634521) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 01:02:13.634840) ========= 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.qkVivZqcSh/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.qNptwxkgUj/Listeners TMPDIR=/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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.026759 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 01:02:13.683208) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-14 01:02:13.683520) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 263190e20543fc7f39c6d41c8fd31cedccdbffd8 --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 263190e20543fc7f39c6d41c8fd31cedccdbffd8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.qkVivZqcSh/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.qNptwxkgUj/Listeners TMPDIR=/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-14 01:02:13,769 truncating revision to first 12 chars 2016-11-14 01:02:13,769 Setting DEBUG logging. 2016-11-14 01:02:13,769 attempt 1/10 2016-11-14 01:02:13,769 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/263190e20543?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-14 01:02:14,504 unpacking tar archive at: mozilla-aurora-263190e20543/testing/mozharness/ program finished with exit code 0 elapsedTime=0.999062 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-14 01:02:14.704040) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 01:02:14.704328) ========= script_repo_revision: 263190e20543fc7f39c6d41c8fd31cedccdbffd8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 01:02:14.704699) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 01:02:14.704985) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 01:02:14.723038) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-11-14 01:02:14.723299) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.qkVivZqcSh/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.qNptwxkgUj/Listeners TMPDIR=/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 01:02:14 INFO - MultiFileLogger online at 20161114 01:02:14 in /builds/slave/test 01:02:14 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 01:02:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:02:14 INFO - {'append_to_log': False, 01:02:14 INFO - 'base_work_dir': '/builds/slave/test', 01:02:14 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 01:02:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:02:14 INFO - 'branch': 'Mozilla-Aurora', 01:02:14 INFO - 'buildbot_json_path': 'buildprops.json', 01:02:14 INFO - 'config_files': ('talos/mac_config.py',), 01:02:14 INFO - 'default_actions': ('clobber', 01:02:14 INFO - 'read-buildbot-config', 01:02:14 INFO - 'download-and-extract', 01:02:14 INFO - 'populate-webroot', 01:02:14 INFO - 'create-virtualenv', 01:02:14 INFO - 'install', 01:02:14 INFO - 'run-tests'), 01:02:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:02:14 INFO - 'download_minidump_stackwalk': True, 01:02:14 INFO - 'download_symbols': 'ondemand', 01:02:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:02:14 INFO - 'tooltool.py': '/tools/tooltool.py', 01:02:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:02:14 INFO - '/tools/misc-python/virtualenv.py')}, 01:02:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:02:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:02:14 INFO - 'installer_path': 'installer.exe', 01:02:14 INFO - 'log_level': 'info', 01:02:14 INFO - 'log_name': 'talos', 01:02:14 INFO - 'log_to_console': True, 01:02:14 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:02:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:02:14 INFO - 'opt_config_files': (), 01:02:14 INFO - 'pip_index': False, 01:02:14 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:02:14 INFO - 'cmd': ('bash', 01:02:14 INFO - '-c', 01:02:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:02:14 INFO - 'enabled': True, 01:02:14 INFO - 'halt_on_failure': False, 01:02:14 INFO - 'name': 'check_screen_resolution'},), 01:02:14 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:02:14 INFO - 'cmd': ('bash', 01:02:14 INFO - '-c', 01:02:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:02:14 INFO - 'enabled': True, 01:02:14 INFO - 'halt_on_failure': False, 01:02:14 INFO - 'name': 'check_screen_resolution'},), 01:02:14 INFO - 'run_cmd_checks_enabled': True, 01:02:14 INFO - 'sps_profile': False, 01:02:14 INFO - 'sps_profile_interval': 0, 01:02:14 INFO - 'suite': 'dromaeojs', 01:02:14 INFO - 'system_bits': '32', 01:02:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:02:14 INFO - 'title': 't-yosemite-r7-0353', 01:02:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:02:14 INFO - 'use_talos_json': True, 01:02:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:02:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:02:14 INFO - 'work_dir': 'build'} 01:02:14 INFO - [mozharness: 2016-11-14 09:02:14.927363Z] Running clobber step. 01:02:14 INFO - Running pre-action listener: _resource_record_pre_action 01:02:14 INFO - Running main action method: clobber 01:02:14 INFO - rmtree: /builds/slave/test/build 01:02:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:02:17 INFO - Running post-action listener: _resource_record_post_action 01:02:17 INFO - [mozharness: 2016-11-14 09:02:17.037136Z] Finished clobber step (success) 01:02:17 INFO - [mozharness: 2016-11-14 09:02:17.037318Z] Running read-buildbot-config step. 01:02:17 INFO - Running pre-action listener: _resource_record_pre_action 01:02:17 INFO - Running main action method: read_buildbot_config 01:02:17 INFO - Using buildbot properties: 01:02:17 INFO - { 01:02:17 INFO - "project": "", 01:02:17 INFO - "product": "firefox", 01:02:17 INFO - "script_repo_revision": "production", 01:02:17 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 01:02:17 INFO - "repository": "", 01:02:17 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 01:02:17 INFO - "buildid": "20161114000520", 01:02:17 INFO - "pgo_build": "False", 01:02:17 INFO - "basedir": "/builds/slave/test", 01:02:17 INFO - "buildnumber": 14, 01:02:17 INFO - "slavename": "t-yosemite-r7-0353", 01:02:17 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 01:02:17 INFO - "platform": "yosemite_r7", 01:02:17 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 01:02:17 INFO - "branch": "mozilla-aurora", 01:02:17 INFO - "repo_path": "releases/mozilla-aurora", 01:02:17 INFO - "revision": "263190e20543fc7f39c6d41c8fd31cedccdbffd8", 01:02:17 INFO - "stage_platform": "macosx64", 01:02:17 INFO - "builduid": "0c1a43545c3a4fae9cc95fa2aecee008", 01:02:17 INFO - "slavebuilddir": "test" 01:02:17 INFO - } 01:02:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/Lg31kfDoTbWhPy7_WiCeiQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 01:02:17 INFO - Running post-action listener: _resource_record_post_action 01:02:17 INFO - [mozharness: 2016-11-14 09:02:17.040550Z] Finished read-buildbot-config step (success) 01:02:17 INFO - [mozharness: 2016-11-14 09:02:17.040671Z] Running download-and-extract step. 01:02:17 INFO - Running pre-action listener: _resource_record_pre_action 01:02:17 INFO - Running main action method: download_and_extract 01:02:17 INFO - mkdir: /builds/slave/test/build/tests 01:02:17 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')]} 01:02:17 INFO - trying https://queue.taskcluster.net/v1/task/Lg31kfDoTbWhPy7_WiCeiQ/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 01:02:17 INFO - Downloading https://queue.taskcluster.net/v1/task/Lg31kfDoTbWhPy7_WiCeiQ/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 01:02:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Lg31kfDoTbWhPy7_WiCeiQ/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 01:02:18 INFO - Downloaded 1199 bytes. 01:02:18 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 01:02:18 INFO - Using the following test package requirements: 01:02:18 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 01:02:18 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 01:02:18 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 01:02:18 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 01:02:18 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 01:02:18 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 01:02:18 INFO - u'jsshell-mac.zip'], 01:02:18 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 01:02:18 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 01:02:18 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 01:02:18 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 01:02:18 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 01:02:18 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 01:02:18 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 01:02:18 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 01:02:18 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 01:02:18 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 01:02:18 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 01:02:18 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 01:02:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Lg31kfDoTbWhPy7_WiCeiQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 01:02:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Lg31kfDoTbWhPy7_WiCeiQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 01:02:18 INFO - Fetch https://queue.taskcluster.net/v1/task/Lg31kfDoTbWhPy7_WiCeiQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 01:02:18 INFO - Expected file size: 16423739 01:02:25 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 01:02:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Lg31kfDoTbWhPy7_WiCeiQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 01:02:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Lg31kfDoTbWhPy7_WiCeiQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 01:02:25 INFO - Fetch https://queue.taskcluster.net/v1/task/Lg31kfDoTbWhPy7_WiCeiQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 01:02:26 INFO - Expected file size: 16423739 01:02:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Lg31kfDoTbWhPy7_WiCeiQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 01:02:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Lg31kfDoTbWhPy7_WiCeiQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 01:02:33 INFO - Fetch https://queue.taskcluster.net/v1/task/Lg31kfDoTbWhPy7_WiCeiQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 01:02:33 INFO - Expected file size: 14414089 01:02:34 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')]} 01:02:34 INFO - trying https://queue.taskcluster.net/v1/task/Lg31kfDoTbWhPy7_WiCeiQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 01:02:34 INFO - Downloading https://queue.taskcluster.net/v1/task/Lg31kfDoTbWhPy7_WiCeiQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 01:02:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Lg31kfDoTbWhPy7_WiCeiQ/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 01:02:38 INFO - Downloaded 115559382 bytes. 01:02:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Lg31kfDoTbWhPy7_WiCeiQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 01:02:38 INFO - mkdir: /builds/slave/test/properties 01:02:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:02:38 INFO - Writing to file /builds/slave/test/properties/build_url 01:02:38 INFO - Contents: 01:02:38 INFO - build_url:https://queue.taskcluster.net/v1/task/Lg31kfDoTbWhPy7_WiCeiQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 01:02:38 INFO - Running post-action listener: _resource_record_post_action 01:02:38 INFO - Running post-action listener: set_extra_try_arguments 01:02:38 INFO - [mozharness: 2016-11-14 09:02:38.929690Z] Finished download-and-extract step (success) 01:02:38 INFO - [mozharness: 2016-11-14 09:02:38.929843Z] Running populate-webroot step. 01:02:38 INFO - Running pre-action listener: _resource_record_pre_action 01:02:38 INFO - Running main action method: populate_webroot 01:02:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:02:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:02:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:02:38 INFO - '--tppagecycles', 01:02:38 INFO - '7'], 01:02:38 INFO - 'tests': ['tsvgm']}}, 01:02:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:02:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:02:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:02:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:02:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:02:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:02:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:02:38 INFO - 'talos_options': ['--disable-e10s'], 01:02:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:02:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:02:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:02:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:02:38 INFO - 'talos_options': ['--disable-e10s'], 01:02:38 INFO - 'tests': ['damp', 'tps']}, 01:02:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:02:38 INFO - 'tests': ['damp', 'tps']}, 01:02:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:02:38 INFO - 'tests': ['dromaeo_dom']}, 01:02:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:02:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:02:38 INFO - 'tests': ['basic_compositor_video']}, 01:02:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:02:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:02:38 INFO - 'tests': ['a11yr', 01:02:38 INFO - 'ts_paint', 01:02:38 INFO - 'tpaint', 01:02:38 INFO - 'sessionrestore', 01:02:38 INFO - 'sessionrestore_no_auto_restore', 01:02:38 INFO - 'tabpaint']}, 01:02:38 INFO - 'other-e10s': {'tests': ['a11yr', 01:02:38 INFO - 'ts_paint', 01:02:38 INFO - 'tpaint', 01:02:38 INFO - 'sessionrestore', 01:02:38 INFO - 'sessionrestore_no_auto_restore', 01:02:38 INFO - 'tabpaint']}, 01:02:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:02:38 INFO - 'ts_paint', 01:02:38 INFO - 'tpaint', 01:02:38 INFO - 'sessionrestore', 01:02:38 INFO - 'sessionrestore_no_auto_restore', 01:02:38 INFO - 'tabpaint']}, 01:02:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:02:38 INFO - 'ts_paint', 01:02:38 INFO - 'tpaint', 01:02:38 INFO - 'sessionrestore', 01:02:38 INFO - 'sessionrestore_no_auto_restore', 01:02:38 INFO - 'tabpaint']}, 01:02:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:02:38 INFO - 'tests': ['a11yr', 01:02:38 INFO - 'ts_paint', 01:02:38 INFO - 'tpaint', 01:02:38 INFO - 'sessionrestore', 01:02:38 INFO - 'sessionrestore_no_auto_restore', 01:02:38 INFO - 'tabpaint']}, 01:02:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:02:38 INFO - 'tests': ['a11yr', 01:02:38 INFO - 'ts_paint', 01:02:38 INFO - 'tpaint', 01:02:38 INFO - 'sessionrestore', 01:02:38 INFO - 'sessionrestore_no_auto_restore', 01:02:38 INFO - 'tabpaint']}, 01:02:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:02:38 INFO - 'tests': ['tsvgx', 01:02:38 INFO - 'tsvgr_opacity', 01:02:38 INFO - 'tart', 01:02:38 INFO - 'tscrollx', 01:02:38 INFO - 'cart']}, 01:02:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:02:38 INFO - 'tsvgr_opacity', 01:02:38 INFO - 'tart', 01:02:38 INFO - 'tscrollx', 01:02:38 INFO - 'cart']}, 01:02:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:02:38 INFO - 'talos_options': ['--disable-e10s'], 01:02:38 INFO - 'tests': ['tp5o']}, 01:02:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:02:38 INFO - 'tests': ['tp5o']}, 01:02:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:02:38 INFO - 'talos_options': ['--disable-e10s', 01:02:38 INFO - '--xperf_path', 01:02:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:02:38 INFO - 'tests': ['tp5n']}, 01:02:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:02:38 INFO - 'talos_options': ['--xperf_path', 01:02:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:02:38 INFO - 'tests': ['tp5n']}}, 01:02:38 INFO - 'talos.zip': {'path': '', 01:02:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:02:38 INFO - Running post-action listener: _resource_record_post_action 01:02:38 INFO - [mozharness: 2016-11-14 09:02:38.948473Z] Finished populate-webroot step (success) 01:02:38 INFO - [mozharness: 2016-11-14 09:02:38.948611Z] Running create-virtualenv step. 01:02:38 INFO - Running pre-action listener: _resource_record_pre_action 01:02:38 INFO - Running main action method: create_virtualenv 01:02:38 INFO - Creating virtualenv /builds/slave/test/build/venv 01:02:38 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 01:02:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:02:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:02:39 INFO - Using real prefix '/tools/python27' 01:02:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:02:39 INFO - Installing distribute.............................................................................................................................................................................................done. 01:02:42 INFO - Installing pip.................done. 01:02:42 INFO - Return code: 0 01:02:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:02:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:02:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:02:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:02:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:02:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:02:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:02:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1071b7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10712d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c52cc3020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fcbd30>, '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 0x106e31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106fc3b20>, '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.qkVivZqcSh/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.qNptwxkgUj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 01:02:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:02:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:02:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qkVivZqcSh/Render', 01:02:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:02:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:02:42 INFO - 'HOME': '/Users/cltbld', 01:02:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:02:42 INFO - 'LOGNAME': 'cltbld', 01:02:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:02:42 INFO - 'MOZ_NO_REMOTE': '1', 01:02:42 INFO - 'NO_EM_RESTART': '1', 01:02:42 INFO - 'PAGER': '/bin/cat', 01:02:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:02:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:02:42 INFO - 'PWD': '/builds/slave/test', 01:02:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:02:42 INFO - 'SHELL': '/bin/bash', 01:02:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qNptwxkgUj/Listeners', 01:02:42 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 01:02:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:02:42 INFO - 'USER': 'cltbld', 01:02:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:02:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:02:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:02:42 INFO - 'XPC_FLAGS': '0x0', 01:02:42 INFO - 'XPC_SERVICE_NAME': '0', 01:02:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:02:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:02:42 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 01:02:42 INFO - Cleaning up... 01:02:42 INFO - Return code: 0 01:02:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:02:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:02:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:02:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:02:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:02:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:02:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:02:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1071b7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10712d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c52cc3020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fcbd30>, '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 0x106e31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106fc3b20>, '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.qkVivZqcSh/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.qNptwxkgUj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 01:02:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 01:02:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 01:02:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qkVivZqcSh/Render', 01:02:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:02:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:02:42 INFO - 'HOME': '/Users/cltbld', 01:02:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:02:42 INFO - 'LOGNAME': 'cltbld', 01:02:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:02:42 INFO - 'MOZ_NO_REMOTE': '1', 01:02:42 INFO - 'NO_EM_RESTART': '1', 01:02:42 INFO - 'PAGER': '/bin/cat', 01:02:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:02:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:02:42 INFO - 'PWD': '/builds/slave/test', 01:02:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:02:42 INFO - 'SHELL': '/bin/bash', 01:02:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qNptwxkgUj/Listeners', 01:02:42 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 01:02:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:02:42 INFO - 'USER': 'cltbld', 01:02:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:02:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:02:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:02:42 INFO - 'XPC_FLAGS': '0x0', 01:02:42 INFO - 'XPC_SERVICE_NAME': '0', 01:02:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:02:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:02:43 INFO - Downloading/unpacking psutil>=3.1.1 01:02: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 01:02: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 01:02: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 01:02: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 01:02: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 01:02: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 01:02:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:02:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:02:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:02:46 INFO - Installing collected packages: psutil 01:02:46 INFO - Running setup.py install for psutil 01:02:46 INFO - building 'psutil._psutil_osx' extension 01:02:46 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 01:02:47 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 01:02:47 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 01:02:47 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 01:02:47 INFO - building 'psutil._psutil_posix' extension 01:02:47 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 01:02:47 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:02:47 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:02:47 INFO - ^ 01:02:47 INFO - 1 warning generated. 01:02:47 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 01:02:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:02:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:02:47 INFO - Successfully installed psutil 01:02:47 INFO - Cleaning up... 01:02:47 INFO - Return code: 0 01:02:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:02: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')]} 01:02:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:02:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:02: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')]} 01:02:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:02:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:02: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1071b7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10712d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c52cc3020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fcbd30>, '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 0x106e31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106fc3b20>, '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.qkVivZqcSh/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.qNptwxkgUj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 01:02: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 01:02: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 mozsystemmonitor==0.3 01:02:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qkVivZqcSh/Render', 01:02:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:02:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:02:47 INFO - 'HOME': '/Users/cltbld', 01:02:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:02:47 INFO - 'LOGNAME': 'cltbld', 01:02:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:02:47 INFO - 'MOZ_NO_REMOTE': '1', 01:02:47 INFO - 'NO_EM_RESTART': '1', 01:02:47 INFO - 'PAGER': '/bin/cat', 01:02:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:02:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:02:47 INFO - 'PWD': '/builds/slave/test', 01:02:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:02:47 INFO - 'SHELL': '/bin/bash', 01:02:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qNptwxkgUj/Listeners', 01:02:47 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 01:02:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:02:47 INFO - 'USER': 'cltbld', 01:02:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:02:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:02:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:02:47 INFO - 'XPC_FLAGS': '0x0', 01:02:47 INFO - 'XPC_SERVICE_NAME': '0', 01:02:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:02:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:02:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:02:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:02:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:02:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:02:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:02:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:02:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:02:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:02:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:02:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:02:50 INFO - Installing collected packages: mozsystemmonitor 01:02:50 INFO - Running setup.py install for mozsystemmonitor 01:02:50 INFO - Successfully installed mozsystemmonitor 01:02:50 INFO - Cleaning up... 01:02:50 INFO - Return code: 0 01:02:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:02:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:02:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:02:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:02:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:02:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:02:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:02:50 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 0x1071b7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10712d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c52cc3020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fcbd30>, '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 0x106e31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106fc3b20>, '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.qkVivZqcSh/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.qNptwxkgUj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 01:02:50 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 01:02:50 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 01:02:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qkVivZqcSh/Render', 01:02:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:02:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:02:50 INFO - 'HOME': '/Users/cltbld', 01:02:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:02:50 INFO - 'LOGNAME': 'cltbld', 01:02:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:02:50 INFO - 'MOZ_NO_REMOTE': '1', 01:02:50 INFO - 'NO_EM_RESTART': '1', 01:02:50 INFO - 'PAGER': '/bin/cat', 01:02:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:02:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:02:50 INFO - 'PWD': '/builds/slave/test', 01:02:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:02:50 INFO - 'SHELL': '/bin/bash', 01:02:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qNptwxkgUj/Listeners', 01:02:50 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 01:02:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:02:50 INFO - 'USER': 'cltbld', 01:02:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:02:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:02:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:02:50 INFO - 'XPC_FLAGS': '0x0', 01:02:50 INFO - 'XPC_SERVICE_NAME': '0', 01:02:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:02:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:02:51 INFO - Downloading/unpacking jsonschema==2.5.1 01:02:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:02:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:02:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:02:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:02:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:02:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:02:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:02:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:02:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:02:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:02:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:02:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:02:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:02:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:02:54 INFO - Downloading functools32-3.2.3-2.tar.gz 01:02:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:02:54 INFO - warning: no files found matching '*.txt' 01:02:54 INFO - no previously-included directories found matching 'build' 01:02:54 INFO - no previously-included directories found matching 'dist' 01:02:54 INFO - no previously-included directories found matching '.git*' 01:02:54 INFO - Installing collected packages: jsonschema, functools32 01:02:54 INFO - Running setup.py install for functools32 01:02:54 INFO - warning: no files found matching '*.txt' 01:02:54 INFO - no previously-included directories found matching 'build' 01:02:54 INFO - no previously-included directories found matching 'dist' 01:02:54 INFO - no previously-included directories found matching '.git*' 01:02:54 INFO - Successfully installed jsonschema functools32 01:02:54 INFO - Cleaning up... 01:02:54 INFO - Return code: 0 01:02:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:02: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')]} 01:02:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:02:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:02: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')]} 01:02:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:02:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:02:54 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 0x1071b7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10712d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c52cc3020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fcbd30>, '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 0x106e31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106fc3b20>, '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.qkVivZqcSh/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.qNptwxkgUj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 01:02:54 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 01:02:54 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 01:02:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qkVivZqcSh/Render', 01:02:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:02:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:02:54 INFO - 'HOME': '/Users/cltbld', 01:02:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:02:54 INFO - 'LOGNAME': 'cltbld', 01:02:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:02:54 INFO - 'MOZ_NO_REMOTE': '1', 01:02:54 INFO - 'NO_EM_RESTART': '1', 01:02:54 INFO - 'PAGER': '/bin/cat', 01:02:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:02:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:02:54 INFO - 'PWD': '/builds/slave/test', 01:02:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:02:54 INFO - 'SHELL': '/bin/bash', 01:02:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qNptwxkgUj/Listeners', 01:02:54 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 01:02:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:02:54 INFO - 'USER': 'cltbld', 01:02:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:02:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:02:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:02:54 INFO - 'XPC_FLAGS': '0x0', 01:02:54 INFO - 'XPC_SERVICE_NAME': '0', 01:02:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:02:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:02:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:02:54 INFO - Cleaning up... 01:02:54 INFO - Return code: 0 01:02:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:02: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')]} 01:02:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:02:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:02: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')]} 01:02:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:02:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:02:54 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 0x1071b7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10712d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c52cc3020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fcbd30>, '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 0x106e31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106fc3b20>, '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.qkVivZqcSh/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.qNptwxkgUj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 01:02:54 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 01:02:54 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 01:02:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qkVivZqcSh/Render', 01:02:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:02:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:02:54 INFO - 'HOME': '/Users/cltbld', 01:02:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:02:54 INFO - 'LOGNAME': 'cltbld', 01:02:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:02:54 INFO - 'MOZ_NO_REMOTE': '1', 01:02:54 INFO - 'NO_EM_RESTART': '1', 01:02:54 INFO - 'PAGER': '/bin/cat', 01:02:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:02:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:02:54 INFO - 'PWD': '/builds/slave/test', 01:02:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:02:54 INFO - 'SHELL': '/bin/bash', 01:02:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qNptwxkgUj/Listeners', 01:02:54 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 01:02:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:02:54 INFO - 'USER': 'cltbld', 01:02:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:02:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:02:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:02:54 INFO - 'XPC_FLAGS': '0x0', 01:02:54 INFO - 'XPC_SERVICE_NAME': '0', 01:02:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:02:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:02:54 INFO - Downloading/unpacking blobuploader==1.2.4 01:02:54 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 01:02:54 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 01:02:54 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 01:02:54 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 01:02:54 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 01:02:54 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 01:02:57 INFO - Downloading blobuploader-1.2.4.tar.gz 01:02:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:02:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:02:57 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 01:02:57 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 01:02:57 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 01:02:57 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 01:02:57 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 01:02:57 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 01:02:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:02:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:02:58 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 01:02:58 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 01:02:58 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 01:02:58 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 01:02:58 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 01:02:58 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 01:02:58 INFO - Downloading docopt-0.6.1.tar.gz 01:02:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:02:58 INFO - Installing collected packages: blobuploader, requests, docopt 01:02:58 INFO - Running setup.py install for blobuploader 01:02:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:02:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:02:58 INFO - Running setup.py install for requests 01:02:59 INFO - Running setup.py install for docopt 01:02:59 INFO - Successfully installed blobuploader requests docopt 01:02:59 INFO - Cleaning up... 01:02:59 INFO - Return code: 0 01:02:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:02:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:02:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:02:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:02:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:02:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:02:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:02:59 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 0x1071b7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10712d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c52cc3020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fcbd30>, '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 0x106e31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106fc3b20>, '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.qkVivZqcSh/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.qNptwxkgUj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 01:02:59 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 01:02:59 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 01:02:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qkVivZqcSh/Render', 01:02:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:02:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:02:59 INFO - 'HOME': '/Users/cltbld', 01:02:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:02:59 INFO - 'LOGNAME': 'cltbld', 01:02:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:02:59 INFO - 'MOZ_NO_REMOTE': '1', 01:02:59 INFO - 'NO_EM_RESTART': '1', 01:02:59 INFO - 'PAGER': '/bin/cat', 01:02:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:02:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:02:59 INFO - 'PWD': '/builds/slave/test', 01:02:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:02:59 INFO - 'SHELL': '/bin/bash', 01:02:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qNptwxkgUj/Listeners', 01:02:59 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 01:02:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:02:59 INFO - 'USER': 'cltbld', 01:02:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:02:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:02:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:02:59 INFO - 'XPC_FLAGS': '0x0', 01:02:59 INFO - 'XPC_SERVICE_NAME': '0', 01:02:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:02:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:02:59 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-Vv3jag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:03:00 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-8BPcTw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:03:00 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-2WDeet-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:03:00 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-HNJDBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:03:00 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-8stQ7r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:03:00 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-rVWa0r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:03:00 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-FnkGiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:03:00 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-GN1_Rb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:03:00 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-hgSDq5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:03:00 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-JW65gS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:03:00 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-7Tq9LZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:03:01 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-Dv3uNc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:03:01 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-yDjZGJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:03:01 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-5ouxEc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:03:01 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-PSePfY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:03:01 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-mEUx95-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:03:01 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-agEAiw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:03:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:03:01 INFO - Running setup.py install for manifestparser 01:03:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:03:01 INFO - Running setup.py install for mozcrash 01:03:01 INFO - Running setup.py install for mozdebug 01:03:02 INFO - Running setup.py install for mozdevice 01:03:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:03:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:03:02 INFO - Running setup.py install for mozfile 01:03:02 INFO - Running setup.py install for mozhttpd 01:03:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:03:02 INFO - Running setup.py install for mozinfo 01:03:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:03:02 INFO - Running setup.py install for mozInstall 01:03:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:03:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:03:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:03:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:03:02 INFO - Running setup.py install for mozleak 01:03:02 INFO - Running setup.py install for mozlog 01:03:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:03:03 INFO - Running setup.py install for moznetwork 01:03:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:03:03 INFO - Running setup.py install for mozprocess 01:03:03 INFO - Running setup.py install for mozprofile 01:03:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:03:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:03:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:03:03 INFO - Running setup.py install for mozrunner 01:03:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:03:03 INFO - Running setup.py install for mozscreenshot 01:03:03 INFO - Running setup.py install for moztest 01:03:04 INFO - Running setup.py install for mozversion 01:03:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:03:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:03:04 INFO - Cleaning up... 01:03:04 INFO - Return code: 0 01:03:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:03:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:03:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:03:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:03:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:03:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03:04 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 0x1071b7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10712d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c52cc3020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fcbd30>, '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 0x106e31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106fc3b20>, '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.qkVivZqcSh/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.qNptwxkgUj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 01:03:04 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 01:03:04 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 01:03:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qkVivZqcSh/Render', 01:03:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:03:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:03:04 INFO - 'HOME': '/Users/cltbld', 01:03:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:03:04 INFO - 'LOGNAME': 'cltbld', 01:03:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:03:04 INFO - 'MOZ_NO_REMOTE': '1', 01:03:04 INFO - 'NO_EM_RESTART': '1', 01:03:04 INFO - 'PAGER': '/bin/cat', 01:03:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:03:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:03:04 INFO - 'PWD': '/builds/slave/test', 01:03:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:03:04 INFO - 'SHELL': '/bin/bash', 01:03:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qNptwxkgUj/Listeners', 01:03:04 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 01:03:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:03:04 INFO - 'USER': 'cltbld', 01:03:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:03:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:03:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:03:04 INFO - 'XPC_FLAGS': '0x0', 01:03:04 INFO - 'XPC_SERVICE_NAME': '0', 01:03:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:03:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:03:04 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-wF1geE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:03:04 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)) 01:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:03:04 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-SaNTyR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:03:04 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)) 01:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:03:04 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-ZcJY2P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:03:04 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)) 01:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:03:04 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-H3v6W3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:03:04 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)) 01:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:03:04 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-inxI1t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:03:05 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)) 01:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:03:05 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-m86bcB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:03:05 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)) 01:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:03:05 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-_NRbGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:03:05 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)) 01:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:03:05 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-d4tKX3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:03:05 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)) 01:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:03:05 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-UzV1pS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:03:05 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)) 01:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:03:05 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-JoMrAQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:03:05 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)) 01:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:03:05 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-W2BXlX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:03:05 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)) 01:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:03:05 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-8ABAo2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:03:05 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)) 01:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:03:05 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-HBfqXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:03:05 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)) 01:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:03:05 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-vOILjM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:03:05 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)) 01:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:03:05 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-8n7Z8N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:03:06 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)) 01:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:03:06 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-ucbAgZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:03:06 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)) 01:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:03:06 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-gptV7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:03:06 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)) 01:03:06 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)) 01:03:06 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)) 01:03:06 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)) 01:03:06 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)) 01:03:06 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)) 01:03:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:03:06 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 01:03:06 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 01:03:06 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 01:03:06 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 01:03:06 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 01:03:06 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 01:03:08 INFO - Downloading blessings-1.6.tar.gz 01:03:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:03:08 INFO - Installing collected packages: blessings 01:03:08 INFO - Running setup.py install for blessings 01:03:09 INFO - Successfully installed blessings 01:03:09 INFO - Cleaning up... 01:03:09 INFO - Return code: 0 01:03:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:03:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:03:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:03:09 INFO - Reading from file tmpfile_stdout 01:03:09 INFO - Current package versions: 01:03:09 INFO - blessings == 1.6 01:03:09 INFO - blobuploader == 1.2.4 01:03:09 INFO - docopt == 0.6.1 01:03:09 INFO - functools32 == 3.2.3-2 01:03:09 INFO - jsonschema == 2.5.1 01:03:09 INFO - manifestparser == 1.1 01:03:09 INFO - mozInstall == 1.12 01:03:09 INFO - mozcrash == 0.17 01:03:09 INFO - mozdebug == 0.1 01:03:09 INFO - mozdevice == 0.48 01:03:09 INFO - mozfile == 1.2 01:03:09 INFO - mozhttpd == 0.7 01:03:09 INFO - mozinfo == 0.9 01:03:09 INFO - mozleak == 0.1 01:03:09 INFO - mozlog == 3.4 01:03:09 INFO - moznetwork == 0.27 01:03:09 INFO - mozprocess == 0.23 01:03:09 INFO - mozprofile == 0.28 01:03:09 INFO - mozrunner == 6.12 01:03:09 INFO - mozscreenshot == 0.1 01:03:09 INFO - mozsystemmonitor == 0.3 01:03:09 INFO - moztest == 0.7 01:03:09 INFO - mozversion == 1.4 01:03:09 INFO - psutil == 3.1.1 01:03:09 INFO - requests == 1.2.3 01:03:09 INFO - wsgiref == 0.1.2 01:03:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:03:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:03:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:03:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:03:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:03:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03:09 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 0x1071b7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10712d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c52cc3020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fcbd30>, '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 0x106e31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106fc3b20>, '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.qkVivZqcSh/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.qNptwxkgUj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 01:03:09 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 01:03:09 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 01:03:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qkVivZqcSh/Render', 01:03:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:03:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:03:09 INFO - 'HOME': '/Users/cltbld', 01:03:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:03:09 INFO - 'LOGNAME': 'cltbld', 01:03:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:03:09 INFO - 'MOZ_NO_REMOTE': '1', 01:03:09 INFO - 'NO_EM_RESTART': '1', 01:03:09 INFO - 'PAGER': '/bin/cat', 01:03:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:03:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:03:09 INFO - 'PWD': '/builds/slave/test', 01:03:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:03:09 INFO - 'SHELL': '/bin/bash', 01:03:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qNptwxkgUj/Listeners', 01:03:09 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 01:03:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:03:09 INFO - 'USER': 'cltbld', 01:03:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:03:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:03:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:03:09 INFO - 'XPC_FLAGS': '0x0', 01:03:09 INFO - 'XPC_SERVICE_NAME': '0', 01:03:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:03:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:03:09 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)) 01:03:09 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)) 01:03:09 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)) 01:03:09 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)) 01:03:09 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)) 01:03:09 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)) 01:03:09 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)) 01:03:09 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)) 01:03:09 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)) 01:03:09 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)) 01:03:09 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)) 01:03:09 INFO - Cleaning up... 01:03:09 INFO - Return code: 0 01:03:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:03:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:03:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:03:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:03:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:03:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03:09 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 0x1071b7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10712d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c52cc3020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fcbd30>, '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 0x106e31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106fc3b20>, '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.qkVivZqcSh/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.qNptwxkgUj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 01:03:09 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 01:03:09 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 01:03:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qkVivZqcSh/Render', 01:03:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:03:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:03:09 INFO - 'HOME': '/Users/cltbld', 01:03:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:03:09 INFO - 'LOGNAME': 'cltbld', 01:03:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:03:09 INFO - 'MOZ_NO_REMOTE': '1', 01:03:09 INFO - 'NO_EM_RESTART': '1', 01:03:09 INFO - 'PAGER': '/bin/cat', 01:03:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:03:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:03:09 INFO - 'PWD': '/builds/slave/test', 01:03:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:03:09 INFO - 'SHELL': '/bin/bash', 01:03:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qNptwxkgUj/Listeners', 01:03:09 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 01:03:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:03:09 INFO - 'USER': 'cltbld', 01:03:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:03:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:03:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:03:09 INFO - 'XPC_FLAGS': '0x0', 01:03:09 INFO - 'XPC_SERVICE_NAME': '0', 01:03:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:03:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:03:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:03:10 INFO - Cleaning up... 01:03:10 INFO - Return code: 0 01:03:10 INFO - Running post-action listener: _resource_record_post_action 01:03:10 INFO - Running post-action listener: _start_resource_monitoring 01:03:10 INFO - Starting resource monitoring. 01:03:10 INFO - [mozharness: 2016-11-14 09:03:10.063672Z] Finished create-virtualenv step (success) 01:03:10 INFO - [mozharness: 2016-11-14 09:03:10.064659Z] Running install step. 01:03:10 INFO - Running pre-action listener: _resource_record_pre_action 01:03:10 INFO - Running main action method: install 01:03:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:03:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:03:10 INFO - Reading from file tmpfile_stdout 01:03:10 INFO - Detecting whether we're running mozinstall >=1.0... 01:03:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:03:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:03:10 INFO - Reading from file tmpfile_stdout 01:03:10 INFO - Output received: 01:03:10 INFO - Usage: mozinstall [options] installer 01:03:10 INFO - Options: 01:03:10 INFO - -h, --help show this help message and exit 01:03:10 INFO - -d DEST, --destination=DEST 01:03:10 INFO - Directory to install application into. [default: 01:03:10 INFO - "/builds/slave/test"] 01:03:10 INFO - --app=APP Application being installed. [default: firefox] 01:03:10 INFO - mkdir: /builds/slave/test/build/application 01:03:10 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'] 01:03:10 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 01:03:42 INFO - Reading from file tmpfile_stdout 01:03:42 INFO - Output received: 01:03:42 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 01:03:42 INFO - Running post-action listener: _resource_record_post_action 01:03:42 INFO - [mozharness: 2016-11-14 09:03:42.951198Z] Finished install step (success) 01:03:42 INFO - [mozharness: 2016-11-14 09:03:42.951335Z] Running run-tests step. 01:03:42 INFO - Running pre-action listener: _resource_record_pre_action 01:03:42 INFO - Running main action method: run_tests 01:03:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:03:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:03:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:03:42 INFO - 2016-11-14 01:03:42.965 screenresolution[1646:8265] starting screenresolution argv=screenresolution get 01:03:42 INFO - 2016-11-14 01:03:42.968 screenresolution[1646:8265] Display 0: 1600x1200x32@60 01:03:42 INFO - 2016-11-14 01:03:42.974 screenresolution[1647:8267] starting screenresolution argv=screenresolution list 01:03:42 INFO - Available Modes on Display 0 01:03:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:03:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:03:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:03:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:03:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:03:43 INFO - Intel Iris: 01:03:43 INFO - Chipset Model: Intel Iris 01:03:43 INFO - Type: GPU 01:03:43 INFO - Bus: Built-In 01:03:43 INFO - VRAM (Dynamic, Max): 1536 MB 01:03:43 INFO - Vendor: Intel (0x8086) 01:03:43 INFO - Device ID: 0x0a2e 01:03:43 INFO - Revision ID: 0x0009 01:03:43 INFO - Displays: 01:03:43 INFO - Display: 01:03:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:03:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:03:43 INFO - Display Serial Number: 1600x1200 60 01:03:43 INFO - Main Display: Yes 01:03:43 INFO - Mirror: Off 01:03:43 INFO - Online: Yes 01:03:43 INFO - Rotation: Supported 01:03:43 INFO - Return code: 0 01:03:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:03:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:03:43 INFO - Python 2.7.3 01:03:43 INFO - Return code: 0 01:03:43 INFO - grabbing minidump binary from tooltool 01:03:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:03:43 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 0x106fcbd30>, '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 0x106e31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106fc3b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:03:43 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 01:03:43 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 01:03:43 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 01:03:43 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:03:43 INFO - Return code: 0 01:03:43 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:03:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:03:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:03:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:03:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:03:43 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/Lg31kfDoTbWhPy7_WiCeiQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0353', '--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 01:03:43 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/Lg31kfDoTbWhPy7_WiCeiQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0353 --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 01:03:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qkVivZqcSh/Render', 01:03:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:03:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:03:43 INFO - 'HOME': '/Users/cltbld', 01:03:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:03:43 INFO - 'LOGNAME': 'cltbld', 01:03:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:03:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:03:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:03:43 INFO - 'MOZ_NO_REMOTE': '1', 01:03:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:03:43 INFO - 'NO_EM_RESTART': '1', 01:03:43 INFO - 'PAGER': '/bin/cat', 01:03:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:03:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:03:43 INFO - 'PWD': '/builds/slave/test', 01:03:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:03:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:03:43 INFO - 'SHELL': '/bin/bash', 01:03:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qNptwxkgUj/Listeners', 01:03:43 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 01:03:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:03:43 INFO - 'USER': 'cltbld', 01:03:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:03:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:03:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:03:43 INFO - 'XPC_FLAGS': '0x0', 01:03:43 INFO - 'XPC_SERVICE_NAME': '0', 01:03:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:03:43 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/Lg31kfDoTbWhPy7_WiCeiQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0353', '--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 01:03:43 INFO - mozversion application_buildid: 20161114000520 01:03:43 INFO - mozversion application_changeset: 263190e20543fc7f39c6d41c8fd31cedccdbffd8 01:03:43 INFO - mozversion application_display_name: FirefoxDeveloperEdition 01:03:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:03:43 INFO - mozversion application_name: Firefox 01:03:43 INFO - mozversion application_remotingname: firefox-dev 01:03:43 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:03:43 INFO - mozversion application_vendor: Mozilla 01:03:43 INFO - mozversion application_version: 51.0a2 01:03:43 INFO - mozversion platform_buildid: 20161114000520 01:03:43 INFO - mozversion platform_changeset: 263190e20543fc7f39c6d41c8fd31cedccdbffd8 01:03:43 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:03:43 INFO - mozversion platform_version: 51.0a2 01:03:43 INFO - using testdate: 1479114223 01:03:43 INFO - actual date: 1479114223 01:03:43 INFO - starting webserver on 'localhost:49266' 01:03:43 INFO - SUITE-START | Running 2 tests 01:03:43 INFO - TEST-START | dromaeo_css 01:03:43 INFO - operating with platform_type : mac_ 01:03:43 INFO - Initialising browser for dromaeo_css test... 01:03:43 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/tmpNsoxvi/profile http://localhost:49266/getInfo.html) 01:03:45 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 01:03:45 INFO - PROCESS | 1657 | colorDepth:24 01:03:45 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 01:03:45 INFO - PROCESS | 1657 | __metrics 01:03:45 INFO - PROCESS | 1657 | 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" 01:03:45 INFO - PROCESS | 1657 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:03:46 INFO - TEST-INFO | 1657: exit 0 01:03:46 INFO - Browser initialized. 01:03:46 INFO - Running cycle 1/1 for dromaeo_css test... 01:03:46 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/tmpNsoxvi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:03:58 INFO - PROCESS | 1660 | RSS: Main: 219701248 01:03:58 INFO - PROCESS | 1660 | 01:04:53 INFO - PROCESS | 1660 | 1479114293293 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] 01:07:02 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49266/tests/dromaeo/cssquery-ext.html) 01:07:03 INFO - PROCESS | 1660 | RSS: Main: 306798592 01:07:03 INFO - PROCESS | 1660 | 01:10:06 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-ext.html (next: http://localhost:49266/tests/dromaeo/cssquery-jquery.html) 01:10:07 INFO - PROCESS | 1660 | RSS: Main: 351133696 01:10:07 INFO - PROCESS | 1660 | 01:13:09 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49266/tests/dromaeo/cssquery-mootools.html) 01:13:09 INFO - PROCESS | 1660 | RSS: Main: 314515456 01:13:09 INFO - PROCESS | 1660 | 01:16:12 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49266/tests/dromaeo/cssquery-prototype.html) 01:16:12 INFO - PROCESS | 1660 | RSS: Main: 335396864 01:16:12 INFO - PROCESS | 1660 | 01:19:16 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49266/tests/dromaeo/cssquery-yui.html) 01:19:16 INFO - PROCESS | 1660 | RSS: Main: 312430592 01:19:16 INFO - PROCESS | 1660 | 01:22:19 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-yui.html (next: http://localhost:49266/tests/dromaeo/cssquery-dojo.html) 01:22:19 INFO - PROCESS | 1660 | RSS: Main: 480641024 01:22:19 INFO - PROCESS | 1660 | 01:22:19 INFO - PROCESS | 1660 | __start_tp_report 01:22:19 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 01:22:19 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 01:22:19 INFO - PROCESS | 1660 | |i|pagename|runs| 01:22:19 INFO - PROCESS | 1660 | |0;dojo.html;3170.1123685368098;3324.2188085799835;3353.916152096199;3357.429237029703;3395.7792743471673;5640.294963129609;5691.573132015105;5697.4587414195685;5715.599908006441;5763.51010164136;5628.352739434966;5720.427957204278;5728.656280623166;5731.627444216123;5732.340780810208;5188.351456067972;5189.091908915943;5214.348206474191;5235.86910327243;5266.131088370434;5200.375954885419;5201.895962080756;5226.137687281613;5294.258803767476;5318.521333080022;5285.418603953562;5300.416954135042;5306.230596563496;5311.787528498855;5328.040952628526;5226.5557427618505;5268.446813084609;5312.814051508179;5315.096433606296;5324.760385782611;5151.381834179922;5184.7148406837605;5188.7146206958605;5201.1678131498775;5278.155495120801;5735.8566035849435;5743.885122297573;5778.7399567019165;5797.971010144923;5802.596577599537;6103.055501741115;6104.246950856121;6109.205803245594;6145.846353841145;6249.468795152417;6246.562740608159;6295.433410992987;6307.9369206308265;6337.049442583603;6343.682815859234;5784.1169008879715;5786.855328616776;5798.681072540966;5798.9130163047585;5821.039528477754;6243.282022567372;6250.593711408744;6302.684865756693;6315.5263355247625;6321.1150438938585;6134.957057300269;6174.166487524127;6175.320714721377;6184.536159788034;6188.257409110935;6235.127082208494;6272.6236425814595;6283.5287353448675;6294.937050629526;6308.27454842699;5019.899602007939;6141.140240366352;6156.78451254204;6250.874982500324;6259.906101408483;6133.646189560866;6145.709401025745;6196.535259855529;6209;6235.719392627343;4958.231474121517;4959.479254678279;4963.305137280783;4969.055879382906;4993.151164302078;4418.867433976986;4430.379746835381;4454.710443821141;4473.3960915276675;4475.283954567253;5619.606627536034;5640.746166422521;5681.0626246668835;5687.118496633028;5722.484976352148;6218.378162183836;6286.402791734778;6291.685415729286;6297.874042519215;6317.936820631827;5780.335261444988;5789.218455508537;5790.449907258888;5796.275465566804;5840.2115714378015;5260.710660913686;5277.973610132001;5344.893102137936;5381.838544843661;5389.353277606634;6266.780662676784;6275.96862015687;6300.9684951574945;6333.461655759312;6350.4919606432295;6266.937330626818;6297.685115744102;6305.274893387135;6316.305206427198;6322.936770632235;6175.475084617858;6269;6299.905501417391;6313.621182729051;6340.809775706736;5942.227510423617;5954.3152537458745;5973.522118230444;5992.61048031894;6004.819855404345;6146;6148.415900489446;6153.753849845956;6160.599561028519;6167.198264225622;5825.155352473952;5842.211301474416;5847.707614619337;5883.235179426647;5992.940070599413;5896.498797602252;5918.408159184047;5964;6014.849628759316;6038.486728628116;5857.941420585739;5906.26171728534;6004.729787159501;6039.909401358896;6052.90920636182;5979.073243647242;6015.0676645120075;6027.909581356371;6099.268087829311;6174.320824709368;5837.795677151279;5875.294964604275;5933.614315069507;5953.821385358447;5988.341282458839 01:22:19 INFO - PROCESS | 1660 | |1;ext.html;461.42782949143054;470.88698712309053;486.7201359218448;497.4279578484743;512.743628185907;30097;31415.05754827356;32357.67642323576;40242.59757402425;41263;34342.82828585854;42676.7196984091;42803.14393712124;42807.3578896316;42870.78564607172;9752.804943901117;9927.751806204831;9945.204383649327;9945.751356216117;9950.751231219205;8972;9163.266938644925;9757.853632195523;9893.4558599277;12160.391980400944;12145.453454594564;12410;12419.006479481664;12451.81322280162;12463.626091217233;12339.012878969661;12413.689657758538;12414.379281035912;12416.875831241663;12444.626661200133;12268.263904165779;12300.261984280973;12336.568220112253;12351.505939762399;12360.752784944341;40414.39378409326;40621;40636.593634063574;40802.79598602017;41011.7949410254;3392.3554524640485;3466.6533346665383;3578.6600272974024;3586.7668601540818;4039.7172197946156;30928.38143237145;31057.0682879514;31198.37603247945;31206.375872482422;31363.686363136305;3163.7469002479747;3208.6630903755004;3212.27723762154;3254.528093426464;3318;410089;518833;519474;520265.9999999962;520596;57487;57851.4214857846;57878.84242315214;57950.94343396006;58015.41984580184;34044.14889627729;34339;34585.135371615914;35824.462633060524;60248.39751602428;13838.30808459573;16961.49115526536;16969.830301696824;16970.830291697173;17061.658766824843;12951.093423460266;13072.411741471657;13094.738105237842;13102.60692179217;13112.606621801362;16544.75182872258;16836.737244706695;18691.439256822316;19001.714974275397;19104.61790764205;7668.961655191688;7692.307692307719;7750;7877.369810415153;7897.842043159105;854.6325080215566;944.4003058058182;974.4591751577942;1001.6594357918343;1044.9529771160317;28480;29077.273068173465;29821.254468638457;30340.69659303423;30570.235744106576;1043.7181960870673;1058.2803693488347;1074.2856000759407;1146.5643055638805;1179.3277831635885;13209.273489957952;14933.40266389354;15341;15419.922900385427;15548.76676849848;688733;694066;695244;696100;696449;56830.86338273212;57202;57267.71366143226;57287.713561432756;57351.71324143353;1239.0521251242806;1255.667248179215;1343.234356416872;1371.3143428285857;1382.2881216173678;29559.965401210855;30601.87027457187;31098;31307.217319567193;31738;46899.296510551685;47292.76353618348;47316.7634161827;47456.101755929376;47552.524474756196;561210;564357;564363;564592;564881;24946.50106997886;27224.727752722218;27268;27868.442631147667;27946.301342466602;45863.31205031994;46389.76805115953;47176.29235561538;47379.05241895212;47860.04279914452;38302;38519;39346.213075738895;39468.01329966659;40713.59286407098;38493;38577.52716078193;39294.607053929096;39641.00897477586;39866.60133398745;36355.63644363522;37188.25623487461;38482;38503;38510;33189.33621327608;34454;34517.82741086279;35116.94649160529;35183.64816351906;23395.181168659015;23876.761232387453;25763.6135457972;25811.741882580933;26159.346016348984 01:22:19 INFO - PROCESS | 1660 | |2;jquery.html;355.65856777493605;372.4952689106261;372.79309982959455;385.64135354120674;406.8331983886607;14803.851961480383;15006.099634021966;16048.839511604894;20341.28805491808;20677.689834652494;19447.930363829983;19843.603127937433;20395.694064589043;20557.486062848435;20662.48343791406;4686.039361930796;5990.820275391745;6211.844703882394;6260.18617579714;6280.371962803729;5865.32548756892;6191.783287584935;6251;6252.781152659658;6254.374562543755;5857.443542863442;6065.332813390545;6092.6953652317425;6212.378762123797;6213.502919766408;5123.641345105844;6136.570440069197;6139.754409823602;6143.32423433422;6147.72335244915;4547.477040140393;5009.849704508871;5305.3898801637915;5322.520973112439;5330;25028.374290642696;25412.872935635205;25493.49013019748;25661.74338256612;25930.833112509983;2241.5965126277265;2318.8260880434036;2438.207582535683;3001.354708737632;3016.170553097894;14933.402663893432;15596.92201538985;15883.841161588467;15906.681866362724;16281.592960175973;1689.7127488327014;1841.373932862833;1859.061174107081;1940.40817550647;1974.5458544534838;114410;115603;116267.41866290699;116273.99999999916;117205;10269.229807764448;10485.475726213659;10742.462876856125;10825.404602746925;10981.61564345244;13146.079774415699;13157;13255;13259.469621215236;13261.469541218436;6761.966190169116;7078.433725302067;8325.916740832514;8735.34484913634;8810.118988101267;8902.42134261271;8904.73285801427;8905.643774248958;9075.909240907638;9122;5305.62860599762;6569.605823650596;6587.440067594308;6629.204495460479;6633.9668301658185;1550.5658415643638;1678.7493317478556;1770.0884044716981;1799.127423199747;1821.826926441986;875.3784812782868;907.6414816147585;1004.2668851738272;1045.3170395662976;1083.2200815412891;21649.89175054115;22196.556068878534;22228.666570001464;22248.88875555612;22316.88841555782;933.6685476655689;960.4237457525429;980.460746589373;981.0924894472585;981.6858605246252;9521.761955951157;11572.884271157349;11636.941815291038;11725;11808.763824723457;571441;577452;605277;617977;618919;74166;77717.84502022051;100067;106435.80692579235;108774;934.1079269297804;973.600823662295;1010.5856598794606;1010.888802231754;1015.918726501878;19767.912764798075;19886.602267954848;20337;20420.693689594966;20422.59154816925;40783.796081019405;46799.830004248804;47907.281390778466;49056.50943490662;49259;65701.67149164224;66575.66712166602;67090;68193.31806682068;69366.9594956066;6817.625030623363;7466.216047315171;7722.806929826799;7775.6112194388925;8226.629801659059;9379.718608441757;12079.51681932713;12534.498620055096;12952.870471295166;13271.137376070525;11323.660290191307;11333.829992550283;11388.088952883914;11407.25852819564;11730.589429369931;5139.768710407966;7870.72452464161;10806.351618902576;11528.769424611293;11743.647690569296;11125.44114853572;11326.32042077478;11434.656960291204;11869.762604747684;11886.167968242486;6645.667716614246;7175.103112110986;8179.836403271782;8235.21765432283;8307.303250053668;10828.837567436653;11197.88802112001;11227.887721122685;11334.206605537533;11746.70633234176 01:22:19 INFO - PROCESS | 1660 | |3;mootools.html;1240.4603997261192;1434.368877693815;1612.4920649995252;1855.1002763659615;1870.5043163561659;8375.246227839492;8954.104589541043;8971.95514022429;8974.910250897488;8975.596098175582;7815.140334563193;8033.758987230392;8037.236462536064;8136.593170341489;8710;2163.2536774812665;2200.449887528118;2334.6031174700256;2403.25499095281;2406.3743426709007;2408.385861605288;2412.421018955447;2413.650020746991;2413.8431001984904;2414.3582363992477;2370.5969985102574;2420.745821688724;2422.685050943384;2423.115562819567;2426.3206302235403;2378.1676413255395;2381.6189409694452;2400.7719266669637;2402.519496100787;2405.338531903723;2345.870977096259;2365.633326834326;2394.1261439574428;2394.293683363412;2397.484540823731;8813.911860881373;8925.776855578597;8932.687355942577;8933.374663773538;8942.195202431747;4830.888895554007;5167.63057789686;5237.947620523784;5420.322459692538;5424.728763561806;3595.388783906742;3690.760100593453;3761.9247615047548;3770.4155855842387;3770.6417890300377;1065.6802959112313;1099.2744788439672;1118.245184500467;1125.2910666280272;1125.8367536707212;11787.646370608896;11817.704557386049;11823.231489953125;11829.881701182963;11838.052955763604;4002.959970400317;4654.697444666086;4668.95331046692;4845.830395936126;4849;10116.848247276297;10127.848082278771;10130.797384052277;10176.084152426318;10178.694639160836;5377.198638456082;5383.16560933056;5387.919181212285;5391.865203369869;5393.622446428791;4766.928496072562;4853.12643724126;4903.043906438282;4922.286268491049;4944.90110197794;3676.981615091961;3821.541415030214;3826.1391186982705;3830.540335159743;3841.4814000109627;1085.696005118568;1237.5915947737226;1283.3711481374246;1299.6743321811698;1300.7756735981577;755.9811004724926;795.4034474144391;885.2210055151426;904.8733177355175;910.1581037540249;5851.210086638334;5860;5925.288965324189;5996.70016499182;6198.721057552421;943.1370296178919;944.1918725640459;950.7005293332578;954.6944977607099;993.3146129170849;3880;3914.7864162109836;4012.2376748417705;4143.585641435832;4158.355454904495;10486.73783155412;10929.961653642891;10937.507812148473;10947.781044379068;10967.122630189566;10445.791084178274;10595.84106238407;10869.728256793485;10873.565057397775;10873.728156795985;8032.598370081472;8167.714130005421;8175.223353781381;8178.977627796526;8191.672333106728;5707;5838.474537291664;5838.620489668158;6020.397960203944;6032.3967603239325;9843.2125429964;9889.307748457539;10013.949930250303;10125.64560240388;10165.54255058539;10166.491675416348;10353.63762268317;10376.688699339033;10421.739456513647;10431.843522347323;7132.358087771918;7259.455540834353;7262.237465066092;7263.673134708845;7264.636768161677;6870.381665650116;8210.261076503144;8255.752327430188;8349.874751878606;8352.039515455557;7472.813179670552;7538.3215510604305;7599.620018998918;7602.581857997863;7651.885221721567;7444.255574442513;7456.552606843607;7486.43851711113;7516.436267279866;7549.999250198592;6958.8956165658565;6983.371496565131;6984.511084224056;7035.1909530404655;7070.7525236616475;4926.713759029667;5036.6726162799305;5046.21783623539;5046.84859454217;5122.846314610568;5017.54842064216;5066.645334826527;5117.565006974449;5158.767855446439;5202.401723801811 01:22:19 INFO - PROCESS | 1660 | |4;prototype.html;272.8635234249352;293.74297489696517;298.5074626865672;312.484400738781;314.8111133320007;5309.62832601718;5384.899889043276;5453.863653408666;5467.316585426816;5499.50504454599;4418.889527761808;4752.334673145762;4898.717859034456;5276.525112739852;5295.655782374152;4122.783778785258;4138.33786594145;4147.847635796786;4150.481189851269;4169.166166766644;3817.835560154152;4033.878983630481;4104.589541045902;4129.421880936671;4204.579542045802;3480.6693364130365;3603.0632035670783;3766.495280638372;3855.8264878080554;3927.6465118139363;3771.698264138862;3787.8257740100657;4099.098198396348;4113.239050775601;4143.233501802161;3613.6747692707518;3643.508126402928;3650.872219472306;3652.2330310634798;3654.397024490956;5068.72122033288;5203.219517072432;5279.313689220377;5288.524032837063;5357;4511.887202819923;4653.371794807692;4700.341952126671;4759.666823322369;4767.947244841856;5664.858378540528;5687.573431992617;5740.052891272935;5745.563609097726;5773.624714393593;3735.9813200933822;3997.960020399817;4000.899752568067;4017.1764788218347;4047.6761859051207;5676.524103733018;5829.300483941912;5860.443257890493;5877.764889404419;5917.822465326047;3507.8421471033867;3642.907127861684;3950.9209815803524;3955.5055618047745;4092.7544347339253;3462;4155.480564929384;4176.60322269384;4176.895577610584;4179.937300940488;3985.4655957456007;4762.452317983407;4773.618110551148;4787.595412220765;4807.927881081787;4737.218358970731;5441.972790136103;5711.7144142792695;5761.88476230473;5783.566232532493;1254.7239607286383;1394.4910107810576;1416.3838730152418;1419.950301739434;1425.7790042543422;759.9626509814175;860.8837806896114;871.3595507302127;885.2829208341265;889.3818795936762;3619.841650671812;3733.570639376452;4425.911481770347;4473.4408198975125;4533.297338912474;4153.896152596149;4166.0834616384345;4887.804487820447;4901.181820453254;4916.262560615936;3880.611938806097;3891.124496988155;4336.956630433719;4337.652987760972;4348.67384946124;2280.897359618821;2472.925812225636;2717.402171522262;3093.24215567183;3100.612423447069;5761.942380576224;6067.817965461043;6082.391760823883;6085.330613632497;6088.756449742049;4998.600111991032;5648.74580643872;5929.665825189384;6043.8186854394435;6064.545159113084;5375.629214550265;5395.7841686332895;5707.8858422832145;6049.78825741097;6096.695165241809;4737.431508219036;5115.846524604268;5737.168110624019;5912.320083190488;5945.256842894638;4854.611631069435;5033.194688849767;5345.572354211731;5600.943990560042;5636.660785773858;5803.912941305968;5951.7619295227705;5992.5205983520345;6026.608270462406;6033.716061596316;2890.3930174663556;3443.9311213776086;3772.8490860365278;3945.6251656092627;3960.089179488676;5923.348431672426;5933.584649074523;5934.287885453773;5959.67221802805;5961.769950401927;4607.3601854534545;5562.805301814417;5700.743466544099;5701.885962280814;5710.628809127394;4946.826861059845;5670.4329567044615;5671.404502527175;5689.715514224189;5716.79991200306;4501.527339629291;4747.857564272939;5243.00907424886;5473.233747275464;5635.464630860061;4971.776270067783;5266.86832829167;5654.830355089354;5671.6597004179885;5711.485966263056;5553.944460555343;5555.999840057657;5565.944340556704;5573.21974923503;5621.494065534122 01:22:19 INFO - PROCESS | 1660 | |5;yui.html;593.2144245820082;728.3481284250593;772.9033870766154;796.2117503671363;813.341193633157;12040.638780836578;15636.452724154657;16442.260098295574;16569.33722651094;16637.33450661972;14867.330970106344;14867.851321486782;14875.851241487582;15060.623484412896;15061.849381506181;688.3013741052811;765.8698021336386;839.4082172068693;863.4689665855517;867.9392442529025;706.0503622627558;718.6730037832774;851.9574021298941;866.9263112635402;881.180502133016;905.266733945503;910.744991402405;911.4030310146865;911.4986757283501;911.9589618467152;902.3818684201343;904.3850181876288;904.8597467392565;904.92308153807;906.7687739626354;530.941596424393;550.6888607936543;655.4363247607054;670.4569298867932;673.3771261583065;15347;15373.923130384277;15374.769378459332;15387.4614388497;15405.306761195772;13925.582232532939;14135.434582616683;14320.713585728226;14338.856611433857;14557.490487832874;9735.41587504752;12371.876281237162;12588.559400420942;13091.41088651013;13242.66893327665;4588.449386073659;4600.700954437951;4649.488556258809;4733.219018861883;4802.5197480252045;123183;129681;130338;131917;132402.3379883104;10765.46172691378;11067.889321106686;11331;11335.036521895567;11364;22125;22533.549329013327;22541.323760287218;22607.773922260567;23005.88497057504;7885.566293853778;7915.445918785745;8104.554249516334;8160.755177344689;8192.508449493049;4363.36731173978;4427.070315233773;4513.571210734975;4516.525764794715;4532.410786597721;3457.101153700056;3548.7870727756417;3551.3074950384425;3561.3233485637647;3567.2152126532123;553.441024565184;627.0343670746998;634.8444631065327;636.5480508838684;637.3371693438771;566.4109326300684;572.9598928075078;597.1311741416316;617.3332800575367;621.8227805075531;8195.590220489072;8963.417377870417;9161.450312981242;9202.585883635253;9240.630374785067;499.1389852504401;542.6716836314052;616.8149555133532;618.8050764009323;629.4838232649183;4459.955400446019;4460.130274596422;4469.508354081048;4485.820567177341;4489.438820147481;104019.4799026;137016;170837;170977.14511427362;171802.14098929425;102405.98593820627;117049;123365;136825;141820.29089854486;102923.4853825726;106214;108643;110659;112547;9032.232260257952;9204.447733136034;9207.815843683224;9275.62897484093;9368.4378937264;61066.69466652638;62667;63042.68478657577;63484;65750.01374979284;92930.53534732283;93032.53483732538;94759.52620236855;97010.51494742482;99649;11379.487923043318;12582.496700131893;13039.59954403559;13089.934550327187;13101;14447.349869255699;14513.419463221353;14514.709705805613;14529.273536323353;15882.444114455939;13499.257540834955;13579.59261222165;13636.045476816527;13966.371513281723;14150.363233654305;13802.861971380158;14085.08446950945;14204.502842400467;14224.928875355557;14650.120992740469;13258.403371848097;13480.865191348354;13580.45678172862;13654.93172534131;13666.18002919828;10878.234535696094;10955.123590112931;11220.775584488101;11318;11868.703282418008;10348.223883208639;10772.353658780497;10988.560457581927;11017.83473247918;11045.779084418427 01:22:19 INFO - PROCESS | 1660 | __end_tp_report 01:22:19 INFO - PROCESS | 1660 | __start_cc_report 01:22:19 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,1017 01:22:19 INFO - PROCESS | 1660 | __end_cc_report 01:22:19 INFO - PROCESS | 1660 | __startTimestamp1479115339875__endTimestamp 01:22:19 INFO - PROCESS | 1660 | 01:22:19 INFO - PROCESS | 1660 | ------- Summary: start ------- 01:22:19 INFO - PROCESS | 1660 | Number of tests: 6 01:22:19 INFO - PROCESS | 1660 | 01:22:19 INFO - PROCESS | 1660 | [#0] dojo.html Cycles:165 Average:5733.66 Median:5883.24 stddev:629.16 (10.7%) stddev-sans-first:598.08 01:22:19 INFO - PROCESS | 1660 | Values: 3170.1 3324.2 3353.9 3357.4 3395.8 5640.3 5691.6 5697.5 5715.6 5763.5 5628.4 5720.4 5728.7 5731.6 5732.3 5188.4 5189.1 5214.3 5235.9 5266.1 5200.4 5201.9 5226.1 5294.3 5318.5 5285.4 5300.4 5306.2 5311.8 5328.0 5226.6 5268.4 5312.8 5315.1 5324.8 5151.4 5184.7 5188.7 5201.2 5278.2 5735.9 5743.9 5778.7 5798.0 5802.6 6103.1 6104.2 6109.2 6145.8 6249.5 6246.6 6295.4 6307.9 6337.0 6343.7 5784.1 5786.9 5798.7 5798.9 5821.0 6243.3 6250.6 6302.7 6315.5 6321.1 6135.0 6174.2 6175.3 6184.5 6188.3 6235.1 6272.6 6283.5 6294.9 6308.3 5019.9 6141.1 6156.8 6250.9 6259.9 6133.6 6145.7 6196.5 6209.0 6235.7 4958.2 4959.5 4963.3 4969.1 4993.2 4418.9 4430.4 4454.7 4473.4 4475.3 5619.6 5640.7 5681.1 5687.1 5722.5 6218.4 6286.4 6291.7 6297.9 6317.9 5780.3 5789.2 5790.4 5796.3 5840.2 5260.7 5278.0 5344.9 5381.8 5389.4 6266.8 6276.0 6301.0 6333.5 6350.5 6266.9 6297.7 6305.3 6316.3 6322.9 6175.5 6269.0 6299.9 6313.6 6340.8 5942.2 5954.3 5973.5 5992.6 6004.8 6146.0 6148.4 6153.8 6160.6 6167.2 5825.2 5842.2 5847.7 5883.2 5992.9 5896.5 5918.4 5964.0 6014.8 6038.5 5857.9 5906.3 6004.7 6039.9 6052.9 5979.1 6015.1 6027.9 6099.3 6174.3 5837.8 5875.3 5933.6 5953.8 5988.3 01:22:19 INFO - PROCESS | 1660 | 01:22:19 INFO - PROCESS | 1660 | [#1] ext.html Cycles:180 Average:70947.34 Median:35150.30 stddev:158316.79 (450.4%) stddev-sans-first:158672.46 01:22:19 INFO - PROCESS | 1660 | Values: 461.4 470.9 486.7 497.4 512.7 30097.0 31415.1 32357.7 40242.6 41263.0 34342.8 42676.7 42803.1 42807.4 42870.8 9752.8 9927.8 9945.2 9945.8 9950.8 8972.0 9163.3 9757.9 9893.5 12160.4 12145.5 12410.0 12419.0 12451.8 12463.6 12339.0 12413.7 12414.4 12416.9 12444.6 12268.3 12300.3 12336.6 12351.5 12360.8 40414.4 40621.0 40636.6 40802.8 41011.8 3392.4 3466.7 3578.7 3586.8 4039.7 30928.4 31057.1 31198.4 31206.4 31363.7 3163.7 3208.7 3212.3 3254.5 3318.0 410089.0 518833.0 519474.0 520266.0 520596.0 57487.0 57851.4 57878.8 57950.9 58015.4 34044.1 34339.0 34585.1 35824.5 60248.4 13838.3 16961.5 16969.8 16970.8 17061.7 12951.1 13072.4 13094.7 13102.6 13112.6 16544.8 16836.7 18691.4 19001.7 19104.6 7669.0 7692.3 7750.0 7877.4 7897.8 854.6 944.4 974.5 1001.7 1045.0 28480.0 29077.3 29821.3 30340.7 30570.2 1043.7 1058.3 1074.3 1146.6 1179.3 13209.3 14933.4 15341.0 15419.9 15548.8 688733.0 694066.0 695244.0 696100.0 696449.0 56830.9 57202.0 57267.7 57287.7 57351.7 1239.1 1255.7 1343.2 1371.3 1382.3 29560.0 30601.9 31098.0 31307.2 31738.0 46899.3 47292.8 47316.8 47456.1 47552.5 561210.0 564357.0 564363.0 564592.0 564881.0 24946.5 27224.7 27268.0 27868.4 27946.3 45863.3 46389.8 47176.3 47379.1 47860.0 38302.0 38519.0 39346.2 39468.0 40713.6 38493.0 38577.5 39294.6 39641.0 39866.6 36355.6 37188.3 38482.0 38503.0 38510.0 33189.3 34454.0 34517.8 35116.9 35183.6 23395.2 23876.8 25763.6 25811.7 26159.3 01:22:19 INFO - PROCESS | 1660 | 01:22:19 INFO - PROCESS | 1660 | [#2] jquery.html Cycles:180 Average:33636.41 Median:25577.62 stddev:98976.53 (387.0%) stddev-sans-first:99222.64 01:22:19 INFO - PROCESS | 1660 | Values: 355.7 372.5 372.8 385.6 406.8 14803.9 15006.1 16048.8 20341.3 20677.7 19447.9 19843.6 20395.7 20557.5 20662.5 4686.0 5990.8 6211.8 6260.2 6280.4 5865.3 6191.8 6251.0 6252.8 6254.4 5857.4 6065.3 6092.7 6212.4 6213.5 5123.6 6136.6 6139.8 6143.3 6147.7 4547.5 5009.8 5305.4 5322.5 5330.0 25028.4 25412.9 25493.5 25661.7 25930.8 2241.6 2318.8 2438.2 3001.4 3016.2 14933.4 15596.9 15883.8 15906.7 16281.6 1689.7 1841.4 1859.1 1940.4 1974.5 114410.0 115603.0 116267.4 116274.0 117205.0 10269.2 10485.5 10742.5 10825.4 10981.6 13146.1 13157.0 13255.0 13259.5 13261.5 6762.0 7078.4 8325.9 8735.3 8810.1 8902.4 8904.7 8905.6 9075.9 9122.0 5305.6 6569.6 6587.4 6629.2 6634.0 1550.6 1678.7 1770.1 1799.1 1821.8 875.4 907.6 1004.3 1045.3 1083.2 21649.9 22196.6 22228.7 22248.9 22316.9 933.7 960.4 980.5 981.1 981.7 9521.8 11572.9 11636.9 11725.0 11808.8 571441.0 577452.0 605277.0 617977.0 618919.0 74166.0 77717.8 100067.0 106435.8 108774.0 934.1 973.6 1010.6 1010.9 1015.9 19767.9 19886.6 20337.0 20420.7 20422.6 40783.8 46799.8 47907.3 49056.5 49259.0 65701.7 66575.7 67090.0 68193.3 69367.0 6817.6 7466.2 7722.8 7775.6 8226.6 9379.7 12079.5 12534.5 12952.9 13271.1 11323.7 11333.8 11388.1 11407.3 11730.6 5139.8 7870.7 10806.4 11528.8 11743.6 11125.4 11326.3 11434.7 11869.8 11886.2 6645.7 7175.1 8179.8 8235.2 8307.3 10828.8 11197.9 11227.9 11334.2 11746.7 01:22:19 INFO - PROCESS | 1660 | 01:22:19 INFO - PROCESS | 1660 | [#3] mootools.html Cycles:180 Average:5737.88 Median:4878.09 stddev:3218.17 (66.0%) stddev-sans-first:3209.45 01:22:19 INFO - PROCESS | 1660 | Values: 1240.5 1434.4 1612.5 1855.1 1870.5 8375.2 8954.1 8972.0 8974.9 8975.6 7815.1 8033.8 8037.2 8136.6 8710.0 2163.3 2200.4 2334.6 2403.3 2406.4 2408.4 2412.4 2413.7 2413.8 2414.4 2370.6 2420.7 2422.7 2423.1 2426.3 2378.2 2381.6 2400.8 2402.5 2405.3 2345.9 2365.6 2394.1 2394.3 2397.5 8813.9 8925.8 8932.7 8933.4 8942.2 4830.9 5167.6 5237.9 5420.3 5424.7 3595.4 3690.8 3761.9 3770.4 3770.6 1065.7 1099.3 1118.2 1125.3 1125.8 11787.6 11817.7 11823.2 11829.9 11838.1 4003.0 4654.7 4669.0 4845.8 4849.0 10116.8 10127.8 10130.8 10176.1 10178.7 5377.2 5383.2 5387.9 5391.9 5393.6 4766.9 4853.1 4903.0 4922.3 4944.9 3677.0 3821.5 3826.1 3830.5 3841.5 1085.7 1237.6 1283.4 1299.7 1300.8 756.0 795.4 885.2 904.9 910.2 5851.2 5860.0 5925.3 5996.7 6198.7 943.1 944.2 950.7 954.7 993.3 3880.0 3914.8 4012.2 4143.6 4158.4 10486.7 10930.0 10937.5 10947.8 10967.1 10445.8 10595.8 10869.7 10873.6 10873.7 8032.6 8167.7 8175.2 8179.0 8191.7 5707.0 5838.5 5838.6 6020.4 6032.4 9843.2 9889.3 10013.9 10125.6 10165.5 10166.5 10353.6 10376.7 10421.7 10431.8 7132.4 7259.5 7262.2 7263.7 7264.6 6870.4 8210.3 8255.8 8349.9 8352.0 7472.8 7538.3 7599.6 7602.6 7651.9 7444.3 7456.6 7486.4 7516.4 7550.0 6958.9 6983.4 6984.5 7035.2 7070.8 4926.7 5036.7 5046.2 5046.8 5122.8 5017.5 5066.6 5117.6 5158.8 5202.4 01:22:19 INFO - PROCESS | 1660 | 01:22:19 INFO - PROCESS | 1660 | [#4] prototype.html Cycles:180 Average:4511.54 Median:4893.26 stddev:1413.93 (28.9%) stddev-sans-first:1381.64 01:22:19 INFO - PROCESS | 1660 | Values: 272.9 293.7 298.5 312.5 314.8 5309.6 5384.9 5453.9 5467.3 5499.5 4418.9 4752.3 4898.7 5276.5 5295.7 4122.8 4138.3 4147.8 4150.5 4169.2 3817.8 4033.9 4104.6 4129.4 4204.6 3480.7 3603.1 3766.5 3855.8 3927.6 3771.7 3787.8 4099.1 4113.2 4143.2 3613.7 3643.5 3650.9 3652.2 3654.4 5068.7 5203.2 5279.3 5288.5 5357.0 4511.9 4653.4 4700.3 4759.7 4767.9 5664.9 5687.6 5740.1 5745.6 5773.6 3736.0 3998.0 4000.9 4017.2 4047.7 5676.5 5829.3 5860.4 5877.8 5917.8 3507.8 3642.9 3950.9 3955.5 4092.8 3462.0 4155.5 4176.6 4176.9 4179.9 3985.5 4762.5 4773.6 4787.6 4807.9 4737.2 5442.0 5711.7 5761.9 5783.6 1254.7 1394.5 1416.4 1420.0 1425.8 760.0 860.9 871.4 885.3 889.4 3619.8 3733.6 4425.9 4473.4 4533.3 4153.9 4166.1 4887.8 4901.2 4916.3 3880.6 3891.1 4337.0 4337.7 4348.7 2280.9 2472.9 2717.4 3093.2 3100.6 5761.9 6067.8 6082.4 6085.3 6088.8 4998.6 5648.7 5929.7 6043.8 6064.5 5375.6 5395.8 5707.9 6049.8 6096.7 4737.4 5115.8 5737.2 5912.3 5945.3 4854.6 5033.2 5345.6 5600.9 5636.7 5803.9 5951.8 5992.5 6026.6 6033.7 2890.4 3443.9 3772.8 3945.6 3960.1 5923.3 5933.6 5934.3 5959.7 5961.8 4607.4 5562.8 5700.7 5701.9 5710.6 4946.8 5670.4 5671.4 5689.7 5716.8 4501.5 4747.9 5243.0 5473.2 5635.5 4971.8 5266.9 5654.8 5671.7 5711.5 5553.9 5556.0 5565.9 5573.2 5621.5 01:22:19 INFO - PROCESS | 1660 | 01:22:19 INFO - PROCESS | 1660 | [#5] yui.html Cycles:180 Average:25514.74 Median:3550.05 stddev:41120.36 (1158.3%) stddev-sans-first:41193.14 01:22:19 INFO - PROCESS | 1660 | Values: 593.2 728.3 772.9 796.2 813.3 12040.6 15636.5 16442.3 16569.3 16637.3 14867.3 14867.9 14875.9 15060.6 15061.8 688.3 765.9 839.4 863.5 867.9 706.1 718.7 852.0 866.9 881.2 905.3 910.7 911.4 911.5 912.0 902.4 904.4 904.9 904.9 906.8 530.9 550.7 655.4 670.5 673.4 15347.0 15373.9 15374.8 15387.5 15405.3 13925.6 14135.4 14320.7 14338.9 14557.5 9735.4 12371.9 12588.6 13091.4 13242.7 4588.4 4600.7 4649.5 4733.2 4802.5 123183.0 129681.0 130338.0 131917.0 132402.3 10765.5 11067.9 11331.0 11335.0 11364.0 22125.0 22533.5 22541.3 22607.8 23005.9 7885.6 7915.4 8104.6 8160.8 8192.5 4363.4 4427.1 4513.6 4516.5 4532.4 3457.1 3548.8 3551.3 3561.3 3567.2 553.4 627.0 634.8 636.5 637.3 566.4 573.0 597.1 617.3 621.8 8195.6 8963.4 9161.5 9202.6 9240.6 499.1 542.7 616.8 618.8 629.5 4460.0 4460.1 4469.5 4485.8 4489.4 104019.5 137016.0 170837.0 170977.1 171802.1 102406.0 117049.0 123365.0 136825.0 141820.3 102923.5 106214.0 108643.0 110659.0 112547.0 9032.2 9204.4 9207.8 9275.6 9368.4 61066.7 62667.0 63042.7 63484.0 65750.0 92930.5 93032.5 94759.5 97010.5 99649.0 11379.5 12582.5 13039.6 13089.9 13101.0 14447.3 14513.4 14514.7 14529.3 15882.4 13499.3 13579.6 13636.0 13966.4 14150.4 13802.9 14085.1 14204.5 14224.9 14650.1 13258.4 13480.9 13580.5 13654.9 13666.2 10878.2 10955.1 11220.8 11318.0 11868.7 10348.2 10772.4 10988.6 11017.8 11045.8 01:22:19 INFO - PROCESS | 1660 | -------- Summary: end -------- 01:22:19 INFO - PROCESS | 1660 | 01:22:20 INFO - TEST-INFO | 1660: exit 0 01:22:20 INFO - TEST-OK | dromaeo_css | took 1116940ms 01:22:20 INFO - TEST-START | kraken 01:22:20 INFO - operating with platform_type : mac_ 01:22:20 INFO - Initialising browser for kraken test... 01:22:20 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/tmpA9nUi6/profile http://localhost:49266/getInfo.html) 01:22:22 INFO - PROCESS | 1667 | __metrics Screen width/height:1600/1200 01:22:22 INFO - PROCESS | 1667 | colorDepth:24 01:22:22 INFO - PROCESS | 1667 | Browser inner width/height: 1024/689 01:22:22 INFO - PROCESS | 1667 | __metrics 01:22:22 INFO - PROCESS | 1667 | 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" 01:22:22 INFO - PROCESS | 1667 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:22:23 INFO - TEST-INFO | 1667: exit 0 01:22:23 INFO - Browser initialized. 01:22:23 INFO - Running cycle 1/1 for kraken test... 01:22:23 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/tmpA9nUi6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:22:35 INFO - PROCESS | 1668 | RSS: Main: 219787264 01:22:35 INFO - PROCESS | 1668 | 01:22:38 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection) 01:22:39 INFO - PROCESS | 1668 | RSS: Main: 269799424 01:22:39 INFO - PROCESS | 1668 | 01:22:41 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-dft) 01:22:42 INFO - PROCESS | 1668 | RSS: Main: 280338432 01:22:42 INFO - PROCESS | 1668 | 01:22:45 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-fft) 01:22:45 INFO - PROCESS | 1668 | RSS: Main: 376664064 01:22:45 INFO - PROCESS | 1668 | 01:22:47 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator) 01:22:48 INFO - PROCESS | 1668 | RSS: Main: 279388160 01:22:48 INFO - PROCESS | 1668 | 01:22:50 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:22:51 INFO - PROCESS | 1668 | RSS: Main: 281198592 01:22:51 INFO - PROCESS | 1668 | 01:22:53 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom) 01:22:54 INFO - PROCESS | 1668 | RSS: Main: 319590400 01:22:54 INFO - PROCESS | 1668 | 01:22:57 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate) 01:22:57 INFO - PROCESS | 1668 | RSS: Main: 320430080 01:22:57 INFO - PROCESS | 1668 | 01:23:00 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial) 01:23:01 INFO - PROCESS | 1668 | RSS: Main: 316416000 01:23:01 INFO - PROCESS | 1668 | 01:23:02 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:23:03 INFO - PROCESS | 1668 | RSS: Main: 295698432 01:23:03 INFO - PROCESS | 1668 | 01:23:05 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:23:06 INFO - PROCESS | 1668 | RSS: Main: 298729472 01:23:06 INFO - PROCESS | 1668 | 01:23:08 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:23:08 INFO - PROCESS | 1668 | RSS: Main: 305709056 01:23:08 INFO - PROCESS | 1668 | 01:23:11 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:23:12 INFO - PROCESS | 1668 | RSS: Main: 310341632 01:23:12 INFO - PROCESS | 1668 | 01:23:15 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:23:15 INFO - PROCESS | 1668 | RSS: Main: 310370304 01:23:15 INFO - PROCESS | 1668 | 01:23:17 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49266/tests/kraken/driver.html?testName=ai-astar) 01:23:17 INFO - PROCESS | 1668 | RSS: Main: 353669120 01:23:17 INFO - PROCESS | 1668 | 01:23:17 INFO - PROCESS | 1668 | __start_tp_report 01:23:17 INFO - PROCESS | 1668 | _x_x_mozilla_page_load 01:23:17 INFO - PROCESS | 1668 | _x_x_mozilla_page_load_details 01:23:17 INFO - PROCESS | 1668 | |i|pagename|runs| 01:23:17 INFO - PROCESS | 1668 | |0;ai-astar;116;115;114;115;114;115;114;113;114;115 01:23:17 INFO - PROCESS | 1668 | |1;audio-beat-detection;147;106;108;141;110;106;104;124;140;107 01:23:17 INFO - PROCESS | 1668 | |2;audio-dft;182;184;182;182;184;182;182;183;185;185 01:23:17 INFO - PROCESS | 1668 | |3;audio-fft;82;59;58;90;62;59;61;58;82;57 01:23:17 INFO - PROCESS | 1668 | |4;audio-oscillator;93;69;93;69;68;67;92;68;68;90 01:23:17 INFO - PROCESS | 1668 | |5;imaging-gaussian-blur;89;86;90;87;90;86;90;88;89;87 01:23:17 INFO - PROCESS | 1668 | |6;imaging-darkroom;94;94;94;95;94;94;94;94;94;95 01:23:17 INFO - PROCESS | 1668 | |7;imaging-desaturate;84;86;86;96;137;86;84;86;86;86 01:23:17 INFO - PROCESS | 1668 | |8;json-parse-financial;51;54;54;54;57;56;55;56;56;56 01:23:17 INFO - PROCESS | 1668 | |9;json-stringify-tinderbox;65;79;83;76;75;71;72;71;72;73 01:23:17 INFO - PROCESS | 1668 | |10;stanford-crypto-aes;83;86;85;82;82;84;85;82;83;89 01:23:17 INFO - PROCESS | 1668 | |11;stanford-crypto-ccm;138;138;139;134;134;138;137;144;201;136 01:23:17 INFO - PROCESS | 1668 | |12;stanford-crypto-pbkdf2;160;158;159;160;162;162;163;163;160;163 01:23:17 INFO - PROCESS | 1668 | |13;stanford-crypto-sha256-iterative;67;79;82;89;88;89;67;67;72;86 01:23:17 INFO - PROCESS | 1668 | __end_tp_report 01:23:17 INFO - PROCESS | 1668 | __start_cc_report 01:23:17 INFO - PROCESS | 1668 | _x_x_mozilla_cycle_collect,1938 01:23:17 INFO - PROCESS | 1668 | __end_cc_report 01:23:17 INFO - PROCESS | 1668 | __startTimestamp1479115397931__endTimestamp 01:23:17 INFO - PROCESS | 1668 | 01:23:17 INFO - PROCESS | 1668 | ------- Summary: start ------- 01:23:17 INFO - PROCESS | 1668 | Number of tests: 14 01:23:17 INFO - PROCESS | 1668 | 01:23:17 INFO - PROCESS | 1668 | [#0] ai-astar Cycles:10 Average:114.50 Median:115.00 stddev:0.85 (0.7%) stddev-sans-first:0.71 01:23:17 INFO - PROCESS | 1668 | Values: 116.0 115.0 114.0 115.0 114.0 115.0 114.0 113.0 114.0 115.0 01:23:17 INFO - PROCESS | 1668 | 01:23:17 INFO - PROCESS | 1668 | [#1] audio-beat-detection Cycles:10 Average:119.30 Median:117.00 stddev:17.13 (14.6%) stddev-sans-first:14.96 01:23:17 INFO - PROCESS | 1668 | Values: 147.0 106.0 108.0 141.0 110.0 106.0 104.0 124.0 140.0 107.0 01:23:17 INFO - PROCESS | 1668 | 01:23:17 INFO - PROCESS | 1668 | [#2] audio-dft Cycles:10 Average:183.10 Median:183.50 stddev:1.29 (0.7%) stddev-sans-first:1.30 01:23:17 INFO - PROCESS | 1668 | Values: 182.0 184.0 182.0 182.0 184.0 182.0 182.0 183.0 185.0 185.0 01:23:17 INFO - PROCESS | 1668 | 01:23:17 INFO - PROCESS | 1668 | [#3] audio-fft Cycles:10 Average:66.80 Median:61.50 stddev:12.60 (20.5%) stddev-sans-first:12.11 01:23:17 INFO - PROCESS | 1668 | Values: 82.0 59.0 58.0 90.0 62.0 59.0 61.0 58.0 82.0 57.0 01:23:17 INFO - PROCESS | 1668 | 01:23:17 INFO - PROCESS | 1668 | [#4] audio-oscillator Cycles:10 Average:77.70 Median:79.50 stddev:12.35 (15.5%) stddev-sans-first:11.79 01:23:17 INFO - PROCESS | 1668 | Values: 93.0 69.0 93.0 69.0 68.0 67.0 92.0 68.0 68.0 90.0 01:23:17 INFO - PROCESS | 1668 | 01:23:17 INFO - PROCESS | 1668 | [#5] imaging-gaussian-blur Cycles:10 Average:88.20 Median:89.00 stddev:1.62 (1.8%) stddev-sans-first:1.69 01:23:17 INFO - PROCESS | 1668 | Values: 89.0 86.0 90.0 87.0 90.0 86.0 90.0 88.0 89.0 87.0 01:23:17 INFO - PROCESS | 1668 | 01:23:17 INFO - PROCESS | 1668 | [#6] imaging-darkroom Cycles:10 Average:94.20 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 01:23:17 INFO - PROCESS | 1668 | Values: 94.0 94.0 94.0 95.0 94.0 94.0 94.0 94.0 94.0 95.0 01:23:17 INFO - PROCESS | 1668 | 01:23:17 INFO - PROCESS | 1668 | [#7] imaging-desaturate Cycles:10 Average:91.70 Median:86.00 stddev:16.28 (18.9%) stddev-sans-first:17.02 01:23:17 INFO - PROCESS | 1668 | Values: 84.0 86.0 86.0 96.0 137.0 86.0 84.0 86.0 86.0 86.0 01:23:17 INFO - PROCESS | 1668 | 01:23:17 INFO - PROCESS | 1668 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:56.00 stddev:1.73 (3.1%) stddev-sans-first:1.12 01:23:17 INFO - PROCESS | 1668 | Values: 51.0 54.0 54.0 54.0 57.0 56.0 55.0 56.0 56.0 56.0 01:23:17 INFO - PROCESS | 1668 | 01:23:17 INFO - PROCESS | 1668 | [#9] json-stringify-tinderbox Cycles:10 Average:73.70 Median:74.00 stddev:4.92 (6.7%) stddev-sans-first:4.09 01:23:17 INFO - PROCESS | 1668 | Values: 65.0 79.0 83.0 76.0 75.0 71.0 72.0 71.0 72.0 73.0 01:23:17 INFO - PROCESS | 1668 | 01:23:17 INFO - PROCESS | 1668 | [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:84.50 stddev:2.23 (2.6%) stddev-sans-first:2.33 01:23:17 INFO - PROCESS | 1668 | Values: 83.0 86.0 85.0 82.0 82.0 84.0 85.0 82.0 83.0 89.0 01:23:17 INFO - PROCESS | 1668 | 01:23:17 INFO - PROCESS | 1668 | [#11] stanford-crypto-ccm Cycles:10 Average:143.90 Median:138.00 stddev:20.26 (14.7%) stddev-sans-first:21.38 01:23:17 INFO - PROCESS | 1668 | Values: 138.0 138.0 139.0 134.0 134.0 138.0 137.0 144.0 201.0 136.0 01:23:17 INFO - PROCESS | 1668 | 01:23:17 INFO - PROCESS | 1668 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.00 Median:162.00 stddev:1.83 (1.1%) stddev-sans-first:1.90 01:23:17 INFO - PROCESS | 1668 | Values: 160.0 158.0 159.0 160.0 162.0 162.0 163.0 163.0 160.0 163.0 01:23:17 INFO - PROCESS | 1668 | 01:23:17 INFO - PROCESS | 1668 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.60 Median:84.00 stddev:9.54 (11.4%) stddev-sans-first:9.14 01:23:17 INFO - PROCESS | 1668 | Values: 67.0 79.0 82.0 89.0 88.0 89.0 67.0 67.0 72.0 86.0 01:23:17 INFO - PROCESS | 1668 | -------- Summary: end -------- 01:23:17 INFO - PROCESS | 1668 | 01:23:18 INFO - TEST-INFO | 1668: exit 0 01:23:18 INFO - TEST-OK | kraken | took 58296ms 01:23:18 INFO - SUITE-END | took 1175s 01:23:19 INFO - Completed test suite (00:19:35) 01:23:19 INFO - javascript benchmark 01:23:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3170.1123685368098, 3324.2188085799835, 3353.916152096199, 3357.429237029703, 3395.7792743471673, 5640.294963129609, 5691.573132015105, 5697.4587414195685, 5715.599908006441, 5763.51010164136, 5628.352739434966, 5720.427957204278, 5728.656280623166, 5731.627444216123, 5732.340780810208, 5188.351456067972, 5189.091908915943, 5214.348206474191, 5235.86910327243, 5266.131088370434, 5200.375954885419, 5201.895962080756, 5226.137687281613, 5294.258803767476, 5318.521333080022, 5285.418603953562, 5300.416954135042, 5306.230596563496, 5311.787528498855, 5328.040952628526, 5226.5557427618505, 5268.446813084609, 5312.814051508179, 5315.096433606296, 5324.760385782611, 5151.381834179922, 5184.7148406837605, 5188.7146206958605, 5201.1678131498775, 5278.155495120801, 5735.8566035849435, 5743.885122297573, 5778.7399567019165, 5797.971010144923, 5802.596577599537, 6103.055501741115, 6104.246950856121, 6109.205803245594, 6145.846353841145, 6249.468795152417, 6246.562740608159, 6295.433410992987, 6307.9369206308265, 6337.049442583603, 6343.682815859234, 5784.1169008879715, 5786.855328616776, 5798.681072540966, 5798.9130163047585, 5821.039528477754, 6243.282022567372, 6250.593711408744, 6302.684865756693, 6315.5263355247625, 6321.1150438938585, 6134.957057300269, 6174.166487524127, 6175.320714721377, 6184.536159788034, 6188.257409110935, 6235.127082208494, 6272.6236425814595, 6283.5287353448675, 6294.937050629526, 6308.27454842699, 5019.899602007939, 6141.140240366352, 6156.78451254204, 6250.874982500324, 6259.906101408483, 6133.646189560866, 6145.709401025745, 6196.535259855529, 6209.0, 6235.719392627343, 4958.231474121517, 4959.479254678279, 4963.305137280783, 4969.055879382906, 4993.151164302078, 4418.867433976986, 4430.379746835381, 4454.710443821141, 4473.3960915276675, 4475.283954567253, 5619.606627536034, 5640.746166422521, 5681.0626246668835, 5687.118496633028, 5722.484976352148, 6218.378162183836, 6286.402791734778, 6291.685415729286, 6297.874042519215, 6317.936820631827, 5780.335261444988, 5789.218455508537, 5790.449907258888, 5796.275465566804, 5840.2115714378015, 5260.710660913686, 5277.973610132001, 5344.893102137936, 5381.838544843661, 5389.353277606634, 6266.780662676784, 6275.96862015687, 6300.9684951574945, 6333.461655759312, 6350.4919606432295, 6266.937330626818, 6297.685115744102, 6305.274893387135, 6316.305206427198, 6322.936770632235, 6175.475084617858, 6269.0, 6299.905501417391, 6313.621182729051, 6340.809775706736, 5942.227510423617, 5954.3152537458745, 5973.522118230444, 5992.61048031894, 6004.819855404345, 6146.0, 6148.415900489446, 6153.753849845956, 6160.599561028519, 6167.198264225622, 5825.155352473952, 5842.211301474416, 5847.707614619337, 5883.235179426647, 5992.940070599413, 5896.498797602252, 5918.408159184047, 5964.0, 6014.849628759316, 6038.486728628116, 5857.941420585739, 5906.26171728534, 6004.729787159501, 6039.909401358896, 6052.90920636182, 5979.073243647242, 6015.0676645120075, 6027.909581356371, 6099.268087829311, 6174.320824709368, 5837.795677151279, 5875.294964604275, 5933.614315069507, 5953.821385358447, 5988.341282458839], "value": 5693.185806866473, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [461.42782949143054, 470.88698712309053, 486.7201359218448, 497.4279578484743, 512.743628185907, 30097.0, 31415.05754827356, 32357.67642323576, 40242.59757402425, 41263.0, 34342.82828585854, 42676.7196984091, 42803.14393712124, 42807.3578896316, 42870.78564607172, 9752.804943901117, 9927.751806204831, 9945.204383649327, 9945.751356216117, 9950.751231219205, 8972.0, 9163.266938644925, 9757.853632195523, 9893.4558599277, 12160.391980400944, 12145.453454594564, 12410.0, 12419.006479481664, 12451.81322280162, 12463.626091217233, 12339.012878969661, 12413.689657758538, 12414.379281035912, 12416.875831241663, 12444.626661200133, 12268.263904165779, 12300.261984280973, 12336.568220112253, 12351.505939762399, 12360.752784944341, 40414.39378409326, 40621.0, 40636.593634063574, 40802.79598602017, 41011.7949410254, 3392.3554524640485, 3466.6533346665383, 3578.6600272974024, 3586.7668601540818, 4039.7172197946156, 30928.38143237145, 31057.0682879514, 31198.37603247945, 31206.375872482422, 31363.686363136305, 3163.7469002479747, 3208.6630903755004, 3212.27723762154, 3254.528093426464, 3318.0, 410089.0, 518833.0, 519474.0, 520265.9999999962, 520596.0, 57487.0, 57851.4214857846, 57878.84242315214, 57950.94343396006, 58015.41984580184, 34044.14889627729, 34339.0, 34585.135371615914, 35824.462633060524, 60248.39751602428, 13838.30808459573, 16961.49115526536, 16969.830301696824, 16970.830291697173, 17061.658766824843, 12951.093423460266, 13072.411741471657, 13094.738105237842, 13102.60692179217, 13112.606621801362, 16544.75182872258, 16836.737244706695, 18691.439256822316, 19001.714974275397, 19104.61790764205, 7668.961655191688, 7692.307692307719, 7750.0, 7877.369810415153, 7897.842043159105, 854.6325080215566, 944.4003058058182, 974.4591751577942, 1001.6594357918343, 1044.9529771160317, 28480.0, 29077.273068173465, 29821.254468638457, 30340.69659303423, 30570.235744106576, 1043.7181960870673, 1058.2803693488347, 1074.2856000759407, 1146.5643055638805, 1179.3277831635885, 13209.273489957952, 14933.40266389354, 15341.0, 15419.922900385427, 15548.76676849848, 688733.0, 694066.0, 695244.0, 696100.0, 696449.0, 56830.86338273212, 57202.0, 57267.71366143226, 57287.713561432756, 57351.71324143353, 1239.0521251242806, 1255.667248179215, 1343.234356416872, 1371.3143428285857, 1382.2881216173678, 29559.965401210855, 30601.87027457187, 31098.0, 31307.217319567193, 31738.0, 46899.296510551685, 47292.76353618348, 47316.7634161827, 47456.101755929376, 47552.524474756196, 561210.0, 564357.0, 564363.0, 564592.0, 564881.0, 24946.50106997886, 27224.727752722218, 27268.0, 27868.442631147667, 27946.301342466602, 45863.31205031994, 46389.76805115953, 47176.29235561538, 47379.05241895212, 47860.04279914452, 38302.0, 38519.0, 39346.213075738895, 39468.01329966659, 40713.59286407098, 38493.0, 38577.52716078193, 39294.607053929096, 39641.00897477586, 39866.60133398745, 36355.63644363522, 37188.25623487461, 38482.0, 38503.0, 38510.0, 33189.33621327608, 34454.0, 34517.82741086279, 35116.94649160529, 35183.64816351906, 23395.181168659015, 23876.761232387453, 25763.6135457972, 25811.741882580933, 26159.346016348984], "value": 20125.96437436987, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.65856777493605, 372.4952689106261, 372.79309982959455, 385.64135354120674, 406.8331983886607, 14803.851961480383, 15006.099634021966, 16048.839511604894, 20341.28805491808, 20677.689834652494, 19447.930363829983, 19843.603127937433, 20395.694064589043, 20557.486062848435, 20662.48343791406, 4686.039361930796, 5990.820275391745, 6211.844703882394, 6260.18617579714, 6280.371962803729, 5865.32548756892, 6191.783287584935, 6251.0, 6252.781152659658, 6254.374562543755, 5857.443542863442, 6065.332813390545, 6092.6953652317425, 6212.378762123797, 6213.502919766408, 5123.641345105844, 6136.570440069197, 6139.754409823602, 6143.32423433422, 6147.72335244915, 4547.477040140393, 5009.849704508871, 5305.3898801637915, 5322.520973112439, 5330.0, 25028.374290642696, 25412.872935635205, 25493.49013019748, 25661.74338256612, 25930.833112509983, 2241.5965126277265, 2318.8260880434036, 2438.207582535683, 3001.354708737632, 3016.170553097894, 14933.402663893432, 15596.92201538985, 15883.841161588467, 15906.681866362724, 16281.592960175973, 1689.7127488327014, 1841.373932862833, 1859.061174107081, 1940.40817550647, 1974.5458544534838, 114410.0, 115603.0, 116267.41866290699, 116273.99999999916, 117205.0, 10269.229807764448, 10485.475726213659, 10742.462876856125, 10825.404602746925, 10981.61564345244, 13146.079774415699, 13157.0, 13255.0, 13259.469621215236, 13261.469541218436, 6761.966190169116, 7078.433725302067, 8325.916740832514, 8735.34484913634, 8810.118988101267, 8902.42134261271, 8904.73285801427, 8905.643774248958, 9075.909240907638, 9122.0, 5305.62860599762, 6569.605823650596, 6587.440067594308, 6629.204495460479, 6633.9668301658185, 1550.5658415643638, 1678.7493317478556, 1770.0884044716981, 1799.127423199747, 1821.826926441986, 875.3784812782868, 907.6414816147585, 1004.2668851738272, 1045.3170395662976, 1083.2200815412891, 21649.89175054115, 22196.556068878534, 22228.666570001464, 22248.88875555612, 22316.88841555782, 933.6685476655689, 960.4237457525429, 980.460746589373, 981.0924894472585, 981.6858605246252, 9521.761955951157, 11572.884271157349, 11636.941815291038, 11725.0, 11808.763824723457, 571441.0, 577452.0, 605277.0, 617977.0, 618919.0, 74166.0, 77717.84502022051, 100067.0, 106435.80692579235, 108774.0, 934.1079269297804, 973.600823662295, 1010.5856598794606, 1010.888802231754, 1015.918726501878, 19767.912764798075, 19886.602267954848, 20337.0, 20420.693689594966, 20422.59154816925, 40783.796081019405, 46799.830004248804, 47907.281390778466, 49056.50943490662, 49259.0, 65701.67149164224, 66575.66712166602, 67090.0, 68193.31806682068, 69366.9594956066, 6817.625030623363, 7466.216047315171, 7722.806929826799, 7775.6112194388925, 8226.629801659059, 9379.718608441757, 12079.51681932713, 12534.498620055096, 12952.870471295166, 13271.137376070525, 11323.660290191307, 11333.829992550283, 11388.088952883914, 11407.25852819564, 11730.589429369931, 5139.768710407966, 7870.72452464161, 10806.351618902576, 11528.769424611293, 11743.647690569296, 11125.44114853572, 11326.32042077478, 11434.656960291204, 11869.762604747684, 11886.167968242486, 6645.667716614246, 7175.103112110986, 8179.836403271782, 8235.21765432283, 8307.303250053668, 10828.837567436653, 11197.88802112001, 11227.887721122685, 11334.206605537533, 11746.70633234176], "value": 9537.613304459308, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1240.4603997261192, 1434.368877693815, 1612.4920649995252, 1855.1002763659615, 1870.5043163561659, 8375.246227839492, 8954.104589541043, 8971.95514022429, 8974.910250897488, 8975.596098175582, 7815.140334563193, 8033.758987230392, 8037.236462536064, 8136.593170341489, 8710.0, 2163.2536774812665, 2200.449887528118, 2334.6031174700256, 2403.25499095281, 2406.3743426709007, 2408.385861605288, 2412.421018955447, 2413.650020746991, 2413.8431001984904, 2414.3582363992477, 2370.5969985102574, 2420.745821688724, 2422.685050943384, 2423.115562819567, 2426.3206302235403, 2378.1676413255395, 2381.6189409694452, 2400.7719266669637, 2402.519496100787, 2405.338531903723, 2345.870977096259, 2365.633326834326, 2394.1261439574428, 2394.293683363412, 2397.484540823731, 8813.911860881373, 8925.776855578597, 8932.687355942577, 8933.374663773538, 8942.195202431747, 4830.888895554007, 5167.63057789686, 5237.947620523784, 5420.322459692538, 5424.728763561806, 3595.388783906742, 3690.760100593453, 3761.9247615047548, 3770.4155855842387, 3770.6417890300377, 1065.6802959112313, 1099.2744788439672, 1118.245184500467, 1125.2910666280272, 1125.8367536707212, 11787.646370608896, 11817.704557386049, 11823.231489953125, 11829.881701182963, 11838.052955763604, 4002.959970400317, 4654.697444666086, 4668.95331046692, 4845.830395936126, 4849.0, 10116.848247276297, 10127.848082278771, 10130.797384052277, 10176.084152426318, 10178.694639160836, 5377.198638456082, 5383.16560933056, 5387.919181212285, 5391.865203369869, 5393.622446428791, 4766.928496072562, 4853.12643724126, 4903.043906438282, 4922.286268491049, 4944.90110197794, 3676.981615091961, 3821.541415030214, 3826.1391186982705, 3830.540335159743, 3841.4814000109627, 1085.696005118568, 1237.5915947737226, 1283.3711481374246, 1299.6743321811698, 1300.7756735981577, 755.9811004724926, 795.4034474144391, 885.2210055151426, 904.8733177355175, 910.1581037540249, 5851.210086638334, 5860.0, 5925.288965324189, 5996.70016499182, 6198.721057552421, 943.1370296178919, 944.1918725640459, 950.7005293332578, 954.6944977607099, 993.3146129170849, 3880.0, 3914.7864162109836, 4012.2376748417705, 4143.585641435832, 4158.355454904495, 10486.73783155412, 10929.961653642891, 10937.507812148473, 10947.781044379068, 10967.122630189566, 10445.791084178274, 10595.84106238407, 10869.728256793485, 10873.565057397775, 10873.728156795985, 8032.598370081472, 8167.714130005421, 8175.223353781381, 8178.977627796526, 8191.672333106728, 5707.0, 5838.474537291664, 5838.620489668158, 6020.397960203944, 6032.3967603239325, 9843.2125429964, 9889.307748457539, 10013.949930250303, 10125.64560240388, 10165.54255058539, 10166.491675416348, 10353.63762268317, 10376.688699339033, 10421.739456513647, 10431.843522347323, 7132.358087771918, 7259.455540834353, 7262.237465066092, 7263.673134708845, 7264.636768161677, 6870.381665650116, 8210.261076503144, 8255.752327430188, 8349.874751878606, 8352.039515455557, 7472.813179670552, 7538.3215510604305, 7599.620018998918, 7602.581857997863, 7651.885221721567, 7444.255574442513, 7456.552606843607, 7486.43851711113, 7516.436267279866, 7549.999250198592, 6958.8956165658565, 6983.371496565131, 6984.511084224056, 7035.1909530404655, 7070.7525236616475, 4926.713759029667, 5036.6726162799305, 5046.21783623539, 5046.84859454217, 5122.846314610568, 5017.54842064216, 5066.645334826527, 5117.565006974449, 5158.767855446439, 5202.401723801811], "value": 4608.9695495839205, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [272.8635234249352, 293.74297489696517, 298.5074626865672, 312.484400738781, 314.8111133320007, 5309.62832601718, 5384.899889043276, 5453.863653408666, 5467.316585426816, 5499.50504454599, 4418.889527761808, 4752.334673145762, 4898.717859034456, 5276.525112739852, 5295.655782374152, 4122.783778785258, 4138.33786594145, 4147.847635796786, 4150.481189851269, 4169.166166766644, 3817.835560154152, 4033.878983630481, 4104.589541045902, 4129.421880936671, 4204.579542045802, 3480.6693364130365, 3603.0632035670783, 3766.495280638372, 3855.8264878080554, 3927.6465118139363, 3771.698264138862, 3787.8257740100657, 4099.098198396348, 4113.239050775601, 4143.233501802161, 3613.6747692707518, 3643.508126402928, 3650.872219472306, 3652.2330310634798, 3654.397024490956, 5068.72122033288, 5203.219517072432, 5279.313689220377, 5288.524032837063, 5357.0, 4511.887202819923, 4653.371794807692, 4700.341952126671, 4759.666823322369, 4767.947244841856, 5664.858378540528, 5687.573431992617, 5740.052891272935, 5745.563609097726, 5773.624714393593, 3735.9813200933822, 3997.960020399817, 4000.899752568067, 4017.1764788218347, 4047.6761859051207, 5676.524103733018, 5829.300483941912, 5860.443257890493, 5877.764889404419, 5917.822465326047, 3507.8421471033867, 3642.907127861684, 3950.9209815803524, 3955.5055618047745, 4092.7544347339253, 3462.0, 4155.480564929384, 4176.60322269384, 4176.895577610584, 4179.937300940488, 3985.4655957456007, 4762.452317983407, 4773.618110551148, 4787.595412220765, 4807.927881081787, 4737.218358970731, 5441.972790136103, 5711.7144142792695, 5761.88476230473, 5783.566232532493, 1254.7239607286383, 1394.4910107810576, 1416.3838730152418, 1419.950301739434, 1425.7790042543422, 759.9626509814175, 860.8837806896114, 871.3595507302127, 885.2829208341265, 889.3818795936762, 3619.841650671812, 3733.570639376452, 4425.911481770347, 4473.4408198975125, 4533.297338912474, 4153.896152596149, 4166.0834616384345, 4887.804487820447, 4901.181820453254, 4916.262560615936, 3880.611938806097, 3891.124496988155, 4336.956630433719, 4337.652987760972, 4348.67384946124, 2280.897359618821, 2472.925812225636, 2717.402171522262, 3093.24215567183, 3100.612423447069, 5761.942380576224, 6067.817965461043, 6082.391760823883, 6085.330613632497, 6088.756449742049, 4998.600111991032, 5648.74580643872, 5929.665825189384, 6043.8186854394435, 6064.545159113084, 5375.629214550265, 5395.7841686332895, 5707.8858422832145, 6049.78825741097, 6096.695165241809, 4737.431508219036, 5115.846524604268, 5737.168110624019, 5912.320083190488, 5945.256842894638, 4854.611631069435, 5033.194688849767, 5345.572354211731, 5600.943990560042, 5636.660785773858, 5803.912941305968, 5951.7619295227705, 5992.5205983520345, 6026.608270462406, 6033.716061596316, 2890.3930174663556, 3443.9311213776086, 3772.8490860365278, 3945.6251656092627, 3960.089179488676, 5923.348431672426, 5933.584649074523, 5934.287885453773, 5959.67221802805, 5961.769950401927, 4607.3601854534545, 5562.805301814417, 5700.743466544099, 5701.885962280814, 5710.628809127394, 4946.826861059845, 5670.4329567044615, 5671.404502527175, 5689.715514224189, 5716.79991200306, 4501.527339629291, 4747.857564272939, 5243.00907424886, 5473.233747275464, 5635.464630860061, 4971.776270067783, 5266.86832829167, 5654.830355089354, 5671.6597004179885, 5711.485966263056, 5553.944460555343, 5555.999840057657, 5565.944340556704, 5573.21974923503, 5621.494065534122], "value": 4061.5333182123663, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.2144245820082, 728.3481284250593, 772.9033870766154, 796.2117503671363, 813.341193633157, 12040.638780836578, 15636.452724154657, 16442.260098295574, 16569.33722651094, 16637.33450661972, 14867.330970106344, 14867.851321486782, 14875.851241487582, 15060.623484412896, 15061.849381506181, 688.3013741052811, 765.8698021336386, 839.4082172068693, 863.4689665855517, 867.9392442529025, 706.0503622627558, 718.6730037832774, 851.9574021298941, 866.9263112635402, 881.180502133016, 905.266733945503, 910.744991402405, 911.4030310146865, 911.4986757283501, 911.9589618467152, 902.3818684201343, 904.3850181876288, 904.8597467392565, 904.92308153807, 906.7687739626354, 530.941596424393, 550.6888607936543, 655.4363247607054, 670.4569298867932, 673.3771261583065, 15347.0, 15373.923130384277, 15374.769378459332, 15387.4614388497, 15405.306761195772, 13925.582232532939, 14135.434582616683, 14320.713585728226, 14338.856611433857, 14557.490487832874, 9735.41587504752, 12371.876281237162, 12588.559400420942, 13091.41088651013, 13242.66893327665, 4588.449386073659, 4600.700954437951, 4649.488556258809, 4733.219018861883, 4802.5197480252045, 123183.0, 129681.0, 130338.0, 131917.0, 132402.3379883104, 10765.46172691378, 11067.889321106686, 11331.0, 11335.036521895567, 11364.0, 22125.0, 22533.549329013327, 22541.323760287218, 22607.773922260567, 23005.88497057504, 7885.566293853778, 7915.445918785745, 8104.554249516334, 8160.755177344689, 8192.508449493049, 4363.36731173978, 4427.070315233773, 4513.571210734975, 4516.525764794715, 4532.410786597721, 3457.101153700056, 3548.7870727756417, 3551.3074950384425, 3561.3233485637647, 3567.2152126532123, 553.441024565184, 627.0343670746998, 634.8444631065327, 636.5480508838684, 637.3371693438771, 566.4109326300684, 572.9598928075078, 597.1311741416316, 617.3332800575367, 621.8227805075531, 8195.590220489072, 8963.417377870417, 9161.450312981242, 9202.585883635253, 9240.630374785067, 499.1389852504401, 542.6716836314052, 616.8149555133532, 618.8050764009323, 629.4838232649183, 4459.955400446019, 4460.130274596422, 4469.508354081048, 4485.820567177341, 4489.438820147481, 104019.4799026, 137016.0, 170837.0, 170977.14511427362, 171802.14098929425, 102405.98593820627, 117049.0, 123365.0, 136825.0, 141820.29089854486, 102923.4853825726, 106214.0, 108643.0, 110659.0, 112547.0, 9032.232260257952, 9204.447733136034, 9207.815843683224, 9275.62897484093, 9368.4378937264, 61066.69466652638, 62667.0, 63042.68478657577, 63484.0, 65750.01374979284, 92930.53534732283, 93032.53483732538, 94759.52620236855, 97010.51494742482, 99649.0, 11379.487923043318, 12582.496700131893, 13039.59954403559, 13089.934550327187, 13101.0, 14447.349869255699, 14513.419463221353, 14514.709705805613, 14529.273536323353, 15882.444114455939, 13499.257540834955, 13579.59261222165, 13636.045476816527, 13966.371513281723, 14150.363233654305, 13802.861971380158, 14085.08446950945, 14204.502842400467, 14224.928875355557, 14650.120992740469, 13258.403371848097, 13480.865191348354, 13580.45678172862, 13654.93172534131, 13666.18002919828, 10878.234535696094, 10955.123590112931, 11220.775584488101, 11318.0, 11868.703282418008, 10348.223883208639, 10772.353658780497, 10988.560457581927, 11017.83473247918, 11045.779084418427], "value": 7860.158033979483, "unit": "score"}], "name": "dromaeo_css", "value": 7374.295844301833, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 115.0, 114.0, 115.0, 114.0, 115.0, 114.0, 113.0, 114.0, 115.0], "value": 114.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 106.0, 108.0, 141.0, 110.0, 106.0, 104.0, 124.0, 140.0, 107.0], "value": 119.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 184.0, 182.0, 182.0, 184.0, 182.0, 182.0, 183.0, 185.0, 185.0], "value": 183.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 59.0, 58.0, 90.0, 62.0, 59.0, 61.0, 58.0, 82.0, 57.0], "value": 66.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 69.0, 93.0, 69.0, 68.0, 67.0, 92.0, 68.0, 68.0, 90.0], "value": 77.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 90.0, 87.0, 90.0, 86.0, 90.0, 88.0, 89.0, 87.0], "value": 88.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0], "value": 94.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 86.0, 96.0, 137.0, 86.0, 84.0, 86.0, 86.0, 86.0], "value": 91.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 54.0, 54.0, 54.0, 57.0, 56.0, 55.0, 56.0, 56.0, 56.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 79.0, 83.0, 76.0, 75.0, 71.0, 72.0, 71.0, 72.0, 73.0], "value": 73.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 86.0, 85.0, 82.0, 82.0, 84.0, 85.0, 82.0, 83.0, 89.0], "value": 84.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 138.0, 139.0, 134.0, 134.0, 138.0, 137.0, 144.0, 201.0, 136.0], "value": 143.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 158.0, 159.0, 160.0, 162.0, 162.0, 163.0, 163.0, 160.0, 163.0], "value": 161.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 79.0, 82.0, 89.0, 88.0, 89.0, 67.0, 67.0, 72.0, 86.0], "value": 78.6, "unit": "score"}], "name": "kraken", "value": 1431.7, "alertThreshold": 2.0}]} 01:23:19 INFO - Return code: 0 01:23:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:23:19 INFO - # TBPL SUCCESS # 01:23:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:23:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:23:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:23:19 INFO - 2016-11-14 01:23:19.204 screenresolution[1672:10729] starting screenresolution argv=screenresolution get 01:23:19 INFO - 2016-11-14 01:23:19.208 screenresolution[1672:10729] Display 0: 1600x1200x32@60 01:23:19 INFO - 2016-11-14 01:23:19.214 screenresolution[1673:10732] starting screenresolution argv=screenresolution list 01:23:19 INFO - Available Modes on Display 0 01:23:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:23:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:23:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:23:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:23:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:23:19 INFO - Intel Iris: 01:23:19 INFO - Chipset Model: Intel Iris 01:23:19 INFO - Type: GPU 01:23:19 INFO - Bus: Built-In 01:23:19 INFO - VRAM (Dynamic, Max): 1536 MB 01:23:19 INFO - Vendor: Intel (0x8086) 01:23:19 INFO - Device ID: 0x0a2e 01:23:19 INFO - Revision ID: 0x0009 01:23:19 INFO - Displays: 01:23:19 INFO - Display: 01:23:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:23:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:23:19 INFO - Display Serial Number: 1600x1200 60 01:23:19 INFO - Main Display: Yes 01:23:19 INFO - Mirror: Off 01:23:19 INFO - Online: Yes 01:23:19 INFO - Rotation: Supported 01:23:19 INFO - Return code: 0 01:23:19 INFO - Running post-action listener: _resource_record_post_action 01:23:19 INFO - [mozharness: 2016-11-14 09:23:19.453699Z] Finished run-tests step (success) 01:23:19 INFO - Running post-run listener: _resource_record_post_run 01:23:19 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 32254976; Write bytes: 663682048; Read time: 197; Write time: 1895 01:23:19 INFO - TinderboxPrint: CPU usage
53.3% 01:23:19 INFO - TinderboxPrint: I/O read bytes / time
32,254,976 / 197 01:23:19 INFO - TinderboxPrint: I/O write bytes / time
663,682,048 / 1,895 01:23:19 INFO - TinderboxPrint: CPU idle
2,255.2 (46.7%) 01:23:19 INFO - TinderboxPrint: CPU system
969.2 (20.1%) 01:23:19 INFO - TinderboxPrint: CPU user
1,609.3 (33.3%) 01:23:19 INFO - TinderboxPrint: Swap in / out
392,511,488 / 0 01:23:19 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 355650048; Write bytes: 356443648; Read time: 27897; Write time: 739 01:23:19 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 31333376; Write bytes: 297027072; Read time: 186; Write time: 1121 01:23:19 INFO - Running post-run listener: _upload_blobber_files 01:23:19 INFO - Blob upload gear active. 01:23:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:23:19 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 01:23:19 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'] 01:23:19 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 01:23:20 INFO - (blobuploader) - INFO - Open directory for files ... 01:23:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:23:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:23:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:23:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:23:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:23:21 INFO - (blobuploader) - INFO - Done attempting. 01:23:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:23:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:23:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:23:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:23:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:23:22 INFO - (blobuploader) - INFO - Done attempting. 01:23:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:23:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:23:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:23:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:23:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:23:24 INFO - (blobuploader) - INFO - Done attempting. 01:23:24 INFO - (blobuploader) - INFO - Iteration through files over. 01:23:24 INFO - Return code: 0 01:23:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:23:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:23:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/275f90c1468706cd2644b6ba92d73dd2c65522847858c61a96bffafd2597f4b1c44c859072c9dc69594e13e21d4b41c14cfa2d255a991cc954b4b44ac0f53096", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2f14d505ee6a777fe7cab0657579d16a1aac2d916edfc0dc01bc52add5277294389325bb20afc5306a85cd1f10e42604683867bd53d71851aa8edffe790cb2f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4785544a3c6772088d450b39707eec3c117309967e374e976af92feb5711cbd1b318c22e2cbf6a88c8cf3cec98dd31a965fe8cfd98515f0fd297240591e9a9bd"} 01:23:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:23:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:23:24 INFO - Contents: 01:23:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/275f90c1468706cd2644b6ba92d73dd2c65522847858c61a96bffafd2597f4b1c44c859072c9dc69594e13e21d4b41c14cfa2d255a991cc954b4b44ac0f53096", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2f14d505ee6a777fe7cab0657579d16a1aac2d916edfc0dc01bc52add5277294389325bb20afc5306a85cd1f10e42604683867bd53d71851aa8edffe790cb2f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4785544a3c6772088d450b39707eec3c117309967e374e976af92feb5711cbd1b318c22e2cbf6a88c8cf3cec98dd31a965fe8cfd98515f0fd297240591e9a9bd"} 01:23:24 INFO - Running post-run listener: copy_logs_to_upload_dir 01:23:24 INFO - Copying logs to upload dir... 01:23:24 INFO - mkdir: /builds/slave/test/build/upload/logs 01:23:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.990750 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-11-14 01:23:24.750975) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 01:23:24.754257) ========= 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.qkVivZqcSh/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.qNptwxkgUj/Listeners TMPDIR=/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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/275f90c1468706cd2644b6ba92d73dd2c65522847858c61a96bffafd2597f4b1c44c859072c9dc69594e13e21d4b41c14cfa2d255a991cc954b4b44ac0f53096", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2f14d505ee6a777fe7cab0657579d16a1aac2d916edfc0dc01bc52add5277294389325bb20afc5306a85cd1f10e42604683867bd53d71851aa8edffe790cb2f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4785544a3c6772088d450b39707eec3c117309967e374e976af92feb5711cbd1b318c22e2cbf6a88c8cf3cec98dd31a965fe8cfd98515f0fd297240591e9a9bd"} build_url:https://queue.taskcluster.net/v1/task/Lg31kfDoTbWhPy7_WiCeiQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011670 build_url: 'https://queue.taskcluster.net/v1/task/Lg31kfDoTbWhPy7_WiCeiQ/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/275f90c1468706cd2644b6ba92d73dd2c65522847858c61a96bffafd2597f4b1c44c859072c9dc69594e13e21d4b41c14cfa2d255a991cc954b4b44ac0f53096", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2f14d505ee6a777fe7cab0657579d16a1aac2d916edfc0dc01bc52add5277294389325bb20afc5306a85cd1f10e42604683867bd53d71851aa8edffe790cb2f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4785544a3c6772088d450b39707eec3c117309967e374e976af92feb5711cbd1b318c22e2cbf6a88c8cf3cec98dd31a965fe8cfd98515f0fd297240591e9a9bd"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 01:23:24.786685) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 01:23:24.787015) ========= 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.qkVivZqcSh/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.qNptwxkgUj/Listeners TMPDIR=/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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.005161 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 01:23:24.835756) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 01:23:24.836172) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 01:23:24.836503) ========= ========= Total master_lag: 0.17 =========