builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0079 starttime: 1482426978.54 results: success (0) buildid: 20161222071052 builduid: 161e872a16d742fd96a434d38f5eb11f revision: 6ff5553aea2ac05e70992a1a6573f8ff7ad6da2a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-22 09:16:18.539155) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-22 09:16:18.539589) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-22 09:16:18.539869) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-22 09:16:18.566268) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 09:16:18.566610) ========= 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.p0O9cG2V6H/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.6splFFC3td/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-12-22 09:16:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 22.3M=0.001s 2016-12-22 09:16:18 (22.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.124926 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 09:16:18.715597) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 09:16:18.715921) ========= 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.p0O9cG2V6H/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.6splFFC3td/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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.027603 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 09:16:18.768471) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-22 09:16:18.768819) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 6ff5553aea2ac05e70992a1a6573f8ff7ad6da2a --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 6ff5553aea2ac05e70992a1a6573f8ff7ad6da2a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.p0O9cG2V6H/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.6splFFC3td/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-12-22 09:16:19,009 truncating revision to first 12 chars 2016-12-22 09:16:19,009 Setting DEBUG logging. 2016-12-22 09:16:19,009 attempt 1/10 2016-12-22 09:16:19,009 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/6ff5553aea2a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-22 09:16:20,555 unpacking tar archive at: mozilla-beta-6ff5553aea2a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.831298 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-22 09:16:20.626871) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-22 09:16:20.630273) ========= script_repo_revision: 6ff5553aea2ac05e70992a1a6573f8ff7ad6da2a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-22 09:16:20.630669) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-22 09:16:20.630939) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-22 09:16:20.651646) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-12-22 09:16:20.651948) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.p0O9cG2V6H/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.6splFFC3td/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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 09:16:21 INFO - MultiFileLogger online at 20161222 09:16:21 in /builds/slave/test 09:16:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 09:16:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:16:21 INFO - {'append_to_log': False, 09:16:21 INFO - 'base_work_dir': '/builds/slave/test', 09:16:21 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:16:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:16:21 INFO - 'branch': 'Mozilla-Beta', 09:16:21 INFO - 'buildbot_json_path': 'buildprops.json', 09:16:21 INFO - 'config_files': ('talos/mac_config.py',), 09:16:21 INFO - 'default_actions': ('clobber', 09:16:21 INFO - 'read-buildbot-config', 09:16:21 INFO - 'download-and-extract', 09:16:21 INFO - 'populate-webroot', 09:16:21 INFO - 'create-virtualenv', 09:16:21 INFO - 'install', 09:16:21 INFO - 'run-tests'), 09:16:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:16:21 INFO - 'download_minidump_stackwalk': True, 09:16:21 INFO - 'download_symbols': 'ondemand', 09:16:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:16:21 INFO - 'tooltool.py': '/tools/tooltool.py', 09:16:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:16:21 INFO - '/tools/misc-python/virtualenv.py')}, 09:16:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:16:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:16:21 INFO - 'installer_path': 'installer.exe', 09:16:21 INFO - 'log_level': 'info', 09:16:21 INFO - 'log_name': 'talos', 09:16:21 INFO - 'log_to_console': True, 09:16:21 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:16:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:16:21 INFO - 'opt_config_files': (), 09:16:21 INFO - 'pip_index': False, 09:16:21 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:16:21 INFO - 'cmd': ('bash', 09:16:21 INFO - '-c', 09:16:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:16:21 INFO - 'enabled': True, 09:16:21 INFO - 'halt_on_failure': False, 09:16:21 INFO - 'name': 'check_screen_resolution'},), 09:16:21 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:16:21 INFO - 'cmd': ('bash', 09:16:21 INFO - '-c', 09:16:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:16:21 INFO - 'enabled': True, 09:16:21 INFO - 'halt_on_failure': False, 09:16:21 INFO - 'name': 'check_screen_resolution'},), 09:16:21 INFO - 'run_cmd_checks_enabled': True, 09:16:21 INFO - 'sps_profile': False, 09:16:21 INFO - 'sps_profile_interval': 0, 09:16:21 INFO - 'suite': 'dromaeojs-e10s', 09:16:21 INFO - 'system_bits': '32', 09:16:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:16:21 INFO - 'title': 't-yosemite-r7-0079', 09:16:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:16:21 INFO - 'use_talos_json': True, 09:16:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:16:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:16:21 INFO - 'work_dir': 'build'} 09:16:21 INFO - [mozharness: 2016-12-22 17:16:21.013225Z] Running clobber step. 09:16:21 INFO - Running pre-action listener: _resource_record_pre_action 09:16:21 INFO - Running main action method: clobber 09:16:21 INFO - rmtree: /builds/slave/test/build 09:16:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:16:22 INFO - Running post-action listener: _resource_record_post_action 09:16:22 INFO - [mozharness: 2016-12-22 17:16:22.535121Z] Finished clobber step (success) 09:16:22 INFO - [mozharness: 2016-12-22 17:16:22.535331Z] Running read-buildbot-config step. 09:16:22 INFO - Running pre-action listener: _resource_record_pre_action 09:16:22 INFO - Running main action method: read_buildbot_config 09:16:22 INFO - Using buildbot properties: 09:16:22 INFO - { 09:16:22 INFO - "project": "", 09:16:22 INFO - "product": "firefox", 09:16:22 INFO - "script_repo_revision": "production", 09:16:22 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 09:16:22 INFO - "repository": "", 09:16:22 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 09:16:22 INFO - "buildid": "20161222071052", 09:16:22 INFO - "pgo_build": "False", 09:16:22 INFO - "basedir": "/builds/slave/test", 09:16:22 INFO - "buildnumber": 12, 09:16:22 INFO - "slavename": "t-yosemite-r7-0079", 09:16:22 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 09:16:22 INFO - "platform": "yosemite_r7", 09:16:22 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 09:16:22 INFO - "branch": "mozilla-beta", 09:16:22 INFO - "repo_path": "releases/mozilla-beta", 09:16:22 INFO - "revision": "6ff5553aea2ac05e70992a1a6573f8ff7ad6da2a", 09:16:22 INFO - "stage_platform": "macosx64", 09:16:22 INFO - "builduid": "161e872a16d742fd96a434d38f5eb11f", 09:16:22 INFO - "slavebuilddir": "test" 09:16:22 INFO - } 09:16:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/WZmcmsk6SI6HSTk-NAD1vg/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 09:16:22 INFO - Running post-action listener: _resource_record_post_action 09:16:22 INFO - [mozharness: 2016-12-22 17:16:22.541299Z] Finished read-buildbot-config step (success) 09:16:22 INFO - [mozharness: 2016-12-22 17:16:22.541564Z] Running download-and-extract step. 09:16:22 INFO - Running pre-action listener: _resource_record_pre_action 09:16:22 INFO - Running main action method: download_and_extract 09:16:22 INFO - mkdir: /builds/slave/test/build/tests 09:16:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:22 INFO - trying https://queue.taskcluster.net/v1/task/WZmcmsk6SI6HSTk-NAD1vg/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 09:16:22 INFO - Downloading https://queue.taskcluster.net/v1/task/WZmcmsk6SI6HSTk-NAD1vg/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 09:16:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WZmcmsk6SI6HSTk-NAD1vg/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 09:16:23 INFO - Downloaded 1165 bytes. 09:16:23 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 09:16:23 INFO - Using the following test package requirements: 09:16:23 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 09:16:23 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:16:23 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 09:16:23 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:16:23 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 09:16:23 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 09:16:23 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:16:23 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 09:16:23 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 09:16:23 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:16:23 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 09:16:23 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:16:23 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 09:16:23 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:16:23 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 09:16:23 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:16:23 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 09:16:23 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 09:16:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WZmcmsk6SI6HSTk-NAD1vg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 09:16:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WZmcmsk6SI6HSTk-NAD1vg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 09:16:23 INFO - Fetch https://queue.taskcluster.net/v1/task/WZmcmsk6SI6HSTk-NAD1vg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 09:16:24 INFO - Expected file size: 16232805 09:16:31 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 09:16:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WZmcmsk6SI6HSTk-NAD1vg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 09:16:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WZmcmsk6SI6HSTk-NAD1vg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 09:16:31 INFO - Fetch https://queue.taskcluster.net/v1/task/WZmcmsk6SI6HSTk-NAD1vg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 09:16:31 INFO - Expected file size: 16232805 09:16:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WZmcmsk6SI6HSTk-NAD1vg/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 09:16:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WZmcmsk6SI6HSTk-NAD1vg/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 09:16:38 INFO - Fetch https://queue.taskcluster.net/v1/task/WZmcmsk6SI6HSTk-NAD1vg/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 09:16:42 INFO - Expected file size: 14414089 09:16:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:43 INFO - trying https://queue.taskcluster.net/v1/task/WZmcmsk6SI6HSTk-NAD1vg/artifacts/public/build/firefox-51.0.en-US.mac.dmg 09:16:43 INFO - Downloading https://queue.taskcluster.net/v1/task/WZmcmsk6SI6HSTk-NAD1vg/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 09:16:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WZmcmsk6SI6HSTk-NAD1vg/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 09:16:45 INFO - Downloaded 86034101 bytes. 09:16:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WZmcmsk6SI6HSTk-NAD1vg/artifacts/public/build/firefox-51.0.en-US.mac.dmg 09:16:45 INFO - mkdir: /builds/slave/test/properties 09:16:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:16:45 INFO - Writing to file /builds/slave/test/properties/build_url 09:16:45 INFO - Contents: 09:16:45 INFO - build_url:https://queue.taskcluster.net/v1/task/WZmcmsk6SI6HSTk-NAD1vg/artifacts/public/build/firefox-51.0.en-US.mac.dmg 09:16:46 INFO - Running post-action listener: _resource_record_post_action 09:16:46 INFO - Running post-action listener: set_extra_try_arguments 09:16:46 INFO - [mozharness: 2016-12-22 17:16:46.555035Z] Finished download-and-extract step (success) 09:16:46 INFO - [mozharness: 2016-12-22 17:16:46.555159Z] Running populate-webroot step. 09:16:46 INFO - Running pre-action listener: _resource_record_pre_action 09:16:46 INFO - Running main action method: populate_webroot 09:16:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:16:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:16:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:16:46 INFO - '--tppagecycles', 09:16:46 INFO - '7'], 09:16:46 INFO - 'tests': ['tsvgm']}}, 09:16:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:16:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:16:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:16:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:16:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:16:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:16:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:46 INFO - 'talos_options': ['--disable-e10s'], 09:16:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:16:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:16:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:46 INFO - 'talos_options': ['--disable-e10s'], 09:16:46 INFO - 'tests': ['damp', 'tps']}, 09:16:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:46 INFO - 'tests': ['damp', 'tps']}, 09:16:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:16:46 INFO - 'tests': ['dromaeo_dom']}, 09:16:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:16:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:16:46 INFO - 'tests': ['basic_compositor_video']}, 09:16:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:16:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:16:46 INFO - 'tests': ['a11yr', 09:16:46 INFO - 'ts_paint', 09:16:46 INFO - 'tpaint', 09:16:46 INFO - 'sessionrestore', 09:16:46 INFO - 'sessionrestore_no_auto_restore', 09:16:46 INFO - 'tabpaint']}, 09:16:46 INFO - 'other-e10s': {'tests': ['a11yr', 09:16:46 INFO - 'ts_paint', 09:16:46 INFO - 'tpaint', 09:16:46 INFO - 'sessionrestore', 09:16:46 INFO - 'sessionrestore_no_auto_restore', 09:16:46 INFO - 'tabpaint']}, 09:16:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:16:46 INFO - 'ts_paint', 09:16:46 INFO - 'tpaint', 09:16:46 INFO - 'sessionrestore', 09:16:46 INFO - 'sessionrestore_no_auto_restore', 09:16:46 INFO - 'tabpaint']}, 09:16:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:16:46 INFO - 'ts_paint', 09:16:46 INFO - 'tpaint', 09:16:46 INFO - 'sessionrestore', 09:16:46 INFO - 'sessionrestore_no_auto_restore', 09:16:46 INFO - 'tabpaint']}, 09:16:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:16:46 INFO - 'tests': ['a11yr', 09:16:46 INFO - 'ts_paint', 09:16:46 INFO - 'tpaint', 09:16:46 INFO - 'sessionrestore', 09:16:46 INFO - 'sessionrestore_no_auto_restore', 09:16:46 INFO - 'tabpaint']}, 09:16:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:16:46 INFO - 'tests': ['a11yr', 09:16:46 INFO - 'ts_paint', 09:16:46 INFO - 'tpaint', 09:16:46 INFO - 'sessionrestore', 09:16:46 INFO - 'sessionrestore_no_auto_restore', 09:16:46 INFO - 'tabpaint']}, 09:16:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:16:46 INFO - 'tests': ['tsvgx', 09:16:46 INFO - 'tsvgr_opacity', 09:16:46 INFO - 'tart', 09:16:46 INFO - 'tscrollx', 09:16:46 INFO - 'cart']}, 09:16:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:16:46 INFO - 'tsvgr_opacity', 09:16:46 INFO - 'tart', 09:16:46 INFO - 'tscrollx', 09:16:46 INFO - 'cart']}, 09:16:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:46 INFO - 'talos_options': ['--disable-e10s'], 09:16:46 INFO - 'tests': ['tp5o']}, 09:16:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:46 INFO - 'tests': ['tp5o']}, 09:16:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:46 INFO - 'talos_options': ['--disable-e10s', 09:16:46 INFO - '--xperf_path', 09:16:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:16:46 INFO - 'tests': ['tp5n']}, 09:16:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:46 INFO - 'talos_options': ['--xperf_path', 09:16:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:16:46 INFO - 'tests': ['tp5n']}}, 09:16:46 INFO - 'talos.zip': {'path': '', 09:16:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:16:46 INFO - Running post-action listener: _resource_record_post_action 09:16:46 INFO - [mozharness: 2016-12-22 17:16:46.573826Z] Finished populate-webroot step (success) 09:16:46 INFO - [mozharness: 2016-12-22 17:16:46.573958Z] Running create-virtualenv step. 09:16:46 INFO - Running pre-action listener: _resource_record_pre_action 09:16:46 INFO - Running main action method: create_virtualenv 09:16:46 INFO - Creating virtualenv /builds/slave/test/build/venv 09:16:46 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 09:16:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:16:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:16:46 INFO - Using real prefix '/tools/python27' 09:16:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:16:47 INFO - Installing distribute.............................................................................................................................................................................................done. 09:16:50 INFO - Installing pip.................done. 09:16:50 INFO - Return code: 0 09:16:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:16:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1090b8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10902e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7b3c980c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108eccd30>, '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 0x108d32db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ec4b20>, '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.p0O9cG2V6H/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.6splFFC3td/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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 09:16: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', 'pip>=1.5'] in /builds/slave/test/build 09:16: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 pip>=1.5 09:16:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p0O9cG2V6H/Render', 09:16:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:16:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:16:50 INFO - 'HOME': '/Users/cltbld', 09:16:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:16:50 INFO - 'LOGNAME': 'cltbld', 09:16:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:50 INFO - 'MOZ_NO_REMOTE': '1', 09:16:50 INFO - 'NO_EM_RESTART': '1', 09:16:50 INFO - 'PAGER': '/bin/cat', 09:16:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:16:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:50 INFO - 'PWD': '/builds/slave/test', 09:16:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:16:50 INFO - 'SHELL': '/bin/bash', 09:16:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6splFFC3td/Listeners', 09:16:50 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 09:16:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:16:50 INFO - 'USER': 'cltbld', 09:16:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:16:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:16:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:50 INFO - 'XPC_FLAGS': '0x0', 09:16:50 INFO - 'XPC_SERVICE_NAME': '0', 09:16:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:16:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:50 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 09:16:50 INFO - Cleaning up... 09:16:50 INFO - Return code: 0 09:16:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:16:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16: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', '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 0x1090b8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10902e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7b3c980c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108eccd30>, '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 0x108d32db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ec4b20>, '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.p0O9cG2V6H/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.6splFFC3td/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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 09:16: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', 'psutil>=3.1.1'] in /builds/slave/test/build 09:16: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 psutil>=3.1.1 09:16:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p0O9cG2V6H/Render', 09:16:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:16:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:16:50 INFO - 'HOME': '/Users/cltbld', 09:16:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:16:50 INFO - 'LOGNAME': 'cltbld', 09:16:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:50 INFO - 'MOZ_NO_REMOTE': '1', 09:16:50 INFO - 'NO_EM_RESTART': '1', 09:16:50 INFO - 'PAGER': '/bin/cat', 09:16:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:16:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:50 INFO - 'PWD': '/builds/slave/test', 09:16:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:16:50 INFO - 'SHELL': '/bin/bash', 09:16:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6splFFC3td/Listeners', 09:16:50 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 09:16:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:16:50 INFO - 'USER': 'cltbld', 09:16:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:16:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:16:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:50 INFO - 'XPC_FLAGS': '0x0', 09:16:50 INFO - 'XPC_SERVICE_NAME': '0', 09:16:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:16:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:50 INFO - Downloading/unpacking psutil>=3.1.1 09:16: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 09:16: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 09:16: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 09:16: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 09:16: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 09:16: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 09:16:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:16:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:16:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:16:53 INFO - Installing collected packages: psutil 09:16:53 INFO - Running setup.py install for psutil 09:16:54 INFO - building 'psutil._psutil_osx' extension 09:16:54 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 09:16:54 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 09:16:54 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 09:16:54 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 09:16:54 INFO - building 'psutil._psutil_posix' extension 09:16:54 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 09:16:54 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:16:54 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:16:54 INFO - ^ 09:16:54 INFO - 1 warning generated. 09:16:54 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 09:16:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:16:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:16:55 INFO - Successfully installed psutil 09:16:55 INFO - Cleaning up... 09:16:55 INFO - Return code: 0 09:16:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:16:55 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')]} 09:16:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:55 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')]} 09:16:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:55 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 0x1090b8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10902e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7b3c980c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108eccd30>, '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 0x108d32db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ec4b20>, '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.p0O9cG2V6H/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.6splFFC3td/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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 09:16:55 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 09:16:55 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 09:16:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p0O9cG2V6H/Render', 09:16:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:16:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:16:55 INFO - 'HOME': '/Users/cltbld', 09:16:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:16:55 INFO - 'LOGNAME': 'cltbld', 09:16:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:55 INFO - 'MOZ_NO_REMOTE': '1', 09:16:55 INFO - 'NO_EM_RESTART': '1', 09:16:55 INFO - 'PAGER': '/bin/cat', 09:16:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:16:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:55 INFO - 'PWD': '/builds/slave/test', 09:16:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:16:55 INFO - 'SHELL': '/bin/bash', 09:16:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6splFFC3td/Listeners', 09:16:55 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 09:16:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:16:55 INFO - 'USER': 'cltbld', 09:16:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:16:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:16:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:55 INFO - 'XPC_FLAGS': '0x0', 09:16:55 INFO - 'XPC_SERVICE_NAME': '0', 09:16:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:16:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:16:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:16:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:16:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:16:58 INFO - Installing collected packages: mozsystemmonitor 09:16:58 INFO - Running setup.py install for mozsystemmonitor 09:16:58 INFO - Successfully installed mozsystemmonitor 09:16:58 INFO - Cleaning up... 09:16:58 INFO - Return code: 0 09:16:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:16:58 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')]} 09:16:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:58 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')]} 09:16:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:58 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 0x1090b8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10902e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7b3c980c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108eccd30>, '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 0x108d32db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ec4b20>, '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.p0O9cG2V6H/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.6splFFC3td/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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 09:16:58 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 09:16:58 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 09:16:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p0O9cG2V6H/Render', 09:16:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:16:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:16:58 INFO - 'HOME': '/Users/cltbld', 09:16:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:16:58 INFO - 'LOGNAME': 'cltbld', 09:16:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:58 INFO - 'MOZ_NO_REMOTE': '1', 09:16:58 INFO - 'NO_EM_RESTART': '1', 09:16:58 INFO - 'PAGER': '/bin/cat', 09:16:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:16:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:58 INFO - 'PWD': '/builds/slave/test', 09:16:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:16:58 INFO - 'SHELL': '/bin/bash', 09:16:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6splFFC3td/Listeners', 09:16:58 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 09:16:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:16:58 INFO - 'USER': 'cltbld', 09:16:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:16:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:16:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:58 INFO - 'XPC_FLAGS': '0x0', 09:16:58 INFO - 'XPC_SERVICE_NAME': '0', 09:16:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:16:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:58 INFO - Downloading/unpacking jsonschema==2.5.1 09:16:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:17:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:17:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:17:01 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 09:17:01 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 09:17:01 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 09:17:01 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 09:17:01 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 09:17:01 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 09:17:01 INFO - Downloading functools32-3.2.3-2.tar.gz 09:17:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:17:01 INFO - warning: no files found matching '*.txt' 09:17:01 INFO - no previously-included directories found matching 'build' 09:17:01 INFO - no previously-included directories found matching 'dist' 09:17:01 INFO - no previously-included directories found matching '.git*' 09:17:01 INFO - Installing collected packages: jsonschema, functools32 09:17:01 INFO - Running setup.py install for functools32 09:17:02 INFO - warning: no files found matching '*.txt' 09:17:02 INFO - no previously-included directories found matching 'build' 09:17:02 INFO - no previously-included directories found matching 'dist' 09:17:02 INFO - no previously-included directories found matching '.git*' 09:17:02 INFO - Successfully installed jsonschema functools32 09:17:02 INFO - Cleaning up... 09:17:02 INFO - Return code: 0 09:17:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:17:02 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')]} 09:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:02 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')]} 09:17:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:02 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 0x1090b8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10902e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7b3c980c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108eccd30>, '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 0x108d32db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ec4b20>, '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.p0O9cG2V6H/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.6splFFC3td/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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 09:17:02 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 09:17:02 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 09:17:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p0O9cG2V6H/Render', 09:17:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:17:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:17:02 INFO - 'HOME': '/Users/cltbld', 09:17:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:17:02 INFO - 'LOGNAME': 'cltbld', 09:17:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:02 INFO - 'MOZ_NO_REMOTE': '1', 09:17:02 INFO - 'NO_EM_RESTART': '1', 09:17:02 INFO - 'PAGER': '/bin/cat', 09:17:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:17:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:02 INFO - 'PWD': '/builds/slave/test', 09:17:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:17:02 INFO - 'SHELL': '/bin/bash', 09:17:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6splFFC3td/Listeners', 09:17:02 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 09:17:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:17:02 INFO - 'USER': 'cltbld', 09:17:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:17:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:17:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:02 INFO - 'XPC_FLAGS': '0x0', 09:17:02 INFO - 'XPC_SERVICE_NAME': '0', 09:17:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:17:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:17:02 INFO - Cleaning up... 09:17:02 INFO - Return code: 0 09:17:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:17:02 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')]} 09:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:02 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')]} 09:17:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:02 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 0x1090b8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10902e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7b3c980c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108eccd30>, '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 0x108d32db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ec4b20>, '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.p0O9cG2V6H/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.6splFFC3td/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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 09:17:02 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 09:17:02 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 09:17:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p0O9cG2V6H/Render', 09:17:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:17:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:17:02 INFO - 'HOME': '/Users/cltbld', 09:17:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:17:02 INFO - 'LOGNAME': 'cltbld', 09:17:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:02 INFO - 'MOZ_NO_REMOTE': '1', 09:17:02 INFO - 'NO_EM_RESTART': '1', 09:17:02 INFO - 'PAGER': '/bin/cat', 09:17:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:17:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:02 INFO - 'PWD': '/builds/slave/test', 09:17:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:17:02 INFO - 'SHELL': '/bin/bash', 09:17:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6splFFC3td/Listeners', 09:17:02 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 09:17:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:17:02 INFO - 'USER': 'cltbld', 09:17:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:17:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:17:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:02 INFO - 'XPC_FLAGS': '0x0', 09:17:02 INFO - 'XPC_SERVICE_NAME': '0', 09:17:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:17:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:02 INFO - Downloading/unpacking blobuploader==1.2.4 09:17:02 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 09:17:02 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 09:17:02 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 09:17:02 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 09:17:02 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 09:17:02 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 09:17:05 INFO - Downloading blobuploader-1.2.4.tar.gz 09:17:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:17:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:17: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 09:17: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 09:17: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 09:17: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 09:17: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 09:17: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 09:17:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:17:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:17:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:17:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:17:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:17:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:17:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:17:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:17:06 INFO - Downloading docopt-0.6.1.tar.gz 09:17:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:17:06 INFO - Installing collected packages: blobuploader, requests, docopt 09:17:06 INFO - Running setup.py install for blobuploader 09:17:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:17:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:17:06 INFO - Running setup.py install for requests 09:17:07 INFO - Running setup.py install for docopt 09:17:07 INFO - Successfully installed blobuploader requests docopt 09:17:07 INFO - Cleaning up... 09:17:07 INFO - Return code: 0 09:17:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:17:07 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')]} 09:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:07 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')]} 09:17:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:07 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 0x1090b8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10902e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7b3c980c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108eccd30>, '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 0x108d32db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ec4b20>, '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.p0O9cG2V6H/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.6splFFC3td/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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 09:17:07 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 09:17:07 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 09:17:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p0O9cG2V6H/Render', 09:17:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:17:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:17:07 INFO - 'HOME': '/Users/cltbld', 09:17:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:17:07 INFO - 'LOGNAME': 'cltbld', 09:17:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:07 INFO - 'MOZ_NO_REMOTE': '1', 09:17:07 INFO - 'NO_EM_RESTART': '1', 09:17:07 INFO - 'PAGER': '/bin/cat', 09:17:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:17:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:07 INFO - 'PWD': '/builds/slave/test', 09:17:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:17:07 INFO - 'SHELL': '/bin/bash', 09:17:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6splFFC3td/Listeners', 09:17:07 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 09:17:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:17:07 INFO - 'USER': 'cltbld', 09:17:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:17:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:17:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:07 INFO - 'XPC_FLAGS': '0x0', 09:17:07 INFO - 'XPC_SERVICE_NAME': '0', 09:17:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:17:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:17:07 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-pNvX6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:17:07 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-Drx35P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:17:08 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-hQPLmc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:17:08 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-HiR1ZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:17:08 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-Fp4iZq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:17:08 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-l6J7SY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:17:08 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-qchpdY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:17:08 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-egQXJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:17:08 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-PLVgwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:17:08 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-bMW6hw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:17:08 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-2RvW5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:17:08 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-bgctNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:17:09 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-qCDrOq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:17:09 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-f9RJ78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:17:09 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-2WH8gh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:17:09 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-MmMX6S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:17:09 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-6tEifP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:17:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:17:09 INFO - Running setup.py install for manifestparser 09:17:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:17:09 INFO - Running setup.py install for mozcrash 09:17:09 INFO - Running setup.py install for mozdebug 09:17:09 INFO - Running setup.py install for mozdevice 09:17:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:17:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:17:10 INFO - Running setup.py install for mozfile 09:17:10 INFO - Running setup.py install for mozhttpd 09:17:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:17:10 INFO - Running setup.py install for mozinfo 09:17:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:17:10 INFO - Running setup.py install for mozInstall 09:17:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:17:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:17:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:17:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:17:10 INFO - Running setup.py install for mozleak 09:17:10 INFO - Running setup.py install for mozlog 09:17:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:17:11 INFO - Running setup.py install for moznetwork 09:17:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:17:11 INFO - Running setup.py install for mozprocess 09:17:11 INFO - Running setup.py install for mozprofile 09:17:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:17:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:17:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:17:11 INFO - Running setup.py install for mozrunner 09:17:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:17:11 INFO - Running setup.py install for mozscreenshot 09:17:11 INFO - Running setup.py install for moztest 09:17:11 INFO - Running setup.py install for mozversion 09:17:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:17:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:17:12 INFO - Cleaning up... 09:17:12 INFO - Return code: 0 09:17:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:17:12 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')]} 09:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:12 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')]} 09:17:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:12 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 0x1090b8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10902e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7b3c980c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108eccd30>, '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 0x108d32db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ec4b20>, '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.p0O9cG2V6H/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.6splFFC3td/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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 09:17:12 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 09:17:12 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 09:17:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p0O9cG2V6H/Render', 09:17:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:17:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:17:12 INFO - 'HOME': '/Users/cltbld', 09:17:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:17:12 INFO - 'LOGNAME': 'cltbld', 09:17:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:12 INFO - 'MOZ_NO_REMOTE': '1', 09:17:12 INFO - 'NO_EM_RESTART': '1', 09:17:12 INFO - 'PAGER': '/bin/cat', 09:17:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:17:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:12 INFO - 'PWD': '/builds/slave/test', 09:17:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:17:12 INFO - 'SHELL': '/bin/bash', 09:17:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6splFFC3td/Listeners', 09:17:12 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 09:17:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:17:12 INFO - 'USER': 'cltbld', 09:17:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:17:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:17:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:12 INFO - 'XPC_FLAGS': '0x0', 09:17:12 INFO - 'XPC_SERVICE_NAME': '0', 09:17:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:17:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:17:12 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-SRwqnc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:17:12 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)) 09:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:17:12 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-L1LNxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:17:12 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)) 09:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:17:12 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-MZybEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:17:12 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)) 09:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:17:12 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-6QFR_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:17:12 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)) 09:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:17:12 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-y0pbQO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:17:12 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)) 09:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:17:12 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-sQDZ3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:17:13 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)) 09:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:17:13 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-7UVXim-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:17:13 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)) 09:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:17:13 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-6RbDHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:17:13 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)) 09:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:17:13 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-qFLMw3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:17:13 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)) 09:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:17:13 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-wKxMau-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:17:13 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)) 09:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:17:13 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-HGWTEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:17:13 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)) 09:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:17:13 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-Inkw7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:17:13 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)) 09:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:17:13 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-yjcicm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:17:13 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)) 09:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:17:13 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-ySpHX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:17:13 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)) 09:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:17:13 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-IP8Nyt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:17:14 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)) 09:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:17:14 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-ygL60E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:17:14 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)) 09:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:17:14 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-yvzGgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:17:14 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)) 09:17:14 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)) 09:17:14 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)) 09:17:14 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)) 09:17:14 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)) 09:17:14 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)) 09:17:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:17:14 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 09:17:14 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 09:17:14 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 09:17:14 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 09:17:14 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 09:17:14 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 09:17:17 INFO - Downloading blessings-1.6.tar.gz 09:17:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:17:17 INFO - Installing collected packages: blessings 09:17:17 INFO - Running setup.py install for blessings 09:17:17 INFO - Successfully installed blessings 09:17:17 INFO - Cleaning up... 09:17:17 INFO - Return code: 0 09:17:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:17:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:17:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:17:17 INFO - Reading from file tmpfile_stdout 09:17:17 INFO - Current package versions: 09:17:17 INFO - blessings == 1.6 09:17:17 INFO - blobuploader == 1.2.4 09:17:17 INFO - docopt == 0.6.1 09:17:17 INFO - functools32 == 3.2.3-2 09:17:17 INFO - jsonschema == 2.5.1 09:17:17 INFO - manifestparser == 1.1 09:17:17 INFO - mozInstall == 1.12 09:17:17 INFO - mozcrash == 0.17 09:17:17 INFO - mozdebug == 0.1 09:17:17 INFO - mozdevice == 0.48 09:17:17 INFO - mozfile == 1.2 09:17:17 INFO - mozhttpd == 0.7 09:17:17 INFO - mozinfo == 0.9 09:17:17 INFO - mozleak == 0.1 09:17:17 INFO - mozlog == 3.4 09:17:17 INFO - moznetwork == 0.27 09:17:17 INFO - mozprocess == 0.23 09:17:17 INFO - mozprofile == 0.28 09:17:17 INFO - mozrunner == 6.12 09:17:17 INFO - mozscreenshot == 0.1 09:17:17 INFO - mozsystemmonitor == 0.3 09:17:17 INFO - moztest == 0.7 09:17:17 INFO - mozversion == 1.4 09:17:17 INFO - psutil == 3.1.1 09:17:17 INFO - requests == 1.2.3 09:17:17 INFO - wsgiref == 0.1.2 09:17:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:17: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')]} 09:17:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:17:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:18 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 0x1090b8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10902e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7b3c980c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108eccd30>, '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 0x108d32db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ec4b20>, '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.p0O9cG2V6H/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.6splFFC3td/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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 09:17:18 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 09:17:18 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 09:17:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p0O9cG2V6H/Render', 09:17:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:17:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:17:18 INFO - 'HOME': '/Users/cltbld', 09:17:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:17:18 INFO - 'LOGNAME': 'cltbld', 09:17:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:18 INFO - 'MOZ_NO_REMOTE': '1', 09:17:18 INFO - 'NO_EM_RESTART': '1', 09:17:18 INFO - 'PAGER': '/bin/cat', 09:17:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:17:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:18 INFO - 'PWD': '/builds/slave/test', 09:17:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:17:18 INFO - 'SHELL': '/bin/bash', 09:17:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6splFFC3td/Listeners', 09:17:18 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 09:17:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:17:18 INFO - 'USER': 'cltbld', 09:17:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:17:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:17:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:18 INFO - 'XPC_FLAGS': '0x0', 09:17:18 INFO - 'XPC_SERVICE_NAME': '0', 09:17:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:17:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:18 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)) 09:17:18 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)) 09:17:18 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)) 09:17:18 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)) 09:17:18 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)) 09:17:18 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)) 09:17:18 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)) 09:17:18 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)) 09:17:18 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)) 09:17:18 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)) 09:17:18 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)) 09:17:18 INFO - Cleaning up... 09:17:18 INFO - Return code: 0 09:17:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:17:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:17:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:17:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1090b8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10902e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7b3c980c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108eccd30>, '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 0x108d32db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ec4b20>, '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.p0O9cG2V6H/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.6splFFC3td/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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 09:17:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:17:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:17:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p0O9cG2V6H/Render', 09:17:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:17:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:17:18 INFO - 'HOME': '/Users/cltbld', 09:17:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:17:18 INFO - 'LOGNAME': 'cltbld', 09:17:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:18 INFO - 'MOZ_NO_REMOTE': '1', 09:17:18 INFO - 'NO_EM_RESTART': '1', 09:17:18 INFO - 'PAGER': '/bin/cat', 09:17:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:17:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:18 INFO - 'PWD': '/builds/slave/test', 09:17:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:17:18 INFO - 'SHELL': '/bin/bash', 09:17:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6splFFC3td/Listeners', 09:17:18 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 09:17:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:17:18 INFO - 'USER': 'cltbld', 09:17:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:17:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:17:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:18 INFO - 'XPC_FLAGS': '0x0', 09:17:18 INFO - 'XPC_SERVICE_NAME': '0', 09:17:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:17:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:17:18 INFO - Cleaning up... 09:17:18 INFO - Return code: 0 09:17:18 INFO - Running post-action listener: _resource_record_post_action 09:17:18 INFO - Running post-action listener: _start_resource_monitoring 09:17:18 INFO - Starting resource monitoring. 09:17:18 INFO - [mozharness: 2016-12-22 17:17:18.844352Z] Finished create-virtualenv step (success) 09:17:18 INFO - [mozharness: 2016-12-22 17:17:18.845319Z] Running install step. 09:17:18 INFO - Running pre-action listener: _resource_record_pre_action 09:17:18 INFO - Running main action method: install 09:17:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:17:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:17:19 INFO - Reading from file tmpfile_stdout 09:17:19 INFO - Detecting whether we're running mozinstall >=1.0... 09:17:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:17:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:17:19 INFO - Reading from file tmpfile_stdout 09:17:19 INFO - Output received: 09:17:19 INFO - Usage: mozinstall [options] installer 09:17:19 INFO - Options: 09:17:19 INFO - -h, --help show this help message and exit 09:17:19 INFO - -d DEST, --destination=DEST 09:17:19 INFO - Directory to install application into. [default: 09:17:19 INFO - "/builds/slave/test"] 09:17:19 INFO - --app=APP Application being installed. [default: firefox] 09:17:19 INFO - mkdir: /builds/slave/test/build/application 09:17:19 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'] 09:17:19 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 09:17:41 INFO - Reading from file tmpfile_stdout 09:17:41 INFO - Output received: 09:17:41 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 09:17:41 INFO - Running post-action listener: _resource_record_post_action 09:17:41 INFO - [mozharness: 2016-12-22 17:17:41.064973Z] Finished install step (success) 09:17:41 INFO - [mozharness: 2016-12-22 17:17:41.065114Z] Running run-tests step. 09:17:41 INFO - Running pre-action listener: _resource_record_pre_action 09:17:41 INFO - Running main action method: run_tests 09:17:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:17:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:17:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:17:41 INFO - 2016-12-22 09:17:41.079 screenresolution[1627:7472] starting screenresolution argv=screenresolution get 09:17:41 INFO - 2016-12-22 09:17:41.081 screenresolution[1627:7472] Display 0: 1600x1200x32@60 09:17:41 INFO - 2016-12-22 09:17:41.087 screenresolution[1628:7474] starting screenresolution argv=screenresolution list 09:17:41 INFO - Available Modes on Display 0 09:17:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:17:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:17:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:17:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:17:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:17:41 INFO - Intel Iris: 09:17:41 INFO - Chipset Model: Intel Iris 09:17:41 INFO - Type: GPU 09:17:41 INFO - Bus: Built-In 09:17:41 INFO - VRAM (Dynamic, Max): 1536 MB 09:17:41 INFO - Vendor: Intel (0x8086) 09:17:41 INFO - Device ID: 0x0a2e 09:17:41 INFO - Revision ID: 0x0009 09:17:41 INFO - Displays: 09:17:41 INFO - Display: 09:17:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:17:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:17:41 INFO - Display Serial Number: 1600x1200 60 09:17:41 INFO - Main Display: Yes 09:17:41 INFO - Mirror: Off 09:17:41 INFO - Online: Yes 09:17:41 INFO - Rotation: Supported 09:17:41 INFO - Return code: 0 09:17:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:17:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:17:41 INFO - Python 2.7.3 09:17:41 INFO - Return code: 0 09:17:41 INFO - grabbing minidump binary from tooltool 09:17: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')]} 09:17:41 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 0x108eccd30>, '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 0x108d32db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ec4b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:17:41 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 09:17:41 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 09:17:41 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 09:17:41 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:17:41 INFO - Return code: 0 09:17:41 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:17:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:17:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:17:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:17:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:17:41 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-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WZmcmsk6SI6HSTk-NAD1vg/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0079', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:17:41 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-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WZmcmsk6SI6HSTk-NAD1vg/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0079 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:17:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p0O9cG2V6H/Render', 09:17:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:17:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:17:41 INFO - 'HOME': '/Users/cltbld', 09:17:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:17:41 INFO - 'LOGNAME': 'cltbld', 09:17:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:17:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:17:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:41 INFO - 'MOZ_NO_REMOTE': '1', 09:17:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:17:41 INFO - 'NO_EM_RESTART': '1', 09:17:41 INFO - 'PAGER': '/bin/cat', 09:17:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:17:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:41 INFO - 'PWD': '/builds/slave/test', 09:17:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:17:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:17:41 INFO - 'SHELL': '/bin/bash', 09:17:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6splFFC3td/Listeners', 09:17:41 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 09:17:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:17:41 INFO - 'USER': 'cltbld', 09:17:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:17:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:17:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:41 INFO - 'XPC_FLAGS': '0x0', 09:17:41 INFO - 'XPC_SERVICE_NAME': '0', 09:17:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:17:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WZmcmsk6SI6HSTk-NAD1vg/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0079', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:17:41 INFO - mozversion application_buildid: 20161222071052 09:17:41 INFO - mozversion application_changeset: 6ff5553aea2ac05e70992a1a6573f8ff7ad6da2a 09:17:41 INFO - mozversion application_display_name: Firefox 09:17:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:17:41 INFO - mozversion application_name: Firefox 09:17:41 INFO - mozversion application_remotingname: firefox 09:17:41 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:17:41 INFO - mozversion application_vendor: Mozilla 09:17:41 INFO - mozversion application_version: 51.0 09:17:41 INFO - mozversion platform_buildid: 20161222071052 09:17:41 INFO - mozversion platform_changeset: 6ff5553aea2ac05e70992a1a6573f8ff7ad6da2a 09:17:41 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:17:41 INFO - mozversion platform_version: 51.0 09:17:41 INFO - using testdate: 1482427061 09:17:41 INFO - actual date: 1482427061 09:17:41 INFO - starting webserver on 'localhost:49241' 09:17:41 INFO - SUITE-START | Running 2 tests 09:17:41 INFO - TEST-START | dromaeo_css 09:17:41 INFO - operating with platform_type : mac_ 09:17:41 INFO - Initialising browser for dromaeo_css test... 09:17:41 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/tmpaw1X_Q/profile http://localhost:49241/getInfo.html) 09:17:44 INFO - PROCESS | 1638 | __metrics Screen width/height:1600/1200 09:17:44 INFO - PROCESS | 1638 | colorDepth:24 09:17:44 INFO - PROCESS | 1638 | Browser inner width/height: 1024/689 09:17:44 INFO - PROCESS | 1638 | __metrics 09:17:44 ERROR - PROCESS | 1638 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3015: TypeError: this.tabs is undefined 09:17:45 INFO - TEST-INFO | 1638: exit 0 09:17:45 INFO - Browser initialized. 09:17:45 INFO - Running cycle 1/1 for dromaeo_css test... 09:17:45 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/tmpaw1X_Q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:17:57 INFO - PROCESS | 1642 | RSS: Main: 174645248 09:17:57 INFO - PROCESS | 1642 | 09:18:46 INFO - PROCESS | 1642 | 1482427126807 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:20:58 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 09:21:00 INFO - PROCESS | 1642 | RSS: Main: 185982976 09:21:00 INFO - PROCESS | 1642 | 09:24:02 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 09:24:02 INFO - PROCESS | 1642 | RSS: Main: 196722688 09:24:02 INFO - PROCESS | 1642 | 09:27:04 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 09:27:05 INFO - PROCESS | 1642 | RSS: Main: 199720960 09:27:05 INFO - PROCESS | 1642 | 09:30:07 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 09:30:07 INFO - PROCESS | 1642 | RSS: Main: 203837440 09:30:07 INFO - PROCESS | 1642 | 09:33:10 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 09:33:11 INFO - PROCESS | 1642 | RSS: Main: 205385728 09:33:11 INFO - PROCESS | 1642 | 09:36:13 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 09:36:13 INFO - PROCESS | 1642 | RSS: Main: 207245312 09:36:13 INFO - PROCESS | 1642 | 09:36:13 INFO - PROCESS | 1642 | __start_tp_report 09:36:13 INFO - PROCESS | 1642 | _x_x_mozilla_page_load 09:36:13 INFO - PROCESS | 1642 | _x_x_mozilla_page_load_details 09:36:13 INFO - PROCESS | 1642 | |i|pagename|runs| 09:36:13 INFO - PROCESS | 1642 | |0;dojo.html;3556.8399422026005;3568.107973006748;3586.1393265616252;3590.605033446322;3611.656892595204;5537.723113844302;5935.02072158094;5993.280806303239;5998.310194327653;6001.279846418436;5958.79144229952;6068.757249710006;6071.514278857692;6085.604435711675;6099.1766111574925;5297.549708274802;5383.219433182206;5406.270153529263;5472.26124473197;5524.06090964535;5483.561315094783;5485.122380419134;5486.984907792052;5501.889962200754;5510.448955104477;5358.785648574052;5377.784888604451;5461;5471.562275017989;5476.123820188771;4497.392851964975;5367.9800837840885;5398.946010539884;5428.484293992104;5478.342598888119;5285.154375299933;5373.38206106295;5377;5383.865403364947;5397.865053373658;5989.071693887411;6056.666883321415;6069.271687397496;6097.298810636745;6119.816405507842;6142.590862071548;6175.135481032659;6190.257169139687;6206.813795586095;6211.9068213976825;6324.209473815773;6352.07894855248;6352.555321127523;6360.777372791977;6374.58565193261;6103.115048317969;6121.112438696408;6123.2652081750475;6133.938660613337;6152.138700581967;6122.764110201795;6236;6343.55595108338;6385.808425747235;6460.741570337228;6197.349278325711;6253.405926436982;6257.812265632038;6260.186175797117;6261.186045814015;6339.6196228225535;6350.587211831216;6351.841203969845;6360.52296077796;6390.009548519987;6145.66198859067;6171.105189747462;6192.504599632019;6220.129181914535;6263.843403914939;6155.96922015396;6238.1266622672865;6260.186175797208;6264.843378915472;6266.655333956676;4252.596003379674;5177.896442071137;5180.352455943007;5181.81863634771;5182.714950677749;4497.145542346943;4518;4651.813927442932;4653.697509661861;4675.976620116878;5063.569596584258;5351.03681337363;6037.54718396122;6056.0007598745715;6135.723892424851;5775.451332123442;6309.14826498426;6333.65164915934;6338.524610654219;6342.302346741854;5977.880442391128;5998.430149135826;6033.276006879115;6110.847228819315;6141.170941922873;5638.126090455986;5658.519025882763;5686.402927692616;5728.169415434739;5733.397993210653;6505.934940650627;6520.706568204348;6524.869502609921;6564.245111812203;6565.507586931095;6173.197484327188;6211.316755156839;6295.213098362705;6341.8097457076365;6376.139221205078;6374.23509178883;6452.677366131581;6453.838654033499;6547.80356589284;6553.475721942328;6254.843628909313;6266.154069200599;6276.995680691068;6277.372262773869;6290.056491526308;6170.074488826712;6284.057391391328;6336.4614007808;6345.682715864096;6374.298827129105;6122.459144589048;6131.713108457373;6137.8979746733885;6142.406692085002;6241.938870391953;5119.6416250862085;5127.435982042047;5618.101103823368;5676.347220069745;6219.284782250099;5427.348718153847;5630;6160.44555989963;6210.689465526615;6234.1583886174785;5292.285541451854;5997.880042399215;6116.143739876332;6168.691565421621;6202.255729312511;6149.323574406902;6171.321154673072;6211.16149319836;6215.595986260879;6237.5009999200865 09:36:13 INFO - PROCESS | 1642 | |1;ext.html;458.30795498796806;459.9126166028456;497.89793092416056;508.065160105406;543.6330476928073;40374;41849.16301673969;42030.57969420309;44178.55821441785;44206;43403.56596434035;43811.561884381146;43816.028278727455;43852;43986.7800660997;10064.547095380707;10109.241806864478;10146.289759716823;10225.846612300822;10279.743006424862;10026.19790416765;10156.796864062715;10160.441175735332;10174;10193.796124077515;10043.096121349077;10062.345947513424;10127.037931396506;10177;10192;9991.800163996715;10125.544350504246;10139.898601013969;10163.390196588229;10177.592896284139;8710.303175745925;9945;10018.949905250427;10125.443100629462;10139.23955703318;41359.7932010341;41439.1712165755;41643.58356416428;41799.16401671949;41835;3288.539604455378;3531.2231309111953;3598.712103031777;3915.8237879295216;4398.956010439919;31125.91059312913;31313.686863131305;31783.364332713216;31816.204594885083;31844.363112737847;3248.382807266612;3328.9667103328898;3344.1973926257765;3424.9143771405666;3443.1220038890174;486217;489749.653755194;490335.54832225613;491618;494659;33710;57894.71052644794;58079.41920580825;58339.708301458224;58382.12426813601;34667.82666086704;36857.41998060164;37042.07394815151;37047.4442883357;37092.81453592715;15419.460318888785;15685.294161762748;15786.763198552031;15896.205189740467;15947.282372293275;13386.129901556367;13457.865421345858;13466.663333416744;13519.783219510291;13554.525591604246;7878.330341921001;8163.632636531371;8182.18178182189;8244.958775206085;8254.958725206336;3091.211741006029;3383.543221665093;3404.506346579732;3425.845836937344;3441.9827900860337;991.8859331176862;995.9701208963743;1005.939643621385;1067.4716015572342;1168.7253495428567;33948.83025584856;34365.48451773226;34527.65472345244;35199.82400087983;35366.46950295748;1007.6976906927893;1078.266778590566;1122.8315752637006;1166.2128063557066;1173.9823902641467;13211.207327560378;14369.425222990963;15171.468998585216;15805.972611780428;15989.60025999336;688072.7981800495;710192;715611;715953;717663.4116829382;48631.75684121557;59140.11289830656;60283.397166027775;60361.39638603558;60499.69750151221;1440.3446431873472;1455.1850963460497;1458.9927050364893;1483.725510780509;1486.313034705617;24519.50960980806;28398.432031358843;30034.948776793583;30340.089797306115;31296;49630.751846240535;50299.74850125872;57336.1399579015;57853.264402068;63247;674645;682971;684628;684795;685531;45196.693556418424;45500.31749523826;45740;45968.54031459642;46085;39820.40269396019;48175.277370840166;49338.506614933394;50329;50443.49556504388;39945.601903933224;40272.798636006635;40586;41239.381409279486;42073.1585368297;40883.54698718087;41039.794801025804;41312.1737565253;42517.787411062745;42826.357604635334;39746.40380394238;40221.798891006525;40867;41083.7945810281;41085.794571026956;32368;36114.45828312525;37177;37684.70700617925;37833.054173645876;26826;26858.59712104359;26917;26929.192124236306;26998.460030799666 09:36:13 INFO - PROCESS | 1642 | |2;jquery.html;378.75570257184114;381.6927373464361;389.3886598041073;390.88468901674014;406.6035615275107;20595.588088238244;21640.783592164073;22188;22357.217497387614;22893.885530572366;21254.256101036466;21301.147954081818;21400.892995535;21461.463463413424;21720.456988575294;5745.942540574603;6137.693115344237;6188.195534580498;6254.781082662108;6267.937320626781;4391.121775644884;4470.463544374679;4630.259158534635;6097.5426842986735;6245.625262484243;4639.652026098056;6793.388595026447;6796.4562834973085;6850.349216824394;6884.173899132111;5808.622439541437;6088.634681919099;6138.17134686816;6822.215445223813;6945.270746571613;5866.853328666774;6019.127226552126;6038.698065096728;6039.426254505859;6041.818745437644;22898.77101228983;25212.495750084894;25240.368990775194;26464.338391540172;26488.73511264882;2153.2894144932134;2226.565819665166;2279.1681036421587;2348.852537599608;2379.3575734551573;7885.960570197112;10205.846912296322;10279.640212592598;10798.67603971882;10815.567377304898;1924.8171423714725;1953.90230488475;1962.3131903833687;1981.6631172700675;2058.495668561197;115987.42006289998;122939.77060229372;125298.99999999908;127587.36206319001;129051;9810.950945245371;10005.349652272578;10091.69724908254;10499.842502362471;11795.115366347558;12676.49294028247;12690.98472122228;12741.681457963625;12780.360981950866;12792.936035319764;6462.1276127723095;7582.962085189539;8139.430239883151;8300.626471808782;8680.435771674822;7537.359324457482;7975.800604984805;8725.956370218108;9058.909410905806;9193.080691930754;4009.558948515661;4046.291898917678;4069.328560787496;4111.753294802322;4148.336266197394;1953.9609207815763;1957.1877670766758;1979.356709069558;1995.4712001319663;1996.8817462221202;740.7999840043158;753.6533194730486;896.4038914122166;994.557421947241;1037.2842738510403;21593;21893.67159492609;21924.89037554802;22078.448038799157;22182.667259991114;950.8858936927613;968.7142293023575;985.6895078050392;1018.5721996761378;1036.160709825044;11652;11737.471813768401;11844;11890.28658280506;11959.222650527861;539635;540214;546788;588186;596057;134234.65765342416;135360;138030;138644.6135538652;140765.29617351847;988.0958922585897;1015.7359086637528;1039.153090231459;1039.6984874386494;1044.639599338227;19849.801501985374;19906.5023374411;20549;20616.27843025547;20740.792592073885;55095.72452137714;56138.43861561332;56404;57009.14486282792;58592;78123.60938195273;85863.14136858801;86734.56632717048;88344;88555.55722221348;7414.221506741715;7684.846303073796;8362.540060296742;8365.372597055124;8452.66189352419;10233.334833235816;13031.08782385224;13048.54330098442;13382.197068175941;13387.129836560593;11324.660260192208;11453.08375329955;11601.767964640829;11776.352300623548;11870.465829037887;9757.024297570186;10570.841437378293;11300.83048754253;11437.142214333791;11616.767664646828;11357.772844542898;11603.767924641628;11752.529898804294;11937.46281417321;12003.279803211486;8089.312408445348;8122;8503.617337219715;8538.146185381413;8650.524221167645;8818.470891746516;11393.544258229578;11684.006859417044;11868.762624747284;11926.58256961037 09:36:13 INFO - PROCESS | 1642 | |3;mootools.html;1527.343242405765;1577.6529163584012;1798.4334934495632;1833.834954854063;1932.4299331697148;8229.958850205756;8466.534340611264;8862.601182946766;9444.66943656973;9456.101670341315;8902.065283145257;9158.49628270445;9168.12902774237;9256.166944974952;9263.166315031645;2413.7224219214795;2426.6602675625427;2455.7789798918093;2455.791257743094;2465.963010554834;2041.9591608167827;2116.6824976253533;2204.9448763780874;2425.599776036952;2460.954094509835;2036.2364113457454;2042.3158241988951;2443.5235129149823;2449.0571130114945;2461.716902556211;2407.313915534073;2407.7953373963232;2410.08416801616;2425.7331693513697;2436.719777225624;2060.3509894383224;2414.9396265093337;2416.670831042937;2431.5077046027786;2432.5013372258645;8156.9184308156755;9239.353245272834;9353.111454411888;9435.90564094364;9436.95281523588;5361.597880159004;5485.4788795064405;5571.609987300891;5596;5613.915791263134;3100.4264211121017;3703.3148867459604;3737.3085979093685;3770.7171962102952;3775.1505911170043;1083.9024487796137;1107.8449017137607;1117.3798541809292;1119.4738472917797;1139.242403801471;12255.448504817216;12335.198212116273;12341.197822141532;12343.5062597496;12379.75240495185;4803.231482962709;4906.435759887588;4909.558139767438;5038.748062596856;5056.747162641853;10171.593136274614;10280.126189273846;10305.845412318671;10369.68890933258;10424.843627345595;5462.808801691922;5596.888062238732;5611.158326251095;5623.156526521055;5629.268195134607;4255.787210639455;4518.661100417482;4534.886627834265;4947.925781113287;5330.946690533123;4109.219248342805;4109.753414795122;4186.476690413699;4225.492940847118;4239.872803815891;1308.9280089594972;1311.8556958734532;1324.1591589340837;1326.6351753267736;1327.157255142991;916.4959272400154;921;937.2642475656577;937.4234845570062;943.2124176312718;5168.61235407346;5887.087501437284;5912.526997840162;5958.076498142795;5981.192539007266;431.63742456336826;437.5646231999181;450.9210888094636;454.8135264541522;471.7711909723781;3945.9802700986884;3961.1087505311075;3972.940405893914;4000.2599519089063;4007.338789099766;10233.59065637381;10941.83587246192;11159.553617855196;11253.66239012831;11601.071914247008;11027;11042.834357484644;11057.612983545538;11066.502007409686;11561.364124973206;8184;8610.13898610134;8627.956860215785;8715.477071375737;8731.563421828883;6085.482733967662;6104.481119104926;6120.143179954721;6184.783532576338;6194.690265486798;10420.062194402237;10448.791024179625;10714.035736783728;10728.302660327054;10817.945910270399;10637.787244255227;10770.623028193975;10897.964693354119;10952.507137179005;10979.341239525655;7157.749478768426;7348.448866335153;7736.419768517496;7813.96093019554;7963.124056353912;8655.004674462518;8747.956260218658;8855.468671879707;8869.157430044135;8878.422902511316;7730.420218483749;7797.298243157916;7823;7883.2905038546805;8032;7614.695412183451;7699.230076992256;7728.265814747815;7736.800795876648;7752.14726380109;7118.857622847618;7250.20247772734;7261.273872612696;7261.38278246355;7263.782086537412;4474.194644963938;4558.3618293438285;4843.539863712942;5019.32239147725;5246.055709972242;4934.506549345037;5046.268291097696;5061.7469126544265;5100.566451851634;5148.716820574904 09:36:13 INFO - PROCESS | 1642 | |4;prototype.html;307.7230492556699;312.7982451318899;320.887689308742;323.54380323743527;323.74100719424456;5044.747762611873;5407.83776486706;5555.50000499955;5665.575081868861;5683.1584207896;5333.626646134772;5510.448955104487;5513.448655134494;5518.19986102015;5528.723563821813;3599.6760291573755;3929.135590170158;4265.338872474764;4270.594293542124;4286.914261714764;4151.771652559108;4236.907057847773;4245.893852653693;4282.850100246492;4287.48550173978;3713.591504934455;3753.9812300938456;3801.467794508771;3936.1734035852364;4175.914262291795;4132.524759652633;4202.327627579603;4237.152569486099;4261.659067274611;4267.125239325962;3627.121649443923;3712.3874560697454;3724.9068773280615;3736.1033351995598;3746.5316835395574;4941.517544736565;5157.30376399185;5194.71429071401;5273.789048438096;5398.217258497496;4315.417418648505;4908.460069392364;4908.680935739166;4912.803487860481;4940.950590494121;5488;5825.708714564297;5834.212381328552;5839.080459770115;6003.579749417542;3537.7523573349877;3837.712171587142;4114.794260286973;4117.814698338582;4133.2973394522705;5822.3595404505895;6132.264128304588;6146.89355915935;6225.564210505267;6234.750609975596;3378.8141652209365;3508.4035713928693;4056.7768772717195;4179.811908464066;4203.684723645739;3718.4236443351324;3782.3759079751535;3783.5459744830796;4116.382542618571;4206.72656277341;4874.073925954058;4907.214845624683;4916.926246106311;4925.975370123127;4930.915198656362;5642.322921249476;5807.82576522705;5837.416258374214;5877.4424777434015;5891.293044834561;1325.9204447732975;1418.3971811979868;1425.5865798918405;1430.399232322427;1443.8700516953315;732.6300218389679;810.9270165685117;844.4933040175969;856.9528675922884;913.7983551629586;3943.580311088006;4166.021139958495;4610.74640894754;4634.606058484999;4659.646878326424;4909.967283534405;4978.253262010728;5051.318072060225;5051.570616497565;5067.569256613156;4329.350597410414;4361.323994780814;4576.771161441915;4624.375709279204;4668.95331046692;2822.379076603144;2826.4951460189627;2838.9716102838706;2858.799304292202;3148.6775554267265;5829.941700583025;6186.845328866724;6221.595596286227;6228.283747369111;6255.499560035186;4878.780454879539;5863.824085277449;6186.721597528122;6212.565120441525;6256.217972753406;5574.358948720949;6319.304876463677;6338.429541341301;6371.458426033746;6438.25960014595;5025.221090730943;5549.972250138723;5776;6086.387107416626;6152;5524.254225679482;5939.643621382731;5964.522838173022;6010.669413182317;6045.372776334164;5402.5677945763455;5703.173039909107;5794.391588883106;5898.292204935436;6375.489960803217;3505.3339865425487;3973.5430425501436;4018.598140185958;4072.7374513900786;4088.6933479989716;5603.262988473586;5807.912881306699;6121.693915304306;6161.255833008648;6224.78616669745;5056.8508383937415;5429.914017196656;5874.94125058744;6047.606905551125;6052.667103309184;5195.402528709247;5636.098224284095;5905.852353691193;5934.368048786619;5946.375630558729;5109.565686916505;5816.214811000461;5817.709114544171;5841.1238314253205;5842.795502157574;4708.858734237979;5306.151015837602;5530.889382212253;5919.856100729593;5962.243786414531;4616.584507394351;5004.42449118356;5563.527100196528;5735.655860648374;5831.7375718093635 09:36:13 INFO - PROCESS | 1642 | |5;yui.html;644.0307337457126;684.7432212920152;712.9857402851943;792.1247022040641;821.47015175212;15132.167730774803;15748.842511574881;16411.83588164118;16531.17344132793;16577.00537967721;14587.34356953937;14700.852991470083;14917.254137293146;15286.770698439504;15289.923550382233;726.8800647893091;893.9955300223489;911.8814554107956;913.4793167894303;916.6150216908915;729.4565548666251;887.4586502233632;912.311205040197;917.6008436330218;919.1681528216974;881.8721285413611;884.3279107878027;909.3180114913814;922.9676961306355;926.4672813132443;878.2447095497866;896.9506677132788;914.3005600715458;919.4529255093208;920.5443305563755;626.8526896179394;638.8019713888709;680.0852852912824;688.9793306200822;689.2280645676824;14662.780058299135;14765.483208087773;14831.925840370837;15276.541703748906;15287.312070956834;13436.664083397896;14972.326245318878;15034.323455444532;15129.924350378287;15223.695526089527;11874.821877671842;11913.523459061715;12201.694957626041;12225.877741222652;12654.620361389174;3835.5972622874474;3953.5058117735284;3972.443857859902;3993.3211354069585;3996.4205190247544;111924.4403777976;113131;117853.41073294665;117902.64194716058;119574.99999999913;10765.569377224823;10792.892071079346;10939.398333091598;11293.378864162385;11322.547098116147;20983.37049888506;21260;21288.935553222276;21297.36107916765;21827.454313642287;7937.7618671438795;7947.125816160218;7967.402444816546;8189.426740128253;8326.83346333082;4380.496242932039;4544.931826022612;4583.862484125481;4620.676552641283;4662.207424737802;3604.1710406606103;3751.8874433767032;3753.1930634913624;3758.0416993666986;3772.43413487979;598.5720210049748;670.5004771445305;677.654396257912;678.5724993254219;681.5774219983642;599.7211296746947;664.8736740019477;687.1455201681744;688.1054628982303;690.9481788865855;9059.728208153765;9098.862642169728;9308.394954327947;9572.186364159124;9624.615015399446;579.278797896613;636.7134789344814;665.8401983523919;682.6006786030129;700.478143782885;4262.978685106555;4442.777861106932;4475.283954567253;4492.595666390041;4781.497942716034;98089.01910980798;98414;125649.74350256563;156057.43942560657;162269;114460;115668.42165789286;144786.1890565151;146766.5323346774;153771.2311438458;82367.17632823595;93735;101308;109472;113303.43348283206;9514.762130946781;9846.753831154278;10008.199344052604;10012.749681258027;10050.597976080875;61671;61901.52393904194;62398.68800655968;63996.68001660148;65792.6710366445;58880.41119588921;68004.31995680177;90908.5454572723;92337.53831230801;98960;11153.776924461628;13669.863301366859;13716.696913793174;13761.17432954026;13984.230867302396;15227.771583426036;15469.690606187589;15470;15856.127912964897;15875.682486350439;14114.576562703136;14309.57071287863;14378.496752613608;14454.927725361305;14536.41854325815;12956.546520871725;13755.656108597364;14257.786133208218;14565.271736412926;14754.557363279118;13736;14047.648808779863;14063.789043164565;14305.356258968579;14701.264936753334;11399.544018239178;11476.885231147582;12064.879351206375;12100.576479823163;12170.817437738619;11532.308061516336;11549.769004619693;11753.412329383325;11841.407929603658;11929.821052684043 09:36:13 INFO - PROCESS | 1642 | __end_tp_report 09:36:13 INFO - PROCESS | 1642 | __start_cc_report 09:36:13 INFO - PROCESS | 1642 | _x_x_mozilla_cycle_collect,352 09:36:13 INFO - PROCESS | 1642 | __end_cc_report 09:36:13 INFO - PROCESS | 1642 | __startTimestamp1482428173770__endTimestamp 09:36:13 INFO - PROCESS | 1642 | 09:36:13 INFO - PROCESS | 1642 | ------- Summary: start ------- 09:36:13 INFO - PROCESS | 1642 | Number of tests: 6 09:36:13 INFO - PROCESS | 1642 | 09:36:13 INFO - PROCESS | 1642 | [#0] dojo.html Cycles:165 Average:5863.49 Median:6123.27 stddev:628.25 (10.3%) stddev-sans-first:603.55 09:36:13 INFO - PROCESS | 1642 | Values: 3556.8 3568.1 3586.1 3590.6 3611.7 5537.7 5935.0 5993.3 5998.3 6001.3 5958.8 6068.8 6071.5 6085.6 6099.2 5297.5 5383.2 5406.3 5472.3 5524.1 5483.6 5485.1 5487.0 5501.9 5510.4 5358.8 5377.8 5461.0 5471.6 5476.1 4497.4 5368.0 5398.9 5428.5 5478.3 5285.2 5373.4 5377.0 5383.9 5397.9 5989.1 6056.7 6069.3 6097.3 6119.8 6142.6 6175.1 6190.3 6206.8 6211.9 6324.2 6352.1 6352.6 6360.8 6374.6 6103.1 6121.1 6123.3 6133.9 6152.1 6122.8 6236.0 6343.6 6385.8 6460.7 6197.3 6253.4 6257.8 6260.2 6261.2 6339.6 6350.6 6351.8 6360.5 6390.0 6145.7 6171.1 6192.5 6220.1 6263.8 6156.0 6238.1 6260.2 6264.8 6266.7 4252.6 5177.9 5180.4 5181.8 5182.7 4497.1 4518.0 4651.8 4653.7 4676.0 5063.6 5351.0 6037.5 6056.0 6135.7 5775.5 6309.1 6333.7 6338.5 6342.3 5977.9 5998.4 6033.3 6110.8 6141.2 5638.1 5658.5 5686.4 5728.2 5733.4 6505.9 6520.7 6524.9 6564.2 6565.5 6173.2 6211.3 6295.2 6341.8 6376.1 6374.2 6452.7 6453.8 6547.8 6553.5 6254.8 6266.2 6277.0 6277.4 6290.1 6170.1 6284.1 6336.5 6345.7 6374.3 6122.5 6131.7 6137.9 6142.4 6241.9 5119.6 5127.4 5618.1 5676.3 6219.3 5427.3 5630.0 6160.4 6210.7 6234.2 5292.3 5997.9 6116.1 6168.7 6202.3 6149.3 6171.3 6211.2 6215.6 6237.5 09:36:13 INFO - PROCESS | 1642 | 09:36:13 INFO - PROCESS | 1642 | [#1] ext.html Cycles:180 Average:75157.88 Median:37134.91 stddev:170327.14 (458.7%) stddev-sans-first:170712.61 09:36:13 INFO - PROCESS | 1642 | Values: 458.3 459.9 497.9 508.1 543.6 40374.0 41849.2 42030.6 44178.6 44206.0 43403.6 43811.6 43816.0 43852.0 43986.8 10064.5 10109.2 10146.3 10225.8 10279.7 10026.2 10156.8 10160.4 10174.0 10193.8 10043.1 10062.3 10127.0 10177.0 10192.0 9991.8 10125.5 10139.9 10163.4 10177.6 8710.3 9945.0 10018.9 10125.4 10139.2 41359.8 41439.2 41643.6 41799.2 41835.0 3288.5 3531.2 3598.7 3915.8 4399.0 31125.9 31313.7 31783.4 31816.2 31844.4 3248.4 3329.0 3344.2 3424.9 3443.1 486217.0 489749.7 490335.5 491618.0 494659.0 33710.0 57894.7 58079.4 58339.7 58382.1 34667.8 36857.4 37042.1 37047.4 37092.8 15419.5 15685.3 15786.8 15896.2 15947.3 13386.1 13457.9 13466.7 13519.8 13554.5 7878.3 8163.6 8182.2 8245.0 8255.0 3091.2 3383.5 3404.5 3425.8 3442.0 991.9 996.0 1005.9 1067.5 1168.7 33948.8 34365.5 34527.7 35199.8 35366.5 1007.7 1078.3 1122.8 1166.2 1174.0 13211.2 14369.4 15171.5 15806.0 15989.6 688072.8 710192.0 715611.0 715953.0 717663.4 48631.8 59140.1 60283.4 60361.4 60499.7 1440.3 1455.2 1459.0 1483.7 1486.3 24519.5 28398.4 30034.9 30340.1 31296.0 49630.8 50299.7 57336.1 57853.3 63247.0 674645.0 682971.0 684628.0 684795.0 685531.0 45196.7 45500.3 45740.0 45968.5 46085.0 39820.4 48175.3 49338.5 50329.0 50443.5 39945.6 40272.8 40586.0 41239.4 42073.2 40883.5 41039.8 41312.2 42517.8 42826.4 39746.4 40221.8 40867.0 41083.8 41085.8 32368.0 36114.5 37177.0 37684.7 37833.1 26826.0 26858.6 26917.0 26929.2 26998.5 09:36:13 INFO - PROCESS | 1642 | 09:36:13 INFO - PROCESS | 1642 | [#2] jquery.html Cycles:180 Average:34895.67 Median:22896.33 stddev:94814.20 (414.1%) stddev-sans-first:95044.76 09:36:13 INFO - PROCESS | 1642 | Values: 378.8 381.7 389.4 390.9 406.6 20595.6 21640.8 22188.0 22357.2 22893.9 21254.3 21301.1 21400.9 21461.5 21720.5 5745.9 6137.7 6188.2 6254.8 6267.9 4391.1 4470.5 4630.3 6097.5 6245.6 4639.7 6793.4 6796.5 6850.3 6884.2 5808.6 6088.6 6138.2 6822.2 6945.3 5866.9 6019.1 6038.7 6039.4 6041.8 22898.8 25212.5 25240.4 26464.3 26488.7 2153.3 2226.6 2279.2 2348.9 2379.4 7886.0 10205.8 10279.6 10798.7 10815.6 1924.8 1953.9 1962.3 1981.7 2058.5 115987.4 122939.8 125299.0 127587.4 129051.0 9811.0 10005.3 10091.7 10499.8 11795.1 12676.5 12691.0 12741.7 12780.4 12792.9 6462.1 7583.0 8139.4 8300.6 8680.4 7537.4 7975.8 8726.0 9058.9 9193.1 4009.6 4046.3 4069.3 4111.8 4148.3 1954.0 1957.2 1979.4 1995.5 1996.9 740.8 753.7 896.4 994.6 1037.3 21593.0 21893.7 21924.9 22078.4 22182.7 950.9 968.7 985.7 1018.6 1036.2 11652.0 11737.5 11844.0 11890.3 11959.2 539635.0 540214.0 546788.0 588186.0 596057.0 134234.7 135360.0 138030.0 138644.6 140765.3 988.1 1015.7 1039.2 1039.7 1044.6 19849.8 19906.5 20549.0 20616.3 20740.8 55095.7 56138.4 56404.0 57009.1 58592.0 78123.6 85863.1 86734.6 88344.0 88555.6 7414.2 7684.8 8362.5 8365.4 8452.7 10233.3 13031.1 13048.5 13382.2 13387.1 11324.7 11453.1 11601.8 11776.4 11870.5 9757.0 10570.8 11300.8 11437.1 11616.8 11357.8 11603.8 11752.5 11937.5 12003.3 8089.3 8122.0 8503.6 8538.1 8650.5 8818.5 11393.5 11684.0 11868.8 11926.6 09:36:13 INFO - PROCESS | 1642 | 09:36:13 INFO - PROCESS | 1642 | [#3] mootools.html Cycles:180 Average:5913.39 Median:4526.77 stddev:3406.24 (75.2%) stddev-sans-first:3399.85 09:36:13 INFO - PROCESS | 1642 | Values: 1527.3 1577.7 1798.4 1833.8 1932.4 8230.0 8466.5 8862.6 9444.7 9456.1 8902.1 9158.5 9168.1 9256.2 9263.2 2413.7 2426.7 2455.8 2455.8 2466.0 2042.0 2116.7 2204.9 2425.6 2461.0 2036.2 2042.3 2443.5 2449.1 2461.7 2407.3 2407.8 2410.1 2425.7 2436.7 2060.4 2414.9 2416.7 2431.5 2432.5 8156.9 9239.4 9353.1 9435.9 9437.0 5361.6 5485.5 5571.6 5596.0 5613.9 3100.4 3703.3 3737.3 3770.7 3775.2 1083.9 1107.8 1117.4 1119.5 1139.2 12255.4 12335.2 12341.2 12343.5 12379.8 4803.2 4906.4 4909.6 5038.7 5056.7 10171.6 10280.1 10305.8 10369.7 10424.8 5462.8 5596.9 5611.2 5623.2 5629.3 4255.8 4518.7 4534.9 4947.9 5330.9 4109.2 4109.8 4186.5 4225.5 4239.9 1308.9 1311.9 1324.2 1326.6 1327.2 916.5 921.0 937.3 937.4 943.2 5168.6 5887.1 5912.5 5958.1 5981.2 431.6 437.6 450.9 454.8 471.8 3946.0 3961.1 3972.9 4000.3 4007.3 10233.6 10941.8 11159.6 11253.7 11601.1 11027.0 11042.8 11057.6 11066.5 11561.4 8184.0 8610.1 8628.0 8715.5 8731.6 6085.5 6104.5 6120.1 6184.8 6194.7 10420.1 10448.8 10714.0 10728.3 10817.9 10637.8 10770.6 10898.0 10952.5 10979.3 7157.7 7348.4 7736.4 7814.0 7963.1 8655.0 8748.0 8855.5 8869.2 8878.4 7730.4 7797.3 7823.0 7883.3 8032.0 7614.7 7699.2 7728.3 7736.8 7752.1 7118.9 7250.2 7261.3 7261.4 7263.8 4474.2 4558.4 4843.5 5019.3 5246.1 4934.5 5046.3 5061.7 5100.6 5148.7 09:36:13 INFO - PROCESS | 1642 | 09:36:13 INFO - PROCESS | 1642 | [#4] prototype.html Cycles:180 Average:4676.31 Median:5054.21 stddev:1464.13 (29.0%) stddev-sans-first:1431.05 09:36:13 INFO - PROCESS | 1642 | Values: 307.7 312.8 320.9 323.5 323.7 5044.7 5407.8 5555.5 5665.6 5683.2 5333.6 5510.4 5513.4 5518.2 5528.7 3599.7 3929.1 4265.3 4270.6 4286.9 4151.8 4236.9 4245.9 4282.9 4287.5 3713.6 3754.0 3801.5 3936.2 4175.9 4132.5 4202.3 4237.2 4261.7 4267.1 3627.1 3712.4 3724.9 3736.1 3746.5 4941.5 5157.3 5194.7 5273.8 5398.2 4315.4 4908.5 4908.7 4912.8 4941.0 5488.0 5825.7 5834.2 5839.1 6003.6 3537.8 3837.7 4114.8 4117.8 4133.3 5822.4 6132.3 6146.9 6225.6 6234.8 3378.8 3508.4 4056.8 4179.8 4203.7 3718.4 3782.4 3783.5 4116.4 4206.7 4874.1 4907.2 4916.9 4926.0 4930.9 5642.3 5807.8 5837.4 5877.4 5891.3 1325.9 1418.4 1425.6 1430.4 1443.9 732.6 810.9 844.5 857.0 913.8 3943.6 4166.0 4610.7 4634.6 4659.6 4910.0 4978.3 5051.3 5051.6 5067.6 4329.4 4361.3 4576.8 4624.4 4669.0 2822.4 2826.5 2839.0 2858.8 3148.7 5829.9 6186.8 6221.6 6228.3 6255.5 4878.8 5863.8 6186.7 6212.6 6256.2 5574.4 6319.3 6338.4 6371.5 6438.3 5025.2 5550.0 5776.0 6086.4 6152.0 5524.3 5939.6 5964.5 6010.7 6045.4 5402.6 5703.2 5794.4 5898.3 6375.5 3505.3 3973.5 4018.6 4072.7 4088.7 5603.3 5807.9 6121.7 6161.3 6224.8 5056.9 5429.9 5874.9 6047.6 6052.7 5195.4 5636.1 5905.9 5934.4 5946.4 5109.6 5816.2 5817.7 5841.1 5842.8 4708.9 5306.2 5530.9 5919.9 5962.2 4616.6 5004.4 5563.5 5735.7 5831.7 09:36:13 INFO - PROCESS | 1642 | 09:36:13 INFO - PROCESS | 1642 | [#5] yui.html Cycles:180 Average:24319.51 Median:3752.54 stddev:38188.11 (1017.7%) stddev-sans-first:38253.86 09:36:13 INFO - PROCESS | 1642 | Values: 644.0 684.7 713.0 792.1 821.5 15132.2 15748.8 16411.8 16531.2 16577.0 14587.3 14700.9 14917.3 15286.8 15289.9 726.9 894.0 911.9 913.5 916.6 729.5 887.5 912.3 917.6 919.2 881.9 884.3 909.3 923.0 926.5 878.2 897.0 914.3 919.5 920.5 626.9 638.8 680.1 689.0 689.2 14662.8 14765.5 14831.9 15276.5 15287.3 13436.7 14972.3 15034.3 15129.9 15223.7 11874.8 11913.5 12201.7 12225.9 12654.6 3835.6 3953.5 3972.4 3993.3 3996.4 111924.4 113131.0 117853.4 117902.6 119575.0 10765.6 10792.9 10939.4 11293.4 11322.5 20983.4 21260.0 21288.9 21297.4 21827.5 7937.8 7947.1 7967.4 8189.4 8326.8 4380.5 4544.9 4583.9 4620.7 4662.2 3604.2 3751.9 3753.2 3758.0 3772.4 598.6 670.5 677.7 678.6 681.6 599.7 664.9 687.1 688.1 690.9 9059.7 9098.9 9308.4 9572.2 9624.6 579.3 636.7 665.8 682.6 700.5 4263.0 4442.8 4475.3 4492.6 4781.5 98089.0 98414.0 125649.7 156057.4 162269.0 114460.0 115668.4 144786.2 146766.5 153771.2 82367.2 93735.0 101308.0 109472.0 113303.4 9514.8 9846.8 10008.2 10012.7 10050.6 61671.0 61901.5 62398.7 63996.7 65792.7 58880.4 68004.3 90908.5 92337.5 98960.0 11153.8 13669.9 13716.7 13761.2 13984.2 15227.8 15469.7 15470.0 15856.1 15875.7 14114.6 14309.6 14378.5 14454.9 14536.4 12956.5 13755.7 14257.8 14565.3 14754.6 13736.0 14047.6 14063.8 14305.4 14701.3 11399.5 11476.9 12064.9 12100.6 12170.8 11532.3 11549.8 11753.4 11841.4 11929.8 09:36:13 INFO - PROCESS | 1642 | -------- Summary: end -------- 09:36:13 INFO - PROCESS | 1642 | 09:36:14 INFO - TEST-INFO | 1642: exit 0 09:36:14 INFO - TEST-OK | dromaeo_css | took 1112599ms 09:36:14 INFO - TEST-START | kraken 09:36:14 INFO - operating with platform_type : mac_ 09:36:14 INFO - Initialising browser for kraken test... 09:36:14 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/tmpWo6kLy/profile http://localhost:49241/getInfo.html) 09:36:16 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 09:36:16 INFO - PROCESS | 1655 | colorDepth:24 09:36:16 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 09:36:16 INFO - PROCESS | 1655 | __metrics 09:36:16 ERROR - PROCESS | 1655 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3015: TypeError: this.tabs is undefined 09:36:17 INFO - TEST-INFO | 1655: exit 0 09:36:17 INFO - Browser initialized. 09:36:17 INFO - Running cycle 1/1 for kraken test... 09:36:17 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/tmpWo6kLy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:36:29 INFO - PROCESS | 1658 | RSS: Main: 174940160 09:36:29 INFO - PROCESS | 1658 | 09:36:32 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 09:36:32 INFO - PROCESS | 1658 | RSS: Main: 186986496 09:36:32 INFO - PROCESS | 1658 | 09:36:35 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 09:36:36 INFO - PROCESS | 1658 | RSS: Main: 194478080 09:36:36 INFO - PROCESS | 1658 | 09:36:39 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 09:36:39 INFO - PROCESS | 1658 | RSS: Main: 198176768 09:36:39 INFO - PROCESS | 1658 | 09:36:41 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 09:36:42 INFO - PROCESS | 1658 | RSS: Main: 199471104 09:36:42 INFO - PROCESS | 1658 | 09:36:44 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:36:44 INFO - PROCESS | 1658 | RSS: Main: 199704576 09:36:44 INFO - PROCESS | 1658 | 09:36:47 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 09:36:48 INFO - PROCESS | 1658 | RSS: Main: 200458240 09:36:48 INFO - PROCESS | 1658 | 09:36:51 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 09:36:51 INFO - PROCESS | 1658 | RSS: Main: 200552448 09:36:51 INFO - PROCESS | 1658 | 09:36:54 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 09:36:55 INFO - PROCESS | 1658 | RSS: Main: 201031680 09:36:55 INFO - PROCESS | 1658 | 09:36:56 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:36:57 INFO - PROCESS | 1658 | RSS: Main: 200617984 09:36:57 INFO - PROCESS | 1658 | 09:36:59 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:37:00 INFO - PROCESS | 1658 | RSS: Main: 200626176 09:37:00 INFO - PROCESS | 1658 | 09:37:02 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:37:02 INFO - PROCESS | 1658 | RSS: Main: 200548352 09:37:02 INFO - PROCESS | 1658 | 09:37:05 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:37:06 INFO - PROCESS | 1658 | RSS: Main: 200704000 09:37:06 INFO - PROCESS | 1658 | 09:37:09 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:37:09 INFO - PROCESS | 1658 | RSS: Main: 201093120 09:37:09 INFO - PROCESS | 1658 | 09:37:11 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 09:37:11 INFO - PROCESS | 1658 | RSS: Main: 202780672 09:37:11 INFO - PROCESS | 1658 | 09:37:11 INFO - PROCESS | 1658 | __start_tp_report 09:37:11 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 09:37:11 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 09:37:11 INFO - PROCESS | 1658 | |i|pagename|runs| 09:37:11 INFO - PROCESS | 1658 | |0;ai-astar;106;117;117;117;118;117;115;117;116;117 09:37:11 INFO - PROCESS | 1658 | |1;audio-beat-detection;145;109;142;159;109;114;108;109;134;111 09:37:11 INFO - PROCESS | 1658 | |2;audio-dft;202;196;200;195;196;193;196;194;201;195 09:37:11 INFO - PROCESS | 1658 | |3;audio-fft;80;59;60;86;58;58;61;59;76;59 09:37:11 INFO - PROCESS | 1658 | |4;audio-oscillator;88;70;89;71;68;67;82;69;71;86 09:37:11 INFO - PROCESS | 1658 | |5;imaging-gaussian-blur;89;86;89;86;109;85;89;87;89;89 09:37:11 INFO - PROCESS | 1658 | |6;imaging-darkroom;94;95;95;95;96;97;95;100;148;149 09:37:11 INFO - PROCESS | 1658 | |7;imaging-desaturate;142;151;91;91;90;110;124;91;92;95 09:37:11 INFO - PROCESS | 1658 | |8;json-parse-financial;53;53;52;54;57;59;57;57;56;58 09:37:11 INFO - PROCESS | 1658 | |9;json-stringify-tinderbox;68;71;68;79;74;71;68;66;71;68 09:37:11 INFO - PROCESS | 1658 | |10;stanford-crypto-aes;83;84;79;79;79;76;81;82;79;83 09:37:11 INFO - PROCESS | 1658 | |11;stanford-crypto-ccm;153;153;129;128;140;134;154;158;202;138 09:37:11 INFO - PROCESS | 1658 | |12;stanford-crypto-pbkdf2;163;185;222;189;162;158;164;163;154;166 09:37:11 INFO - PROCESS | 1658 | |13;stanford-crypto-sha256-iterative;70;68;65;60;74;88;87;78;67;67 09:37:11 INFO - PROCESS | 1658 | __end_tp_report 09:37:11 INFO - PROCESS | 1658 | __start_cc_report 09:37:11 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,901 09:37:11 INFO - PROCESS | 1658 | __end_cc_report 09:37:11 INFO - PROCESS | 1658 | __startTimestamp1482428231828__endTimestamp 09:37:11 INFO - PROCESS | 1658 | 09:37:11 INFO - PROCESS | 1658 | ------- Summary: start ------- 09:37:11 INFO - PROCESS | 1658 | Number of tests: 14 09:37:11 INFO - PROCESS | 1658 | 09:37:11 INFO - PROCESS | 1658 | [#0] ai-astar Cycles:10 Average:115.70 Median:117.00 stddev:3.50 (3.0%) stddev-sans-first:0.83 09:37:11 INFO - PROCESS | 1658 | Values: 106.0 117.0 117.0 117.0 118.0 117.0 115.0 117.0 116.0 117.0 09:37:11 INFO - PROCESS | 1658 | 09:37:11 INFO - PROCESS | 1658 | [#1] audio-beat-detection Cycles:10 Average:124.00 Median:124.00 stddev:19.12 (15.4%) stddev-sans-first:18.71 09:37:11 INFO - PROCESS | 1658 | Values: 145.0 109.0 142.0 159.0 109.0 114.0 108.0 109.0 134.0 111.0 09:37:11 INFO - PROCESS | 1658 | 09:37:11 INFO - PROCESS | 1658 | [#2] audio-dft Cycles:10 Average:196.80 Median:196.00 stddev:3.08 (1.6%) stddev-sans-first:2.64 09:37:11 INFO - PROCESS | 1658 | Values: 202.0 196.0 200.0 195.0 196.0 193.0 196.0 194.0 201.0 195.0 09:37:11 INFO - PROCESS | 1658 | 09:37:11 INFO - PROCESS | 1658 | [#3] audio-fft Cycles:10 Average:65.60 Median:60.50 stddev:10.70 (17.7%) stddev-sans-first:10.00 09:37:11 INFO - PROCESS | 1658 | Values: 80.0 59.0 60.0 86.0 58.0 58.0 61.0 59.0 76.0 59.0 09:37:11 INFO - PROCESS | 1658 | 09:37:11 INFO - PROCESS | 1658 | [#4] audio-oscillator Cycles:10 Average:76.10 Median:76.50 stddev:9.00 (11.8%) stddev-sans-first:8.45 09:37:11 INFO - PROCESS | 1658 | Values: 88.0 70.0 89.0 71.0 68.0 67.0 82.0 69.0 71.0 86.0 09:37:11 INFO - PROCESS | 1658 | 09:37:11 INFO - PROCESS | 1658 | [#5] imaging-gaussian-blur Cycles:10 Average:89.80 Median:89.00 stddev:6.92 (7.8%) stddev-sans-first:7.34 09:37:11 INFO - PROCESS | 1658 | Values: 89.0 86.0 89.0 86.0 109.0 85.0 89.0 87.0 89.0 89.0 09:37:11 INFO - PROCESS | 1658 | 09:37:11 INFO - PROCESS | 1658 | [#6] imaging-darkroom Cycles:10 Average:106.40 Median:95.00 stddev:22.25 (23.4%) stddev-sans-first:23.15 09:37:11 INFO - PROCESS | 1658 | Values: 94.0 95.0 95.0 95.0 96.0 97.0 95.0 100.0 148.0 149.0 09:37:11 INFO - PROCESS | 1658 | 09:37:11 INFO - PROCESS | 1658 | [#7] imaging-desaturate Cycles:10 Average:107.70 Median:91.00 stddev:23.29 (25.6%) stddev-sans-first:21.13 09:37:11 INFO - PROCESS | 1658 | Values: 142.0 151.0 91.0 91.0 90.0 110.0 124.0 91.0 92.0 95.0 09:37:11 INFO - PROCESS | 1658 | 09:37:11 INFO - PROCESS | 1658 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:57.00 stddev:2.41 (4.2%) stddev-sans-first:2.37 09:37:11 INFO - PROCESS | 1658 | Values: 53.0 53.0 52.0 54.0 57.0 59.0 57.0 57.0 56.0 58.0 09:37:11 INFO - PROCESS | 1658 | 09:37:11 INFO - PROCESS | 1658 | [#9] json-stringify-tinderbox Cycles:10 Average:70.40 Median:71.00 stddev:3.81 (5.4%) stddev-sans-first:3.94 09:37:11 INFO - PROCESS | 1658 | Values: 68.0 71.0 68.0 79.0 74.0 71.0 68.0 66.0 71.0 68.0 09:37:11 INFO - PROCESS | 1658 | 09:37:11 INFO - PROCESS | 1658 | [#10] stanford-crypto-aes Cycles:10 Average:80.50 Median:81.50 stddev:2.51 (3.1%) stddev-sans-first:2.49 09:37:11 INFO - PROCESS | 1658 | Values: 83.0 84.0 79.0 79.0 79.0 76.0 81.0 82.0 79.0 83.0 09:37:11 INFO - PROCESS | 1658 | 09:37:11 INFO - PROCESS | 1658 | [#11] stanford-crypto-ccm Cycles:10 Average:148.90 Median:153.00 stddev:21.64 (14.1%) stddev-sans-first:22.90 09:37:11 INFO - PROCESS | 1658 | Values: 153.0 153.0 129.0 128.0 140.0 134.0 154.0 158.0 202.0 138.0 09:37:11 INFO - PROCESS | 1658 | 09:37:11 INFO - PROCESS | 1658 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.60 Median:165.00 stddev:20.65 (12.5%) stddev-sans-first:21.60 09:37:11 INFO - PROCESS | 1658 | Values: 163.0 185.0 222.0 189.0 162.0 158.0 164.0 163.0 154.0 166.0 09:37:11 INFO - PROCESS | 1658 | 09:37:11 INFO - PROCESS | 1658 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.40 Median:72.00 stddev:9.32 (12.9%) stddev-sans-first:9.85 09:37:11 INFO - PROCESS | 1658 | Values: 70.0 68.0 65.0 60.0 74.0 88.0 87.0 78.0 67.0 67.0 09:37:11 INFO - PROCESS | 1658 | -------- Summary: end -------- 09:37:11 INFO - PROCESS | 1658 | 09:37:12 INFO - TEST-INFO | 1658: exit 0 09:37:12 INFO - TEST-OK | kraken | took 58493ms 09:37:12 INFO - SUITE-END | took 1171s 09:37:13 INFO - Completed test suite (00:19:31) 09:37:13 INFO - javascript benchmark 09:37:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7472.5903974725625, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3556.8399422026005, 3568.107973006748, 3586.1393265616252, 3590.605033446322, 3611.656892595204, 5537.723113844302, 5935.02072158094, 5993.280806303239, 5998.310194327653, 6001.279846418436, 5958.79144229952, 6068.757249710006, 6071.514278857692, 6085.604435711675, 6099.1766111574925, 5297.549708274802, 5383.219433182206, 5406.270153529263, 5472.26124473197, 5524.06090964535, 5483.561315094783, 5485.122380419134, 5486.984907792052, 5501.889962200754, 5510.448955104477, 5358.785648574052, 5377.784888604451, 5461.0, 5471.562275017989, 5476.123820188771, 4497.392851964975, 5367.9800837840885, 5398.946010539884, 5428.484293992104, 5478.342598888119, 5285.154375299933, 5373.38206106295, 5377.0, 5383.865403364947, 5397.865053373658, 5989.071693887411, 6056.666883321415, 6069.271687397496, 6097.298810636745, 6119.816405507842, 6142.590862071548, 6175.135481032659, 6190.257169139687, 6206.813795586095, 6211.9068213976825, 6324.209473815773, 6352.07894855248, 6352.555321127523, 6360.777372791977, 6374.58565193261, 6103.115048317969, 6121.112438696408, 6123.2652081750475, 6133.938660613337, 6152.138700581967, 6122.764110201795, 6236.0, 6343.55595108338, 6385.808425747235, 6460.741570337228, 6197.349278325711, 6253.405926436982, 6257.812265632038, 6260.186175797117, 6261.186045814015, 6339.6196228225535, 6350.587211831216, 6351.841203969845, 6360.52296077796, 6390.009548519987, 6145.66198859067, 6171.105189747462, 6192.504599632019, 6220.129181914535, 6263.843403914939, 6155.96922015396, 6238.1266622672865, 6260.186175797208, 6264.843378915472, 6266.655333956676, 4252.596003379674, 5177.896442071137, 5180.352455943007, 5181.81863634771, 5182.714950677749, 4497.145542346943, 4518.0, 4651.813927442932, 4653.697509661861, 4675.976620116878, 5063.569596584258, 5351.03681337363, 6037.54718396122, 6056.0007598745715, 6135.723892424851, 5775.451332123442, 6309.14826498426, 6333.65164915934, 6338.524610654219, 6342.302346741854, 5977.880442391128, 5998.430149135826, 6033.276006879115, 6110.847228819315, 6141.170941922873, 5638.126090455986, 5658.519025882763, 5686.402927692616, 5728.169415434739, 5733.397993210653, 6505.934940650627, 6520.706568204348, 6524.869502609921, 6564.245111812203, 6565.507586931095, 6173.197484327188, 6211.316755156839, 6295.213098362705, 6341.8097457076365, 6376.139221205078, 6374.23509178883, 6452.677366131581, 6453.838654033499, 6547.80356589284, 6553.475721942328, 6254.843628909313, 6266.154069200599, 6276.995680691068, 6277.372262773869, 6290.056491526308, 6170.074488826712, 6284.057391391328, 6336.4614007808, 6345.682715864096, 6374.298827129105, 6122.459144589048, 6131.713108457373, 6137.8979746733885, 6142.406692085002, 6241.938870391953, 5119.6416250862085, 5127.435982042047, 5618.101103823368, 5676.347220069745, 6219.284782250099, 5427.348718153847, 5630.0, 6160.44555989963, 6210.689465526615, 6234.1583886174785, 5292.285541451854, 5997.880042399215, 6116.143739876332, 6168.691565421621, 6202.255729312511, 6149.323574406902, 6171.321154673072, 6211.16149319836, 6215.595986260879, 6237.5009999200865], "value": 5827.04634845907, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [458.30795498796806, 459.9126166028456, 497.89793092416056, 508.065160105406, 543.6330476928073, 40374.0, 41849.16301673969, 42030.57969420309, 44178.55821441785, 44206.0, 43403.56596434035, 43811.561884381146, 43816.028278727455, 43852.0, 43986.7800660997, 10064.547095380707, 10109.241806864478, 10146.289759716823, 10225.846612300822, 10279.743006424862, 10026.19790416765, 10156.796864062715, 10160.441175735332, 10174.0, 10193.796124077515, 10043.096121349077, 10062.345947513424, 10127.037931396506, 10177.0, 10192.0, 9991.800163996715, 10125.544350504246, 10139.898601013969, 10163.390196588229, 10177.592896284139, 8710.303175745925, 9945.0, 10018.949905250427, 10125.443100629462, 10139.23955703318, 41359.7932010341, 41439.1712165755, 41643.58356416428, 41799.16401671949, 41835.0, 3288.539604455378, 3531.2231309111953, 3598.712103031777, 3915.8237879295216, 4398.956010439919, 31125.91059312913, 31313.686863131305, 31783.364332713216, 31816.204594885083, 31844.363112737847, 3248.382807266612, 3328.9667103328898, 3344.1973926257765, 3424.9143771405666, 3443.1220038890174, 486217.0, 489749.653755194, 490335.54832225613, 491618.0, 494659.0, 33710.0, 57894.71052644794, 58079.41920580825, 58339.708301458224, 58382.12426813601, 34667.82666086704, 36857.41998060164, 37042.07394815151, 37047.4442883357, 37092.81453592715, 15419.460318888785, 15685.294161762748, 15786.763198552031, 15896.205189740467, 15947.282372293275, 13386.129901556367, 13457.865421345858, 13466.663333416744, 13519.783219510291, 13554.525591604246, 7878.330341921001, 8163.632636531371, 8182.18178182189, 8244.958775206085, 8254.958725206336, 3091.211741006029, 3383.543221665093, 3404.506346579732, 3425.845836937344, 3441.9827900860337, 991.8859331176862, 995.9701208963743, 1005.939643621385, 1067.4716015572342, 1168.7253495428567, 33948.83025584856, 34365.48451773226, 34527.65472345244, 35199.82400087983, 35366.46950295748, 1007.6976906927893, 1078.266778590566, 1122.8315752637006, 1166.2128063557066, 1173.9823902641467, 13211.207327560378, 14369.425222990963, 15171.468998585216, 15805.972611780428, 15989.60025999336, 688072.7981800495, 710192.0, 715611.0, 715953.0, 717663.4116829382, 48631.75684121557, 59140.11289830656, 60283.397166027775, 60361.39638603558, 60499.69750151221, 1440.3446431873472, 1455.1850963460497, 1458.9927050364893, 1483.725510780509, 1486.313034705617, 24519.50960980806, 28398.432031358843, 30034.948776793583, 30340.089797306115, 31296.0, 49630.751846240535, 50299.74850125872, 57336.1399579015, 57853.264402068, 63247.0, 674645.0, 682971.0, 684628.0, 684795.0, 685531.0, 45196.693556418424, 45500.31749523826, 45740.0, 45968.54031459642, 46085.0, 39820.40269396019, 48175.277370840166, 49338.506614933394, 50329.0, 50443.49556504388, 39945.601903933224, 40272.798636006635, 40586.0, 41239.381409279486, 42073.1585368297, 40883.54698718087, 41039.794801025804, 41312.1737565253, 42517.787411062745, 42826.357604635334, 39746.40380394238, 40221.798891006525, 40867.0, 41083.7945810281, 41085.794571026956, 32368.0, 36114.45828312525, 37177.0, 37684.70700617925, 37833.054173645876, 26826.0, 26858.59712104359, 26917.0, 26929.192124236306, 26998.460030799666], "value": 19831.599599782527, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.75570257184114, 381.6927373464361, 389.3886598041073, 390.88468901674014, 406.6035615275107, 20595.588088238244, 21640.783592164073, 22188.0, 22357.217497387614, 22893.885530572366, 21254.256101036466, 21301.147954081818, 21400.892995535, 21461.463463413424, 21720.456988575294, 5745.942540574603, 6137.693115344237, 6188.195534580498, 6254.781082662108, 6267.937320626781, 4391.121775644884, 4470.463544374679, 4630.259158534635, 6097.5426842986735, 6245.625262484243, 4639.652026098056, 6793.388595026447, 6796.4562834973085, 6850.349216824394, 6884.173899132111, 5808.622439541437, 6088.634681919099, 6138.17134686816, 6822.215445223813, 6945.270746571613, 5866.853328666774, 6019.127226552126, 6038.698065096728, 6039.426254505859, 6041.818745437644, 22898.77101228983, 25212.495750084894, 25240.368990775194, 26464.338391540172, 26488.73511264882, 2153.2894144932134, 2226.565819665166, 2279.1681036421587, 2348.852537599608, 2379.3575734551573, 7885.960570197112, 10205.846912296322, 10279.640212592598, 10798.67603971882, 10815.567377304898, 1924.8171423714725, 1953.90230488475, 1962.3131903833687, 1981.6631172700675, 2058.495668561197, 115987.42006289998, 122939.77060229372, 125298.99999999908, 127587.36206319001, 129051.0, 9810.950945245371, 10005.349652272578, 10091.69724908254, 10499.842502362471, 11795.115366347558, 12676.49294028247, 12690.98472122228, 12741.681457963625, 12780.360981950866, 12792.936035319764, 6462.1276127723095, 7582.962085189539, 8139.430239883151, 8300.626471808782, 8680.435771674822, 7537.359324457482, 7975.800604984805, 8725.956370218108, 9058.909410905806, 9193.080691930754, 4009.558948515661, 4046.291898917678, 4069.328560787496, 4111.753294802322, 4148.336266197394, 1953.9609207815763, 1957.1877670766758, 1979.356709069558, 1995.4712001319663, 1996.8817462221202, 740.7999840043158, 753.6533194730486, 896.4038914122166, 994.557421947241, 1037.2842738510403, 21593.0, 21893.67159492609, 21924.89037554802, 22078.448038799157, 22182.667259991114, 950.8858936927613, 968.7142293023575, 985.6895078050392, 1018.5721996761378, 1036.160709825044, 11652.0, 11737.471813768401, 11844.0, 11890.28658280506, 11959.222650527861, 539635.0, 540214.0, 546788.0, 588186.0, 596057.0, 134234.65765342416, 135360.0, 138030.0, 138644.6135538652, 140765.29617351847, 988.0958922585897, 1015.7359086637528, 1039.153090231459, 1039.6984874386494, 1044.639599338227, 19849.801501985374, 19906.5023374411, 20549.0, 20616.27843025547, 20740.792592073885, 55095.72452137714, 56138.43861561332, 56404.0, 57009.14486282792, 58592.0, 78123.60938195273, 85863.14136858801, 86734.56632717048, 88344.0, 88555.55722221348, 7414.221506741715, 7684.846303073796, 8362.540060296742, 8365.372597055124, 8452.66189352419, 10233.334833235816, 13031.08782385224, 13048.54330098442, 13382.197068175941, 13387.129836560593, 11324.660260192208, 11453.08375329955, 11601.767964640829, 11776.352300623548, 11870.465829037887, 9757.024297570186, 10570.841437378293, 11300.83048754253, 11437.142214333791, 11616.767664646828, 11357.772844542898, 11603.767924641628, 11752.529898804294, 11937.46281417321, 12003.279803211486, 8089.312408445348, 8122.0, 8503.617337219715, 8538.146185381413, 8650.524221167645, 8818.470891746516, 11393.544258229578, 11684.006859417044, 11868.762624747284, 11926.58256961037], "value": 9719.15358645665, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1527.343242405765, 1577.6529163584012, 1798.4334934495632, 1833.834954854063, 1932.4299331697148, 8229.958850205756, 8466.534340611264, 8862.601182946766, 9444.66943656973, 9456.101670341315, 8902.065283145257, 9158.49628270445, 9168.12902774237, 9256.166944974952, 9263.166315031645, 2413.7224219214795, 2426.6602675625427, 2455.7789798918093, 2455.791257743094, 2465.963010554834, 2041.9591608167827, 2116.6824976253533, 2204.9448763780874, 2425.599776036952, 2460.954094509835, 2036.2364113457454, 2042.3158241988951, 2443.5235129149823, 2449.0571130114945, 2461.716902556211, 2407.313915534073, 2407.7953373963232, 2410.08416801616, 2425.7331693513697, 2436.719777225624, 2060.3509894383224, 2414.9396265093337, 2416.670831042937, 2431.5077046027786, 2432.5013372258645, 8156.9184308156755, 9239.353245272834, 9353.111454411888, 9435.90564094364, 9436.95281523588, 5361.597880159004, 5485.4788795064405, 5571.609987300891, 5596.0, 5613.915791263134, 3100.4264211121017, 3703.3148867459604, 3737.3085979093685, 3770.7171962102952, 3775.1505911170043, 1083.9024487796137, 1107.8449017137607, 1117.3798541809292, 1119.4738472917797, 1139.242403801471, 12255.448504817216, 12335.198212116273, 12341.197822141532, 12343.5062597496, 12379.75240495185, 4803.231482962709, 4906.435759887588, 4909.558139767438, 5038.748062596856, 5056.747162641853, 10171.593136274614, 10280.126189273846, 10305.845412318671, 10369.68890933258, 10424.843627345595, 5462.808801691922, 5596.888062238732, 5611.158326251095, 5623.156526521055, 5629.268195134607, 4255.787210639455, 4518.661100417482, 4534.886627834265, 4947.925781113287, 5330.946690533123, 4109.219248342805, 4109.753414795122, 4186.476690413699, 4225.492940847118, 4239.872803815891, 1308.9280089594972, 1311.8556958734532, 1324.1591589340837, 1326.6351753267736, 1327.157255142991, 916.4959272400154, 921.0, 937.2642475656577, 937.4234845570062, 943.2124176312718, 5168.61235407346, 5887.087501437284, 5912.526997840162, 5958.076498142795, 5981.192539007266, 431.63742456336826, 437.5646231999181, 450.9210888094636, 454.8135264541522, 471.7711909723781, 3945.9802700986884, 3961.1087505311075, 3972.940405893914, 4000.2599519089063, 4007.338789099766, 10233.59065637381, 10941.83587246192, 11159.553617855196, 11253.66239012831, 11601.071914247008, 11027.0, 11042.834357484644, 11057.612983545538, 11066.502007409686, 11561.364124973206, 8184.0, 8610.13898610134, 8627.956860215785, 8715.477071375737, 8731.563421828883, 6085.482733967662, 6104.481119104926, 6120.143179954721, 6184.783532576338, 6194.690265486798, 10420.062194402237, 10448.791024179625, 10714.035736783728, 10728.302660327054, 10817.945910270399, 10637.787244255227, 10770.623028193975, 10897.964693354119, 10952.507137179005, 10979.341239525655, 7157.749478768426, 7348.448866335153, 7736.419768517496, 7813.96093019554, 7963.124056353912, 8655.004674462518, 8747.956260218658, 8855.468671879707, 8869.157430044135, 8878.422902511316, 7730.420218483749, 7797.298243157916, 7823.0, 7883.2905038546805, 8032.0, 7614.695412183451, 7699.230076992256, 7728.265814747815, 7736.800795876648, 7752.14726380109, 7118.857622847618, 7250.20247772734, 7261.273872612696, 7261.38278246355, 7263.782086537412, 4474.194644963938, 4558.3618293438285, 4843.539863712942, 5019.32239147725, 5246.055709972242, 4934.506549345037, 5046.268291097696, 5061.7469126544265, 5100.566451851634, 5148.716820574904], "value": 4636.749382360672, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [307.7230492556699, 312.7982451318899, 320.887689308742, 323.54380323743527, 323.74100719424456, 5044.747762611873, 5407.83776486706, 5555.50000499955, 5665.575081868861, 5683.1584207896, 5333.626646134772, 5510.448955104487, 5513.448655134494, 5518.19986102015, 5528.723563821813, 3599.6760291573755, 3929.135590170158, 4265.338872474764, 4270.594293542124, 4286.914261714764, 4151.771652559108, 4236.907057847773, 4245.893852653693, 4282.850100246492, 4287.48550173978, 3713.591504934455, 3753.9812300938456, 3801.467794508771, 3936.1734035852364, 4175.914262291795, 4132.524759652633, 4202.327627579603, 4237.152569486099, 4261.659067274611, 4267.125239325962, 3627.121649443923, 3712.3874560697454, 3724.9068773280615, 3736.1033351995598, 3746.5316835395574, 4941.517544736565, 5157.30376399185, 5194.71429071401, 5273.789048438096, 5398.217258497496, 4315.417418648505, 4908.460069392364, 4908.680935739166, 4912.803487860481, 4940.950590494121, 5488.0, 5825.708714564297, 5834.212381328552, 5839.080459770115, 6003.579749417542, 3537.7523573349877, 3837.712171587142, 4114.794260286973, 4117.814698338582, 4133.2973394522705, 5822.3595404505895, 6132.264128304588, 6146.89355915935, 6225.564210505267, 6234.750609975596, 3378.8141652209365, 3508.4035713928693, 4056.7768772717195, 4179.811908464066, 4203.684723645739, 3718.4236443351324, 3782.3759079751535, 3783.5459744830796, 4116.382542618571, 4206.72656277341, 4874.073925954058, 4907.214845624683, 4916.926246106311, 4925.975370123127, 4930.915198656362, 5642.322921249476, 5807.82576522705, 5837.416258374214, 5877.4424777434015, 5891.293044834561, 1325.9204447732975, 1418.3971811979868, 1425.5865798918405, 1430.399232322427, 1443.8700516953315, 732.6300218389679, 810.9270165685117, 844.4933040175969, 856.9528675922884, 913.7983551629586, 3943.580311088006, 4166.021139958495, 4610.74640894754, 4634.606058484999, 4659.646878326424, 4909.967283534405, 4978.253262010728, 5051.318072060225, 5051.570616497565, 5067.569256613156, 4329.350597410414, 4361.323994780814, 4576.771161441915, 4624.375709279204, 4668.95331046692, 2822.379076603144, 2826.4951460189627, 2838.9716102838706, 2858.799304292202, 3148.6775554267265, 5829.941700583025, 6186.845328866724, 6221.595596286227, 6228.283747369111, 6255.499560035186, 4878.780454879539, 5863.824085277449, 6186.721597528122, 6212.565120441525, 6256.217972753406, 5574.358948720949, 6319.304876463677, 6338.429541341301, 6371.458426033746, 6438.25960014595, 5025.221090730943, 5549.972250138723, 5776.0, 6086.387107416626, 6152.0, 5524.254225679482, 5939.643621382731, 5964.522838173022, 6010.669413182317, 6045.372776334164, 5402.5677945763455, 5703.173039909107, 5794.391588883106, 5898.292204935436, 6375.489960803217, 3505.3339865425487, 3973.5430425501436, 4018.598140185958, 4072.7374513900786, 4088.6933479989716, 5603.262988473586, 5807.912881306699, 6121.693915304306, 6161.255833008648, 6224.78616669745, 5056.8508383937415, 5429.914017196656, 5874.94125058744, 6047.606905551125, 6052.667103309184, 5195.402528709247, 5636.098224284095, 5905.852353691193, 5934.368048786619, 5946.375630558729, 5109.565686916505, 5816.214811000461, 5817.709114544171, 5841.1238314253205, 5842.795502157574, 4708.858734237979, 5306.151015837602, 5530.889382212253, 5919.856100729593, 5962.243786414531, 4616.584507394351, 5004.42449118356, 5563.527100196528, 5735.655860648374, 5831.7375718093635], "value": 4206.148353869036, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [644.0307337457126, 684.7432212920152, 712.9857402851943, 792.1247022040641, 821.47015175212, 15132.167730774803, 15748.842511574881, 16411.83588164118, 16531.17344132793, 16577.00537967721, 14587.34356953937, 14700.852991470083, 14917.254137293146, 15286.770698439504, 15289.923550382233, 726.8800647893091, 893.9955300223489, 911.8814554107956, 913.4793167894303, 916.6150216908915, 729.4565548666251, 887.4586502233632, 912.311205040197, 917.6008436330218, 919.1681528216974, 881.8721285413611, 884.3279107878027, 909.3180114913814, 922.9676961306355, 926.4672813132443, 878.2447095497866, 896.9506677132788, 914.3005600715458, 919.4529255093208, 920.5443305563755, 626.8526896179394, 638.8019713888709, 680.0852852912824, 688.9793306200822, 689.2280645676824, 14662.780058299135, 14765.483208087773, 14831.925840370837, 15276.541703748906, 15287.312070956834, 13436.664083397896, 14972.326245318878, 15034.323455444532, 15129.924350378287, 15223.695526089527, 11874.821877671842, 11913.523459061715, 12201.694957626041, 12225.877741222652, 12654.620361389174, 3835.5972622874474, 3953.5058117735284, 3972.443857859902, 3993.3211354069585, 3996.4205190247544, 111924.4403777976, 113131.0, 117853.41073294665, 117902.64194716058, 119574.99999999913, 10765.569377224823, 10792.892071079346, 10939.398333091598, 11293.378864162385, 11322.547098116147, 20983.37049888506, 21260.0, 21288.935553222276, 21297.36107916765, 21827.454313642287, 7937.7618671438795, 7947.125816160218, 7967.402444816546, 8189.426740128253, 8326.83346333082, 4380.496242932039, 4544.931826022612, 4583.862484125481, 4620.676552641283, 4662.207424737802, 3604.1710406606103, 3751.8874433767032, 3753.1930634913624, 3758.0416993666986, 3772.43413487979, 598.5720210049748, 670.5004771445305, 677.654396257912, 678.5724993254219, 681.5774219983642, 599.7211296746947, 664.8736740019477, 687.1455201681744, 688.1054628982303, 690.9481788865855, 9059.728208153765, 9098.862642169728, 9308.394954327947, 9572.186364159124, 9624.615015399446, 579.278797896613, 636.7134789344814, 665.8401983523919, 682.6006786030129, 700.478143782885, 4262.978685106555, 4442.777861106932, 4475.283954567253, 4492.595666390041, 4781.497942716034, 98089.01910980798, 98414.0, 125649.74350256563, 156057.43942560657, 162269.0, 114460.0, 115668.42165789286, 144786.1890565151, 146766.5323346774, 153771.2311438458, 82367.17632823595, 93735.0, 101308.0, 109472.0, 113303.43348283206, 9514.762130946781, 9846.753831154278, 10008.199344052604, 10012.749681258027, 10050.597976080875, 61671.0, 61901.52393904194, 62398.68800655968, 63996.68001660148, 65792.6710366445, 58880.41119588921, 68004.31995680177, 90908.5454572723, 92337.53831230801, 98960.0, 11153.776924461628, 13669.863301366859, 13716.696913793174, 13761.17432954026, 13984.230867302396, 15227.771583426036, 15469.690606187589, 15470.0, 15856.127912964897, 15875.682486350439, 14114.576562703136, 14309.57071287863, 14378.496752613608, 14454.927725361305, 14536.41854325815, 12956.546520871725, 13755.656108597364, 14257.786133208218, 14565.271736412926, 14754.557363279118, 13736.0, 14047.648808779863, 14063.789043164565, 14305.356258968579, 14701.264936753334, 11399.544018239178, 11476.885231147582, 12064.879351206375, 12100.576479823163, 12170.817437738619, 11532.308061516336, 11549.769004619693, 11753.412329383325, 11841.407929603658, 11929.821052684043], "value": 7947.860599136321, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1482.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 117.0, 117.0, 117.0, 118.0, 117.0, 115.0, 117.0, 116.0, 117.0], "value": 115.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 109.0, 142.0, 159.0, 109.0, 114.0, 108.0, 109.0, 134.0, 111.0], "value": 124.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [202.0, 196.0, 200.0, 195.0, 196.0, 193.0, 196.0, 194.0, 201.0, 195.0], "value": 196.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 60.0, 86.0, 58.0, 58.0, 61.0, 59.0, 76.0, 59.0], "value": 65.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 70.0, 89.0, 71.0, 68.0, 67.0, 82.0, 69.0, 71.0, 86.0], "value": 76.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 89.0, 86.0, 109.0, 85.0, 89.0, 87.0, 89.0, 89.0], "value": 89.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 96.0, 97.0, 95.0, 100.0, 148.0, 149.0], "value": 106.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 151.0, 91.0, 91.0, 90.0, 110.0, 124.0, 91.0, 92.0, 95.0], "value": 107.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 52.0, 54.0, 57.0, 59.0, 57.0, 57.0, 56.0, 58.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 68.0, 79.0, 74.0, 71.0, 68.0, 66.0, 71.0, 68.0], "value": 70.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 79.0, 79.0, 79.0, 76.0, 81.0, 82.0, 79.0, 83.0], "value": 80.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 153.0, 129.0, 128.0, 140.0, 134.0, 154.0, 158.0, 202.0, 138.0], "value": 148.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 185.0, 222.0, 189.0, 162.0, 158.0, 164.0, 163.0, 154.0, 166.0], "value": 172.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 65.0, 60.0, 74.0, 88.0, 87.0, 78.0, 67.0, 67.0], "value": 72.4, "unit": "score"}]}]} 09:37:13 INFO - Return code: 0 09:37:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:37:13 ERROR - # TBPL SUCCESS # 09:37:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:37:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:37:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:37:13 INFO - 2016-12-22 09:37:13.185 screenresolution[1663:10653] starting screenresolution argv=screenresolution get 09:37:13 INFO - 2016-12-22 09:37:13.188 screenresolution[1663:10653] Display 0: 1600x1200x32@60 09:37:13 INFO - 2016-12-22 09:37:13.194 screenresolution[1664:10656] starting screenresolution argv=screenresolution list 09:37:13 INFO - Available Modes on Display 0 09:37:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:37:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:37:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:37:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:37:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:37:13 INFO - Intel Iris: 09:37:13 INFO - Chipset Model: Intel Iris 09:37:13 INFO - Type: GPU 09:37:13 INFO - Bus: Built-In 09:37:13 INFO - VRAM (Dynamic, Max): 1536 MB 09:37:13 INFO - Vendor: Intel (0x8086) 09:37:13 INFO - Device ID: 0x0a2e 09:37:13 INFO - Revision ID: 0x0009 09:37:13 INFO - Displays: 09:37:13 INFO - Display: 09:37:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:37:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:37:13 INFO - Display Serial Number: 1600x1200 60 09:37:13 INFO - Main Display: Yes 09:37:13 INFO - Mirror: Off 09:37:13 INFO - Online: Yes 09:37:13 INFO - Rotation: Supported 09:37:13 INFO - Return code: 0 09:37:13 INFO - Running post-action listener: _resource_record_post_action 09:37:13 INFO - [mozharness: 2016-12-22 17:37:13.432081Z] Finished run-tests step (success) 09:37:13 INFO - Running post-run listener: _resource_record_post_run 09:37:13 INFO - Total resource usage - Wall time: 1194s; CPU: 54.0%; Read bytes: 39007232; Write bytes: 497532928; Read time: 439; Write time: 1526 09:37:13 INFO - TinderboxPrint: CPU usage
54.4% 09:37:13 INFO - TinderboxPrint: I/O read bytes / time
39,007,232 / 439 09:37:13 INFO - TinderboxPrint: I/O write bytes / time
497,532,928 / 1,526 09:37:13 INFO - TinderboxPrint: CPU idle
2,179.4 (45.6%) 09:37:13 INFO - TinderboxPrint: CPU system
971.2 (20.3%) 09:37:13 INFO - TinderboxPrint: CPU user
1,627.1 (34.1%) 09:37:13 INFO - TinderboxPrint: Swap in / out
234,328,064 / 0 09:37:13 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 194470400; Write bytes: 186982400; Read time: 17812; Write time: 345 09:37:13 INFO - run-tests - Wall time: 1172s; CPU: 54.0%; Read bytes: 36897792; Write bytes: 300232704; Read time: 415; Write time: 1145 09:37:13 INFO - Running post-run listener: _upload_blobber_files 09:37:13 INFO - Blob upload gear active. 09:37:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:37:13 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 09:37:13 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'] 09:37:13 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 09:37:14 INFO - (blobuploader) - INFO - Open directory for files ... 09:37:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:37:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:37:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:37:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:37:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:37:15 INFO - (blobuploader) - INFO - Done attempting. 09:37:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:37:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:37:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:37:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:37:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:37:16 INFO - (blobuploader) - INFO - Done attempting. 09:37:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:37:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:37:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:37:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:37:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:37:18 INFO - (blobuploader) - INFO - Done attempting. 09:37:18 INFO - (blobuploader) - INFO - Iteration through files over. 09:37:18 INFO - Return code: 0 09:37:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:37:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:37:18 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3e24e14305af44f908eed682e5ccf138c5916d7cf0c8a91e21799cab5d76f400cb15d8bae312f214c32c5176eae3fe2443de7d08c247f9a78cc793b3cbb2954d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4df9ef2ef52f33a5a9d9f06cbd7cdc572e02a87fa2eb444e1570976b2749daf8fdceec99902d517a8a74f985c43cc41d46b035905a1c724d982852f3513163fa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8928fc170a7302dc61d9d73c309894edda88f55cad785aada24aa00dfc0c9055b011b3007ff20e0753152193c1ffe414e1c691b23cf46882470e9515b6cc47fe"} 09:37:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:37:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:37:18 INFO - Contents: 09:37:18 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3e24e14305af44f908eed682e5ccf138c5916d7cf0c8a91e21799cab5d76f400cb15d8bae312f214c32c5176eae3fe2443de7d08c247f9a78cc793b3cbb2954d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4df9ef2ef52f33a5a9d9f06cbd7cdc572e02a87fa2eb444e1570976b2749daf8fdceec99902d517a8a74f985c43cc41d46b035905a1c724d982852f3513163fa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8928fc170a7302dc61d9d73c309894edda88f55cad785aada24aa00dfc0c9055b011b3007ff20e0753152193c1ffe414e1c691b23cf46882470e9515b6cc47fe"} 09:37:18 INFO - Running post-run listener: copy_logs_to_upload_dir 09:37:18 INFO - Copying logs to upload dir... 09:37:18 INFO - mkdir: /builds/slave/test/build/upload/logs 09:37:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.949695 ========= master_lag: 0.19 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-12-22 09:37:18.795714) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-22 09:37:18.803031) ========= 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.p0O9cG2V6H/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.6splFFC3td/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3e24e14305af44f908eed682e5ccf138c5916d7cf0c8a91e21799cab5d76f400cb15d8bae312f214c32c5176eae3fe2443de7d08c247f9a78cc793b3cbb2954d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4df9ef2ef52f33a5a9d9f06cbd7cdc572e02a87fa2eb444e1570976b2749daf8fdceec99902d517a8a74f985c43cc41d46b035905a1c724d982852f3513163fa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8928fc170a7302dc61d9d73c309894edda88f55cad785aada24aa00dfc0c9055b011b3007ff20e0753152193c1ffe414e1c691b23cf46882470e9515b6cc47fe"} build_url:https://queue.taskcluster.net/v1/task/WZmcmsk6SI6HSTk-NAD1vg/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011064 build_url: 'https://queue.taskcluster.net/v1/task/WZmcmsk6SI6HSTk-NAD1vg/artifacts/public/build/firefox-51.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3e24e14305af44f908eed682e5ccf138c5916d7cf0c8a91e21799cab5d76f400cb15d8bae312f214c32c5176eae3fe2443de7d08c247f9a78cc793b3cbb2954d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4df9ef2ef52f33a5a9d9f06cbd7cdc572e02a87fa2eb444e1570976b2749daf8fdceec99902d517a8a74f985c43cc41d46b035905a1c724d982852f3513163fa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8928fc170a7302dc61d9d73c309894edda88f55cad785aada24aa00dfc0c9055b011b3007ff20e0753152193c1ffe414e1c691b23cf46882470e9515b6cc47fe"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-22 09:37:18.840093) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 09:37:18.840389) ========= 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.p0O9cG2V6H/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.6splFFC3td/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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.005256 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 09:37:18.888125) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-22 09:37:18.888398) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-22 09:37:18.888688) ========= ========= Total master_lag: 0.34 =========