builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0317 starttime: 1484607108.37 results: success (0) buildid: 20170116132722 builduid: 2a272f50d7bc41cda96cdb9c2fc11c57 revision: 4d23adbd1004fa55093929e4934dc77d0de2fd01 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-16 14:51:48.372456) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-16 14:51:48.372867) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-16 14:51:48.373338) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-16 14:51:48.399823) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 14:51:48.400224) ========= 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.4TrqDQPz60/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.8gyJQL4ltv/Listeners TMPDIR=/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-16 14:51:48-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.9M=0.001s 2017-01-16 14:51:48 (18.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.126244 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 14:51:48.550346) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 14:51:48.550659) ========= 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.4TrqDQPz60/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.8gyJQL4ltv/Listeners TMPDIR=/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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.025917 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 14:51:48.598520) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-16 14:51:48.598844) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 4d23adbd1004fa55093929e4934dc77d0de2fd01 --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 4d23adbd1004fa55093929e4934dc77d0de2fd01 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4TrqDQPz60/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.8gyJQL4ltv/Listeners TMPDIR=/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-16 14:51:48,697 truncating revision to first 12 chars 2017-01-16 14:51:48,697 Setting DEBUG logging. 2017-01-16 14:51:48,697 attempt 1/10 2017-01-16 14:51:48,697 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/4d23adbd1004?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-16 14:51:50,815 unpacking tar archive at: mozilla-beta-4d23adbd1004/testing/mozharness/ program finished with exit code 0 elapsedTime=2.403619 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-16 14:51:51.026604) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-16 14:51:51.026942) ========= script_repo_revision: 4d23adbd1004fa55093929e4934dc77d0de2fd01 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-16 14:51:51.027368) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-16 14:51:51.027637) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-16 14:51:51.047924) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-01-16 14:51:51.048540) ========= /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.4TrqDQPz60/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.8gyJQL4ltv/Listeners TMPDIR=/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 14:51:51 INFO - MultiFileLogger online at 20170116 14:51:51 in /builds/slave/test 14:51:51 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 14:51:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:51:51 INFO - {'append_to_log': False, 14:51:51 INFO - 'base_work_dir': '/builds/slave/test', 14:51:51 INFO - 'blob_upload_branch': 'Mozilla-Beta', 14:51:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:51:51 INFO - 'branch': 'Mozilla-Beta', 14:51:51 INFO - 'buildbot_json_path': 'buildprops.json', 14:51:51 INFO - 'config_files': ('talos/mac_config.py',), 14:51:51 INFO - 'default_actions': ('clobber', 14:51:51 INFO - 'read-buildbot-config', 14:51:51 INFO - 'download-and-extract', 14:51:51 INFO - 'populate-webroot', 14:51:51 INFO - 'create-virtualenv', 14:51:51 INFO - 'install', 14:51:51 INFO - 'run-tests'), 14:51:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:51:51 INFO - 'download_minidump_stackwalk': True, 14:51:51 INFO - 'download_symbols': 'ondemand', 14:51:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:51:51 INFO - 'tooltool.py': '/tools/tooltool.py', 14:51:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:51:51 INFO - '/tools/misc-python/virtualenv.py')}, 14:51:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:51:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:51:51 INFO - 'installer_path': 'installer.exe', 14:51:51 INFO - 'log_level': 'info', 14:51:51 INFO - 'log_name': 'talos', 14:51:51 INFO - 'log_to_console': True, 14:51:51 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:51:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:51:51 INFO - 'opt_config_files': (), 14:51:51 INFO - 'pip_index': False, 14:51:51 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:51:51 INFO - 'cmd': ('bash', 14:51:51 INFO - '-c', 14:51:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:51:51 INFO - 'enabled': True, 14:51:51 INFO - 'halt_on_failure': False, 14:51:51 INFO - 'name': 'check_screen_resolution'},), 14:51:51 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:51:51 INFO - 'cmd': ('bash', 14:51:51 INFO - '-c', 14:51:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:51:51 INFO - 'enabled': True, 14:51:51 INFO - 'halt_on_failure': False, 14:51:51 INFO - 'name': 'check_screen_resolution'},), 14:51:51 INFO - 'run_cmd_checks_enabled': True, 14:51:51 INFO - 'sps_profile': False, 14:51:51 INFO - 'sps_profile_interval': 0, 14:51:51 INFO - 'suite': 'dromaeojs', 14:51:51 INFO - 'system_bits': '32', 14:51:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:51:51 INFO - 'title': 't-yosemite-r7-0317', 14:51:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:51:51 INFO - 'use_talos_json': True, 14:51:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:51:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:51:51 INFO - 'work_dir': 'build'} 14:51:51 INFO - [mozharness: 2017-01-16 22:51:51.246169Z] Running clobber step. 14:51:51 INFO - Running pre-action listener: _resource_record_pre_action 14:51:51 INFO - Running main action method: clobber 14:51:51 INFO - rmtree: /builds/slave/test/build 14:51:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:51:53 INFO - Running post-action listener: _resource_record_post_action 14:51:53 INFO - [mozharness: 2017-01-16 22:51:53.573833Z] Finished clobber step (success) 14:51:53 INFO - [mozharness: 2017-01-16 22:51:53.573943Z] Running read-buildbot-config step. 14:51:53 INFO - Running pre-action listener: _resource_record_pre_action 14:51:53 INFO - Running main action method: read_buildbot_config 14:51:53 INFO - Using buildbot properties: 14:51:53 INFO - { 14:51:53 INFO - "project": "", 14:51:53 INFO - "product": "firefox", 14:51:53 INFO - "script_repo_revision": "production", 14:51:53 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 14:51:53 INFO - "repository": "", 14:51:53 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 14:51:53 INFO - "buildid": "20170116132722", 14:51:53 INFO - "pgo_build": "False", 14:51:53 INFO - "basedir": "/builds/slave/test", 14:51:53 INFO - "buildnumber": 5, 14:51:53 INFO - "slavename": "t-yosemite-r7-0317", 14:51:53 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 14:51:53 INFO - "platform": "yosemite_r7", 14:51:53 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 14:51:53 INFO - "branch": "mozilla-beta", 14:51:53 INFO - "repo_path": "releases/mozilla-beta", 14:51:53 INFO - "revision": "4d23adbd1004fa55093929e4934dc77d0de2fd01", 14:51:53 INFO - "stage_platform": "macosx64", 14:51:53 INFO - "builduid": "2a272f50d7bc41cda96cdb9c2fc11c57", 14:51:53 INFO - "slavebuilddir": "test" 14:51:53 INFO - } 14:51:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/VOUMscFtQW-27brDEh90Mg/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 14:51:53 INFO - Running post-action listener: _resource_record_post_action 14:51:53 INFO - [mozharness: 2017-01-16 22:51:53.577331Z] Finished read-buildbot-config step (success) 14:51:53 INFO - [mozharness: 2017-01-16 22:51:53.577470Z] Running download-and-extract step. 14:51:53 INFO - Running pre-action listener: _resource_record_pre_action 14:51:53 INFO - Running main action method: download_and_extract 14:51:53 INFO - mkdir: /builds/slave/test/build/tests 14:51: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')]} 14:51:53 INFO - trying https://queue.taskcluster.net/v1/task/VOUMscFtQW-27brDEh90Mg/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 14:51:53 INFO - Downloading https://queue.taskcluster.net/v1/task/VOUMscFtQW-27brDEh90Mg/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 14:51:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VOUMscFtQW-27brDEh90Mg/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 14:51:54 INFO - Downloaded 1165 bytes. 14:51:54 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 14:51:54 INFO - Using the following test package requirements: 14:51:54 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 14:51:54 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 14:51:54 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 14:51:54 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 14:51:54 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 14:51:54 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 14:51:54 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 14:51:54 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 14:51:54 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 14:51:54 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 14:51:54 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 14:51:54 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 14:51:54 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 14:51:54 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 14:51:54 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 14:51:54 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 14:51:54 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 14:51:54 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 14:51:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VOUMscFtQW-27brDEh90Mg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 14:51:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VOUMscFtQW-27brDEh90Mg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 14:51:54 INFO - Fetch https://queue.taskcluster.net/v1/task/VOUMscFtQW-27brDEh90Mg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 14:51:55 INFO - Expected file size: 16236115 14:52:02 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 14:52:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VOUMscFtQW-27brDEh90Mg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 14:52:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VOUMscFtQW-27brDEh90Mg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 14:52:02 INFO - Fetch https://queue.taskcluster.net/v1/task/VOUMscFtQW-27brDEh90Mg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 14:52:02 INFO - Expected file size: 16236115 14:52:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VOUMscFtQW-27brDEh90Mg/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 14:52:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VOUMscFtQW-27brDEh90Mg/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 14:52:09 INFO - Fetch https://queue.taskcluster.net/v1/task/VOUMscFtQW-27brDEh90Mg/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 14:52:10 INFO - Expected file size: 14414089 14:52:10 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')]} 14:52:10 INFO - trying https://queue.taskcluster.net/v1/task/VOUMscFtQW-27brDEh90Mg/artifacts/public/build/firefox-51.0.en-US.mac.dmg 14:52:10 INFO - Downloading https://queue.taskcluster.net/v1/task/VOUMscFtQW-27brDEh90Mg/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 14:52:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VOUMscFtQW-27brDEh90Mg/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 14:52:13 INFO - Downloaded 86168872 bytes. 14:52:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VOUMscFtQW-27brDEh90Mg/artifacts/public/build/firefox-51.0.en-US.mac.dmg 14:52:13 INFO - mkdir: /builds/slave/test/properties 14:52:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:52:13 INFO - Writing to file /builds/slave/test/properties/build_url 14:52:13 INFO - Contents: 14:52:13 INFO - build_url:https://queue.taskcluster.net/v1/task/VOUMscFtQW-27brDEh90Mg/artifacts/public/build/firefox-51.0.en-US.mac.dmg 14:52:14 INFO - Running post-action listener: _resource_record_post_action 14:52:14 INFO - Running post-action listener: set_extra_try_arguments 14:52:14 INFO - [mozharness: 2017-01-16 22:52:14.213158Z] Finished download-and-extract step (success) 14:52:14 INFO - [mozharness: 2017-01-16 22:52:14.213315Z] Running populate-webroot step. 14:52:14 INFO - Running pre-action listener: _resource_record_pre_action 14:52:14 INFO - Running main action method: populate_webroot 14:52:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:52:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:52:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:52:14 INFO - '--tppagecycles', 14:52:14 INFO - '7'], 14:52:14 INFO - 'tests': ['tsvgm']}}, 14:52:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:52:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:52:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:52:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:52:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:52:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:52:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:52:14 INFO - 'talos_options': ['--disable-e10s'], 14:52:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:52:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:52:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:52:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:52:14 INFO - 'talos_options': ['--disable-e10s'], 14:52:14 INFO - 'tests': ['damp', 'tps']}, 14:52:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:52:14 INFO - 'tests': ['damp', 'tps']}, 14:52:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:52:14 INFO - 'tests': ['dromaeo_dom']}, 14:52:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:52:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:52:14 INFO - 'tests': ['basic_compositor_video']}, 14:52:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:52:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:52:14 INFO - 'tests': ['a11yr', 14:52:14 INFO - 'ts_paint', 14:52:14 INFO - 'tpaint', 14:52:14 INFO - 'sessionrestore', 14:52:14 INFO - 'sessionrestore_no_auto_restore', 14:52:14 INFO - 'tabpaint']}, 14:52:14 INFO - 'other-e10s': {'tests': ['a11yr', 14:52:14 INFO - 'ts_paint', 14:52:14 INFO - 'tpaint', 14:52:14 INFO - 'sessionrestore', 14:52:14 INFO - 'sessionrestore_no_auto_restore', 14:52:14 INFO - 'tabpaint']}, 14:52:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:52:14 INFO - 'ts_paint', 14:52:14 INFO - 'tpaint', 14:52:14 INFO - 'sessionrestore', 14:52:14 INFO - 'sessionrestore_no_auto_restore', 14:52:14 INFO - 'tabpaint']}, 14:52:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:52:14 INFO - 'ts_paint', 14:52:14 INFO - 'tpaint', 14:52:14 INFO - 'sessionrestore', 14:52:14 INFO - 'sessionrestore_no_auto_restore', 14:52:14 INFO - 'tabpaint']}, 14:52:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:52:14 INFO - 'tests': ['a11yr', 14:52:14 INFO - 'ts_paint', 14:52:14 INFO - 'tpaint', 14:52:14 INFO - 'sessionrestore', 14:52:14 INFO - 'sessionrestore_no_auto_restore', 14:52:14 INFO - 'tabpaint']}, 14:52:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:52:14 INFO - 'tests': ['a11yr', 14:52:14 INFO - 'ts_paint', 14:52:14 INFO - 'tpaint', 14:52:14 INFO - 'sessionrestore', 14:52:14 INFO - 'sessionrestore_no_auto_restore', 14:52:14 INFO - 'tabpaint']}, 14:52:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:52:14 INFO - 'tests': ['tsvgx', 14:52:14 INFO - 'tsvgr_opacity', 14:52:14 INFO - 'tart', 14:52:14 INFO - 'tscrollx', 14:52:14 INFO - 'cart']}, 14:52:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:52:14 INFO - 'tsvgr_opacity', 14:52:14 INFO - 'tart', 14:52:14 INFO - 'tscrollx', 14:52:14 INFO - 'cart']}, 14:52:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:52:14 INFO - 'talos_options': ['--disable-e10s'], 14:52:14 INFO - 'tests': ['tp5o']}, 14:52:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:52:14 INFO - 'tests': ['tp5o']}, 14:52:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:52:14 INFO - 'talos_options': ['--disable-e10s', 14:52:14 INFO - '--xperf_path', 14:52:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:52:14 INFO - 'tests': ['tp5n']}, 14:52:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:52:14 INFO - 'talos_options': ['--xperf_path', 14:52:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:52:14 INFO - 'tests': ['tp5n']}}, 14:52:14 INFO - 'talos.zip': {'path': '', 14:52:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:52:14 INFO - Running post-action listener: _resource_record_post_action 14:52:14 INFO - [mozharness: 2017-01-16 22:52:14.232643Z] Finished populate-webroot step (success) 14:52:14 INFO - [mozharness: 2017-01-16 22:52:14.232778Z] Running create-virtualenv step. 14:52:14 INFO - Running pre-action listener: _resource_record_pre_action 14:52:14 INFO - Running main action method: create_virtualenv 14:52:14 INFO - Creating virtualenv /builds/slave/test/build/venv 14:52:14 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 14:52:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:52:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:52:14 INFO - Using real prefix '/tools/python27' 14:52:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:52:15 INFO - Installing distribute.............................................................................................................................................................................................done. 14:52:17 INFO - Installing pip.................done. 14:52:17 INFO - Return code: 0 14:52:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:52:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:52:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:52:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:52:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:52:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:17 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 0x104df0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d66570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe9e3591130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c04d30>, '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 0x104a6adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104bfcb20>, '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.4TrqDQPz60/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.8gyJQL4ltv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 14:52:17 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 14:52:17 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 14:52:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4TrqDQPz60/Render', 14:52:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:52:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:52:17 INFO - 'HOME': '/Users/cltbld', 14:52:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:52:17 INFO - 'LOGNAME': 'cltbld', 14:52:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:52:17 INFO - 'MOZ_NO_REMOTE': '1', 14:52:17 INFO - 'NO_EM_RESTART': '1', 14:52:17 INFO - 'PAGER': '/bin/cat', 14:52:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:52:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:52:17 INFO - 'PWD': '/builds/slave/test', 14:52:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:52:17 INFO - 'SHELL': '/bin/bash', 14:52:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8gyJQL4ltv/Listeners', 14:52:17 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 14:52:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:52:17 INFO - 'USER': 'cltbld', 14:52:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:52:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:52:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:52:17 INFO - 'XPC_FLAGS': '0x0', 14:52:17 INFO - 'XPC_SERVICE_NAME': '0', 14:52:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:52:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:52:18 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 14:52:18 INFO - Cleaning up... 14:52:18 INFO - Return code: 0 14:52:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:52:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:52:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:52:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:52:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:52:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:18 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 0x104df0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d66570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe9e3591130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c04d30>, '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 0x104a6adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104bfcb20>, '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.4TrqDQPz60/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.8gyJQL4ltv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 14:52:18 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 14:52:18 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 14:52:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4TrqDQPz60/Render', 14:52:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:52:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:52:18 INFO - 'HOME': '/Users/cltbld', 14:52:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:52:18 INFO - 'LOGNAME': 'cltbld', 14:52:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:52:18 INFO - 'MOZ_NO_REMOTE': '1', 14:52:18 INFO - 'NO_EM_RESTART': '1', 14:52:18 INFO - 'PAGER': '/bin/cat', 14:52:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:52:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:52:18 INFO - 'PWD': '/builds/slave/test', 14:52:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:52:18 INFO - 'SHELL': '/bin/bash', 14:52:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8gyJQL4ltv/Listeners', 14:52:18 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 14:52:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:52:18 INFO - 'USER': 'cltbld', 14:52:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:52:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:52:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:52:18 INFO - 'XPC_FLAGS': '0x0', 14:52:18 INFO - 'XPC_SERVICE_NAME': '0', 14:52:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:52:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:52:18 INFO - Downloading/unpacking psutil>=3.1.1 14:52:18 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 14:52:18 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 14:52:18 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 14:52:18 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 14:52:18 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 14:52:18 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 14:52:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:52:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:52:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:52:21 INFO - Installing collected packages: psutil 14:52:21 INFO - Running setup.py install for psutil 14:52:22 INFO - building 'psutil._psutil_osx' extension 14:52:22 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 14:52:22 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 14:52:22 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 14:52:22 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 14:52:22 INFO - building 'psutil._psutil_posix' extension 14:52:22 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 14:52:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:52:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:52:22 INFO - ^ 14:52:22 INFO - 1 warning generated. 14:52:22 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 14:52:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:52:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:52:23 INFO - Successfully installed psutil 14:52:23 INFO - Cleaning up... 14:52:23 INFO - Return code: 0 14:52:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:52:23 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')]} 14:52:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:52:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:23 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')]} 14:52:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:52:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:23 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 0x104df0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d66570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe9e3591130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c04d30>, '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 0x104a6adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104bfcb20>, '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.4TrqDQPz60/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.8gyJQL4ltv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 14:52:23 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 14:52:23 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 14:52:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4TrqDQPz60/Render', 14:52:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:52:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:52:23 INFO - 'HOME': '/Users/cltbld', 14:52:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:52:23 INFO - 'LOGNAME': 'cltbld', 14:52:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:52:23 INFO - 'MOZ_NO_REMOTE': '1', 14:52:23 INFO - 'NO_EM_RESTART': '1', 14:52:23 INFO - 'PAGER': '/bin/cat', 14:52:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:52:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:52:23 INFO - 'PWD': '/builds/slave/test', 14:52:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:52:23 INFO - 'SHELL': '/bin/bash', 14:52:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8gyJQL4ltv/Listeners', 14:52:23 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 14:52:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:52:23 INFO - 'USER': 'cltbld', 14:52:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:52:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:52:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:52:23 INFO - 'XPC_FLAGS': '0x0', 14:52:23 INFO - 'XPC_SERVICE_NAME': '0', 14:52:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:52:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:52:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:52:23 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 14:52:23 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 14:52:23 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 14:52:23 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 14:52:23 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 14:52:23 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 14:52:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:52:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:52:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:52:26 INFO - Installing collected packages: mozsystemmonitor 14:52:26 INFO - Running setup.py install for mozsystemmonitor 14:52:26 INFO - Successfully installed mozsystemmonitor 14:52:26 INFO - Cleaning up... 14:52:26 INFO - Return code: 0 14:52:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:52:26 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')]} 14:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:52:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:26 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')]} 14:52:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:52:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:26 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 0x104df0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d66570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe9e3591130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c04d30>, '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 0x104a6adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104bfcb20>, '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.4TrqDQPz60/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.8gyJQL4ltv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 14:52:26 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 14:52:26 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 14:52:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4TrqDQPz60/Render', 14:52:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:52:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:52:26 INFO - 'HOME': '/Users/cltbld', 14:52:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:52:26 INFO - 'LOGNAME': 'cltbld', 14:52:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:52:26 INFO - 'MOZ_NO_REMOTE': '1', 14:52:26 INFO - 'NO_EM_RESTART': '1', 14:52:26 INFO - 'PAGER': '/bin/cat', 14:52:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:52:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:52:26 INFO - 'PWD': '/builds/slave/test', 14:52:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:52:26 INFO - 'SHELL': '/bin/bash', 14:52:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8gyJQL4ltv/Listeners', 14:52:26 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 14:52:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:52:26 INFO - 'USER': 'cltbld', 14:52:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:52:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:52:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:52:26 INFO - 'XPC_FLAGS': '0x0', 14:52:26 INFO - 'XPC_SERVICE_NAME': '0', 14:52:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:52:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:52:26 INFO - Downloading/unpacking jsonschema==2.5.1 14:52:26 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 14:52:26 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 14:52:26 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 14:52:26 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 14:52:26 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 14:52:26 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 14:52:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:52:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:52:29 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 14:52:29 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 14:52:29 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 14:52:29 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 14:52:29 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 14:52:29 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 14:52:29 INFO - Downloading functools32-3.2.3-2.tar.gz 14:52:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:52:29 INFO - warning: no files found matching '*.txt' 14:52:29 INFO - no previously-included directories found matching 'build' 14:52:29 INFO - no previously-included directories found matching 'dist' 14:52:29 INFO - no previously-included directories found matching '.git*' 14:52:29 INFO - Installing collected packages: jsonschema, functools32 14:52:29 INFO - Running setup.py install for functools32 14:52:29 INFO - warning: no files found matching '*.txt' 14:52:29 INFO - no previously-included directories found matching 'build' 14:52:29 INFO - no previously-included directories found matching 'dist' 14:52:29 INFO - no previously-included directories found matching '.git*' 14:52:29 INFO - Successfully installed jsonschema functools32 14:52:29 INFO - Cleaning up... 14:52:30 INFO - Return code: 0 14:52:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:52:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:52:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:52:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:52:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:52:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104df0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d66570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe9e3591130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c04d30>, '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 0x104a6adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104bfcb20>, '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.4TrqDQPz60/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.8gyJQL4ltv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 14:52:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:52:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:52:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4TrqDQPz60/Render', 14:52:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:52:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:52:30 INFO - 'HOME': '/Users/cltbld', 14:52:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:52:30 INFO - 'LOGNAME': 'cltbld', 14:52:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:52:30 INFO - 'MOZ_NO_REMOTE': '1', 14:52:30 INFO - 'NO_EM_RESTART': '1', 14:52:30 INFO - 'PAGER': '/bin/cat', 14:52:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:52:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:52:30 INFO - 'PWD': '/builds/slave/test', 14:52:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:52:30 INFO - 'SHELL': '/bin/bash', 14:52:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8gyJQL4ltv/Listeners', 14:52:30 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 14:52:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:52:30 INFO - 'USER': 'cltbld', 14:52:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:52:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:52:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:52:30 INFO - 'XPC_FLAGS': '0x0', 14:52:30 INFO - 'XPC_SERVICE_NAME': '0', 14:52:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:52:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:52:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:52:30 INFO - Cleaning up... 14:52:30 INFO - Return code: 0 14:52:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:52:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:52:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:52:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:52:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:52:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104df0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d66570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe9e3591130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c04d30>, '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 0x104a6adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104bfcb20>, '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.4TrqDQPz60/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.8gyJQL4ltv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 14:52:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:52:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:52:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4TrqDQPz60/Render', 14:52:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:52:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:52:30 INFO - 'HOME': '/Users/cltbld', 14:52:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:52:30 INFO - 'LOGNAME': 'cltbld', 14:52:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:52:30 INFO - 'MOZ_NO_REMOTE': '1', 14:52:30 INFO - 'NO_EM_RESTART': '1', 14:52:30 INFO - 'PAGER': '/bin/cat', 14:52:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:52:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:52:30 INFO - 'PWD': '/builds/slave/test', 14:52:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:52:30 INFO - 'SHELL': '/bin/bash', 14:52:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8gyJQL4ltv/Listeners', 14:52:30 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 14:52:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:52:30 INFO - 'USER': 'cltbld', 14:52:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:52:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:52:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:52:30 INFO - 'XPC_FLAGS': '0x0', 14:52:30 INFO - 'XPC_SERVICE_NAME': '0', 14:52:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:52:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:52:30 INFO - Downloading/unpacking blobuploader==1.2.4 14:52:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:52:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:52:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:52:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:52:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:52:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:52:33 INFO - Downloading blobuploader-1.2.4.tar.gz 14:52:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:52:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:52: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 14:52: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 14:52: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 14:52: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 14:52: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 14:52: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 14:52:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:52:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:52: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 14:52: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 14:52: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 14:52: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 14:52: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 14:52: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 14:52:34 INFO - Downloading docopt-0.6.1.tar.gz 14:52:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:52:34 INFO - Installing collected packages: blobuploader, requests, docopt 14:52:34 INFO - Running setup.py install for blobuploader 14:52:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:52:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:52:34 INFO - Running setup.py install for requests 14:52:35 INFO - Running setup.py install for docopt 14:52:35 INFO - Successfully installed blobuploader requests docopt 14:52:35 INFO - Cleaning up... 14:52:35 INFO - Return code: 0 14:52:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:52:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:52:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:52:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:52:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:35 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 0x104df0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d66570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe9e3591130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c04d30>, '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 0x104a6adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104bfcb20>, '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.4TrqDQPz60/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.8gyJQL4ltv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 14:52:35 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 14:52:35 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 14:52:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4TrqDQPz60/Render', 14:52:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:52:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:52:35 INFO - 'HOME': '/Users/cltbld', 14:52:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:52:35 INFO - 'LOGNAME': 'cltbld', 14:52:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:52:35 INFO - 'MOZ_NO_REMOTE': '1', 14:52:35 INFO - 'NO_EM_RESTART': '1', 14:52:35 INFO - 'PAGER': '/bin/cat', 14:52:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:52:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:52:35 INFO - 'PWD': '/builds/slave/test', 14:52:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:52:35 INFO - 'SHELL': '/bin/bash', 14:52:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8gyJQL4ltv/Listeners', 14:52:35 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 14:52:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:52:35 INFO - 'USER': 'cltbld', 14:52:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:52:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:52:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:52:35 INFO - 'XPC_FLAGS': '0x0', 14:52:35 INFO - 'XPC_SERVICE_NAME': '0', 14:52:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:52:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:52:35 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-EvCx8c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:52:35 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-9JQSau-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:52:35 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-kwirow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:52:35 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-Rk9Gop-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:52:36 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-6_J_wK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:52:36 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-v6vW1T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:52:36 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-m65e9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:52:36 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-MBATQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:52:36 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-hvonZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:52:36 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-ttn0Hp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:52:36 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-5HrChy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:52:36 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-qJB15i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:52:36 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-k6rQF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:52:36 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-aZtm87-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:52:37 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-WGJrJ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:52:37 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-5x0D6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:52:37 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-Sw78DS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:52:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:52:37 INFO - Running setup.py install for manifestparser 14:52:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:52:37 INFO - Running setup.py install for mozcrash 14:52:37 INFO - Running setup.py install for mozdebug 14:52:37 INFO - Running setup.py install for mozdevice 14:52:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:52:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:52:37 INFO - Running setup.py install for mozfile 14:52:38 INFO - Running setup.py install for mozhttpd 14:52:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:52:38 INFO - Running setup.py install for mozinfo 14:52:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:52:38 INFO - Running setup.py install for mozInstall 14:52:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:52:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:52:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:52:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:52:38 INFO - Running setup.py install for mozleak 14:52:38 INFO - Running setup.py install for mozlog 14:52:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:52:38 INFO - Running setup.py install for moznetwork 14:52:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:52:38 INFO - Running setup.py install for mozprocess 14:52:39 INFO - Running setup.py install for mozprofile 14:52:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:52:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:52:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:52:39 INFO - Running setup.py install for mozrunner 14:52:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:52:39 INFO - Running setup.py install for mozscreenshot 14:52:39 INFO - Running setup.py install for moztest 14:52:39 INFO - Running setup.py install for mozversion 14:52:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:52:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:52:39 INFO - Cleaning up... 14:52:39 INFO - Return code: 0 14:52:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:52:39 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')]} 14:52:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:52:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:39 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')]} 14:52:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:52:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:39 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 0x104df0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d66570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe9e3591130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c04d30>, '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 0x104a6adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104bfcb20>, '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.4TrqDQPz60/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.8gyJQL4ltv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 14:52:39 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 14:52:39 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 14:52:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4TrqDQPz60/Render', 14:52:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:52:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:52:39 INFO - 'HOME': '/Users/cltbld', 14:52:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:52:39 INFO - 'LOGNAME': 'cltbld', 14:52:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:52:39 INFO - 'MOZ_NO_REMOTE': '1', 14:52:39 INFO - 'NO_EM_RESTART': '1', 14:52:39 INFO - 'PAGER': '/bin/cat', 14:52:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:52:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:52:39 INFO - 'PWD': '/builds/slave/test', 14:52:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:52:39 INFO - 'SHELL': '/bin/bash', 14:52:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8gyJQL4ltv/Listeners', 14:52:39 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 14:52:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:52:39 INFO - 'USER': 'cltbld', 14:52:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:52:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:52:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:52:39 INFO - 'XPC_FLAGS': '0x0', 14:52:39 INFO - 'XPC_SERVICE_NAME': '0', 14:52:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:52:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:52:40 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-3VcEGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:52:40 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)) 14:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:52:40 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-pUh_mZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:52:40 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)) 14:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:52:40 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-wANCFw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:52:40 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)) 14:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:52:40 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-cshZIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:52:40 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)) 14:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:52:40 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-CibaVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:52:40 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)) 14:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:52:40 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-vK21p7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:52:40 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)) 14:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:52:40 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-sh5biI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:52:40 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)) 14:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:52:40 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-9oiE5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:52:41 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)) 14:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:52:41 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-jXqX7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:52:41 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)) 14:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:52:41 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-8nzfoU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:52:41 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)) 14:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:52:41 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-_42iTr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:52:41 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)) 14:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:52:41 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-4fU4gP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:52:41 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)) 14:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:52:41 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-5P2Av0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:52:41 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)) 14:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:52:41 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-qKH_Jd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:52:41 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)) 14:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:52:41 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-EuXzOC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:52:41 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)) 14:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:52:41 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-L4snGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:52:41 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)) 14:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:52:41 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-TDKfdy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:52:41 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)) 14:52:42 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)) 14:52:42 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)) 14:52:42 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)) 14:52:42 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)) 14:52:42 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)) 14:52:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:52:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:52:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:52:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:52:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:52:44 INFO - Downloading blessings-1.6.tar.gz 14:52:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:52:44 INFO - Installing collected packages: blessings 14:52:44 INFO - Running setup.py install for blessings 14:52:44 INFO - Successfully installed blessings 14:52:44 INFO - Cleaning up... 14:52:45 INFO - Return code: 0 14:52:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:52:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:52:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:52:45 INFO - Reading from file tmpfile_stdout 14:52:45 INFO - Current package versions: 14:52:45 INFO - blessings == 1.6 14:52:45 INFO - blobuploader == 1.2.4 14:52:45 INFO - docopt == 0.6.1 14:52:45 INFO - functools32 == 3.2.3-2 14:52:45 INFO - jsonschema == 2.5.1 14:52:45 INFO - manifestparser == 1.1 14:52:45 INFO - mozInstall == 1.12 14:52:45 INFO - mozcrash == 0.17 14:52:45 INFO - mozdebug == 0.1 14:52:45 INFO - mozdevice == 0.48 14:52:45 INFO - mozfile == 1.2 14:52:45 INFO - mozhttpd == 0.7 14:52:45 INFO - mozinfo == 0.9 14:52:45 INFO - mozleak == 0.1 14:52:45 INFO - mozlog == 3.4 14:52:45 INFO - moznetwork == 0.27 14:52:45 INFO - mozprocess == 0.23 14:52:45 INFO - mozprofile == 0.28 14:52:45 INFO - mozrunner == 6.12 14:52:45 INFO - mozscreenshot == 0.1 14:52:45 INFO - mozsystemmonitor == 0.3 14:52:45 INFO - moztest == 0.7 14:52:45 INFO - mozversion == 1.4 14:52:45 INFO - psutil == 3.1.1 14:52:45 INFO - requests == 1.2.3 14:52:45 INFO - wsgiref == 0.1.2 14:52:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:52:45 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')]} 14:52:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:52:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:45 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')]} 14:52:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:52:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:45 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 0x104df0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d66570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe9e3591130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c04d30>, '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 0x104a6adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104bfcb20>, '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.4TrqDQPz60/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.8gyJQL4ltv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 14:52:45 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 14:52:45 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 14:52:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4TrqDQPz60/Render', 14:52:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:52:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:52:45 INFO - 'HOME': '/Users/cltbld', 14:52:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:52:45 INFO - 'LOGNAME': 'cltbld', 14:52:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:52:45 INFO - 'MOZ_NO_REMOTE': '1', 14:52:45 INFO - 'NO_EM_RESTART': '1', 14:52:45 INFO - 'PAGER': '/bin/cat', 14:52:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:52:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:52:45 INFO - 'PWD': '/builds/slave/test', 14:52:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:52:45 INFO - 'SHELL': '/bin/bash', 14:52:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8gyJQL4ltv/Listeners', 14:52:45 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 14:52:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:52:45 INFO - 'USER': 'cltbld', 14:52:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:52:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:52:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:52:45 INFO - 'XPC_FLAGS': '0x0', 14:52:45 INFO - 'XPC_SERVICE_NAME': '0', 14:52:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:52:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:52:45 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)) 14:52:45 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)) 14:52:45 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)) 14:52:45 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)) 14:52:45 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)) 14:52:45 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)) 14:52:45 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)) 14:52:45 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)) 14:52:45 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)) 14:52:45 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)) 14:52:45 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)) 14:52:45 INFO - Cleaning up... 14:52:45 INFO - Return code: 0 14:52:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:52:45 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')]} 14:52:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:52:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:45 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')]} 14:52:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:52:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:45 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 0x104df0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d66570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe9e3591130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c04d30>, '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 0x104a6adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104bfcb20>, '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.4TrqDQPz60/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.8gyJQL4ltv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 14:52:45 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 14:52:45 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 14:52:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4TrqDQPz60/Render', 14:52:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:52:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:52:45 INFO - 'HOME': '/Users/cltbld', 14:52:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:52:45 INFO - 'LOGNAME': 'cltbld', 14:52:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:52:45 INFO - 'MOZ_NO_REMOTE': '1', 14:52:45 INFO - 'NO_EM_RESTART': '1', 14:52:45 INFO - 'PAGER': '/bin/cat', 14:52:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:52:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:52:45 INFO - 'PWD': '/builds/slave/test', 14:52:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:52:45 INFO - 'SHELL': '/bin/bash', 14:52:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8gyJQL4ltv/Listeners', 14:52:45 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 14:52:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:52:45 INFO - 'USER': 'cltbld', 14:52:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:52:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:52:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:52:45 INFO - 'XPC_FLAGS': '0x0', 14:52:45 INFO - 'XPC_SERVICE_NAME': '0', 14:52:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:52:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:52:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:52:46 INFO - Cleaning up... 14:52:46 INFO - Return code: 0 14:52:46 INFO - Running post-action listener: _resource_record_post_action 14:52:46 INFO - Running post-action listener: _start_resource_monitoring 14:52:46 INFO - Starting resource monitoring. 14:52:46 INFO - [mozharness: 2017-01-16 22:52:46.208907Z] Finished create-virtualenv step (success) 14:52:46 INFO - [mozharness: 2017-01-16 22:52:46.209700Z] Running install step. 14:52:46 INFO - Running pre-action listener: _resource_record_pre_action 14:52:46 INFO - Running main action method: install 14:52:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:52:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:52:46 INFO - Reading from file tmpfile_stdout 14:52:46 INFO - Detecting whether we're running mozinstall >=1.0... 14:52:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:52:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:52:46 INFO - Reading from file tmpfile_stdout 14:52:46 INFO - Output received: 14:52:46 INFO - Usage: mozinstall [options] installer 14:52:46 INFO - Options: 14:52:46 INFO - -h, --help show this help message and exit 14:52:46 INFO - -d DEST, --destination=DEST 14:52:46 INFO - Directory to install application into. [default: 14:52:46 INFO - "/builds/slave/test"] 14:52:46 INFO - --app=APP Application being installed. [default: firefox] 14:52:46 INFO - mkdir: /builds/slave/test/build/application 14:52:46 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'] 14:52:46 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 14:53:08 INFO - Reading from file tmpfile_stdout 14:53:08 INFO - Output received: 14:53:08 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 14:53:08 INFO - Running post-action listener: _resource_record_post_action 14:53:08 INFO - [mozharness: 2017-01-16 22:53:08.491983Z] Finished install step (success) 14:53:08 INFO - [mozharness: 2017-01-16 22:53:08.492126Z] Running run-tests step. 14:53:08 INFO - Running pre-action listener: _resource_record_pre_action 14:53:08 INFO - Running main action method: run_tests 14:53:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:53:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:53:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:53:08 INFO - 2017-01-16 14:53:08.506 screenresolution[1621:7356] starting screenresolution argv=screenresolution get 14:53:08 INFO - 2017-01-16 14:53:08.509 screenresolution[1621:7356] Display 0: 1600x1200x32@60 14:53:08 INFO - 2017-01-16 14:53:08.515 screenresolution[1622:7358] starting screenresolution argv=screenresolution list 14:53:08 INFO - Available Modes on Display 0 14:53:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:53:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:53:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:53:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:53:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:53:08 INFO - Intel Iris: 14:53:08 INFO - Chipset Model: Intel Iris 14:53:08 INFO - Type: GPU 14:53:08 INFO - Bus: Built-In 14:53:08 INFO - VRAM (Dynamic, Max): 1536 MB 14:53:08 INFO - Vendor: Intel (0x8086) 14:53:08 INFO - Device ID: 0x0a2e 14:53:08 INFO - Revision ID: 0x0009 14:53:08 INFO - Displays: 14:53:08 INFO - Display: 14:53:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:53:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:53:08 INFO - Display Serial Number: 1600x1200 60 14:53:08 INFO - Main Display: Yes 14:53:08 INFO - Mirror: Off 14:53:08 INFO - Online: Yes 14:53:08 INFO - Rotation: Supported 14:53:08 INFO - Return code: 0 14:53:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:53:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:53:08 INFO - Python 2.7.3 14:53:08 INFO - Return code: 0 14:53:08 INFO - grabbing minidump binary from tooltool 14:53:08 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')]} 14:53:08 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 0x104c04d30>, '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 0x104a6adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104bfcb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:53:08 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 14:53:08 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 14:53:08 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 14:53:08 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:53:08 INFO - Return code: 0 14:53:08 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:53:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:53:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:53:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:53:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:53:08 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/VOUMscFtQW-27brDEh90Mg/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0317', '--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 14:53:08 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/VOUMscFtQW-27brDEh90Mg/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0317 --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 14:53:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4TrqDQPz60/Render', 14:53:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:53:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:53:08 INFO - 'HOME': '/Users/cltbld', 14:53:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:53:08 INFO - 'LOGNAME': 'cltbld', 14:53:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:53:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:53:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:08 INFO - 'MOZ_NO_REMOTE': '1', 14:53:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:53:08 INFO - 'NO_EM_RESTART': '1', 14:53:08 INFO - 'PAGER': '/bin/cat', 14:53:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:53:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:53:08 INFO - 'PWD': '/builds/slave/test', 14:53:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:53:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:53:08 INFO - 'SHELL': '/bin/bash', 14:53:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8gyJQL4ltv/Listeners', 14:53:08 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 14:53:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:53:08 INFO - 'USER': 'cltbld', 14:53:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:53:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:53:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:08 INFO - 'XPC_FLAGS': '0x0', 14:53:08 INFO - 'XPC_SERVICE_NAME': '0', 14:53:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:53:08 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/VOUMscFtQW-27brDEh90Mg/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0317', '--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 14:53:09 INFO - mozversion application_buildid: 20170116132722 14:53:09 INFO - mozversion application_changeset: 4d23adbd1004fa55093929e4934dc77d0de2fd01 14:53:09 INFO - mozversion application_display_name: Firefox 14:53:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:53:09 INFO - mozversion application_name: Firefox 14:53:09 INFO - mozversion application_remotingname: firefox 14:53:09 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:53:09 INFO - mozversion application_vendor: Mozilla 14:53:09 INFO - mozversion application_version: 51.0 14:53:09 INFO - mozversion platform_buildid: 20170116132722 14:53:09 INFO - mozversion platform_changeset: 4d23adbd1004fa55093929e4934dc77d0de2fd01 14:53:09 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:53:09 INFO - mozversion platform_version: 51.0 14:53:09 INFO - using testdate: 1484607189 14:53:09 INFO - actual date: 1484607189 14:53:09 INFO - starting webserver on 'localhost:49241' 14:53:09 INFO - SUITE-START | Running 2 tests 14:53:09 INFO - TEST-START | dromaeo_css 14:53:09 INFO - operating with platform_type : mac_ 14:53:09 INFO - Initialising browser for dromaeo_css test... 14:53:09 INFO - TEST-INFO | started process 1632 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/tmpBEQuu2/profile http://localhost:49241/getInfo.html) 14:53:11 INFO - PROCESS | 1632 | __metrics Screen width/height:1600/1200 14:53:11 INFO - PROCESS | 1632 | colorDepth:24 14:53:11 INFO - PROCESS | 1632 | Browser inner width/height: 1024/689 14:53:11 INFO - PROCESS | 1632 | __metrics 14:53:11 INFO - PROCESS | 1632 | 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" 14:53:11 INFO - PROCESS | 1632 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:53:12 INFO - TEST-INFO | 1632: exit 0 14:53:12 INFO - Browser initialized. 14:53:12 INFO - Running cycle 1/1 for dromaeo_css test... 14:53:12 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/tmpBEQuu2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:53:24 INFO - PROCESS | 1635 | RSS: Main: 168259584 14:53:24 INFO - PROCESS | 1635 | 14:54:15 INFO - PROCESS | 1635 | 1484607255731 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] 14:56:25 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 14:56:27 INFO - PROCESS | 1635 | RSS: Main: 322109440 14:56:27 INFO - PROCESS | 1635 | 14:59:30 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 14:59:30 INFO - PROCESS | 1635 | RSS: Main: 303816704 14:59:30 INFO - PROCESS | 1635 | 15:02:32 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 15:02:33 INFO - PROCESS | 1635 | RSS: Main: 300879872 15:02:33 INFO - PROCESS | 1635 | 15:05:35 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 15:05:36 INFO - PROCESS | 1635 | RSS: Main: 294821888 15:05:36 INFO - PROCESS | 1635 | 15:08:39 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 15:08:39 INFO - PROCESS | 1635 | RSS: Main: 261550080 15:08:39 INFO - PROCESS | 1635 | 15:11:42 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 15:11:42 INFO - PROCESS | 1635 | RSS: Main: 411869184 15:11:42 INFO - PROCESS | 1635 | 15:11:42 INFO - PROCESS | 1635 | __start_tp_report 15:11:42 INFO - PROCESS | 1635 | _x_x_mozilla_page_load 15:11:42 INFO - PROCESS | 1635 | _x_x_mozilla_page_load_details 15:11:42 INFO - PROCESS | 1635 | |i|pagename|runs| 15:11:42 INFO - PROCESS | 1635 | |0;dojo.html;3434.5706786651676;3435.484677298405;3470.462078377849;3479.5128681984543;3527.8588856445726;5647.745851436685;5719.857003574907;5730.770769169233;5750.309962804464;5758.712064396785;5576.665400075998;5723.4848863602265;5768.625039372438;5834.095715164146;5845.152452894327;5210.452902445236;5250.789968401278;5269.341332333458;5275.657082289658;5278;5215.426303106655;5215.71313577755;5217.139172036609;5344.5724342052545;5362.088444964346;5220.582353411718;5265.578753699714;5287.312649355578;5288.682679039251;5294.020606187848;5281.128613778722;5346.732663366835;5350.866228344284;5350.9833131705245;5395.190721391783;5058.317127187819;5149.382074151088;5252.212168174766;5280.52475277223;5302.019126461579;4713.787879545429;5640.633358831663;5715.999700052515;5725.599208055396;5729.255196824428;6270.811875643738;6279.748810047593;6321.051842223657;6345.49236061114;6366.745330186787;6348.968255158741;6406.519511036691;6409.647469389181;6411.166548348731;6429.710663020175;5757.88484230313;5801.216835727208;5814.738336774855;5831.591788574844;5860.296764388216;6370.458511026522;6406.0390941359165;6410.583312084793;6411;6426.967865160645;6200.410960958701;6217.316095229521;6221.626702397871;6237.5321850860455;6242.563020588515;6119.694015299217;6200.224971878515;6218.098375735493;6225.533085018642;6334.9366506334345;6215.844603884939;6280.0893870389455;6325.715342809584;6328;6331.891918914263;6267.341929097471;6295.37046295376;6313.589616674902;6318.368163183645;6332.620042797447;4913.77887995034;4945;4952.083864485082;4985.850424487271;5004.699718016931;4484.932726009112;4521.88695282614;4573.49691533931;4574.222382195035;4595.310703394518;5769.624974376652;5811.912821307684;5841.94158058414;5844.064949608042;5862.70686465675;6372.267189273293;6395;6404.039394090923;6411.2627047889155;6411.839704007344;5658.009848276535;5755.424457554295;5770.653760774283;5794.62334948227;5799.536037117021;5440.42875498067;5490.176473529003;5491.643043202179;5499.065158922993;5503.064479038573;6365.713542890581;6368.968155159195;6378.84052898672;6382.106505089291;6383.0744542042075;6204.286507051566;6209.5032397409;6291.433770960452;6372.458341041063;6414.775482858077;6283.748650053946;6341.746330146742;6345.333739957238;6354.586951848115;6373.203349581302;6277.027060805583;6300.810975670737;6327.114204011534;6329.955557332988;6333.050042493663;6348.650824204528;6395;6405.3594640535575;6410.903836442364;6422.133012043314;4891.413030436371;6067.544934130046;6130.938690613037;6140.416660417253;6169.56813023084;6190.721417536131;6195.31851496326;6204.13142160107;6211.751529938932;6214.533909956681;6030.487408570145;6055.545834062551;6055.969720151547;6063.242094738158;6078.513718902389;6032.487238584769;6049.848753781191;6049.879002420015;6106.816795496142;6196.225471816023;6016.037434010537;6017.247844019497;6027.4876635484725;6029.849253768691;6061.575689701855 15:11:42 INFO - PROCESS | 1635 | |1;ext.html;503.51159375405854;520.5471240021183;552.98803190162;559.1808001278126;562.5302872101795;31709.84145079274;32609.18477038075;33815.66184338156;33848.15379615511;34074;34821.12947176315;35248;35437.64562354382;35441.64558354416;43506.12987740243;9603.80792384152;9932.702018939442;9936.40381577104;9944.850827237597;9954.352967057155;9802.852957205612;9885.258605604573;9895;9895.158911492532;9904.702858914245;9020.233280171193;9231.86152207714;9869.111779939803;9922.950385248063;9944.751381215492;10513.632022879163;11896.22674526153;12152.635420937342;12188.08589355793;12374.876251237463;11959.043276537943;12039.63881083569;12049.216800907912;12052.638420847301;12058.155929084967;41922.79038604788;42224.94437639053;42287.78856105731;42300.7309780704;42438.57561424377;3477.5826900772067;3478.878239261639;3503.9649603503894;3639.7998110103936;3813.580506144322;32145.1963700907;32204.033878983668;32355.19112022218;32700.509492357633;32752.181195470064;3295.802251864896;3313.1717070732316;3325.1022223999626;3413.9829300853585;3441.1397150712323;412945;413206;413437;413655;414383;59717;60034.39793612397;60122.699386503664;60156.699216504516;60167.69916150479;35433.64566354355;36305.27389452196;36357;37666.43500347497;37746;17373.47879563615;17582.560435989202;17582.560435989202;17584.56038599045;17627.823721762874;13407;13495.920326373867;13498.325083745773;13518.729625407634;13546.187228766306;18951.434986811862;19305.227790888206;19339.80660193408;19349.12928918202;19511.317103901296;6910.654467276616;8147.959260203779;8273.131321211307;8342.499450033018;8374.49753014821;934.3926447808979;1075.5213929801164;1120.9351116439416;1134.8014097532898;1174.307158776326;30801.69198308033;31351.529727054112;31365.843170784;31654.050378488682;31981.68018319787;1101.1851230089676;1136.9772604547863;1150.465033759306;1158.7334912970064;1204.3556697166973;15833.129177895096;16204;16230.431934882223;16318.102504362136;16483.91758041202;745823;753328;754650;754970;755609;59845.80308393895;60358.39641603616;60397.79204415887;60445;60498.79002420015;1309.6267563744286;1342.8522862485315;1347.4138749643937;1456.1699831096173;1481.3556103095189;30392.848035759678;31963;32232.71069157301;33163.17092072621;33203.667963320055;51964.22053669274;55185;55196;55337.72331138318;55442;631051;639096;640561;640934;641733;25638;26400.603990940537;26411.20766376935;26431.735682642928;26443.471130577665;47780.7610961943;47904;48084.519154808004;55164.72417638046;57688.55778605569;40032.79655636233;44705;44956;45961.31058034199;46494.070118598116;43896.34155487734;44842.327365088895;44902.3264651037;45659.71701414982;46324.53675463202;42829;42916.570834291255;43745.56254437415;43954.12091758083;44382.55617443784;36310.27379452449;36821.63178368289;38267.808660956514;38968.41547376848;39089.80455097706;27917.860410698628;28267.57598635981;28333.858330708215;28338;28341 15:11:42 INFO - PROCESS | 1635 | |2;jquery.html;384.2545461804098;384.63651849002696;394.22534719276615;397.25514660012476;414.155123547962;11692.159392143794;19711.112999915003;20086.296979605715;21181.68227476587;21211;16517.752233716503;18463.815361846377;19602.019899005027;20722.585548289026;20894.05976731047;5650.406707295726;6141.754329826802;6249.968750156266;6256.843578910541;6259.155014073087;5974.522038236931;6142.785002524913;6173.938260617381;6217.440430361266;6268.968655156741;6037.124616930564;6170.2904166021035;6171.2594488661425;6183.103449999748;6189.288231853327;5927.940720592804;6143.354947730513;6151.077338399231;6195.81412557624;6203.658798766066;5377.5966802489575;5385.515303622693;5385.757640906129;5387.595930305243;5394.460553944614;23911.7608823913;24671.62992555113;24905.750942490704;25508.36229094269;25938.74061259382;2170.121100954116;2306.5848147333472;2419.6128619420806;2555.5783295756178;2860.256333353343;9980.30137890348;10187.235957303157;10265.332753371007;10586.523606437651;10647.627333043383;1775.7247626617896;1909.8567607429359;1971.5859669469428;1977.2782934228903;2003.4490515108316;119951;125061;125805.37097314546;127465.08802367972;132241;11368.545258189744;11395.145364097725;11509.043462611377;11571.942140289244;11725.296482211095;14593.124412535282;14618.415263389557;14618.903582231374;14624.049436786574;14627.926860365844;7746.186650401627;7798.869163971192;8574.485530868167;8605.397622166389;8685.131486851264;8588.656453741905;8683.826323473495;8705.608247628872;8842.46945183291;8872;3319.817410042471;3795.91816332344;4243.681723870722;4426.623736982328;4454.131444368382;1794.2553840156188;1826.4155470249393;1829.0928929226907;1909.2458478900755;1911.4074636862617;846.7417437681567;900.1052783889818;908.3006085314271;938.1041105743998;949.1742184299566;20161.29435469781;21325.46686332823;21327.93360332008;21337.67993480099;21347.359579212647;920.2040235196507;984.8768903887014;1005.4017859373661;1010.4846528270635;1054.9050585447346;11076.280041797418;11312.547498100148;11317.151213659008;11342.546298147981;11352.716182095513;653900;656391;660902;670597.6470117618;672296;133075.33462332626;134831;137661;140923;142955.2852235732;941.5151197133482;959;960.4477425480377;960.5533426956499;995.3579940938055;17794.644107117525;18485.9075704626;19044.143013564146;19099.94950277748;19152.61694766125;55421;57766;58269.35835465826;58951.705241473515;59866.70066649639;65527.344726552124;79205;80336.79494807699;81394.18605814103;81731.59134204291;7440.851182976418;8076.83846323082;8138.87791683137;8323.625436855476;8341.374396920133;11917.463714133059;12143.514259429878;12882.549110781078;13422.530211442552;13439.664008399868;11288.9435552825;11460.82808757886;11572.710682233012;11649.272232885396;11718.179727419;11114.722131946766;11256.662300131009;11342.376169310766;11786.882131178578;11854.170208085696;11521.135914806255;11550.94224528872;11944.104192185447;11985.700357490783;11991.64025079249;8119.5534245617055;8191.467554608931;8200.876986845084;8318.625661845352;8335.166483351859;8336.916630833857;11231.66305010851;11386.544538218379;11407.885921140682;11766.82349764737 15:11:42 INFO - PROCESS | 1635 | |3;mootools.html;1322.266142291028;1524.0703171065652;1566.3029951671508;1761.2690733345662;1916.492129585659;8037.919620803797;8555.700550480728;8743.300535957116;9021.36850420471;9084.227840633537;8947.955260223689;9030.638774449031;9034.232090272335;9038.18656320931;9053.230475409582;2382.7617238276207;2412.7707867752624;2415.516896620683;2418.4921166554955;2419.383057320381;2289.3589794857467;2318.988405057981;2332.7667233276707;2334.124703236286;2339.0526836631107;2014.21445636202;2386.176769014687;2409.3856066702965;2413.8672373019476;2421.503591763693;2362.574736547421;2390.3665528634924;2393.2102406206086;2395.64065390192;2401.351635058542;2295.2999335202758;2389.4862604539935;2391.1391898916377;2392.138830021191;2400.0399840063938;8081.676732930676;8332.791680207984;8967.148120928501;8987.37088403812;9093;5295.549878260353;5474.069408200576;5475.315585551806;5535.806246781383;5542.224088627595;3469.60099588548;3546.8896006875866;3554.0759402555523;3631.4734363517405;3632.0919770057485;1095.1293721491434;1098.3300186885992;1106.397013627575;1112.238116889933;1119.9888001119966;11597.942010289895;11720.648380548597;11721.531138754439;11722.70693232676;11730.999999999915;4780.665353425296;4790.329353890458;4845.418549773979;4949.57928576075;4959.677620954626;10253.33353332031;10257.128144107834;10259.640912568024;10265.12746416563;10268.691939241835;5495.2856128703015;5495.972520137374;5503.11950087984;5506.91739623898;5507.531859791962;4973.179425394769;4986.576141028053;5017.623678224148;5019.949800501949;5044.2937988681615;3692.778433294011;3821.8280177392085;4070.6946978976694;4139.917201656011;4184.979075104605;1291.2059083663667;1294.2752058847075;1299.7205600795874;1301.8828305452366;1310.5282098444552;919.6548800558548;925.6621333213328;930.3069213435898;947.8436058050345;991.9305648604673;5882.529397648178;5922.437368449991;6039.184710064085;6161.291451483047;6195.101710251988;448.8025268881682;455.66053290298277;459.68970944612255;461.1675924955488;463.4623836349818;4070.531888832763;4091.284025295561;4141.544430112685;4158.459400277945;4199.118185181146;10497.107745841537;10981.560737570568;10983.39591322469;11013.00882920541;11013.953674400918;10841.13270938323;10853.51159197838;10895.83656245157;10914.345139291669;10951.83572246417;8018.959905200437;8185.181481851886;8302.211289927447;8305.837182794414;8341.16588341161;6088.360722124113;6095.2323826091715;6098.573099882966;6231.688415579112;6291.276503202191;9925.454100024279;10243.641472548425;10249.436281004617;10255.84616230772;10282.537285822305;10037.247206459691;10358.119559837498;10516.526756296138;10541.841872372073;10546.156307495228;8383.664653413794;8600.612972416131;8600.78498037554;8611.13888611134;8617.48295102296;8337.124601916712;8339;8345.666173352998;8486.278666313432;8578.914210858062;7656.196099409704;7686.461947663834;7699.961500192463;7701.345385642059;7724.304812566896;7510.173880873209;7543.660535275816;7583.355414789805;7595.810104747426;7625.618719063914;7065.788026359218;7080;7132.714691412493;7166.570005799668;7216.5670059796585;5132.12753831842;5141.126008578476;5158.3552055993005;5203.323567936144;5216.582673386196;4979.701217926936;5065.290859279778;5083.46623604531;5124.564412024871;5243.056249875059 15:11:42 INFO - PROCESS | 1635 | |4;prototype.html;289.99275018124547;302.8939871045133;318.5747027717997;322.1190045226306;325.1043375500496;4398.954486163933;5221.859037794505;5326.668332916771;5339.599530035248;5414.3232095988005;4339.544347843478;4564.475085365184;4972.30387745715;5273.414078426668;5338.3860856001575;3387.9830600847085;4104.774237416941;4108.506979162505;4114.259433302004;4123.546409894909;4118.176364727066;4120.75275483472;4123.195976784528;4124.803806896011;4159.376093585956;3554.022643772957;3758.4174452959833;4009.9799501002453;4061.8172182251724;4106.609872062149;2977.783993287266;3667.468217108518;3717.5353080864893;3745.7077308328585;4036.0313524753847;3499.4400895856797;3526.188976535386;3542.8405721742583;3559.893203203882;3562.412201986669;5077.39071311445;5155.922661160085;5250.291210686547;5264.684118952875;5286.524212820865;3892.260470510594;4598.229681572619;4604.401427814396;4611.83858564952;4612.215923293048;5589.524890384322;5590.664560126364;5608.130739735348;5615.073512870372;5644.322681278232;3707.3141468828353;3765.3410653135593;3888.51393575803;3914.432407300954;3924.1563063941103;4736.928946065812;5211.973940130313;5737.627054241502;5765.827025189251;5774.335951365605;3421.2473255883665;3434.9313013740084;3769.5476542815036;3856.014152711356;3926.1755031443718;3023.6220472440946;3504.3166582516674;3835.6547910688173;3975.1453437511072;4023.959760402417;3834.9808250958567;4637.907241855144;4652.976735116303;4654.650901182425;4659.440867095903;4472.776361181928;5162.5095615916425;5589.329280486368;5700.9429905701245;5747.252857128547;1173.565780661161;1331.7415042784476;1334.3194970564887;1346.5556366399064;1352.5604178641784;784.5292824305371;793.9801504962306;817.4713286154928;831.4096991136361;837.6691206973211;4349.043210493686;4455.836356187078;4464.464264288241;4471.485779135376;4515.9774201128785;4063.22798668258;4286.935695964501;4406.444262327842;4444.933326000112;4812.302216178635;3839.6928245740833;4029.7179197456485;4345.847895323648;4376.627986621173;4395.956040439619;2124.8087672109586;2191.6849890065832;2323.6001853300536;2413.674153989224;2472.678551788256;4569.994601187734;4691.7654117294;4997.825076122391;5005.799768009311;5017.096922553902;4902.6416904420585;4907.852764417074;4929.901401971941;4958.677685950402;4963.45402005779;4933.654644174945;5524.530414914777;5532.75226348899;6036.464684832293;6089.54328425361;5824.271966004249;5859.949017843721;5872.383399742966;5892.616979896465;5909.881802364014;5482.972585137049;5754.942450575608;5843.312076444883;5879.559033072622;5884.382139875252;5251.553617942518;5788.739506722123;6066.666333351708;6068.939310606837;6075.726592303268;3182.3292771294327;3858.4983952087173;3861.2856621523983;3869.574346821791;3874.5544262409057;4836.46798852133;5007.148784706682;5811.767529298781;5884.941150588439;5902.822915312548;4667.813287468599;4767.594754445772;5057.848264552069;5458.699771512446;5743.396943320891;4740.5733483986605;5694.402087780889;5708.828735137787;5715.17130016137;5715.771369145187;5112.463191364853;5613.46672066153;5631.2960879890015;5645.548356131418;5667.404922483245;4706.717596944058;5486.396496385315;5629.54963602919;5677.968642264039;5695.971520142372;4540.750258735669;5109.824740309676;5519.724013799374;5538.44615538459;5540.916886246629 15:11:42 INFO - PROCESS | 1635 | |5;yui.html;705.3017512662466;721.2931327299243;754.7697952124603;765.4565258666347;866.4541338956457;15970.520884373473;16583.005019698812;16616.08611526367;16641;16685.66628667426;14993.250337483138;15113.54659360221;15120.092794432314;15129.546113616581;15164.54506364808;703.7994171661078;727.1564984617844;734.0017576096504;862.7756783236372;877.9780505487366;892.0633334998225;896.5875697179305;903.286403741047;903.4985583001431;904.4934836491553;918.1186061381082;938.0431959401407;970.0154343341515;971.9951400243024;975.9609615615367;962.8459446488528;969.0648524174135;969.2391472693902;969.3166317746008;969.7575606098476;717.1072015340934;717.720089165226;719.4352433339803;719.8704233238016;720.7549433192739;15695.450659226986;15839.366425342972;15846.207689615474;15854.682906341925;15854.682906341925;13764.65588360289;13817.792733109012;13873;13989.650258743512;14216.50242241527;13435.798463023062;13633.250171240577;14067.155970641794;14147.646308842259;14388.208648524327;4672.929906051412;4688.29675548667;4713.811447542129;4840.177169881129;4878.56092951636;114516.28225576623;127272;129146;129441;129958;11122.721931951604;11175;11207.271527350696;11398;11522.423878806027;21111.78888211098;21163.894180529307;21244.150233990775;21247.575048499253;21464.57070858574;8012.0786109596975;8107.716229931924;8113.716019939392;8156.632951517196;8173.468724532886;4467.642588592905;4499.505054444008;4638.141943740419;4716.764161791965;4800.807967681323;3561;3641.6540428659237;3671.541057367829;3673.081729567608;3674.0814796300924;634.7143785296635;636.8662580857979;640.7276907314373;641.2913730328014;660.2704012066694;585.4175095779726;630.8738252349549;647.9190101237346;649.4966401039138;656.6618191631313;9464.242860571137;9573.473458959825;9790.706278811647;10743.462826858626;11066.778664426667;636.8315884413579;646.9357906244296;719.2124623537219;720.9042255771199;735.874901266786;4515.392254220456;4801.783919723621;4962.354893863775;5013.1227035268685;5017.724025178651;95869;111491;151488;166279;167491.16254418893;117094.9999999983;118712;123425;134188.32905835408;135641.96537051952;104707.4764626172;113737;115649;117339.41330293294;119304.99999999827;8980.955095224483;10396.376217426978;10612.787744244917;10689.144868410664;10729.980651838063;63619;64889.67555162194;65790.01314980183;66003;68392.6580367095;88171.55914220645;89454.10545894718;90708.09291906997;93352.13295733911;94981;13225.735485290048;13289.867101328862;13532.661683457993;13928.303584820922;13952.16287022782;15412.614684632525;15468.381264749283;15485;15528.767068494208;15655.68688626244;13988.230647314496;14055.945804064531;14287.285635718381;14607.123572585679;14770.778438323649;13041.934790325988;13333.666658333232;13837.169769813843;14079.436822526985;14428.278586070865;13311.534096306583;13880.791788122984;14077.296135192995;14537.055091419024;14987.925060374628;11331.810159933419;11756.70608234801;11856.644300670994;12114.030877529953;12141.271523708252;11602.245854019462;11740.41297935117;11998.460069297078;12024.939875300568;12047.216930899463 15:11:42 INFO - PROCESS | 1635 | __end_tp_report 15:11:42 INFO - PROCESS | 1635 | __start_cc_report 15:11:42 INFO - PROCESS | 1635 | _x_x_mozilla_cycle_collect,1379 15:11:42 INFO - PROCESS | 1635 | __end_cc_report 15:11:42 INFO - PROCESS | 1635 | __startTimestamp1484608302742__endTimestamp 15:11:42 INFO - PROCESS | 1635 | 15:11:42 INFO - PROCESS | 1635 | ------- Summary: start ------- 15:11:42 INFO - PROCESS | 1635 | Number of tests: 6 15:11:42 INFO - PROCESS | 1635 | 15:11:42 INFO - PROCESS | 1635 | [#0] dojo.html Cycles:165 Average:5810.21 Median:6049.85 stddev:649.55 (10.7%) stddev-sans-first:624.23 15:11:42 INFO - PROCESS | 1635 | Values: 3434.6 3435.5 3470.5 3479.5 3527.9 5647.7 5719.9 5730.8 5750.3 5758.7 5576.7 5723.5 5768.6 5834.1 5845.2 5210.5 5250.8 5269.3 5275.7 5278.0 5215.4 5215.7 5217.1 5344.6 5362.1 5220.6 5265.6 5287.3 5288.7 5294.0 5281.1 5346.7 5350.9 5351.0 5395.2 5058.3 5149.4 5252.2 5280.5 5302.0 4713.8 5640.6 5716.0 5725.6 5729.3 6270.8 6279.7 6321.1 6345.5 6366.7 6349.0 6406.5 6409.6 6411.2 6429.7 5757.9 5801.2 5814.7 5831.6 5860.3 6370.5 6406.0 6410.6 6411.0 6427.0 6200.4 6217.3 6221.6 6237.5 6242.6 6119.7 6200.2 6218.1 6225.5 6334.9 6215.8 6280.1 6325.7 6328.0 6331.9 6267.3 6295.4 6313.6 6318.4 6332.6 4913.8 4945.0 4952.1 4985.9 5004.7 4484.9 4521.9 4573.5 4574.2 4595.3 5769.6 5811.9 5841.9 5844.1 5862.7 6372.3 6395.0 6404.0 6411.3 6411.8 5658.0 5755.4 5770.7 5794.6 5799.5 5440.4 5490.2 5491.6 5499.1 5503.1 6365.7 6369.0 6378.8 6382.1 6383.1 6204.3 6209.5 6291.4 6372.5 6414.8 6283.7 6341.7 6345.3 6354.6 6373.2 6277.0 6300.8 6327.1 6330.0 6333.1 6348.7 6395.0 6405.4 6410.9 6422.1 4891.4 6067.5 6130.9 6140.4 6169.6 6190.7 6195.3 6204.1 6211.8 6214.5 6030.5 6055.5 6056.0 6063.2 6078.5 6032.5 6049.8 6049.9 6106.8 6196.2 6016.0 6017.2 6027.5 6029.8 6061.6 15:11:42 INFO - PROCESS | 1635 | 15:11:42 INFO - PROCESS | 1635 | [#1] ext.html Cycles:180 Average:73357.05 Median:20230.72 stddev:165808.40 (819.6%) stddev-sans-first:166183.31 15:11:42 INFO - PROCESS | 1635 | Values: 503.5 520.5 553.0 559.2 562.5 31709.8 32609.2 33815.7 33848.2 34074.0 34821.1 35248.0 35437.6 35441.6 43506.1 9603.8 9932.7 9936.4 9944.9 9954.4 9802.9 9885.3 9895.0 9895.2 9904.7 9020.2 9231.9 9869.1 9923.0 9944.8 10513.6 11896.2 12152.6 12188.1 12374.9 11959.0 12039.6 12049.2 12052.6 12058.2 41922.8 42224.9 42287.8 42300.7 42438.6 3477.6 3478.9 3504.0 3639.8 3813.6 32145.2 32204.0 32355.2 32700.5 32752.2 3295.8 3313.2 3325.1 3414.0 3441.1 412945.0 413206.0 413437.0 413655.0 414383.0 59717.0 60034.4 60122.7 60156.7 60167.7 35433.6 36305.3 36357.0 37666.4 37746.0 17373.5 17582.6 17582.6 17584.6 17627.8 13407.0 13495.9 13498.3 13518.7 13546.2 18951.4 19305.2 19339.8 19349.1 19511.3 6910.7 8148.0 8273.1 8342.5 8374.5 934.4 1075.5 1120.9 1134.8 1174.3 30801.7 31351.5 31365.8 31654.1 31981.7 1101.2 1137.0 1150.5 1158.7 1204.4 15833.1 16204.0 16230.4 16318.1 16483.9 745823.0 753328.0 754650.0 754970.0 755609.0 59845.8 60358.4 60397.8 60445.0 60498.8 1309.6 1342.9 1347.4 1456.2 1481.4 30392.8 31963.0 32232.7 33163.2 33203.7 51964.2 55185.0 55196.0 55337.7 55442.0 631051.0 639096.0 640561.0 640934.0 641733.0 25638.0 26400.6 26411.2 26431.7 26443.5 47780.8 47904.0 48084.5 55164.7 57688.6 40032.8 44705.0 44956.0 45961.3 46494.1 43896.3 44842.3 44902.3 45659.7 46324.5 42829.0 42916.6 43745.6 43954.1 44382.6 36310.3 36821.6 38267.8 38968.4 39089.8 27917.9 28267.6 28333.9 28338.0 28341.0 15:11:42 INFO - PROCESS | 1635 | 15:11:42 INFO - PROCESS | 1635 | [#2] jquery.html Cycles:180 Average:37451.75 Median:24788.69 stddev:110507.44 (445.8%) stddev-sans-first:110782.39 15:11:42 INFO - PROCESS | 1635 | Values: 384.3 384.6 394.2 397.3 414.2 11692.2 19711.1 20086.3 21181.7 21211.0 16517.8 18463.8 19602.0 20722.6 20894.1 5650.4 6141.8 6250.0 6256.8 6259.2 5974.5 6142.8 6173.9 6217.4 6269.0 6037.1 6170.3 6171.3 6183.1 6189.3 5927.9 6143.4 6151.1 6195.8 6203.7 5377.6 5385.5 5385.8 5387.6 5394.5 23911.8 24671.6 24905.8 25508.4 25938.7 2170.1 2306.6 2419.6 2555.6 2860.3 9980.3 10187.2 10265.3 10586.5 10647.6 1775.7 1909.9 1971.6 1977.3 2003.4 119951.0 125061.0 125805.4 127465.1 132241.0 11368.5 11395.1 11509.0 11571.9 11725.3 14593.1 14618.4 14618.9 14624.0 14627.9 7746.2 7798.9 8574.5 8605.4 8685.1 8588.7 8683.8 8705.6 8842.5 8872.0 3319.8 3795.9 4243.7 4426.6 4454.1 1794.3 1826.4 1829.1 1909.2 1911.4 846.7 900.1 908.3 938.1 949.2 20161.3 21325.5 21327.9 21337.7 21347.4 920.2 984.9 1005.4 1010.5 1054.9 11076.3 11312.5 11317.2 11342.5 11352.7 653900.0 656391.0 660902.0 670597.6 672296.0 133075.3 134831.0 137661.0 140923.0 142955.3 941.5 959.0 960.4 960.6 995.4 17794.6 18485.9 19044.1 19099.9 19152.6 55421.0 57766.0 58269.4 58951.7 59866.7 65527.3 79205.0 80336.8 81394.2 81731.6 7440.9 8076.8 8138.9 8323.6 8341.4 11917.5 12143.5 12882.5 13422.5 13439.7 11288.9 11460.8 11572.7 11649.3 11718.2 11114.7 11256.7 11342.4 11786.9 11854.2 11521.1 11550.9 11944.1 11985.7 11991.6 8119.6 8191.5 8200.9 8318.6 8335.2 8336.9 11231.7 11386.5 11407.9 11766.8 15:11:42 INFO - PROCESS | 1635 | 15:11:42 INFO - PROCESS | 1635 | [#3] mootools.html Cycles:180 Average:5849.74 Median:4817.87 stddev:3293.38 (68.4%) stddev-sans-first:3285.04 15:11:42 INFO - PROCESS | 1635 | Values: 1322.3 1524.1 1566.3 1761.3 1916.5 8037.9 8555.7 8743.3 9021.4 9084.2 8948.0 9030.6 9034.2 9038.2 9053.2 2382.8 2412.8 2415.5 2418.5 2419.4 2289.4 2319.0 2332.8 2334.1 2339.1 2014.2 2386.2 2409.4 2413.9 2421.5 2362.6 2390.4 2393.2 2395.6 2401.4 2295.3 2389.5 2391.1 2392.1 2400.0 8081.7 8332.8 8967.1 8987.4 9093.0 5295.5 5474.1 5475.3 5535.8 5542.2 3469.6 3546.9 3554.1 3631.5 3632.1 1095.1 1098.3 1106.4 1112.2 1120.0 11597.9 11720.6 11721.5 11722.7 11731.0 4780.7 4790.3 4845.4 4949.6 4959.7 10253.3 10257.1 10259.6 10265.1 10268.7 5495.3 5496.0 5503.1 5506.9 5507.5 4973.2 4986.6 5017.6 5019.9 5044.3 3692.8 3821.8 4070.7 4139.9 4185.0 1291.2 1294.3 1299.7 1301.9 1310.5 919.7 925.7 930.3 947.8 991.9 5882.5 5922.4 6039.2 6161.3 6195.1 448.8 455.7 459.7 461.2 463.5 4070.5 4091.3 4141.5 4158.5 4199.1 10497.1 10981.6 10983.4 11013.0 11014.0 10841.1 10853.5 10895.8 10914.3 10951.8 8019.0 8185.2 8302.2 8305.8 8341.2 6088.4 6095.2 6098.6 6231.7 6291.3 9925.5 10243.6 10249.4 10255.8 10282.5 10037.2 10358.1 10516.5 10541.8 10546.2 8383.7 8600.6 8600.8 8611.1 8617.5 8337.1 8339.0 8345.7 8486.3 8578.9 7656.2 7686.5 7700.0 7701.3 7724.3 7510.2 7543.7 7583.4 7595.8 7625.6 7065.8 7080.0 7132.7 7166.6 7216.6 5132.1 5141.1 5158.4 5203.3 5216.6 4979.7 5065.3 5083.5 5124.6 5243.1 15:11:42 INFO - PROCESS | 1635 | 15:11:42 INFO - PROCESS | 1635 | [#4] prototype.html Cycles:180 Average:4381.41 Median:4679.79 stddev:1388.83 (29.7%) stddev-sans-first:1358.35 15:11:42 INFO - PROCESS | 1635 | Values: 290.0 302.9 318.6 322.1 325.1 4399.0 5221.9 5326.7 5339.6 5414.3 4339.5 4564.5 4972.3 5273.4 5338.4 3388.0 4104.8 4108.5 4114.3 4123.5 4118.2 4120.8 4123.2 4124.8 4159.4 3554.0 3758.4 4010.0 4061.8 4106.6 2977.8 3667.5 3717.5 3745.7 4036.0 3499.4 3526.2 3542.8 3559.9 3562.4 5077.4 5155.9 5250.3 5264.7 5286.5 3892.3 4598.2 4604.4 4611.8 4612.2 5589.5 5590.7 5608.1 5615.1 5644.3 3707.3 3765.3 3888.5 3914.4 3924.2 4736.9 5212.0 5737.6 5765.8 5774.3 3421.2 3434.9 3769.5 3856.0 3926.2 3023.6 3504.3 3835.7 3975.1 4024.0 3835.0 4637.9 4653.0 4654.7 4659.4 4472.8 5162.5 5589.3 5700.9 5747.3 1173.6 1331.7 1334.3 1346.6 1352.6 784.5 794.0 817.5 831.4 837.7 4349.0 4455.8 4464.5 4471.5 4516.0 4063.2 4286.9 4406.4 4444.9 4812.3 3839.7 4029.7 4345.8 4376.6 4396.0 2124.8 2191.7 2323.6 2413.7 2472.7 4570.0 4691.8 4997.8 5005.8 5017.1 4902.6 4907.9 4929.9 4958.7 4963.5 4933.7 5524.5 5532.8 6036.5 6089.5 5824.3 5859.9 5872.4 5892.6 5909.9 5483.0 5754.9 5843.3 5879.6 5884.4 5251.6 5788.7 6066.7 6068.9 6075.7 3182.3 3858.5 3861.3 3869.6 3874.6 4836.5 5007.1 5811.8 5884.9 5902.8 4667.8 4767.6 5057.8 5458.7 5743.4 4740.6 5694.4 5708.8 5715.2 5715.8 5112.5 5613.5 5631.3 5645.5 5667.4 4706.7 5486.4 5629.5 5678.0 5696.0 4540.8 5109.8 5519.7 5538.4 5540.9 15:11:42 INFO - PROCESS | 1635 | 15:11:42 INFO - PROCESS | 1635 | [#5] yui.html Cycles:180 Average:25499.23 Median:21137.84 stddev:40101.74 (189.7%) stddev-sans-first:40171.02 15:11:42 INFO - PROCESS | 1635 | Values: 705.3 721.3 754.8 765.5 866.5 15970.5 16583.0 16616.1 16641.0 16685.7 14993.3 15113.5 15120.1 15129.5 15164.5 703.8 727.2 734.0 862.8 878.0 892.1 896.6 903.3 903.5 904.5 918.1 938.0 970.0 972.0 976.0 962.8 969.1 969.2 969.3 969.8 717.1 717.7 719.4 719.9 720.8 15695.5 15839.4 15846.2 15854.7 15854.7 13764.7 13817.8 13873.0 13989.7 14216.5 13435.8 13633.3 14067.2 14147.6 14388.2 4672.9 4688.3 4713.8 4840.2 4878.6 114516.3 127272.0 129146.0 129441.0 129958.0 11122.7 11175.0 11207.3 11398.0 11522.4 21111.8 21163.9 21244.2 21247.6 21464.6 8012.1 8107.7 8113.7 8156.6 8173.5 4467.6 4499.5 4638.1 4716.8 4800.8 3561.0 3641.7 3671.5 3673.1 3674.1 634.7 636.9 640.7 641.3 660.3 585.4 630.9 647.9 649.5 656.7 9464.2 9573.5 9790.7 10743.5 11066.8 636.8 646.9 719.2 720.9 735.9 4515.4 4801.8 4962.4 5013.1 5017.7 95869.0 111491.0 151488.0 166279.0 167491.2 117095.0 118712.0 123425.0 134188.3 135642.0 104707.5 113737.0 115649.0 117339.4 119305.0 8981.0 10396.4 10612.8 10689.1 10730.0 63619.0 64889.7 65790.0 66003.0 68392.7 88171.6 89454.1 90708.1 93352.1 94981.0 13225.7 13289.9 13532.7 13928.3 13952.2 15412.6 15468.4 15485.0 15528.8 15655.7 13988.2 14055.9 14287.3 14607.1 14770.8 13041.9 13333.7 13837.2 14079.4 14428.3 13311.5 13880.8 14077.3 14537.1 14987.9 11331.8 11756.7 11856.6 12114.0 12141.3 11602.2 11740.4 11998.5 12024.9 12047.2 15:11:42 INFO - PROCESS | 1635 | -------- Summary: end -------- 15:11:42 INFO - PROCESS | 1635 | 15:11:43 INFO - TEST-INFO | 1635: exit 0 15:11:43 INFO - TEST-OK | dromaeo_css | took 1114251ms 15:11:43 INFO - TEST-START | kraken 15:11:43 INFO - operating with platform_type : mac_ 15:11:43 INFO - Initialising browser for kraken test... 15:11:43 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/tmpMMEmRR/profile http://localhost:49241/getInfo.html) 15:11:45 INFO - PROCESS | 1645 | __metrics Screen width/height:1600/1200 15:11:45 INFO - PROCESS | 1645 | colorDepth:24 15:11:45 INFO - PROCESS | 1645 | Browser inner width/height: 1024/689 15:11:45 INFO - PROCESS | 1645 | __metrics 15:11:45 INFO - PROCESS | 1645 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:11:45 INFO - PROCESS | 1645 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:11:46 INFO - TEST-INFO | 1645: exit 0 15:11:46 INFO - Browser initialized. 15:11:46 INFO - Running cycle 1/1 for kraken test... 15:11:46 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/tmpMMEmRR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:11:58 INFO - PROCESS | 1647 | RSS: Main: 168914944 15:11:58 INFO - PROCESS | 1647 | 15:12:00 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 15:12:01 INFO - PROCESS | 1647 | RSS: Main: 218935296 15:12:01 INFO - PROCESS | 1647 | 15:12:04 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 15:12:04 INFO - PROCESS | 1647 | RSS: Main: 232697856 15:12:04 INFO - PROCESS | 1647 | 15:12:07 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 15:12:08 INFO - PROCESS | 1647 | RSS: Main: 330313728 15:12:08 INFO - PROCESS | 1647 | 15:12:10 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 15:12:11 INFO - PROCESS | 1647 | RSS: Main: 229347328 15:12:11 INFO - PROCESS | 1647 | 15:12:13 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:12:13 INFO - PROCESS | 1647 | RSS: Main: 230141952 15:12:13 INFO - PROCESS | 1647 | 15:12:16 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 15:12:16 INFO - PROCESS | 1647 | RSS: Main: 267620352 15:12:16 INFO - PROCESS | 1647 | 15:12:19 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 15:12:20 INFO - PROCESS | 1647 | RSS: Main: 267841536 15:12:20 INFO - PROCESS | 1647 | 15:12:23 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 15:12:23 INFO - PROCESS | 1647 | RSS: Main: 268222464 15:12:23 INFO - PROCESS | 1647 | 15:12:25 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:12:26 INFO - PROCESS | 1647 | RSS: Main: 240353280 15:12:26 INFO - PROCESS | 1647 | 15:12:27 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:12:28 INFO - PROCESS | 1647 | RSS: Main: 244551680 15:12:28 INFO - PROCESS | 1647 | 15:12:30 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:12:31 INFO - PROCESS | 1647 | RSS: Main: 251662336 15:12:31 INFO - PROCESS | 1647 | 15:12:34 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:12:34 INFO - PROCESS | 1647 | RSS: Main: 257712128 15:12:34 INFO - PROCESS | 1647 | 15:12:37 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:12:38 INFO - PROCESS | 1647 | RSS: Main: 258666496 15:12:38 INFO - PROCESS | 1647 | 15:12:40 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 15:12:40 INFO - PROCESS | 1647 | RSS: Main: 302907392 15:12:40 INFO - PROCESS | 1647 | 15:12:40 INFO - PROCESS | 1647 | __start_tp_report 15:12:40 INFO - PROCESS | 1647 | _x_x_mozilla_page_load 15:12:40 INFO - PROCESS | 1647 | _x_x_mozilla_page_load_details 15:12:40 INFO - PROCESS | 1647 | |i|pagename|runs| 15:12:40 INFO - PROCESS | 1647 | |0;ai-astar;113;113;112;110;113;113;112;112;113;113 15:12:40 INFO - PROCESS | 1647 | |1;audio-beat-detection;142;109;109;145;109;109;107;106;136;105 15:12:40 INFO - PROCESS | 1647 | |2;audio-dft;182;184;181;183;184;182;184;183;184;181 15:12:40 INFO - PROCESS | 1647 | |3;audio-fft;80;57;58;87;63;57;59;58;82;57 15:12:40 INFO - PROCESS | 1647 | |4;audio-oscillator;87;70;93;69;68;69;90;68;70;89 15:12:40 INFO - PROCESS | 1647 | |5;imaging-gaussian-blur;90;86;90;87;90;86;91;87;90;85 15:12:40 INFO - PROCESS | 1647 | |6;imaging-darkroom;96;97;96;99;97;97;99;97;98;97 15:12:40 INFO - PROCESS | 1647 | |7;imaging-desaturate;84;86;85;84;99;139;68;136;71;130 15:12:40 INFO - PROCESS | 1647 | |8;json-parse-financial;56;52;52;53;54;69;71;56;56;55 15:12:40 INFO - PROCESS | 1647 | |9;json-stringify-tinderbox;62;72;65;68;71;68;67;67;67;67 15:12:40 INFO - PROCESS | 1647 | |10;stanford-crypto-aes;84;84;83;84;84;84;85;87;124;84 15:12:40 INFO - PROCESS | 1647 | |11;stanford-crypto-ccm;144;136;142;137;131;133;134;138;167;148 15:12:40 INFO - PROCESS | 1647 | |12;stanford-crypto-pbkdf2;157;160;158;158;160;158;156;175;156;159 15:12:40 INFO - PROCESS | 1647 | |13;stanford-crypto-sha256-iterative;64;66;65;70;80;83;83;64;65;65 15:12:40 INFO - PROCESS | 1647 | __end_tp_report 15:12:40 INFO - PROCESS | 1647 | __start_cc_report 15:12:40 INFO - PROCESS | 1647 | _x_x_mozilla_cycle_collect,1920 15:12:40 INFO - PROCESS | 1647 | __end_cc_report 15:12:40 INFO - PROCESS | 1647 | __startTimestamp1484608360270__endTimestamp 15:12:40 INFO - PROCESS | 1647 | 15:12:40 INFO - PROCESS | 1647 | ------- Summary: start ------- 15:12:40 INFO - PROCESS | 1647 | Number of tests: 14 15:12:40 INFO - PROCESS | 1647 | 15:12:40 INFO - PROCESS | 1647 | [#0] ai-astar Cycles:10 Average:112.40 Median:113.00 stddev:0.97 (0.9%) stddev-sans-first:1.00 15:12:40 INFO - PROCESS | 1647 | Values: 113.0 113.0 112.0 110.0 113.0 113.0 112.0 112.0 113.0 113.0 15:12:40 INFO - PROCESS | 1647 | 15:12:40 INFO - PROCESS | 1647 | [#1] audio-beat-detection Cycles:10 Average:117.70 Median:109.00 stddev:16.28 (14.9%) stddev-sans-first:14.71 15:12:40 INFO - PROCESS | 1647 | Values: 142.0 109.0 109.0 145.0 109.0 109.0 107.0 106.0 136.0 105.0 15:12:40 INFO - PROCESS | 1647 | 15:12:40 INFO - PROCESS | 1647 | [#2] audio-dft Cycles:10 Average:182.80 Median:183.50 stddev:1.23 (0.7%) stddev-sans-first:1.27 15:12:40 INFO - PROCESS | 1647 | Values: 182.0 184.0 181.0 183.0 184.0 182.0 184.0 183.0 184.0 181.0 15:12:40 INFO - PROCESS | 1647 | 15:12:40 INFO - PROCESS | 1647 | [#3] audio-fft Cycles:10 Average:65.80 Median:61.00 stddev:12.12 (19.9%) stddev-sans-first:11.71 15:12:40 INFO - PROCESS | 1647 | Values: 80.0 57.0 58.0 87.0 63.0 57.0 59.0 58.0 82.0 57.0 15:12:40 INFO - PROCESS | 1647 | 15:12:40 INFO - PROCESS | 1647 | [#4] audio-oscillator Cycles:10 Average:77.30 Median:78.50 stddev:10.83 (13.8%) stddev-sans-first:10.91 15:12:40 INFO - PROCESS | 1647 | Values: 87.0 70.0 93.0 69.0 68.0 69.0 90.0 68.0 70.0 89.0 15:12:40 INFO - PROCESS | 1647 | 15:12:40 INFO - PROCESS | 1647 | [#5] imaging-gaussian-blur Cycles:10 Average:88.20 Median:90.00 stddev:2.20 (2.4%) stddev-sans-first:2.24 15:12:40 INFO - PROCESS | 1647 | Values: 90.0 86.0 90.0 87.0 90.0 86.0 91.0 87.0 90.0 85.0 15:12:40 INFO - PROCESS | 1647 | 15:12:40 INFO - PROCESS | 1647 | [#6] imaging-darkroom Cycles:10 Average:97.30 Median:97.00 stddev:1.06 (1.1%) stddev-sans-first:1.01 15:12:40 INFO - PROCESS | 1647 | Values: 96.0 97.0 96.0 99.0 97.0 97.0 99.0 97.0 98.0 97.0 15:12:40 INFO - PROCESS | 1647 | 15:12:40 INFO - PROCESS | 1647 | [#7] imaging-desaturate Cycles:10 Average:98.20 Median:84.00 stddev:26.84 (32.0%) stddev-sans-first:27.97 15:12:40 INFO - PROCESS | 1647 | Values: 84.0 86.0 85.0 84.0 99.0 139.0 68.0 136.0 71.0 130.0 15:12:40 INFO - PROCESS | 1647 | 15:12:40 INFO - PROCESS | 1647 | [#8] json-parse-financial Cycles:10 Average:57.40 Median:56.00 stddev:6.83 (12.2%) stddev-sans-first:7.23 15:12:40 INFO - PROCESS | 1647 | Values: 56.0 52.0 52.0 53.0 54.0 69.0 71.0 56.0 56.0 55.0 15:12:40 INFO - PROCESS | 1647 | 15:12:40 INFO - PROCESS | 1647 | [#9] json-stringify-tinderbox Cycles:10 Average:67.40 Median:67.50 stddev:2.80 (4.1%) stddev-sans-first:2.18 15:12:40 INFO - PROCESS | 1647 | Values: 62.0 72.0 65.0 68.0 71.0 68.0 67.0 67.0 67.0 67.0 15:12:40 INFO - PROCESS | 1647 | 15:12:40 INFO - PROCESS | 1647 | [#10] stanford-crypto-aes Cycles:10 Average:88.30 Median:84.00 stddev:12.59 (15.0%) stddev-sans-first:13.25 15:12:40 INFO - PROCESS | 1647 | Values: 84.0 84.0 83.0 84.0 84.0 84.0 85.0 87.0 124.0 84.0 15:12:40 INFO - PROCESS | 1647 | 15:12:40 INFO - PROCESS | 1647 | [#11] stanford-crypto-ccm Cycles:10 Average:141.00 Median:140.00 stddev:10.53 (7.5%) stddev-sans-first:11.11 15:12:40 INFO - PROCESS | 1647 | Values: 144.0 136.0 142.0 137.0 131.0 133.0 134.0 138.0 167.0 148.0 15:12:40 INFO - PROCESS | 1647 | 15:12:40 INFO - PROCESS | 1647 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.70 Median:158.50 stddev:5.56 (3.5%) stddev-sans-first:5.81 15:12:40 INFO - PROCESS | 1647 | Values: 157.0 160.0 158.0 158.0 160.0 158.0 156.0 175.0 156.0 159.0 15:12:40 INFO - PROCESS | 1647 | 15:12:40 INFO - PROCESS | 1647 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.50 Median:68.00 stddev:8.15 (12.0%) stddev-sans-first:8.30 15:12:40 INFO - PROCESS | 1647 | Values: 64.0 66.0 65.0 70.0 80.0 83.0 83.0 64.0 65.0 65.0 15:12:40 INFO - PROCESS | 1647 | -------- Summary: end -------- 15:12:40 INFO - PROCESS | 1647 | 15:12:41 INFO - TEST-INFO | 1647: exit 0 15:12:41 INFO - TEST-OK | kraken | took 57699ms 15:12:41 INFO - SUITE-END | took 1171s 15:12:41 INFO - Completed test suite (00:19:32) 15:12:41 INFO - javascript benchmark 15:12:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3434.5706786651676, 3435.484677298405, 3470.462078377849, 3479.5128681984543, 3527.8588856445726, 5647.745851436685, 5719.857003574907, 5730.770769169233, 5750.309962804464, 5758.712064396785, 5576.665400075998, 5723.4848863602265, 5768.625039372438, 5834.095715164146, 5845.152452894327, 5210.452902445236, 5250.789968401278, 5269.341332333458, 5275.657082289658, 5278.0, 5215.426303106655, 5215.71313577755, 5217.139172036609, 5344.5724342052545, 5362.088444964346, 5220.582353411718, 5265.578753699714, 5287.312649355578, 5288.682679039251, 5294.020606187848, 5281.128613778722, 5346.732663366835, 5350.866228344284, 5350.9833131705245, 5395.190721391783, 5058.317127187819, 5149.382074151088, 5252.212168174766, 5280.52475277223, 5302.019126461579, 4713.787879545429, 5640.633358831663, 5715.999700052515, 5725.599208055396, 5729.255196824428, 6270.811875643738, 6279.748810047593, 6321.051842223657, 6345.49236061114, 6366.745330186787, 6348.968255158741, 6406.519511036691, 6409.647469389181, 6411.166548348731, 6429.710663020175, 5757.88484230313, 5801.216835727208, 5814.738336774855, 5831.591788574844, 5860.296764388216, 6370.458511026522, 6406.0390941359165, 6410.583312084793, 6411.0, 6426.967865160645, 6200.410960958701, 6217.316095229521, 6221.626702397871, 6237.5321850860455, 6242.563020588515, 6119.694015299217, 6200.224971878515, 6218.098375735493, 6225.533085018642, 6334.9366506334345, 6215.844603884939, 6280.0893870389455, 6325.715342809584, 6328.0, 6331.891918914263, 6267.341929097471, 6295.37046295376, 6313.589616674902, 6318.368163183645, 6332.620042797447, 4913.77887995034, 4945.0, 4952.083864485082, 4985.850424487271, 5004.699718016931, 4484.932726009112, 4521.88695282614, 4573.49691533931, 4574.222382195035, 4595.310703394518, 5769.624974376652, 5811.912821307684, 5841.94158058414, 5844.064949608042, 5862.70686465675, 6372.267189273293, 6395.0, 6404.039394090923, 6411.2627047889155, 6411.839704007344, 5658.009848276535, 5755.424457554295, 5770.653760774283, 5794.62334948227, 5799.536037117021, 5440.42875498067, 5490.176473529003, 5491.643043202179, 5499.065158922993, 5503.064479038573, 6365.713542890581, 6368.968155159195, 6378.84052898672, 6382.106505089291, 6383.0744542042075, 6204.286507051566, 6209.5032397409, 6291.433770960452, 6372.458341041063, 6414.775482858077, 6283.748650053946, 6341.746330146742, 6345.333739957238, 6354.586951848115, 6373.203349581302, 6277.027060805583, 6300.810975670737, 6327.114204011534, 6329.955557332988, 6333.050042493663, 6348.650824204528, 6395.0, 6405.3594640535575, 6410.903836442364, 6422.133012043314, 4891.413030436371, 6067.544934130046, 6130.938690613037, 6140.416660417253, 6169.56813023084, 6190.721417536131, 6195.31851496326, 6204.13142160107, 6211.751529938932, 6214.533909956681, 6030.487408570145, 6055.545834062551, 6055.969720151547, 6063.242094738158, 6078.513718902389, 6032.487238584769, 6049.848753781191, 6049.879002420015, 6106.816795496142, 6196.225471816023, 6016.037434010537, 6017.247844019497, 6027.4876635484725, 6029.849253768691, 6061.575689701855], "value": 5769.279949085459, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [503.51159375405854, 520.5471240021183, 552.98803190162, 559.1808001278126, 562.5302872101795, 31709.84145079274, 32609.18477038075, 33815.66184338156, 33848.15379615511, 34074.0, 34821.12947176315, 35248.0, 35437.64562354382, 35441.64558354416, 43506.12987740243, 9603.80792384152, 9932.702018939442, 9936.40381577104, 9944.850827237597, 9954.352967057155, 9802.852957205612, 9885.258605604573, 9895.0, 9895.158911492532, 9904.702858914245, 9020.233280171193, 9231.86152207714, 9869.111779939803, 9922.950385248063, 9944.751381215492, 10513.632022879163, 11896.22674526153, 12152.635420937342, 12188.08589355793, 12374.876251237463, 11959.043276537943, 12039.63881083569, 12049.216800907912, 12052.638420847301, 12058.155929084967, 41922.79038604788, 42224.94437639053, 42287.78856105731, 42300.7309780704, 42438.57561424377, 3477.5826900772067, 3478.878239261639, 3503.9649603503894, 3639.7998110103936, 3813.580506144322, 32145.1963700907, 32204.033878983668, 32355.19112022218, 32700.509492357633, 32752.181195470064, 3295.802251864896, 3313.1717070732316, 3325.1022223999626, 3413.9829300853585, 3441.1397150712323, 412945.0, 413206.0, 413437.0, 413655.0, 414383.0, 59717.0, 60034.39793612397, 60122.699386503664, 60156.699216504516, 60167.69916150479, 35433.64566354355, 36305.27389452196, 36357.0, 37666.43500347497, 37746.0, 17373.47879563615, 17582.560435989202, 17582.560435989202, 17584.56038599045, 17627.823721762874, 13407.0, 13495.920326373867, 13498.325083745773, 13518.729625407634, 13546.187228766306, 18951.434986811862, 19305.227790888206, 19339.80660193408, 19349.12928918202, 19511.317103901296, 6910.654467276616, 8147.959260203779, 8273.131321211307, 8342.499450033018, 8374.49753014821, 934.3926447808979, 1075.5213929801164, 1120.9351116439416, 1134.8014097532898, 1174.307158776326, 30801.69198308033, 31351.529727054112, 31365.843170784, 31654.050378488682, 31981.68018319787, 1101.1851230089676, 1136.9772604547863, 1150.465033759306, 1158.7334912970064, 1204.3556697166973, 15833.129177895096, 16204.0, 16230.431934882223, 16318.102504362136, 16483.91758041202, 745823.0, 753328.0, 754650.0, 754970.0, 755609.0, 59845.80308393895, 60358.39641603616, 60397.79204415887, 60445.0, 60498.79002420015, 1309.6267563744286, 1342.8522862485315, 1347.4138749643937, 1456.1699831096173, 1481.3556103095189, 30392.848035759678, 31963.0, 32232.71069157301, 33163.17092072621, 33203.667963320055, 51964.22053669274, 55185.0, 55196.0, 55337.72331138318, 55442.0, 631051.0, 639096.0, 640561.0, 640934.0, 641733.0, 25638.0, 26400.603990940537, 26411.20766376935, 26431.735682642928, 26443.471130577665, 47780.7610961943, 47904.0, 48084.519154808004, 55164.72417638046, 57688.55778605569, 40032.79655636233, 44705.0, 44956.0, 45961.31058034199, 46494.070118598116, 43896.34155487734, 44842.327365088895, 44902.3264651037, 45659.71701414982, 46324.53675463202, 42829.0, 42916.570834291255, 43745.56254437415, 43954.12091758083, 44382.55617443784, 36310.27379452449, 36821.63178368289, 38267.808660956514, 38968.41547376848, 39089.80455097706, 27917.860410698628, 28267.57598635981, 28333.858330708215, 28338.0, 28341.0], "value": 20788.292064739682, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.2545461804098, 384.63651849002696, 394.22534719276615, 397.25514660012476, 414.155123547962, 11692.159392143794, 19711.112999915003, 20086.296979605715, 21181.68227476587, 21211.0, 16517.752233716503, 18463.815361846377, 19602.019899005027, 20722.585548289026, 20894.05976731047, 5650.406707295726, 6141.754329826802, 6249.968750156266, 6256.843578910541, 6259.155014073087, 5974.522038236931, 6142.785002524913, 6173.938260617381, 6217.440430361266, 6268.968655156741, 6037.124616930564, 6170.2904166021035, 6171.2594488661425, 6183.103449999748, 6189.288231853327, 5927.940720592804, 6143.354947730513, 6151.077338399231, 6195.81412557624, 6203.658798766066, 5377.5966802489575, 5385.515303622693, 5385.757640906129, 5387.595930305243, 5394.460553944614, 23911.7608823913, 24671.62992555113, 24905.750942490704, 25508.36229094269, 25938.74061259382, 2170.121100954116, 2306.5848147333472, 2419.6128619420806, 2555.5783295756178, 2860.256333353343, 9980.30137890348, 10187.235957303157, 10265.332753371007, 10586.523606437651, 10647.627333043383, 1775.7247626617896, 1909.8567607429359, 1971.5859669469428, 1977.2782934228903, 2003.4490515108316, 119951.0, 125061.0, 125805.37097314546, 127465.08802367972, 132241.0, 11368.545258189744, 11395.145364097725, 11509.043462611377, 11571.942140289244, 11725.296482211095, 14593.124412535282, 14618.415263389557, 14618.903582231374, 14624.049436786574, 14627.926860365844, 7746.186650401627, 7798.869163971192, 8574.485530868167, 8605.397622166389, 8685.131486851264, 8588.656453741905, 8683.826323473495, 8705.608247628872, 8842.46945183291, 8872.0, 3319.817410042471, 3795.91816332344, 4243.681723870722, 4426.623736982328, 4454.131444368382, 1794.2553840156188, 1826.4155470249393, 1829.0928929226907, 1909.2458478900755, 1911.4074636862617, 846.7417437681567, 900.1052783889818, 908.3006085314271, 938.1041105743998, 949.1742184299566, 20161.29435469781, 21325.46686332823, 21327.93360332008, 21337.67993480099, 21347.359579212647, 920.2040235196507, 984.8768903887014, 1005.4017859373661, 1010.4846528270635, 1054.9050585447346, 11076.280041797418, 11312.547498100148, 11317.151213659008, 11342.546298147981, 11352.716182095513, 653900.0, 656391.0, 660902.0, 670597.6470117618, 672296.0, 133075.33462332626, 134831.0, 137661.0, 140923.0, 142955.2852235732, 941.5151197133482, 959.0, 960.4477425480377, 960.5533426956499, 995.3579940938055, 17794.644107117525, 18485.9075704626, 19044.143013564146, 19099.94950277748, 19152.61694766125, 55421.0, 57766.0, 58269.35835465826, 58951.705241473515, 59866.70066649639, 65527.344726552124, 79205.0, 80336.79494807699, 81394.18605814103, 81731.59134204291, 7440.851182976418, 8076.83846323082, 8138.87791683137, 8323.625436855476, 8341.374396920133, 11917.463714133059, 12143.514259429878, 12882.549110781078, 13422.530211442552, 13439.664008399868, 11288.9435552825, 11460.82808757886, 11572.710682233012, 11649.272232885396, 11718.179727419, 11114.722131946766, 11256.662300131009, 11342.376169310766, 11786.882131178578, 11854.170208085696, 11521.135914806255, 11550.94224528872, 11944.104192185447, 11985.700357490783, 11991.64025079249, 8119.5534245617055, 8191.467554608931, 8200.876986845084, 8318.625661845352, 8335.166483351859, 8336.916630833857, 11231.66305010851, 11386.544538218379, 11407.885921140682, 11766.82349764737], "value": 9715.902166038632, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1322.266142291028, 1524.0703171065652, 1566.3029951671508, 1761.2690733345662, 1916.492129585659, 8037.919620803797, 8555.700550480728, 8743.300535957116, 9021.36850420471, 9084.227840633537, 8947.955260223689, 9030.638774449031, 9034.232090272335, 9038.18656320931, 9053.230475409582, 2382.7617238276207, 2412.7707867752624, 2415.516896620683, 2418.4921166554955, 2419.383057320381, 2289.3589794857467, 2318.988405057981, 2332.7667233276707, 2334.124703236286, 2339.0526836631107, 2014.21445636202, 2386.176769014687, 2409.3856066702965, 2413.8672373019476, 2421.503591763693, 2362.574736547421, 2390.3665528634924, 2393.2102406206086, 2395.64065390192, 2401.351635058542, 2295.2999335202758, 2389.4862604539935, 2391.1391898916377, 2392.138830021191, 2400.0399840063938, 8081.676732930676, 8332.791680207984, 8967.148120928501, 8987.37088403812, 9093.0, 5295.549878260353, 5474.069408200576, 5475.315585551806, 5535.806246781383, 5542.224088627595, 3469.60099588548, 3546.8896006875866, 3554.0759402555523, 3631.4734363517405, 3632.0919770057485, 1095.1293721491434, 1098.3300186885992, 1106.397013627575, 1112.238116889933, 1119.9888001119966, 11597.942010289895, 11720.648380548597, 11721.531138754439, 11722.70693232676, 11730.999999999915, 4780.665353425296, 4790.329353890458, 4845.418549773979, 4949.57928576075, 4959.677620954626, 10253.33353332031, 10257.128144107834, 10259.640912568024, 10265.12746416563, 10268.691939241835, 5495.2856128703015, 5495.972520137374, 5503.11950087984, 5506.91739623898, 5507.531859791962, 4973.179425394769, 4986.576141028053, 5017.623678224148, 5019.949800501949, 5044.2937988681615, 3692.778433294011, 3821.8280177392085, 4070.6946978976694, 4139.917201656011, 4184.979075104605, 1291.2059083663667, 1294.2752058847075, 1299.7205600795874, 1301.8828305452366, 1310.5282098444552, 919.6548800558548, 925.6621333213328, 930.3069213435898, 947.8436058050345, 991.9305648604673, 5882.529397648178, 5922.437368449991, 6039.184710064085, 6161.291451483047, 6195.101710251988, 448.8025268881682, 455.66053290298277, 459.68970944612255, 461.1675924955488, 463.4623836349818, 4070.531888832763, 4091.284025295561, 4141.544430112685, 4158.459400277945, 4199.118185181146, 10497.107745841537, 10981.560737570568, 10983.39591322469, 11013.00882920541, 11013.953674400918, 10841.13270938323, 10853.51159197838, 10895.83656245157, 10914.345139291669, 10951.83572246417, 8018.959905200437, 8185.181481851886, 8302.211289927447, 8305.837182794414, 8341.16588341161, 6088.360722124113, 6095.2323826091715, 6098.573099882966, 6231.688415579112, 6291.276503202191, 9925.454100024279, 10243.641472548425, 10249.436281004617, 10255.84616230772, 10282.537285822305, 10037.247206459691, 10358.119559837498, 10516.526756296138, 10541.841872372073, 10546.156307495228, 8383.664653413794, 8600.612972416131, 8600.78498037554, 8611.13888611134, 8617.48295102296, 8337.124601916712, 8339.0, 8345.666173352998, 8486.278666313432, 8578.914210858062, 7656.196099409704, 7686.461947663834, 7699.961500192463, 7701.345385642059, 7724.304812566896, 7510.173880873209, 7543.660535275816, 7583.355414789805, 7595.810104747426, 7625.618719063914, 7065.788026359218, 7080.0, 7132.714691412493, 7166.570005799668, 7216.5670059796585, 5132.12753831842, 5141.126008578476, 5158.3552055993005, 5203.323567936144, 5216.582673386196, 4979.701217926936, 5065.290859279778, 5083.46623604531, 5124.564412024871, 5243.056249875059], "value": 4612.441323190122, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [289.99275018124547, 302.8939871045133, 318.5747027717997, 322.1190045226306, 325.1043375500496, 4398.954486163933, 5221.859037794505, 5326.668332916771, 5339.599530035248, 5414.3232095988005, 4339.544347843478, 4564.475085365184, 4972.30387745715, 5273.414078426668, 5338.3860856001575, 3387.9830600847085, 4104.774237416941, 4108.506979162505, 4114.259433302004, 4123.546409894909, 4118.176364727066, 4120.75275483472, 4123.195976784528, 4124.803806896011, 4159.376093585956, 3554.022643772957, 3758.4174452959833, 4009.9799501002453, 4061.8172182251724, 4106.609872062149, 2977.783993287266, 3667.468217108518, 3717.5353080864893, 3745.7077308328585, 4036.0313524753847, 3499.4400895856797, 3526.188976535386, 3542.8405721742583, 3559.893203203882, 3562.412201986669, 5077.39071311445, 5155.922661160085, 5250.291210686547, 5264.684118952875, 5286.524212820865, 3892.260470510594, 4598.229681572619, 4604.401427814396, 4611.83858564952, 4612.215923293048, 5589.524890384322, 5590.664560126364, 5608.130739735348, 5615.073512870372, 5644.322681278232, 3707.3141468828353, 3765.3410653135593, 3888.51393575803, 3914.432407300954, 3924.1563063941103, 4736.928946065812, 5211.973940130313, 5737.627054241502, 5765.827025189251, 5774.335951365605, 3421.2473255883665, 3434.9313013740084, 3769.5476542815036, 3856.014152711356, 3926.1755031443718, 3023.6220472440946, 3504.3166582516674, 3835.6547910688173, 3975.1453437511072, 4023.959760402417, 3834.9808250958567, 4637.907241855144, 4652.976735116303, 4654.650901182425, 4659.440867095903, 4472.776361181928, 5162.5095615916425, 5589.329280486368, 5700.9429905701245, 5747.252857128547, 1173.565780661161, 1331.7415042784476, 1334.3194970564887, 1346.5556366399064, 1352.5604178641784, 784.5292824305371, 793.9801504962306, 817.4713286154928, 831.4096991136361, 837.6691206973211, 4349.043210493686, 4455.836356187078, 4464.464264288241, 4471.485779135376, 4515.9774201128785, 4063.22798668258, 4286.935695964501, 4406.444262327842, 4444.933326000112, 4812.302216178635, 3839.6928245740833, 4029.7179197456485, 4345.847895323648, 4376.627986621173, 4395.956040439619, 2124.8087672109586, 2191.6849890065832, 2323.6001853300536, 2413.674153989224, 2472.678551788256, 4569.994601187734, 4691.7654117294, 4997.825076122391, 5005.799768009311, 5017.096922553902, 4902.6416904420585, 4907.852764417074, 4929.901401971941, 4958.677685950402, 4963.45402005779, 4933.654644174945, 5524.530414914777, 5532.75226348899, 6036.464684832293, 6089.54328425361, 5824.271966004249, 5859.949017843721, 5872.383399742966, 5892.616979896465, 5909.881802364014, 5482.972585137049, 5754.942450575608, 5843.312076444883, 5879.559033072622, 5884.382139875252, 5251.553617942518, 5788.739506722123, 6066.666333351708, 6068.939310606837, 6075.726592303268, 3182.3292771294327, 3858.4983952087173, 3861.2856621523983, 3869.574346821791, 3874.5544262409057, 4836.46798852133, 5007.148784706682, 5811.767529298781, 5884.941150588439, 5902.822915312548, 4667.813287468599, 4767.594754445772, 5057.848264552069, 5458.699771512446, 5743.396943320891, 4740.5733483986605, 5694.402087780889, 5708.828735137787, 5715.17130016137, 5715.771369145187, 5112.463191364853, 5613.46672066153, 5631.2960879890015, 5645.548356131418, 5667.404922483245, 4706.717596944058, 5486.396496385315, 5629.54963602919, 5677.968642264039, 5695.971520142372, 4540.750258735669, 5109.824740309676, 5519.724013799374, 5538.44615538459, 5540.916886246629], "value": 3942.8173676737874, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [705.3017512662466, 721.2931327299243, 754.7697952124603, 765.4565258666347, 866.4541338956457, 15970.520884373473, 16583.005019698812, 16616.08611526367, 16641.0, 16685.66628667426, 14993.250337483138, 15113.54659360221, 15120.092794432314, 15129.546113616581, 15164.54506364808, 703.7994171661078, 727.1564984617844, 734.0017576096504, 862.7756783236372, 877.9780505487366, 892.0633334998225, 896.5875697179305, 903.286403741047, 903.4985583001431, 904.4934836491553, 918.1186061381082, 938.0431959401407, 970.0154343341515, 971.9951400243024, 975.9609615615367, 962.8459446488528, 969.0648524174135, 969.2391472693902, 969.3166317746008, 969.7575606098476, 717.1072015340934, 717.720089165226, 719.4352433339803, 719.8704233238016, 720.7549433192739, 15695.450659226986, 15839.366425342972, 15846.207689615474, 15854.682906341925, 15854.682906341925, 13764.65588360289, 13817.792733109012, 13873.0, 13989.650258743512, 14216.50242241527, 13435.798463023062, 13633.250171240577, 14067.155970641794, 14147.646308842259, 14388.208648524327, 4672.929906051412, 4688.29675548667, 4713.811447542129, 4840.177169881129, 4878.56092951636, 114516.28225576623, 127272.0, 129146.0, 129441.0, 129958.0, 11122.721931951604, 11175.0, 11207.271527350696, 11398.0, 11522.423878806027, 21111.78888211098, 21163.894180529307, 21244.150233990775, 21247.575048499253, 21464.57070858574, 8012.0786109596975, 8107.716229931924, 8113.716019939392, 8156.632951517196, 8173.468724532886, 4467.642588592905, 4499.505054444008, 4638.141943740419, 4716.764161791965, 4800.807967681323, 3561.0, 3641.6540428659237, 3671.541057367829, 3673.081729567608, 3674.0814796300924, 634.7143785296635, 636.8662580857979, 640.7276907314373, 641.2913730328014, 660.2704012066694, 585.4175095779726, 630.8738252349549, 647.9190101237346, 649.4966401039138, 656.6618191631313, 9464.242860571137, 9573.473458959825, 9790.706278811647, 10743.462826858626, 11066.778664426667, 636.8315884413579, 646.9357906244296, 719.2124623537219, 720.9042255771199, 735.874901266786, 4515.392254220456, 4801.783919723621, 4962.354893863775, 5013.1227035268685, 5017.724025178651, 95869.0, 111491.0, 151488.0, 166279.0, 167491.16254418893, 117094.9999999983, 118712.0, 123425.0, 134188.32905835408, 135641.96537051952, 104707.4764626172, 113737.0, 115649.0, 117339.41330293294, 119304.99999999827, 8980.955095224483, 10396.376217426978, 10612.787744244917, 10689.144868410664, 10729.980651838063, 63619.0, 64889.67555162194, 65790.01314980183, 66003.0, 68392.6580367095, 88171.55914220645, 89454.10545894718, 90708.09291906997, 93352.13295733911, 94981.0, 13225.735485290048, 13289.867101328862, 13532.661683457993, 13928.303584820922, 13952.16287022782, 15412.614684632525, 15468.381264749283, 15485.0, 15528.767068494208, 15655.68688626244, 13988.230647314496, 14055.945804064531, 14287.285635718381, 14607.123572585679, 14770.778438323649, 13041.934790325988, 13333.666658333232, 13837.169769813843, 14079.436822526985, 14428.278586070865, 13311.534096306583, 13880.791788122984, 14077.296135192995, 14537.055091419024, 14987.925060374628, 11331.810159933419, 11756.70608234801, 11856.644300670994, 12114.030877529953, 12141.271523708252, 11602.245854019462, 11740.41297935117, 11998.460069297078, 12024.939875300568, 12047.216930899463], "value": 8192.573496293784, "unit": "score"}], "name": "dromaeo_css", "value": 7469.160405465999, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 112.0, 110.0, 113.0, 113.0, 112.0, 112.0, 113.0, 113.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 109.0, 109.0, 145.0, 109.0, 109.0, 107.0, 106.0, 136.0, 105.0], "value": 117.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 184.0, 181.0, 183.0, 184.0, 182.0, 184.0, 183.0, 184.0, 181.0], "value": 182.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 57.0, 58.0, 87.0, 63.0, 57.0, 59.0, 58.0, 82.0, 57.0], "value": 65.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 70.0, 93.0, 69.0, 68.0, 69.0, 90.0, 68.0, 70.0, 89.0], "value": 77.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 86.0, 90.0, 87.0, 90.0, 86.0, 91.0, 87.0, 90.0, 85.0], "value": 88.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 99.0, 97.0, 97.0, 99.0, 97.0, 98.0, 97.0], "value": 97.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 85.0, 84.0, 99.0, 139.0, 68.0, 136.0, 71.0, 130.0], "value": 98.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 52.0, 52.0, 53.0, 54.0, 69.0, 71.0, 56.0, 56.0, 55.0], "value": 57.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 72.0, 65.0, 68.0, 71.0, 68.0, 67.0, 67.0, 67.0, 67.0], "value": 67.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 83.0, 84.0, 84.0, 84.0, 85.0, 87.0, 124.0, 84.0], "value": 88.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 136.0, 142.0, 137.0, 131.0, 133.0, 134.0, 138.0, 167.0, 148.0], "value": 141.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 160.0, 158.0, 158.0, 160.0, 158.0, 156.0, 175.0, 156.0, 159.0], "value": 159.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 65.0, 70.0, 80.0, 83.0, 83.0, 64.0, 65.0, 65.0], "value": 70.5, "unit": "score"}], "name": "kraken", "value": 1424.0, "alertThreshold": 2.0}]} 15:12:41 INFO - Return code: 0 15:12:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:12:41 INFO - # TBPL SUCCESS # 15:12:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:12:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:12:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:12:41 INFO - 2017-01-16 15:12:41.589 screenresolution[1651:9737] starting screenresolution argv=screenresolution get 15:12:41 INFO - 2017-01-16 15:12:41.592 screenresolution[1651:9737] Display 0: 1600x1200x32@60 15:12:41 INFO - 2017-01-16 15:12:41.597 screenresolution[1652:9740] starting screenresolution argv=screenresolution list 15:12:41 INFO - Available Modes on Display 0 15:12:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:12:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:12:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:12:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:12:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:12:41 INFO - Intel Iris: 15:12:41 INFO - Chipset Model: Intel Iris 15:12:41 INFO - Type: GPU 15:12:41 INFO - Bus: Built-In 15:12:41 INFO - VRAM (Dynamic, Max): 1536 MB 15:12:41 INFO - Vendor: Intel (0x8086) 15:12:41 INFO - Device ID: 0x0a2e 15:12:41 INFO - Revision ID: 0x0009 15:12:41 INFO - Displays: 15:12:41 INFO - Display: 15:12:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:12:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:12:41 INFO - Display Serial Number: 1600x1200 60 15:12:41 INFO - Main Display: Yes 15:12:41 INFO - Mirror: Off 15:12:41 INFO - Online: Yes 15:12:41 INFO - Rotation: Supported 15:12:41 INFO - Return code: 0 15:12:41 INFO - Running post-action listener: _resource_record_post_action 15:12:41 INFO - [mozharness: 2017-01-16 23:12:41.831840Z] Finished run-tests step (success) 15:12:41 INFO - Running post-run listener: _resource_record_post_run 15:12:41 INFO - Total resource usage - Wall time: 1195s; CPU: 53.0%; Read bytes: 37843968; Write bytes: 494674944; Read time: 243; Write time: 1561 15:12:41 INFO - TinderboxPrint: CPU usage
53.5% 15:12:41 INFO - TinderboxPrint: I/O read bytes / time
37,843,968 / 243 15:12:41 INFO - TinderboxPrint: I/O write bytes / time
494,674,944 / 1,561 15:12:41 INFO - TinderboxPrint: CPU idle
2,224.1 (46.5%) 15:12:41 INFO - TinderboxPrint: CPU system
958.9 (20.1%) 15:12:41 INFO - TinderboxPrint: CPU user
1,598.6 (33.4%) 15:12:41 INFO - TinderboxPrint: Swap in / out
233,578,496 / 0 15:12:41 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 192786944; Write bytes: 186097664; Read time: 17498; Write time: 399 15:12:41 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 35771392; Write bytes: 297231360; Read time: 222; Write time: 1124 15:12:42 INFO - Running post-run listener: _upload_blobber_files 15:12:42 INFO - Blob upload gear active. 15:12:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:12:42 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 15:12:42 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'] 15:12:42 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 15:12:42 INFO - (blobuploader) - INFO - Open directory for files ... 15:12:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:12:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:12:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:12:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:12:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:12:44 INFO - (blobuploader) - INFO - Done attempting. 15:12:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:12:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:12:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:12:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:12:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:12:45 INFO - (blobuploader) - INFO - Done attempting. 15:12:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:12:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:12:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:12:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:12:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:12:47 INFO - (blobuploader) - INFO - Done attempting. 15:12:47 INFO - (blobuploader) - INFO - Iteration through files over. 15:12:47 INFO - Return code: 0 15:12:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:12:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:12:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dac5dad9f9273ff7be7dce739fdf43e21d3d38dee163e7d41e44f2ad32f35c0601dbfa8ab728972ec14a8875097d0e943c8650a1051992be273b61a5cb8e7028", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7644a821f30fdf62fed8a702cf27b9aecddd221cdd9e2580d96bcbff5e8f7e94f72c079da2a1efaf1baa3ecbfb5ca4d386b9a7ce071447c14b269d7e091057a8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b4609b38fff89c0f7eee83155dbba777fdfac6478cdb28a1c34ae57e2cfb5da29f12fb69b004547fda3096477da3537c05944016cca91266fa465b6542768467"} 15:12:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:12:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:12:47 INFO - Contents: 15:12:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dac5dad9f9273ff7be7dce739fdf43e21d3d38dee163e7d41e44f2ad32f35c0601dbfa8ab728972ec14a8875097d0e943c8650a1051992be273b61a5cb8e7028", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7644a821f30fdf62fed8a702cf27b9aecddd221cdd9e2580d96bcbff5e8f7e94f72c079da2a1efaf1baa3ecbfb5ca4d386b9a7ce071447c14b269d7e091057a8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b4609b38fff89c0f7eee83155dbba777fdfac6478cdb28a1c34ae57e2cfb5da29f12fb69b004547fda3096477da3537c05944016cca91266fa465b6542768467"} 15:12:47 INFO - Running post-run listener: copy_logs_to_upload_dir 15:12:47 INFO - Copying logs to upload dir... 15:12:47 INFO - mkdir: /builds/slave/test/build/upload/logs 15:12:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.586100 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-01-16 15:12:47.675951) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-16 15:12:47.679455) ========= 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.4TrqDQPz60/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.8gyJQL4ltv/Listeners TMPDIR=/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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/dac5dad9f9273ff7be7dce739fdf43e21d3d38dee163e7d41e44f2ad32f35c0601dbfa8ab728972ec14a8875097d0e943c8650a1051992be273b61a5cb8e7028", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7644a821f30fdf62fed8a702cf27b9aecddd221cdd9e2580d96bcbff5e8f7e94f72c079da2a1efaf1baa3ecbfb5ca4d386b9a7ce071447c14b269d7e091057a8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b4609b38fff89c0f7eee83155dbba777fdfac6478cdb28a1c34ae57e2cfb5da29f12fb69b004547fda3096477da3537c05944016cca91266fa465b6542768467"} build_url:https://queue.taskcluster.net/v1/task/VOUMscFtQW-27brDEh90Mg/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011031 build_url: 'https://queue.taskcluster.net/v1/task/VOUMscFtQW-27brDEh90Mg/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/dac5dad9f9273ff7be7dce739fdf43e21d3d38dee163e7d41e44f2ad32f35c0601dbfa8ab728972ec14a8875097d0e943c8650a1051992be273b61a5cb8e7028", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7644a821f30fdf62fed8a702cf27b9aecddd221cdd9e2580d96bcbff5e8f7e94f72c079da2a1efaf1baa3ecbfb5ca4d386b9a7ce071447c14b269d7e091057a8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b4609b38fff89c0f7eee83155dbba777fdfac6478cdb28a1c34ae57e2cfb5da29f12fb69b004547fda3096477da3537c05944016cca91266fa465b6542768467"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-16 15:12:47.714625) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 15:12:47.714988) ========= 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.4TrqDQPz60/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.8gyJQL4ltv/Listeners TMPDIR=/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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.004992 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 15:12:47.763961) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-16 15:12:47.764291) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-16 15:12:47.764602) ========= ========= Total master_lag: 0.18 =========