builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0023 starttime: 1490670456.08 results: success (0) buildid: 20170327184522 builduid: 83b0a9b6517c40cf907af40a0ab93f4a revision: db2babffcafbd6b5b47a8c5813005838eb171a90 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-27 20:07:36.079664) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-27 20:07:36.080080) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-27 20:07:36.080366) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-27 20:07:36.107266) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 20:07:36.107589) ========= 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.2qL2Khrcbr/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.5E2o71iXbO/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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-03-27 20:07:36-- 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% 13.4M=0.001s 2017-03-27 20:07:36 (13.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122384 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 20:07:36.257524) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 20:07:36.258292) ========= 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.2qL2Khrcbr/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.5E2o71iXbO/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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.037145 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 20:07:36.322435) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-27 20:07:36.322785) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev db2babffcafbd6b5b47a8c5813005838eb171a90 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev db2babffcafbd6b5b47a8c5813005838eb171a90 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2qL2Khrcbr/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.5E2o71iXbO/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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-03-27 20:07:36,429 truncating revision to first 12 chars 2017-03-27 20:07:36,429 Setting DEBUG logging. 2017-03-27 20:07:36,429 attempt 1/10 2017-03-27 20:07:36,429 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/db2babffcafb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-27 20:07:38,076 unpacking tar archive at: mozilla-aurora-db2babffcafb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.921252 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-27 20:07:38.267994) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-27 20:07:38.268335) ========= script_repo_revision: db2babffcafbd6b5b47a8c5813005838eb171a90 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-27 20:07:38.268707) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-27 20:07:38.268966) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-27 20:07:38.288537) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2017-03-27 20:07:38.288905) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2qL2Khrcbr/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.5E2o71iXbO/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 20:07:38 INFO - MultiFileLogger online at 20170327 20:07:38 in /builds/slave/test 20:07:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 20:07:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:07:38 INFO - {'append_to_log': False, 20:07:38 INFO - 'base_work_dir': '/builds/slave/test', 20:07:38 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 20:07:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:07:38 INFO - 'branch': 'Mozilla-Aurora', 20:07:38 INFO - 'buildbot_json_path': 'buildprops.json', 20:07:38 INFO - 'config_files': ('talos/mac_config.py',), 20:07:38 INFO - 'default_actions': ('clobber', 20:07:38 INFO - 'read-buildbot-config', 20:07:38 INFO - 'download-and-extract', 20:07:38 INFO - 'populate-webroot', 20:07:38 INFO - 'create-virtualenv', 20:07:38 INFO - 'install', 20:07:38 INFO - 'run-tests'), 20:07:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:07:38 INFO - 'download_minidump_stackwalk': True, 20:07:38 INFO - 'download_symbols': 'ondemand', 20:07:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:07:38 INFO - 'tooltool.py': '/tools/tooltool.py', 20:07:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:07:38 INFO - '/tools/misc-python/virtualenv.py')}, 20:07:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:07:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:07:38 INFO - 'gecko_profile': False, 20:07:38 INFO - 'gecko_profile_interval': 0, 20:07:38 INFO - 'installer_path': 'installer.exe', 20:07:38 INFO - 'log_level': 'info', 20:07:38 INFO - 'log_name': 'talos', 20:07:38 INFO - 'log_to_console': True, 20:07:38 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:07:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:07:38 INFO - 'opt_config_files': (), 20:07:38 INFO - 'pip_index': False, 20:07:38 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:07:38 INFO - 'cmd': ('bash', 20:07:38 INFO - '-c', 20:07:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:07:38 INFO - 'enabled': True, 20:07:38 INFO - 'halt_on_failure': False, 20:07:38 INFO - 'name': 'check_screen_resolution'},), 20:07:38 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:07:38 INFO - 'cmd': ('bash', 20:07:38 INFO - '-c', 20:07:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:07:38 INFO - 'enabled': True, 20:07:38 INFO - 'halt_on_failure': False, 20:07:38 INFO - 'name': 'check_screen_resolution'},), 20:07:38 INFO - 'run_cmd_checks_enabled': True, 20:07:38 INFO - 'suite': 'dromaeojs', 20:07:38 INFO - 'system_bits': '32', 20:07:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:07:38 INFO - 'title': 't-yosemite-r7-0023', 20:07:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:07:38 INFO - 'use_talos_json': True, 20:07:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:07:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:07:38 INFO - 'work_dir': 'build'} 20:07:38 INFO - [mozharness: 2017-03-28 03:07:38.506987Z] Running clobber step. 20:07:38 INFO - Running pre-action listener: _resource_record_pre_action 20:07:38 INFO - Running main action method: clobber 20:07:38 INFO - rmtree: /builds/slave/test/build 20:07:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:07:40 INFO - Running post-action listener: _resource_record_post_action 20:07:40 INFO - [mozharness: 2017-03-28 03:07:40.978313Z] Finished clobber step (success) 20:07:40 INFO - [mozharness: 2017-03-28 03:07:40.978462Z] Running read-buildbot-config step. 20:07:40 INFO - Running pre-action listener: _resource_record_pre_action 20:07:40 INFO - Running main action method: read_buildbot_config 20:07:40 INFO - Using buildbot properties: 20:07:40 INFO - { 20:07:40 INFO - "project": "", 20:07:40 INFO - "product": "firefox", 20:07:40 INFO - "script_repo_revision": "production", 20:07:40 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 20:07:40 INFO - "repository": "", 20:07:40 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 20:07:40 INFO - "buildid": "20170327184522", 20:07:40 INFO - "pgo_build": "False", 20:07:40 INFO - "basedir": "/builds/slave/test", 20:07:40 INFO - "buildnumber": 21, 20:07:40 INFO - "slavename": "t-yosemite-r7-0023", 20:07:40 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 20:07:40 INFO - "platform": "yosemite_r7", 20:07:40 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 20:07:40 INFO - "branch": "mozilla-aurora", 20:07:40 INFO - "repo_path": "releases/mozilla-aurora", 20:07:40 INFO - "revision": "db2babffcafbd6b5b47a8c5813005838eb171a90", 20:07:40 INFO - "stage_platform": "macosx64", 20:07:40 INFO - "builduid": "83b0a9b6517c40cf907af40a0ab93f4a", 20:07:40 INFO - "slavebuilddir": "test" 20:07:40 INFO - } 20:07:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/OLagjjlQTVOVUc5rVT3oWw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 20:07:40 INFO - Running post-action listener: _resource_record_post_action 20:07:40 INFO - [mozharness: 2017-03-28 03:07:40.982015Z] Finished read-buildbot-config step (success) 20:07:40 INFO - [mozharness: 2017-03-28 03:07:40.982123Z] Running download-and-extract step. 20:07:40 INFO - Running pre-action listener: _resource_record_pre_action 20:07:40 INFO - Running main action method: download_and_extract 20:07:40 INFO - mkdir: /builds/slave/test/build/tests 20:07:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:07:40 INFO - trying https://queue.taskcluster.net/v1/task/OLagjjlQTVOVUc5rVT3oWw/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 20:07:40 INFO - Downloading https://queue.taskcluster.net/v1/task/OLagjjlQTVOVUc5rVT3oWw/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 20:07:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OLagjjlQTVOVUc5rVT3oWw/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json'}, attempt #1 20:07:42 INFO - Downloaded 1199 bytes. 20:07:42 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 20:07:42 INFO - Using the following test package requirements: 20:07:42 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 20:07:42 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 20:07:42 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 20:07:42 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 20:07:42 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 20:07:42 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 20:07:42 INFO - u'jsshell-mac.zip'], 20:07:42 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 20:07:42 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 20:07:42 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 20:07:42 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 20:07:42 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 20:07:42 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 20:07:42 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 20:07:42 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 20:07:42 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 20:07:42 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 20:07:42 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 20:07:42 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 20:07:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OLagjjlQTVOVUc5rVT3oWw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 20:07:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OLagjjlQTVOVUc5rVT3oWw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 20:07:42 INFO - Fetch https://queue.taskcluster.net/v1/task/OLagjjlQTVOVUc5rVT3oWw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 20:07:44 INFO - Expected file size: 51787824 20:07:44 INFO - Obtained file size: 51787824 20:08:00 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip', u'firefox-54.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 20:08:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OLagjjlQTVOVUc5rVT3oWw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 20:08:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OLagjjlQTVOVUc5rVT3oWw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 20:08:00 INFO - Fetch https://queue.taskcluster.net/v1/task/OLagjjlQTVOVUc5rVT3oWw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 20:08:02 INFO - Expected file size: 51787824 20:08:02 INFO - Obtained file size: 51787824 20:08:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OLagjjlQTVOVUc5rVT3oWw/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 20:08:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OLagjjlQTVOVUc5rVT3oWw/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 20:08:17 INFO - Fetch https://queue.taskcluster.net/v1/task/OLagjjlQTVOVUc5rVT3oWw/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 20:08:18 INFO - Expected file size: 14404438 20:08:18 INFO - Obtained file size: 14404438 20:08: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')]} 20:08:18 INFO - trying https://queue.taskcluster.net/v1/task/OLagjjlQTVOVUc5rVT3oWw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 20:08:18 INFO - Downloading https://queue.taskcluster.net/v1/task/OLagjjlQTVOVUc5rVT3oWw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 20:08:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OLagjjlQTVOVUc5rVT3oWw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg'}, attempt #1 20:08:20 INFO - Downloaded 74670029 bytes. 20:08:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OLagjjlQTVOVUc5rVT3oWw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 20:08:20 INFO - mkdir: /builds/slave/test/properties 20:08:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:08:20 INFO - Writing to file /builds/slave/test/properties/build_url 20:08:20 INFO - Contents: 20:08:20 INFO - build_url:https://queue.taskcluster.net/v1/task/OLagjjlQTVOVUc5rVT3oWw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 20:08:21 INFO - Running post-action listener: _resource_record_post_action 20:08:21 INFO - Running post-action listener: set_extra_try_arguments 20:08:21 INFO - [mozharness: 2017-03-28 03:08:21.105175Z] Finished download-and-extract step (success) 20:08:21 INFO - [mozharness: 2017-03-28 03:08:21.105296Z] Running populate-webroot step. 20:08:21 INFO - Running pre-action listener: _resource_record_pre_action 20:08:21 INFO - Running main action method: populate_webroot 20:08:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:08:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:08:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:08:21 INFO - '--tppagecycles', 20:08:21 INFO - '7'], 20:08:21 INFO - 'tests': ['tsvgm']}}, 20:08:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:08:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:08:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:08:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:08:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:08:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:08:21 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 20:08:21 INFO - 'talos_options': ['--disable-e10s'], 20:08:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:08:21 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 20:08:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:08:21 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 20:08:21 INFO - 'talos_options': ['--disable-e10s'], 20:08:21 INFO - 'tests': ['damp', 'tps']}, 20:08:21 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 20:08:21 INFO - 'tests': ['damp', 'tps']}, 20:08:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:08:21 INFO - 'tests': ['dromaeo_dom']}, 20:08:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:08:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:08:21 INFO - 'tests': ['basic_compositor_video']}, 20:08:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:08:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:08:21 INFO - 'tests': ['a11yr', 20:08:21 INFO - 'ts_paint', 20:08:21 INFO - 'tpaint', 20:08:21 INFO - 'sessionrestore', 20:08:21 INFO - 'sessionrestore_no_auto_restore', 20:08:21 INFO - 'tabpaint']}, 20:08:21 INFO - 'other-e10s': {'tests': ['a11yr', 20:08:21 INFO - 'ts_paint', 20:08:21 INFO - 'tpaint', 20:08:21 INFO - 'sessionrestore', 20:08:21 INFO - 'sessionrestore_no_auto_restore', 20:08:21 INFO - 'tabpaint']}, 20:08:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:08:21 INFO - 'ts_paint', 20:08:21 INFO - 'tpaint', 20:08:21 INFO - 'sessionrestore', 20:08:21 INFO - 'sessionrestore_no_auto_restore', 20:08:21 INFO - 'tabpaint']}, 20:08:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:08:21 INFO - 'ts_paint', 20:08:21 INFO - 'tpaint', 20:08:21 INFO - 'sessionrestore', 20:08:21 INFO - 'sessionrestore_no_auto_restore', 20:08:21 INFO - 'tabpaint']}, 20:08:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:08:21 INFO - 'tests': ['a11yr', 20:08:21 INFO - 'ts_paint', 20:08:21 INFO - 'tpaint', 20:08:21 INFO - 'sessionrestore', 20:08:21 INFO - 'sessionrestore_no_auto_restore', 20:08:21 INFO - 'tabpaint']}, 20:08:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:08:21 INFO - 'tests': ['a11yr', 20:08:21 INFO - 'ts_paint', 20:08:21 INFO - 'tpaint', 20:08:21 INFO - 'sessionrestore', 20:08:21 INFO - 'sessionrestore_no_auto_restore', 20:08:21 INFO - 'tabpaint']}, 20:08:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:08:21 INFO - 'tests': ['tsvgx', 20:08:21 INFO - 'tsvgr_opacity', 20:08:21 INFO - 'tart', 20:08:21 INFO - 'tscrollx', 20:08:21 INFO - 'cart', 20:08:21 INFO - 'tsvg_static']}, 20:08:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:08:21 INFO - 'tsvgr_opacity', 20:08:21 INFO - 'tart', 20:08:21 INFO - 'tscrollx', 20:08:21 INFO - 'cart', 20:08:21 INFO - 'tsvg_static']}, 20:08:21 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 20:08:21 INFO - 'talos_options': ['--disable-e10s'], 20:08:21 INFO - 'tests': ['tp5o']}, 20:08:21 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 20:08:21 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 20:08:21 INFO - 'talos_options': ['--disable-e10s', 20:08:21 INFO - '--xperf_path', 20:08:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:08:21 INFO - 'tests': ['tp5n']}, 20:08:21 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 20:08:21 INFO - 'talos_options': ['--xperf_path', 20:08:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:08:21 INFO - 'tests': ['tp5n']}}, 20:08:21 INFO - 'talos.zip': {'path': '', 20:08:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:08:21 INFO - Running post-action listener: _resource_record_post_action 20:08:21 INFO - [mozharness: 2017-03-28 03:08:21.123646Z] Finished populate-webroot step (success) 20:08:21 INFO - [mozharness: 2017-03-28 03:08:21.123776Z] Running create-virtualenv step. 20:08:21 INFO - Running pre-action listener: _resource_record_pre_action 20:08:21 INFO - Running main action method: create_virtualenv 20:08:21 INFO - Creating virtualenv /builds/slave/test/build/venv 20:08:21 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 20:08:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:08:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:08:21 INFO - Using real prefix '/tools/python27' 20:08:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:08:21 INFO - Installing distribute.............................................................................................................................................................................................done. 20:08:24 INFO - Installing pip.................done. 20:08:24 INFO - Return code: 0 20:08:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:08:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:08:25 INFO - Reading from file tmpfile_stdout 20:08:25 INFO - Output received: 20:08:25 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 20:08:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:08:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:08:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:08:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10843eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108441768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9b3da9ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10821cd30>, '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 0x108143db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108211be8>, '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.2qL2Khrcbr/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.5E2o71iXbO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 20:08:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:08:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:08:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2qL2Khrcbr/Render', 20:08:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:08:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:08:25 INFO - 'HOME': '/Users/cltbld', 20:08:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:08:25 INFO - 'LOGNAME': 'cltbld', 20:08:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:25 INFO - 'MOZ_NO_REMOTE': '1', 20:08:25 INFO - 'NO_EM_RESTART': '1', 20:08:25 INFO - 'PAGER': '/bin/cat', 20:08:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:08:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:25 INFO - 'PWD': '/builds/slave/test', 20:08:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:08:25 INFO - 'SHELL': '/bin/bash', 20:08:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5E2o71iXbO/Listeners', 20:08:25 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 20:08:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:08:25 INFO - 'USER': 'cltbld', 20:08:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:08:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:08:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:25 INFO - 'XPC_FLAGS': '0x0', 20:08:25 INFO - 'XPC_SERVICE_NAME': '0', 20:08:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:08:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:25 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 20:08:25 INFO - Cleaning up... 20:08:25 INFO - Return code: 0 20:08:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:08:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:08:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:08:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10843eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108441768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9b3da9ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10821cd30>, '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 0x108143db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108211be8>, '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.2qL2Khrcbr/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.5E2o71iXbO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 20:08:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:08:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:08:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2qL2Khrcbr/Render', 20:08:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:08:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:08:25 INFO - 'HOME': '/Users/cltbld', 20:08:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:08:25 INFO - 'LOGNAME': 'cltbld', 20:08:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:25 INFO - 'MOZ_NO_REMOTE': '1', 20:08:25 INFO - 'NO_EM_RESTART': '1', 20:08:25 INFO - 'PAGER': '/bin/cat', 20:08:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:08:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:25 INFO - 'PWD': '/builds/slave/test', 20:08:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:08:25 INFO - 'SHELL': '/bin/bash', 20:08:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5E2o71iXbO/Listeners', 20:08:25 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 20:08:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:08:25 INFO - 'USER': 'cltbld', 20:08:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:08:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:08:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:25 INFO - 'XPC_FLAGS': '0x0', 20:08:25 INFO - 'XPC_SERVICE_NAME': '0', 20:08:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:08:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:25 INFO - Downloading/unpacking psutil>=3.1.1 20:08:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:08:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:08:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:08:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:08:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:08:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:08:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:08:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:08:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:08:29 INFO - Installing collected packages: psutil 20:08:29 INFO - Running setup.py install for psutil 20:08:29 INFO - building 'psutil._psutil_osx' extension 20:08:29 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 20:08:29 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 20:08:29 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 20:08:29 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 20:08:29 INFO - building 'psutil._psutil_posix' extension 20:08:29 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 20:08:30 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:08:30 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:08:30 INFO - ^ 20:08:30 INFO - 1 warning generated. 20:08:30 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 20:08:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:08:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:08:30 INFO - Successfully installed psutil 20:08:30 INFO - Cleaning up... 20:08:30 INFO - Return code: 0 20:08:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:08: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')]} 20:08:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08: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')]} 20:08:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10843eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108441768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9b3da9ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10821cd30>, '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 0x108143db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108211be8>, '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.2qL2Khrcbr/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.5E2o71iXbO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 20:08: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:08: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 mozsystemmonitor==0.3 20:08:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2qL2Khrcbr/Render', 20:08:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:08:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:08:30 INFO - 'HOME': '/Users/cltbld', 20:08:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:08:30 INFO - 'LOGNAME': 'cltbld', 20:08:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:30 INFO - 'MOZ_NO_REMOTE': '1', 20:08:30 INFO - 'NO_EM_RESTART': '1', 20:08:30 INFO - 'PAGER': '/bin/cat', 20:08:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:08:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:30 INFO - 'PWD': '/builds/slave/test', 20:08:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:08:30 INFO - 'SHELL': '/bin/bash', 20:08:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5E2o71iXbO/Listeners', 20:08:30 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 20:08:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:08:30 INFO - 'USER': 'cltbld', 20:08:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:08:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:08:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:30 INFO - 'XPC_FLAGS': '0x0', 20:08:30 INFO - 'XPC_SERVICE_NAME': '0', 20:08:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:08:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:08: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 20:08: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 20:08: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 20:08: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 20:08: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 20:08: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 20:08:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:08:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:08:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:08:34 INFO - Installing collected packages: mozsystemmonitor 20:08:34 INFO - Running setup.py install for mozsystemmonitor 20:08:34 INFO - Successfully installed mozsystemmonitor 20:08:34 INFO - Cleaning up... 20:08:34 INFO - Return code: 0 20:08:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:08:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:08:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10843eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108441768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9b3da9ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10821cd30>, '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 0x108143db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108211be8>, '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.2qL2Khrcbr/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.5E2o71iXbO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 20:08:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:08:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:08:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2qL2Khrcbr/Render', 20:08:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:08:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:08:35 INFO - 'HOME': '/Users/cltbld', 20:08:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:08:35 INFO - 'LOGNAME': 'cltbld', 20:08:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:35 INFO - 'MOZ_NO_REMOTE': '1', 20:08:35 INFO - 'NO_EM_RESTART': '1', 20:08:35 INFO - 'PAGER': '/bin/cat', 20:08:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:08:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:35 INFO - 'PWD': '/builds/slave/test', 20:08:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:08:35 INFO - 'SHELL': '/bin/bash', 20:08:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5E2o71iXbO/Listeners', 20:08:35 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 20:08:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:08:35 INFO - 'USER': 'cltbld', 20:08:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:08:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:08:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:35 INFO - 'XPC_FLAGS': '0x0', 20:08:35 INFO - 'XPC_SERVICE_NAME': '0', 20:08:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:08:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:35 INFO - Downloading/unpacking jsonschema==2.5.1 20:08:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:08:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:08:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:08:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:08:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:08:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:08:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:08:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:08:38 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 20:08:38 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 20:08:38 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 20:08:38 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 20:08:38 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 20:08:38 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 20:08:38 INFO - Downloading functools32-3.2.3-2.tar.gz 20:08:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:08:38 INFO - warning: no files found matching '*.txt' 20:08:38 INFO - no previously-included directories found matching 'build' 20:08:38 INFO - no previously-included directories found matching 'dist' 20:08:38 INFO - no previously-included directories found matching '.git*' 20:08:38 INFO - Installing collected packages: jsonschema, functools32 20:08:39 INFO - Running setup.py install for functools32 20:08:39 INFO - warning: no files found matching '*.txt' 20:08:39 INFO - no previously-included directories found matching 'build' 20:08:39 INFO - no previously-included directories found matching 'dist' 20:08:39 INFO - no previously-included directories found matching '.git*' 20:08:39 INFO - Successfully installed jsonschema functools32 20:08:39 INFO - Cleaning up... 20:08:39 INFO - Return code: 0 20:08:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:08: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')]} 20:08:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08: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')]} 20:08:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:39 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 0x10843eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108441768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9b3da9ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10821cd30>, '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 0x108143db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108211be8>, '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.2qL2Khrcbr/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.5E2o71iXbO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 20:08:39 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 20:08:39 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 20:08:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2qL2Khrcbr/Render', 20:08:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:08:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:08:39 INFO - 'HOME': '/Users/cltbld', 20:08:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:08:39 INFO - 'LOGNAME': 'cltbld', 20:08:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:39 INFO - 'MOZ_NO_REMOTE': '1', 20:08:39 INFO - 'NO_EM_RESTART': '1', 20:08:39 INFO - 'PAGER': '/bin/cat', 20:08:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:08:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:39 INFO - 'PWD': '/builds/slave/test', 20:08:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:08:39 INFO - 'SHELL': '/bin/bash', 20:08:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5E2o71iXbO/Listeners', 20:08:39 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 20:08:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:08:39 INFO - 'USER': 'cltbld', 20:08:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:08:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:08:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:39 INFO - 'XPC_FLAGS': '0x0', 20:08:39 INFO - 'XPC_SERVICE_NAME': '0', 20:08:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:08:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:08:39 INFO - Cleaning up... 20:08:39 INFO - Return code: 0 20:08:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:08: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')]} 20:08:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08: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')]} 20:08:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:39 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 0x10843eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108441768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9b3da9ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10821cd30>, '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 0x108143db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108211be8>, '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.2qL2Khrcbr/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.5E2o71iXbO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 20:08:39 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 20:08:39 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 20:08:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2qL2Khrcbr/Render', 20:08:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:08:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:08:39 INFO - 'HOME': '/Users/cltbld', 20:08:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:08:39 INFO - 'LOGNAME': 'cltbld', 20:08:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:39 INFO - 'MOZ_NO_REMOTE': '1', 20:08:39 INFO - 'NO_EM_RESTART': '1', 20:08:39 INFO - 'PAGER': '/bin/cat', 20:08:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:08:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:39 INFO - 'PWD': '/builds/slave/test', 20:08:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:08:39 INFO - 'SHELL': '/bin/bash', 20:08:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5E2o71iXbO/Listeners', 20:08:39 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 20:08:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:08:39 INFO - 'USER': 'cltbld', 20:08:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:08:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:08:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:39 INFO - 'XPC_FLAGS': '0x0', 20:08:39 INFO - 'XPC_SERVICE_NAME': '0', 20:08:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:08:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:39 INFO - Downloading/unpacking blobuploader==1.2.4 20:08:39 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 20:08:39 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 20:08:39 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 20:08:39 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 20:08:39 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 20:08:39 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 20:08:42 INFO - Downloading blobuploader-1.2.4.tar.gz 20:08:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:08:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:08: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 20:08: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 20:08: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 20:08: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 20:08: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 20:08: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 20:08:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:08:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:08:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:08:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:08:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:08:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:08:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:08:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:08:43 INFO - Downloading docopt-0.6.1.tar.gz 20:08:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:08:43 INFO - Installing collected packages: blobuploader, requests, docopt 20:08:43 INFO - Running setup.py install for blobuploader 20:08:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:08:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:08:43 INFO - Running setup.py install for requests 20:08:44 INFO - Running setup.py install for docopt 20:08:44 INFO - Successfully installed blobuploader requests docopt 20:08:44 INFO - Cleaning up... 20:08:44 INFO - Return code: 0 20:08:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:08:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:08:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:08:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:44 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 0x10843eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108441768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9b3da9ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10821cd30>, '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 0x108143db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108211be8>, '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.2qL2Khrcbr/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.5E2o71iXbO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 20:08:44 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 20:08:44 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 20:08:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2qL2Khrcbr/Render', 20:08:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:08:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:08:44 INFO - 'HOME': '/Users/cltbld', 20:08:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:08:44 INFO - 'LOGNAME': 'cltbld', 20:08:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:44 INFO - 'MOZ_NO_REMOTE': '1', 20:08:44 INFO - 'NO_EM_RESTART': '1', 20:08:44 INFO - 'PAGER': '/bin/cat', 20:08:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:08:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:44 INFO - 'PWD': '/builds/slave/test', 20:08:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:08:44 INFO - 'SHELL': '/bin/bash', 20:08:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5E2o71iXbO/Listeners', 20:08:44 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 20:08:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:08:44 INFO - 'USER': 'cltbld', 20:08:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:08:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:08:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:44 INFO - 'XPC_FLAGS': '0x0', 20:08:44 INFO - 'XPC_SERVICE_NAME': '0', 20:08:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:08:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:08:44 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-047J1d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:08:44 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-SSm174-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:08:45 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-hKa4A6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:08:45 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-cmIcFN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:08:45 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-wpjR1u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:08:45 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-DJrboW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:08:45 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-zgrVay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:08:45 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-t85Dws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:08:45 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-lnnt8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:08:45 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-fhrmhC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:08:45 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-EX0kYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:08:45 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-ItA052-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:08:46 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-nkkdRF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:08:46 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-g2eIAX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:08:46 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-Qsohp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:08:46 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-GIRX9P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:08:46 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-zMicvm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:08:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:08:46 INFO - Running setup.py install for manifestparser 20:08:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:08:46 INFO - Running setup.py install for mozcrash 20:08:46 INFO - Running setup.py install for mozdebug 20:08:47 INFO - Running setup.py install for mozdevice 20:08:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:08:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:08:47 INFO - Running setup.py install for mozfile 20:08:47 INFO - Running setup.py install for mozhttpd 20:08:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:08:47 INFO - Running setup.py install for mozinfo 20:08:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:08:47 INFO - Running setup.py install for mozInstall 20:08:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:08:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:08:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:08:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:08:47 INFO - Running setup.py install for mozleak 20:08:47 INFO - Running setup.py install for mozlog 20:08:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:08:48 INFO - Running setup.py install for moznetwork 20:08:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:08:48 INFO - Running setup.py install for mozprocess 20:08:48 INFO - Running setup.py install for mozprofile 20:08:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:08:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:08:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:08:48 INFO - Running setup.py install for mozrunner 20:08:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:08:48 INFO - Running setup.py install for mozscreenshot 20:08:48 INFO - Running setup.py install for moztest 20:08:49 INFO - Running setup.py install for mozversion 20:08:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:08:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:08:49 INFO - Cleaning up... 20:08:49 INFO - Return code: 0 20:08:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:08:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:08:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:49 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 0x10843eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108441768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9b3da9ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10821cd30>, '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 0x108143db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108211be8>, '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.2qL2Khrcbr/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.5E2o71iXbO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 20:08:49 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 20:08:49 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 20:08:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2qL2Khrcbr/Render', 20:08:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:08:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:08:49 INFO - 'HOME': '/Users/cltbld', 20:08:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:08:49 INFO - 'LOGNAME': 'cltbld', 20:08:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:49 INFO - 'MOZ_NO_REMOTE': '1', 20:08:49 INFO - 'NO_EM_RESTART': '1', 20:08:49 INFO - 'PAGER': '/bin/cat', 20:08:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:08:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:49 INFO - 'PWD': '/builds/slave/test', 20:08:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:08:49 INFO - 'SHELL': '/bin/bash', 20:08:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5E2o71iXbO/Listeners', 20:08:49 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 20:08:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:08:49 INFO - 'USER': 'cltbld', 20:08:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:08:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:08:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:49 INFO - 'XPC_FLAGS': '0x0', 20:08:49 INFO - 'XPC_SERVICE_NAME': '0', 20:08:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:08:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:08:49 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-bswrd8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:08:49 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)) 20:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:08:49 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-1lsSQg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:08:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:08:49 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-AbMMCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:08:49 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)) 20:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:08:49 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-9lqkMw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:08:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:08:49 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-l_KlHx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:08:50 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)) 20:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:08:50 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-MpjqEV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:08:50 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)) 20:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:08:50 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-alJv8J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:08:50 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)) 20:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:08:50 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-lWLPMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:08:50 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)) 20:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:08:50 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-O3yEmZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:08:50 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)) 20:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:08:50 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-EAr4_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:08:50 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)) 20:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:08:50 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-yCPDfi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:08:50 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)) 20:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:08:50 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-BljWBa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:08:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 20:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:08:50 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-WAgXI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:08:50 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)) 20:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:08:50 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-CVfX57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:08:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 20:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:08:50 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-fvfAR0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:08:51 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)) 20:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:08:51 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-ba5TkE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:08:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 20:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:08:51 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-eefXuC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:08:51 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)) 20:08:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:08:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:08:51 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)) 20:08:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:08:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:08:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:08:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:08:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:08:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:08:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:08:53 INFO - Downloading blessings-1.6.tar.gz 20:08:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:08:54 INFO - Installing collected packages: blessings 20:08:54 INFO - Running setup.py install for blessings 20:08:54 INFO - Successfully installed blessings 20:08:54 INFO - Cleaning up... 20:08:54 INFO - Return code: 0 20:08:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:08:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:08:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:08:54 INFO - Reading from file tmpfile_stdout 20:08:54 INFO - Current package versions: 20:08:54 INFO - blessings == 1.6 20:08:54 INFO - blobuploader == 1.2.4 20:08:54 INFO - docopt == 0.6.1 20:08:54 INFO - functools32 == 3.2.3-2 20:08:54 INFO - jsonschema == 2.5.1 20:08:54 INFO - manifestparser == 1.1 20:08:54 INFO - mozInstall == 1.12 20:08:54 INFO - mozcrash == 1.0 20:08:54 INFO - mozdebug == 0.1 20:08:54 INFO - mozdevice == 0.49 20:08:54 INFO - mozfile == 1.2 20:08:54 INFO - mozhttpd == 0.7 20:08:54 INFO - mozinfo == 0.9 20:08:54 INFO - mozleak == 0.1 20:08:54 INFO - mozlog == 3.4 20:08:54 INFO - moznetwork == 0.27 20:08:54 INFO - mozprocess == 0.25 20:08:54 INFO - mozprofile == 0.28 20:08:54 INFO - mozrunner == 6.13 20:08:54 INFO - mozscreenshot == 0.1 20:08:54 INFO - mozsystemmonitor == 0.3 20:08:54 INFO - moztest == 0.8 20:08:54 INFO - mozversion == 1.4 20:08:54 INFO - psutil == 3.1.1 20:08:54 INFO - requests == 1.2.3 20:08:54 INFO - wsgiref == 0.1.2 20:08:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:08:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:08:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:54 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 0x10843eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108441768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9b3da9ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10821cd30>, '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 0x108143db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108211be8>, '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.2qL2Khrcbr/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.5E2o71iXbO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 20:08:54 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 20:08:54 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 20:08:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2qL2Khrcbr/Render', 20:08:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:08:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:08:54 INFO - 'HOME': '/Users/cltbld', 20:08:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:08:54 INFO - 'LOGNAME': 'cltbld', 20:08:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:54 INFO - 'MOZ_NO_REMOTE': '1', 20:08:54 INFO - 'NO_EM_RESTART': '1', 20:08:54 INFO - 'PAGER': '/bin/cat', 20:08:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:08:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:54 INFO - 'PWD': '/builds/slave/test', 20:08:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:08:54 INFO - 'SHELL': '/bin/bash', 20:08:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5E2o71iXbO/Listeners', 20:08:54 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 20:08:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:08:54 INFO - 'USER': 'cltbld', 20:08:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:08:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:08:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:54 INFO - 'XPC_FLAGS': '0x0', 20:08:54 INFO - 'XPC_SERVICE_NAME': '0', 20:08:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:08:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:54 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)) 20:08:54 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)) 20:08:54 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)) 20:08:54 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)) 20:08:54 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)) 20:08:54 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)) 20:08:54 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)) 20:08:54 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)) 20:08:54 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)) 20:08:54 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)) 20:08:54 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)) 20:08:54 INFO - Cleaning up... 20:08:54 INFO - Return code: 0 20:08:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:08:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:08:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10843eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108441768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9b3da9ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10821cd30>, '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 0x108143db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108211be8>, '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.2qL2Khrcbr/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.5E2o71iXbO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 20:08:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:08:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:08:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2qL2Khrcbr/Render', 20:08:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:08:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:08:54 INFO - 'HOME': '/Users/cltbld', 20:08:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:08:54 INFO - 'LOGNAME': 'cltbld', 20:08:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:54 INFO - 'MOZ_NO_REMOTE': '1', 20:08:54 INFO - 'NO_EM_RESTART': '1', 20:08:54 INFO - 'PAGER': '/bin/cat', 20:08:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:08:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:08:54 INFO - 'PWD': '/builds/slave/test', 20:08:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:08:54 INFO - 'SHELL': '/bin/bash', 20:08:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5E2o71iXbO/Listeners', 20:08:54 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 20:08:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:08:54 INFO - 'USER': 'cltbld', 20:08:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:08:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:08:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:54 INFO - 'XPC_FLAGS': '0x0', 20:08:54 INFO - 'XPC_SERVICE_NAME': '0', 20:08:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:08:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:08:55 INFO - Cleaning up... 20:08:55 INFO - Return code: 0 20:08:55 INFO - Running post-action listener: _resource_record_post_action 20:08:55 INFO - Running post-action listener: _start_resource_monitoring 20:08:55 INFO - Starting resource monitoring. 20:08:55 INFO - [mozharness: 2017-03-28 03:08:55.125454Z] Finished create-virtualenv step (success) 20:08:55 INFO - [mozharness: 2017-03-28 03:08:55.126437Z] Running install step. 20:08:55 INFO - Running pre-action listener: _resource_record_pre_action 20:08:55 INFO - Running main action method: install 20:08:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:08:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:08:55 INFO - Reading from file tmpfile_stdout 20:08:55 INFO - Detecting whether we're running mozinstall >=1.0... 20:08:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:08:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:08:55 INFO - Reading from file tmpfile_stdout 20:08:55 INFO - Output received: 20:08:55 INFO - Usage: mozinstall [options] installer 20:08:55 INFO - Options: 20:08:55 INFO - -h, --help show this help message and exit 20:08:55 INFO - -d DEST, --destination=DEST 20:08:55 INFO - Directory to install application into. [default: 20:08:55 INFO - "/builds/slave/test"] 20:08:55 INFO - --app=APP Application being installed. [default: firefox] 20:08:55 INFO - mkdir: /builds/slave/test/build/application 20:08:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 20:08:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 20:09:15 INFO - Reading from file tmpfile_stdout 20:09:15 INFO - Output received: 20:09:15 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 20:09:15 INFO - Running post-action listener: _resource_record_post_action 20:09:15 INFO - [mozharness: 2017-03-28 03:09:15.705943Z] Finished install step (success) 20:09:15 INFO - [mozharness: 2017-03-28 03:09:15.706097Z] Running run-tests step. 20:09:15 INFO - Running pre-action listener: _resource_record_pre_action 20:09:15 INFO - Running main action method: run_tests 20:09:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:09:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:09:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:09:15 INFO - 2017-03-27 20:09:15.720 screenresolution[1629:7576] starting screenresolution argv=screenresolution get 20:09:15 INFO - 2017-03-27 20:09:15.723 screenresolution[1629:7576] Display 0: 1600x1200x32@60 20:09:15 INFO - 2017-03-27 20:09:15.729 screenresolution[1630:7579] starting screenresolution argv=screenresolution list 20:09:15 INFO - Available Modes on Display 0 20:09:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:09:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:09:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:09:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:09:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:09:15 INFO - Intel Iris: 20:09:15 INFO - Chipset Model: Intel Iris 20:09:15 INFO - Type: GPU 20:09:15 INFO - Bus: Built-In 20:09:15 INFO - VRAM (Dynamic, Max): 1536 MB 20:09:15 INFO - Vendor: Intel (0x8086) 20:09:15 INFO - Device ID: 0x0a2e 20:09:15 INFO - Revision ID: 0x0009 20:09:15 INFO - Displays: 20:09:15 INFO - Display: 20:09:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:09:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:09:15 INFO - Display Serial Number: 1600x1200 60 20:09:15 INFO - Main Display: Yes 20:09:15 INFO - Mirror: Off 20:09:15 INFO - Online: Yes 20:09:15 INFO - Rotation: Supported 20:09:15 INFO - Return code: 0 20:09:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:09:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:09:15 INFO - Python 2.7.3 20:09:15 INFO - Return code: 0 20:09:15 INFO - grabbing minidump binary from tooltool 20:09:15 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')]} 20:09:15 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 0x10821cd30>, '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 0x108143db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108211be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:09:15 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 20:09:15 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 20:09:15 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 20:09:16 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:09:16 INFO - Return code: 0 20:09:16 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:09:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:09:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:09:16 INFO - ENV: RUST_BACKTRACE is now 1 20:09:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:09:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:09:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OLagjjlQTVOVUc5rVT3oWw/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0023', '--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 20:09:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OLagjjlQTVOVUc5rVT3oWw/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0023 --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 20:09:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2qL2Khrcbr/Render', 20:09:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:09:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:09:16 INFO - 'HOME': '/Users/cltbld', 20:09:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:09:16 INFO - 'LOGNAME': 'cltbld', 20:09:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:09:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:09:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:16 INFO - 'MOZ_NO_REMOTE': '1', 20:09:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:09:16 INFO - 'NO_EM_RESTART': '1', 20:09:16 INFO - 'PAGER': '/bin/cat', 20:09:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:09:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:16 INFO - 'PWD': '/builds/slave/test', 20:09:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:09:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:09:16 INFO - 'RUST_BACKTRACE': '1', 20:09:16 INFO - 'SHELL': '/bin/bash', 20:09:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5E2o71iXbO/Listeners', 20:09:16 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 20:09:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:09:16 INFO - 'USER': 'cltbld', 20:09:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:09:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:09:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:16 INFO - 'XPC_FLAGS': '0x0', 20:09:16 INFO - 'XPC_SERVICE_NAME': '0', 20:09:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:09:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OLagjjlQTVOVUc5rVT3oWw/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0023', '--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 20:09:16 INFO - mozversion application_buildid: 20170327184522 20:09:16 INFO - mozversion application_changeset: db2babffcafbd6b5b47a8c5813005838eb171a90 20:09:16 INFO - mozversion application_display_name: FirefoxDeveloperEdition 20:09:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:09:16 INFO - mozversion application_name: Firefox 20:09:16 INFO - mozversion application_remotingname: firefox-dev 20:09:16 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 20:09:16 INFO - mozversion application_vendor: Mozilla 20:09:16 INFO - mozversion application_version: 54.0a2 20:09:16 INFO - mozversion platform_buildid: 20170327184522 20:09:16 INFO - mozversion platform_changeset: db2babffcafbd6b5b47a8c5813005838eb171a90 20:09:16 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 20:09:16 INFO - mozversion platform_version: 54.0a2 20:09:16 INFO - using testdate: 1490670556 20:09:16 INFO - actual date: 1490670556 20:09:16 INFO - starting webserver on 'localhost:49244' 20:09:16 INFO - SUITE-START | Running 2 tests 20:09:16 INFO - TEST-START | dromaeo_css 20:09:16 INFO - operating with platform_type : mac_ 20:09:16 INFO - Initialising browser for dromaeo_css test... 20:09:16 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/tmpjGqhIW/profile http://localhost:49244/getInfo.html) 20:09:19 INFO - PROCESS | 1640 | __metrics Screen width/height:1600/1200 20:09:19 INFO - PROCESS | 1640 | colorDepth:24 20:09:19 INFO - PROCESS | 1640 | Browser inner width/height: 1024/689 20:09:19 INFO - PROCESS | 1640 | __metrics 20:09:19 INFO - PROCESS | 1640 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:09:19 INFO - PROCESS | 1640 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:09:19 INFO - TEST-INFO | 1640: exit 0 20:09:19 INFO - Browser initialized. 20:09:19 INFO - Running cycle 1/1 for dromaeo_css test... 20:09:19 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/tmpjGqhIW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:09:31 INFO - PROCESS | 1642 | RSS: Main: 214786048 20:09:31 INFO - PROCESS | 1642 | 20:12:36 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49244/tests/dromaeo/cssquery-ext.html) 20:12:38 INFO - PROCESS | 1642 | RSS: Main: 416825344 20:12:38 INFO - PROCESS | 1642 | 20:14:21 INFO - PROCESS | 1642 | ************************* 20:14:21 INFO - PROCESS | 1642 | A coding exception was thrown and uncaught in a Task. 20:14:21 INFO - PROCESS | 1642 | 20:14:21 ERROR - PROCESS | 1642 | Full message: TypeError: NetworkError when attempting to fetch resource. 20:14:21 INFO - PROCESS | 1642 | Full stack: 20:14:21 INFO - PROCESS | 1642 | ************************* 20:15:42 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-ext.html (next: http://localhost:49244/tests/dromaeo/cssquery-jquery.html) 20:15:42 INFO - PROCESS | 1642 | RSS: Main: 351772672 20:15:42 INFO - PROCESS | 1642 | 20:18:45 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49244/tests/dromaeo/cssquery-mootools.html) 20:18:45 INFO - PROCESS | 1642 | RSS: Main: 323870720 20:18:45 INFO - PROCESS | 1642 | 20:21:48 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49244/tests/dromaeo/cssquery-prototype.html) 20:21:49 INFO - PROCESS | 1642 | RSS: Main: 341843968 20:21:49 INFO - PROCESS | 1642 | 20:24:52 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49244/tests/dromaeo/cssquery-yui.html) 20:24:53 INFO - PROCESS | 1642 | RSS: Main: 317820928 20:24:53 INFO - PROCESS | 1642 | 20:27:57 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-yui.html (next: http://localhost:49244/tests/dromaeo/cssquery-dojo.html) 20:27:57 INFO - PROCESS | 1642 | RSS: Main: 540860416 20:27:57 INFO - PROCESS | 1642 | 20:27:57 INFO - PROCESS | 1642 | __start_tp_report 20:27:57 INFO - PROCESS | 1642 | _x_x_mozilla_page_load 20:27:57 INFO - PROCESS | 1642 | _x_x_mozilla_page_load_details 20:27:57 INFO - PROCESS | 1642 | |i|pagename|runs| 20:27:57 INFO - PROCESS | 1642 | |0;dojo.html;3294.489354150107;3337.6662333766626;3393.8472768725405;3409.659034096591;3448.413769659158;5871.853203669911;5930.466258036776;5937.40625937406;5968.761249550018;5979.9999999999945;5952.642841429506;6017.638941663503;6026.517878569714;6048.032314829628;6061.2120424344885;5332.760025798849;5351.09031464652;5393.1101368274185;5414.052540805363;5476.507114359707;5227;5237.109691352479;5299.178627312773;5443.646162999412;5516.806911758089;5302.973485132569;5325.920111198316;5329.014132385501;5331.2269720890645;5345.679259244438;5328.413874473805;5338.772082421065;5339.359276886779;5348.090824559834;5357.785688572452;5184.611154163453;5291.920621190647;5298.708571028592;5301.204819277101;5333.733313334356;5941.019731744257;5943;5943.821685349403;5946.791862284799;5951;6306.684665766739;6322.0516922462;6324.968375158141;6332.556721029529;6333.366663333676;6383.489320854321;6385.106085148083;6394.040893865911;6399.584027038228;6408.07082972971;6074.362191969868;6088.66512341821;6093.695315234265;6109.755609775603;6115.082737589352;6337;6604.933950660528;6605.24039735427;6608.933910660928;6609.876321025389;6237.688115594202;6240.563160578807;6328.778492752732;6337.366263373626;6346.397092276226;6447.742090316428;6452.193475815523;6465.127207826883;6466.288708242089;6469.256035555877;6360.936390636127;6363.713632886531;6384.553081284358;6387.425131738166;6394.61632302054;5191.896162076813;6229.003359462465;6245.77104107714;6293.622382657055;6401.9039714404325;5039.891223930729;5060.84817455477;5130.307408499804;5149.665271757323;5184.326037615086;4573.451185857652;4575.954240457553;4580.358749775034;4588.678792484561;4612.492625811158;5688.687122208318;5963.671998040063;5997.790077347272;6005.519558435315;6008.729607167688;6336.714847831859;6375.330590288046;6376.649284289409;6416.679166041679;6457.3865482779065;5989.341172471025;6010.398960103955;6012.699365031818;6021.729022194012;6047.576669633084;5637.887242255132;5657.151427285858;5662.830115096472;5676.035074037423;5687.516561092353;6209.813705588839;6331.050342448485;6425.421712045938;6434.131392261985;6674.466042716474;6281.654509001866;6364.745410183541;6370.458511026614;6387.840303992437;6398.1362516059735;6660.900086498609;6665.3001434850585;6671.266160722414;6685.0306705526455;6685.732570697118;6383.234011918599;6403.775867844603;6408.647524386203;6408.775692850728;6412.647304398303;6158.414950579688;6243.125962365181;6360.173177486897;6373.458256048288;6423.646699431576;6295.8667439861265;6322.241331040304;6333.271673757393;6352.809415717536;6357.491400687842;6296.968515157578;6349.904751428639;6350.968245158745;6360.332165122781;6360.522960777867;5071.39143302806;6019.969900150471;6044.667543285162;6304.873902521832;6308.211473565804;6287.591306565058;6348.111264423077;6351.30135685065;6358.96820515913;6376.713047912763;5199.4020687621405;5855.795047173328;5942.6434413933575;5992.5205983520345;6154.815355539341 20:27:57 INFO - PROCESS | 1642 | |1;ext.html;783.2089589514591;805.2068712318365;869.865170898511;883.916027977342;885.07067579042;38609.80695096524;39024.82925512232;39176.41235381472;39241.21517569647;39286.60713392865;40105.59894401055;40454.17956191971;40462;40534.59465405345;40743;7253.274672532731;7439.925600743977;8998.550072496382;9137.086291370877;9154.130357616015;9025.638974441048;10898.400587967659;10939.453027348602;10950.452477376139;11031.944840275788;10872.18458615607;10897.182711296646;10939.234253602252;10970.232083754141;10989.890101098967;6216.44052035319;7441.144268409148;10860.34837909724;10896.891031089746;10900.182486313559;9786.804263914753;9964;10519.158467322595;10755.83866242007;10924.399158046304;38675.03312417184;38943.8052809737;38996;39059.60940390588;39082.60917390818;3738.345789486829;3752.4746535485056;3780.8865734028022;3785.9053523661855;3798.240351929625;24616.50766984668;25509;25745.35636609081;26045;26162.476750465074;2985.910422687323;2987.3726517431364;3004.699530047;3139.8587063581967;3194.9680503194904;361051;363092;364738;365161;365922;35285.64714352875;36286;37422.62577374246;41570.79214603908;41836.58163418388;43554.12891742211;44358;45496;45877.770611146734;46213.61359159231;13326.06717529783;13384.862286705544;13400.994925380635;13409.396577154052;13417.329133543284;11661.53353865836;11668.358240296695;11684.47419866108;11691.88308116925;11713.297202167898;11553.191276610725;11565.016973557174;11610.361430121424;11618.012468940065;11658.358790266617;5591.27313449249;5681.659100453986;5692;5701.486866182064;5706.600537962386;1009.1926458832904;1063.1707268330715;1065.248999455382;1085.5006696919506;1126.5155982927256;15912.363505459884;16060.357585696442;16294.592635184215;16550.50348489547;16576.83423165753;1028.0448239485609;1140.6178930058356;1148.7013376522164;1188.8870557297043;1196.3838623109107;8284.751457456287;8301.916980830114;8308.916910830936;8540.188682075193;8544.786380340416;478748;480143;481816;481879;482219;54920.45079549233;55465;55528.11303208817;55660.886782264126;55709.721451392485;1444.8916331275198;1464.7656374979952;1465.413834466222;1469.8383177850428;1471.220253265771;15553.766693499832;15776.605584860012;15910.443134490237;16331.673366532365;16356.509304720877;44776.77611611921;44851.551484484735;44945;44980.77509612431;45174.54825451835;373779;418952;445843;445875;446144;25204.369890752143;27483;29628.851855740584;30398.69601304047;30934.53598196074;42384.78807605942;42638;42680.359794603726;42913.35629965615;42938;29700.851495742383;30048.3990320188;30630.693693062785;30693.386132277676;30802.229944251572;29566.852165739034;29678.703212967594;29696.25759355947;30632.84683576568;30674.539881901343;35737.92786216418;36117.91646250617;36553.08617284589;36595.451068233466;36730.44904326384;28566.59130971746;30045.549316760702;30076;30933;31001.379972399973;20054.699179512027;22107;23767.405814854075;23991.400214994766;24319.66241856644 20:27:57 INFO - PROCESS | 1642 | |2;jquery.html;378.4663624289752;402.5933806855077;414.70348700679017;422.9429027081344;441.24326779573045;12601.936990315047;14605.050671706345;20524.48688782781;20859.478513037164;21377.931103444844;21214.363569092915;21463.034163462642;21660.566788664255;22000.88999555004;22030.779692203072;6353.714082866282;6421;6516.446102081329;6550.377714117151;6604.834879128012;3956.723029387944;6438.130852334922;6551.868962620745;6562.475001999853;6565.409113179813;4073.9388909166387;7399.963000185018;7481.476296659236;7499.662515186802;7516.699332026712;7218.494705370626;7311.524750891175;7390.29792169743;7393.408527317802;7469.551826890377;6872.828179295508;7078.893816592756;7211.242819503981;7218.6390680465765;7223.9277607223785;26366.472670546675;26555.734442655714;26565.070222542312;26629.866850665818;26813.463730725278;2865.970805521998;2875.8130721503035;2906.811057281291;2922.649282086142;2970.376220993594;13509;15864.52406427809;16445.83554164455;16462;16640.623837373663;1765.2674140231788;1934.7907557776389;2024.089159878046;2028.6956956456502;2031.3804289691639;117450;120160;120341;120458.39770801178;121482;19323.323683671006;19972.60054798925;20242.493937651383;20380.796192038186;20449.795502045086;32956.516956737;33166.502502462485;33632.663673363444;33637.495437568454;33637.83181084079;10376.221783366278;10520.10579100785;10659.040686338267;10700.625478108228;10802;8702.260307873776;8729.781755456164;8755.255803256667;8870.556472176366;8914.414819702213;9906.950465247628;9952.203823694088;10063.446510441996;10154.086132247985;10161;3285.589301337333;3301.851416686255;3892.6107389261415;3897.785621790829;3913.178232571135;869.4913475616709;978;982.474376208725;1010.3331801011298;1020.3469779341227;20616.38150855477;21138;22162.556748865256;22248.666270005964;22279.665805012937;967.264878692199;996.1283876607968;1014.2342531388754;1029.9742506437399;1032.200044965143;9624.807503849885;11065.191042937453;11065.280756750786;11216.607418740305;11231.94384028091;751649;757048;760357;765917;777234;96493.51753241189;131677;137303;158397;166697.33302666817;1012.6303899076931;1235.3699613197334;1241.2153083221172;1283.8587755346905;1284.3578210894552;18710.625787484445;19238;19470.221191152763;19530.902345488183;19552.413427597196;60509;60692.69653651703;61138;61219.693901530205;61868;87323.1267687315;87383;88046;88177;89794.55102724445;7353.5955522446775;10345.068943795095;10597.576096956343;11263.380514071478;11396.48715807774;12337.252053472313;12572.685682858002;12856.935715321364;12864.292463914575;12991.765782250672;8956.417832840845;10757.193210509087;10965.56137754481;11017;11140.498677559368;9940.956199599228;10166.135878450414;10250.58997640086;10441.686749397226;10583.947080264858;11007.229493935347;11044.889551104387;11055.778884422105;11218.551257949917;11345.376004319842;10548.156147508027;10743.355398676105;11270.042046426146;11343.432828358384;11373.43132843338;7913.485623434458;11304.095672346028;11512.481938312629;11555.42222888869;11594.188406811441 20:27:57 INFO - PROCESS | 1642 | |3;mootools.html;1537.2160198298864;1543.8224604170523;1560.282270155729;1586.9761953570699;1588.0709784775906;10437.68686939391;10991.450427478623;11012.284201526894;11015.614453494109;11019.063379612722;10576.78846423071;10996.395198264092;11115.221934464591;11170.497327620256;11196.328220306787;2378.3816207785926;2415.5651982643117;2419.2984034629935;2420.044082587377;2427.720812106613;2296.1733775840685;2382.261498935327;2385.439421735891;2387.9880600597057;2395.101836811196;2306.9769302307013;2350.74141844397;2378.8810559472045;2386.9283921482383;2392.35406440261;2284.9146655338745;2289.267434420986;2358.375030616871;2360.2919124262653;2361.4214517443165;2343.1798870395396;2371.0160283482332;2373.371056669984;2374.3589230907733;2374.7150341958904;10846.132309415229;11110.16673749464;11110.944460276261;11115.221934464591;11123.165762567758;5655.434456554352;5828.766849326022;5837.941620583782;5841.970790146022;5850.3564607893095;3054.7403470705017;3426.5031570422148;3654.689351405134;3661.5240018797654;3671.6144804795645;1167.1363191238506;1174.7533018066217;1192.5885569478517;1217.141914949967;1221.529711061239;13697.726045479134;13793.034487585874;13993.860061399357;14047.297635118202;14295.928520357436;4548.7043342183315;4707.388039554836;4709.576138147583;4733.573978341966;4761.47623761386;11672.299662020307;11680.948714615726;11681.474333655005;11689.707757305965;11693.181477296508;4807.278908163734;4994.150994330972;5004.449510553836;5439.755211015514;5577.274954256002;4652.720836749806;5169.353830771153;5238.057149713089;5265.368155821249;5280.419153893069;3829.3872980323013;3857.247836671822;3900.9804950975063;3927.509061367329;3927.9410808837893;992.335135459244;1003.3077176748167;1021.0090323868486;1024.3034736379184;1032.726327523207;914.7392992996964;915.716128000322;935.3218916285639;943.8631398447187;971.3734641156415;6527.836804079936;6609.735610575523;6690.96654516734;6743.5953842769595;6751.696173672197;968.0899954043177;974.3228456222998;991.3655260633201;992.8957459466797;1005.6027868991707;4118.773467459258;4142.399352093989;4172.415861779354;4190.036291652876;4266.850660226877;13300.467981280834;13929.651758705912;13931.442742290397;13937.790933136012;14014.229217393142;11631.941840290745;13812.447502100005;13832.170069795844;13849.961252906072;13867.722645547032;9807;10198.541065652063;10254.128399086012;10271.84592231132;10275;6829.112215412163;6829.453643708591;6833.760818371333;6962.965185174042;7063;11808.350540720343;12427.378631068592;12449.315287659265;12485.500579976699;12487.001039916604;11188.496517656888;11645.708857278636;11766;11793.587224447103;12550.49798008106;8795.384323097322;9165;9312.115349041831;9319.767005824908;9322.766930826512;10113.494325283853;10167.847482287623;10234.948825255826;10296.897031029894;10377.533011014371;8611.526366049928;8693.608787604699;8739.91260087391;8822.779430514289;8880.777980550538;8398.916010839814;8492.405531612727;8595.613197406006;8626.568671566522;8645.740627781177;7602.1257555381835;7861.724839630586;7871.803204919923;7965;7965.402594805529;5825.679587622722;5826.242588463642;5963.582549221513;6046.637201767908;6139.9079013813935;5965.373635768182;5983.4914032306;6071.2714474263375;6079.240094988127;6287.71705273273 20:27:57 INFO - PROCESS | 1642 | |4;prototype.html;355.6123825030716;366.748777087695;373.1641123882504;373.8783649052842;377.3792111975799;4324.005478739888;5091.210862316342;5123.923141152876;5127.077126117302;5138.047541934069;4108.77401742904;4200.894977625561;4393.5606439356125;4881.682690625115;5000.199968005111;3957.9802100989455;3983.5219773627205;4186.37204419338;4194.790260486963;4263.82544902099;3557.7687450315775;3872.7095467839886;4059.391091336294;4177.665786737069;4234.941264683829;3891.416287556875;4094.5700701426217;4199.496060472748;4214.220369231687;4225.471816022997;3918.902027449308;4021.7989100544855;4160.43834082398;4161.9375709364385;4195.559466256061;3415.453527435623;3614.024213462377;3838.673712734421;3860.6332398422105;3869.593692662258;4102.630763231324;4582.6104781093645;4933.309336692866;4973.900521989576;4978.626603004789;3980.4825372701653;4414.757188354639;4807.639427042951;4815.544072523038;4849.418069831608;4691.554302341272;4774.498677638832;4953.69653111305;4966.652334336598;5190.8183213587345;3867.690584753241;3928.5482169550583;4001.639852413268;4264.019275566637;4374.671899607511;5042.621803364762;5317.83007738297;5339.599530035224;5366.651167674088;5503.174523821459;4100.482821356118;4286.37847512109;4365.1448134543325;4392.341148827638;4443.466783985942;4189.874303770892;4432.4043344396;4443.800028998703;4477.462704475483;4484.040533248106;4758.762061896891;4809.052333804814;4829.9275510867365;4863.197572400585;4997.300377947017;4360.4331436913635;4515.909681806411;4571.062932098912;5116.437191908887;5405.21624364465;1521.6500204952702;1550.7516449258455;1673.012922375804;1673.205227516944;1699.218359554594;1222.3460448659923;1227.2329793878826;1241.0133943514927;1242.881926217008;1376.7865980772997;4433.958019865329;4587.220172570671;4731.266653668687;4778.95221047792;4869.853904382874;4717.160307480085;5391.56867450603;5604;5611.102223644198;5630.690312032795;4634.381574410448;4642.535746425398;4663.927296721773;4905.828296009622;4963.70217786934;2320.4662927526424;2608.360951566878;2903.404802015582;2916.4750344938116;2924.8976285830317;5096.980603879165;5183.844484665466;5585.162225666182;5780.624259423208;5795.594308398372;5004.47453017428;5074.974625126851;5517.724113794295;5767.106098554731;5789.56578256624;4721.5750582447745;5064.708499332646;5140.434552199255;5905.586608937333;5920.585559010828;5000.449950505515;5170.71561064145;5315.7507985624125;5518.061929471919;5635.577331700221;4595.540445955377;4974.726390048438;5265.815696450606;5541.833744987657;5564.221009058816;5281.339832520935;5440.918386224131;5541.2796336476;5642.351129620146;5669.603127781181;3703.5370578677666;4348.478182618106;4375.015621485268;4420.801063952194;4426.734395936254;4952.7771250294545;5214.515516655597;5255.63210575256;5450.6645871761675;5588.608797384144;4786.928196076992;5020.322256495327;5337.386200586827;5360.426995042323;5466.91799622998;4764.785584648768;4789.521047895182;4973.825916092919;5353.099649624327;5366.356037275552;4312.69811113219;4456.821727130879;4480.843170489147;4577.473590536998;5180.041692286939;4547.749873756975;5194.117000110066;5271.762770675252;5323.627346085892;5446.856160206401;4551.738594451061;4873.975630121969;5263.315768950012;5278.287431196739;5333.679979201261 20:27:57 INFO - PROCESS | 1642 | |5;yui.html;725.4994054102668;728.4811168713233;769.0924708843565;808.8180159464117;821.131776810447;14979.925100374496;16314.592135196626;16487.83512164878;16504.58738531537;16512.09183494909;14693.412263509474;14778;14943.551693449213;15011.174385408825;15570.45503407381;941.9529023548829;963.9903600963971;970.0541971577726;970.8203982263268;971.5822196455522;944.2446043165475;960.2126256469697;963.6579014449875;981.092489447262;982.9875228514605;1024.0578667625764;1027.8355463125902;1028.1466382902174;1028.5628607841675;1028.747956750597;1018.1803648063307;1019.0675531888313;1019.4494972714763;1019.9796004079914;1021.3004092196795;756.8713318735773;757.3675980556187;757.5114051436848;758.0827199089109;758.1849511774864;13640.86359136406;15700.293486793007;16055.116968566725;16099.195040247942;16138.75791863123;12010.819837702442;14049.157050576896;14281.642958926006;14450.916181286446;14504.34730437133;11467;11561.190716649839;11614.477348519336;11708.71204167541;11725.941370293094;3603.9099022524383;3672.338978983782;3687.9631203687886;3838.8848334550007;3843.0776613612534;88821;107507;110748.9999999992;112067.43966280116;112693;10425.478726063666;10683.252172348017;10874.72813179661;10971.725706857393;11399.088072954144;21653.891730541247;21814.018369173424;21829.235976740736;22111.889440552695;22146.778532214794;6338.778142764981;7714.459987800912;7718.845623087507;7757.7672669819995;7834.334081603128;4254.510731265944;4330.242207613655;4460.30865215892;4518.277075667943;4555.886102847456;3157.542156387311;3368.4105281575626;3425.469052296898;3496.021114088059;3523.453864650983;611.8592723673491;617.527591392585;630.5050535329744;639.6993413095837;647.1360733420842;656.1601150527333;698.2842586349033;699.7725739134802;715.1704023333012;735.1729304532402;9019.639214431481;9625.71122866315;10220.897791022144;10265.178785697126;10577.629782957714;648.4229036157823;689.5862482510454;703.5286358140058;710.5625369567086;719.9445582860857;4897.4857639948;4982.252662100714;4982.7259500727805;4993.375828021497;5007.8247261346405;60341;92912.0708792917;103852.96147038433;105217;106397;44398;63805.68097159485;78571.82142267871;87549;93943;76467;76832.61583692046;77168.61415692886;78321;81101.59449202716;11119.777604447703;11159.665210043711;11205.271657342246;11210.27133236337;11499.885001149882;49043;49188.26217606811;49749.75125124351;50377.99244015026;51122;64045;64680.35319646932;64724.67637661781;65674;65959.34040659532;13683.452661893412;13743.725125497635;14070.015098943386;14104.717905641624;14363.353649086026;14384.928075359556;14692.926535367254;14853.331600077807;15086.17026063577;15088.39646414175;13324.666883327995;13859.89120870348;14169.079009864327;14177.007609467239;14617;11446.644555222458;13178.163938976291;14131.576052718436;14299.57101286963;14436.639084022983;13163.276019818619;13738.10702304387;13887.444502220202;14026.649333766738;14049.719005620034;9201.355905086579;9638.228941684509;9789.657361992297;9823.705288841345;9966.103050725469;10001.837112654588;10592.682219533426;10701;10793.73015674583;10933.890661093288 20:27:57 INFO - PROCESS | 1642 | __end_tp_report 20:27:57 INFO - PROCESS | 1642 | __start_cc_report 20:27:57 INFO - PROCESS | 1642 | _x_x_mozilla_cycle_collect,2340 20:27:57 INFO - PROCESS | 1642 | __end_cc_report 20:27:57 INFO - PROCESS | 1642 | __startTimestamp1490671677353__endTimestamp 20:27:57 INFO - PROCESS | 1642 | 20:27:57 INFO - PROCESS | 1642 | ------- Summary: start ------- 20:27:57 INFO - PROCESS | 1642 | Number of tests: 6 20:27:57 INFO - PROCESS | 1642 | 20:27:57 INFO - PROCESS | 1642 | [#0] dojo.html Cycles:165 Average:5915.64 Median:6115.08 stddev:674.87 (11.0%) stddev-sans-first:644.86 20:27:57 INFO - PROCESS | 1642 | Values: 3294.5 3337.7 3393.8 3409.7 3448.4 5871.9 5930.5 5937.4 5968.8 5980.0 5952.6 6017.6 6026.5 6048.0 6061.2 5332.8 5351.1 5393.1 5414.1 5476.5 5227.0 5237.1 5299.2 5443.6 5516.8 5303.0 5325.9 5329.0 5331.2 5345.7 5328.4 5338.8 5339.4 5348.1 5357.8 5184.6 5291.9 5298.7 5301.2 5333.7 5941.0 5943.0 5943.8 5946.8 5951.0 6306.7 6322.1 6325.0 6332.6 6333.4 6383.5 6385.1 6394.0 6399.6 6408.1 6074.4 6088.7 6093.7 6109.8 6115.1 6337.0 6604.9 6605.2 6608.9 6609.9 6237.7 6240.6 6328.8 6337.4 6346.4 6447.7 6452.2 6465.1 6466.3 6469.3 6360.9 6363.7 6384.6 6387.4 6394.6 5191.9 6229.0 6245.8 6293.6 6401.9 5039.9 5060.8 5130.3 5149.7 5184.3 4573.5 4576.0 4580.4 4588.7 4612.5 5688.7 5963.7 5997.8 6005.5 6008.7 6336.7 6375.3 6376.6 6416.7 6457.4 5989.3 6010.4 6012.7 6021.7 6047.6 5637.9 5657.2 5662.8 5676.0 5687.5 6209.8 6331.1 6425.4 6434.1 6674.5 6281.7 6364.7 6370.5 6387.8 6398.1 6660.9 6665.3 6671.3 6685.0 6685.7 6383.2 6403.8 6408.6 6408.8 6412.6 6158.4 6243.1 6360.2 6373.5 6423.6 6295.9 6322.2 6333.3 6352.8 6357.5 6297.0 6349.9 6351.0 6360.3 6360.5 5071.4 6020.0 6044.7 6304.9 6308.2 6287.6 6348.1 6351.3 6359.0 6376.7 5199.4 5855.8 5942.6 5992.5 6154.8 20:27:57 INFO - PROCESS | 1642 | 20:27:57 INFO - PROCESS | 1642 | [#1] ext.html Cycles:180 Average:54562.46 Median:35511.79 stddev:113576.94 (319.8%) stddev-sans-first:113823.78 20:27:57 INFO - PROCESS | 1642 | Values: 783.2 805.2 869.9 883.9 885.1 38609.8 39024.8 39176.4 39241.2 39286.6 40105.6 40454.2 40462.0 40534.6 40743.0 7253.3 7439.9 8998.6 9137.1 9154.1 9025.6 10898.4 10939.5 10950.5 11031.9 10872.2 10897.2 10939.2 10970.2 10989.9 6216.4 7441.1 10860.3 10896.9 10900.2 9786.8 9964.0 10519.2 10755.8 10924.4 38675.0 38943.8 38996.0 39059.6 39082.6 3738.3 3752.5 3780.9 3785.9 3798.2 24616.5 25509.0 25745.4 26045.0 26162.5 2985.9 2987.4 3004.7 3139.9 3195.0 361051.0 363092.0 364738.0 365161.0 365922.0 35285.6 36286.0 37422.6 41570.8 41836.6 43554.1 44358.0 45496.0 45877.8 46213.6 13326.1 13384.9 13401.0 13409.4 13417.3 11661.5 11668.4 11684.5 11691.9 11713.3 11553.2 11565.0 11610.4 11618.0 11658.4 5591.3 5681.7 5692.0 5701.5 5706.6 1009.2 1063.2 1065.2 1085.5 1126.5 15912.4 16060.4 16294.6 16550.5 16576.8 1028.0 1140.6 1148.7 1188.9 1196.4 8284.8 8301.9 8308.9 8540.2 8544.8 478748.0 480143.0 481816.0 481879.0 482219.0 54920.5 55465.0 55528.1 55660.9 55709.7 1444.9 1464.8 1465.4 1469.8 1471.2 15553.8 15776.6 15910.4 16331.7 16356.5 44776.8 44851.6 44945.0 44980.8 45174.5 373779.0 418952.0 445843.0 445875.0 446144.0 25204.4 27483.0 29628.9 30398.7 30934.5 42384.8 42638.0 42680.4 42913.4 42938.0 29700.9 30048.4 30630.7 30693.4 30802.2 29566.9 29678.7 29696.3 30632.8 30674.5 35737.9 36117.9 36553.1 36595.5 36730.4 28566.6 30045.5 30076.0 30933.0 31001.4 20054.7 22107.0 23767.4 23991.4 24319.7 20:27:57 INFO - PROCESS | 1642 | 20:27:57 INFO - PROCESS | 1642 | [#2] jquery.html Cycles:180 Average:41922.06 Median:21561.80 stddev:126109.19 (584.9%) stddev-sans-first:126424.38 20:27:57 INFO - PROCESS | 1642 | Values: 378.5 402.6 414.7 422.9 441.2 12601.9 14605.1 20524.5 20859.5 21377.9 21214.4 21463.0 21660.6 22000.9 22030.8 6353.7 6421.0 6516.4 6550.4 6604.8 3956.7 6438.1 6551.9 6562.5 6565.4 4073.9 7400.0 7481.5 7499.7 7516.7 7218.5 7311.5 7390.3 7393.4 7469.6 6872.8 7078.9 7211.2 7218.6 7223.9 26366.5 26555.7 26565.1 26629.9 26813.5 2866.0 2875.8 2906.8 2922.6 2970.4 13509.0 15864.5 16445.8 16462.0 16640.6 1765.3 1934.8 2024.1 2028.7 2031.4 117450.0 120160.0 120341.0 120458.4 121482.0 19323.3 19972.6 20242.5 20380.8 20449.8 32956.5 33166.5 33632.7 33637.5 33637.8 10376.2 10520.1 10659.0 10700.6 10802.0 8702.3 8729.8 8755.3 8870.6 8914.4 9907.0 9952.2 10063.4 10154.1 10161.0 3285.6 3301.9 3892.6 3897.8 3913.2 869.5 978.0 982.5 1010.3 1020.3 20616.4 21138.0 22162.6 22248.7 22279.7 967.3 996.1 1014.2 1030.0 1032.2 9624.8 11065.2 11065.3 11216.6 11231.9 751649.0 757048.0 760357.0 765917.0 777234.0 96493.5 131677.0 137303.0 158397.0 166697.3 1012.6 1235.4 1241.2 1283.9 1284.4 18710.6 19238.0 19470.2 19530.9 19552.4 60509.0 60692.7 61138.0 61219.7 61868.0 87323.1 87383.0 88046.0 88177.0 89794.6 7353.6 10345.1 10597.6 11263.4 11396.5 12337.3 12572.7 12856.9 12864.3 12991.8 8956.4 10757.2 10965.6 11017.0 11140.5 9941.0 10166.1 10250.6 10441.7 10583.9 11007.2 11044.9 11055.8 11218.6 11345.4 10548.2 10743.4 11270.0 11343.4 11373.4 7913.5 11304.1 11512.5 11555.4 11594.2 20:27:57 INFO - PROCESS | 1642 | 20:27:57 INFO - PROCESS | 1642 | [#3] mootools.html Cycles:180 Average:6671.71 Median:2417.43 stddev:4131.88 (170.9%) stddev-sans-first:4125.46 20:27:57 INFO - PROCESS | 1642 | Values: 1537.2 1543.8 1560.3 1587.0 1588.1 10437.7 10991.5 11012.3 11015.6 11019.1 10576.8 10996.4 11115.2 11170.5 11196.3 2378.4 2415.6 2419.3 2420.0 2427.7 2296.2 2382.3 2385.4 2388.0 2395.1 2307.0 2350.7 2378.9 2386.9 2392.4 2284.9 2289.3 2358.4 2360.3 2361.4 2343.2 2371.0 2373.4 2374.4 2374.7 10846.1 11110.2 11110.9 11115.2 11123.2 5655.4 5828.8 5837.9 5842.0 5850.4 3054.7 3426.5 3654.7 3661.5 3671.6 1167.1 1174.8 1192.6 1217.1 1221.5 13697.7 13793.0 13993.9 14047.3 14295.9 4548.7 4707.4 4709.6 4733.6 4761.5 11672.3 11680.9 11681.5 11689.7 11693.2 4807.3 4994.2 5004.4 5439.8 5577.3 4652.7 5169.4 5238.1 5265.4 5280.4 3829.4 3857.2 3901.0 3927.5 3927.9 992.3 1003.3 1021.0 1024.3 1032.7 914.7 915.7 935.3 943.9 971.4 6527.8 6609.7 6691.0 6743.6 6751.7 968.1 974.3 991.4 992.9 1005.6 4118.8 4142.4 4172.4 4190.0 4266.9 13300.5 13929.7 13931.4 13937.8 14014.2 11631.9 13812.4 13832.2 13850.0 13867.7 9807.0 10198.5 10254.1 10271.8 10275.0 6829.1 6829.5 6833.8 6963.0 7063.0 11808.4 12427.4 12449.3 12485.5 12487.0 11188.5 11645.7 11766.0 11793.6 12550.5 8795.4 9165.0 9312.1 9319.8 9322.8 10113.5 10167.8 10234.9 10296.9 10377.5 8611.5 8693.6 8739.9 8822.8 8880.8 8398.9 8492.4 8595.6 8626.6 8645.7 7602.1 7861.7 7871.8 7965.0 7965.4 5825.7 5826.2 5963.6 6046.6 6139.9 5965.4 5983.5 6071.3 6079.2 6287.7 20:27:57 INFO - PROCESS | 1642 | 20:27:57 INFO - PROCESS | 1642 | [#4] prototype.html Cycles:180 Average:4422.76 Median:4726.42 stddev:1202.16 (25.4%) stddev-sans-first:1166.13 20:27:57 INFO - PROCESS | 1642 | Values: 355.6 366.7 373.2 373.9 377.4 4324.0 5091.2 5123.9 5127.1 5138.0 4108.8 4200.9 4393.6 4881.7 5000.2 3958.0 3983.5 4186.4 4194.8 4263.8 3557.8 3872.7 4059.4 4177.7 4234.9 3891.4 4094.6 4199.5 4214.2 4225.5 3918.9 4021.8 4160.4 4161.9 4195.6 3415.5 3614.0 3838.7 3860.6 3869.6 4102.6 4582.6 4933.3 4973.9 4978.6 3980.5 4414.8 4807.6 4815.5 4849.4 4691.6 4774.5 4953.7 4966.7 5190.8 3867.7 3928.5 4001.6 4264.0 4374.7 5042.6 5317.8 5339.6 5366.7 5503.2 4100.5 4286.4 4365.1 4392.3 4443.5 4189.9 4432.4 4443.8 4477.5 4484.0 4758.8 4809.1 4829.9 4863.2 4997.3 4360.4 4515.9 4571.1 5116.4 5405.2 1521.7 1550.8 1673.0 1673.2 1699.2 1222.3 1227.2 1241.0 1242.9 1376.8 4434.0 4587.2 4731.3 4779.0 4869.9 4717.2 5391.6 5604.0 5611.1 5630.7 4634.4 4642.5 4663.9 4905.8 4963.7 2320.5 2608.4 2903.4 2916.5 2924.9 5097.0 5183.8 5585.2 5780.6 5795.6 5004.5 5075.0 5517.7 5767.1 5789.6 4721.6 5064.7 5140.4 5905.6 5920.6 5000.4 5170.7 5315.8 5518.1 5635.6 4595.5 4974.7 5265.8 5541.8 5564.2 5281.3 5440.9 5541.3 5642.4 5669.6 3703.5 4348.5 4375.0 4420.8 4426.7 4952.8 5214.5 5255.6 5450.7 5588.6 4786.9 5020.3 5337.4 5360.4 5466.9 4764.8 4789.5 4973.8 5353.1 5366.4 4312.7 4456.8 4480.8 4577.5 5180.0 4547.7 5194.1 5271.8 5323.6 5446.9 4551.7 4874.0 5263.3 5278.3 5333.7 20:27:57 INFO - PROCESS | 1642 | 20:27:57 INFO - PROCESS | 1642 | [#5] yui.html Cycles:180 Average:19852.95 Median:3262.98 stddev:27987.81 (857.7%) stddev-sans-first:28029.47 20:27:57 INFO - PROCESS | 1642 | Values: 725.5 728.5 769.1 808.8 821.1 14979.9 16314.6 16487.8 16504.6 16512.1 14693.4 14778.0 14943.6 15011.2 15570.5 942.0 964.0 970.1 970.8 971.6 944.2 960.2 963.7 981.1 983.0 1024.1 1027.8 1028.1 1028.6 1028.7 1018.2 1019.1 1019.4 1020.0 1021.3 756.9 757.4 757.5 758.1 758.2 13640.9 15700.3 16055.1 16099.2 16138.8 12010.8 14049.2 14281.6 14450.9 14504.3 11467.0 11561.2 11614.5 11708.7 11725.9 3603.9 3672.3 3688.0 3838.9 3843.1 88821.0 107507.0 110749.0 112067.4 112693.0 10425.5 10683.3 10874.7 10971.7 11399.1 21653.9 21814.0 21829.2 22111.9 22146.8 6338.8 7714.5 7718.8 7757.8 7834.3 4254.5 4330.2 4460.3 4518.3 4555.9 3157.5 3368.4 3425.5 3496.0 3523.5 611.9 617.5 630.5 639.7 647.1 656.2 698.3 699.8 715.2 735.2 9019.6 9625.7 10220.9 10265.2 10577.6 648.4 689.6 703.5 710.6 719.9 4897.5 4982.3 4982.7 4993.4 5007.8 60341.0 92912.1 103853.0 105217.0 106397.0 44398.0 63805.7 78571.8 87549.0 93943.0 76467.0 76832.6 77168.6 78321.0 81101.6 11119.8 11159.7 11205.3 11210.3 11499.9 49043.0 49188.3 49749.8 50378.0 51122.0 64045.0 64680.4 64724.7 65674.0 65959.3 13683.5 13743.7 14070.0 14104.7 14363.4 14384.9 14692.9 14853.3 15086.2 15088.4 13324.7 13859.9 14169.1 14177.0 14617.0 11446.6 13178.2 14131.6 14299.6 14436.6 13163.3 13738.1 13887.4 14026.6 14049.7 9201.4 9638.2 9789.7 9823.7 9966.1 10001.8 10592.7 10701.0 10793.7 10933.9 20:27:57 INFO - PROCESS | 1642 | -------- Summary: end -------- 20:27:57 INFO - PROCESS | 1642 | 20:27:58 INFO - TEST-INFO | 1642: exit 0 20:27:58 INFO - TEST-OK | dromaeo_css | took 1121741ms 20:27:58 INFO - TEST-START | kraken 20:27:58 INFO - operating with platform_type : mac_ 20:27:58 INFO - Initialising browser for kraken test... 20:27:58 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/tmplQimww/profile http://localhost:49244/getInfo.html) 20:28:00 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 20:28:00 INFO - PROCESS | 1652 | colorDepth:24 20:28:00 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 20:28:00 INFO - PROCESS | 1652 | __metrics 20:28:00 INFO - PROCESS | 1652 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:28:00 INFO - PROCESS | 1652 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:28:01 INFO - TEST-INFO | 1652: exit 0 20:28:01 INFO - Browser initialized. 20:28:01 INFO - Running cycle 1/1 for kraken test... 20:28:01 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/tmplQimww/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:28:13 INFO - PROCESS | 1653 | RSS: Main: 214728704 20:28:13 INFO - PROCESS | 1653 | 20:28:16 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection) 20:28:16 INFO - PROCESS | 1653 | RSS: Main: 267419648 20:28:16 INFO - PROCESS | 1653 | 20:28:19 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-dft) 20:28:20 INFO - PROCESS | 1653 | RSS: Main: 278773760 20:28:20 INFO - PROCESS | 1653 | 20:28:23 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-fft) 20:28:23 INFO - PROCESS | 1653 | RSS: Main: 377380864 20:28:23 INFO - PROCESS | 1653 | 20:28:25 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator) 20:28:26 INFO - PROCESS | 1653 | RSS: Main: 277770240 20:28:26 INFO - PROCESS | 1653 | 20:28:28 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:28:29 INFO - PROCESS | 1653 | RSS: Main: 280440832 20:28:29 INFO - PROCESS | 1653 | 20:28:32 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom) 20:28:32 INFO - PROCESS | 1653 | RSS: Main: 320299008 20:28:32 INFO - PROCESS | 1653 | 20:28:35 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate) 20:28:36 INFO - PROCESS | 1653 | RSS: Main: 322048000 20:28:36 INFO - PROCESS | 1653 | 20:28:39 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial) 20:28:40 INFO - PROCESS | 1653 | RSS: Main: 317857792 20:28:40 INFO - PROCESS | 1653 | 20:28:41 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:28:42 INFO - PROCESS | 1653 | RSS: Main: 295890944 20:28:42 INFO - PROCESS | 1653 | 20:28:44 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:28:44 INFO - PROCESS | 1653 | RSS: Main: 298496000 20:28:44 INFO - PROCESS | 1653 | 20:28:47 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:28:47 INFO - PROCESS | 1653 | RSS: Main: 302747648 20:28:47 INFO - PROCESS | 1653 | 20:28:50 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:28:51 INFO - PROCESS | 1653 | RSS: Main: 322834432 20:28:51 INFO - PROCESS | 1653 | 20:28:54 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:28:55 INFO - PROCESS | 1653 | RSS: Main: 315928576 20:28:55 INFO - PROCESS | 1653 | 20:28:56 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49244/tests/kraken/driver.html?testName=ai-astar) 20:28:57 INFO - PROCESS | 1653 | RSS: Main: 360865792 20:28:57 INFO - PROCESS | 1653 | 20:28:57 INFO - PROCESS | 1653 | __start_tp_report 20:28:57 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 20:28:57 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 20:28:57 INFO - PROCESS | 1653 | |i|pagename|runs| 20:28:57 INFO - PROCESS | 1653 | |0;ai-astar;118;116;117;116;116;117;117;117;117;117 20:28:57 INFO - PROCESS | 1653 | |1;audio-beat-detection;143;110;110;141;111;110;108;112;150;138 20:28:57 INFO - PROCESS | 1653 | |2;audio-dft;187;185;182;186;188;184;184;183;185;183 20:28:57 INFO - PROCESS | 1653 | |3;audio-fft;80;59;61;92;63;62;59;61;77;58 20:28:57 INFO - PROCESS | 1653 | |4;audio-oscillator;89;84;120;102;84;68;82;69;69;84 20:28:57 INFO - PROCESS | 1653 | |5;imaging-gaussian-blur;89;89;89;89;90;88;89;89;89;89 20:28:57 INFO - PROCESS | 1653 | |6;imaging-darkroom;141;151;96;96;97;96;95;96;96;95 20:28:57 INFO - PROCESS | 1653 | |7;imaging-desaturate;84;86;83;84;84;87;83;86;84;85 20:28:57 INFO - PROCESS | 1653 | |8;json-parse-financial;61;60;60;62;66;65;64;65;64;63 20:28:57 INFO - PROCESS | 1653 | |9;json-stringify-tinderbox;54;57;64;64;61;57;61;79;83;59 20:28:57 INFO - PROCESS | 1653 | |10;stanford-crypto-aes;85;85;82;84;83;84;85;92;100;74 20:28:57 INFO - PROCESS | 1653 | |11;stanford-crypto-ccm;137;141;139;146;140;143;150;145;200;144 20:28:57 INFO - PROCESS | 1653 | |12;stanford-crypto-pbkdf2;167;164;176;221;218;175;166;165;163;165 20:28:57 INFO - PROCESS | 1653 | |13;stanford-crypto-sha256-iterative;65;66;65;64;65;64;64;65;64;65 20:28:57 INFO - PROCESS | 1653 | __end_tp_report 20:28:57 INFO - PROCESS | 1653 | __start_cc_report 20:28:57 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,2130 20:28:57 INFO - PROCESS | 1653 | __end_cc_report 20:28:57 INFO - PROCESS | 1653 | __startTimestamp1490671737131__endTimestamp 20:28:57 INFO - PROCESS | 1653 | 20:28:57 INFO - PROCESS | 1653 | ------- Summary: start ------- 20:28:57 INFO - PROCESS | 1653 | Number of tests: 14 20:28:57 INFO - PROCESS | 1653 | 20:28:57 INFO - PROCESS | 1653 | [#0] ai-astar Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.50 20:28:57 INFO - PROCESS | 1653 | Values: 118.0 116.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 20:28:57 INFO - PROCESS | 1653 | 20:28:57 INFO - PROCESS | 1653 | [#1] audio-beat-detection Cycles:10 Average:123.30 Median:125.00 stddev:17.24 (13.8%) stddev-sans-first:16.74 20:28:57 INFO - PROCESS | 1653 | Values: 143.0 110.0 110.0 141.0 111.0 110.0 108.0 112.0 150.0 138.0 20:28:57 INFO - PROCESS | 1653 | 20:28:57 INFO - PROCESS | 1653 | [#2] audio-dft Cycles:10 Average:184.70 Median:185.00 stddev:1.89 (1.0%) stddev-sans-first:1.81 20:28:57 INFO - PROCESS | 1653 | Values: 187.0 185.0 182.0 186.0 188.0 184.0 184.0 183.0 185.0 183.0 20:28:57 INFO - PROCESS | 1653 | 20:28:57 INFO - PROCESS | 1653 | [#3] audio-fft Cycles:10 Average:67.20 Median:62.50 stddev:11.62 (18.6%) stddev-sans-first:11.37 20:28:57 INFO - PROCESS | 1653 | Values: 80.0 59.0 61.0 92.0 63.0 62.0 59.0 61.0 77.0 58.0 20:28:57 INFO - PROCESS | 1653 | 20:28:57 INFO - PROCESS | 1653 | [#4] audio-oscillator Cycles:10 Average:85.10 Median:83.00 stddev:16.13 (19.4%) stddev-sans-first:17.05 20:28:57 INFO - PROCESS | 1653 | Values: 89.0 84.0 120.0 102.0 84.0 68.0 82.0 69.0 69.0 84.0 20:28:57 INFO - PROCESS | 1653 | 20:28:57 INFO - PROCESS | 1653 | [#5] imaging-gaussian-blur Cycles:10 Average:89.00 Median:89.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 20:28:57 INFO - PROCESS | 1653 | Values: 89.0 89.0 89.0 89.0 90.0 88.0 89.0 89.0 89.0 89.0 20:28:57 INFO - PROCESS | 1653 | 20:28:57 INFO - PROCESS | 1653 | [#6] imaging-darkroom Cycles:10 Average:105.90 Median:96.00 stddev:21.27 (22.2%) stddev-sans-first:18.38 20:28:57 INFO - PROCESS | 1653 | Values: 141.0 151.0 96.0 96.0 97.0 96.0 95.0 96.0 96.0 95.0 20:28:57 INFO - PROCESS | 1653 | 20:28:57 INFO - PROCESS | 1653 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:84.50 stddev:1.35 (1.6%) stddev-sans-first:1.41 20:28:57 INFO - PROCESS | 1653 | Values: 84.0 86.0 83.0 84.0 84.0 87.0 83.0 86.0 84.0 85.0 20:28:57 INFO - PROCESS | 1653 | 20:28:57 INFO - PROCESS | 1653 | [#8] json-parse-financial Cycles:10 Average:63.00 Median:64.00 stddev:2.16 (3.4%) stddev-sans-first:2.17 20:28:57 INFO - PROCESS | 1653 | Values: 61.0 60.0 60.0 62.0 66.0 65.0 64.0 65.0 64.0 63.0 20:28:57 INFO - PROCESS | 1653 | 20:28:57 INFO - PROCESS | 1653 | [#9] json-stringify-tinderbox Cycles:10 Average:63.90 Median:62.50 stddev:9.59 (15.3%) stddev-sans-first:9.47 20:28:57 INFO - PROCESS | 1653 | Values: 54.0 57.0 64.0 64.0 61.0 57.0 61.0 79.0 83.0 59.0 20:28:57 INFO - PROCESS | 1653 | 20:28:57 INFO - PROCESS | 1653 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:84.50 stddev:6.74 (8.0%) stddev-sans-first:7.14 20:28:57 INFO - PROCESS | 1653 | Values: 85.0 85.0 82.0 84.0 83.0 84.0 85.0 92.0 100.0 74.0 20:28:57 INFO - PROCESS | 1653 | 20:28:57 INFO - PROCESS | 1653 | [#11] stanford-crypto-ccm Cycles:10 Average:148.50 Median:144.50 stddev:18.48 (12.8%) stddev-sans-first:19.13 20:28:57 INFO - PROCESS | 1653 | Values: 137.0 141.0 139.0 146.0 140.0 143.0 150.0 145.0 200.0 144.0 20:28:57 INFO - PROCESS | 1653 | 20:28:57 INFO - PROCESS | 1653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.00 Median:171.00 stddev:22.33 (13.1%) stddev-sans-first:23.32 20:28:57 INFO - PROCESS | 1653 | Values: 167.0 164.0 176.0 221.0 218.0 175.0 166.0 165.0 163.0 165.0 20:28:57 INFO - PROCESS | 1653 | 20:28:57 INFO - PROCESS | 1653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.70 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 20:28:57 INFO - PROCESS | 1653 | Values: 65.0 66.0 65.0 64.0 65.0 64.0 64.0 65.0 64.0 65.0 20:28:57 INFO - PROCESS | 1653 | -------- Summary: end -------- 20:28:57 INFO - PROCESS | 1653 | 20:28:58 INFO - TEST-INFO | 1653: exit 0 20:28:58 INFO - TEST-OK | kraken | took 60142ms 20:28:58 INFO - SUITE-END | took 1181s 20:28:58 INFO - Completed test suite (00:19:41) 20:28:58 INFO - javascript benchmark 20:28:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7545.125593312666, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3294.489354150107, 3337.6662333766626, 3393.8472768725405, 3409.659034096591, 3448.413769659158, 5871.853203669911, 5930.466258036776, 5937.40625937406, 5968.761249550018, 5979.9999999999945, 5952.642841429506, 6017.638941663503, 6026.517878569714, 6048.032314829628, 6061.2120424344885, 5332.760025798849, 5351.09031464652, 5393.1101368274185, 5414.052540805363, 5476.507114359707, 5227.0, 5237.109691352479, 5299.178627312773, 5443.646162999412, 5516.806911758089, 5302.973485132569, 5325.920111198316, 5329.014132385501, 5331.2269720890645, 5345.679259244438, 5328.413874473805, 5338.772082421065, 5339.359276886779, 5348.090824559834, 5357.785688572452, 5184.611154163453, 5291.920621190647, 5298.708571028592, 5301.204819277101, 5333.733313334356, 5941.019731744257, 5943.0, 5943.821685349403, 5946.791862284799, 5951.0, 6306.684665766739, 6322.0516922462, 6324.968375158141, 6332.556721029529, 6333.366663333676, 6383.489320854321, 6385.106085148083, 6394.040893865911, 6399.584027038228, 6408.07082972971, 6074.362191969868, 6088.66512341821, 6093.695315234265, 6109.755609775603, 6115.082737589352, 6337.0, 6604.933950660528, 6605.24039735427, 6608.933910660928, 6609.876321025389, 6237.688115594202, 6240.563160578807, 6328.778492752732, 6337.366263373626, 6346.397092276226, 6447.742090316428, 6452.193475815523, 6465.127207826883, 6466.288708242089, 6469.256035555877, 6360.936390636127, 6363.713632886531, 6384.553081284358, 6387.425131738166, 6394.61632302054, 5191.896162076813, 6229.003359462465, 6245.77104107714, 6293.622382657055, 6401.9039714404325, 5039.891223930729, 5060.84817455477, 5130.307408499804, 5149.665271757323, 5184.326037615086, 4573.451185857652, 4575.954240457553, 4580.358749775034, 4588.678792484561, 4612.492625811158, 5688.687122208318, 5963.671998040063, 5997.790077347272, 6005.519558435315, 6008.729607167688, 6336.714847831859, 6375.330590288046, 6376.649284289409, 6416.679166041679, 6457.3865482779065, 5989.341172471025, 6010.398960103955, 6012.699365031818, 6021.729022194012, 6047.576669633084, 5637.887242255132, 5657.151427285858, 5662.830115096472, 5676.035074037423, 5687.516561092353, 6209.813705588839, 6331.050342448485, 6425.421712045938, 6434.131392261985, 6674.466042716474, 6281.654509001866, 6364.745410183541, 6370.458511026614, 6387.840303992437, 6398.1362516059735, 6660.900086498609, 6665.3001434850585, 6671.266160722414, 6685.0306705526455, 6685.732570697118, 6383.234011918599, 6403.775867844603, 6408.647524386203, 6408.775692850728, 6412.647304398303, 6158.414950579688, 6243.125962365181, 6360.173177486897, 6373.458256048288, 6423.646699431576, 6295.8667439861265, 6322.241331040304, 6333.271673757393, 6352.809415717536, 6357.491400687842, 6296.968515157578, 6349.904751428639, 6350.968245158745, 6360.332165122781, 6360.522960777867, 5071.39143302806, 6019.969900150471, 6044.667543285162, 6304.873902521832, 6308.211473565804, 6287.591306565058, 6348.111264423077, 6351.30135685065, 6358.96820515913, 6376.713047912763, 5199.4020687621405, 5855.795047173328, 5942.6434413933575, 5992.5205983520345, 6154.815355539341], "value": 5871.283575241046, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [783.2089589514591, 805.2068712318365, 869.865170898511, 883.916027977342, 885.07067579042, 38609.80695096524, 39024.82925512232, 39176.41235381472, 39241.21517569647, 39286.60713392865, 40105.59894401055, 40454.17956191971, 40462.0, 40534.59465405345, 40743.0, 7253.274672532731, 7439.925600743977, 8998.550072496382, 9137.086291370877, 9154.130357616015, 9025.638974441048, 10898.400587967659, 10939.453027348602, 10950.452477376139, 11031.944840275788, 10872.18458615607, 10897.182711296646, 10939.234253602252, 10970.232083754141, 10989.890101098967, 6216.44052035319, 7441.144268409148, 10860.34837909724, 10896.891031089746, 10900.182486313559, 9786.804263914753, 9964.0, 10519.158467322595, 10755.83866242007, 10924.399158046304, 38675.03312417184, 38943.8052809737, 38996.0, 39059.60940390588, 39082.60917390818, 3738.345789486829, 3752.4746535485056, 3780.8865734028022, 3785.9053523661855, 3798.240351929625, 24616.50766984668, 25509.0, 25745.35636609081, 26045.0, 26162.476750465074, 2985.910422687323, 2987.3726517431364, 3004.699530047, 3139.8587063581967, 3194.9680503194904, 361051.0, 363092.0, 364738.0, 365161.0, 365922.0, 35285.64714352875, 36286.0, 37422.62577374246, 41570.79214603908, 41836.58163418388, 43554.12891742211, 44358.0, 45496.0, 45877.770611146734, 46213.61359159231, 13326.06717529783, 13384.862286705544, 13400.994925380635, 13409.396577154052, 13417.329133543284, 11661.53353865836, 11668.358240296695, 11684.47419866108, 11691.88308116925, 11713.297202167898, 11553.191276610725, 11565.016973557174, 11610.361430121424, 11618.012468940065, 11658.358790266617, 5591.27313449249, 5681.659100453986, 5692.0, 5701.486866182064, 5706.600537962386, 1009.1926458832904, 1063.1707268330715, 1065.248999455382, 1085.5006696919506, 1126.5155982927256, 15912.363505459884, 16060.357585696442, 16294.592635184215, 16550.50348489547, 16576.83423165753, 1028.0448239485609, 1140.6178930058356, 1148.7013376522164, 1188.8870557297043, 1196.3838623109107, 8284.751457456287, 8301.916980830114, 8308.916910830936, 8540.188682075193, 8544.786380340416, 478748.0, 480143.0, 481816.0, 481879.0, 482219.0, 54920.45079549233, 55465.0, 55528.11303208817, 55660.886782264126, 55709.721451392485, 1444.8916331275198, 1464.7656374979952, 1465.413834466222, 1469.8383177850428, 1471.220253265771, 15553.766693499832, 15776.605584860012, 15910.443134490237, 16331.673366532365, 16356.509304720877, 44776.77611611921, 44851.551484484735, 44945.0, 44980.77509612431, 45174.54825451835, 373779.0, 418952.0, 445843.0, 445875.0, 446144.0, 25204.369890752143, 27483.0, 29628.851855740584, 30398.69601304047, 30934.53598196074, 42384.78807605942, 42638.0, 42680.359794603726, 42913.35629965615, 42938.0, 29700.851495742383, 30048.3990320188, 30630.693693062785, 30693.386132277676, 30802.229944251572, 29566.852165739034, 29678.703212967594, 29696.25759355947, 30632.84683576568, 30674.539881901343, 35737.92786216418, 36117.91646250617, 36553.08617284589, 36595.451068233466, 36730.44904326384, 28566.59130971746, 30045.549316760702, 30076.0, 30933.0, 31001.379972399973, 20054.699179512027, 22107.0, 23767.405814854075, 23991.400214994766, 24319.66241856644], "value": 17466.777094403194, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.4663624289752, 402.5933806855077, 414.70348700679017, 422.9429027081344, 441.24326779573045, 12601.936990315047, 14605.050671706345, 20524.48688782781, 20859.478513037164, 21377.931103444844, 21214.363569092915, 21463.034163462642, 21660.566788664255, 22000.88999555004, 22030.779692203072, 6353.714082866282, 6421.0, 6516.446102081329, 6550.377714117151, 6604.834879128012, 3956.723029387944, 6438.130852334922, 6551.868962620745, 6562.475001999853, 6565.409113179813, 4073.9388909166387, 7399.963000185018, 7481.476296659236, 7499.662515186802, 7516.699332026712, 7218.494705370626, 7311.524750891175, 7390.29792169743, 7393.408527317802, 7469.551826890377, 6872.828179295508, 7078.893816592756, 7211.242819503981, 7218.6390680465765, 7223.9277607223785, 26366.472670546675, 26555.734442655714, 26565.070222542312, 26629.866850665818, 26813.463730725278, 2865.970805521998, 2875.8130721503035, 2906.811057281291, 2922.649282086142, 2970.376220993594, 13509.0, 15864.52406427809, 16445.83554164455, 16462.0, 16640.623837373663, 1765.2674140231788, 1934.7907557776389, 2024.089159878046, 2028.6956956456502, 2031.3804289691639, 117450.0, 120160.0, 120341.0, 120458.39770801178, 121482.0, 19323.323683671006, 19972.60054798925, 20242.493937651383, 20380.796192038186, 20449.795502045086, 32956.516956737, 33166.502502462485, 33632.663673363444, 33637.495437568454, 33637.83181084079, 10376.221783366278, 10520.10579100785, 10659.040686338267, 10700.625478108228, 10802.0, 8702.260307873776, 8729.781755456164, 8755.255803256667, 8870.556472176366, 8914.414819702213, 9906.950465247628, 9952.203823694088, 10063.446510441996, 10154.086132247985, 10161.0, 3285.589301337333, 3301.851416686255, 3892.6107389261415, 3897.785621790829, 3913.178232571135, 869.4913475616709, 978.0, 982.474376208725, 1010.3331801011298, 1020.3469779341227, 20616.38150855477, 21138.0, 22162.556748865256, 22248.666270005964, 22279.665805012937, 967.264878692199, 996.1283876607968, 1014.2342531388754, 1029.9742506437399, 1032.200044965143, 9624.807503849885, 11065.191042937453, 11065.280756750786, 11216.607418740305, 11231.94384028091, 751649.0, 757048.0, 760357.0, 765917.0, 777234.0, 96493.51753241189, 131677.0, 137303.0, 158397.0, 166697.33302666817, 1012.6303899076931, 1235.3699613197334, 1241.2153083221172, 1283.8587755346905, 1284.3578210894552, 18710.625787484445, 19238.0, 19470.221191152763, 19530.902345488183, 19552.413427597196, 60509.0, 60692.69653651703, 61138.0, 61219.693901530205, 61868.0, 87323.1267687315, 87383.0, 88046.0, 88177.0, 89794.55102724445, 7353.5955522446775, 10345.068943795095, 10597.576096956343, 11263.380514071478, 11396.48715807774, 12337.252053472313, 12572.685682858002, 12856.935715321364, 12864.292463914575, 12991.765782250672, 8956.417832840845, 10757.193210509087, 10965.56137754481, 11017.0, 11140.498677559368, 9940.956199599228, 10166.135878450414, 10250.58997640086, 10441.686749397226, 10583.947080264858, 11007.229493935347, 11044.889551104387, 11055.778884422105, 11218.551257949917, 11345.376004319842, 10548.156147508027, 10743.355398676105, 11270.042046426146, 11343.432828358384, 11373.43132843338, 7913.485623434458, 11304.095672346028, 11512.481938312629, 11555.42222888869, 11594.188406811441], "value": 11311.25381555722, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1537.2160198298864, 1543.8224604170523, 1560.282270155729, 1586.9761953570699, 1588.0709784775906, 10437.68686939391, 10991.450427478623, 11012.284201526894, 11015.614453494109, 11019.063379612722, 10576.78846423071, 10996.395198264092, 11115.221934464591, 11170.497327620256, 11196.328220306787, 2378.3816207785926, 2415.5651982643117, 2419.2984034629935, 2420.044082587377, 2427.720812106613, 2296.1733775840685, 2382.261498935327, 2385.439421735891, 2387.9880600597057, 2395.101836811196, 2306.9769302307013, 2350.74141844397, 2378.8810559472045, 2386.9283921482383, 2392.35406440261, 2284.9146655338745, 2289.267434420986, 2358.375030616871, 2360.2919124262653, 2361.4214517443165, 2343.1798870395396, 2371.0160283482332, 2373.371056669984, 2374.3589230907733, 2374.7150341958904, 10846.132309415229, 11110.16673749464, 11110.944460276261, 11115.221934464591, 11123.165762567758, 5655.434456554352, 5828.766849326022, 5837.941620583782, 5841.970790146022, 5850.3564607893095, 3054.7403470705017, 3426.5031570422148, 3654.689351405134, 3661.5240018797654, 3671.6144804795645, 1167.1363191238506, 1174.7533018066217, 1192.5885569478517, 1217.141914949967, 1221.529711061239, 13697.726045479134, 13793.034487585874, 13993.860061399357, 14047.297635118202, 14295.928520357436, 4548.7043342183315, 4707.388039554836, 4709.576138147583, 4733.573978341966, 4761.47623761386, 11672.299662020307, 11680.948714615726, 11681.474333655005, 11689.707757305965, 11693.181477296508, 4807.278908163734, 4994.150994330972, 5004.449510553836, 5439.755211015514, 5577.274954256002, 4652.720836749806, 5169.353830771153, 5238.057149713089, 5265.368155821249, 5280.419153893069, 3829.3872980323013, 3857.247836671822, 3900.9804950975063, 3927.509061367329, 3927.9410808837893, 992.335135459244, 1003.3077176748167, 1021.0090323868486, 1024.3034736379184, 1032.726327523207, 914.7392992996964, 915.716128000322, 935.3218916285639, 943.8631398447187, 971.3734641156415, 6527.836804079936, 6609.735610575523, 6690.96654516734, 6743.5953842769595, 6751.696173672197, 968.0899954043177, 974.3228456222998, 991.3655260633201, 992.8957459466797, 1005.6027868991707, 4118.773467459258, 4142.399352093989, 4172.415861779354, 4190.036291652876, 4266.850660226877, 13300.467981280834, 13929.651758705912, 13931.442742290397, 13937.790933136012, 14014.229217393142, 11631.941840290745, 13812.447502100005, 13832.170069795844, 13849.961252906072, 13867.722645547032, 9807.0, 10198.541065652063, 10254.128399086012, 10271.84592231132, 10275.0, 6829.112215412163, 6829.453643708591, 6833.760818371333, 6962.965185174042, 7063.0, 11808.350540720343, 12427.378631068592, 12449.315287659265, 12485.500579976699, 12487.001039916604, 11188.496517656888, 11645.708857278636, 11766.0, 11793.587224447103, 12550.49798008106, 8795.384323097322, 9165.0, 9312.115349041831, 9319.767005824908, 9322.766930826512, 10113.494325283853, 10167.847482287623, 10234.948825255826, 10296.897031029894, 10377.533011014371, 8611.526366049928, 8693.608787604699, 8739.91260087391, 8822.779430514289, 8880.777980550538, 8398.916010839814, 8492.405531612727, 8595.613197406006, 8626.568671566522, 8645.740627781177, 7602.1257555381835, 7861.724839630586, 7871.803204919923, 7965.0, 7965.402594805529, 5825.679587622722, 5826.242588463642, 5963.582549221513, 6046.637201767908, 6139.9079013813935, 5965.373635768182, 5983.4914032306, 6071.2714474263375, 6079.240094988127, 6287.71705273273], "value": 5097.554445262011, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.6123825030716, 366.748777087695, 373.1641123882504, 373.8783649052842, 377.3792111975799, 4324.005478739888, 5091.210862316342, 5123.923141152876, 5127.077126117302, 5138.047541934069, 4108.77401742904, 4200.894977625561, 4393.5606439356125, 4881.682690625115, 5000.199968005111, 3957.9802100989455, 3983.5219773627205, 4186.37204419338, 4194.790260486963, 4263.82544902099, 3557.7687450315775, 3872.7095467839886, 4059.391091336294, 4177.665786737069, 4234.941264683829, 3891.416287556875, 4094.5700701426217, 4199.496060472748, 4214.220369231687, 4225.471816022997, 3918.902027449308, 4021.7989100544855, 4160.43834082398, 4161.9375709364385, 4195.559466256061, 3415.453527435623, 3614.024213462377, 3838.673712734421, 3860.6332398422105, 3869.593692662258, 4102.630763231324, 4582.6104781093645, 4933.309336692866, 4973.900521989576, 4978.626603004789, 3980.4825372701653, 4414.757188354639, 4807.639427042951, 4815.544072523038, 4849.418069831608, 4691.554302341272, 4774.498677638832, 4953.69653111305, 4966.652334336598, 5190.8183213587345, 3867.690584753241, 3928.5482169550583, 4001.639852413268, 4264.019275566637, 4374.671899607511, 5042.621803364762, 5317.83007738297, 5339.599530035224, 5366.651167674088, 5503.174523821459, 4100.482821356118, 4286.37847512109, 4365.1448134543325, 4392.341148827638, 4443.466783985942, 4189.874303770892, 4432.4043344396, 4443.800028998703, 4477.462704475483, 4484.040533248106, 4758.762061896891, 4809.052333804814, 4829.9275510867365, 4863.197572400585, 4997.300377947017, 4360.4331436913635, 4515.909681806411, 4571.062932098912, 5116.437191908887, 5405.21624364465, 1521.6500204952702, 1550.7516449258455, 1673.012922375804, 1673.205227516944, 1699.218359554594, 1222.3460448659923, 1227.2329793878826, 1241.0133943514927, 1242.881926217008, 1376.7865980772997, 4433.958019865329, 4587.220172570671, 4731.266653668687, 4778.95221047792, 4869.853904382874, 4717.160307480085, 5391.56867450603, 5604.0, 5611.102223644198, 5630.690312032795, 4634.381574410448, 4642.535746425398, 4663.927296721773, 4905.828296009622, 4963.70217786934, 2320.4662927526424, 2608.360951566878, 2903.404802015582, 2916.4750344938116, 2924.8976285830317, 5096.980603879165, 5183.844484665466, 5585.162225666182, 5780.624259423208, 5795.594308398372, 5004.47453017428, 5074.974625126851, 5517.724113794295, 5767.106098554731, 5789.56578256624, 4721.5750582447745, 5064.708499332646, 5140.434552199255, 5905.586608937333, 5920.585559010828, 5000.449950505515, 5170.71561064145, 5315.7507985624125, 5518.061929471919, 5635.577331700221, 4595.540445955377, 4974.726390048438, 5265.815696450606, 5541.833744987657, 5564.221009058816, 5281.339832520935, 5440.918386224131, 5541.2796336476, 5642.351129620146, 5669.603127781181, 3703.5370578677666, 4348.478182618106, 4375.015621485268, 4420.801063952194, 4426.734395936254, 4952.7771250294545, 5214.515516655597, 5255.63210575256, 5450.6645871761675, 5588.608797384144, 4786.928196076992, 5020.322256495327, 5337.386200586827, 5360.426995042323, 5466.91799622998, 4764.785584648768, 4789.521047895182, 4973.825916092919, 5353.099649624327, 5366.356037275552, 4312.69811113219, 4456.821727130879, 4480.843170489147, 4577.473590536998, 5180.041692286939, 4547.749873756975, 5194.117000110066, 5271.762770675252, 5323.627346085892, 5446.856160206401, 4551.738594451061, 4873.975630121969, 5263.315768950012, 5278.287431196739, 5333.679979201261], "value": 4085.293232484435, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [725.4994054102668, 728.4811168713233, 769.0924708843565, 808.8180159464117, 821.131776810447, 14979.925100374496, 16314.592135196626, 16487.83512164878, 16504.58738531537, 16512.09183494909, 14693.412263509474, 14778.0, 14943.551693449213, 15011.174385408825, 15570.45503407381, 941.9529023548829, 963.9903600963971, 970.0541971577726, 970.8203982263268, 971.5822196455522, 944.2446043165475, 960.2126256469697, 963.6579014449875, 981.092489447262, 982.9875228514605, 1024.0578667625764, 1027.8355463125902, 1028.1466382902174, 1028.5628607841675, 1028.747956750597, 1018.1803648063307, 1019.0675531888313, 1019.4494972714763, 1019.9796004079914, 1021.3004092196795, 756.8713318735773, 757.3675980556187, 757.5114051436848, 758.0827199089109, 758.1849511774864, 13640.86359136406, 15700.293486793007, 16055.116968566725, 16099.195040247942, 16138.75791863123, 12010.819837702442, 14049.157050576896, 14281.642958926006, 14450.916181286446, 14504.34730437133, 11467.0, 11561.190716649839, 11614.477348519336, 11708.71204167541, 11725.941370293094, 3603.9099022524383, 3672.338978983782, 3687.9631203687886, 3838.8848334550007, 3843.0776613612534, 88821.0, 107507.0, 110748.9999999992, 112067.43966280116, 112693.0, 10425.478726063666, 10683.252172348017, 10874.72813179661, 10971.725706857393, 11399.088072954144, 21653.891730541247, 21814.018369173424, 21829.235976740736, 22111.889440552695, 22146.778532214794, 6338.778142764981, 7714.459987800912, 7718.845623087507, 7757.7672669819995, 7834.334081603128, 4254.510731265944, 4330.242207613655, 4460.30865215892, 4518.277075667943, 4555.886102847456, 3157.542156387311, 3368.4105281575626, 3425.469052296898, 3496.021114088059, 3523.453864650983, 611.8592723673491, 617.527591392585, 630.5050535329744, 639.6993413095837, 647.1360733420842, 656.1601150527333, 698.2842586349033, 699.7725739134802, 715.1704023333012, 735.1729304532402, 9019.639214431481, 9625.71122866315, 10220.897791022144, 10265.178785697126, 10577.629782957714, 648.4229036157823, 689.5862482510454, 703.5286358140058, 710.5625369567086, 719.9445582860857, 4897.4857639948, 4982.252662100714, 4982.7259500727805, 4993.375828021497, 5007.8247261346405, 60341.0, 92912.0708792917, 103852.96147038433, 105217.0, 106397.0, 44398.0, 63805.68097159485, 78571.82142267871, 87549.0, 93943.0, 76467.0, 76832.61583692046, 77168.61415692886, 78321.0, 81101.59449202716, 11119.777604447703, 11159.665210043711, 11205.271657342246, 11210.27133236337, 11499.885001149882, 49043.0, 49188.26217606811, 49749.75125124351, 50377.99244015026, 51122.0, 64045.0, 64680.35319646932, 64724.67637661781, 65674.0, 65959.34040659532, 13683.452661893412, 13743.725125497635, 14070.015098943386, 14104.717905641624, 14363.353649086026, 14384.928075359556, 14692.926535367254, 14853.331600077807, 15086.17026063577, 15088.39646414175, 13324.666883327995, 13859.89120870348, 14169.079009864327, 14177.007609467239, 14617.0, 11446.644555222458, 13178.163938976291, 14131.576052718436, 14299.57101286963, 14436.639084022983, 13163.276019818619, 13738.10702304387, 13887.444502220202, 14026.649333766738, 14049.719005620034, 9201.355905086579, 9638.228941684509, 9789.657361992297, 9823.705288841345, 9966.103050725469, 10001.837112654588, 10592.682219533426, 10701.0, 10793.73015674583, 10933.890661093288], "value": 7636.896742854788, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1460.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 116.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 110.0, 110.0, 141.0, 111.0, 110.0, 108.0, 112.0, 150.0, 138.0], "value": 123.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 185.0, 182.0, 186.0, 188.0, 184.0, 184.0, 183.0, 185.0, 183.0], "value": 184.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 61.0, 92.0, 63.0, 62.0, 59.0, 61.0, 77.0, 58.0], "value": 67.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 84.0, 120.0, 102.0, 84.0, 68.0, 82.0, 69.0, 69.0, 84.0], "value": 85.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 89.0, 89.0, 90.0, 88.0, 89.0, 89.0, 89.0, 89.0], "value": 89.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 151.0, 96.0, 96.0, 97.0, 96.0, 95.0, 96.0, 96.0, 95.0], "value": 105.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 83.0, 84.0, 84.0, 87.0, 83.0, 86.0, 84.0, 85.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 60.0, 62.0, 66.0, 65.0, 64.0, 65.0, 64.0, 63.0], "value": 63.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 57.0, 64.0, 64.0, 61.0, 57.0, 61.0, 79.0, 83.0, 59.0], "value": 63.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 82.0, 84.0, 83.0, 84.0, 85.0, 92.0, 100.0, 74.0], "value": 85.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 141.0, 139.0, 146.0, 140.0, 143.0, 150.0, 145.0, 200.0, 144.0], "value": 148.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 164.0, 176.0, 221.0, 218.0, 175.0, 166.0, 165.0, 163.0, 165.0], "value": 178.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 64.0, 65.0, 64.0, 64.0, 65.0, 64.0, 65.0], "value": 64.7, "unit": "score"}]}]} 20:28:58 INFO - Return code: 0 20:28:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:28:58 ERROR - # TBPL SUCCESS # 20:28:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:28:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:28:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:28:58 INFO - 2017-03-27 20:28:58.484 screenresolution[1657:10001] starting screenresolution argv=screenresolution get 20:28:58 INFO - 2017-03-27 20:28:58.487 screenresolution[1657:10001] Display 0: 1600x1200x32@60 20:28:58 INFO - 2017-03-27 20:28:58.494 screenresolution[1658:10004] starting screenresolution argv=screenresolution list 20:28:58 INFO - Available Modes on Display 0 20:28:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:28:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:28:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:28:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:28:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:28:58 INFO - Intel Iris: 20:28:58 INFO - Chipset Model: Intel Iris 20:28:58 INFO - Type: GPU 20:28:58 INFO - Bus: Built-In 20:28:58 INFO - VRAM (Dynamic, Max): 1536 MB 20:28:58 INFO - Vendor: Intel (0x8086) 20:28:58 INFO - Device ID: 0x0a2e 20:28:58 INFO - Revision ID: 0x0009 20:28:58 INFO - Displays: 20:28:58 INFO - Display: 20:28:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:28:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:28:58 INFO - Display Serial Number: 1600x1200 60 20:28:58 INFO - Main Display: Yes 20:28:58 INFO - Mirror: Off 20:28:58 INFO - Online: Yes 20:28:58 INFO - Rotation: Supported 20:28:58 INFO - Return code: 0 20:28:58 INFO - Running post-action listener: _resource_record_post_action 20:28:58 INFO - [mozharness: 2017-03-28 03:28:58.737592Z] Finished run-tests step (success) 20:28:58 INFO - Running post-run listener: _resource_record_post_run 20:28:58 INFO - Total resource usage - Wall time: 1203s; CPU: 54.0%; Read bytes: 39367680; Write bytes: 508854272; Read time: 377; Write time: 1577 20:28:58 INFO - TinderboxPrint: CPU usage
53.7% 20:28:58 INFO - TinderboxPrint: I/O read bytes / time
39,367,680 / 377 20:28:58 INFO - TinderboxPrint: I/O write bytes / time
508,854,272 / 1,577 20:28:58 INFO - TinderboxPrint: CPU idle
2,227.3 (46.3%) 20:28:58 INFO - TinderboxPrint: CPU system
959.5 (19.9%) 20:28:58 INFO - TinderboxPrint: CPU user
1,627.0 (33.8%) 20:28:58 INFO - TinderboxPrint: Swap in / out
247,500,800 / 0 20:28:58 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 201617920; Write bytes: 200492544; Read time: 15601; Write time: 349 20:28:58 INFO - run-tests - Wall time: 1183s; CPU: 54.0%; Read bytes: 37454848; Write bytes: 297593344; Read time: 358; Write time: 1190 20:28:59 INFO - Running post-run listener: _upload_blobber_files 20:28:59 INFO - Blob upload gear active. 20:28:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:28:59 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 20:28:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:28:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:28:59 INFO - (blobuploader) - INFO - Open directory for files ... 20:28:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:28:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:28:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:29:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:29:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:29:00 INFO - (blobuploader) - INFO - Done attempting. 20:29:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:29:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:29:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:29:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:29:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:29:01 INFO - (blobuploader) - INFO - Done attempting. 20:29:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 20:29:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:29:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:29:02 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 20:29:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:29:02 INFO - (blobuploader) - INFO - Done attempting. 20:29:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:29:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:29:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:29:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:29:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:29:05 INFO - (blobuploader) - INFO - Done attempting. 20:29:05 INFO - (blobuploader) - INFO - Iteration through files over. 20:29:05 INFO - Return code: 0 20:29:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:29:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:29:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b925971da847129c141253c58b00c914cfda1a902bed7a40ede438d130964588b225c986b19c600b631f40bf1a96c98ccf906370f065eacc8467bdc96ca1e743", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5be252c44d7e1059b5dc72a138c1d2f3242360801f9732f86f5d315be6c0dbe6c152d68a29a5144b5f4f293af27ef9b4c310eec4f7d214be98ace4eea11b481b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/613a3b97f52b2d42d1a23faad33f6a9be930aff612f1de42a7f711f9d66474cd0e5ea9575c4971dd653a9951a941db4ea3149def757f80bcce0ca67197452a30", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e8fcfbe2742a43f8117bfcf0cb93026eefc63831b7d8e056b77e48d398f88b21ce817b70cbb537c08401111b633df81fee6ac07a53b0dfe689012cc13451a5ff"} 20:29:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:29:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:29:05 INFO - Contents: 20:29:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b925971da847129c141253c58b00c914cfda1a902bed7a40ede438d130964588b225c986b19c600b631f40bf1a96c98ccf906370f065eacc8467bdc96ca1e743", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5be252c44d7e1059b5dc72a138c1d2f3242360801f9732f86f5d315be6c0dbe6c152d68a29a5144b5f4f293af27ef9b4c310eec4f7d214be98ace4eea11b481b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/613a3b97f52b2d42d1a23faad33f6a9be930aff612f1de42a7f711f9d66474cd0e5ea9575c4971dd653a9951a941db4ea3149def757f80bcce0ca67197452a30", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e8fcfbe2742a43f8117bfcf0cb93026eefc63831b7d8e056b77e48d398f88b21ce817b70cbb537c08401111b633df81fee6ac07a53b0dfe689012cc13451a5ff"} 20:29:05 INFO - Running post-run listener: copy_logs_to_upload_dir 20:29:05 INFO - Copying logs to upload dir... 20:29:05 INFO - mkdir: /builds/slave/test/build/upload/logs 20:29:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1286.995864 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2017-03-27 20:29:05.323390) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-27 20:29:05.328847) ========= 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.2qL2Khrcbr/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.5E2o71iXbO/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b925971da847129c141253c58b00c914cfda1a902bed7a40ede438d130964588b225c986b19c600b631f40bf1a96c98ccf906370f065eacc8467bdc96ca1e743", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5be252c44d7e1059b5dc72a138c1d2f3242360801f9732f86f5d315be6c0dbe6c152d68a29a5144b5f4f293af27ef9b4c310eec4f7d214be98ace4eea11b481b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/613a3b97f52b2d42d1a23faad33f6a9be930aff612f1de42a7f711f9d66474cd0e5ea9575c4971dd653a9951a941db4ea3149def757f80bcce0ca67197452a30", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e8fcfbe2742a43f8117bfcf0cb93026eefc63831b7d8e056b77e48d398f88b21ce817b70cbb537c08401111b633df81fee6ac07a53b0dfe689012cc13451a5ff"} build_url:https://queue.taskcluster.net/v1/task/OLagjjlQTVOVUc5rVT3oWw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011107 build_url: 'https://queue.taskcluster.net/v1/task/OLagjjlQTVOVUc5rVT3oWw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b925971da847129c141253c58b00c914cfda1a902bed7a40ede438d130964588b225c986b19c600b631f40bf1a96c98ccf906370f065eacc8467bdc96ca1e743", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5be252c44d7e1059b5dc72a138c1d2f3242360801f9732f86f5d315be6c0dbe6c152d68a29a5144b5f4f293af27ef9b4c310eec4f7d214be98ace4eea11b481b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/613a3b97f52b2d42d1a23faad33f6a9be930aff612f1de42a7f711f9d66474cd0e5ea9575c4971dd653a9951a941db4ea3149def757f80bcce0ca67197452a30", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e8fcfbe2742a43f8117bfcf0cb93026eefc63831b7d8e056b77e48d398f88b21ce817b70cbb537c08401111b633df81fee6ac07a53b0dfe689012cc13451a5ff"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-27 20:29:05.364209) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 20:29:05.364529) ========= 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.2qL2Khrcbr/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.5E2o71iXbO/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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.005093 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 20:29:05.413240) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-27 20:29:05.413545) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-27 20:29:05.413863) ========= ========= Total master_lag: 0.19 =========