builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0155 starttime: 1483655413.35 results: success (0) buildid: 20170105120613 builduid: 5eabebb5731b42b0a5763b0c1ebe08bb revision: 8b03928134689c8f0479f716d70bf65f2c644ec5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-05 14:30:13.347200) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-05 14:30:13.347637) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-05 14:30:13.347953) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-05 14:30:13.374777) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 14:30:13.375105) ========= 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.xSEb7wP775/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.SxMnO2eSq1/Listeners TMPDIR=/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-05 14:30:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.17M=0.001s 2017-01-05 14:30:13 (9.17 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.120980 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 14:30:13.520459) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 14:30:13.520792) ========= 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.xSEb7wP775/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.SxMnO2eSq1/Listeners TMPDIR=/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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.027791 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 14:30:13.578185) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-05 14:30:13.578589) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 8b03928134689c8f0479f716d70bf65f2c644ec5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 8b03928134689c8f0479f716d70bf65f2c644ec5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xSEb7wP775/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.SxMnO2eSq1/Listeners TMPDIR=/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-05 14:30:13,670 truncating revision to first 12 chars 2017-01-05 14:30:13,671 Setting DEBUG logging. 2017-01-05 14:30:13,671 attempt 1/10 2017-01-05 14:30:13,671 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/8b0392813468?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-05 14:30:14,382 unpacking tar archive at: mozilla-beta-8b0392813468/testing/mozharness/ program finished with exit code 0 elapsedTime=0.974957 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-05 14:30:14.579484) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-05 14:30:14.579804) ========= script_repo_revision: 8b03928134689c8f0479f716d70bf65f2c644ec5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-05 14:30:14.580795) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-05 14:30:14.581146) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-05 14:30:14.612769) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-01-05 14:30:14.613115) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xSEb7wP775/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.SxMnO2eSq1/Listeners TMPDIR=/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 14:30:14 INFO - MultiFileLogger online at 20170105 14:30:14 in /builds/slave/test 14:30:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 14:30:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:30:14 INFO - {'append_to_log': False, 14:30:14 INFO - 'base_work_dir': '/builds/slave/test', 14:30:14 INFO - 'blob_upload_branch': 'Mozilla-Beta', 14:30:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:30:14 INFO - 'branch': 'Mozilla-Beta', 14:30:14 INFO - 'buildbot_json_path': 'buildprops.json', 14:30:14 INFO - 'config_files': ('talos/mac_config.py',), 14:30:14 INFO - 'default_actions': ('clobber', 14:30:14 INFO - 'read-buildbot-config', 14:30:14 INFO - 'download-and-extract', 14:30:14 INFO - 'populate-webroot', 14:30:14 INFO - 'create-virtualenv', 14:30:14 INFO - 'install', 14:30:14 INFO - 'run-tests'), 14:30:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:30:14 INFO - 'download_minidump_stackwalk': True, 14:30:14 INFO - 'download_symbols': 'ondemand', 14:30:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:30:14 INFO - 'tooltool.py': '/tools/tooltool.py', 14:30:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:30:14 INFO - '/tools/misc-python/virtualenv.py')}, 14:30:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:30:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:30:14 INFO - 'installer_path': 'installer.exe', 14:30:14 INFO - 'log_level': 'info', 14:30:14 INFO - 'log_name': 'talos', 14:30:14 INFO - 'log_to_console': True, 14:30:14 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:30:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:30:14 INFO - 'opt_config_files': (), 14:30:14 INFO - 'pip_index': False, 14:30:14 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:30:14 INFO - 'cmd': ('bash', 14:30:14 INFO - '-c', 14:30:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:30:14 INFO - 'enabled': True, 14:30:14 INFO - 'halt_on_failure': False, 14:30:14 INFO - 'name': 'check_screen_resolution'},), 14:30:14 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:30:14 INFO - 'cmd': ('bash', 14:30:14 INFO - '-c', 14:30:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:30:14 INFO - 'enabled': True, 14:30:14 INFO - 'halt_on_failure': False, 14:30:14 INFO - 'name': 'check_screen_resolution'},), 14:30:14 INFO - 'run_cmd_checks_enabled': True, 14:30:14 INFO - 'sps_profile': False, 14:30:14 INFO - 'sps_profile_interval': 0, 14:30:14 INFO - 'suite': 'dromaeojs', 14:30:14 INFO - 'system_bits': '32', 14:30:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:30:14 INFO - 'title': 't-yosemite-r7-0155', 14:30:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:30:14 INFO - 'use_talos_json': True, 14:30:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:30:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:30:14 INFO - 'work_dir': 'build'} 14:30:14 INFO - [mozharness: 2017-01-05 22:30:14.812943Z] Running clobber step. 14:30:14 INFO - Running pre-action listener: _resource_record_pre_action 14:30:14 INFO - Running main action method: clobber 14:30:14 INFO - rmtree: /builds/slave/test/build 14:30:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:30:17 INFO - Running post-action listener: _resource_record_post_action 14:30:17 INFO - [mozharness: 2017-01-05 22:30:17.636637Z] Finished clobber step (success) 14:30:17 INFO - [mozharness: 2017-01-05 22:30:17.636764Z] Running read-buildbot-config step. 14:30:17 INFO - Running pre-action listener: _resource_record_pre_action 14:30:17 INFO - Running main action method: read_buildbot_config 14:30:17 INFO - Using buildbot properties: 14:30:17 INFO - { 14:30:17 INFO - "project": "", 14:30:17 INFO - "product": "firefox", 14:30:17 INFO - "script_repo_revision": "production", 14:30:17 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 14:30:17 INFO - "repository": "", 14:30:17 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 14:30:17 INFO - "buildid": "20170105120613", 14:30:17 INFO - "pgo_build": "False", 14:30:17 INFO - "basedir": "/builds/slave/test", 14:30:17 INFO - "buildnumber": 22, 14:30:17 INFO - "slavename": "t-yosemite-r7-0155", 14:30:17 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 14:30:17 INFO - "platform": "yosemite_r7", 14:30:17 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 14:30:17 INFO - "branch": "mozilla-beta", 14:30:17 INFO - "repo_path": "releases/mozilla-beta", 14:30:17 INFO - "revision": "8b03928134689c8f0479f716d70bf65f2c644ec5", 14:30:17 INFO - "stage_platform": "macosx64", 14:30:17 INFO - "builduid": "5eabebb5731b42b0a5763b0c1ebe08bb", 14:30:17 INFO - "slavebuilddir": "test" 14:30:17 INFO - } 14:30:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/e6fBqRQmRx65RTdlI8O9PQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 14:30:17 INFO - Running post-action listener: _resource_record_post_action 14:30:17 INFO - [mozharness: 2017-01-05 22:30:17.640063Z] Finished read-buildbot-config step (success) 14:30:17 INFO - [mozharness: 2017-01-05 22:30:17.640173Z] Running download-and-extract step. 14:30:17 INFO - Running pre-action listener: _resource_record_pre_action 14:30:17 INFO - Running main action method: download_and_extract 14:30:17 INFO - mkdir: /builds/slave/test/build/tests 14:30:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:30:17 INFO - trying https://queue.taskcluster.net/v1/task/e6fBqRQmRx65RTdlI8O9PQ/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 14:30:17 INFO - Downloading https://queue.taskcluster.net/v1/task/e6fBqRQmRx65RTdlI8O9PQ/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 14:30:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e6fBqRQmRx65RTdlI8O9PQ/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json'}, attempt #1 14:30:18 INFO - Downloaded 1165 bytes. 14:30:18 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 14:30:18 INFO - Using the following test package requirements: 14:30:18 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 14:30:18 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 14:30:18 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 14:30:18 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 14:30:18 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 14:30:18 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 14:30:18 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 14:30:18 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 14:30:18 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 14:30:18 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 14:30:18 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 14:30:18 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 14:30:18 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 14:30:18 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 14:30:18 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 14:30:18 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 14:30:18 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 14:30:18 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 14:30:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e6fBqRQmRx65RTdlI8O9PQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 14:30:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e6fBqRQmRx65RTdlI8O9PQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 14:30:18 INFO - Fetch https://queue.taskcluster.net/v1/task/e6fBqRQmRx65RTdlI8O9PQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 14:30:19 INFO - Expected file size: 16234541 14:30:26 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip', u'firefox-51.0.en-US.mac.talos.tests.zip'] for test suite category: talos 14:30:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e6fBqRQmRx65RTdlI8O9PQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 14:30:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e6fBqRQmRx65RTdlI8O9PQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 14:30:26 INFO - Fetch https://queue.taskcluster.net/v1/task/e6fBqRQmRx65RTdlI8O9PQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 14:30:26 INFO - Expected file size: 16234541 14:30:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e6fBqRQmRx65RTdlI8O9PQ/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 14:30:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e6fBqRQmRx65RTdlI8O9PQ/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 14:30:33 INFO - Fetch https://queue.taskcluster.net/v1/task/e6fBqRQmRx65RTdlI8O9PQ/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 14:30:33 INFO - Expected file size: 14414089 14:30: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')]} 14:30:34 INFO - trying https://queue.taskcluster.net/v1/task/e6fBqRQmRx65RTdlI8O9PQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg 14:30:34 INFO - Downloading https://queue.taskcluster.net/v1/task/e6fBqRQmRx65RTdlI8O9PQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 14:30:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e6fBqRQmRx65RTdlI8O9PQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg'}, attempt #1 14:30:36 INFO - Downloaded 86123938 bytes. 14:30:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/e6fBqRQmRx65RTdlI8O9PQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg 14:30:36 INFO - mkdir: /builds/slave/test/properties 14:30:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:30:36 INFO - Writing to file /builds/slave/test/properties/build_url 14:30:36 INFO - Contents: 14:30:36 INFO - build_url:https://queue.taskcluster.net/v1/task/e6fBqRQmRx65RTdlI8O9PQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg 14:30:37 INFO - Running post-action listener: _resource_record_post_action 14:30:37 INFO - Running post-action listener: set_extra_try_arguments 14:30:37 INFO - [mozharness: 2017-01-05 22:30:37.432752Z] Finished download-and-extract step (success) 14:30:37 INFO - [mozharness: 2017-01-05 22:30:37.432865Z] Running populate-webroot step. 14:30:37 INFO - Running pre-action listener: _resource_record_pre_action 14:30:37 INFO - Running main action method: populate_webroot 14:30:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:30:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:30:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:30:37 INFO - '--tppagecycles', 14:30:37 INFO - '7'], 14:30:37 INFO - 'tests': ['tsvgm']}}, 14:30:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:30:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:30:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:30:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:30:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:30:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:30:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:30:37 INFO - 'talos_options': ['--disable-e10s'], 14:30:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:30:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:30:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:30:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:30:37 INFO - 'talos_options': ['--disable-e10s'], 14:30:37 INFO - 'tests': ['damp', 'tps']}, 14:30:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:30:37 INFO - 'tests': ['damp', 'tps']}, 14:30:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:30:37 INFO - 'tests': ['dromaeo_dom']}, 14:30:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:30:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:30:37 INFO - 'tests': ['basic_compositor_video']}, 14:30:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:30:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:30:37 INFO - 'tests': ['a11yr', 14:30:37 INFO - 'ts_paint', 14:30:37 INFO - 'tpaint', 14:30:37 INFO - 'sessionrestore', 14:30:37 INFO - 'sessionrestore_no_auto_restore', 14:30:37 INFO - 'tabpaint']}, 14:30:37 INFO - 'other-e10s': {'tests': ['a11yr', 14:30:37 INFO - 'ts_paint', 14:30:37 INFO - 'tpaint', 14:30:37 INFO - 'sessionrestore', 14:30:37 INFO - 'sessionrestore_no_auto_restore', 14:30:37 INFO - 'tabpaint']}, 14:30:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:30:37 INFO - 'ts_paint', 14:30:37 INFO - 'tpaint', 14:30:37 INFO - 'sessionrestore', 14:30:37 INFO - 'sessionrestore_no_auto_restore', 14:30:37 INFO - 'tabpaint']}, 14:30:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:30:37 INFO - 'ts_paint', 14:30:37 INFO - 'tpaint', 14:30:37 INFO - 'sessionrestore', 14:30:37 INFO - 'sessionrestore_no_auto_restore', 14:30:37 INFO - 'tabpaint']}, 14:30:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:30:37 INFO - 'tests': ['a11yr', 14:30:37 INFO - 'ts_paint', 14:30:37 INFO - 'tpaint', 14:30:37 INFO - 'sessionrestore', 14:30:37 INFO - 'sessionrestore_no_auto_restore', 14:30:37 INFO - 'tabpaint']}, 14:30:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:30:37 INFO - 'tests': ['a11yr', 14:30:37 INFO - 'ts_paint', 14:30:37 INFO - 'tpaint', 14:30:37 INFO - 'sessionrestore', 14:30:37 INFO - 'sessionrestore_no_auto_restore', 14:30:37 INFO - 'tabpaint']}, 14:30:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:30:37 INFO - 'tests': ['tsvgx', 14:30:37 INFO - 'tsvgr_opacity', 14:30:37 INFO - 'tart', 14:30:37 INFO - 'tscrollx', 14:30:37 INFO - 'cart']}, 14:30:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:30:37 INFO - 'tsvgr_opacity', 14:30:37 INFO - 'tart', 14:30:37 INFO - 'tscrollx', 14:30:37 INFO - 'cart']}, 14:30:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:30:37 INFO - 'talos_options': ['--disable-e10s'], 14:30:37 INFO - 'tests': ['tp5o']}, 14:30:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:30:37 INFO - 'tests': ['tp5o']}, 14:30:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:30:37 INFO - 'talos_options': ['--disable-e10s', 14:30:37 INFO - '--xperf_path', 14:30:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:30:37 INFO - 'tests': ['tp5n']}, 14:30:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:30:37 INFO - 'talos_options': ['--xperf_path', 14:30:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:30:37 INFO - 'tests': ['tp5n']}}, 14:30:37 INFO - 'talos.zip': {'path': '', 14:30:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:30:37 INFO - Running post-action listener: _resource_record_post_action 14:30:37 INFO - [mozharness: 2017-01-05 22:30:37.451770Z] Finished populate-webroot step (success) 14:30:37 INFO - [mozharness: 2017-01-05 22:30:37.451880Z] Running create-virtualenv step. 14:30:37 INFO - Running pre-action listener: _resource_record_pre_action 14:30:37 INFO - Running main action method: create_virtualenv 14:30:37 INFO - Creating virtualenv /builds/slave/test/build/venv 14:30:37 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:30:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:30:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:30:37 INFO - Using real prefix '/tools/python27' 14:30:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:30:38 INFO - Installing distribute.............................................................................................................................................................................................done. 14:30:41 INFO - Installing pip.................done. 14:30:41 INFO - Return code: 0 14:30:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:30:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:30:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:30:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:41 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 0x109bec490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b62570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8c8cd4980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a00d30>, '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 0x109866db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1099f8b20>, '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.xSEb7wP775/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.SxMnO2eSq1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:30:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:30:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:30:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xSEb7wP775/Render', 14:30:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:30:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:30:41 INFO - 'HOME': '/Users/cltbld', 14:30:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:30:41 INFO - 'LOGNAME': 'cltbld', 14:30:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:41 INFO - 'MOZ_NO_REMOTE': '1', 14:30:41 INFO - 'NO_EM_RESTART': '1', 14:30:41 INFO - 'PAGER': '/bin/cat', 14:30:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:30:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:41 INFO - 'PWD': '/builds/slave/test', 14:30:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:30:41 INFO - 'SHELL': '/bin/bash', 14:30:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SxMnO2eSq1/Listeners', 14:30:41 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 14:30:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:30:41 INFO - 'USER': 'cltbld', 14:30:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:30:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:30:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:41 INFO - 'XPC_FLAGS': '0x0', 14:30:41 INFO - 'XPC_SERVICE_NAME': '0', 14:30:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:30:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:41 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:30:41 INFO - Cleaning up... 14:30:41 INFO - Return code: 0 14:30:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:30:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:30:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:30:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:41 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 0x109bec490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b62570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8c8cd4980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a00d30>, '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 0x109866db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1099f8b20>, '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.xSEb7wP775/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.SxMnO2eSq1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:30:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:30:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:30:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xSEb7wP775/Render', 14:30:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:30:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:30:41 INFO - 'HOME': '/Users/cltbld', 14:30:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:30:41 INFO - 'LOGNAME': 'cltbld', 14:30:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:41 INFO - 'MOZ_NO_REMOTE': '1', 14:30:41 INFO - 'NO_EM_RESTART': '1', 14:30:41 INFO - 'PAGER': '/bin/cat', 14:30:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:30:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:41 INFO - 'PWD': '/builds/slave/test', 14:30:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:30:41 INFO - 'SHELL': '/bin/bash', 14:30:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SxMnO2eSq1/Listeners', 14:30:41 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 14:30:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:30:41 INFO - 'USER': 'cltbld', 14:30:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:30:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:30:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:41 INFO - 'XPC_FLAGS': '0x0', 14:30:41 INFO - 'XPC_SERVICE_NAME': '0', 14:30:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:30:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:41 INFO - Downloading/unpacking psutil>=3.1.1 14:30:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:30:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:30:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:30:45 INFO - Installing collected packages: psutil 14:30:45 INFO - Running setup.py install for psutil 14:30:45 INFO - building 'psutil._psutil_osx' extension 14:30:45 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 14:30:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 14:30:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 14:30:46 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 14:30:46 INFO - building 'psutil._psutil_posix' extension 14:30:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 14:30:46 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:30:46 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:30:46 INFO - ^ 14:30:46 INFO - 1 warning generated. 14:30:46 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 14:30:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:30:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:30:46 INFO - Successfully installed psutil 14:30:46 INFO - Cleaning up... 14:30:46 INFO - Return code: 0 14:30:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:30:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:30:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:30:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:46 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 0x109bec490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b62570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8c8cd4980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a00d30>, '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 0x109866db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1099f8b20>, '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.xSEb7wP775/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.SxMnO2eSq1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:30:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:30:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:30:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xSEb7wP775/Render', 14:30:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:30:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:30:46 INFO - 'HOME': '/Users/cltbld', 14:30:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:30:46 INFO - 'LOGNAME': 'cltbld', 14:30:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:46 INFO - 'MOZ_NO_REMOTE': '1', 14:30:46 INFO - 'NO_EM_RESTART': '1', 14:30:46 INFO - 'PAGER': '/bin/cat', 14:30:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:30:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:46 INFO - 'PWD': '/builds/slave/test', 14:30:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:30:46 INFO - 'SHELL': '/bin/bash', 14:30:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SxMnO2eSq1/Listeners', 14:30:46 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 14:30:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:30:46 INFO - 'USER': 'cltbld', 14:30:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:30:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:30:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:46 INFO - 'XPC_FLAGS': '0x0', 14:30:46 INFO - 'XPC_SERVICE_NAME': '0', 14:30:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:30:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:30:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:30:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:30:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:30:49 INFO - Installing collected packages: mozsystemmonitor 14:30:49 INFO - Running setup.py install for mozsystemmonitor 14:30:49 INFO - Successfully installed mozsystemmonitor 14:30:49 INFO - Cleaning up... 14:30:49 INFO - Return code: 0 14:30:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:30: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')]} 14:30:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30: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')]} 14:30:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109bec490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b62570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8c8cd4980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a00d30>, '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 0x109866db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1099f8b20>, '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.xSEb7wP775/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.SxMnO2eSq1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:30:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:30:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:30:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xSEb7wP775/Render', 14:30:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:30:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:30:50 INFO - 'HOME': '/Users/cltbld', 14:30:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:30:50 INFO - 'LOGNAME': 'cltbld', 14:30:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:50 INFO - 'MOZ_NO_REMOTE': '1', 14:30:50 INFO - 'NO_EM_RESTART': '1', 14:30:50 INFO - 'PAGER': '/bin/cat', 14:30:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:30:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:50 INFO - 'PWD': '/builds/slave/test', 14:30:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:30:50 INFO - 'SHELL': '/bin/bash', 14:30:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SxMnO2eSq1/Listeners', 14:30:50 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 14:30:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:30:50 INFO - 'USER': 'cltbld', 14:30:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:30:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:30:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:50 INFO - 'XPC_FLAGS': '0x0', 14:30:50 INFO - 'XPC_SERVICE_NAME': '0', 14:30:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:30:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:50 INFO - Downloading/unpacking jsonschema==2.5.1 14:30:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:30:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:30:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:53 INFO - Downloading functools32-3.2.3-2.tar.gz 14:30:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:30:53 INFO - warning: no files found matching '*.txt' 14:30:53 INFO - no previously-included directories found matching 'build' 14:30:53 INFO - no previously-included directories found matching 'dist' 14:30:53 INFO - no previously-included directories found matching '.git*' 14:30:53 INFO - Installing collected packages: jsonschema, functools32 14:30:53 INFO - Running setup.py install for functools32 14:30:53 INFO - warning: no files found matching '*.txt' 14:30:53 INFO - no previously-included directories found matching 'build' 14:30:53 INFO - no previously-included directories found matching 'dist' 14:30:53 INFO - no previously-included directories found matching '.git*' 14:30:53 INFO - Successfully installed jsonschema functools32 14:30:53 INFO - Cleaning up... 14:30:53 INFO - Return code: 0 14:30:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:30:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:30:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:30:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:53 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 0x109bec490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b62570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8c8cd4980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a00d30>, '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 0x109866db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1099f8b20>, '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.xSEb7wP775/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.SxMnO2eSq1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:30:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:30:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:30:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xSEb7wP775/Render', 14:30:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:30:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:30:53 INFO - 'HOME': '/Users/cltbld', 14:30:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:30:53 INFO - 'LOGNAME': 'cltbld', 14:30:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:53 INFO - 'MOZ_NO_REMOTE': '1', 14:30:53 INFO - 'NO_EM_RESTART': '1', 14:30:53 INFO - 'PAGER': '/bin/cat', 14:30:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:30:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:53 INFO - 'PWD': '/builds/slave/test', 14:30:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:30:53 INFO - 'SHELL': '/bin/bash', 14:30:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SxMnO2eSq1/Listeners', 14:30:53 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 14:30:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:30:53 INFO - 'USER': 'cltbld', 14:30:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:30:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:30:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:53 INFO - 'XPC_FLAGS': '0x0', 14:30:53 INFO - 'XPC_SERVICE_NAME': '0', 14:30:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:30:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:30:53 INFO - Cleaning up... 14:30:53 INFO - Return code: 0 14:30:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:30:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:30:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30: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')]} 14:30:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109bec490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b62570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8c8cd4980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a00d30>, '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 0x109866db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1099f8b20>, '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.xSEb7wP775/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.SxMnO2eSq1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:30:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:30:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:30:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xSEb7wP775/Render', 14:30:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:30:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:30:54 INFO - 'HOME': '/Users/cltbld', 14:30:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:30:54 INFO - 'LOGNAME': 'cltbld', 14:30:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:54 INFO - 'MOZ_NO_REMOTE': '1', 14:30:54 INFO - 'NO_EM_RESTART': '1', 14:30:54 INFO - 'PAGER': '/bin/cat', 14:30:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:30:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:54 INFO - 'PWD': '/builds/slave/test', 14:30:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:30:54 INFO - 'SHELL': '/bin/bash', 14:30:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SxMnO2eSq1/Listeners', 14:30:54 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 14:30:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:30:54 INFO - 'USER': 'cltbld', 14:30:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:30:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:30:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:54 INFO - 'XPC_FLAGS': '0x0', 14:30:54 INFO - 'XPC_SERVICE_NAME': '0', 14:30:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:30:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:54 INFO - Downloading/unpacking blobuploader==1.2.4 14:30:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:56 INFO - Downloading blobuploader-1.2.4.tar.gz 14:30:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:30:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:30:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:30:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:30:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:30:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:30:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:30:58 INFO - Downloading docopt-0.6.1.tar.gz 14:30:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:30:58 INFO - Installing collected packages: blobuploader, requests, docopt 14:30:58 INFO - Running setup.py install for blobuploader 14:30:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:30:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:30:58 INFO - Running setup.py install for requests 14:30:58 INFO - Running setup.py install for docopt 14:30:58 INFO - Successfully installed blobuploader requests docopt 14:30:58 INFO - Cleaning up... 14:30:59 INFO - Return code: 0 14:30:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:30:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:30:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:30:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:30:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:30:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:30:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109bec490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b62570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8c8cd4980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a00d30>, '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 0x109866db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1099f8b20>, '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.xSEb7wP775/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.SxMnO2eSq1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:30:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:30:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:30:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xSEb7wP775/Render', 14:30:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:30:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:30:59 INFO - 'HOME': '/Users/cltbld', 14:30:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:30:59 INFO - 'LOGNAME': 'cltbld', 14:30:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:59 INFO - 'MOZ_NO_REMOTE': '1', 14:30:59 INFO - 'NO_EM_RESTART': '1', 14:30:59 INFO - 'PAGER': '/bin/cat', 14:30:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:30:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:59 INFO - 'PWD': '/builds/slave/test', 14:30:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:30:59 INFO - 'SHELL': '/bin/bash', 14:30:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SxMnO2eSq1/Listeners', 14:30:59 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 14:30:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:30:59 INFO - 'USER': 'cltbld', 14:30:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:30:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:30:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:59 INFO - 'XPC_FLAGS': '0x0', 14:30:59 INFO - 'XPC_SERVICE_NAME': '0', 14:30:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:30:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:30:59 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-8PbmvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:30:59 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-4z_774-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:30:59 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-Zuxy2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:30:59 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-92gOpm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:30:59 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-9RUWLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:30:59 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-xqQtxj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:30:59 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-v6nUB9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:31:00 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-iVRT25-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:31:00 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-MUctoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:31:00 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-pj_EFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:31:00 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-1nhoFd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:31:00 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-FKlHia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:31:00 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-1Af7N4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:31:00 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-WUAbGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:31:00 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-beqqks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:31:00 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-DAZ2Il-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:31:00 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-QV0Ex1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:31:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:31:01 INFO - Running setup.py install for manifestparser 14:31:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:31:01 INFO - Running setup.py install for mozcrash 14:31:01 INFO - Running setup.py install for mozdebug 14:31:01 INFO - Running setup.py install for mozdevice 14:31:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:31:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:31:01 INFO - Running setup.py install for mozfile 14:31:01 INFO - Running setup.py install for mozhttpd 14:31:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:31:01 INFO - Running setup.py install for mozinfo 14:31:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:31:02 INFO - Running setup.py install for mozInstall 14:31:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:31:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:31:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:31:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:31:02 INFO - Running setup.py install for mozleak 14:31:02 INFO - Running setup.py install for mozlog 14:31:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:31:02 INFO - Running setup.py install for moznetwork 14:31:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:31:02 INFO - Running setup.py install for mozprocess 14:31:02 INFO - Running setup.py install for mozprofile 14:31:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:31:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:31:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:31:03 INFO - Running setup.py install for mozrunner 14:31:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:31:03 INFO - Running setup.py install for mozscreenshot 14:31:03 INFO - Running setup.py install for moztest 14:31:03 INFO - Running setup.py install for mozversion 14:31:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:31:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:31:03 INFO - Cleaning up... 14:31:03 INFO - Return code: 0 14:31:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:31:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:31:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:31:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:03 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 0x109bec490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b62570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8c8cd4980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a00d30>, '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 0x109866db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1099f8b20>, '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.xSEb7wP775/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.SxMnO2eSq1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:31:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:31:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:31:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xSEb7wP775/Render', 14:31:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:31:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:31:03 INFO - 'HOME': '/Users/cltbld', 14:31:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:31:03 INFO - 'LOGNAME': 'cltbld', 14:31:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:03 INFO - 'MOZ_NO_REMOTE': '1', 14:31:03 INFO - 'NO_EM_RESTART': '1', 14:31:03 INFO - 'PAGER': '/bin/cat', 14:31:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:31:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:03 INFO - 'PWD': '/builds/slave/test', 14:31:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:31:03 INFO - 'SHELL': '/bin/bash', 14:31:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SxMnO2eSq1/Listeners', 14:31:03 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 14:31:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:31:03 INFO - 'USER': 'cltbld', 14:31:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:31:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:31:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:03 INFO - 'XPC_FLAGS': '0x0', 14:31:03 INFO - 'XPC_SERVICE_NAME': '0', 14:31:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:31:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:31:03 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-XIJuXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:31:04 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:31:04 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-38S8be-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:31:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:31:04 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-qyt6bz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:31:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:31:04 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-_gNPDQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:31:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:31:04 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-8LURQd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:31:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:31:04 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-itjo3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:31:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:31:04 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-iiAoNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:31:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:31:04 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-eYlVqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:31:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:31:04 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-ju3GbH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:31:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:31:04 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-hbvsRp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:31:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:31:04 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-AU6edV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:31:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:31:05 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-MmVxvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:31:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:31:05 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-NXyRie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:31:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:31:05 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-huGzJl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:31:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:31:05 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-6ELltl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:31:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:31:05 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-bjqmg8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:31:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:31:05 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-AALIFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:31:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:31:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:31:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:31:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:31:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:31:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:31:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:31:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:08 INFO - Downloading blessings-1.6.tar.gz 14:31:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:31:08 INFO - Installing collected packages: blessings 14:31:08 INFO - Running setup.py install for blessings 14:31:08 INFO - Successfully installed blessings 14:31:08 INFO - Cleaning up... 14:31:08 INFO - Return code: 0 14:31:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:31:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:31:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:31:09 INFO - Reading from file tmpfile_stdout 14:31:09 INFO - Current package versions: 14:31:09 INFO - blessings == 1.6 14:31:09 INFO - blobuploader == 1.2.4 14:31:09 INFO - docopt == 0.6.1 14:31:09 INFO - functools32 == 3.2.3-2 14:31:09 INFO - jsonschema == 2.5.1 14:31:09 INFO - manifestparser == 1.1 14:31:09 INFO - mozInstall == 1.12 14:31:09 INFO - mozcrash == 0.17 14:31:09 INFO - mozdebug == 0.1 14:31:09 INFO - mozdevice == 0.48 14:31:09 INFO - mozfile == 1.2 14:31:09 INFO - mozhttpd == 0.7 14:31:09 INFO - mozinfo == 0.9 14:31:09 INFO - mozleak == 0.1 14:31:09 INFO - mozlog == 3.4 14:31:09 INFO - moznetwork == 0.27 14:31:09 INFO - mozprocess == 0.23 14:31:09 INFO - mozprofile == 0.28 14:31:09 INFO - mozrunner == 6.12 14:31:09 INFO - mozscreenshot == 0.1 14:31:09 INFO - mozsystemmonitor == 0.3 14:31:09 INFO - moztest == 0.7 14:31:09 INFO - mozversion == 1.4 14:31:09 INFO - psutil == 3.1.1 14:31:09 INFO - requests == 1.2.3 14:31:09 INFO - wsgiref == 0.1.2 14:31:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:31:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:31:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:31:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109bec490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b62570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8c8cd4980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a00d30>, '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 0x109866db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1099f8b20>, '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.xSEb7wP775/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.SxMnO2eSq1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:31:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:31:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:31:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xSEb7wP775/Render', 14:31:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:31:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:31:09 INFO - 'HOME': '/Users/cltbld', 14:31:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:31:09 INFO - 'LOGNAME': 'cltbld', 14:31:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:09 INFO - 'MOZ_NO_REMOTE': '1', 14:31:09 INFO - 'NO_EM_RESTART': '1', 14:31:09 INFO - 'PAGER': '/bin/cat', 14:31:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:31:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:09 INFO - 'PWD': '/builds/slave/test', 14:31:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:31:09 INFO - 'SHELL': '/bin/bash', 14:31:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SxMnO2eSq1/Listeners', 14:31:09 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 14:31:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:31:09 INFO - 'USER': 'cltbld', 14:31:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:31:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:31:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:09 INFO - 'XPC_FLAGS': '0x0', 14:31:09 INFO - 'XPC_SERVICE_NAME': '0', 14:31:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:31:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:31:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:31:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:31:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:31:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:31:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:31:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:31:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:31:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:31:09 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:31:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:31:09 INFO - Cleaning up... 14:31:09 INFO - Return code: 0 14:31:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:31:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:31:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:31:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109bec490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b62570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8c8cd4980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a00d30>, '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 0x109866db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1099f8b20>, '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.xSEb7wP775/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.SxMnO2eSq1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:31:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:31:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:31:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xSEb7wP775/Render', 14:31:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:31:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:31:09 INFO - 'HOME': '/Users/cltbld', 14:31:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:31:09 INFO - 'LOGNAME': 'cltbld', 14:31:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:09 INFO - 'MOZ_NO_REMOTE': '1', 14:31:09 INFO - 'NO_EM_RESTART': '1', 14:31:09 INFO - 'PAGER': '/bin/cat', 14:31:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:31:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:09 INFO - 'PWD': '/builds/slave/test', 14:31:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:31:09 INFO - 'SHELL': '/bin/bash', 14:31:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SxMnO2eSq1/Listeners', 14:31:09 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 14:31:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:31:09 INFO - 'USER': 'cltbld', 14:31:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:31:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:31:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:09 INFO - 'XPC_FLAGS': '0x0', 14:31:09 INFO - 'XPC_SERVICE_NAME': '0', 14:31:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:31:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:31:09 INFO - Cleaning up... 14:31:09 INFO - Return code: 0 14:31:09 INFO - Running post-action listener: _resource_record_post_action 14:31:09 INFO - Running post-action listener: _start_resource_monitoring 14:31:09 INFO - Starting resource monitoring. 14:31:09 INFO - [mozharness: 2017-01-05 22:31:09.593132Z] Finished create-virtualenv step (success) 14:31:09 INFO - [mozharness: 2017-01-05 22:31:09.594077Z] Running install step. 14:31:09 INFO - Running pre-action listener: _resource_record_pre_action 14:31:09 INFO - Running main action method: install 14:31:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:31:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:31:09 INFO - Reading from file tmpfile_stdout 14:31:09 INFO - Detecting whether we're running mozinstall >=1.0... 14:31:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:31:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:31:09 INFO - Reading from file tmpfile_stdout 14:31:09 INFO - Output received: 14:31:09 INFO - Usage: mozinstall [options] installer 14:31:09 INFO - Options: 14:31:09 INFO - -h, --help show this help message and exit 14:31:09 INFO - -d DEST, --destination=DEST 14:31:09 INFO - Directory to install application into. [default: 14:31:09 INFO - "/builds/slave/test"] 14:31:09 INFO - --app=APP Application being installed. [default: firefox] 14:31:09 INFO - mkdir: /builds/slave/test/build/application 14:31:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:31:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.mac.dmg --destination /builds/slave/test/build/application 14:31:31 INFO - Reading from file tmpfile_stdout 14:31:31 INFO - Output received: 14:31:31 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 14:31:31 INFO - Running post-action listener: _resource_record_post_action 14:31:31 INFO - [mozharness: 2017-01-05 22:31:31.802278Z] Finished install step (success) 14:31:31 INFO - [mozharness: 2017-01-05 22:31:31.802411Z] Running run-tests step. 14:31:31 INFO - Running pre-action listener: _resource_record_pre_action 14:31:31 INFO - Running main action method: run_tests 14:31:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:31:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:31:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:31:31 INFO - 2017-01-05 14:31:31.816 screenresolution[1623:8250] starting screenresolution argv=screenresolution get 14:31:31 INFO - 2017-01-05 14:31:31.819 screenresolution[1623:8250] Display 0: 1600x1200x32@60 14:31:31 INFO - 2017-01-05 14:31:31.825 screenresolution[1624:8252] starting screenresolution argv=screenresolution list 14:31:31 INFO - Available Modes on Display 0 14:31:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:31:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:31:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:31:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:31:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:31:32 INFO - Intel Iris: 14:31:32 INFO - Chipset Model: Intel Iris 14:31:32 INFO - Type: GPU 14:31:32 INFO - Bus: Built-In 14:31:32 INFO - VRAM (Dynamic, Max): 1536 MB 14:31:32 INFO - Vendor: Intel (0x8086) 14:31:32 INFO - Device ID: 0x0a2e 14:31:32 INFO - Revision ID: 0x0009 14:31:32 INFO - Displays: 14:31:32 INFO - Display: 14:31:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:31:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:31:32 INFO - Display Serial Number: 1600x1200 60 14:31:32 INFO - Main Display: Yes 14:31:32 INFO - Mirror: Off 14:31:32 INFO - Online: Yes 14:31:32 INFO - Rotation: Supported 14:31:32 INFO - Return code: 0 14:31:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:31:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:31:32 INFO - Python 2.7.3 14:31:32 INFO - Return code: 0 14:31:32 INFO - grabbing minidump binary from tooltool 14:31:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:31:32 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 0x109a00d30>, '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 0x109866db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1099f8b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:31:32 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:31:32 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 14:31:32 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:31:32 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:31:32 INFO - Return code: 0 14:31:32 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:31:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:31:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:31:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:31:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:31:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e6fBqRQmRx65RTdlI8O9PQ/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0155', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:31:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/e6fBqRQmRx65RTdlI8O9PQ/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0155 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:31:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xSEb7wP775/Render', 14:31:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:31:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:31:32 INFO - 'HOME': '/Users/cltbld', 14:31:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:31:32 INFO - 'LOGNAME': 'cltbld', 14:31:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:31:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:31:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:32 INFO - 'MOZ_NO_REMOTE': '1', 14:31:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:31:32 INFO - 'NO_EM_RESTART': '1', 14:31:32 INFO - 'PAGER': '/bin/cat', 14:31:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:31:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:32 INFO - 'PWD': '/builds/slave/test', 14:31:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:31:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:31:32 INFO - 'SHELL': '/bin/bash', 14:31:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SxMnO2eSq1/Listeners', 14:31:32 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 14:31:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:31:32 INFO - 'USER': 'cltbld', 14:31:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:31:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:31:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:32 INFO - 'XPC_FLAGS': '0x0', 14:31:32 INFO - 'XPC_SERVICE_NAME': '0', 14:31:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:31:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e6fBqRQmRx65RTdlI8O9PQ/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0155', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:31:32 INFO - mozversion application_buildid: 20170105120613 14:31:32 INFO - mozversion application_changeset: 8b03928134689c8f0479f716d70bf65f2c644ec5 14:31:32 INFO - mozversion application_display_name: Firefox 14:31:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:31:32 INFO - mozversion application_name: Firefox 14:31:32 INFO - mozversion application_remotingname: firefox 14:31:32 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:31:32 INFO - mozversion application_vendor: Mozilla 14:31:32 INFO - mozversion application_version: 51.0 14:31:32 INFO - mozversion platform_buildid: 20170105120613 14:31:32 INFO - mozversion platform_changeset: 8b03928134689c8f0479f716d70bf65f2c644ec5 14:31:32 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:31:32 INFO - mozversion platform_version: 51.0 14:31:32 INFO - using testdate: 1483655492 14:31:32 INFO - actual date: 1483655492 14:31:32 INFO - starting webserver on 'localhost:49240' 14:31:32 INFO - SUITE-START | Running 2 tests 14:31:32 INFO - TEST-START | dromaeo_css 14:31:32 INFO - operating with platform_type : mac_ 14:31:32 INFO - Initialising browser for dromaeo_css test... 14:31:32 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/tmpqkDfQE/profile http://localhost:49240/getInfo.html) 14:31:34 INFO - PROCESS | 1634 | __metrics Screen width/height:1600/1200 14:31:34 INFO - PROCESS | 1634 | colorDepth:24 14:31:34 INFO - PROCESS | 1634 | Browser inner width/height: 1024/689 14:31:34 INFO - PROCESS | 1634 | __metrics 14:31:34 INFO - PROCESS | 1634 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:31:34 INFO - PROCESS | 1634 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:31:35 INFO - TEST-INFO | 1634: exit 0 14:31:35 INFO - Browser initialized. 14:31:35 INFO - Running cycle 1/1 for dromaeo_css test... 14:31:35 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/tmpqkDfQE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:31:47 INFO - PROCESS | 1638 | RSS: Main: 169037824 14:31:47 INFO - PROCESS | 1638 | 14:34:49 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 14:34:50 INFO - PROCESS | 1638 | RSS: Main: 277245952 14:34:50 INFO - PROCESS | 1638 | 14:37:53 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 14:37:53 INFO - PROCESS | 1638 | RSS: Main: 301023232 14:37:53 INFO - PROCESS | 1638 | 14:40:56 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 14:40:56 INFO - PROCESS | 1638 | RSS: Main: 286412800 14:40:56 INFO - PROCESS | 1638 | 14:43:58 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 14:43:59 INFO - PROCESS | 1638 | RSS: Main: 265211904 14:43:59 INFO - PROCESS | 1638 | 14:47:02 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 14:47:03 INFO - PROCESS | 1638 | RSS: Main: 260366336 14:47:03 INFO - PROCESS | 1638 | 14:50:06 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 14:50:06 INFO - PROCESS | 1638 | RSS: Main: 306675712 14:50:06 INFO - PROCESS | 1638 | 14:50:06 INFO - PROCESS | 1638 | __start_tp_report 14:50:06 INFO - PROCESS | 1638 | _x_x_mozilla_page_load 14:50:06 INFO - PROCESS | 1638 | _x_x_mozilla_page_load_details 14:50:06 INFO - PROCESS | 1638 | |i|pagename|runs| 14:50:06 INFO - PROCESS | 1638 | |0;dojo.html;3382.1713680148364;3418.7948723076615;3451.6893479586847;3464.8094354810473;3503.019154636701;5704.144378343245;5743.827685169441;5777.971110144444;5779.450952159538;5808.767649294034;5653.349864765553;5751.539876809856;5758.712064396774;5759.078547432412;5767.884642307162;5195.896082078356;5231.424543300234;5257.316548848645;5273.894522109575;5281.339832520935;5194.974025129888;5205.6616319939085;5213.165893457048;5323.8136665216725;5341.4658534146465;5225.869353266161;5239.318888544484;5247.291615631879;5272.736363181844;5312.256284120207;5254.65844720092;5257.631965762398;5325.254464374991;5326.2543243945875;5336.59975501835;4329.588689074533;5122.154844450662;5207.843764687065;5285.973570132125;5294.68231906083;5622.634528755659;5652.604317697763;5657.2928383952;5663.688497132656;5681.517071048966;6233.501319894398;6277.403646653561;6350.587211831263;6363.045543168516;6367.267764207129;6176.752929882799;6337.936620633781;6355.968220158916;6402.647854368008;6420.0048992406255;5744.913826292609;5752.309722833245;5787.450192231731;5803.332616749043;5805.36141024487;6293.30773614902;6328.905066424008;6342.5560210785725;6348.301686814447;6355.205599300088;6037.245344331958;6207.224096987877;6218.5647004709235;6220.875582488325;6230.7507699691505;6182.752689892354;6191.288001879751;6226.688665566703;6245.96877015612;6297.118403423525;5195.402528709247;6218.471429928507;6291.056341548713;6301.40136687014;6314.336994615591;6254.124422580842;6292;6323;6331.366863313724;6341.365863413714;4159.812808423628;4942.20924652054;4948.628852836052;4955.653104282737;5042.924356134661;4478.57453541913;4491.236489796743;4492.505824359318;4525.886852828639;4548.88627784308;5921.02303119989;5930.406959304035;5933.436323549256;5933.58464907461;5954.136650185786;6111.77406523465;6232.719527621268;6355.745770169141;6367.395097465734;6371.139896113966;5871.911921321183;5891.7054147292465;5917.171595976567;5953.166556682068;6014.09788531715;5476.151196564539;5479.150731636602;5484.067708489566;5485.040117979338;5490.890182196334;6261.96869015652;6322;6339.239291284891;6342.492600592034;6347.143135676717;6126.823043872828;6236.75052997875;6275.246970363585;6279.403456671609;6366.29970703213;5774.133879918046;5879.059350503899;6281.152044473937;6303.9684801575695;6338.239411270677;6253.7185826637;6263.937360626518;6278.46633036197;6281.277653069956;6283.37166283368;6128;6174.228221472316;6187.381261873777;6203.565750397429;6206.100115483139;5529.364123125892;6124.899720462962;6127.601705889103;6132.01899668756;6134.069235337226;5895.263092113486;6081.5134789217645;6095.634261944298;6095.634261944298;6102.7253773579405;4933.654644174873;5816.360200377871;5858.736356864037;5894.852628684317;5912.852178695567;6140.631562106288;6157.547319866312;6172.598781079216;6176.845578860564;6182.103594978613;5977.790777322773;5984.581079324405;6007.219061522149;6025.367336429612;6057.091436284592 14:50:06 INFO - PROCESS | 1638 | |1;ext.html;485.3956823754426;489.56184215127456;526.5419085395705;541.1287826599172;552.0752739161903;32377.190570235754;32870.50694239583;32882.177945551346;32943.67056329436;33886.813961511354;41172.38241426381;42373.152536949245;42391.57608423915;44362.11275774483;44394.890127746825;10042.246831487631;10214.591416343375;10216.693499195037;10216.79566408675;10221.386716796978;9362.625494980193;9615.56729947154;10013.198944084455;10116.291859569834;10133.391996480197;12271;12540.372981350942;12592;12738.87261127386;12758.617241482723;12456.06579506536;12522.248665080124;12528.874711252862;12535.498580056787;12536.31050292229;12293.877061229363;12371.75256494874;12383;12387;12387.504499819996;41074;41307.58692413067;41450.37824432636;41514.79242603798;41519;3291.9506207406907;3867.400552914303;3873.205992771475;3956.5647778744315;4064.512258528966;31469.685303146904;31521;31891.84054079738;31934.520982185284;32278;3239.951400728991;3367.8821241256683;3403.8978830634874;3407.6081250656243;3473.5831700195886;386512;387802;387945;388102;388193;35038.299234015176;35380.64619353774;35932.28135437277;35947.82026089853;59747.701261493414;30962;36121;36247.63752362495;36296.81851590725;36385.090372740364;15753.68492630141;15887.761683574756;15919.920400398156;15930.442434514736;15942.043477391393;13339;13457.461701532025;13478.730425391437;13481.865181348061;13673.86326136726;6693.698783554654;7560.243975602506;7789.3768498519985;7946.32456241226;7994.800129996796;3319.983400082984;3375.729941604715;3394.813285269334;3413.7269018478464;3423.8116903570044;942.6465075596651;1006.808706345792;1015.3400289811682;1048.6853943816825;1103.823388257875;30809.69190308113;31026.224344391572;31097.067087987398;31236.531452028237;31333.37333253322;1059.3749687684303;1070.5878236878857;1092.2845536173818;1131.6774719205152;1143.9428028598704;15423;15565.84434155644;15989.840101598835;16000.759893614902;16092.75860862088;600884;606387;607091;607793;610493;50988.235176472386;51729.482705172464;58143.709281453324;59098.704506477196;59131.70434147888;1415.2074838090703;1428.100296813022;1458.8103546539307;1461.3789139615621;1461.4008256614736;30061.676464878336;31700.524492132176;31867.20331991719;32058;32251.193720157185;55080;58697;58718;58748;58769.70615146897;668660;675353.6232318807;675773;675843;676684;44067.77966110149;44321.33517997297;45110.32334515051;45194.32208516809;45246.54753452423;47790;48498.27252591143;48967.020659587324;49099;49106.75446622744;39593.60406395899;39745.2050958985;40655.7967210162;41317.38023929704;41728.74813755592;34671.82664086663;40274.395884062345;40352.1200021796;40954.79522602368;41189.382159267036;39011.60988390193;39605.80197098996;39790.005249868984;40051.99870003273;40178.59821401749;34420.13949651279;35534.28931421409;35708.46437303391;36321;36554.63445365619;26116.60825087663;26445.867770661025;26623.60064598994;26738.267102930102;26746.86626566855 14:50:06 INFO - PROCESS | 1638 | |2;jquery.html;327.84099711639857;362.32245700539994;388.95527014393355;394.4339872283273;404.1694318176151;19685.117338350337;20581.691274630874;21551.568968620617;21773.020214090364;22091.005904734324;21367.6794848077;21683.45791355217;21808.454788630293;22135.557288854212;22275.331740047826;5931.911021334683;6046.818595442144;6164.29110652274;6327.050942358637;6352.205974253218;6224.782132625359;6245.46913512352;6272.184615999914;6285.968570157165;6302.212223472066;5975.701214939258;6190.473809726156;6230.968845155768;6270.623762574237;6271.9651257542455;5252.553532949704;5972.193753843219;6183.752649893999;6229.595076320047;6255.249370075598;5448.863778405532;5478.890422191574;5479.232907392969;5480.80817171401;5502.58730595207;26195;26654.86672566625;26657.600135997975;26814.5977810333;27064.1880743578;2111.831053515715;2378.8334816562847;2392.3899405651623;2515.8490490570625;2572.2926195296254;9973.202143828476;10278.691639250834;10497.317674351143;10685.893141068567;10842.891571084347;1808.4755420927916;1876.493346796371;1904.7997575528761;1916.5017095555118;1975.101328895349;103018;105689;119304;134350.32824835912;135075;11680.415979201007;11698.2981021139;11816.527338906519;11900.821487677691;12044.39778011096;13539.255340956144;14345.92827035879;15096.849031509764;15212.315445804965;15246.771298430533;7277.818054548678;8955.373123881396;9026.954865225633;9083.227925626263;9114.36199466031;9003.099690031075;9012.071076900034;9048.864267036;9148.542572871329;9188.90811091894;3967.78177200251;4576.519465456146;4632.62938964882;4671.719696818202;4702.177119004229;1707.5218938697185;1720.9655806883793;1887.5658598522143;1985.0967809646577;1999.5800881814691;895.3810105441557;895.8443607746065;1009.8939611340703;1026.93719960595;1052.5421441672897;20873.373798786062;21584.892075539836;21640.783592164193;21720.782792171874;21803;963.2486660404895;1001.1990407673977;1017.2014968249888;1028.0901402259055;1030.2067408095725;9101.40840845343;11350.432478376213;11395;11621.302721836717;11634.011109055826;631957;638241.8087909531;643892;644372;644639;136892;138869;140796.29601851926;143432;147361.26319368335;1002.9598816047422;1043.2644985285356;1078.309881675728;1078.4230436716318;1079.6545105566142;18829.058547072316;19177.712334315274;19510.90244548768;19551.70672439943;19556.60886782228;56453.43546564482;57002.714986424806;57985.420145798;58781.70609146927;59151.70424147852;82310.87617812844;84721.57639211764;84955.57522212349;86122;87101.56449217713;7114.581152093525;7248.34764871143;7635.732749353746;7785.571793551409;8221.465604735673;11153.776924461303;12625.936870315956;13133.080684352004;13597.932010339884;13739.175649461064;11146.721331966766;11281.7743645125;11411.37237451915;11691.532338706356;11707.707307317385;10820;11035.282706624044;11165.665030049111;11252.83120753173;11802.639472105442;11437.771244574895;11779.411029448665;11780.941095294469;11826.408679566159;11925.82111268349;7229.963850180716;7477.551346919202;7502.812429689083;7541.245875412635;7754.302112809874;8386.245237928615;10391.324563903323;11361;11544.365059921785;11667.59163429276 14:50:06 INFO - PROCESS | 1638 | |3;mootools.html;1210.910180837246;1527.6639139389338;1562.7187106320862;1761.621251430942;1920.1647283431716;7760.3791696664275;8181.754547363581;8327.83344333113;9261.073892610735;9265.629374825015;9097.181253687168;9200.26397888169;9208.217301529377;9210.815783684338;9239.076092390758;2392.1866565367773;2428.7935525480357;2430.9756902431013;2433.9513209735796;2435.914742983996;2365.775251351119;2395.197608801054;2409.674693916325;2411.8191135664897;2412.1678021082785;2376.0377047295874;2384.7615238476187;2394.5091256292503;2411.9990204065293;2413.155395611531;2358.2453614843257;2375.8574485530835;2380.4643955110137;2382.3918854773046;2396.496735685508;2353.458704497975;2366.6923299971068;2376.940576485584;2378.4172877644914;2379.1078345620394;9178.173964343174;9244.168024877794;9254.352195346328;9261.981182069967;9274.675386361445;5377.731113444352;5598.692071936042;5602.663840169603;5638.04153293941;5641.379448260729;3592.676659100667;3623.1304486923214;3659.908502287464;3661.9633803662155;3668.0829792551863;920.2821798996794;1065.8081545321838;1088.374184843718;1091.4651820607924;1112.5104953820373;11997.880021199851;12037.819432708517;12115.212511186744;12125.818112728404;12127.818082728767;4573.131105090089;4612.169809434334;4791.976040119846;4805.8946442318465;4809.422869255712;9486.715398538056;9526.237900967906;9526.85709714355;9526.85709714355;9528.237740980705;4914.90170196594;5258.894822103536;5452.345718513724;5452.727363631882;5453.536449401766;4335.30635098389;4564.88587785308;4719.834805781781;4731.668783185144;5090.796368145233;3907.9218415631526;3937.3897045957924;3996.900077498086;4026.9194616107516;4036.091879327128;1197.3115458611333;1204.6506513111274;1208.4078801387257;1210.3706072842074;1219.6950762309423;760.6158889760635;857.9313654907593;901.5131828812499;912.7946212102224;923.5013092929877;5752.741126649311;5763.106718458645;5773.364929857712;5906.734196961061;6122.418370254819;862.4997501449144;897.434616191795;915.1260546178383;931.6832277025844;955.6655170690203;3781.6596506314563;3827.13889374894;3833.750806197588;3879.165979314461;3970.186111847122;10909.781804363869;11348.432578371048;11359.716007099889;11365.829512557319;11367.772644547063;11305.982461578498;11321.94339028316;11341.603043893589;11348.375839328915;11380.94309528447;6666.699998500079;8411.957940210383;8539.74380768578;8694.652213911373;8702.216800487986;5946.345901950695;5992.970035149797;6024.819255422344;6049.879002420015;6070.2412198475195;10052.396856188652;10222.948885255526;10407.68776936693;10436.37381757097;10436.478176091317;9592.472414017016;10314.690559283234;10588.788224235319;10619.94690026545;10771.030607245386;6687.1975362956755;7675.117361503499;7777;7872.448928574945;7877.133515313197;7777.650005749641;8294.046184688837;8582.399232053696;8609.870851937101;8728.039915609152;7687.769366919001;7727.574983375968;7733.033370828646;7761.573113478813;7817.804554886174;7447.329740323397;7528.20953799865;7588.772336829904;7634.4655874088285;7644.80887977805;6811.625360605214;6931.68807403658;7024;7054.188768291712;7139.643017849191;4952.504749525163;4999.925001125059;5001.599872010158;5034.993001399808;5084.949150508595;4925.039617274597;4939.456659767495;4946.82686105999;5097.464766199644;5116.1046816806165 14:50:06 INFO - PROCESS | 1638 | |4;prototype.html;296.6721772441452;302.84857571214377;307.6631088957592;313.14199094481114;315.2371261547056;5113.821016264432;5299.648589609649;5343.412224655294;5343.759530821113;5352.946470535294;4280.78596070196;4406.669499787513;5174.301469301643;5174.767135478903;5276.551493123079;3541.521894544242;3889.81360684991;3896.123372241251;4022.8994275143136;4066.2274167908004;3966.424868394081;4033.596640335972;4103.528094269167;4118.258713431596;4118.876433706979;3348.7990720556722;4031.8387264509383;4056.6146216109423;4060.7157498975084;4106.733062350938;4034.5158580970324;4044.775373544568;4045.41341505483;4066.816993235282;4082.530508991474;3037.6506701729363;3472.2361080562237;3496.947545786815;3540.477594634306;3558.181618227822;5081.161608334621;5085.457271364317;5089.41471730752;5094.566961808214;5111.642185047048;3882.4758657581147;4198.71939058587;4581.748003859786;4587.42657167854;4596.368289257332;4912.950870491285;5160.277561141444;5217.373915130171;5543.334799824007;5568.716826101319;3780.7145570505886;3797.487339209199;3799.639034291738;3805.5813860475328;3830.3488406970882;4584.954150458486;5700.37295897451;5768.855778605526;5870.295564532241;5928.199693041471;3093.3194697166587;3247.886323978649;3864.30442520349;3867.303885300673;3876.0116170376373;3595.8741444049333;3891.4162875568327;3892.404114313118;3917.3144699678014;3929.6659783918685;3882.5535063468064;4184.644305234089;4301.698881078294;4481.574250446202;4547.545245475492;5116;5565.582581306418;5583.553315734732;5585.218069470277;5595.664260144323;1230.9015278777676;1271.3706715175863;1326.5953884065452;1338.4846833968993;1341.745068436994;789.8547106695315;798.3014861995754;816.9509829410255;822.4325215601216;830.3896635972555;3879.2241551689212;4264.424302719155;4443.622661875881;4459.799309031101;4463.843765468193;4010.3130902295534;4412.933805992912;4708.882277943078;4792.9281060784115;4818.518148185223;3561.1837962638724;3947.921041579152;4056.7971601419813;4329.567043295645;4429.689921705514;2202.9008694608783;2240.2271216430304;2256.424611724;2258.90964361427;2494.538510375586;4550.908981820345;4917.0577621839175;4922.90154196914;4933.50664933511;4954.95945851368;4679.578837904605;4828.985912958248;4842.903141937212;4864.683795553348;4902.2156454967035;3985.940210896897;4299.516666749966;4322.805473753626;4376.098769378316;4919.950800492021;3994.320965435941;4380.737155770664;4520.276755719069;4663.090697313991;4670.883227919329;3875.767453952772;4685.4143232095985;4698.882527936692;4748.810047598057;4773.546513081252;4183.937240941449;4384.517703052726;4591.517890621437;4889.535494128052;5818.040023396092;3656.213914008501;3737.570179429292;3774.2828862516035;3852.345101332724;3893.5133108361456;5664.603477756517;5688.857778555569;5696.031674615242;5705.857353566194;5715.085586306171;5390.460953904578;5680.630759000652;5691.686957217393;5704.828855134353;5736.942630573641;4713.114754098388;5172.965406918706;5333.386660534088;5361.383440904346;5707.486326230659;4666.323383109498;4837.685550439211;5481.6287982889435;5489.231507588861;5565;4633.976830115827;4655.743934083658;5593.636413633101;5622.297212848394;5637.731510410125;4896.338994235733;5232.293640358503;5500.9823182711325;5544.417836127149;5561.582881284001 14:50:06 INFO - PROCESS | 1638 | |5;yui.html;631.4222486424921;721.8375865430277;733.361975081679;740.5815714121518;743.323575546253;16889.32442702292;17429.651406971883;17439.21523531441;17477.82522174778;17975.550611234725;16144.75782863255;16355.83644163558;16738.497845064638;16745.320748680213;16758.664826703458;723.2116992478198;738.4535443771597;867.5055218525443;869.4609342207808;890.6971629645919;870.7997160653053;893.7274131389923;894.3426581462652;896.0143841774062;896.3143195455482;954.89973552777;955.4362925873733;959.1080295325345;959.2613687460652;960.9813597586581;951.2912879904516;951.9381240219363;952.2762700347786;952.5427794658568;954.3510412919212;707.8548897476005;709.1915216653019;709.7906117695293;711.4557363616838;712.1205311440367;15272.847271527253;15496.225188740518;15524.61188470286;15541.533753987398;15548.76676849848;14248.643783905381;14318.71362572753;14387;14421.908823220574;14452.927735361362;9325.673601423985;11890.702732431671;11921.880781192163;11971.760564788743;12093.758124837454;3831.0230891122865;3896.3960586109197;3969.6824254059607;3984.442178095069;4007.5992400759983;122061.38969305097;122783;123102;125340;127807;10970.835437468444;11363.488643011084;11458.968692817687;11510.712232194262;11933.701657458632;25114.24657260285;25133.748662513142;25160.496790064095;25176.748232517806;25587.23238302854;8263.834723305621;8308.376871734523;8319.251267385844;8353.20644538768;8368.414211005293;4301.956980430155;4345.783180709406;4433;4505.301678239878;4510.300903359985;3181.5227715842807;3592.7485076044427;3801.1067399161175;3802.372608519563;3805.1058001369656;600.8497875531117;657.7215215026318;689.2762599270745;691.4675699711195;701.8280521272321;538.3485981961792;571.5770329955886;663.2074670768385;687.0861753867345;696.4115322552435;8381.622826972802;9202.677906273382;9329.253659707207;9364.95317523408;9515.191208747334;605.2192671453863;629.2260519560874;688.8312363470982;693.8716337477583;703.6657587645827;4051.554329023805;4213.831446742096;4295.699301048959;4485.46174459067;4562.749048802348;130177;131932.34033829768;137645;154929.22535387252;155183;125160;128664;129340;130812;133122.66877331297;73082.53834923272;79805;107601;118269;119165;9338;9757.658481953098;9950.000995996199;10086.8486972694;10104.938981406847;62607.37392626015;62859;64253;64869.35130648633;65423;88240.55879720561;90246;93029;96352;96503;13056.020798440344;13380.598582042554;13580.864191358356;13663.590092297247;13802;13558;14095.647608809863;14645.560633181021;14986.17576033285;15263.618409539406;13330.733385332045;13492.5277615283;13628.182309061489;14215.431382744575;14305.141691498544;13427.395767190696;13752.793708094587;14160;14244.786328205293;14294.28528573588;13211.933940330237;13220.867791321964;13440.663983400493;13633.223839506376;13839.792403114163;9227.261819054595;9961.551730172016;10702.518386672775;11046.392448415414;11222.382768947786;11333.979941804948;11533.596324128615;11681.824772628588;11766.529338826693;11839.467223974769 14:50:06 INFO - PROCESS | 1638 | __end_tp_report 14:50:06 INFO - PROCESS | 1638 | __start_cc_report 14:50:06 INFO - PROCESS | 1638 | _x_x_mozilla_cycle_collect,1045 14:50:06 INFO - PROCESS | 1638 | __end_cc_report 14:50:06 INFO - PROCESS | 1638 | __startTimestamp1483656606356__endTimestamp 14:50:06 INFO - PROCESS | 1638 | 14:50:06 INFO - PROCESS | 1638 | ------- Summary: start ------- 14:50:06 INFO - PROCESS | 1638 | Number of tests: 6 14:50:06 INFO - PROCESS | 1638 | 14:50:06 INFO - PROCESS | 1638 | [#0] dojo.html Cycles:165 Average:5766.30 Median:5953.17 stddev:647.94 (10.9%) stddev-sans-first:622.35 14:50:06 INFO - PROCESS | 1638 | Values: 3382.2 3418.8 3451.7 3464.8 3503.0 5704.1 5743.8 5778.0 5779.5 5808.8 5653.3 5751.5 5758.7 5759.1 5767.9 5195.9 5231.4 5257.3 5273.9 5281.3 5195.0 5205.7 5213.2 5323.8 5341.5 5225.9 5239.3 5247.3 5272.7 5312.3 5254.7 5257.6 5325.3 5326.3 5336.6 4329.6 5122.2 5207.8 5286.0 5294.7 5622.6 5652.6 5657.3 5663.7 5681.5 6233.5 6277.4 6350.6 6363.0 6367.3 6176.8 6337.9 6356.0 6402.6 6420.0 5744.9 5752.3 5787.5 5803.3 5805.4 6293.3 6328.9 6342.6 6348.3 6355.2 6037.2 6207.2 6218.6 6220.9 6230.8 6182.8 6191.3 6226.7 6246.0 6297.1 5195.4 6218.5 6291.1 6301.4 6314.3 6254.1 6292.0 6323.0 6331.4 6341.4 4159.8 4942.2 4948.6 4955.7 5042.9 4478.6 4491.2 4492.5 4525.9 4548.9 5921.0 5930.4 5933.4 5933.6 5954.1 6111.8 6232.7 6355.7 6367.4 6371.1 5871.9 5891.7 5917.2 5953.2 6014.1 5476.2 5479.2 5484.1 5485.0 5490.9 6262.0 6322.0 6339.2 6342.5 6347.1 6126.8 6236.8 6275.2 6279.4 6366.3 5774.1 5879.1 6281.2 6304.0 6338.2 6253.7 6263.9 6278.5 6281.3 6283.4 6128.0 6174.2 6187.4 6203.6 6206.1 5529.4 6124.9 6127.6 6132.0 6134.1 5895.3 6081.5 6095.6 6095.6 6102.7 4933.7 5816.4 5858.7 5894.9 5912.9 6140.6 6157.5 6172.6 6176.8 6182.1 5977.8 5984.6 6007.2 6025.4 6057.1 14:50:06 INFO - PROCESS | 1638 | 14:50:06 INFO - PROCESS | 1638 | [#1] ext.html Cycles:180 Average:68623.08 Median:19255.94 stddev:152564.81 (792.3%) stddev-sans-first:152907.02 14:50:06 INFO - PROCESS | 1638 | Values: 485.4 489.6 526.5 541.1 552.1 32377.2 32870.5 32882.2 32943.7 33886.8 41172.4 42373.2 42391.6 44362.1 44394.9 10042.2 10214.6 10216.7 10216.8 10221.4 9362.6 9615.6 10013.2 10116.3 10133.4 12271.0 12540.4 12592.0 12738.9 12758.6 12456.1 12522.2 12528.9 12535.5 12536.3 12293.9 12371.8 12383.0 12387.0 12387.5 41074.0 41307.6 41450.4 41514.8 41519.0 3292.0 3867.4 3873.2 3956.6 4064.5 31469.7 31521.0 31891.8 31934.5 32278.0 3240.0 3367.9 3403.9 3407.6 3473.6 386512.0 387802.0 387945.0 388102.0 388193.0 35038.3 35380.6 35932.3 35947.8 59747.7 30962.0 36121.0 36247.6 36296.8 36385.1 15753.7 15887.8 15919.9 15930.4 15942.0 13339.0 13457.5 13478.7 13481.9 13673.9 6693.7 7560.2 7789.4 7946.3 7994.8 3320.0 3375.7 3394.8 3413.7 3423.8 942.6 1006.8 1015.3 1048.7 1103.8 30809.7 31026.2 31097.1 31236.5 31333.4 1059.4 1070.6 1092.3 1131.7 1143.9 15423.0 15565.8 15989.8 16000.8 16092.8 600884.0 606387.0 607091.0 607793.0 610493.0 50988.2 51729.5 58143.7 59098.7 59131.7 1415.2 1428.1 1458.8 1461.4 1461.4 30061.7 31700.5 31867.2 32058.0 32251.2 55080.0 58697.0 58718.0 58748.0 58769.7 668660.0 675353.6 675773.0 675843.0 676684.0 44067.8 44321.3 45110.3 45194.3 45246.5 47790.0 48498.3 48967.0 49099.0 49106.8 39593.6 39745.2 40655.8 41317.4 41728.7 34671.8 40274.4 40352.1 40954.8 41189.4 39011.6 39605.8 39790.0 40052.0 40178.6 34420.1 35534.3 35708.5 36321.0 36554.6 26116.6 26445.9 26623.6 26738.3 26746.9 14:50:06 INFO - PROCESS | 1638 | 14:50:06 INFO - PROCESS | 1638 | [#2] jquery.html Cycles:180 Average:37165.69 Median:21805.73 stddev:107015.92 (490.8%) stddev-sans-first:107280.39 14:50:06 INFO - PROCESS | 1638 | Values: 327.8 362.3 389.0 394.4 404.2 19685.1 20581.7 21551.6 21773.0 22091.0 21367.7 21683.5 21808.5 22135.6 22275.3 5931.9 6046.8 6164.3 6327.1 6352.2 6224.8 6245.5 6272.2 6286.0 6302.2 5975.7 6190.5 6231.0 6270.6 6272.0 5252.6 5972.2 6183.8 6229.6 6255.2 5448.9 5478.9 5479.2 5480.8 5502.6 26195.0 26654.9 26657.6 26814.6 27064.2 2111.8 2378.8 2392.4 2515.8 2572.3 9973.2 10278.7 10497.3 10685.9 10842.9 1808.5 1876.5 1904.8 1916.5 1975.1 103018.0 105689.0 119304.0 134350.3 135075.0 11680.4 11698.3 11816.5 11900.8 12044.4 13539.3 14345.9 15096.8 15212.3 15246.8 7277.8 8955.4 9027.0 9083.2 9114.4 9003.1 9012.1 9048.9 9148.5 9188.9 3967.8 4576.5 4632.6 4671.7 4702.2 1707.5 1721.0 1887.6 1985.1 1999.6 895.4 895.8 1009.9 1026.9 1052.5 20873.4 21584.9 21640.8 21720.8 21803.0 963.2 1001.2 1017.2 1028.1 1030.2 9101.4 11350.4 11395.0 11621.3 11634.0 631957.0 638241.8 643892.0 644372.0 644639.0 136892.0 138869.0 140796.3 143432.0 147361.3 1003.0 1043.3 1078.3 1078.4 1079.7 18829.1 19177.7 19510.9 19551.7 19556.6 56453.4 57002.7 57985.4 58781.7 59151.7 82310.9 84721.6 84955.6 86122.0 87101.6 7114.6 7248.3 7635.7 7785.6 8221.5 11153.8 12625.9 13133.1 13597.9 13739.2 11146.7 11281.8 11411.4 11691.5 11707.7 10820.0 11035.3 11165.7 11252.8 11802.6 11437.8 11779.4 11780.9 11826.4 11925.8 7230.0 7477.6 7502.8 7541.2 7754.3 8386.2 10391.3 11361.0 11544.4 11667.6 14:50:06 INFO - PROCESS | 1638 | 14:50:06 INFO - PROCESS | 1638 | [#3] mootools.html Cycles:180 Average:5823.79 Median:4949.67 stddev:3322.25 (67.1%) stddev-sans-first:3313.47 14:50:06 INFO - PROCESS | 1638 | Values: 1210.9 1527.7 1562.7 1761.6 1920.2 7760.4 8181.8 8327.8 9261.1 9265.6 9097.2 9200.3 9208.2 9210.8 9239.1 2392.2 2428.8 2431.0 2434.0 2435.9 2365.8 2395.2 2409.7 2411.8 2412.2 2376.0 2384.8 2394.5 2412.0 2413.2 2358.2 2375.9 2380.5 2382.4 2396.5 2353.5 2366.7 2376.9 2378.4 2379.1 9178.2 9244.2 9254.4 9262.0 9274.7 5377.7 5598.7 5602.7 5638.0 5641.4 3592.7 3623.1 3659.9 3662.0 3668.1 920.3 1065.8 1088.4 1091.5 1112.5 11997.9 12037.8 12115.2 12125.8 12127.8 4573.1 4612.2 4792.0 4805.9 4809.4 9486.7 9526.2 9526.9 9526.9 9528.2 4914.9 5258.9 5452.3 5452.7 5453.5 4335.3 4564.9 4719.8 4731.7 5090.8 3907.9 3937.4 3996.9 4026.9 4036.1 1197.3 1204.7 1208.4 1210.4 1219.7 760.6 857.9 901.5 912.8 923.5 5752.7 5763.1 5773.4 5906.7 6122.4 862.5 897.4 915.1 931.7 955.7 3781.7 3827.1 3833.8 3879.2 3970.2 10909.8 11348.4 11359.7 11365.8 11367.8 11306.0 11321.9 11341.6 11348.4 11380.9 6666.7 8412.0 8539.7 8694.7 8702.2 5946.3 5993.0 6024.8 6049.9 6070.2 10052.4 10222.9 10407.7 10436.4 10436.5 9592.5 10314.7 10588.8 10619.9 10771.0 6687.2 7675.1 7777.0 7872.4 7877.1 7777.7 8294.0 8582.4 8609.9 8728.0 7687.8 7727.6 7733.0 7761.6 7817.8 7447.3 7528.2 7588.8 7634.5 7644.8 6811.6 6931.7 7024.0 7054.2 7139.6 4952.5 4999.9 5001.6 5035.0 5084.9 4925.0 4939.5 4946.8 5097.5 5116.1 14:50:06 INFO - PROCESS | 1638 | 14:50:06 INFO - PROCESS | 1638 | [#4] prototype.html Cycles:180 Average:4234.55 Median:4549.23 stddev:1296.79 (28.5%) stddev-sans-first:1266.29 14:50:06 INFO - PROCESS | 1638 | Values: 296.7 302.8 307.7 313.1 315.2 5113.8 5299.6 5343.4 5343.8 5352.9 4280.8 4406.7 5174.3 5174.8 5276.6 3541.5 3889.8 3896.1 4022.9 4066.2 3966.4 4033.6 4103.5 4118.3 4118.9 3348.8 4031.8 4056.6 4060.7 4106.7 4034.5 4044.8 4045.4 4066.8 4082.5 3037.7 3472.2 3496.9 3540.5 3558.2 5081.2 5085.5 5089.4 5094.6 5111.6 3882.5 4198.7 4581.7 4587.4 4596.4 4913.0 5160.3 5217.4 5543.3 5568.7 3780.7 3797.5 3799.6 3805.6 3830.3 4585.0 5700.4 5768.9 5870.3 5928.2 3093.3 3247.9 3864.3 3867.3 3876.0 3595.9 3891.4 3892.4 3917.3 3929.7 3882.6 4184.6 4301.7 4481.6 4547.5 5116.0 5565.6 5583.6 5585.2 5595.7 1230.9 1271.4 1326.6 1338.5 1341.7 789.9 798.3 817.0 822.4 830.4 3879.2 4264.4 4443.6 4459.8 4463.8 4010.3 4412.9 4708.9 4792.9 4818.5 3561.2 3947.9 4056.8 4329.6 4429.7 2202.9 2240.2 2256.4 2258.9 2494.5 4550.9 4917.1 4922.9 4933.5 4955.0 4679.6 4829.0 4842.9 4864.7 4902.2 3985.9 4299.5 4322.8 4376.1 4920.0 3994.3 4380.7 4520.3 4663.1 4670.9 3875.8 4685.4 4698.9 4748.8 4773.5 4183.9 4384.5 4591.5 4889.5 5818.0 3656.2 3737.6 3774.3 3852.3 3893.5 5664.6 5688.9 5696.0 5705.9 5715.1 5390.5 5680.6 5691.7 5704.8 5736.9 4713.1 5173.0 5333.4 5361.4 5707.5 4666.3 4837.7 5481.6 5489.2 5565.0 4634.0 4655.7 5593.6 5622.3 5637.7 4896.3 5232.3 5501.0 5544.4 5561.6 14:50:06 INFO - PROCESS | 1638 | 14:50:06 INFO - PROCESS | 1638 | [#5] yui.html Cycles:180 Average:25166.36 Median:3803.74 stddev:39602.98 (1041.2%) stddev-sans-first:39671.23 14:50:06 INFO - PROCESS | 1638 | Values: 631.4 721.8 733.4 740.6 743.3 16889.3 17429.7 17439.2 17477.8 17975.6 16144.8 16355.8 16738.5 16745.3 16758.7 723.2 738.5 867.5 869.5 890.7 870.8 893.7 894.3 896.0 896.3 954.9 955.4 959.1 959.3 961.0 951.3 951.9 952.3 952.5 954.4 707.9 709.2 709.8 711.5 712.1 15272.8 15496.2 15524.6 15541.5 15548.8 14248.6 14318.7 14387.0 14421.9 14452.9 9325.7 11890.7 11921.9 11971.8 12093.8 3831.0 3896.4 3969.7 3984.4 4007.6 122061.4 122783.0 123102.0 125340.0 127807.0 10970.8 11363.5 11459.0 11510.7 11933.7 25114.2 25133.7 25160.5 25176.7 25587.2 8263.8 8308.4 8319.3 8353.2 8368.4 4302.0 4345.8 4433.0 4505.3 4510.3 3181.5 3592.7 3801.1 3802.4 3805.1 600.8 657.7 689.3 691.5 701.8 538.3 571.6 663.2 687.1 696.4 8381.6 9202.7 9329.3 9365.0 9515.2 605.2 629.2 688.8 693.9 703.7 4051.6 4213.8 4295.7 4485.5 4562.7 130177.0 131932.3 137645.0 154929.2 155183.0 125160.0 128664.0 129340.0 130812.0 133122.7 73082.5 79805.0 107601.0 118269.0 119165.0 9338.0 9757.7 9950.0 10086.8 10104.9 62607.4 62859.0 64253.0 64869.4 65423.0 88240.6 90246.0 93029.0 96352.0 96503.0 13056.0 13380.6 13580.9 13663.6 13802.0 13558.0 14095.6 14645.6 14986.2 15263.6 13330.7 13492.5 13628.2 14215.4 14305.1 13427.4 13752.8 14160.0 14244.8 14294.3 13211.9 13220.9 13440.7 13633.2 13839.8 9227.3 9961.6 10702.5 11046.4 11222.4 11334.0 11533.6 11681.8 11766.5 11839.5 14:50:06 INFO - PROCESS | 1638 | -------- Summary: end -------- 14:50:06 INFO - PROCESS | 1638 | 14:50:06 INFO - TEST-INFO | 1638: exit 0 14:50:06 INFO - TEST-OK | dromaeo_css | took 1114581ms 14:50:06 INFO - TEST-START | kraken 14:50:06 INFO - operating with platform_type : mac_ 14:50:06 INFO - Initialising browser for kraken test... 14:50:07 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/tmpLi7sYn/profile http://localhost:49240/getInfo.html) 14:50:09 INFO - PROCESS | 1645 | __metrics Screen width/height:1600/1200 14:50:09 INFO - PROCESS | 1645 | colorDepth:24 14:50:09 INFO - PROCESS | 1645 | Browser inner width/height: 1024/689 14:50:09 INFO - PROCESS | 1645 | __metrics 14:50:09 INFO - PROCESS | 1645 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:50:09 INFO - PROCESS | 1645 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:50:09 INFO - TEST-INFO | 1645: exit 0 14:50:09 INFO - Browser initialized. 14:50:09 INFO - Running cycle 1/1 for kraken test... 14:50:09 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/tmpLi7sYn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:50:21 INFO - PROCESS | 1647 | RSS: Main: 168849408 14:50:21 INFO - PROCESS | 1647 | 14:50:24 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 14:50:25 INFO - PROCESS | 1647 | RSS: Main: 218603520 14:50:25 INFO - PROCESS | 1647 | 14:50:27 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 14:50:28 INFO - PROCESS | 1647 | RSS: Main: 232296448 14:50:28 INFO - PROCESS | 1647 | 14:50:31 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 14:50:32 INFO - PROCESS | 1647 | RSS: Main: 330493952 14:50:32 INFO - PROCESS | 1647 | 14:50:34 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 14:50:34 INFO - PROCESS | 1647 | RSS: Main: 228417536 14:50:34 INFO - PROCESS | 1647 | 14:50:36 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:50:37 INFO - PROCESS | 1647 | RSS: Main: 229163008 14:50:37 INFO - PROCESS | 1647 | 14:50:39 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 14:50:40 INFO - PROCESS | 1647 | RSS: Main: 266326016 14:50:40 INFO - PROCESS | 1647 | 14:50:43 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 14:50:43 INFO - PROCESS | 1647 | RSS: Main: 268967936 14:50:43 INFO - PROCESS | 1647 | 14:50:46 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 14:50:47 INFO - PROCESS | 1647 | RSS: Main: 266719232 14:50:47 INFO - PROCESS | 1647 | 14:50:48 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:50:49 INFO - PROCESS | 1647 | RSS: Main: 240340992 14:50:49 INFO - PROCESS | 1647 | 14:50:51 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:50:51 INFO - PROCESS | 1647 | RSS: Main: 246108160 14:50:51 INFO - PROCESS | 1647 | 14:50:53 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:50:54 INFO - PROCESS | 1647 | RSS: Main: 251633664 14:50:54 INFO - PROCESS | 1647 | 14:50:57 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:50:57 INFO - PROCESS | 1647 | RSS: Main: 277225472 14:50:57 INFO - PROCESS | 1647 | 14:51:00 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:51:01 INFO - PROCESS | 1647 | RSS: Main: 266063872 14:51:01 INFO - PROCESS | 1647 | 14:51:02 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 14:51:03 INFO - PROCESS | 1647 | RSS: Main: 309911552 14:51:03 INFO - PROCESS | 1647 | 14:51:03 INFO - PROCESS | 1647 | __start_tp_report 14:51:03 INFO - PROCESS | 1647 | _x_x_mozilla_page_load 14:51:03 INFO - PROCESS | 1647 | _x_x_mozilla_page_load_details 14:51:03 INFO - PROCESS | 1647 | |i|pagename|runs| 14:51:03 INFO - PROCESS | 1647 | |0;ai-astar;114;113;112;112;111;113;117;117;112;112 14:51:03 INFO - PROCESS | 1647 | |1;audio-beat-detection;142;110;108;141;108;108;107;105;136;107 14:51:03 INFO - PROCESS | 1647 | |2;audio-dft;181;185;182;186;218;183;184;185;182;182 14:51:03 INFO - PROCESS | 1647 | |3;audio-fft;80;59;60;86;61;60;58;60;81;57 14:51:03 INFO - PROCESS | 1647 | |4;audio-oscillator;87;70;92;72;66;68;91;67;69;90 14:51:03 INFO - PROCESS | 1647 | |5;imaging-gaussian-blur;88;86;88;86;87;84;89;84;88;85 14:51:03 INFO - PROCESS | 1647 | |6;imaging-darkroom;93;93;93;93;93;92;93;93;93;92 14:51:03 INFO - PROCESS | 1647 | |7;imaging-desaturate;86;85;84;84;83;85;86;86;84;84 14:51:03 INFO - PROCESS | 1647 | |8;json-parse-financial;56;53;54;54;57;59;57;55;59;56 14:51:03 INFO - PROCESS | 1647 | |9;json-stringify-tinderbox;66;71;81;70;71;67;69;69;68;70 14:51:03 INFO - PROCESS | 1647 | |10;stanford-crypto-aes;85;87;81;81;80;83;85;81;88;99 14:51:03 INFO - PROCESS | 1647 | |11;stanford-crypto-ccm;137;134;131;144;145;149;135;135;140;136 14:51:03 INFO - PROCESS | 1647 | |12;stanford-crypto-pbkdf2;161;162;160;158;170;160;162;158;159;158 14:51:03 INFO - PROCESS | 1647 | |13;stanford-crypto-sha256-iterative;64;65;66;65;65;64;71;67;65;66 14:51:03 INFO - PROCESS | 1647 | __end_tp_report 14:51:03 INFO - PROCESS | 1647 | __start_cc_report 14:51:03 INFO - PROCESS | 1647 | _x_x_mozilla_cycle_collect,1840 14:51:03 INFO - PROCESS | 1647 | __end_cc_report 14:51:03 INFO - PROCESS | 1647 | __startTimestamp1483656663225__endTimestamp 14:51:03 INFO - PROCESS | 1647 | 14:51:03 INFO - PROCESS | 1647 | ------- Summary: start ------- 14:51:03 INFO - PROCESS | 1647 | Number of tests: 14 14:51:03 INFO - PROCESS | 1647 | 14:51:03 INFO - PROCESS | 1647 | [#0] ai-astar Cycles:10 Average:113.30 Median:113.00 stddev:2.11 (1.9%) stddev-sans-first:2.22 14:51:03 INFO - PROCESS | 1647 | Values: 114.0 113.0 112.0 112.0 111.0 113.0 117.0 117.0 112.0 112.0 14:51:03 INFO - PROCESS | 1647 | 14:51:03 INFO - PROCESS | 1647 | [#1] audio-beat-detection Cycles:10 Average:117.20 Median:109.00 stddev:15.63 (14.3%) stddev-sans-first:13.76 14:51:03 INFO - PROCESS | 1647 | Values: 142.0 110.0 108.0 141.0 108.0 108.0 107.0 105.0 136.0 107.0 14:51:03 INFO - PROCESS | 1647 | 14:51:03 INFO - PROCESS | 1647 | [#2] audio-dft Cycles:10 Average:186.80 Median:184.50 stddev:11.08 (6.0%) stddev-sans-first:11.56 14:51:03 INFO - PROCESS | 1647 | Values: 181.0 185.0 182.0 186.0 218.0 183.0 184.0 185.0 182.0 182.0 14:51:03 INFO - PROCESS | 1647 | 14:51:03 INFO - PROCESS | 1647 | [#3] audio-fft Cycles:10 Average:66.20 Median:60.50 stddev:11.29 (18.7%) stddev-sans-first:10.82 14:51:03 INFO - PROCESS | 1647 | Values: 80.0 59.0 60.0 86.0 61.0 60.0 58.0 60.0 81.0 57.0 14:51:03 INFO - PROCESS | 1647 | 14:51:03 INFO - PROCESS | 1647 | [#4] audio-oscillator Cycles:10 Average:77.20 Median:79.50 stddev:11.20 (14.1%) stddev-sans-first:11.31 14:51:03 INFO - PROCESS | 1647 | Values: 87.0 70.0 92.0 72.0 66.0 68.0 91.0 67.0 69.0 90.0 14:51:03 INFO - PROCESS | 1647 | 14:51:03 INFO - PROCESS | 1647 | [#5] imaging-gaussian-blur Cycles:10 Average:86.50 Median:87.50 stddev:1.78 (2.0%) stddev-sans-first:1.80 14:51:03 INFO - PROCESS | 1647 | Values: 88.0 86.0 88.0 86.0 87.0 84.0 89.0 84.0 88.0 85.0 14:51:03 INFO - PROCESS | 1647 | 14:51:03 INFO - PROCESS | 1647 | [#6] imaging-darkroom Cycles:10 Average:92.80 Median:93.00 stddev:0.42 (0.5%) stddev-sans-first:0.44 14:51:03 INFO - PROCESS | 1647 | Values: 93.0 93.0 93.0 93.0 93.0 92.0 93.0 93.0 93.0 92.0 14:51:03 INFO - PROCESS | 1647 | 14:51:03 INFO - PROCESS | 1647 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:1.06 (1.2%) stddev-sans-first:1.01 14:51:03 INFO - PROCESS | 1647 | Values: 86.0 85.0 84.0 84.0 83.0 85.0 86.0 86.0 84.0 84.0 14:51:03 INFO - PROCESS | 1647 | 14:51:03 INFO - PROCESS | 1647 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.50 stddev:2.05 (3.6%) stddev-sans-first:2.18 14:51:03 INFO - PROCESS | 1647 | Values: 56.0 53.0 54.0 54.0 57.0 59.0 57.0 55.0 59.0 56.0 14:51:03 INFO - PROCESS | 1647 | 14:51:03 INFO - PROCESS | 1647 | [#9] json-stringify-tinderbox Cycles:10 Average:70.20 Median:70.00 stddev:4.13 (5.9%) stddev-sans-first:4.09 14:51:03 INFO - PROCESS | 1647 | Values: 66.0 71.0 81.0 70.0 71.0 67.0 69.0 69.0 68.0 70.0 14:51:03 INFO - PROCESS | 1647 | 14:51:03 INFO - PROCESS | 1647 | [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:85.00 stddev:5.64 (6.6%) stddev-sans-first:5.98 14:51:03 INFO - PROCESS | 1647 | Values: 85.0 87.0 81.0 81.0 80.0 83.0 85.0 81.0 88.0 99.0 14:51:03 INFO - PROCESS | 1647 | 14:51:03 INFO - PROCESS | 1647 | [#11] stanford-crypto-ccm Cycles:10 Average:138.60 Median:138.50 stddev:5.72 (4.1%) stddev-sans-first:6.04 14:51:03 INFO - PROCESS | 1647 | Values: 137.0 134.0 131.0 144.0 145.0 149.0 135.0 135.0 140.0 136.0 14:51:03 INFO - PROCESS | 1647 | 14:51:03 INFO - PROCESS | 1647 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.80 Median:160.50 stddev:3.58 (2.2%) stddev-sans-first:3.80 14:51:03 INFO - PROCESS | 1647 | Values: 161.0 162.0 160.0 158.0 170.0 160.0 162.0 158.0 159.0 158.0 14:51:03 INFO - PROCESS | 1647 | 14:51:03 INFO - PROCESS | 1647 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:65.50 stddev:2.04 (3.1%) stddev-sans-first:2.06 14:51:03 INFO - PROCESS | 1647 | Values: 64.0 65.0 66.0 65.0 65.0 64.0 71.0 67.0 65.0 66.0 14:51:03 INFO - PROCESS | 1647 | -------- Summary: end -------- 14:51:03 INFO - PROCESS | 1647 | 14:51:03 INFO - TEST-INFO | 1647: exit 0 14:51:04 INFO - TEST-OK | kraken | took 57044ms 14:51:04 INFO - SUITE-END | took 1171s 14:51:04 INFO - Completed test suite (00:19:31) 14:51:04 INFO - javascript benchmark 14:51:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3382.1713680148364, 3418.7948723076615, 3451.6893479586847, 3464.8094354810473, 3503.019154636701, 5704.144378343245, 5743.827685169441, 5777.971110144444, 5779.450952159538, 5808.767649294034, 5653.349864765553, 5751.539876809856, 5758.712064396774, 5759.078547432412, 5767.884642307162, 5195.896082078356, 5231.424543300234, 5257.316548848645, 5273.894522109575, 5281.339832520935, 5194.974025129888, 5205.6616319939085, 5213.165893457048, 5323.8136665216725, 5341.4658534146465, 5225.869353266161, 5239.318888544484, 5247.291615631879, 5272.736363181844, 5312.256284120207, 5254.65844720092, 5257.631965762398, 5325.254464374991, 5326.2543243945875, 5336.59975501835, 4329.588689074533, 5122.154844450662, 5207.843764687065, 5285.973570132125, 5294.68231906083, 5622.634528755659, 5652.604317697763, 5657.2928383952, 5663.688497132656, 5681.517071048966, 6233.501319894398, 6277.403646653561, 6350.587211831263, 6363.045543168516, 6367.267764207129, 6176.752929882799, 6337.936620633781, 6355.968220158916, 6402.647854368008, 6420.0048992406255, 5744.913826292609, 5752.309722833245, 5787.450192231731, 5803.332616749043, 5805.36141024487, 6293.30773614902, 6328.905066424008, 6342.5560210785725, 6348.301686814447, 6355.205599300088, 6037.245344331958, 6207.224096987877, 6218.5647004709235, 6220.875582488325, 6230.7507699691505, 6182.752689892354, 6191.288001879751, 6226.688665566703, 6245.96877015612, 6297.118403423525, 5195.402528709247, 6218.471429928507, 6291.056341548713, 6301.40136687014, 6314.336994615591, 6254.124422580842, 6292.0, 6323.0, 6331.366863313724, 6341.365863413714, 4159.812808423628, 4942.20924652054, 4948.628852836052, 4955.653104282737, 5042.924356134661, 4478.57453541913, 4491.236489796743, 4492.505824359318, 4525.886852828639, 4548.88627784308, 5921.02303119989, 5930.406959304035, 5933.436323549256, 5933.58464907461, 5954.136650185786, 6111.77406523465, 6232.719527621268, 6355.745770169141, 6367.395097465734, 6371.139896113966, 5871.911921321183, 5891.7054147292465, 5917.171595976567, 5953.166556682068, 6014.09788531715, 5476.151196564539, 5479.150731636602, 5484.067708489566, 5485.040117979338, 5490.890182196334, 6261.96869015652, 6322.0, 6339.239291284891, 6342.492600592034, 6347.143135676717, 6126.823043872828, 6236.75052997875, 6275.246970363585, 6279.403456671609, 6366.29970703213, 5774.133879918046, 5879.059350503899, 6281.152044473937, 6303.9684801575695, 6338.239411270677, 6253.7185826637, 6263.937360626518, 6278.46633036197, 6281.277653069956, 6283.37166283368, 6128.0, 6174.228221472316, 6187.381261873777, 6203.565750397429, 6206.100115483139, 5529.364123125892, 6124.899720462962, 6127.601705889103, 6132.01899668756, 6134.069235337226, 5895.263092113486, 6081.5134789217645, 6095.634261944298, 6095.634261944298, 6102.7253773579405, 4933.654644174873, 5816.360200377871, 5858.736356864037, 5894.852628684317, 5912.852178695567, 6140.631562106288, 6157.547319866312, 6172.598781079216, 6176.845578860564, 6182.103594978613, 5977.790777322773, 5984.581079324405, 6007.219061522149, 6025.367336429612, 6057.091436284592], "value": 5725.875648792294, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [485.3956823754426, 489.56184215127456, 526.5419085395705, 541.1287826599172, 552.0752739161903, 32377.190570235754, 32870.50694239583, 32882.177945551346, 32943.67056329436, 33886.813961511354, 41172.38241426381, 42373.152536949245, 42391.57608423915, 44362.11275774483, 44394.890127746825, 10042.246831487631, 10214.591416343375, 10216.693499195037, 10216.79566408675, 10221.386716796978, 9362.625494980193, 9615.56729947154, 10013.198944084455, 10116.291859569834, 10133.391996480197, 12271.0, 12540.372981350942, 12592.0, 12738.87261127386, 12758.617241482723, 12456.06579506536, 12522.248665080124, 12528.874711252862, 12535.498580056787, 12536.31050292229, 12293.877061229363, 12371.75256494874, 12383.0, 12387.0, 12387.504499819996, 41074.0, 41307.58692413067, 41450.37824432636, 41514.79242603798, 41519.0, 3291.9506207406907, 3867.400552914303, 3873.205992771475, 3956.5647778744315, 4064.512258528966, 31469.685303146904, 31521.0, 31891.84054079738, 31934.520982185284, 32278.0, 3239.951400728991, 3367.8821241256683, 3403.8978830634874, 3407.6081250656243, 3473.5831700195886, 386512.0, 387802.0, 387945.0, 388102.0, 388193.0, 35038.299234015176, 35380.64619353774, 35932.28135437277, 35947.82026089853, 59747.701261493414, 30962.0, 36121.0, 36247.63752362495, 36296.81851590725, 36385.090372740364, 15753.68492630141, 15887.761683574756, 15919.920400398156, 15930.442434514736, 15942.043477391393, 13339.0, 13457.461701532025, 13478.730425391437, 13481.865181348061, 13673.86326136726, 6693.698783554654, 7560.243975602506, 7789.3768498519985, 7946.32456241226, 7994.800129996796, 3319.983400082984, 3375.729941604715, 3394.813285269334, 3413.7269018478464, 3423.8116903570044, 942.6465075596651, 1006.808706345792, 1015.3400289811682, 1048.6853943816825, 1103.823388257875, 30809.69190308113, 31026.224344391572, 31097.067087987398, 31236.531452028237, 31333.37333253322, 1059.3749687684303, 1070.5878236878857, 1092.2845536173818, 1131.6774719205152, 1143.9428028598704, 15423.0, 15565.84434155644, 15989.840101598835, 16000.759893614902, 16092.75860862088, 600884.0, 606387.0, 607091.0, 607793.0, 610493.0, 50988.235176472386, 51729.482705172464, 58143.709281453324, 59098.704506477196, 59131.70434147888, 1415.2074838090703, 1428.100296813022, 1458.8103546539307, 1461.3789139615621, 1461.4008256614736, 30061.676464878336, 31700.524492132176, 31867.20331991719, 32058.0, 32251.193720157185, 55080.0, 58697.0, 58718.0, 58748.0, 58769.70615146897, 668660.0, 675353.6232318807, 675773.0, 675843.0, 676684.0, 44067.77966110149, 44321.33517997297, 45110.32334515051, 45194.32208516809, 45246.54753452423, 47790.0, 48498.27252591143, 48967.020659587324, 49099.0, 49106.75446622744, 39593.60406395899, 39745.2050958985, 40655.7967210162, 41317.38023929704, 41728.74813755592, 34671.82664086663, 40274.395884062345, 40352.1200021796, 40954.79522602368, 41189.382159267036, 39011.60988390193, 39605.80197098996, 39790.005249868984, 40051.99870003273, 40178.59821401749, 34420.13949651279, 35534.28931421409, 35708.46437303391, 36321.0, 36554.63445365619, 26116.60825087663, 26445.867770661025, 26623.60064598994, 26738.267102930102, 26746.86626566855], "value": 19591.924561733806, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.84099711639857, 362.32245700539994, 388.95527014393355, 394.4339872283273, 404.1694318176151, 19685.117338350337, 20581.691274630874, 21551.568968620617, 21773.020214090364, 22091.005904734324, 21367.6794848077, 21683.45791355217, 21808.454788630293, 22135.557288854212, 22275.331740047826, 5931.911021334683, 6046.818595442144, 6164.29110652274, 6327.050942358637, 6352.205974253218, 6224.782132625359, 6245.46913512352, 6272.184615999914, 6285.968570157165, 6302.212223472066, 5975.701214939258, 6190.473809726156, 6230.968845155768, 6270.623762574237, 6271.9651257542455, 5252.553532949704, 5972.193753843219, 6183.752649893999, 6229.595076320047, 6255.249370075598, 5448.863778405532, 5478.890422191574, 5479.232907392969, 5480.80817171401, 5502.58730595207, 26195.0, 26654.86672566625, 26657.600135997975, 26814.5977810333, 27064.1880743578, 2111.831053515715, 2378.8334816562847, 2392.3899405651623, 2515.8490490570625, 2572.2926195296254, 9973.202143828476, 10278.691639250834, 10497.317674351143, 10685.893141068567, 10842.891571084347, 1808.4755420927916, 1876.493346796371, 1904.7997575528761, 1916.5017095555118, 1975.101328895349, 103018.0, 105689.0, 119304.0, 134350.32824835912, 135075.0, 11680.415979201007, 11698.2981021139, 11816.527338906519, 11900.821487677691, 12044.39778011096, 13539.255340956144, 14345.92827035879, 15096.849031509764, 15212.315445804965, 15246.771298430533, 7277.818054548678, 8955.373123881396, 9026.954865225633, 9083.227925626263, 9114.36199466031, 9003.099690031075, 9012.071076900034, 9048.864267036, 9148.542572871329, 9188.90811091894, 3967.78177200251, 4576.519465456146, 4632.62938964882, 4671.719696818202, 4702.177119004229, 1707.5218938697185, 1720.9655806883793, 1887.5658598522143, 1985.0967809646577, 1999.5800881814691, 895.3810105441557, 895.8443607746065, 1009.8939611340703, 1026.93719960595, 1052.5421441672897, 20873.373798786062, 21584.892075539836, 21640.783592164193, 21720.782792171874, 21803.0, 963.2486660404895, 1001.1990407673977, 1017.2014968249888, 1028.0901402259055, 1030.2067408095725, 9101.40840845343, 11350.432478376213, 11395.0, 11621.302721836717, 11634.011109055826, 631957.0, 638241.8087909531, 643892.0, 644372.0, 644639.0, 136892.0, 138869.0, 140796.29601851926, 143432.0, 147361.26319368335, 1002.9598816047422, 1043.2644985285356, 1078.309881675728, 1078.4230436716318, 1079.6545105566142, 18829.058547072316, 19177.712334315274, 19510.90244548768, 19551.70672439943, 19556.60886782228, 56453.43546564482, 57002.714986424806, 57985.420145798, 58781.70609146927, 59151.70424147852, 82310.87617812844, 84721.57639211764, 84955.57522212349, 86122.0, 87101.56449217713, 7114.581152093525, 7248.34764871143, 7635.732749353746, 7785.571793551409, 8221.465604735673, 11153.776924461303, 12625.936870315956, 13133.080684352004, 13597.932010339884, 13739.175649461064, 11146.721331966766, 11281.7743645125, 11411.37237451915, 11691.532338706356, 11707.707307317385, 10820.0, 11035.282706624044, 11165.665030049111, 11252.83120753173, 11802.639472105442, 11437.771244574895, 11779.411029448665, 11780.941095294469, 11826.408679566159, 11925.82111268349, 7229.963850180716, 7477.551346919202, 7502.812429689083, 7541.245875412635, 7754.302112809874, 8386.245237928615, 10391.324563903323, 11361.0, 11544.365059921785, 11667.59163429276], "value": 9857.348487125426, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1210.910180837246, 1527.6639139389338, 1562.7187106320862, 1761.621251430942, 1920.1647283431716, 7760.3791696664275, 8181.754547363581, 8327.83344333113, 9261.073892610735, 9265.629374825015, 9097.181253687168, 9200.26397888169, 9208.217301529377, 9210.815783684338, 9239.076092390758, 2392.1866565367773, 2428.7935525480357, 2430.9756902431013, 2433.9513209735796, 2435.914742983996, 2365.775251351119, 2395.197608801054, 2409.674693916325, 2411.8191135664897, 2412.1678021082785, 2376.0377047295874, 2384.7615238476187, 2394.5091256292503, 2411.9990204065293, 2413.155395611531, 2358.2453614843257, 2375.8574485530835, 2380.4643955110137, 2382.3918854773046, 2396.496735685508, 2353.458704497975, 2366.6923299971068, 2376.940576485584, 2378.4172877644914, 2379.1078345620394, 9178.173964343174, 9244.168024877794, 9254.352195346328, 9261.981182069967, 9274.675386361445, 5377.731113444352, 5598.692071936042, 5602.663840169603, 5638.04153293941, 5641.379448260729, 3592.676659100667, 3623.1304486923214, 3659.908502287464, 3661.9633803662155, 3668.0829792551863, 920.2821798996794, 1065.8081545321838, 1088.374184843718, 1091.4651820607924, 1112.5104953820373, 11997.880021199851, 12037.819432708517, 12115.212511186744, 12125.818112728404, 12127.818082728767, 4573.131105090089, 4612.169809434334, 4791.976040119846, 4805.8946442318465, 4809.422869255712, 9486.715398538056, 9526.237900967906, 9526.85709714355, 9526.85709714355, 9528.237740980705, 4914.90170196594, 5258.894822103536, 5452.345718513724, 5452.727363631882, 5453.536449401766, 4335.30635098389, 4564.88587785308, 4719.834805781781, 4731.668783185144, 5090.796368145233, 3907.9218415631526, 3937.3897045957924, 3996.900077498086, 4026.9194616107516, 4036.091879327128, 1197.3115458611333, 1204.6506513111274, 1208.4078801387257, 1210.3706072842074, 1219.6950762309423, 760.6158889760635, 857.9313654907593, 901.5131828812499, 912.7946212102224, 923.5013092929877, 5752.741126649311, 5763.106718458645, 5773.364929857712, 5906.734196961061, 6122.418370254819, 862.4997501449144, 897.434616191795, 915.1260546178383, 931.6832277025844, 955.6655170690203, 3781.6596506314563, 3827.13889374894, 3833.750806197588, 3879.165979314461, 3970.186111847122, 10909.781804363869, 11348.432578371048, 11359.716007099889, 11365.829512557319, 11367.772644547063, 11305.982461578498, 11321.94339028316, 11341.603043893589, 11348.375839328915, 11380.94309528447, 6666.699998500079, 8411.957940210383, 8539.74380768578, 8694.652213911373, 8702.216800487986, 5946.345901950695, 5992.970035149797, 6024.819255422344, 6049.879002420015, 6070.2412198475195, 10052.396856188652, 10222.948885255526, 10407.68776936693, 10436.37381757097, 10436.478176091317, 9592.472414017016, 10314.690559283234, 10588.788224235319, 10619.94690026545, 10771.030607245386, 6687.1975362956755, 7675.117361503499, 7777.0, 7872.448928574945, 7877.133515313197, 7777.650005749641, 8294.046184688837, 8582.399232053696, 8609.870851937101, 8728.039915609152, 7687.769366919001, 7727.574983375968, 7733.033370828646, 7761.573113478813, 7817.804554886174, 7447.329740323397, 7528.20953799865, 7588.772336829904, 7634.4655874088285, 7644.80887977805, 6811.625360605214, 6931.68807403658, 7024.0, 7054.188768291712, 7139.643017849191, 4952.504749525163, 4999.925001125059, 5001.599872010158, 5034.993001399808, 5084.949150508595, 4925.039617274597, 4939.456659767495, 4946.82686105999, 5097.464766199644, 5116.1046816806165], "value": 4643.06676168306, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.6721772441452, 302.84857571214377, 307.6631088957592, 313.14199094481114, 315.2371261547056, 5113.821016264432, 5299.648589609649, 5343.412224655294, 5343.759530821113, 5352.946470535294, 4280.78596070196, 4406.669499787513, 5174.301469301643, 5174.767135478903, 5276.551493123079, 3541.521894544242, 3889.81360684991, 3896.123372241251, 4022.8994275143136, 4066.2274167908004, 3966.424868394081, 4033.596640335972, 4103.528094269167, 4118.258713431596, 4118.876433706979, 3348.7990720556722, 4031.8387264509383, 4056.6146216109423, 4060.7157498975084, 4106.733062350938, 4034.5158580970324, 4044.775373544568, 4045.41341505483, 4066.816993235282, 4082.530508991474, 3037.6506701729363, 3472.2361080562237, 3496.947545786815, 3540.477594634306, 3558.181618227822, 5081.161608334621, 5085.457271364317, 5089.41471730752, 5094.566961808214, 5111.642185047048, 3882.4758657581147, 4198.71939058587, 4581.748003859786, 4587.42657167854, 4596.368289257332, 4912.950870491285, 5160.277561141444, 5217.373915130171, 5543.334799824007, 5568.716826101319, 3780.7145570505886, 3797.487339209199, 3799.639034291738, 3805.5813860475328, 3830.3488406970882, 4584.954150458486, 5700.37295897451, 5768.855778605526, 5870.295564532241, 5928.199693041471, 3093.3194697166587, 3247.886323978649, 3864.30442520349, 3867.303885300673, 3876.0116170376373, 3595.8741444049333, 3891.4162875568327, 3892.404114313118, 3917.3144699678014, 3929.6659783918685, 3882.5535063468064, 4184.644305234089, 4301.698881078294, 4481.574250446202, 4547.545245475492, 5116.0, 5565.582581306418, 5583.553315734732, 5585.218069470277, 5595.664260144323, 1230.9015278777676, 1271.3706715175863, 1326.5953884065452, 1338.4846833968993, 1341.745068436994, 789.8547106695315, 798.3014861995754, 816.9509829410255, 822.4325215601216, 830.3896635972555, 3879.2241551689212, 4264.424302719155, 4443.622661875881, 4459.799309031101, 4463.843765468193, 4010.3130902295534, 4412.933805992912, 4708.882277943078, 4792.9281060784115, 4818.518148185223, 3561.1837962638724, 3947.921041579152, 4056.7971601419813, 4329.567043295645, 4429.689921705514, 2202.9008694608783, 2240.2271216430304, 2256.424611724, 2258.90964361427, 2494.538510375586, 4550.908981820345, 4917.0577621839175, 4922.90154196914, 4933.50664933511, 4954.95945851368, 4679.578837904605, 4828.985912958248, 4842.903141937212, 4864.683795553348, 4902.2156454967035, 3985.940210896897, 4299.516666749966, 4322.805473753626, 4376.098769378316, 4919.950800492021, 3994.320965435941, 4380.737155770664, 4520.276755719069, 4663.090697313991, 4670.883227919329, 3875.767453952772, 4685.4143232095985, 4698.882527936692, 4748.810047598057, 4773.546513081252, 4183.937240941449, 4384.517703052726, 4591.517890621437, 4889.535494128052, 5818.040023396092, 3656.213914008501, 3737.570179429292, 3774.2828862516035, 3852.345101332724, 3893.5133108361456, 5664.603477756517, 5688.857778555569, 5696.031674615242, 5705.857353566194, 5715.085586306171, 5390.460953904578, 5680.630759000652, 5691.686957217393, 5704.828855134353, 5736.942630573641, 4713.114754098388, 5172.965406918706, 5333.386660534088, 5361.383440904346, 5707.486326230659, 4666.323383109498, 4837.685550439211, 5481.6287982889435, 5489.231507588861, 5565.0, 4633.976830115827, 4655.743934083658, 5593.636413633101, 5622.297212848394, 5637.731510410125, 4896.338994235733, 5232.293640358503, 5500.9823182711325, 5544.417836127149, 5561.582881284001], "value": 3828.7023509678975, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [631.4222486424921, 721.8375865430277, 733.361975081679, 740.5815714121518, 743.323575546253, 16889.32442702292, 17429.651406971883, 17439.21523531441, 17477.82522174778, 17975.550611234725, 16144.75782863255, 16355.83644163558, 16738.497845064638, 16745.320748680213, 16758.664826703458, 723.2116992478198, 738.4535443771597, 867.5055218525443, 869.4609342207808, 890.6971629645919, 870.7997160653053, 893.7274131389923, 894.3426581462652, 896.0143841774062, 896.3143195455482, 954.89973552777, 955.4362925873733, 959.1080295325345, 959.2613687460652, 960.9813597586581, 951.2912879904516, 951.9381240219363, 952.2762700347786, 952.5427794658568, 954.3510412919212, 707.8548897476005, 709.1915216653019, 709.7906117695293, 711.4557363616838, 712.1205311440367, 15272.847271527253, 15496.225188740518, 15524.61188470286, 15541.533753987398, 15548.76676849848, 14248.643783905381, 14318.71362572753, 14387.0, 14421.908823220574, 14452.927735361362, 9325.673601423985, 11890.702732431671, 11921.880781192163, 11971.760564788743, 12093.758124837454, 3831.0230891122865, 3896.3960586109197, 3969.6824254059607, 3984.442178095069, 4007.5992400759983, 122061.38969305097, 122783.0, 123102.0, 125340.0, 127807.0, 10970.835437468444, 11363.488643011084, 11458.968692817687, 11510.712232194262, 11933.701657458632, 25114.24657260285, 25133.748662513142, 25160.496790064095, 25176.748232517806, 25587.23238302854, 8263.834723305621, 8308.376871734523, 8319.251267385844, 8353.20644538768, 8368.414211005293, 4301.956980430155, 4345.783180709406, 4433.0, 4505.301678239878, 4510.300903359985, 3181.5227715842807, 3592.7485076044427, 3801.1067399161175, 3802.372608519563, 3805.1058001369656, 600.8497875531117, 657.7215215026318, 689.2762599270745, 691.4675699711195, 701.8280521272321, 538.3485981961792, 571.5770329955886, 663.2074670768385, 687.0861753867345, 696.4115322552435, 8381.622826972802, 9202.677906273382, 9329.253659707207, 9364.95317523408, 9515.191208747334, 605.2192671453863, 629.2260519560874, 688.8312363470982, 693.8716337477583, 703.6657587645827, 4051.554329023805, 4213.831446742096, 4295.699301048959, 4485.46174459067, 4562.749048802348, 130177.0, 131932.34033829768, 137645.0, 154929.22535387252, 155183.0, 125160.0, 128664.0, 129340.0, 130812.0, 133122.66877331297, 73082.53834923272, 79805.0, 107601.0, 118269.0, 119165.0, 9338.0, 9757.658481953098, 9950.000995996199, 10086.8486972694, 10104.938981406847, 62607.37392626015, 62859.0, 64253.0, 64869.35130648633, 65423.0, 88240.55879720561, 90246.0, 93029.0, 96352.0, 96503.0, 13056.020798440344, 13380.598582042554, 13580.864191358356, 13663.590092297247, 13802.0, 13558.0, 14095.647608809863, 14645.560633181021, 14986.17576033285, 15263.618409539406, 13330.733385332045, 13492.5277615283, 13628.182309061489, 14215.431382744575, 14305.141691498544, 13427.395767190696, 13752.793708094587, 14160.0, 14244.786328205293, 14294.28528573588, 13211.933940330237, 13220.867791321964, 13440.663983400493, 13633.223839506376, 13839.792403114163, 9227.261819054595, 9961.551730172016, 10702.518386672775, 11046.392448415414, 11222.382768947786, 11333.979941804948, 11533.596324128615, 11681.824772628588, 11766.529338826693, 11839.467223974769], "value": 8014.235743274682, "unit": "score"}], "name": "dromaeo_css", "value": 7349.216989151631, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 112.0, 112.0, 111.0, 113.0, 117.0, 117.0, 112.0, 112.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 110.0, 108.0, 141.0, 108.0, 108.0, 107.0, 105.0, 136.0, 107.0], "value": 117.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 185.0, 182.0, 186.0, 218.0, 183.0, 184.0, 185.0, 182.0, 182.0], "value": 186.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 60.0, 86.0, 61.0, 60.0, 58.0, 60.0, 81.0, 57.0], "value": 66.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 70.0, 92.0, 72.0, 66.0, 68.0, 91.0, 67.0, 69.0, 90.0], "value": 77.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 88.0, 86.0, 87.0, 84.0, 89.0, 84.0, 88.0, 85.0], "value": 86.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 93.0, 93.0, 93.0, 92.0, 93.0, 93.0, 93.0, 92.0], "value": 92.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 84.0, 84.0, 83.0, 85.0, 86.0, 86.0, 84.0, 84.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 54.0, 54.0, 57.0, 59.0, 57.0, 55.0, 59.0, 56.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 71.0, 81.0, 70.0, 71.0, 67.0, 69.0, 69.0, 68.0, 70.0], "value": 70.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 81.0, 81.0, 80.0, 83.0, 85.0, 81.0, 88.0, 99.0], "value": 85.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 134.0, 131.0, 144.0, 145.0, 149.0, 135.0, 135.0, 140.0, 136.0], "value": 138.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 160.0, 158.0, 170.0, 160.0, 162.0, 158.0, 159.0, 158.0], "value": 160.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 66.0, 65.0, 65.0, 64.0, 71.0, 67.0, 65.0, 66.0], "value": 65.8, "unit": "score"}], "name": "kraken", "value": 1401.1, "alertThreshold": 2.0}]} 14:51:04 INFO - Return code: 0 14:51:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:51:04 INFO - # TBPL SUCCESS # 14:51:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:51:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:51:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:51:04 INFO - 2017-01-05 14:51:04.561 screenresolution[1651:10496] starting screenresolution argv=screenresolution get 14:51:04 INFO - 2017-01-05 14:51:04.563 screenresolution[1651:10496] Display 0: 1600x1200x32@60 14:51:04 INFO - 2017-01-05 14:51:04.569 screenresolution[1652:10499] starting screenresolution argv=screenresolution list 14:51:04 INFO - Available Modes on Display 0 14:51:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:51:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:51:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:51:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:51:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:51:04 INFO - Intel Iris: 14:51:04 INFO - Chipset Model: Intel Iris 14:51:04 INFO - Type: GPU 14:51:04 INFO - Bus: Built-In 14:51:04 INFO - VRAM (Dynamic, Max): 1536 MB 14:51:04 INFO - Vendor: Intel (0x8086) 14:51:04 INFO - Device ID: 0x0a2e 14:51:04 INFO - Revision ID: 0x0009 14:51:04 INFO - Displays: 14:51:04 INFO - Display: 14:51:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:51:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:51:04 INFO - Display Serial Number: 1600x1200 60 14:51:04 INFO - Main Display: Yes 14:51:04 INFO - Mirror: Off 14:51:04 INFO - Online: Yes 14:51:04 INFO - Rotation: Supported 14:51:04 INFO - Return code: 0 14:51:04 INFO - Running post-action listener: _resource_record_post_action 14:51:04 INFO - [mozharness: 2017-01-05 22:51:04.806455Z] Finished run-tests step (success) 14:51:04 INFO - Running post-run listener: _resource_record_post_run 14:51:04 INFO - Total resource usage - Wall time: 1194s; CPU: 53.0%; Read bytes: 33213440; Write bytes: 495615488; Read time: 315; Write time: 1918 14:51:04 INFO - TinderboxPrint: CPU usage
53.4% 14:51:04 INFO - TinderboxPrint: I/O read bytes / time
33,213,440 / 315 14:51:04 INFO - TinderboxPrint: I/O write bytes / time
495,615,488 / 1,918 14:51:04 INFO - TinderboxPrint: CPU idle
2,224.6 (46.6%) 14:51:04 INFO - TinderboxPrint: CPU system
954.5 (20.0%) 14:51:04 INFO - TinderboxPrint: CPU user
1,598.5 (33.5%) 14:51:04 INFO - TinderboxPrint: Swap in / out
225,361,920 / 0 14:51:04 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 194836992; Write bytes: 188061184; Read time: 17731; Write time: 367 14:51:04 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 30231552; Write bytes: 297232384; Read time: 287; Write time: 1519 14:51:05 INFO - Running post-run listener: _upload_blobber_files 14:51:05 INFO - Blob upload gear active. 14:51:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:51:05 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 14:51:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:51:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:51:05 INFO - (blobuploader) - INFO - Open directory for files ... 14:51:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:51:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:51:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:51:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:51:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:51:06 INFO - (blobuploader) - INFO - Done attempting. 14:51:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:51:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:51:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:51:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:51:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:51:07 INFO - (blobuploader) - INFO - Done attempting. 14:51:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:51:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:51:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:51:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:51:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:51:09 INFO - (blobuploader) - INFO - Done attempting. 14:51:09 INFO - (blobuploader) - INFO - Iteration through files over. 14:51:09 INFO - Return code: 0 14:51:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:51:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:51:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b1fad015c9815bc219f830f234ecb11d02ea3f29c557c8c93a8fd455e6d13184f80602290f2ef9f24310cc383e4deca0b2bbbcf8ec1428ac3d87a039a6a37da1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/37bb0c86cd6542a2dbc1fe188c3b0c9e80ce15879e64e79e673217fd38239d16e1277e363ba4fe5b0a7fb12796dd0bf38b83111f97e48f14bc30624525cc2ff2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fdd866464c51c034605489435d3494665e7dfbf8625c2fb5f35f11d0a0440903aa06135d50ecf16eea48b98a855666bfccd42827cedb2d29316330486dec0386"} 14:51:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:51:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:51:09 INFO - Contents: 14:51:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b1fad015c9815bc219f830f234ecb11d02ea3f29c557c8c93a8fd455e6d13184f80602290f2ef9f24310cc383e4deca0b2bbbcf8ec1428ac3d87a039a6a37da1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/37bb0c86cd6542a2dbc1fe188c3b0c9e80ce15879e64e79e673217fd38239d16e1277e363ba4fe5b0a7fb12796dd0bf38b83111f97e48f14bc30624525cc2ff2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fdd866464c51c034605489435d3494665e7dfbf8625c2fb5f35f11d0a0440903aa06135d50ecf16eea48b98a855666bfccd42827cedb2d29316330486dec0386"} 14:51:09 INFO - Running post-run listener: copy_logs_to_upload_dir 14:51:09 INFO - Copying logs to upload dir... 14:51:09 INFO - mkdir: /builds/slave/test/build/upload/logs 14:51:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.359499 ========= master_lag: 1.30 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-01-05 14:51:11.269617) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-05 14:51:11.273753) ========= 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.xSEb7wP775/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.SxMnO2eSq1/Listeners TMPDIR=/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b1fad015c9815bc219f830f234ecb11d02ea3f29c557c8c93a8fd455e6d13184f80602290f2ef9f24310cc383e4deca0b2bbbcf8ec1428ac3d87a039a6a37da1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/37bb0c86cd6542a2dbc1fe188c3b0c9e80ce15879e64e79e673217fd38239d16e1277e363ba4fe5b0a7fb12796dd0bf38b83111f97e48f14bc30624525cc2ff2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fdd866464c51c034605489435d3494665e7dfbf8625c2fb5f35f11d0a0440903aa06135d50ecf16eea48b98a855666bfccd42827cedb2d29316330486dec0386"} build_url:https://queue.taskcluster.net/v1/task/e6fBqRQmRx65RTdlI8O9PQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010953 build_url: 'https://queue.taskcluster.net/v1/task/e6fBqRQmRx65RTdlI8O9PQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b1fad015c9815bc219f830f234ecb11d02ea3f29c557c8c93a8fd455e6d13184f80602290f2ef9f24310cc383e4deca0b2bbbcf8ec1428ac3d87a039a6a37da1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/37bb0c86cd6542a2dbc1fe188c3b0c9e80ce15879e64e79e673217fd38239d16e1277e363ba4fe5b0a7fb12796dd0bf38b83111f97e48f14bc30624525cc2ff2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fdd866464c51c034605489435d3494665e7dfbf8625c2fb5f35f11d0a0440903aa06135d50ecf16eea48b98a855666bfccd42827cedb2d29316330486dec0386"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-05 14:51:11.311890) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 14:51:11.312215) ========= 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.xSEb7wP775/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.SxMnO2eSq1/Listeners TMPDIR=/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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.005141 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 14:51:11.361062) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-05 14:51:11.361380) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-05 14:51:11.361703) ========= ========= Total master_lag: 1.45 =========