builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0112 starttime: 1479931682.68 results: success (0) buildid: 20161123105335 builduid: 7396ef0ef8184dbc93af6468be6d0b7b revision: 08a24b71cfd864cda7a88eb9f524f2b5461aed0a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-23 12:08:02.681278) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-23 12:08:02.681948) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-23 12:08:02.682227) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-23 12:08:02.708400) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 12:08:02.708745) ========= 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.9dVwkGuzoY/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.unJpTrr72s/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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-23 12:08:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 20.0M=0.001s 2016-11-23 12:08:02 (20.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.109655 ========= master_lag: 0.72 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 12:08:03.541848) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 12:08:03.542155) ========= 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.9dVwkGuzoY/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.unJpTrr72s/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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.019877 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 12:08:03.585157) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-23 12:08:03.585707) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 08a24b71cfd864cda7a88eb9f524f2b5461aed0a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 08a24b71cfd864cda7a88eb9f524f2b5461aed0a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9dVwkGuzoY/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.unJpTrr72s/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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-23 12:08:03,661 truncating revision to first 12 chars 2016-11-23 12:08:03,661 Setting DEBUG logging. 2016-11-23 12:08:03,661 attempt 1/10 2016-11-23 12:08:03,661 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/08a24b71cfd8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-23 12:08:05,120 unpacking tar archive at: mozilla-beta-08a24b71cfd8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.728755 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-23 12:08:05.339944) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-23 12:08:05.340466) ========= script_repo_revision: 08a24b71cfd864cda7a88eb9f524f2b5461aed0a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-23 12:08:05.341036) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-23 12:08:05.341439) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-23 12:08:05.363128) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-11-23 12:08:05.363601) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9dVwkGuzoY/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.unJpTrr72s/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 12:08:05 INFO - MultiFileLogger online at 20161123 12:08:05 in /builds/slave/test 12:08:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 12:08:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:08:05 INFO - {'append_to_log': False, 12:08:05 INFO - 'base_work_dir': '/builds/slave/test', 12:08:05 INFO - 'blob_upload_branch': 'Mozilla-Beta', 12:08:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:08:05 INFO - 'branch': 'Mozilla-Beta', 12:08:05 INFO - 'buildbot_json_path': 'buildprops.json', 12:08:05 INFO - 'config_files': ('talos/mac_config.py',), 12:08:05 INFO - 'default_actions': ('clobber', 12:08:05 INFO - 'read-buildbot-config', 12:08:05 INFO - 'download-and-extract', 12:08:05 INFO - 'populate-webroot', 12:08:05 INFO - 'create-virtualenv', 12:08:05 INFO - 'install', 12:08:05 INFO - 'run-tests'), 12:08:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:08:05 INFO - 'download_minidump_stackwalk': True, 12:08:05 INFO - 'download_symbols': 'ondemand', 12:08:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:08:05 INFO - 'tooltool.py': '/tools/tooltool.py', 12:08:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:08:05 INFO - '/tools/misc-python/virtualenv.py')}, 12:08:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:08:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:08:05 INFO - 'installer_path': 'installer.exe', 12:08:05 INFO - 'log_level': 'info', 12:08:05 INFO - 'log_name': 'talos', 12:08:05 INFO - 'log_to_console': True, 12:08:05 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:08:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:08:05 INFO - 'opt_config_files': (), 12:08:05 INFO - 'pip_index': False, 12:08:05 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:08:05 INFO - 'cmd': ('bash', 12:08:05 INFO - '-c', 12:08:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:08:05 INFO - 'enabled': True, 12:08:05 INFO - 'halt_on_failure': False, 12:08:05 INFO - 'name': 'check_screen_resolution'},), 12:08:05 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:08:05 INFO - 'cmd': ('bash', 12:08:05 INFO - '-c', 12:08:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:08:05 INFO - 'enabled': True, 12:08:05 INFO - 'halt_on_failure': False, 12:08:05 INFO - 'name': 'check_screen_resolution'},), 12:08:05 INFO - 'run_cmd_checks_enabled': True, 12:08:05 INFO - 'sps_profile': False, 12:08:05 INFO - 'sps_profile_interval': 0, 12:08:05 INFO - 'suite': 'dromaeojs', 12:08:05 INFO - 'system_bits': '32', 12:08:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:08:05 INFO - 'title': 't-yosemite-r7-0112', 12:08:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:08:05 INFO - 'use_talos_json': True, 12:08:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:08:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:08:05 INFO - 'work_dir': 'build'} 12:08:05 INFO - [mozharness: 2016-11-23 20:08:05.558689Z] Running clobber step. 12:08:05 INFO - Running pre-action listener: _resource_record_pre_action 12:08:05 INFO - Running main action method: clobber 12:08:05 INFO - rmtree: /builds/slave/test/build 12:08:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:08:06 INFO - Running post-action listener: _resource_record_post_action 12:08:06 INFO - [mozharness: 2016-11-23 20:08:06.455562Z] Finished clobber step (success) 12:08:06 INFO - [mozharness: 2016-11-23 20:08:06.455679Z] Running read-buildbot-config step. 12:08:06 INFO - Running pre-action listener: _resource_record_pre_action 12:08:06 INFO - Running main action method: read_buildbot_config 12:08:06 INFO - Using buildbot properties: 12:08:06 INFO - { 12:08:06 INFO - "project": "", 12:08:06 INFO - "product": "firefox", 12:08:06 INFO - "script_repo_revision": "production", 12:08:06 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 12:08:06 INFO - "repository": "", 12:08:06 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 12:08:06 INFO - "buildid": "20161123105335", 12:08:06 INFO - "pgo_build": "False", 12:08:06 INFO - "basedir": "/builds/slave/test", 12:08:06 INFO - "buildnumber": 1, 12:08:06 INFO - "slavename": "t-yosemite-r7-0112", 12:08:06 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 12:08:06 INFO - "platform": "yosemite_r7", 12:08:06 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 12:08:06 INFO - "branch": "mozilla-beta", 12:08:06 INFO - "repo_path": "releases/mozilla-beta", 12:08:06 INFO - "revision": "08a24b71cfd864cda7a88eb9f524f2b5461aed0a", 12:08:06 INFO - "stage_platform": "macosx64", 12:08:06 INFO - "builduid": "7396ef0ef8184dbc93af6468be6d0b7b", 12:08:06 INFO - "slavebuilddir": "test" 12:08:06 INFO - } 12:08:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/DediSqmMSV2gPJGor5yAHQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 12:08:06 INFO - Running post-action listener: _resource_record_post_action 12:08:06 INFO - [mozharness: 2016-11-23 20:08:06.459154Z] Finished read-buildbot-config step (success) 12:08:06 INFO - [mozharness: 2016-11-23 20:08:06.459255Z] Running download-and-extract step. 12:08:06 INFO - Running pre-action listener: _resource_record_pre_action 12:08:06 INFO - Running main action method: download_and_extract 12:08:06 INFO - mkdir: /builds/slave/test/build/tests 12:08:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:08:06 INFO - trying https://queue.taskcluster.net/v1/task/DediSqmMSV2gPJGor5yAHQ/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 12:08:06 INFO - Downloading https://queue.taskcluster.net/v1/task/DediSqmMSV2gPJGor5yAHQ/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 12:08:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DediSqmMSV2gPJGor5yAHQ/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json'}, attempt #1 12:08:07 INFO - Downloaded 1165 bytes. 12:08:07 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 12:08:07 INFO - Using the following test package requirements: 12:08:07 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 12:08:07 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 12:08:07 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 12:08:07 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 12:08:07 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 12:08:07 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 12:08:07 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 12:08:07 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 12:08:07 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 12:08:07 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 12:08:07 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 12:08:07 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 12:08:07 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 12:08:07 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 12:08:07 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 12:08:07 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 12:08:07 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 12:08:07 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 12:08:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DediSqmMSV2gPJGor5yAHQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 12:08:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DediSqmMSV2gPJGor5yAHQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 12:08:07 INFO - Fetch https://queue.taskcluster.net/v1/task/DediSqmMSV2gPJGor5yAHQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 12:08:08 INFO - Expected file size: 16231738 12:08:15 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip', u'firefox-51.0.en-US.mac.talos.tests.zip'] for test suite category: talos 12:08:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DediSqmMSV2gPJGor5yAHQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 12:08:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DediSqmMSV2gPJGor5yAHQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 12:08:15 INFO - Fetch https://queue.taskcluster.net/v1/task/DediSqmMSV2gPJGor5yAHQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 12:08:16 INFO - Expected file size: 16231738 12:08:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DediSqmMSV2gPJGor5yAHQ/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 12:08:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DediSqmMSV2gPJGor5yAHQ/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 12:08:22 INFO - Fetch https://queue.taskcluster.net/v1/task/DediSqmMSV2gPJGor5yAHQ/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 12:08:23 INFO - Expected file size: 14414089 12:08:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:08:25 INFO - trying https://queue.taskcluster.net/v1/task/DediSqmMSV2gPJGor5yAHQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg 12:08:25 INFO - Downloading https://queue.taskcluster.net/v1/task/DediSqmMSV2gPJGor5yAHQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 12:08:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DediSqmMSV2gPJGor5yAHQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg'}, attempt #1 12:08:28 INFO - Downloaded 86034639 bytes. 12:08:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DediSqmMSV2gPJGor5yAHQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg 12:08:28 INFO - mkdir: /builds/slave/test/properties 12:08:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:08:28 INFO - Writing to file /builds/slave/test/properties/build_url 12:08:28 INFO - Contents: 12:08:28 INFO - build_url:https://queue.taskcluster.net/v1/task/DediSqmMSV2gPJGor5yAHQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg 12:08:29 INFO - Running post-action listener: _resource_record_post_action 12:08:29 INFO - Running post-action listener: set_extra_try_arguments 12:08:29 INFO - [mozharness: 2016-11-23 20:08:29.068581Z] Finished download-and-extract step (success) 12:08:29 INFO - [mozharness: 2016-11-23 20:08:29.068711Z] Running populate-webroot step. 12:08:29 INFO - Running pre-action listener: _resource_record_pre_action 12:08:29 INFO - Running main action method: populate_webroot 12:08:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:08:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:08:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:08:29 INFO - '--tppagecycles', 12:08:29 INFO - '7'], 12:08:29 INFO - 'tests': ['tsvgm']}}, 12:08:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:08:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:08:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:08:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:08:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:08:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:08:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:08:29 INFO - 'talos_options': ['--disable-e10s'], 12:08:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:08:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:08:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:08:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:08:29 INFO - 'talos_options': ['--disable-e10s'], 12:08:29 INFO - 'tests': ['damp', 'tps']}, 12:08:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:08:29 INFO - 'tests': ['damp', 'tps']}, 12:08:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:08:29 INFO - 'tests': ['dromaeo_dom']}, 12:08:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:08:29 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:08:29 INFO - 'tests': ['basic_compositor_video']}, 12:08:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:08:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:08:29 INFO - 'tests': ['a11yr', 12:08:29 INFO - 'ts_paint', 12:08:29 INFO - 'tpaint', 12:08:29 INFO - 'sessionrestore', 12:08:29 INFO - 'sessionrestore_no_auto_restore', 12:08:29 INFO - 'tabpaint']}, 12:08:29 INFO - 'other-e10s': {'tests': ['a11yr', 12:08:29 INFO - 'ts_paint', 12:08:29 INFO - 'tpaint', 12:08:29 INFO - 'sessionrestore', 12:08:29 INFO - 'sessionrestore_no_auto_restore', 12:08:29 INFO - 'tabpaint']}, 12:08:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:08:29 INFO - 'ts_paint', 12:08:29 INFO - 'tpaint', 12:08:29 INFO - 'sessionrestore', 12:08:29 INFO - 'sessionrestore_no_auto_restore', 12:08:29 INFO - 'tabpaint']}, 12:08:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:08:29 INFO - 'ts_paint', 12:08:29 INFO - 'tpaint', 12:08:29 INFO - 'sessionrestore', 12:08:29 INFO - 'sessionrestore_no_auto_restore', 12:08:29 INFO - 'tabpaint']}, 12:08:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:08:29 INFO - 'tests': ['a11yr', 12:08:29 INFO - 'ts_paint', 12:08:29 INFO - 'tpaint', 12:08:29 INFO - 'sessionrestore', 12:08:29 INFO - 'sessionrestore_no_auto_restore', 12:08:29 INFO - 'tabpaint']}, 12:08:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:08:29 INFO - 'tests': ['a11yr', 12:08:29 INFO - 'ts_paint', 12:08:29 INFO - 'tpaint', 12:08:29 INFO - 'sessionrestore', 12:08:29 INFO - 'sessionrestore_no_auto_restore', 12:08:29 INFO - 'tabpaint']}, 12:08:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:08:29 INFO - 'tests': ['tsvgx', 12:08:29 INFO - 'tsvgr_opacity', 12:08:29 INFO - 'tart', 12:08:29 INFO - 'tscrollx', 12:08:29 INFO - 'cart']}, 12:08:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:08:29 INFO - 'tsvgr_opacity', 12:08:29 INFO - 'tart', 12:08:29 INFO - 'tscrollx', 12:08:29 INFO - 'cart']}, 12:08:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:08:29 INFO - 'talos_options': ['--disable-e10s'], 12:08:29 INFO - 'tests': ['tp5o']}, 12:08:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:08:29 INFO - 'tests': ['tp5o']}, 12:08:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:08:29 INFO - 'talos_options': ['--disable-e10s', 12:08:29 INFO - '--xperf_path', 12:08:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:08:29 INFO - 'tests': ['tp5n']}, 12:08:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:08:29 INFO - 'talos_options': ['--xperf_path', 12:08:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:08:29 INFO - 'tests': ['tp5n']}}, 12:08:29 INFO - 'talos.zip': {'path': '', 12:08:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:08:29 INFO - Running post-action listener: _resource_record_post_action 12:08:29 INFO - [mozharness: 2016-11-23 20:08:29.087725Z] Finished populate-webroot step (success) 12:08:29 INFO - [mozharness: 2016-11-23 20:08:29.087834Z] Running create-virtualenv step. 12:08:29 INFO - Running pre-action listener: _resource_record_pre_action 12:08:29 INFO - Running main action method: create_virtualenv 12:08:29 INFO - Creating virtualenv /builds/slave/test/build/venv 12:08:29 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 12:08:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:08:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:08:29 INFO - Using real prefix '/tools/python27' 12:08:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:08:29 INFO - Installing distribute.............................................................................................................................................................................................done. 12:08:32 INFO - Installing pip.................done. 12:08:32 INFO - Return code: 0 12:08:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:08:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:08:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:08:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:08:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:08:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:08:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:08:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10286e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027e4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91b8dafb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102682d30>, '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 0x1024e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10267ab20>, '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.9dVwkGuzoY/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.unJpTrr72s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 12:08:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:08:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:08:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9dVwkGuzoY/Render', 12:08:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:08:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:08:32 INFO - 'HOME': '/Users/cltbld', 12:08:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:08:32 INFO - 'LOGNAME': 'cltbld', 12:08:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:08:32 INFO - 'MOZ_NO_REMOTE': '1', 12:08:32 INFO - 'NO_EM_RESTART': '1', 12:08:32 INFO - 'PAGER': '/bin/cat', 12:08:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:08:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:08:32 INFO - 'PWD': '/builds/slave/test', 12:08:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:08:32 INFO - 'SHELL': '/bin/bash', 12:08:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.unJpTrr72s/Listeners', 12:08:32 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 12:08:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:08:32 INFO - 'USER': 'cltbld', 12:08:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:08:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:08:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:08:32 INFO - 'XPC_FLAGS': '0x0', 12:08:32 INFO - 'XPC_SERVICE_NAME': '0', 12:08:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:08:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:08:33 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 12:08:33 INFO - Cleaning up... 12:08:33 INFO - Return code: 0 12:08:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:08:33 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')]} 12:08:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:08:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:08:33 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')]} 12:08:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:08:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:08:33 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 0x10286e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027e4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91b8dafb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102682d30>, '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 0x1024e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10267ab20>, '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.9dVwkGuzoY/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.unJpTrr72s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 12:08:33 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 12:08:33 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 12:08:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9dVwkGuzoY/Render', 12:08:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:08:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:08:33 INFO - 'HOME': '/Users/cltbld', 12:08:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:08:33 INFO - 'LOGNAME': 'cltbld', 12:08:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:08:33 INFO - 'MOZ_NO_REMOTE': '1', 12:08:33 INFO - 'NO_EM_RESTART': '1', 12:08:33 INFO - 'PAGER': '/bin/cat', 12:08:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:08:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:08:33 INFO - 'PWD': '/builds/slave/test', 12:08:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:08:33 INFO - 'SHELL': '/bin/bash', 12:08:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.unJpTrr72s/Listeners', 12:08:33 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 12:08:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:08:33 INFO - 'USER': 'cltbld', 12:08:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:08:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:08:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:08:33 INFO - 'XPC_FLAGS': '0x0', 12:08:33 INFO - 'XPC_SERVICE_NAME': '0', 12:08:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:08:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:08:33 INFO - Downloading/unpacking psutil>=3.1.1 12:08:33 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 12:08:33 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 12:08:33 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 12:08:33 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 12:08:33 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 12:08:33 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 12:08:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:08:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:08:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:08:36 INFO - Installing collected packages: psutil 12:08:36 INFO - Running setup.py install for psutil 12:08:36 INFO - building 'psutil._psutil_osx' extension 12:08:36 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 12:08:36 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 12:08:37 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 12:08:37 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 12:08:37 INFO - building 'psutil._psutil_posix' extension 12:08:37 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 12:08:37 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:08:37 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:08:37 INFO - ^ 12:08:37 INFO - 1 warning generated. 12:08:37 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 12:08:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:08:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:08:37 INFO - Successfully installed psutil 12:08:37 INFO - Cleaning up... 12:08:37 INFO - Return code: 0 12:08:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:08:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:08:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:08:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:08:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:08:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:08:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:08:37 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 0x10286e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027e4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91b8dafb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102682d30>, '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 0x1024e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10267ab20>, '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.9dVwkGuzoY/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.unJpTrr72s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 12:08:37 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 12:08:37 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 12:08:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9dVwkGuzoY/Render', 12:08:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:08:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:08:37 INFO - 'HOME': '/Users/cltbld', 12:08:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:08:37 INFO - 'LOGNAME': 'cltbld', 12:08:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:08:37 INFO - 'MOZ_NO_REMOTE': '1', 12:08:37 INFO - 'NO_EM_RESTART': '1', 12:08:37 INFO - 'PAGER': '/bin/cat', 12:08:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:08:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:08:37 INFO - 'PWD': '/builds/slave/test', 12:08:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:08:37 INFO - 'SHELL': '/bin/bash', 12:08:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.unJpTrr72s/Listeners', 12:08:37 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 12:08:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:08:37 INFO - 'USER': 'cltbld', 12:08:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:08:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:08:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:08:37 INFO - 'XPC_FLAGS': '0x0', 12:08:37 INFO - 'XPC_SERVICE_NAME': '0', 12:08:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:08:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:08:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:08:37 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 12:08:37 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 12:08:37 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 12:08:37 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 12:08:37 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 12:08:37 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 12:08:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:08:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:08:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:08:40 INFO - Installing collected packages: mozsystemmonitor 12:08:40 INFO - Running setup.py install for mozsystemmonitor 12:08:40 INFO - Successfully installed mozsystemmonitor 12:08:40 INFO - Cleaning up... 12:08:40 INFO - Return code: 0 12:08:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:08:40 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')]} 12:08:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:08:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:08:40 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')]} 12:08:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:08:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:08:40 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 0x10286e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027e4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91b8dafb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102682d30>, '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 0x1024e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10267ab20>, '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.9dVwkGuzoY/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.unJpTrr72s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 12:08:40 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 12:08:40 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 12:08:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9dVwkGuzoY/Render', 12:08:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:08:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:08:40 INFO - 'HOME': '/Users/cltbld', 12:08:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:08:40 INFO - 'LOGNAME': 'cltbld', 12:08:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:08:40 INFO - 'MOZ_NO_REMOTE': '1', 12:08:40 INFO - 'NO_EM_RESTART': '1', 12:08:40 INFO - 'PAGER': '/bin/cat', 12:08:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:08:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:08:40 INFO - 'PWD': '/builds/slave/test', 12:08:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:08:40 INFO - 'SHELL': '/bin/bash', 12:08:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.unJpTrr72s/Listeners', 12:08:40 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 12:08:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:08:40 INFO - 'USER': 'cltbld', 12:08:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:08:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:08:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:08:40 INFO - 'XPC_FLAGS': '0x0', 12:08:40 INFO - 'XPC_SERVICE_NAME': '0', 12:08:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:08:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:08:40 INFO - Downloading/unpacking jsonschema==2.5.1 12:08:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:08:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:08:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:08:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:08:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:08:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:08:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:08:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:08: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 12:08: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 12:08: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 12:08: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 12:08: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 12:08: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 12:08:43 INFO - Downloading functools32-3.2.3-2.tar.gz 12:08:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:08:43 INFO - warning: no files found matching '*.txt' 12:08:43 INFO - no previously-included directories found matching 'build' 12:08:43 INFO - no previously-included directories found matching 'dist' 12:08:43 INFO - no previously-included directories found matching '.git*' 12:08:43 INFO - Installing collected packages: jsonschema, functools32 12:08:43 INFO - Running setup.py install for functools32 12:08:43 INFO - warning: no files found matching '*.txt' 12:08:43 INFO - no previously-included directories found matching 'build' 12:08:43 INFO - no previously-included directories found matching 'dist' 12:08:43 INFO - no previously-included directories found matching '.git*' 12:08:43 INFO - Successfully installed jsonschema functools32 12:08:43 INFO - Cleaning up... 12:08:44 INFO - Return code: 0 12:08:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:08:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:08:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:08:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:08:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:08:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:08:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:08:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10286e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027e4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91b8dafb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102682d30>, '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 0x1024e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10267ab20>, '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.9dVwkGuzoY/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.unJpTrr72s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 12:08:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:08:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:08:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9dVwkGuzoY/Render', 12:08:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:08:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:08:44 INFO - 'HOME': '/Users/cltbld', 12:08:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:08:44 INFO - 'LOGNAME': 'cltbld', 12:08:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:08:44 INFO - 'MOZ_NO_REMOTE': '1', 12:08:44 INFO - 'NO_EM_RESTART': '1', 12:08:44 INFO - 'PAGER': '/bin/cat', 12:08:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:08:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:08:44 INFO - 'PWD': '/builds/slave/test', 12:08:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:08:44 INFO - 'SHELL': '/bin/bash', 12:08:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.unJpTrr72s/Listeners', 12:08:44 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 12:08:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:08:44 INFO - 'USER': 'cltbld', 12:08:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:08:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:08:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:08:44 INFO - 'XPC_FLAGS': '0x0', 12:08:44 INFO - 'XPC_SERVICE_NAME': '0', 12:08:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:08:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:08:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:08:44 INFO - Cleaning up... 12:08:44 INFO - Return code: 0 12:08:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:08:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:08:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:08:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:08:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:08:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:08:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:08:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10286e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027e4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91b8dafb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102682d30>, '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 0x1024e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10267ab20>, '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.9dVwkGuzoY/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.unJpTrr72s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 12:08:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:08:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:08:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9dVwkGuzoY/Render', 12:08:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:08:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:08:44 INFO - 'HOME': '/Users/cltbld', 12:08:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:08:44 INFO - 'LOGNAME': 'cltbld', 12:08:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:08:44 INFO - 'MOZ_NO_REMOTE': '1', 12:08:44 INFO - 'NO_EM_RESTART': '1', 12:08:44 INFO - 'PAGER': '/bin/cat', 12:08:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:08:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:08:44 INFO - 'PWD': '/builds/slave/test', 12:08:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:08:44 INFO - 'SHELL': '/bin/bash', 12:08:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.unJpTrr72s/Listeners', 12:08:44 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 12:08:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:08:44 INFO - 'USER': 'cltbld', 12:08:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:08:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:08:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:08:44 INFO - 'XPC_FLAGS': '0x0', 12:08:44 INFO - 'XPC_SERVICE_NAME': '0', 12:08:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:08:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:08:44 INFO - Downloading/unpacking blobuploader==1.2.4 12:08:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:08:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:08:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:08:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:08:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:08:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:08:47 INFO - Downloading blobuploader-1.2.4.tar.gz 12:08:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:08:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:08:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:08:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:08:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:08:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:08:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:08:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:08:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:08:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:08:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:08:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:08:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:08:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:08:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:08:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:08:48 INFO - Downloading docopt-0.6.1.tar.gz 12:08:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:08:48 INFO - Installing collected packages: blobuploader, requests, docopt 12:08:48 INFO - Running setup.py install for blobuploader 12:08:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:08:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:08:48 INFO - Running setup.py install for requests 12:08:49 INFO - Running setup.py install for docopt 12:08:49 INFO - Successfully installed blobuploader requests docopt 12:08:49 INFO - Cleaning up... 12:08:49 INFO - Return code: 0 12:08:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:08:49 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')]} 12:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:08:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:08:49 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')]} 12:08:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:08:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:08:49 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 0x10286e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027e4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91b8dafb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102682d30>, '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 0x1024e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10267ab20>, '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.9dVwkGuzoY/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.unJpTrr72s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 12:08:49 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 12:08:49 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 12:08:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9dVwkGuzoY/Render', 12:08:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:08:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:08:49 INFO - 'HOME': '/Users/cltbld', 12:08:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:08:49 INFO - 'LOGNAME': 'cltbld', 12:08:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:08:49 INFO - 'MOZ_NO_REMOTE': '1', 12:08:49 INFO - 'NO_EM_RESTART': '1', 12:08:49 INFO - 'PAGER': '/bin/cat', 12:08:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:08:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:08:49 INFO - 'PWD': '/builds/slave/test', 12:08:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:08:49 INFO - 'SHELL': '/bin/bash', 12:08:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.unJpTrr72s/Listeners', 12:08:49 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 12:08:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:08:49 INFO - 'USER': 'cltbld', 12:08:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:08:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:08:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:08:49 INFO - 'XPC_FLAGS': '0x0', 12:08:49 INFO - 'XPC_SERVICE_NAME': '0', 12:08:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:08:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:08:49 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-TB5qjm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:08:49 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-dji8Vy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:08:49 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-7LRGBd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:08:49 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-Vytd3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:08:49 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-9_wTLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:08:50 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-R3tlCr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:08:50 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-a_zPdw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:08:50 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-L_Y5RQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:08:50 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-UHolvZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:08:50 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-eSvv5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:08:50 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-6Qdxua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:08:50 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-cIBFkr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:08:50 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-A1jPGg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:08:50 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-l1zIJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:08:50 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-hKdF9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:08:51 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-G4Zov_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:08:51 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-qjaqVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:08:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:08:51 INFO - Running setup.py install for manifestparser 12:08:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:08:51 INFO - Running setup.py install for mozcrash 12:08:51 INFO - Running setup.py install for mozdebug 12:08:51 INFO - Running setup.py install for mozdevice 12:08:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:08:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:08:51 INFO - Running setup.py install for mozfile 12:08:52 INFO - Running setup.py install for mozhttpd 12:08:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:08:52 INFO - Running setup.py install for mozinfo 12:08:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:08:52 INFO - Running setup.py install for mozInstall 12:08:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:08:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:08:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:08:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:08:52 INFO - Running setup.py install for mozleak 12:08:52 INFO - Running setup.py install for mozlog 12:08:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:08:52 INFO - Running setup.py install for moznetwork 12:08:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:08:52 INFO - Running setup.py install for mozprocess 12:08:53 INFO - Running setup.py install for mozprofile 12:08:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:08:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:08:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:08:53 INFO - Running setup.py install for mozrunner 12:08:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:08:53 INFO - Running setup.py install for mozscreenshot 12:08:53 INFO - Running setup.py install for moztest 12:08:53 INFO - Running setup.py install for mozversion 12:08:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:08:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:08:53 INFO - Cleaning up... 12:08:53 INFO - Return code: 0 12:08:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:08:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:08:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:08:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:08:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:08:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:08:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:08:53 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 0x10286e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027e4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91b8dafb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102682d30>, '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 0x1024e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10267ab20>, '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.9dVwkGuzoY/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.unJpTrr72s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 12:08:53 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 12:08:53 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 12:08:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9dVwkGuzoY/Render', 12:08:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:08:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:08:53 INFO - 'HOME': '/Users/cltbld', 12:08:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:08:53 INFO - 'LOGNAME': 'cltbld', 12:08:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:08:53 INFO - 'MOZ_NO_REMOTE': '1', 12:08:53 INFO - 'NO_EM_RESTART': '1', 12:08:53 INFO - 'PAGER': '/bin/cat', 12:08:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:08:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:08:53 INFO - 'PWD': '/builds/slave/test', 12:08:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:08:53 INFO - 'SHELL': '/bin/bash', 12:08:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.unJpTrr72s/Listeners', 12:08:53 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 12:08:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:08:53 INFO - 'USER': 'cltbld', 12:08:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:08:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:08:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:08:53 INFO - 'XPC_FLAGS': '0x0', 12:08:53 INFO - 'XPC_SERVICE_NAME': '0', 12:08:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:08:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:08:54 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-INMUCG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:08:54 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)) 12:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:08:54 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-BIVgSw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:08:54 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)) 12:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:08:54 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-wfcBId-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:08:54 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)) 12:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:08:54 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-ZpiwnU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:08:54 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)) 12:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:08:54 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-Bk6NDP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:08:54 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)) 12:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:08:54 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-yfNMqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:08:54 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)) 12:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:08:54 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-u3Wtfk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:08:54 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)) 12:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:08:54 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-cTpaPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:08:54 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)) 12:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:08:54 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-OzhMJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:08:55 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)) 12:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:08:55 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-EEMWUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:08:55 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)) 12:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:08:55 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-78Pn3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:08:55 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)) 12:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:08:55 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-wuhsnu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:08:55 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)) 12:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:08:55 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-2arzcc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:08:55 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)) 12:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:08:55 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-dGDL8n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:08:55 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)) 12:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:08:55 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-9rw4B2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:08:55 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)) 12:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:08:55 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-kcWnBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:08:55 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)) 12:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:08:55 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-veGMUy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:08:55 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)) 12:08:55 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)) 12:08:55 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)) 12:08:55 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)) 12:08:55 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)) 12:08:55 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)) 12:08:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:08:55 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 12:08:55 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 12:08:55 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 12:08:55 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 12:08:55 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 12:08:55 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 12:08:58 INFO - Downloading blessings-1.6.tar.gz 12:08:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:08:58 INFO - Installing collected packages: blessings 12:08:58 INFO - Running setup.py install for blessings 12:08:58 INFO - Successfully installed blessings 12:08:58 INFO - Cleaning up... 12:08:58 INFO - Return code: 0 12:08:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:08:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:08:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:08:59 INFO - Reading from file tmpfile_stdout 12:08:59 INFO - Current package versions: 12:08:59 INFO - blessings == 1.6 12:08:59 INFO - blobuploader == 1.2.4 12:08:59 INFO - docopt == 0.6.1 12:08:59 INFO - functools32 == 3.2.3-2 12:08:59 INFO - jsonschema == 2.5.1 12:08:59 INFO - manifestparser == 1.1 12:08:59 INFO - mozInstall == 1.12 12:08:59 INFO - mozcrash == 0.17 12:08:59 INFO - mozdebug == 0.1 12:08:59 INFO - mozdevice == 0.48 12:08:59 INFO - mozfile == 1.2 12:08:59 INFO - mozhttpd == 0.7 12:08:59 INFO - mozinfo == 0.9 12:08:59 INFO - mozleak == 0.1 12:08:59 INFO - mozlog == 3.4 12:08:59 INFO - moznetwork == 0.27 12:08:59 INFO - mozprocess == 0.23 12:08:59 INFO - mozprofile == 0.28 12:08:59 INFO - mozrunner == 6.12 12:08:59 INFO - mozscreenshot == 0.1 12:08:59 INFO - mozsystemmonitor == 0.3 12:08:59 INFO - moztest == 0.7 12:08:59 INFO - mozversion == 1.4 12:08:59 INFO - psutil == 3.1.1 12:08:59 INFO - requests == 1.2.3 12:08:59 INFO - wsgiref == 0.1.2 12:08:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:08: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')]} 12:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:08:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:08: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')]} 12:08:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:08:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:08:59 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 0x10286e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027e4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91b8dafb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102682d30>, '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 0x1024e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10267ab20>, '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.9dVwkGuzoY/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.unJpTrr72s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 12:08:59 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 12:08:59 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 12:08:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9dVwkGuzoY/Render', 12:08:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:08:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:08:59 INFO - 'HOME': '/Users/cltbld', 12:08:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:08:59 INFO - 'LOGNAME': 'cltbld', 12:08:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:08:59 INFO - 'MOZ_NO_REMOTE': '1', 12:08:59 INFO - 'NO_EM_RESTART': '1', 12:08:59 INFO - 'PAGER': '/bin/cat', 12:08:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:08:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:08:59 INFO - 'PWD': '/builds/slave/test', 12:08:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:08:59 INFO - 'SHELL': '/bin/bash', 12:08:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.unJpTrr72s/Listeners', 12:08:59 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 12:08:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:08:59 INFO - 'USER': 'cltbld', 12:08:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:08:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:08:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:08:59 INFO - 'XPC_FLAGS': '0x0', 12:08:59 INFO - 'XPC_SERVICE_NAME': '0', 12:08:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:08:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:08:59 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)) 12:08:59 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)) 12:08:59 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)) 12:08:59 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)) 12:08:59 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)) 12:08:59 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)) 12:08:59 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)) 12:08:59 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)) 12:08:59 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)) 12:08:59 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)) 12:08:59 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)) 12:08:59 INFO - Cleaning up... 12:08:59 INFO - Return code: 0 12:08:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:08: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')]} 12:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:08:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:08: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')]} 12:08:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:08:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:08:59 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 0x10286e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1027e4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91b8dafb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102682d30>, '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 0x1024e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10267ab20>, '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.9dVwkGuzoY/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.unJpTrr72s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 12:08:59 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 12:08:59 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 12:08:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9dVwkGuzoY/Render', 12:08:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:08:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:08:59 INFO - 'HOME': '/Users/cltbld', 12:08:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:08:59 INFO - 'LOGNAME': 'cltbld', 12:08:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:08:59 INFO - 'MOZ_NO_REMOTE': '1', 12:08:59 INFO - 'NO_EM_RESTART': '1', 12:08:59 INFO - 'PAGER': '/bin/cat', 12:08:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:08:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:08:59 INFO - 'PWD': '/builds/slave/test', 12:08:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:08:59 INFO - 'SHELL': '/bin/bash', 12:08:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.unJpTrr72s/Listeners', 12:08:59 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 12:08:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:08:59 INFO - 'USER': 'cltbld', 12:08:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:08:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:08:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:08:59 INFO - 'XPC_FLAGS': '0x0', 12:08:59 INFO - 'XPC_SERVICE_NAME': '0', 12:08:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:08:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:08:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:08:59 INFO - Cleaning up... 12:08:59 INFO - Return code: 0 12:08:59 INFO - Running post-action listener: _resource_record_post_action 12:08:59 INFO - Running post-action listener: _start_resource_monitoring 12:08:59 INFO - Starting resource monitoring. 12:08:59 INFO - [mozharness: 2016-11-23 20:08:59.973749Z] Finished create-virtualenv step (success) 12:08:59 INFO - [mozharness: 2016-11-23 20:08:59.974729Z] Running install step. 12:08:59 INFO - Running pre-action listener: _resource_record_pre_action 12:08:59 INFO - Running main action method: install 12:08:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:08:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:09:00 INFO - Reading from file tmpfile_stdout 12:09:00 INFO - Detecting whether we're running mozinstall >=1.0... 12:09:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:09:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:09:00 INFO - Reading from file tmpfile_stdout 12:09:00 INFO - Output received: 12:09:00 INFO - Usage: mozinstall [options] installer 12:09:00 INFO - Options: 12:09:00 INFO - -h, --help show this help message and exit 12:09:00 INFO - -d DEST, --destination=DEST 12:09:00 INFO - Directory to install application into. [default: 12:09:00 INFO - "/builds/slave/test"] 12:09:00 INFO - --app=APP Application being installed. [default: firefox] 12:09:00 INFO - mkdir: /builds/slave/test/build/application 12:09:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 12:09:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.mac.dmg --destination /builds/slave/test/build/application 12:09:21 INFO - Reading from file tmpfile_stdout 12:09:21 INFO - Output received: 12:09:21 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 12:09:21 INFO - Running post-action listener: _resource_record_post_action 12:09:21 INFO - [mozharness: 2016-11-23 20:09:21.883695Z] Finished install step (success) 12:09:21 INFO - [mozharness: 2016-11-23 20:09:21.883819Z] Running run-tests step. 12:09:21 INFO - Running pre-action listener: _resource_record_pre_action 12:09:21 INFO - Running main action method: run_tests 12:09:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:09:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:09:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:09:21 INFO - 2016-11-23 12:09:21.898 screenresolution[1899:10404] starting screenresolution argv=screenresolution get 12:09:21 INFO - 2016-11-23 12:09:21.900 screenresolution[1899:10404] Display 0: 1600x1200x32@60 12:09:21 INFO - 2016-11-23 12:09:21.906 screenresolution[1900:10407] starting screenresolution argv=screenresolution list 12:09:21 INFO - Available Modes on Display 0 12:09:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:09:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:09:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:09:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:09:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:09:22 INFO - Intel Iris: 12:09:22 INFO - Chipset Model: Intel Iris 12:09:22 INFO - Type: GPU 12:09:22 INFO - Bus: Built-In 12:09:22 INFO - VRAM (Dynamic, Max): 1536 MB 12:09:22 INFO - Vendor: Intel (0x8086) 12:09:22 INFO - Device ID: 0x0a2e 12:09:22 INFO - Revision ID: 0x0009 12:09:22 INFO - Displays: 12:09:22 INFO - Display: 12:09:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:09:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:09:22 INFO - Display Serial Number: 1600x1200 60 12:09:22 INFO - Main Display: Yes 12:09:22 INFO - Mirror: Off 12:09:22 INFO - Online: Yes 12:09:22 INFO - Rotation: Supported 12:09:22 INFO - Return code: 0 12:09:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:09:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:09:22 INFO - Python 2.7.3 12:09:22 INFO - Return code: 0 12:09:22 INFO - grabbing minidump binary from tooltool 12:09:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:09:22 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 0x102682d30>, '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 0x1024e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10267ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:09:22 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 12:09:22 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 12:09:22 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 12:09:22 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:09:22 INFO - Return code: 0 12:09:22 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:09:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:09:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:09:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:09:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:09:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DediSqmMSV2gPJGor5yAHQ/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0112', '--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 12:09:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DediSqmMSV2gPJGor5yAHQ/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0112 --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 12:09:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9dVwkGuzoY/Render', 12:09:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:09:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:09:22 INFO - 'HOME': '/Users/cltbld', 12:09:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:09:22 INFO - 'LOGNAME': 'cltbld', 12:09:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:09:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:09:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:09:22 INFO - 'MOZ_NO_REMOTE': '1', 12:09:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:09:22 INFO - 'NO_EM_RESTART': '1', 12:09:22 INFO - 'PAGER': '/bin/cat', 12:09:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:09:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:09:22 INFO - 'PWD': '/builds/slave/test', 12:09:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:09:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:09:22 INFO - 'SHELL': '/bin/bash', 12:09:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.unJpTrr72s/Listeners', 12:09:22 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 12:09:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:09:22 INFO - 'USER': 'cltbld', 12:09:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:09:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:09:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:09:22 INFO - 'XPC_FLAGS': '0x0', 12:09:22 INFO - 'XPC_SERVICE_NAME': '0', 12:09:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:09:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DediSqmMSV2gPJGor5yAHQ/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0112', '--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 12:09:22 INFO - mozversion application_buildid: 20161123105335 12:09:22 INFO - mozversion application_changeset: 08a24b71cfd864cda7a88eb9f524f2b5461aed0a 12:09:22 INFO - mozversion application_display_name: Firefox 12:09:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:09:22 INFO - mozversion application_name: Firefox 12:09:22 INFO - mozversion application_remotingname: firefox 12:09:22 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 12:09:22 INFO - mozversion application_vendor: Mozilla 12:09:22 INFO - mozversion application_version: 51.0 12:09:22 INFO - mozversion platform_buildid: 20161123105335 12:09:22 INFO - mozversion platform_changeset: 08a24b71cfd864cda7a88eb9f524f2b5461aed0a 12:09:22 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 12:09:22 INFO - mozversion platform_version: 51.0 12:09:22 INFO - using testdate: 1479931762 12:09:22 INFO - actual date: 1479931762 12:09:22 INFO - starting webserver on 'localhost:49708' 12:09:22 INFO - SUITE-START | Running 2 tests 12:09:22 INFO - TEST-START | dromaeo_css 12:09:22 INFO - operating with platform_type : mac_ 12:09:22 INFO - Initialising browser for dromaeo_css test... 12:09:22 INFO - TEST-INFO | started process 1910 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/tmpwVU8Ef/profile http://localhost:49708/getInfo.html) 12:09:24 INFO - PROCESS | 1910 | __metrics Screen width/height:1600/1200 12:09:24 INFO - PROCESS | 1910 | colorDepth:24 12:09:24 INFO - PROCESS | 1910 | Browser inner width/height: 1024/689 12:09:24 INFO - PROCESS | 1910 | __metrics 12:09:25 INFO - PROCESS | 1910 | 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" 12:09:25 INFO - PROCESS | 1910 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:09:25 INFO - TEST-INFO | 1910: exit 0 12:09:25 INFO - Browser initialized. 12:09:25 INFO - Running cycle 1/1 for dromaeo_css test... 12:09:25 INFO - TEST-INFO | started process 1913 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/tmpwVU8Ef/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:09:37 INFO - PROCESS | 1913 | RSS: Main: 168386560 12:09:37 INFO - PROCESS | 1913 | 12:10:31 INFO - PROCESS | 1913 | 1479931831845 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] 12:12:40 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49708/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49708/tests/dromaeo/cssquery-ext.html) 12:12:41 INFO - PROCESS | 1913 | RSS: Main: 302407680 12:12:41 INFO - PROCESS | 1913 | 12:15:44 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49708/tests/dromaeo/cssquery-ext.html (next: http://localhost:49708/tests/dromaeo/cssquery-jquery.html) 12:15:44 INFO - PROCESS | 1913 | RSS: Main: 303038464 12:15:44 INFO - PROCESS | 1913 | 12:18:46 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49708/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49708/tests/dromaeo/cssquery-mootools.html) 12:18:47 INFO - PROCESS | 1913 | RSS: Main: 272125952 12:18:47 INFO - PROCESS | 1913 | 12:21:49 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49708/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49708/tests/dromaeo/cssquery-prototype.html) 12:21:50 INFO - PROCESS | 1913 | RSS: Main: 272146432 12:21:50 INFO - PROCESS | 1913 | 12:24:53 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49708/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49708/tests/dromaeo/cssquery-yui.html) 12:24:54 INFO - PROCESS | 1913 | RSS: Main: 258420736 12:24:54 INFO - PROCESS | 1913 | 12:27:57 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49708/tests/dromaeo/cssquery-yui.html (next: http://localhost:49708/tests/dromaeo/cssquery-dojo.html) 12:27:57 INFO - PROCESS | 1913 | RSS: Main: 314302464 12:27:57 INFO - PROCESS | 1913 | 12:27:57 INFO - PROCESS | 1913 | __start_tp_report 12:27:57 INFO - PROCESS | 1913 | _x_x_mozilla_page_load 12:27:57 INFO - PROCESS | 1913 | _x_x_mozilla_page_load_details 12:27:57 INFO - PROCESS | 1913 | |i|pagename|runs| 12:27:57 INFO - PROCESS | 1913 | |0;dojo.html;3194.9840250798748;3412.7781694189875;3459.2735525539633;3479.095435186854;3505.491703702963;5858.765649374025;5954.345022047572;5962.463378295953;5977.940220597793;5980.431858973401;5874.3244526879425;5942.435468630484;5943.3462319144855;5948.286205655328;5971.492423144038;5275.525202731744;5305.973470132644;5319.5478384337375;5385.946140538584;5423.620346575742;5251.002309561171;5266.710330931797;5272.683638981654;5411.404745478014;5426.701531415791;5380.946190538103;5393.056215162331;5395.838124856241;5401.70290634015;5407.918881216785;5267.710275934822;5291.232771248186;5358;5386.5152136307925;5391.83824485268;5171.818986335498;5262.131748261532;5289.656172348785;5338.359396872362;5357.49103835139;6022.728977196037;6058.666773327465;6085.513158947274;6114;6124.050772130327;6212.4408803207925;6274.435300822948;6288.3397243289255;6309;6353;6236.719347629368;6257.374262573706;6268.467180289681;6309.0536419536975;6317.684115794192;6121.571489995702;6124.173236613089;6132;6135.355787642323;6139.938600614026;6228.875422491525;6303.432691057827;6306.49548036156;6308.0537919311555;6467.126937863422;6285.811425657238;6351.174347334817;6354.872902541923;6358.872822543523;6367.204099487564;6317.14718513004;6332.271788744261;6334.208223972004;6334.619922804646;6338.809835704937;6195.070739389128;6196.690165491707;6285.77999770015;6363.681815909186;6372.84067898297;6295.213098362705;6342.746290148342;6368.84077898047;6387.712552935129;6398.9040164397575;5104.9744751276;5130.846074617767;5138.332016837862;5154.149565321755;5171.97414012935;4606.700564463299;4618.815247390134;4625.190591646516;4627.95372046282;4653.302004699322;4864.440589332272;5793.797217097382;5838.065909454467;5853.765849365977;5945.732442040118;6303.149074874925;6314;6327.17746692927;6331.968340158362;6334.3665633436285;5983.072623743326;5999.220101386792;6002.399760023963;6010.2186715726675;6035.245594300713;5456.890862182734;5502.9174562381595;5505.256790333254;5582.302212223472;5612.550995920316;6381.393767592164;6416.165898433361;6428.839279018062;6526.771562995273;6545.345465453416;6339.714712837841;6343.3022367538615;6350.523710721622;6359.3640635936035;6360.809175724736;6243.7814676486105;6433.935660643334;6476.4495017924;6518.445932095825;6547.607143571401;6212.534059945432;6294.370562943669;6308.873822523432;6335.683215839282;6356.9046464304;6336.176297081534;6345;6347.270063942706;6362.013887847391;6385.233771947396;6282.905756413566;6323.936760632335;6329.620222786648;6358.618482891041;6368.808935731936;6097.75608975636;6139.26328840542;6183.721732522137;6200.0699895016105;6227.003679411272;6235.127082208585;6236.469900058546;6239.96880015597;6240.095186198067;6257.624542527463;6298.7480500781285;6330.430261276507;6331.05034244867;6342.524310676626;6350.142730731477;6058.515318774399;6120.3267640558615;6133.325334213144;6149.692515374303;6241.750329986749 12:27:57 INFO - PROCESS | 1913 | |1;ext.html;474.49229324622644;474.83380816714157;507.5711024184563;534.3400899888637;553.8562867678241;32170.356592868156;40664.390034149474;42426.72719818407;42492.575074249246;42510;43936.3409548857;44172.55827441725;44188.55811441885;44192.55807441925;44345.8913527162;9171.908280917205;9807.509624518781;9974.952629973857;9977.950110249474;9980.401175929468;9219.44683319003;12099.455524501374;12381.319027453486;12404;12497.625071247878;12351.752964940695;12448.190867593623;12467.875321246807;12475.812862807064;12477.750444991094;12425.2544847309;12496.125271231018;12502.874971250261;12508.249505029728;12508.74982500354;12240.877591224064;12315.93842030793;12333.876661233362;12335.5065797368;12352.320622365767;41418.792906035276;41662.791686041375;41746.58253417457;41789.79105104486;41807.790961045;3450.27544215715;3588.3540962626716;3653.4337177737493;3952.486176797027;4332.631726303268;31486.527702084488;31860;32177.51733723996;32332.676673233203;32381.51427728586;3296.5055241713935;3350.71518920892;3440.449528075521;3446.827658617084;3492.6507349265125;535193;541128;541244;541942.999999996;544769;59950;60395.39604603986;60407.69796150991;60478;60519;30212.69787302143;35336.82331588326;36207;37565.81217093897;63639;17911.193996270198;18092.819071809376;18093.185806638732;18104.275828966693;18108.818911810715;12570.497180112692;12795.61613151607;13398.732025359439;13516.662083447993;13661.863381366258;18966.71549926752;19261.422157335302;19282.614347712966;19345;19424.22303107888;7411.258874112654;7574.810629734301;7925.801854953557;8060.919390806134;8143.18568143181;878.7100256915203;1038.382162613244;1086.760912599227;1126.357975953715;1169.958736724316;29338.97313594014;30663.38673226523;31126.533102003486;31655.070945861422;31910.840445798087;950.9619615215314;957.6504575829912;1046.0899017854515;1086.239632257423;1091.5088210305394;13192.934035329954;15482;16125.677486450206;16264.918675406783;16951;729907;739946;740533;742041;742206;58771.41228587745;59219.703901480214;59390;59427.70286148628;59530.70234648799;1289.5873320537526;1326.6285440076795;1327.2103098656285;1337.7057047449546;1340.5710172744627;30695.539566906962;33141;33258.334833303685;33343.49984750182;34152.316953661284;54334.72832635811;55161.72419137879;55201.171982419495;55246.44753552413;55425.61435964133;505289.36776580877;607585;613123;614532;617099;26857.328566785203;27152.321191969568;27481.45037099207;27514.17457476279;27549.58675619827;49352.753236235025;49415;49485.50514494809;49542.43772550103;50013.49986500234;39783.403248951865;40238.39642405308;40253.39619905762;40312.57343125867;41773.582264178185;32186.83906580546;39863.00342491461;40421.393679095425;41321.380179297936;41551.1689766209;39217;39459.80270098746;39480.60519394884;39794;39981;33884.49173262453;34960.475592865616;35790.46314305235;35825.64174358327;36025.63974360328;21250;21639;26509.33726656849;26598.335041624116;27193.86403067972 12:27:57 INFO - PROCESS | 1913 | |2;jquery.html;383.1933779394375;387.81966385630676;394.56991878852045;395.36938582960175;413.50999066106664;15153.696926061471;20432.489187770294;21547.46131346717;21837.563248735034;21843;21036.474088147803;21254.89372553139;21591.920403979817;22052.779472205275;22147.892605369747;5994.850128746783;6304.464120549759;6309.369063093677;6314.589551679126;6315.621062736228;5970;6133.539984501158;6170.598911070789;6219.751209951596;6267.247930248376;6173.567850250484;6176.814695559118;6178.598391104564;6189.195404597419;6193.535484838632;5912.704364781765;6148.477379422754;6148.87702245957;6209.5032397408095;6218.440340369389;5378.381486129106;5380.838574842761;5385.8114965976;5389.622726409153;5397;13867.306634668326;14014.509492167826;22686.77313226863;23305.83470826452;24964.5007099857;2256.537409830997;2330.3242059802637;2381.9498473876333;2406.230006397936;2448.338948483917;9966.003399660049;10229.232807539463;12269.631911042683;12749.362531873368;15585.766213506806;1695.703251930907;1893.5455490682275;1915.6456055629753;1984.6081512459593;2012.5069358007381;115067.42466287615;121026.47771305808;126078;127746;133802.99999999904;11264.43677816106;11299.604513842141;11699.532018719327;11723.179377443668;11921.463534140985;13372.398242079129;13873.028887977947;15022.774658380133;15030.774538381933;15053;8606.44058136219;8740;8834.911650883409;8903.643854245887;8989.763685073369;8871.689490867788;8882.777930551789;8900.243479304203;9055.366124371363;9063.818723625622;3979.005248687828;4330.631896288788;4565.908681826411;4578.45058592971;4625.098105869323;1905.6188762247607;1948.6687263165295;1958.8726732762325;1961.2841312920966;1963.8821670699804;786.838698066895;900.2078171209293;918.1231923513162;951.6130637759921;977.8044391121804;18396.98816565075;18980.52548686266;20357.287494937606;20387.796122038886;22307.330780076623;854.2738672128766;934.9061597930438;967.9854802177973;969.767255858603;1005.6228914157191;10507.579696812041;11511.30932144074;11524.539018439169;11527.48126334317;11557.364344960939;614083;622547;626658;643744;644715;138955;140218;149234.50765492424;150431;152647;900.7883147460342;1009.1119814563284;1017.6133069433567;1039.5374058543875;1060.4644654449453;12589.622311330675;18264.178111985257;18364.816351836846;19628.509287267934;19983.000849957734;52909;54775.90448191093;55109;57853.84292314215;58538.14618538112;69647.65176174087;72554.27445725475;78989.60505197437;85698;86197.56901215453;7155.642217889189;7996.520208787491;8086.757397278091;8373.58132093405;8569.357298202784;9173.54132293396;12852;13318.733625327633;13680.863191367958;14173.362198700877;5658.179563963285;6913.965430172817;11045.502952367002;12041.33772642513;12182.512699491921;6386.648734319657;6987.755428560179;10487.37075775456;10962.232643714864;11869.991050760782;11680.94159529231;11832.230904991147;11952.983996360406;12059.57791477294;12192.390380480763;8172.713955011546;8324.6670133194;8499.702510412106;8643.611037503202;8766.736997890073;11553;11682.065434765029;11866.466009029442;11945.402729863647;11950.701232469259 12:27:57 INFO - PROCESS | 1913 | |3;mootools.html;1396.8393634732008;1549.752039673652;1562.7577725452554;1718.5359952812742;1765.999999999999;8216.548089855056;8752.606132724026;9023.097690230974;9329.766755831108;9334.486603236819;9194.862077068849;9288.582013809379;9288.721338359843;9309.162175404212;9335.673251436201;2401.8198635102394;2439.499902519988;2442.242904699549;2444.083468699238;2447.2046584859904;2398.8680622565753;2409.590369637157;2440.5728997425467;2441.9023239070416;2442.2917353967327;2396.724376696685;2413.239829453725;2420.104561312317;2426.514697060595;2428.465737537748;2371.0160283482332;2392.5334559760854;2403.714013003044;2405.867677277749;2410.3974006498374;2358.870262135582;2378.619420892649;2388.9641655375185;2392.079049565912;2392.270357540949;9268.21220196284;9327.906720932771;9363.34456588039;9381.906180938171;9392.201662858664;5340.679559226459;5536.972315138439;5541.226807421626;5605.411431799684;5608.214849921014;3680.650338217865;3692.4276737105793;3747.6814470769746;3751.718621103428;3816.503854498925;1100.9669709908715;1113.7438389170454;1117.6479408986143;1130.3387518301804;1139.9487023083982;12414;12444.191127576678;12551.246925184427;12552.121351505399;12572.559960401433;4494.955050449519;4521.231390663595;4719.2921061841;4733.219018861849;4733.36099626546;9677.467739274407;9678.370905891095;9679.516024198761;9684.370515916444;9687.467189304514;5381.408045115034;5386.811461598825;5387.919181212285;5388.973055134699;5391.892162156813;4573.702709323949;4729.929051064237;4858.927116093261;4960.975195124001;5037.546620804145;3850.5956874528333;3862.304785138646;3946.7631942083567;3954.2882281189663;3979.900502487403;1033.1970711109163;1041.874775242736;1140.43548443521;1156.7859945910034;1163.4473625028045;895.2927187521915;921.9861702074475;927.38792397019;938.3619138985555;953.065995324572;5924.229850119457;5948.970255148696;6196.442320191114;6238.438540531374;6301.527385446018;431.4499013757484;437.2937705605488;445.8852867830424;451.6071018214175;452.30119465426;3899.3760998240145;3951.723379363417;3953.940690889639;4083.7549747015273;4100.466939297932;10995;11515.596954106566;11516.481758320895;11519.88480115205;11535.653930382103;11001.504932278067;11431.428428578538;11447.313161210188;11460.828087578693;11467.31196128235;8558.630619101039;8754.387192896564;8770;8773.341999349946;8789.373965816345;5765.740541675718;5826.155207494974;5975;6024.006039003515;6035.969820150871;10220.744481388025;10583.206259530412;10678.786424271315;10699.94650026745;10738;10836.241463097507;10897.945510272715;10909.781804364027;10915.508802103766;10925.617603383844;6214.689265536796;6260.311365749672;6782.525223234326;7110.182329032021;7208.9907412963275;8576;8705.390622656607;8873.157050080232;8985.730428087169;9008.954955225181;7860.764177074697;8019.9198008019175;8040.316573091119;8147.307478864126;8192.18078192176;7804.570748608881;7876.369890408868;7891.210878912292;7941.364690824605;7952.602369881367;6895.448364130958;6917.13535808024;6977.860442791217;6979.511434199558;6980.581165130108;4980.975095124501;5009.974950125226;5173.586113110867;5185.27406163145;5287.57699384056;5041.899162016666;5080.49195080489;5178.326817513699;5200.401953775364;5328.573714102785 12:27:57 INFO - PROCESS | 1913 | |4;prototype.html;255.7417008821091;306.6856472116082;312.4266970109848;315.9668234835342;321.0432909928412;5207.18811841606;5405.540529055035;5477.178423236512;5509.917351239729;5518.227448157256;4730.763461826912;4796.928046079312;5026.3214466047075;5252.947470525293;5470.729647196409;3627.891163265106;3960.386140148282;3992.860249891254;4071.7964101794864;4232;4141.943804329907;4167.083241686824;4172.436721042666;4206.326987681971;4219.818450833756;3526;3822.789746563938;4039.53545342285;4138.52406973199;4148.419221309019;4036.1927614476926;4040.3939459048747;4058.7620775663413;4059.6143366380147;4072.511298644167;3484.9893530876016;3495.405781017233;3506.333796578642;3513.2095278562374;3516.226430185355;4935.432425271104;5249.160134378481;5251.186066159751;5325.680459172462;5355.812546560891;4655.837045703418;4673.766311684402;4683.976580117112;4711.316859055418;4720.12677654635;5740.82777516671;5742.425757424266;5764.625299355528;5796.246487956539;5819.79630712923;3556.8399422026073;3667.449882517644;3710.8515659373593;3905.37513997759;3941.5664276929515;5152.407473140599;5749.131532252035;5999.730012149464;6017.826523827812;6054.697265136726;3433.6738009889023;3806.71449641278;3954.974444549922;3955.169414423003;3971.860984865516;4024.2957482440456;4035.556088830226;4039;4047.7571345719352;4058.0869304406274;3936.7244292899795;4556.703814252063;4619.3994780678295;4691.859244222679;4726.881827954328;5092.337996060563;5410.675359478444;5442.673439593637;5756.971215143982;5758.596898217084;1146.060230610891;1228.846394200725;1285.1389568988614;1356.830396200475;1357.7759669654397;864.7103220421229;891.4116682989196;907.6278725722422;909.5952301225891;922.2022950148207;4665.743384113838;5418.458154184629;5428.9185662215095;5459.317585301837;5488.231647569343;4931.175465077944;5305.018571564273;5808.128780682847;5828.213191219131;5882.088276317178;4645.372874661945;4857.445617402397;5305.65513241638;5353.598480114007;5365.846343036188;2548;3008.307564729555;3025.2285667154733;3063.2495038715656;3107.735842453372;5335.45271871153;5514.80698175562;6024.578279520391;6073.848153796102;6089.51283897296;5284.471552844685;5490.835274941678;5568.16477528374;5734.225879506297;5979.594795223119;5060.5698515625845;5478.45215478449;5620.662760234399;6094.329623741385;6112.052631842072;5436.646617969819;5750.872177294428;5769.336526299361;5804.245448091721;5833.82498525045;4289.721168124062;4918.4343800461975;5265.420803711512;5285.969235998943;5336.67979921206;5416.593755468434;5633.577561648367;6058.84852878664;6075.635461872302;6180.783672571439;3305.6529064447886;3863.190328041494;3916.3146449370674;3918.4122381642983;3932.4691166692132;4742.620590352694;5524.723763811713;5799.681017543907;5830.5044071254415;5831.4168583141345;5408.323959505062;5415.864603384947;5761.020626493422;5768.971155144198;5975.193348897843;4773.976130119466;4854.271859221004;5862.472377486047;5862.530997520103;5935.397442690536;4897.338859253955;5401.378841433128;5635.746391412315;5741.655500669973;5760.711964401847;4601.700889442175;5282.735863206747;5515.648666076837;5722.397728635989;5786.681732504752;5225.712585807817;5700.261420266858;5722.2561067061015;5780.190773291826;5785.42548565901 12:27:57 INFO - PROCESS | 1913 | |5;yui.html;760.1334478694288;784.4430454377392;789.5341748368463;822.4695071678767;841.4446465332882;15949.202539873004;16316.918415407936;16919.83080169198;17023;17396.47810565685;15484.458043968463;15511.767323490156;15663.843361566409;15681.215939203052;15687;731.8060713910818;884.1732979664002;893.0310612984919;894.3694695239873;894.5840184314293;746.3655892491366;872.1452976083442;898.371140201858;910.5720311453606;912.5254867468913;953.2516974175273;955.3742298794301;956.6125719083782;957.4877440569297;958.0323872888363;951.5527701980093;952.0669743651226;954.3367359685021;954.89973552777;955.479263801223;701.0325750464326;702.1083224305104;702.7364738223166;705.7106586299644;706.2725392845377;15408.306626201736;15498.380064797395;15558.455454059167;15624.531264061983;15644.296006679726;13723.931380343134;14903;15049.699006019819;15179.62050948724;15338.923305383401;13087.934560327138;13470.25913574753;13734.45062197511;13853.391412570007;14003.579892603238;4465.620422264112;4519.186546421643;4555.612772914306;4839.177339852234;4931.630127740434;80167;98804.99999999929;114042.28936565958;116485;118735;10996.780064398827;11014.173936954761;11190.720231994264;11417.143714221467;11563.42182890852;21538.461538461663;21554.784452155276;21624.02691878869;21675.458113547287;21710.674339884914;7605.733799316998;7661.502002369828;7716;7779.688812447439;7934.880976785353;4234.474338549469;4387.736735795863;4414.668899832525;4537.8184872604725;4585.95414045862;3568.91077723059;3695.7228207883977;3701.8704345347783;3706.8517259309865;3711.536057992751;632.6899819088705;637.3912913167914;648.5849056603778;649.4771708774482;684.1584850633749;462.14733816109225;539.4767075936336;618.604093380237;658.7727234104226;674.3593586093231;7360.300771426706;9015.233705135137;9132.589033493508;9405.829316416439;9455.479948602755;539.9730013499309;560.5011539729644;583.4020129367348;653.911721917535;672.825065482978;4348.391225228407;4496.392986946786;4555.339475775994;4578.702384345007;4683.1336202802595;132267;138080;138537.30731346278;148117;152130.23934880254;107450;112366;114134;114184;134576.32711836378;80107;100780;104169;108559;111817.88182118237;10047.949760251153;10050.09549140581;10082.596696132367;10140.746481338025;10173.186145108522;60775.69612151911;61208;61625;62597.06104408528;62704.68647656732;97231;97787.1327720339;98239;100434;101084.98915010756;13180;13622.114562553403;13658.385372658055;13734.45062197501;13987.300634968007;15033.699326013637;15088.39646414175;15223.238838058274;16143.950643208154;16423.507294781175;14204.78692819588;14569.490067847575;14694.779578306549;15433.382664693287;15433.382664693287;14293.857061429253;14477.565673029825;14591.489297874523;15129.621759456102;15242.542723718307;11653.6503904883;13412.463501460223;13552.322383880964;13672.93163534176;13724.65688357799;11395.430228488376;11505.712357191138;12085.456154473246;12233.797500334125;12383.876161238633;9975.551100200364;11407.885921140682;11868.643940681794;12002.159848810848;12032.879671203176 12:27:57 INFO - PROCESS | 1913 | __end_tp_report 12:27:57 INFO - PROCESS | 1913 | __start_cc_report 12:27:57 INFO - PROCESS | 1913 | _x_x_mozilla_cycle_collect,1122 12:27:57 INFO - PROCESS | 1913 | __end_cc_report 12:27:57 INFO - PROCESS | 1913 | __startTimestamp1479932877350__endTimestamp 12:27:57 INFO - PROCESS | 1913 | 12:27:57 INFO - PROCESS | 1913 | ------- Summary: start ------- 12:27:57 INFO - PROCESS | 1913 | Number of tests: 6 12:27:57 INFO - PROCESS | 1913 | 12:27:57 INFO - PROCESS | 1913 | [#0] dojo.html Cycles:165 Average:5903.29 Median:6195.07 stddev:646.57 (10.4%) stddev-sans-first:612.66 12:27:57 INFO - PROCESS | 1913 | Values: 3195.0 3412.8 3459.3 3479.1 3505.5 5858.8 5954.3 5962.5 5977.9 5980.4 5874.3 5942.4 5943.3 5948.3 5971.5 5275.5 5306.0 5319.5 5385.9 5423.6 5251.0 5266.7 5272.7 5411.4 5426.7 5380.9 5393.1 5395.8 5401.7 5407.9 5267.7 5291.2 5358.0 5386.5 5391.8 5171.8 5262.1 5289.7 5338.4 5357.5 6022.7 6058.7 6085.5 6114.0 6124.1 6212.4 6274.4 6288.3 6309.0 6353.0 6236.7 6257.4 6268.5 6309.1 6317.7 6121.6 6124.2 6132.0 6135.4 6139.9 6228.9 6303.4 6306.5 6308.1 6467.1 6285.8 6351.2 6354.9 6358.9 6367.2 6317.1 6332.3 6334.2 6334.6 6338.8 6195.1 6196.7 6285.8 6363.7 6372.8 6295.2 6342.7 6368.8 6387.7 6398.9 5105.0 5130.8 5138.3 5154.1 5172.0 4606.7 4618.8 4625.2 4628.0 4653.3 4864.4 5793.8 5838.1 5853.8 5945.7 6303.1 6314.0 6327.2 6332.0 6334.4 5983.1 5999.2 6002.4 6010.2 6035.2 5456.9 5502.9 5505.3 5582.3 5612.6 6381.4 6416.2 6428.8 6526.8 6545.3 6339.7 6343.3 6350.5 6359.4 6360.8 6243.8 6433.9 6476.4 6518.4 6547.6 6212.5 6294.4 6308.9 6335.7 6356.9 6336.2 6345.0 6347.3 6362.0 6385.2 6282.9 6323.9 6329.6 6358.6 6368.8 6097.8 6139.3 6183.7 6200.1 6227.0 6235.1 6236.5 6240.0 6240.1 6257.6 6298.7 6330.4 6331.1 6342.5 6350.1 6058.5 6120.3 6133.3 6149.7 6241.8 12:27:57 INFO - PROCESS | 1913 | 12:27:57 INFO - PROCESS | 1913 | [#1] ext.html Cycles:180 Average:75226.18 Median:19807.00 stddev:168685.53 (851.6%) stddev-sans-first:169065.37 12:27:57 INFO - PROCESS | 1913 | Values: 474.5 474.8 507.6 534.3 553.9 32170.4 40664.4 42426.7 42492.6 42510.0 43936.3 44172.6 44188.6 44192.6 44345.9 9171.9 9807.5 9975.0 9978.0 9980.4 9219.4 12099.5 12381.3 12404.0 12497.6 12351.8 12448.2 12467.9 12475.8 12477.8 12425.3 12496.1 12502.9 12508.2 12508.7 12240.9 12315.9 12333.9 12335.5 12352.3 41418.8 41662.8 41746.6 41789.8 41807.8 3450.3 3588.4 3653.4 3952.5 4332.6 31486.5 31860.0 32177.5 32332.7 32381.5 3296.5 3350.7 3440.4 3446.8 3492.7 535193.0 541128.0 541244.0 541943.0 544769.0 59950.0 60395.4 60407.7 60478.0 60519.0 30212.7 35336.8 36207.0 37565.8 63639.0 17911.2 18092.8 18093.2 18104.3 18108.8 12570.5 12795.6 13398.7 13516.7 13661.9 18966.7 19261.4 19282.6 19345.0 19424.2 7411.3 7574.8 7925.8 8060.9 8143.2 878.7 1038.4 1086.8 1126.4 1170.0 29339.0 30663.4 31126.5 31655.1 31910.8 951.0 957.7 1046.1 1086.2 1091.5 13192.9 15482.0 16125.7 16264.9 16951.0 729907.0 739946.0 740533.0 742041.0 742206.0 58771.4 59219.7 59390.0 59427.7 59530.7 1289.6 1326.6 1327.2 1337.7 1340.6 30695.5 33141.0 33258.3 33343.5 34152.3 54334.7 55161.7 55201.2 55246.4 55425.6 505289.4 607585.0 613123.0 614532.0 617099.0 26857.3 27152.3 27481.5 27514.2 27549.6 49352.8 49415.0 49485.5 49542.4 50013.5 39783.4 40238.4 40253.4 40312.6 41773.6 32186.8 39863.0 40421.4 41321.4 41551.2 39217.0 39459.8 39480.6 39794.0 39981.0 33884.5 34960.5 35790.5 35825.6 36025.6 21250.0 21639.0 26509.3 26598.3 27193.9 12:27:57 INFO - PROCESS | 1913 | 12:27:57 INFO - PROCESS | 1913 | [#2] jquery.html Cycles:180 Average:36620.52 Median:2394.09 stddev:105622.04 (4411.8%) stddev-sans-first:105883.29 12:27:57 INFO - PROCESS | 1913 | Values: 383.2 387.8 394.6 395.4 413.5 15153.7 20432.5 21547.5 21837.6 21843.0 21036.5 21254.9 21591.9 22052.8 22147.9 5994.9 6304.5 6309.4 6314.6 6315.6 5970.0 6133.5 6170.6 6219.8 6267.2 6173.6 6176.8 6178.6 6189.2 6193.5 5912.7 6148.5 6148.9 6209.5 6218.4 5378.4 5380.8 5385.8 5389.6 5397.0 13867.3 14014.5 22686.8 23305.8 24964.5 2256.5 2330.3 2381.9 2406.2 2448.3 9966.0 10229.2 12269.6 12749.4 15585.8 1695.7 1893.5 1915.6 1984.6 2012.5 115067.4 121026.5 126078.0 127746.0 133803.0 11264.4 11299.6 11699.5 11723.2 11921.5 13372.4 13873.0 15022.8 15030.8 15053.0 8606.4 8740.0 8834.9 8903.6 8989.8 8871.7 8882.8 8900.2 9055.4 9063.8 3979.0 4330.6 4565.9 4578.5 4625.1 1905.6 1948.7 1958.9 1961.3 1963.9 786.8 900.2 918.1 951.6 977.8 18397.0 18980.5 20357.3 20387.8 22307.3 854.3 934.9 968.0 969.8 1005.6 10507.6 11511.3 11524.5 11527.5 11557.4 614083.0 622547.0 626658.0 643744.0 644715.0 138955.0 140218.0 149234.5 150431.0 152647.0 900.8 1009.1 1017.6 1039.5 1060.5 12589.6 18264.2 18364.8 19628.5 19983.0 52909.0 54775.9 55109.0 57853.8 58538.1 69647.7 72554.3 78989.6 85698.0 86197.6 7155.6 7996.5 8086.8 8373.6 8569.4 9173.5 12852.0 13318.7 13680.9 14173.4 5658.2 6914.0 11045.5 12041.3 12182.5 6386.6 6987.8 10487.4 10962.2 11870.0 11680.9 11832.2 11953.0 12059.6 12192.4 8172.7 8324.7 8499.7 8643.6 8766.7 11553.0 11682.1 11866.5 11945.4 11950.7 12:27:57 INFO - PROCESS | 1913 | 12:27:57 INFO - PROCESS | 1913 | [#3] mootools.html Cycles:180 Average:5911.54 Median:4733.29 stddev:3431.11 (72.5%) stddev-sans-first:3423.96 12:27:57 INFO - PROCESS | 1913 | Values: 1396.8 1549.8 1562.8 1718.5 1766.0 8216.5 8752.6 9023.1 9329.8 9334.5 9194.9 9288.6 9288.7 9309.2 9335.7 2401.8 2439.5 2442.2 2444.1 2447.2 2398.9 2409.6 2440.6 2441.9 2442.3 2396.7 2413.2 2420.1 2426.5 2428.5 2371.0 2392.5 2403.7 2405.9 2410.4 2358.9 2378.6 2389.0 2392.1 2392.3 9268.2 9327.9 9363.3 9381.9 9392.2 5340.7 5537.0 5541.2 5605.4 5608.2 3680.7 3692.4 3747.7 3751.7 3816.5 1101.0 1113.7 1117.6 1130.3 1139.9 12414.0 12444.2 12551.2 12552.1 12572.6 4495.0 4521.2 4719.3 4733.2 4733.4 9677.5 9678.4 9679.5 9684.4 9687.5 5381.4 5386.8 5387.9 5389.0 5391.9 4573.7 4729.9 4858.9 4961.0 5037.5 3850.6 3862.3 3946.8 3954.3 3979.9 1033.2 1041.9 1140.4 1156.8 1163.4 895.3 922.0 927.4 938.4 953.1 5924.2 5949.0 6196.4 6238.4 6301.5 431.4 437.3 445.9 451.6 452.3 3899.4 3951.7 3953.9 4083.8 4100.5 10995.0 11515.6 11516.5 11519.9 11535.7 11001.5 11431.4 11447.3 11460.8 11467.3 8558.6 8754.4 8770.0 8773.3 8789.4 5765.7 5826.2 5975.0 6024.0 6036.0 10220.7 10583.2 10678.8 10699.9 10738.0 10836.2 10897.9 10909.8 10915.5 10925.6 6214.7 6260.3 6782.5 7110.2 7209.0 8576.0 8705.4 8873.2 8985.7 9009.0 7860.8 8019.9 8040.3 8147.3 8192.2 7804.6 7876.4 7891.2 7941.4 7952.6 6895.4 6917.1 6977.9 6979.5 6980.6 4981.0 5010.0 5173.6 5185.3 5287.6 5041.9 5080.5 5178.3 5200.4 5328.6 12:27:57 INFO - PROCESS | 1913 | 12:27:57 INFO - PROCESS | 1913 | [#4] prototype.html Cycles:180 Average:4591.04 Median:5250.17 stddev:1413.96 (26.9%) stddev-sans-first:1379.97 12:27:57 INFO - PROCESS | 1913 | Values: 255.7 306.7 312.4 316.0 321.0 5207.2 5405.5 5477.2 5509.9 5518.2 4730.8 4796.9 5026.3 5252.9 5470.7 3627.9 3960.4 3992.9 4071.8 4232.0 4141.9 4167.1 4172.4 4206.3 4219.8 3526.0 3822.8 4039.5 4138.5 4148.4 4036.2 4040.4 4058.8 4059.6 4072.5 3485.0 3495.4 3506.3 3513.2 3516.2 4935.4 5249.2 5251.2 5325.7 5355.8 4655.8 4673.8 4684.0 4711.3 4720.1 5740.8 5742.4 5764.6 5796.2 5819.8 3556.8 3667.4 3710.9 3905.4 3941.6 5152.4 5749.1 5999.7 6017.8 6054.7 3433.7 3806.7 3955.0 3955.2 3971.9 4024.3 4035.6 4039.0 4047.8 4058.1 3936.7 4556.7 4619.4 4691.9 4726.9 5092.3 5410.7 5442.7 5757.0 5758.6 1146.1 1228.8 1285.1 1356.8 1357.8 864.7 891.4 907.6 909.6 922.2 4665.7 5418.5 5428.9 5459.3 5488.2 4931.2 5305.0 5808.1 5828.2 5882.1 4645.4 4857.4 5305.7 5353.6 5365.8 2548.0 3008.3 3025.2 3063.2 3107.7 5335.5 5514.8 6024.6 6073.8 6089.5 5284.5 5490.8 5568.2 5734.2 5979.6 5060.6 5478.5 5620.7 6094.3 6112.1 5436.6 5750.9 5769.3 5804.2 5833.8 4289.7 4918.4 5265.4 5286.0 5336.7 5416.6 5633.6 6058.8 6075.6 6180.8 3305.7 3863.2 3916.3 3918.4 3932.5 4742.6 5524.7 5799.7 5830.5 5831.4 5408.3 5415.9 5761.0 5769.0 5975.2 4774.0 4854.3 5862.5 5862.5 5935.4 4897.3 5401.4 5635.7 5741.7 5760.7 4601.7 5282.7 5515.6 5722.4 5786.7 5225.7 5700.3 5722.3 5780.2 5785.4 12:27:57 INFO - PROCESS | 1913 | 12:27:57 INFO - PROCESS | 1913 | [#5] yui.html Cycles:180 Average:24484.82 Median:21649.74 stddev:37738.47 (174.3%) stddev-sans-first:37802.29 12:27:57 INFO - PROCESS | 1913 | Values: 760.1 784.4 789.5 822.5 841.4 15949.2 16316.9 16919.8 17023.0 17396.5 15484.5 15511.8 15663.8 15681.2 15687.0 731.8 884.2 893.0 894.4 894.6 746.4 872.1 898.4 910.6 912.5 953.3 955.4 956.6 957.5 958.0 951.6 952.1 954.3 954.9 955.5 701.0 702.1 702.7 705.7 706.3 15408.3 15498.4 15558.5 15624.5 15644.3 13723.9 14903.0 15049.7 15179.6 15338.9 13087.9 13470.3 13734.5 13853.4 14003.6 4465.6 4519.2 4555.6 4839.2 4931.6 80167.0 98805.0 114042.3 116485.0 118735.0 10996.8 11014.2 11190.7 11417.1 11563.4 21538.5 21554.8 21624.0 21675.5 21710.7 7605.7 7661.5 7716.0 7779.7 7934.9 4234.5 4387.7 4414.7 4537.8 4586.0 3568.9 3695.7 3701.9 3706.9 3711.5 632.7 637.4 648.6 649.5 684.2 462.1 539.5 618.6 658.8 674.4 7360.3 9015.2 9132.6 9405.8 9455.5 540.0 560.5 583.4 653.9 672.8 4348.4 4496.4 4555.3 4578.7 4683.1 132267.0 138080.0 138537.3 148117.0 152130.2 107450.0 112366.0 114134.0 114184.0 134576.3 80107.0 100780.0 104169.0 108559.0 111817.9 10047.9 10050.1 10082.6 10140.7 10173.2 60775.7 61208.0 61625.0 62597.1 62704.7 97231.0 97787.1 98239.0 100434.0 101085.0 13180.0 13622.1 13658.4 13734.5 13987.3 15033.7 15088.4 15223.2 16144.0 16423.5 14204.8 14569.5 14694.8 15433.4 15433.4 14293.9 14477.6 14591.5 15129.6 15242.5 11653.7 13412.5 13552.3 13672.9 13724.7 11395.4 11505.7 12085.5 12233.8 12383.9 9975.6 11407.9 11868.6 12002.2 12032.9 12:27:57 INFO - PROCESS | 1913 | -------- Summary: end -------- 12:27:57 INFO - PROCESS | 1913 | 12:27:57 INFO - TEST-INFO | 1913: exit 0 12:27:57 INFO - TEST-OK | dromaeo_css | took 1115438ms 12:27:57 INFO - TEST-START | kraken 12:27:57 INFO - operating with platform_type : mac_ 12:27:57 INFO - Initialising browser for kraken test... 12:27:57 INFO - TEST-INFO | started process 1916 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/tmpxL5RYa/profile http://localhost:49708/getInfo.html) 12:28:00 INFO - PROCESS | 1916 | __metrics Screen width/height:1600/1200 12:28:00 INFO - PROCESS | 1916 | colorDepth:24 12:28:00 INFO - PROCESS | 1916 | Browser inner width/height: 1024/689 12:28:00 INFO - PROCESS | 1916 | __metrics 12:28:00 INFO - PROCESS | 1916 | 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" 12:28:00 INFO - PROCESS | 1916 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:28:00 INFO - TEST-INFO | 1916: exit 0 12:28:00 INFO - Browser initialized. 12:28:00 INFO - Running cycle 1/1 for kraken test... 12:28:00 INFO - TEST-INFO | started process 1918 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/tmpxL5RYa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:28:12 INFO - PROCESS | 1918 | RSS: Main: 169082880 12:28:12 INFO - PROCESS | 1918 | 12:28:15 INFO - PROCESS | 1918 | Cycle 1(1): loaded http://localhost:49708/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49708/tests/kraken/driver.html?testName=audio-beat-detection) 12:28:16 INFO - PROCESS | 1918 | RSS: Main: 218726400 12:28:16 INFO - PROCESS | 1918 | 12:28:18 INFO - PROCESS | 1918 | Cycle 1(1): loaded http://localhost:49708/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49708/tests/kraken/driver.html?testName=audio-dft) 12:28:19 INFO - PROCESS | 1918 | RSS: Main: 230092800 12:28:19 INFO - PROCESS | 1918 | 12:28:22 INFO - PROCESS | 1918 | Cycle 1(1): loaded http://localhost:49708/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49708/tests/kraken/driver.html?testName=audio-fft) 12:28:23 INFO - PROCESS | 1918 | RSS: Main: 325001216 12:28:23 INFO - PROCESS | 1918 | 12:28:25 INFO - PROCESS | 1918 | Cycle 1(1): loaded http://localhost:49708/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49708/tests/kraken/driver.html?testName=audio-oscillator) 12:28:25 INFO - PROCESS | 1918 | RSS: Main: 229388288 12:28:25 INFO - PROCESS | 1918 | 12:28:27 INFO - PROCESS | 1918 | Cycle 1(1): loaded http://localhost:49708/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49708/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:28:28 INFO - PROCESS | 1918 | RSS: Main: 229744640 12:28:28 INFO - PROCESS | 1918 | 12:28:31 INFO - PROCESS | 1918 | Cycle 1(1): loaded http://localhost:49708/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49708/tests/kraken/driver.html?testName=imaging-darkroom) 12:28:31 INFO - PROCESS | 1918 | RSS: Main: 267853824 12:28:31 INFO - PROCESS | 1918 | 12:28:34 INFO - PROCESS | 1918 | Cycle 1(1): loaded http://localhost:49708/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49708/tests/kraken/driver.html?testName=imaging-desaturate) 12:28:35 INFO - PROCESS | 1918 | RSS: Main: 267841536 12:28:35 INFO - PROCESS | 1918 | 12:28:37 INFO - PROCESS | 1918 | Cycle 1(1): loaded http://localhost:49708/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49708/tests/kraken/driver.html?testName=json-parse-financial) 12:28:38 INFO - PROCESS | 1918 | RSS: Main: 264642560 12:28:38 INFO - PROCESS | 1918 | 12:28:40 INFO - PROCESS | 1918 | Cycle 1(1): loaded http://localhost:49708/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49708/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:28:40 INFO - PROCESS | 1918 | RSS: Main: 241143808 12:28:40 INFO - PROCESS | 1918 | 12:28:42 INFO - PROCESS | 1918 | Cycle 1(1): loaded http://localhost:49708/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49708/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:28:43 INFO - PROCESS | 1918 | RSS: Main: 246456320 12:28:43 INFO - PROCESS | 1918 | 12:28:45 INFO - PROCESS | 1918 | Cycle 1(1): loaded http://localhost:49708/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49708/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:28:46 INFO - PROCESS | 1918 | RSS: Main: 250843136 12:28:46 INFO - PROCESS | 1918 | 12:28:48 INFO - PROCESS | 1918 | Cycle 1(1): loaded http://localhost:49708/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49708/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:28:49 INFO - PROCESS | 1918 | RSS: Main: 276922368 12:28:49 INFO - PROCESS | 1918 | 12:28:52 INFO - PROCESS | 1918 | Cycle 1(1): loaded http://localhost:49708/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49708/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:28:52 INFO - PROCESS | 1918 | RSS: Main: 264417280 12:28:52 INFO - PROCESS | 1918 | 12:28:54 INFO - PROCESS | 1918 | Cycle 1(1): loaded http://localhost:49708/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49708/tests/kraken/driver.html?testName=ai-astar) 12:28:54 INFO - PROCESS | 1918 | RSS: Main: 308748288 12:28:54 INFO - PROCESS | 1918 | 12:28:54 INFO - PROCESS | 1918 | __start_tp_report 12:28:54 INFO - PROCESS | 1918 | _x_x_mozilla_page_load 12:28:54 INFO - PROCESS | 1918 | _x_x_mozilla_page_load_details 12:28:54 INFO - PROCESS | 1918 | |i|pagename|runs| 12:28:54 INFO - PROCESS | 1918 | |0;ai-astar;113;111;113;111;112;113;110;114;112;112 12:28:54 INFO - PROCESS | 1918 | |1;audio-beat-detection;145;106;109;138;108;102;107;106;131;108 12:28:54 INFO - PROCESS | 1918 | |2;audio-dft;256;236;183;182;180;181;182;184;183;184 12:28:54 INFO - PROCESS | 1918 | |3;audio-fft;80;58;68;87;60;58;57;59;81;72 12:28:54 INFO - PROCESS | 1918 | |4;audio-oscillator;87;70;92;69;68;69;92;67;68;88 12:28:54 INFO - PROCESS | 1918 | |5;imaging-gaussian-blur;87;84;87;84;86;83;87;84;86;83 12:28:54 INFO - PROCESS | 1918 | |6;imaging-darkroom;94;95;95;96;96;95;95;96;136;162 12:28:54 INFO - PROCESS | 1918 | |7;imaging-desaturate;87;87;87;84;85;86;86;83;84;86 12:28:54 INFO - PROCESS | 1918 | |8;json-parse-financial;55;51;52;52;53;55;54;54;55;55 12:28:54 INFO - PROCESS | 1918 | |9;json-stringify-tinderbox;64;72;73;73;70;67;72;100;103;95 12:28:54 INFO - PROCESS | 1918 | |10;stanford-crypto-aes;85;83;82;83;84;80;80;87;82;99 12:28:54 INFO - PROCESS | 1918 | |11;stanford-crypto-ccm;138;134;136;149;143;139;145;150;135;140 12:28:54 INFO - PROCESS | 1918 | |12;stanford-crypto-pbkdf2;160;220;214;159;156;161;158;158;160;159 12:28:54 INFO - PROCESS | 1918 | |13;stanford-crypto-sha256-iterative;64;65;65;65;65;64;66;66;64;65 12:28:54 INFO - PROCESS | 1918 | __end_tp_report 12:28:54 INFO - PROCESS | 1918 | __start_cc_report 12:28:54 INFO - PROCESS | 1918 | _x_x_mozilla_cycle_collect,1828 12:28:54 INFO - PROCESS | 1918 | __end_cc_report 12:28:54 INFO - PROCESS | 1918 | __startTimestamp1479932934898__endTimestamp 12:28:54 INFO - PROCESS | 1918 | 12:28:54 INFO - PROCESS | 1918 | ------- Summary: start ------- 12:28:54 INFO - PROCESS | 1918 | Number of tests: 14 12:28:54 INFO - PROCESS | 1918 | 12:28:54 INFO - PROCESS | 1918 | [#0] ai-astar Cycles:10 Average:112.10 Median:112.50 stddev:1.20 (1.1%) stddev-sans-first:1.22 12:28:54 INFO - PROCESS | 1918 | Values: 113.0 111.0 113.0 111.0 112.0 113.0 110.0 114.0 112.0 112.0 12:28:54 INFO - PROCESS | 1918 | 12:28:54 INFO - PROCESS | 1918 | [#1] audio-beat-detection Cycles:10 Average:116.00 Median:108.50 stddev:15.65 (14.4%) stddev-sans-first:12.60 12:28:54 INFO - PROCESS | 1918 | Values: 145.0 106.0 109.0 138.0 108.0 102.0 107.0 106.0 131.0 108.0 12:28:54 INFO - PROCESS | 1918 | 12:28:54 INFO - PROCESS | 1918 | [#2] audio-dft Cycles:10 Average:195.10 Median:183.50 stddev:27.27 (14.9%) stddev-sans-first:17.92 12:28:54 INFO - PROCESS | 1918 | Values: 256.0 236.0 183.0 182.0 180.0 181.0 182.0 184.0 183.0 184.0 12:28:54 INFO - PROCESS | 1918 | 12:28:54 INFO - PROCESS | 1918 | [#3] audio-fft Cycles:10 Average:68.00 Median:70.00 stddev:11.33 (16.2%) stddev-sans-first:11.16 12:28:54 INFO - PROCESS | 1918 | Values: 80.0 58.0 68.0 87.0 60.0 58.0 57.0 59.0 81.0 72.0 12:28:54 INFO - PROCESS | 1918 | 12:28:54 INFO - PROCESS | 1918 | [#4] audio-oscillator Cycles:10 Average:77.00 Median:78.50 stddev:11.11 (14.1%) stddev-sans-first:11.17 12:28:54 INFO - PROCESS | 1918 | Values: 87.0 70.0 92.0 69.0 68.0 69.0 92.0 67.0 68.0 88.0 12:28:54 INFO - PROCESS | 1918 | 12:28:54 INFO - PROCESS | 1918 | [#5] imaging-gaussian-blur Cycles:10 Average:85.10 Median:86.00 stddev:1.66 (1.9%) stddev-sans-first:1.62 12:28:54 INFO - PROCESS | 1918 | Values: 87.0 84.0 87.0 84.0 86.0 83.0 87.0 84.0 86.0 83.0 12:28:54 INFO - PROCESS | 1918 | 12:28:54 INFO - PROCESS | 1918 | [#6] imaging-darkroom Cycles:10 Average:106.00 Median:95.00 stddev:23.49 (24.7%) stddev-sans-first:24.51 12:28:54 INFO - PROCESS | 1918 | Values: 94.0 95.0 95.0 96.0 96.0 95.0 95.0 96.0 136.0 162.0 12:28:54 INFO - PROCESS | 1918 | 12:28:54 INFO - PROCESS | 1918 | [#7] imaging-desaturate Cycles:10 Average:85.50 Median:86.00 stddev:1.43 (1.7%) stddev-sans-first:1.41 12:28:54 INFO - PROCESS | 1918 | Values: 87.0 87.0 87.0 84.0 85.0 86.0 86.0 83.0 84.0 86.0 12:28:54 INFO - PROCESS | 1918 | 12:28:54 INFO - PROCESS | 1918 | [#8] json-parse-financial Cycles:10 Average:53.60 Median:54.50 stddev:1.51 (2.8%) stddev-sans-first:1.51 12:28:54 INFO - PROCESS | 1918 | Values: 55.0 51.0 52.0 52.0 53.0 55.0 54.0 54.0 55.0 55.0 12:28:54 INFO - PROCESS | 1918 | 12:28:54 INFO - PROCESS | 1918 | [#9] json-stringify-tinderbox Cycles:10 Average:78.90 Median:72.00 stddev:14.50 (20.1%) stddev-sans-first:14.34 12:28:54 INFO - PROCESS | 1918 | Values: 64.0 72.0 73.0 73.0 70.0 67.0 72.0 100.0 103.0 95.0 12:28:54 INFO - PROCESS | 1918 | 12:28:54 INFO - PROCESS | 1918 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:83.50 stddev:5.52 (6.6%) stddev-sans-first:5.85 12:28:54 INFO - PROCESS | 1918 | Values: 85.0 83.0 82.0 83.0 84.0 80.0 80.0 87.0 82.0 99.0 12:28:54 INFO - PROCESS | 1918 | 12:28:54 INFO - PROCESS | 1918 | [#11] stanford-crypto-ccm Cycles:10 Average:140.90 Median:141.50 stddev:5.67 (4.0%) stddev-sans-first:5.91 12:28:54 INFO - PROCESS | 1918 | Values: 138.0 134.0 136.0 149.0 143.0 139.0 145.0 150.0 135.0 140.0 12:28:54 INFO - PROCESS | 1918 | 12:28:54 INFO - PROCESS | 1918 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.50 Median:160.00 stddev:24.59 (15.4%) stddev-sans-first:25.78 12:28:54 INFO - PROCESS | 1918 | Values: 160.0 220.0 214.0 159.0 156.0 161.0 158.0 158.0 160.0 159.0 12:28:54 INFO - PROCESS | 1918 | 12:28:54 INFO - PROCESS | 1918 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:65.00 stddev:0.74 (1.1%) stddev-sans-first:0.71 12:28:54 INFO - PROCESS | 1918 | Values: 64.0 65.0 65.0 65.0 65.0 64.0 66.0 66.0 64.0 65.0 12:28:54 INFO - PROCESS | 1918 | -------- Summary: end -------- 12:28:54 INFO - PROCESS | 1918 | 12:28:55 INFO - TEST-INFO | 1918: exit 0 12:28:55 INFO - TEST-OK | kraken | took 57749ms 12:28:55 INFO - SUITE-END | took 1173s 12:28:56 INFO - Completed test suite (00:19:33) 12:28:56 INFO - javascript benchmark 12:28:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3194.9840250798748, 3412.7781694189875, 3459.2735525539633, 3479.095435186854, 3505.491703702963, 5858.765649374025, 5954.345022047572, 5962.463378295953, 5977.940220597793, 5980.431858973401, 5874.3244526879425, 5942.435468630484, 5943.3462319144855, 5948.286205655328, 5971.492423144038, 5275.525202731744, 5305.973470132644, 5319.5478384337375, 5385.946140538584, 5423.620346575742, 5251.002309561171, 5266.710330931797, 5272.683638981654, 5411.404745478014, 5426.701531415791, 5380.946190538103, 5393.056215162331, 5395.838124856241, 5401.70290634015, 5407.918881216785, 5267.710275934822, 5291.232771248186, 5358.0, 5386.5152136307925, 5391.83824485268, 5171.818986335498, 5262.131748261532, 5289.656172348785, 5338.359396872362, 5357.49103835139, 6022.728977196037, 6058.666773327465, 6085.513158947274, 6114.0, 6124.050772130327, 6212.4408803207925, 6274.435300822948, 6288.3397243289255, 6309.0, 6353.0, 6236.719347629368, 6257.374262573706, 6268.467180289681, 6309.0536419536975, 6317.684115794192, 6121.571489995702, 6124.173236613089, 6132.0, 6135.355787642323, 6139.938600614026, 6228.875422491525, 6303.432691057827, 6306.49548036156, 6308.0537919311555, 6467.126937863422, 6285.811425657238, 6351.174347334817, 6354.872902541923, 6358.872822543523, 6367.204099487564, 6317.14718513004, 6332.271788744261, 6334.208223972004, 6334.619922804646, 6338.809835704937, 6195.070739389128, 6196.690165491707, 6285.77999770015, 6363.681815909186, 6372.84067898297, 6295.213098362705, 6342.746290148342, 6368.84077898047, 6387.712552935129, 6398.9040164397575, 5104.9744751276, 5130.846074617767, 5138.332016837862, 5154.149565321755, 5171.97414012935, 4606.700564463299, 4618.815247390134, 4625.190591646516, 4627.95372046282, 4653.302004699322, 4864.440589332272, 5793.797217097382, 5838.065909454467, 5853.765849365977, 5945.732442040118, 6303.149074874925, 6314.0, 6327.17746692927, 6331.968340158362, 6334.3665633436285, 5983.072623743326, 5999.220101386792, 6002.399760023963, 6010.2186715726675, 6035.245594300713, 5456.890862182734, 5502.9174562381595, 5505.256790333254, 5582.302212223472, 5612.550995920316, 6381.393767592164, 6416.165898433361, 6428.839279018062, 6526.771562995273, 6545.345465453416, 6339.714712837841, 6343.3022367538615, 6350.523710721622, 6359.3640635936035, 6360.809175724736, 6243.7814676486105, 6433.935660643334, 6476.4495017924, 6518.445932095825, 6547.607143571401, 6212.534059945432, 6294.370562943669, 6308.873822523432, 6335.683215839282, 6356.9046464304, 6336.176297081534, 6345.0, 6347.270063942706, 6362.013887847391, 6385.233771947396, 6282.905756413566, 6323.936760632335, 6329.620222786648, 6358.618482891041, 6368.808935731936, 6097.75608975636, 6139.26328840542, 6183.721732522137, 6200.0699895016105, 6227.003679411272, 6235.127082208585, 6236.469900058546, 6239.96880015597, 6240.095186198067, 6257.624542527463, 6298.7480500781285, 6330.430261276507, 6331.05034244867, 6342.524310676626, 6350.142730731477, 6058.515318774399, 6120.3267640558615, 6133.325334213144, 6149.692515374303, 6241.750329986749], "value": 5861.418672009136, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [474.49229324622644, 474.83380816714157, 507.5711024184563, 534.3400899888637, 553.8562867678241, 32170.356592868156, 40664.390034149474, 42426.72719818407, 42492.575074249246, 42510.0, 43936.3409548857, 44172.55827441725, 44188.55811441885, 44192.55807441925, 44345.8913527162, 9171.908280917205, 9807.509624518781, 9974.952629973857, 9977.950110249474, 9980.401175929468, 9219.44683319003, 12099.455524501374, 12381.319027453486, 12404.0, 12497.625071247878, 12351.752964940695, 12448.190867593623, 12467.875321246807, 12475.812862807064, 12477.750444991094, 12425.2544847309, 12496.125271231018, 12502.874971250261, 12508.249505029728, 12508.74982500354, 12240.877591224064, 12315.93842030793, 12333.876661233362, 12335.5065797368, 12352.320622365767, 41418.792906035276, 41662.791686041375, 41746.58253417457, 41789.79105104486, 41807.790961045, 3450.27544215715, 3588.3540962626716, 3653.4337177737493, 3952.486176797027, 4332.631726303268, 31486.527702084488, 31860.0, 32177.51733723996, 32332.676673233203, 32381.51427728586, 3296.5055241713935, 3350.71518920892, 3440.449528075521, 3446.827658617084, 3492.6507349265125, 535193.0, 541128.0, 541244.0, 541942.999999996, 544769.0, 59950.0, 60395.39604603986, 60407.69796150991, 60478.0, 60519.0, 30212.69787302143, 35336.82331588326, 36207.0, 37565.81217093897, 63639.0, 17911.193996270198, 18092.819071809376, 18093.185806638732, 18104.275828966693, 18108.818911810715, 12570.497180112692, 12795.61613151607, 13398.732025359439, 13516.662083447993, 13661.863381366258, 18966.71549926752, 19261.422157335302, 19282.614347712966, 19345.0, 19424.22303107888, 7411.258874112654, 7574.810629734301, 7925.801854953557, 8060.919390806134, 8143.18568143181, 878.7100256915203, 1038.382162613244, 1086.760912599227, 1126.357975953715, 1169.958736724316, 29338.97313594014, 30663.38673226523, 31126.533102003486, 31655.070945861422, 31910.840445798087, 950.9619615215314, 957.6504575829912, 1046.0899017854515, 1086.239632257423, 1091.5088210305394, 13192.934035329954, 15482.0, 16125.677486450206, 16264.918675406783, 16951.0, 729907.0, 739946.0, 740533.0, 742041.0, 742206.0, 58771.41228587745, 59219.703901480214, 59390.0, 59427.70286148628, 59530.70234648799, 1289.5873320537526, 1326.6285440076795, 1327.2103098656285, 1337.7057047449546, 1340.5710172744627, 30695.539566906962, 33141.0, 33258.334833303685, 33343.49984750182, 34152.316953661284, 54334.72832635811, 55161.72419137879, 55201.171982419495, 55246.44753552413, 55425.61435964133, 505289.36776580877, 607585.0, 613123.0, 614532.0, 617099.0, 26857.328566785203, 27152.321191969568, 27481.45037099207, 27514.17457476279, 27549.58675619827, 49352.753236235025, 49415.0, 49485.50514494809, 49542.43772550103, 50013.49986500234, 39783.403248951865, 40238.39642405308, 40253.39619905762, 40312.57343125867, 41773.582264178185, 32186.83906580546, 39863.00342491461, 40421.393679095425, 41321.380179297936, 41551.1689766209, 39217.0, 39459.80270098746, 39480.60519394884, 39794.0, 39981.0, 33884.49173262453, 34960.475592865616, 35790.46314305235, 35825.64174358327, 36025.63974360328, 21250.0, 21639.0, 26509.33726656849, 26598.335041624116, 27193.86403067972], "value": 20991.70204496598, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.1933779394375, 387.81966385630676, 394.56991878852045, 395.36938582960175, 413.50999066106664, 15153.696926061471, 20432.489187770294, 21547.46131346717, 21837.563248735034, 21843.0, 21036.474088147803, 21254.89372553139, 21591.920403979817, 22052.779472205275, 22147.892605369747, 5994.850128746783, 6304.464120549759, 6309.369063093677, 6314.589551679126, 6315.621062736228, 5970.0, 6133.539984501158, 6170.598911070789, 6219.751209951596, 6267.247930248376, 6173.567850250484, 6176.814695559118, 6178.598391104564, 6189.195404597419, 6193.535484838632, 5912.704364781765, 6148.477379422754, 6148.87702245957, 6209.5032397408095, 6218.440340369389, 5378.381486129106, 5380.838574842761, 5385.8114965976, 5389.622726409153, 5397.0, 13867.306634668326, 14014.509492167826, 22686.77313226863, 23305.83470826452, 24964.5007099857, 2256.537409830997, 2330.3242059802637, 2381.9498473876333, 2406.230006397936, 2448.338948483917, 9966.003399660049, 10229.232807539463, 12269.631911042683, 12749.362531873368, 15585.766213506806, 1695.703251930907, 1893.5455490682275, 1915.6456055629753, 1984.6081512459593, 2012.5069358007381, 115067.42466287615, 121026.47771305808, 126078.0, 127746.0, 133802.99999999904, 11264.43677816106, 11299.604513842141, 11699.532018719327, 11723.179377443668, 11921.463534140985, 13372.398242079129, 13873.028887977947, 15022.774658380133, 15030.774538381933, 15053.0, 8606.44058136219, 8740.0, 8834.911650883409, 8903.643854245887, 8989.763685073369, 8871.689490867788, 8882.777930551789, 8900.243479304203, 9055.366124371363, 9063.818723625622, 3979.005248687828, 4330.631896288788, 4565.908681826411, 4578.45058592971, 4625.098105869323, 1905.6188762247607, 1948.6687263165295, 1958.8726732762325, 1961.2841312920966, 1963.8821670699804, 786.838698066895, 900.2078171209293, 918.1231923513162, 951.6130637759921, 977.8044391121804, 18396.98816565075, 18980.52548686266, 20357.287494937606, 20387.796122038886, 22307.330780076623, 854.2738672128766, 934.9061597930438, 967.9854802177973, 969.767255858603, 1005.6228914157191, 10507.579696812041, 11511.30932144074, 11524.539018439169, 11527.48126334317, 11557.364344960939, 614083.0, 622547.0, 626658.0, 643744.0, 644715.0, 138955.0, 140218.0, 149234.50765492424, 150431.0, 152647.0, 900.7883147460342, 1009.1119814563284, 1017.6133069433567, 1039.5374058543875, 1060.4644654449453, 12589.622311330675, 18264.178111985257, 18364.816351836846, 19628.509287267934, 19983.000849957734, 52909.0, 54775.90448191093, 55109.0, 57853.84292314215, 58538.14618538112, 69647.65176174087, 72554.27445725475, 78989.60505197437, 85698.0, 86197.56901215453, 7155.642217889189, 7996.520208787491, 8086.757397278091, 8373.58132093405, 8569.357298202784, 9173.54132293396, 12852.0, 13318.733625327633, 13680.863191367958, 14173.362198700877, 5658.179563963285, 6913.965430172817, 11045.502952367002, 12041.33772642513, 12182.512699491921, 6386.648734319657, 6987.755428560179, 10487.37075775456, 10962.232643714864, 11869.991050760782, 11680.94159529231, 11832.230904991147, 11952.983996360406, 12059.57791477294, 12192.390380480763, 8172.713955011546, 8324.6670133194, 8499.702510412106, 8643.611037503202, 8766.736997890073, 11553.0, 11682.065434765029, 11866.466009029442, 11945.402729863647, 11950.701232469259], "value": 9687.608839431841, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1396.8393634732008, 1549.752039673652, 1562.7577725452554, 1718.5359952812742, 1765.999999999999, 8216.548089855056, 8752.606132724026, 9023.097690230974, 9329.766755831108, 9334.486603236819, 9194.862077068849, 9288.582013809379, 9288.721338359843, 9309.162175404212, 9335.673251436201, 2401.8198635102394, 2439.499902519988, 2442.242904699549, 2444.083468699238, 2447.2046584859904, 2398.8680622565753, 2409.590369637157, 2440.5728997425467, 2441.9023239070416, 2442.2917353967327, 2396.724376696685, 2413.239829453725, 2420.104561312317, 2426.514697060595, 2428.465737537748, 2371.0160283482332, 2392.5334559760854, 2403.714013003044, 2405.867677277749, 2410.3974006498374, 2358.870262135582, 2378.619420892649, 2388.9641655375185, 2392.079049565912, 2392.270357540949, 9268.21220196284, 9327.906720932771, 9363.34456588039, 9381.906180938171, 9392.201662858664, 5340.679559226459, 5536.972315138439, 5541.226807421626, 5605.411431799684, 5608.214849921014, 3680.650338217865, 3692.4276737105793, 3747.6814470769746, 3751.718621103428, 3816.503854498925, 1100.9669709908715, 1113.7438389170454, 1117.6479408986143, 1130.3387518301804, 1139.9487023083982, 12414.0, 12444.191127576678, 12551.246925184427, 12552.121351505399, 12572.559960401433, 4494.955050449519, 4521.231390663595, 4719.2921061841, 4733.219018861849, 4733.36099626546, 9677.467739274407, 9678.370905891095, 9679.516024198761, 9684.370515916444, 9687.467189304514, 5381.408045115034, 5386.811461598825, 5387.919181212285, 5388.973055134699, 5391.892162156813, 4573.702709323949, 4729.929051064237, 4858.927116093261, 4960.975195124001, 5037.546620804145, 3850.5956874528333, 3862.304785138646, 3946.7631942083567, 3954.2882281189663, 3979.900502487403, 1033.1970711109163, 1041.874775242736, 1140.43548443521, 1156.7859945910034, 1163.4473625028045, 895.2927187521915, 921.9861702074475, 927.38792397019, 938.3619138985555, 953.065995324572, 5924.229850119457, 5948.970255148696, 6196.442320191114, 6238.438540531374, 6301.527385446018, 431.4499013757484, 437.2937705605488, 445.8852867830424, 451.6071018214175, 452.30119465426, 3899.3760998240145, 3951.723379363417, 3953.940690889639, 4083.7549747015273, 4100.466939297932, 10995.0, 11515.596954106566, 11516.481758320895, 11519.88480115205, 11535.653930382103, 11001.504932278067, 11431.428428578538, 11447.313161210188, 11460.828087578693, 11467.31196128235, 8558.630619101039, 8754.387192896564, 8770.0, 8773.341999349946, 8789.373965816345, 5765.740541675718, 5826.155207494974, 5975.0, 6024.006039003515, 6035.969820150871, 10220.744481388025, 10583.206259530412, 10678.786424271315, 10699.94650026745, 10738.0, 10836.241463097507, 10897.945510272715, 10909.781804364027, 10915.508802103766, 10925.617603383844, 6214.689265536796, 6260.311365749672, 6782.525223234326, 7110.182329032021, 7208.9907412963275, 8576.0, 8705.390622656607, 8873.157050080232, 8985.730428087169, 9008.954955225181, 7860.764177074697, 8019.9198008019175, 8040.316573091119, 8147.307478864126, 8192.18078192176, 7804.570748608881, 7876.369890408868, 7891.210878912292, 7941.364690824605, 7952.602369881367, 6895.448364130958, 6917.13535808024, 6977.860442791217, 6979.511434199558, 6980.581165130108, 4980.975095124501, 5009.974950125226, 5173.586113110867, 5185.27406163145, 5287.57699384056, 5041.899162016666, 5080.49195080489, 5178.326817513699, 5200.401953775364, 5328.573714102785], "value": 4613.768833798301, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [255.7417008821091, 306.6856472116082, 312.4266970109848, 315.9668234835342, 321.0432909928412, 5207.18811841606, 5405.540529055035, 5477.178423236512, 5509.917351239729, 5518.227448157256, 4730.763461826912, 4796.928046079312, 5026.3214466047075, 5252.947470525293, 5470.729647196409, 3627.891163265106, 3960.386140148282, 3992.860249891254, 4071.7964101794864, 4232.0, 4141.943804329907, 4167.083241686824, 4172.436721042666, 4206.326987681971, 4219.818450833756, 3526.0, 3822.789746563938, 4039.53545342285, 4138.52406973199, 4148.419221309019, 4036.1927614476926, 4040.3939459048747, 4058.7620775663413, 4059.6143366380147, 4072.511298644167, 3484.9893530876016, 3495.405781017233, 3506.333796578642, 3513.2095278562374, 3516.226430185355, 4935.432425271104, 5249.160134378481, 5251.186066159751, 5325.680459172462, 5355.812546560891, 4655.837045703418, 4673.766311684402, 4683.976580117112, 4711.316859055418, 4720.12677654635, 5740.82777516671, 5742.425757424266, 5764.625299355528, 5796.246487956539, 5819.79630712923, 3556.8399422026073, 3667.449882517644, 3710.8515659373593, 3905.37513997759, 3941.5664276929515, 5152.407473140599, 5749.131532252035, 5999.730012149464, 6017.826523827812, 6054.697265136726, 3433.6738009889023, 3806.71449641278, 3954.974444549922, 3955.169414423003, 3971.860984865516, 4024.2957482440456, 4035.556088830226, 4039.0, 4047.7571345719352, 4058.0869304406274, 3936.7244292899795, 4556.703814252063, 4619.3994780678295, 4691.859244222679, 4726.881827954328, 5092.337996060563, 5410.675359478444, 5442.673439593637, 5756.971215143982, 5758.596898217084, 1146.060230610891, 1228.846394200725, 1285.1389568988614, 1356.830396200475, 1357.7759669654397, 864.7103220421229, 891.4116682989196, 907.6278725722422, 909.5952301225891, 922.2022950148207, 4665.743384113838, 5418.458154184629, 5428.9185662215095, 5459.317585301837, 5488.231647569343, 4931.175465077944, 5305.018571564273, 5808.128780682847, 5828.213191219131, 5882.088276317178, 4645.372874661945, 4857.445617402397, 5305.65513241638, 5353.598480114007, 5365.846343036188, 2548.0, 3008.307564729555, 3025.2285667154733, 3063.2495038715656, 3107.735842453372, 5335.45271871153, 5514.80698175562, 6024.578279520391, 6073.848153796102, 6089.51283897296, 5284.471552844685, 5490.835274941678, 5568.16477528374, 5734.225879506297, 5979.594795223119, 5060.5698515625845, 5478.45215478449, 5620.662760234399, 6094.329623741385, 6112.052631842072, 5436.646617969819, 5750.872177294428, 5769.336526299361, 5804.245448091721, 5833.82498525045, 4289.721168124062, 4918.4343800461975, 5265.420803711512, 5285.969235998943, 5336.67979921206, 5416.593755468434, 5633.577561648367, 6058.84852878664, 6075.635461872302, 6180.783672571439, 3305.6529064447886, 3863.190328041494, 3916.3146449370674, 3918.4122381642983, 3932.4691166692132, 4742.620590352694, 5524.723763811713, 5799.681017543907, 5830.5044071254415, 5831.4168583141345, 5408.323959505062, 5415.864603384947, 5761.020626493422, 5768.971155144198, 5975.193348897843, 4773.976130119466, 4854.271859221004, 5862.472377486047, 5862.530997520103, 5935.397442690536, 4897.338859253955, 5401.378841433128, 5635.746391412315, 5741.655500669973, 5760.711964401847, 4601.700889442175, 5282.735863206747, 5515.648666076837, 5722.397728635989, 5786.681732504752, 5225.712585807817, 5700.261420266858, 5722.2561067061015, 5780.190773291826, 5785.42548565901], "value": 4134.8066237235935, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [760.1334478694288, 784.4430454377392, 789.5341748368463, 822.4695071678767, 841.4446465332882, 15949.202539873004, 16316.918415407936, 16919.83080169198, 17023.0, 17396.47810565685, 15484.458043968463, 15511.767323490156, 15663.843361566409, 15681.215939203052, 15687.0, 731.8060713910818, 884.1732979664002, 893.0310612984919, 894.3694695239873, 894.5840184314293, 746.3655892491366, 872.1452976083442, 898.371140201858, 910.5720311453606, 912.5254867468913, 953.2516974175273, 955.3742298794301, 956.6125719083782, 957.4877440569297, 958.0323872888363, 951.5527701980093, 952.0669743651226, 954.3367359685021, 954.89973552777, 955.479263801223, 701.0325750464326, 702.1083224305104, 702.7364738223166, 705.7106586299644, 706.2725392845377, 15408.306626201736, 15498.380064797395, 15558.455454059167, 15624.531264061983, 15644.296006679726, 13723.931380343134, 14903.0, 15049.699006019819, 15179.62050948724, 15338.923305383401, 13087.934560327138, 13470.25913574753, 13734.45062197511, 13853.391412570007, 14003.579892603238, 4465.620422264112, 4519.186546421643, 4555.612772914306, 4839.177339852234, 4931.630127740434, 80167.0, 98804.99999999929, 114042.28936565958, 116485.0, 118735.0, 10996.780064398827, 11014.173936954761, 11190.720231994264, 11417.143714221467, 11563.42182890852, 21538.461538461663, 21554.784452155276, 21624.02691878869, 21675.458113547287, 21710.674339884914, 7605.733799316998, 7661.502002369828, 7716.0, 7779.688812447439, 7934.880976785353, 4234.474338549469, 4387.736735795863, 4414.668899832525, 4537.8184872604725, 4585.95414045862, 3568.91077723059, 3695.7228207883977, 3701.8704345347783, 3706.8517259309865, 3711.536057992751, 632.6899819088705, 637.3912913167914, 648.5849056603778, 649.4771708774482, 684.1584850633749, 462.14733816109225, 539.4767075936336, 618.604093380237, 658.7727234104226, 674.3593586093231, 7360.300771426706, 9015.233705135137, 9132.589033493508, 9405.829316416439, 9455.479948602755, 539.9730013499309, 560.5011539729644, 583.4020129367348, 653.911721917535, 672.825065482978, 4348.391225228407, 4496.392986946786, 4555.339475775994, 4578.702384345007, 4683.1336202802595, 132267.0, 138080.0, 138537.30731346278, 148117.0, 152130.23934880254, 107450.0, 112366.0, 114134.0, 114184.0, 134576.32711836378, 80107.0, 100780.0, 104169.0, 108559.0, 111817.88182118237, 10047.949760251153, 10050.09549140581, 10082.596696132367, 10140.746481338025, 10173.186145108522, 60775.69612151911, 61208.0, 61625.0, 62597.06104408528, 62704.68647656732, 97231.0, 97787.1327720339, 98239.0, 100434.0, 101084.98915010756, 13180.0, 13622.114562553403, 13658.385372658055, 13734.45062197501, 13987.300634968007, 15033.699326013637, 15088.39646414175, 15223.238838058274, 16143.950643208154, 16423.507294781175, 14204.78692819588, 14569.490067847575, 14694.779578306549, 15433.382664693287, 15433.382664693287, 14293.857061429253, 14477.565673029825, 14591.489297874523, 15129.621759456102, 15242.542723718307, 11653.6503904883, 13412.463501460223, 13552.322383880964, 13672.93163534176, 13724.65688357799, 11395.430228488376, 11505.712357191138, 12085.456154473246, 12233.797500334125, 12383.876161238633, 9975.551100200364, 11407.885921140682, 11868.643940681794, 12002.159848810848, 12032.879671203176], "value": 8038.644495728961, "unit": "score"}], "name": "dromaeo_css", "value": 7533.578047708951, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 111.0, 113.0, 111.0, 112.0, 113.0, 110.0, 114.0, 112.0, 112.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 106.0, 109.0, 138.0, 108.0, 102.0, 107.0, 106.0, 131.0, 108.0], "value": 116.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [256.0, 236.0, 183.0, 182.0, 180.0, 181.0, 182.0, 184.0, 183.0, 184.0], "value": 195.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 58.0, 68.0, 87.0, 60.0, 58.0, 57.0, 59.0, 81.0, 72.0], "value": 68.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 70.0, 92.0, 69.0, 68.0, 69.0, 92.0, 67.0, 68.0, 88.0], "value": 77.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 87.0, 84.0, 86.0, 83.0, 87.0, 84.0, 86.0, 83.0], "value": 85.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 136.0, 162.0], "value": 106.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 87.0, 84.0, 85.0, 86.0, 86.0, 83.0, 84.0, 86.0], "value": 85.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 51.0, 52.0, 52.0, 53.0, 55.0, 54.0, 54.0, 55.0, 55.0], "value": 53.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 72.0, 73.0, 73.0, 70.0, 67.0, 72.0, 100.0, 103.0, 95.0], "value": 78.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 82.0, 83.0, 84.0, 80.0, 80.0, 87.0, 82.0, 99.0], "value": 84.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 134.0, 136.0, 149.0, 143.0, 139.0, 145.0, 150.0, 135.0, 140.0], "value": 140.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 220.0, 214.0, 159.0, 156.0, 161.0, 158.0, 158.0, 160.0, 159.0], "value": 170.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 65.0, 65.0, 64.0, 66.0, 66.0, 64.0, 65.0], "value": 64.9, "unit": "score"}], "name": "kraken", "value": 1438.1000000000004, "alertThreshold": 2.0}]} 12:28:56 INFO - Return code: 0 12:28:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:28:56 INFO - # TBPL SUCCESS # 12:28:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:28:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:28:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:28:56 INFO - 2016-11-23 12:28:56.210 screenresolution[1922:12384] starting screenresolution argv=screenresolution get 12:28:56 INFO - 2016-11-23 12:28:56.213 screenresolution[1922:12384] Display 0: 1600x1200x32@60 12:28:56 INFO - 2016-11-23 12:28:56.219 screenresolution[1923:12387] starting screenresolution argv=screenresolution list 12:28:56 INFO - Available Modes on Display 0 12:28:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:28:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:28:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:28:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:28:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:28:56 INFO - Intel Iris: 12:28:56 INFO - Chipset Model: Intel Iris 12:28:56 INFO - Type: GPU 12:28:56 INFO - Bus: Built-In 12:28:56 INFO - VRAM (Dynamic, Max): 1536 MB 12:28:56 INFO - Vendor: Intel (0x8086) 12:28:56 INFO - Device ID: 0x0a2e 12:28:56 INFO - Revision ID: 0x0009 12:28:56 INFO - Displays: 12:28:56 INFO - Display: 12:28:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:28:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:28:56 INFO - Display Serial Number: 1600x1200 60 12:28:56 INFO - Main Display: Yes 12:28:56 INFO - Mirror: Off 12:28:56 INFO - Online: Yes 12:28:56 INFO - Rotation: Supported 12:28:56 INFO - Return code: 0 12:28:56 INFO - Running post-action listener: _resource_record_post_action 12:28:56 INFO - [mozharness: 2016-11-23 20:28:56.451396Z] Finished run-tests step (success) 12:28:56 INFO - Running post-run listener: _resource_record_post_run 12:28:56 INFO - Total resource usage - Wall time: 1196s; CPU: 53.0%; Read bytes: 1089536; Write bytes: 491699200; Read time: 10; Write time: 1722 12:28:56 INFO - TinderboxPrint: CPU usage
53.1% 12:28:56 INFO - TinderboxPrint: I/O read bytes / time
1,089,536 / 10 12:28:56 INFO - TinderboxPrint: I/O write bytes / time
491,699,200 / 1,722 12:28:56 INFO - TinderboxPrint: CPU idle
2,245.3 (46.9%) 12:28:56 INFO - TinderboxPrint: CPU system
951.9 (19.9%) 12:28:56 INFO - TinderboxPrint: CPU user
1,588.4 (33.2%) 12:28:56 INFO - TinderboxPrint: Swap in / out
196,247,552 / 0 12:28:56 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 185381376; Write bytes: 177926144; Read time: 16780; Write time: 480 12:28:56 INFO - run-tests - Wall time: 1175s; CPU: 53.0%; Read bytes: 1089536; Write bytes: 295812096; Read time: 10; Write time: 1185 12:28:56 INFO - Running post-run listener: _upload_blobber_files 12:28:56 INFO - Blob upload gear active. 12:28:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:28:56 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 12:28:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:28:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:28:57 INFO - (blobuploader) - INFO - Open directory for files ... 12:28:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:28:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:28:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:28:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:28:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:28:58 INFO - (blobuploader) - INFO - Done attempting. 12:28:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:28:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:28:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:28:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:28:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:28:59 INFO - (blobuploader) - INFO - Done attempting. 12:28:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:28:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:28:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:29:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:29:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:29:01 INFO - (blobuploader) - INFO - Done attempting. 12:29:01 INFO - (blobuploader) - INFO - Iteration through files over. 12:29:01 INFO - Return code: 0 12:29:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:29:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:29:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/40fcbdc7327cf415d2f4d6bcacfab302b375f63fa28a1f2181d6099e361a9f091954112e46a4ef183d6376e938a354e48bf92823bf4d2acae70d985666e30888", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ae4dbbf37847aa2b0039582f4da1cff806eda5058eb53f8475bd81f6c2cfc41c5e3cd6511ee81a19af3aef3ade4904311e56231e1e279daa0265f6902ac003cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eaf04df02803ff598252ff660d2410b2fbf7b8811f37bf7e7345b789533ac9235f2d14dc48181dd275757a1d274f1bf51aead38ca00f8694d62be28b4665a190"} 12:29:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:29:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:29:01 INFO - Contents: 12:29:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/40fcbdc7327cf415d2f4d6bcacfab302b375f63fa28a1f2181d6099e361a9f091954112e46a4ef183d6376e938a354e48bf92823bf4d2acae70d985666e30888", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ae4dbbf37847aa2b0039582f4da1cff806eda5058eb53f8475bd81f6c2cfc41c5e3cd6511ee81a19af3aef3ade4904311e56231e1e279daa0265f6902ac003cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eaf04df02803ff598252ff660d2410b2fbf7b8811f37bf7e7345b789533ac9235f2d14dc48181dd275757a1d274f1bf51aead38ca00f8694d62be28b4665a190"} 12:29:01 INFO - Running post-run listener: copy_logs_to_upload_dir 12:29:01 INFO - Copying logs to upload dir... 12:29:01 INFO - mkdir: /builds/slave/test/build/upload/logs 12:29:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.374129 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-11-23 12:29:01.780149) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-23 12:29:01.783783) ========= 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.9dVwkGuzoY/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.unJpTrr72s/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/40fcbdc7327cf415d2f4d6bcacfab302b375f63fa28a1f2181d6099e361a9f091954112e46a4ef183d6376e938a354e48bf92823bf4d2acae70d985666e30888", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ae4dbbf37847aa2b0039582f4da1cff806eda5058eb53f8475bd81f6c2cfc41c5e3cd6511ee81a19af3aef3ade4904311e56231e1e279daa0265f6902ac003cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eaf04df02803ff598252ff660d2410b2fbf7b8811f37bf7e7345b789533ac9235f2d14dc48181dd275757a1d274f1bf51aead38ca00f8694d62be28b4665a190"} build_url:https://queue.taskcluster.net/v1/task/DediSqmMSV2gPJGor5yAHQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010888 build_url: 'https://queue.taskcluster.net/v1/task/DediSqmMSV2gPJGor5yAHQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/40fcbdc7327cf415d2f4d6bcacfab302b375f63fa28a1f2181d6099e361a9f091954112e46a4ef183d6376e938a354e48bf92823bf4d2acae70d985666e30888", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ae4dbbf37847aa2b0039582f4da1cff806eda5058eb53f8475bd81f6c2cfc41c5e3cd6511ee81a19af3aef3ade4904311e56231e1e279daa0265f6902ac003cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eaf04df02803ff598252ff660d2410b2fbf7b8811f37bf7e7345b789533ac9235f2d14dc48181dd275757a1d274f1bf51aead38ca00f8694d62be28b4665a190"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-23 12:29:01.818480) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 12:29:01.819003) ========= 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.9dVwkGuzoY/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.unJpTrr72s/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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.005147 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 12:29:01.869051) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-23 12:29:01.869476) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-23 12:29:01.869851) ========= ========= Total master_lag: 0.88 =========