builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0073 starttime: 1483009058.77 results: success (0) buildid: 20161229005836 builduid: 8104ad668dd54266bf4c0c517ee4580c revision: 08e289b7046a9fc826e75455d533cbb3f250df27 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-29 02:57:38.768570) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-29 02:57:38.768961) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-29 02:57:38.769414) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-29 02:57:38.972054) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 02:57:38.972442) ========= 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.FQa93TiuY6/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.J0DKlzi9KG/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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-29 02:57:38-- 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% 28.0M=0s 2016-12-29 02:57:39 (28.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.152164 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 02:57:39.165116) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 02:57:39.165402) ========= 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.FQa93TiuY6/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.J0DKlzi9KG/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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.027255 ========= master_lag: 0.09 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 02:57:39.283699) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 02:57:39.284032) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 08e289b7046a9fc826e75455d533cbb3f250df27 --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 08e289b7046a9fc826e75455d533cbb3f250df27 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FQa93TiuY6/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.J0DKlzi9KG/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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-29 02:57:39,381 truncating revision to first 12 chars 2016-12-29 02:57:39,381 Setting DEBUG logging. 2016-12-29 02:57:39,382 attempt 1/10 2016-12-29 02:57:39,382 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/08e289b7046a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-29 02:57:40,021 unpacking tar archive at: mozilla-beta-08e289b7046a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.934890 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 02:57:40.258168) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-29 02:57:40.258452) ========= script_repo_revision: 08e289b7046a9fc826e75455d533cbb3f250df27 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-29 02:57:40.258829) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-29 02:57:40.259090) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-29 02:57:40.310229) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-12-29 02:57:40.310600) ========= /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.FQa93TiuY6/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.J0DKlzi9KG/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 02:57:40 INFO - MultiFileLogger online at 20161229 02:57:40 in /builds/slave/test 02:57:40 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 02:57:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:57:40 INFO - {'append_to_log': False, 02:57:40 INFO - 'base_work_dir': '/builds/slave/test', 02:57:40 INFO - 'blob_upload_branch': 'Mozilla-Beta', 02:57:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:57:40 INFO - 'branch': 'Mozilla-Beta', 02:57:40 INFO - 'buildbot_json_path': 'buildprops.json', 02:57:40 INFO - 'config_files': ('talos/mac_config.py',), 02:57:40 INFO - 'default_actions': ('clobber', 02:57:40 INFO - 'read-buildbot-config', 02:57:40 INFO - 'download-and-extract', 02:57:40 INFO - 'populate-webroot', 02:57:40 INFO - 'create-virtualenv', 02:57:40 INFO - 'install', 02:57:40 INFO - 'run-tests'), 02:57:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:57:40 INFO - 'download_minidump_stackwalk': True, 02:57:40 INFO - 'download_symbols': 'ondemand', 02:57:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:57:40 INFO - 'tooltool.py': '/tools/tooltool.py', 02:57:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:57:40 INFO - '/tools/misc-python/virtualenv.py')}, 02:57:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:57:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:57:40 INFO - 'installer_path': 'installer.exe', 02:57:40 INFO - 'log_level': 'info', 02:57:40 INFO - 'log_name': 'talos', 02:57:40 INFO - 'log_to_console': True, 02:57:40 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:57:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:57:40 INFO - 'opt_config_files': (), 02:57:40 INFO - 'pip_index': False, 02:57:40 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:57:40 INFO - 'cmd': ('bash', 02:57:40 INFO - '-c', 02:57:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:57:40 INFO - 'enabled': True, 02:57:40 INFO - 'halt_on_failure': False, 02:57:40 INFO - 'name': 'check_screen_resolution'},), 02:57:40 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:57:40 INFO - 'cmd': ('bash', 02:57:40 INFO - '-c', 02:57:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:57:40 INFO - 'enabled': True, 02:57:40 INFO - 'halt_on_failure': False, 02:57:40 INFO - 'name': 'check_screen_resolution'},), 02:57:40 INFO - 'run_cmd_checks_enabled': True, 02:57:40 INFO - 'sps_profile': False, 02:57:40 INFO - 'sps_profile_interval': 0, 02:57:40 INFO - 'suite': 'dromaeojs-e10s', 02:57:40 INFO - 'system_bits': '32', 02:57:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:57:40 INFO - 'title': 't-yosemite-r7-0073', 02:57:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:57:40 INFO - 'use_talos_json': True, 02:57:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:57:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:57:40 INFO - 'work_dir': 'build'} 02:57:40 INFO - [mozharness: 2016-12-29 10:57:40.519148Z] Running clobber step. 02:57:40 INFO - Running pre-action listener: _resource_record_pre_action 02:57:40 INFO - Running main action method: clobber 02:57:40 INFO - rmtree: /builds/slave/test/build 02:57:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:57:43 INFO - Running post-action listener: _resource_record_post_action 02:57:43 INFO - [mozharness: 2016-12-29 10:57:43.456149Z] Finished clobber step (success) 02:57:43 INFO - [mozharness: 2016-12-29 10:57:43.456269Z] Running read-buildbot-config step. 02:57:43 INFO - Running pre-action listener: _resource_record_pre_action 02:57:43 INFO - Running main action method: read_buildbot_config 02:57:43 INFO - Using buildbot properties: 02:57:43 INFO - { 02:57:43 INFO - "project": "", 02:57:43 INFO - "product": "firefox", 02:57:43 INFO - "script_repo_revision": "production", 02:57:43 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 02:57:43 INFO - "repository": "", 02:57:43 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 02:57:43 INFO - "buildid": "20161229005836", 02:57:43 INFO - "pgo_build": "False", 02:57:43 INFO - "basedir": "/builds/slave/test", 02:57:43 INFO - "buildnumber": 13, 02:57:43 INFO - "slavename": "t-yosemite-r7-0073", 02:57:43 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 02:57:43 INFO - "platform": "yosemite_r7", 02:57:43 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 02:57:43 INFO - "branch": "mozilla-beta", 02:57:43 INFO - "repo_path": "releases/mozilla-beta", 02:57:43 INFO - "revision": "08e289b7046a9fc826e75455d533cbb3f250df27", 02:57:43 INFO - "stage_platform": "macosx64", 02:57:43 INFO - "builduid": "8104ad668dd54266bf4c0c517ee4580c", 02:57:43 INFO - "slavebuilddir": "test" 02:57:43 INFO - } 02:57:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/UwDDOUtMQ6aneHiMr8MfZg/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 02:57:43 INFO - Running post-action listener: _resource_record_post_action 02:57:43 INFO - [mozharness: 2016-12-29 10:57:43.459533Z] Finished read-buildbot-config step (success) 02:57:43 INFO - [mozharness: 2016-12-29 10:57:43.459651Z] Running download-and-extract step. 02:57:43 INFO - Running pre-action listener: _resource_record_pre_action 02:57:43 INFO - Running main action method: download_and_extract 02:57:43 INFO - mkdir: /builds/slave/test/build/tests 02:57: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')]} 02:57:43 INFO - trying https://queue.taskcluster.net/v1/task/UwDDOUtMQ6aneHiMr8MfZg/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 02:57:43 INFO - Downloading https://queue.taskcluster.net/v1/task/UwDDOUtMQ6aneHiMr8MfZg/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 02:57:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UwDDOUtMQ6aneHiMr8MfZg/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 02:57:44 INFO - Downloaded 1165 bytes. 02:57:44 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 02:57:44 INFO - Using the following test package requirements: 02:57:44 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 02:57:44 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 02:57:44 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 02:57:44 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 02:57:44 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 02:57:44 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 02:57:44 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 02:57:44 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 02:57:44 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 02:57:44 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 02:57:44 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 02:57:44 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 02:57:44 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 02:57:44 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 02:57:44 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 02:57:44 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 02:57:44 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 02:57:44 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 02:57:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UwDDOUtMQ6aneHiMr8MfZg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 02:57:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UwDDOUtMQ6aneHiMr8MfZg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 02:57:44 INFO - Fetch https://queue.taskcluster.net/v1/task/UwDDOUtMQ6aneHiMr8MfZg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 02:57:45 INFO - Expected file size: 16232814 02:57:51 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 02:57:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UwDDOUtMQ6aneHiMr8MfZg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 02:57:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UwDDOUtMQ6aneHiMr8MfZg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 02:57:51 INFO - Fetch https://queue.taskcluster.net/v1/task/UwDDOUtMQ6aneHiMr8MfZg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 02:57:52 INFO - Expected file size: 16232814 02:57:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UwDDOUtMQ6aneHiMr8MfZg/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 02:57:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UwDDOUtMQ6aneHiMr8MfZg/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 02:57:59 INFO - Fetch https://queue.taskcluster.net/v1/task/UwDDOUtMQ6aneHiMr8MfZg/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 02:58:00 INFO - Expected file size: 14414089 02:58:00 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')]} 02:58:00 INFO - trying https://queue.taskcluster.net/v1/task/UwDDOUtMQ6aneHiMr8MfZg/artifacts/public/build/firefox-51.0.en-US.mac.dmg 02:58:00 INFO - Downloading https://queue.taskcluster.net/v1/task/UwDDOUtMQ6aneHiMr8MfZg/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 02:58:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UwDDOUtMQ6aneHiMr8MfZg/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 02:58:02 INFO - Downloaded 85964174 bytes. 02:58:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UwDDOUtMQ6aneHiMr8MfZg/artifacts/public/build/firefox-51.0.en-US.mac.dmg 02:58:02 INFO - mkdir: /builds/slave/test/properties 02:58:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:58:02 INFO - Writing to file /builds/slave/test/properties/build_url 02:58:02 INFO - Contents: 02:58:02 INFO - build_url:https://queue.taskcluster.net/v1/task/UwDDOUtMQ6aneHiMr8MfZg/artifacts/public/build/firefox-51.0.en-US.mac.dmg 02:58:03 INFO - Running post-action listener: _resource_record_post_action 02:58:03 INFO - Running post-action listener: set_extra_try_arguments 02:58:03 INFO - [mozharness: 2016-12-29 10:58:03.653250Z] Finished download-and-extract step (success) 02:58:03 INFO - [mozharness: 2016-12-29 10:58:03.653407Z] Running populate-webroot step. 02:58:03 INFO - Running pre-action listener: _resource_record_pre_action 02:58:03 INFO - Running main action method: populate_webroot 02:58:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:58:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:58:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:58:03 INFO - '--tppagecycles', 02:58:03 INFO - '7'], 02:58:03 INFO - 'tests': ['tsvgm']}}, 02:58:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:58:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:58:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:58:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:58:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:58:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:58:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:58:03 INFO - 'talos_options': ['--disable-e10s'], 02:58:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:58:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:58:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:58:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:58:03 INFO - 'talos_options': ['--disable-e10s'], 02:58:03 INFO - 'tests': ['damp', 'tps']}, 02:58:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:58:03 INFO - 'tests': ['damp', 'tps']}, 02:58:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:58:03 INFO - 'tests': ['dromaeo_dom']}, 02:58:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:58:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:58:03 INFO - 'tests': ['basic_compositor_video']}, 02:58:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:58:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:58:03 INFO - 'tests': ['a11yr', 02:58:03 INFO - 'ts_paint', 02:58:03 INFO - 'tpaint', 02:58:03 INFO - 'sessionrestore', 02:58:03 INFO - 'sessionrestore_no_auto_restore', 02:58:03 INFO - 'tabpaint']}, 02:58:03 INFO - 'other-e10s': {'tests': ['a11yr', 02:58:03 INFO - 'ts_paint', 02:58:03 INFO - 'tpaint', 02:58:03 INFO - 'sessionrestore', 02:58:03 INFO - 'sessionrestore_no_auto_restore', 02:58:03 INFO - 'tabpaint']}, 02:58:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:58:03 INFO - 'ts_paint', 02:58:03 INFO - 'tpaint', 02:58:03 INFO - 'sessionrestore', 02:58:03 INFO - 'sessionrestore_no_auto_restore', 02:58:03 INFO - 'tabpaint']}, 02:58:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:58:03 INFO - 'ts_paint', 02:58:03 INFO - 'tpaint', 02:58:03 INFO - 'sessionrestore', 02:58:03 INFO - 'sessionrestore_no_auto_restore', 02:58:03 INFO - 'tabpaint']}, 02:58:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:58:03 INFO - 'tests': ['a11yr', 02:58:03 INFO - 'ts_paint', 02:58:03 INFO - 'tpaint', 02:58:03 INFO - 'sessionrestore', 02:58:03 INFO - 'sessionrestore_no_auto_restore', 02:58:03 INFO - 'tabpaint']}, 02:58:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:58:03 INFO - 'tests': ['a11yr', 02:58:03 INFO - 'ts_paint', 02:58:03 INFO - 'tpaint', 02:58:03 INFO - 'sessionrestore', 02:58:03 INFO - 'sessionrestore_no_auto_restore', 02:58:03 INFO - 'tabpaint']}, 02:58:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:58:03 INFO - 'tests': ['tsvgx', 02:58:03 INFO - 'tsvgr_opacity', 02:58:03 INFO - 'tart', 02:58:03 INFO - 'tscrollx', 02:58:03 INFO - 'cart']}, 02:58:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:58:03 INFO - 'tsvgr_opacity', 02:58:03 INFO - 'tart', 02:58:03 INFO - 'tscrollx', 02:58:03 INFO - 'cart']}, 02:58:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:58:03 INFO - 'talos_options': ['--disable-e10s'], 02:58:03 INFO - 'tests': ['tp5o']}, 02:58:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:58:03 INFO - 'tests': ['tp5o']}, 02:58:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:58:03 INFO - 'talos_options': ['--disable-e10s', 02:58:03 INFO - '--xperf_path', 02:58:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:58:03 INFO - 'tests': ['tp5n']}, 02:58:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:58:03 INFO - 'talos_options': ['--xperf_path', 02:58:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:58:03 INFO - 'tests': ['tp5n']}}, 02:58:03 INFO - 'talos.zip': {'path': '', 02:58:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:58:03 INFO - Running post-action listener: _resource_record_post_action 02:58:03 INFO - [mozharness: 2016-12-29 10:58:03.671969Z] Finished populate-webroot step (success) 02:58:03 INFO - [mozharness: 2016-12-29 10:58:03.672063Z] Running create-virtualenv step. 02:58:03 INFO - Running pre-action listener: _resource_record_pre_action 02:58:03 INFO - Running main action method: create_virtualenv 02:58:03 INFO - Creating virtualenv /builds/slave/test/build/venv 02:58:03 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 02:58:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:58:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:58:03 INFO - Using real prefix '/tools/python27' 02:58:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:58:04 INFO - Installing distribute.............................................................................................................................................................................................done. 02:58:07 INFO - Installing pip.................done. 02:58:07 INFO - Return code: 0 02:58:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:58: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')]} 02:58:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58: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')]} 02:58:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:07 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 0x1036fe490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103674570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc16147d540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103512d30>, '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 0x103378db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10350ab20>, '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.FQa93TiuY6/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.J0DKlzi9KG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 02:58:07 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 02:58:07 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 02:58:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FQa93TiuY6/Render', 02:58:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:58:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:58:07 INFO - 'HOME': '/Users/cltbld', 02:58:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:58:07 INFO - 'LOGNAME': 'cltbld', 02:58:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:07 INFO - 'MOZ_NO_REMOTE': '1', 02:58:07 INFO - 'NO_EM_RESTART': '1', 02:58:07 INFO - 'PAGER': '/bin/cat', 02:58:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:58:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:07 INFO - 'PWD': '/builds/slave/test', 02:58:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:58:07 INFO - 'SHELL': '/bin/bash', 02:58:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J0DKlzi9KG/Listeners', 02:58:07 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 02:58:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:58:07 INFO - 'USER': 'cltbld', 02:58:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:58:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:58:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:07 INFO - 'XPC_FLAGS': '0x0', 02:58:07 INFO - 'XPC_SERVICE_NAME': '0', 02:58:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:58:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:07 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 02:58:07 INFO - Cleaning up... 02:58:07 INFO - Return code: 0 02:58:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:58: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')]} 02:58:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58: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')]} 02:58:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:07 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 0x1036fe490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103674570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc16147d540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103512d30>, '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 0x103378db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10350ab20>, '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.FQa93TiuY6/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.J0DKlzi9KG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 02:58:07 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 02:58:07 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 02:58:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FQa93TiuY6/Render', 02:58:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:58:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:58:07 INFO - 'HOME': '/Users/cltbld', 02:58:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:58:07 INFO - 'LOGNAME': 'cltbld', 02:58:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:07 INFO - 'MOZ_NO_REMOTE': '1', 02:58:07 INFO - 'NO_EM_RESTART': '1', 02:58:07 INFO - 'PAGER': '/bin/cat', 02:58:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:58:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:07 INFO - 'PWD': '/builds/slave/test', 02:58:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:58:07 INFO - 'SHELL': '/bin/bash', 02:58:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J0DKlzi9KG/Listeners', 02:58:07 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 02:58:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:58:07 INFO - 'USER': 'cltbld', 02:58:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:58:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:58:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:07 INFO - 'XPC_FLAGS': '0x0', 02:58:07 INFO - 'XPC_SERVICE_NAME': '0', 02:58:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:58:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:08 INFO - Downloading/unpacking psutil>=3.1.1 02:58:08 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 02:58:08 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 02:58:08 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 02:58:08 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 02:58:08 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 02:58:08 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 02:58:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:58:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:58:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:58:11 INFO - Installing collected packages: psutil 02:58:11 INFO - Running setup.py install for psutil 02:58:11 INFO - building 'psutil._psutil_osx' extension 02:58:11 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 02:58:11 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 02:58:12 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 02:58:12 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 02:58:12 INFO - building 'psutil._psutil_posix' extension 02:58:12 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 02:58:12 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:58:12 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:58:12 INFO - ^ 02:58:12 INFO - 1 warning generated. 02:58:12 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 02:58:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:58:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:58:12 INFO - Successfully installed psutil 02:58:12 INFO - Cleaning up... 02:58:12 INFO - Return code: 0 02:58:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:58: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')]} 02:58:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58: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')]} 02:58:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:12 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 0x1036fe490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103674570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc16147d540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103512d30>, '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 0x103378db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10350ab20>, '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.FQa93TiuY6/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.J0DKlzi9KG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 02:58:12 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 02:58:12 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 02:58:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FQa93TiuY6/Render', 02:58:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:58:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:58:12 INFO - 'HOME': '/Users/cltbld', 02:58:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:58:12 INFO - 'LOGNAME': 'cltbld', 02:58:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:12 INFO - 'MOZ_NO_REMOTE': '1', 02:58:12 INFO - 'NO_EM_RESTART': '1', 02:58:12 INFO - 'PAGER': '/bin/cat', 02:58:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:58:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:12 INFO - 'PWD': '/builds/slave/test', 02:58:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:58:12 INFO - 'SHELL': '/bin/bash', 02:58:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J0DKlzi9KG/Listeners', 02:58:12 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 02:58:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:58:12 INFO - 'USER': 'cltbld', 02:58:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:58:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:58:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:12 INFO - 'XPC_FLAGS': '0x0', 02:58:12 INFO - 'XPC_SERVICE_NAME': '0', 02:58:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:58:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:58:12 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 02:58:12 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 02:58:12 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 02:58:12 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 02:58:12 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 02:58:12 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 02:58:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:58:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:58:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:58:15 INFO - Installing collected packages: mozsystemmonitor 02:58:15 INFO - Running setup.py install for mozsystemmonitor 02:58:15 INFO - Successfully installed mozsystemmonitor 02:58:15 INFO - Cleaning up... 02:58:15 INFO - Return code: 0 02:58:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:58:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:58:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:58:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:15 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 0x1036fe490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103674570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc16147d540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103512d30>, '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 0x103378db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10350ab20>, '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.FQa93TiuY6/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.J0DKlzi9KG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 02:58:15 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 02:58:15 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 02:58:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FQa93TiuY6/Render', 02:58:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:58:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:58:15 INFO - 'HOME': '/Users/cltbld', 02:58:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:58:15 INFO - 'LOGNAME': 'cltbld', 02:58:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:15 INFO - 'MOZ_NO_REMOTE': '1', 02:58:15 INFO - 'NO_EM_RESTART': '1', 02:58:15 INFO - 'PAGER': '/bin/cat', 02:58:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:58:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:15 INFO - 'PWD': '/builds/slave/test', 02:58:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:58:15 INFO - 'SHELL': '/bin/bash', 02:58:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J0DKlzi9KG/Listeners', 02:58:15 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 02:58:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:58:15 INFO - 'USER': 'cltbld', 02:58:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:58:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:58:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:15 INFO - 'XPC_FLAGS': '0x0', 02:58:15 INFO - 'XPC_SERVICE_NAME': '0', 02:58:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:58:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:16 INFO - Downloading/unpacking jsonschema==2.5.1 02:58:16 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 02:58:16 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 02:58:16 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 02:58:16 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 02:58:16 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 02:58:16 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 02:58:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:58:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:58:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:58:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:58:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:58:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:58:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:58:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:58:19 INFO - Downloading functools32-3.2.3-2.tar.gz 02:58:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:58:19 INFO - warning: no files found matching '*.txt' 02:58:19 INFO - no previously-included directories found matching 'build' 02:58:19 INFO - no previously-included directories found matching 'dist' 02:58:19 INFO - no previously-included directories found matching '.git*' 02:58:19 INFO - Installing collected packages: jsonschema, functools32 02:58:19 INFO - Running setup.py install for functools32 02:58:19 INFO - warning: no files found matching '*.txt' 02:58:19 INFO - no previously-included directories found matching 'build' 02:58:19 INFO - no previously-included directories found matching 'dist' 02:58:19 INFO - no previously-included directories found matching '.git*' 02:58:19 INFO - Successfully installed jsonschema functools32 02:58:19 INFO - Cleaning up... 02:58:19 INFO - Return code: 0 02:58:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:58:19 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')]} 02:58:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:19 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')]} 02:58:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:19 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 0x1036fe490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103674570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc16147d540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103512d30>, '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 0x103378db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10350ab20>, '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.FQa93TiuY6/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.J0DKlzi9KG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 02:58:19 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 02:58:19 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 02:58:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FQa93TiuY6/Render', 02:58:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:58:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:58:19 INFO - 'HOME': '/Users/cltbld', 02:58:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:58:19 INFO - 'LOGNAME': 'cltbld', 02:58:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:19 INFO - 'MOZ_NO_REMOTE': '1', 02:58:19 INFO - 'NO_EM_RESTART': '1', 02:58:19 INFO - 'PAGER': '/bin/cat', 02:58:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:58:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:19 INFO - 'PWD': '/builds/slave/test', 02:58:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:58:19 INFO - 'SHELL': '/bin/bash', 02:58:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J0DKlzi9KG/Listeners', 02:58:19 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 02:58:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:58:19 INFO - 'USER': 'cltbld', 02:58:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:58:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:58:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:19 INFO - 'XPC_FLAGS': '0x0', 02:58:19 INFO - 'XPC_SERVICE_NAME': '0', 02:58:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:58:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:58:19 INFO - Cleaning up... 02:58:19 INFO - Return code: 0 02:58:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:58:19 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')]} 02:58:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:19 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')]} 02:58:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:19 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 0x1036fe490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103674570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc16147d540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103512d30>, '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 0x103378db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10350ab20>, '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.FQa93TiuY6/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.J0DKlzi9KG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 02:58:19 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 02:58:19 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 02:58:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FQa93TiuY6/Render', 02:58:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:58:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:58:19 INFO - 'HOME': '/Users/cltbld', 02:58:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:58:19 INFO - 'LOGNAME': 'cltbld', 02:58:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:19 INFO - 'MOZ_NO_REMOTE': '1', 02:58:19 INFO - 'NO_EM_RESTART': '1', 02:58:19 INFO - 'PAGER': '/bin/cat', 02:58:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:58:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:19 INFO - 'PWD': '/builds/slave/test', 02:58:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:58:19 INFO - 'SHELL': '/bin/bash', 02:58:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J0DKlzi9KG/Listeners', 02:58:19 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 02:58:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:58:19 INFO - 'USER': 'cltbld', 02:58:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:58:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:58:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:19 INFO - 'XPC_FLAGS': '0x0', 02:58:19 INFO - 'XPC_SERVICE_NAME': '0', 02:58:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:58:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:20 INFO - Downloading/unpacking blobuploader==1.2.4 02:58:20 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 02:58:20 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 02:58:20 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 02:58:20 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 02:58:20 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 02:58:20 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 02:58:22 INFO - Downloading blobuploader-1.2.4.tar.gz 02:58:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:58:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:58:22 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 02:58:22 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 02:58:22 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 02:58:22 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 02:58:22 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 02:58:22 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 02:58:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:58:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:58:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:58:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:58:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:58:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:58:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:58:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:58:23 INFO - Downloading docopt-0.6.1.tar.gz 02:58:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:58:24 INFO - Installing collected packages: blobuploader, requests, docopt 02:58:24 INFO - Running setup.py install for blobuploader 02:58:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:58:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:58:24 INFO - Running setup.py install for requests 02:58:24 INFO - Running setup.py install for docopt 02:58:24 INFO - Successfully installed blobuploader requests docopt 02:58:24 INFO - Cleaning up... 02:58:24 INFO - Return code: 0 02:58:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:58:24 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')]} 02:58:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:58:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:25 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 0x1036fe490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103674570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc16147d540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103512d30>, '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 0x103378db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10350ab20>, '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.FQa93TiuY6/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.J0DKlzi9KG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 02:58:25 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 02:58:25 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 02:58:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FQa93TiuY6/Render', 02:58:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:58:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:58:25 INFO - 'HOME': '/Users/cltbld', 02:58:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:58:25 INFO - 'LOGNAME': 'cltbld', 02:58:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:25 INFO - 'MOZ_NO_REMOTE': '1', 02:58:25 INFO - 'NO_EM_RESTART': '1', 02:58:25 INFO - 'PAGER': '/bin/cat', 02:58:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:58:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:25 INFO - 'PWD': '/builds/slave/test', 02:58:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:58:25 INFO - 'SHELL': '/bin/bash', 02:58:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J0DKlzi9KG/Listeners', 02:58:25 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 02:58:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:58:25 INFO - 'USER': 'cltbld', 02:58:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:58:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:58:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:25 INFO - 'XPC_FLAGS': '0x0', 02:58:25 INFO - 'XPC_SERVICE_NAME': '0', 02:58:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:58:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:58:25 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-5G5Jru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:58:25 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-jO8pbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:58:25 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-pyVRk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:58:25 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-CJ2xAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:58:25 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-s8OkVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:58:25 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-Gp3awb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:58:25 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-sbrdwb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:58:25 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-0AKwW2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:58:26 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-PTLZbF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:58:26 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-J_dERL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:58:26 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-9Btc1k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:58:26 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-9aZvG2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:58:26 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-hFsXMp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:58:26 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-6aTscN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:58:26 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-6t8yfn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:58:26 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-8iG6mS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:58:26 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-mnqsXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:58:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:58:27 INFO - Running setup.py install for manifestparser 02:58:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:58:27 INFO - Running setup.py install for mozcrash 02:58:27 INFO - Running setup.py install for mozdebug 02:58:27 INFO - Running setup.py install for mozdevice 02:58:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:58:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:58:27 INFO - Running setup.py install for mozfile 02:58:27 INFO - Running setup.py install for mozhttpd 02:58:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:58:27 INFO - Running setup.py install for mozinfo 02:58:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:58:28 INFO - Running setup.py install for mozInstall 02:58:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:58:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:58:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:58:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:58:28 INFO - Running setup.py install for mozleak 02:58:28 INFO - Running setup.py install for mozlog 02:58:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:58:28 INFO - Running setup.py install for moznetwork 02:58:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:58:28 INFO - Running setup.py install for mozprocess 02:58:28 INFO - Running setup.py install for mozprofile 02:58:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:58:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:58:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:58:28 INFO - Running setup.py install for mozrunner 02:58:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:58:29 INFO - Running setup.py install for mozscreenshot 02:58:29 INFO - Running setup.py install for moztest 02:58:29 INFO - Running setup.py install for mozversion 02:58:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:58:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:58:29 INFO - Cleaning up... 02:58:29 INFO - Return code: 0 02:58:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:58:29 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')]} 02:58:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:29 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')]} 02:58:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:29 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 0x1036fe490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103674570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc16147d540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103512d30>, '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 0x103378db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10350ab20>, '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.FQa93TiuY6/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.J0DKlzi9KG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 02:58:29 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 02:58:29 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 02:58:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FQa93TiuY6/Render', 02:58:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:58:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:58:29 INFO - 'HOME': '/Users/cltbld', 02:58:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:58:29 INFO - 'LOGNAME': 'cltbld', 02:58:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:29 INFO - 'MOZ_NO_REMOTE': '1', 02:58:29 INFO - 'NO_EM_RESTART': '1', 02:58:29 INFO - 'PAGER': '/bin/cat', 02:58:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:58:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:29 INFO - 'PWD': '/builds/slave/test', 02:58:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:58:29 INFO - 'SHELL': '/bin/bash', 02:58:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J0DKlzi9KG/Listeners', 02:58:29 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 02:58:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:58:29 INFO - 'USER': 'cltbld', 02:58:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:58:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:58:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:29 INFO - 'XPC_FLAGS': '0x0', 02:58:29 INFO - 'XPC_SERVICE_NAME': '0', 02:58:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:58:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:58:29 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-_fhJyV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:58:29 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)) 02:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:58:29 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-wAwLO1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:58:30 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)) 02:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:58:30 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-VAflI4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:58:30 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)) 02:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:58:30 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-VqcIqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:58:30 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)) 02:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:58:30 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-TpCm1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:58:30 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)) 02:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:58:30 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-nID_9a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:58:30 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)) 02:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:58:30 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-3mF_EB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:58:30 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)) 02:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:58:30 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-hrDdOC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:58:30 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)) 02:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:58:30 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-GgoZR1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:58:30 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)) 02:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:58:30 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-5EG8Tr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:58:30 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)) 02:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:58:30 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-vHSWuQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:58:31 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)) 02:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:58:31 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-pMZTtd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:58:31 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)) 02:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:58:31 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-5xT7UW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:58:31 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)) 02:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:58:31 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-10oZvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:58:31 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)) 02:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:58:31 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-YVfstt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:58:31 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)) 02:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:58:31 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-tlXwiv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:58:31 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)) 02:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:58:31 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-doeKB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:58:31 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)) 02:58:31 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)) 02:58:31 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)) 02:58:31 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)) 02:58:31 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)) 02:58:31 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)) 02:58:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:58:31 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 02:58:31 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 02:58:31 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 02:58:31 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 02:58:31 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 02:58:31 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 02:58:34 INFO - Downloading blessings-1.6.tar.gz 02:58:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:58:34 INFO - Installing collected packages: blessings 02:58:34 INFO - Running setup.py install for blessings 02:58:34 INFO - Successfully installed blessings 02:58:34 INFO - Cleaning up... 02:58:34 INFO - Return code: 0 02:58:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:58:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:58:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:58:34 INFO - Reading from file tmpfile_stdout 02:58:34 INFO - Current package versions: 02:58:34 INFO - blessings == 1.6 02:58:34 INFO - blobuploader == 1.2.4 02:58:34 INFO - docopt == 0.6.1 02:58:34 INFO - functools32 == 3.2.3-2 02:58:34 INFO - jsonschema == 2.5.1 02:58:34 INFO - manifestparser == 1.1 02:58:34 INFO - mozInstall == 1.12 02:58:34 INFO - mozcrash == 0.17 02:58:34 INFO - mozdebug == 0.1 02:58:34 INFO - mozdevice == 0.48 02:58:34 INFO - mozfile == 1.2 02:58:34 INFO - mozhttpd == 0.7 02:58:34 INFO - mozinfo == 0.9 02:58:34 INFO - mozleak == 0.1 02:58:34 INFO - mozlog == 3.4 02:58:34 INFO - moznetwork == 0.27 02:58:34 INFO - mozprocess == 0.23 02:58:34 INFO - mozprofile == 0.28 02:58:34 INFO - mozrunner == 6.12 02:58:34 INFO - mozscreenshot == 0.1 02:58:34 INFO - mozsystemmonitor == 0.3 02:58:34 INFO - moztest == 0.7 02:58:34 INFO - mozversion == 1.4 02:58:34 INFO - psutil == 3.1.1 02:58:34 INFO - requests == 1.2.3 02:58:34 INFO - wsgiref == 0.1.2 02:58:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:58:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:58:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:58:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:35 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 0x1036fe490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103674570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc16147d540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103512d30>, '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 0x103378db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10350ab20>, '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.FQa93TiuY6/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.J0DKlzi9KG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 02:58:35 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 02:58:35 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 02:58:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FQa93TiuY6/Render', 02:58:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:58:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:58:35 INFO - 'HOME': '/Users/cltbld', 02:58:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:58:35 INFO - 'LOGNAME': 'cltbld', 02:58:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:35 INFO - 'MOZ_NO_REMOTE': '1', 02:58:35 INFO - 'NO_EM_RESTART': '1', 02:58:35 INFO - 'PAGER': '/bin/cat', 02:58:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:58:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:35 INFO - 'PWD': '/builds/slave/test', 02:58:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:58:35 INFO - 'SHELL': '/bin/bash', 02:58:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J0DKlzi9KG/Listeners', 02:58:35 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 02:58:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:58:35 INFO - 'USER': 'cltbld', 02:58:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:58:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:58:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:35 INFO - 'XPC_FLAGS': '0x0', 02:58:35 INFO - 'XPC_SERVICE_NAME': '0', 02:58:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:58:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:35 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)) 02:58:35 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)) 02:58:35 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)) 02:58:35 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)) 02:58:35 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)) 02:58:35 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)) 02:58:35 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)) 02:58:35 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)) 02:58:35 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)) 02:58:35 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)) 02:58:35 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)) 02:58:35 INFO - Cleaning up... 02:58:35 INFO - Return code: 0 02:58:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:58:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:58:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:58:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1036fe490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103674570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc16147d540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103512d30>, '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 0x103378db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10350ab20>, '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.FQa93TiuY6/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.J0DKlzi9KG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 02:58:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:58:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:58:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FQa93TiuY6/Render', 02:58:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:58:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:58:35 INFO - 'HOME': '/Users/cltbld', 02:58:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:58:35 INFO - 'LOGNAME': 'cltbld', 02:58:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:35 INFO - 'MOZ_NO_REMOTE': '1', 02:58:35 INFO - 'NO_EM_RESTART': '1', 02:58:35 INFO - 'PAGER': '/bin/cat', 02:58:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:58:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:35 INFO - 'PWD': '/builds/slave/test', 02:58:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:58:35 INFO - 'SHELL': '/bin/bash', 02:58:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J0DKlzi9KG/Listeners', 02:58:35 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 02:58:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:58:35 INFO - 'USER': 'cltbld', 02:58:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:58:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:58:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:35 INFO - 'XPC_FLAGS': '0x0', 02:58:35 INFO - 'XPC_SERVICE_NAME': '0', 02:58:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:58:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:58:35 INFO - Cleaning up... 02:58:35 INFO - Return code: 0 02:58:35 INFO - Running post-action listener: _resource_record_post_action 02:58:35 INFO - Running post-action listener: _start_resource_monitoring 02:58:35 INFO - Starting resource monitoring. 02:58:35 INFO - [mozharness: 2016-12-29 10:58:35.562816Z] Finished create-virtualenv step (success) 02:58:35 INFO - [mozharness: 2016-12-29 10:58:35.563750Z] Running install step. 02:58:35 INFO - Running pre-action listener: _resource_record_pre_action 02:58:35 INFO - Running main action method: install 02:58:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:58:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:58:35 INFO - Reading from file tmpfile_stdout 02:58:35 INFO - Detecting whether we're running mozinstall >=1.0... 02:58:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:58:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:58:35 INFO - Reading from file tmpfile_stdout 02:58:35 INFO - Output received: 02:58:35 INFO - Usage: mozinstall [options] installer 02:58:35 INFO - Options: 02:58:35 INFO - -h, --help show this help message and exit 02:58:35 INFO - -d DEST, --destination=DEST 02:58:35 INFO - Directory to install application into. [default: 02:58:35 INFO - "/builds/slave/test"] 02:58:35 INFO - --app=APP Application being installed. [default: firefox] 02:58:35 INFO - mkdir: /builds/slave/test/build/application 02:58:35 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'] 02:58:35 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 02:58:57 INFO - Reading from file tmpfile_stdout 02:58:57 INFO - Output received: 02:58:57 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 02:58:57 INFO - Running post-action listener: _resource_record_post_action 02:58:57 INFO - [mozharness: 2016-12-29 10:58:57.876693Z] Finished install step (success) 02:58:57 INFO - [mozharness: 2016-12-29 10:58:57.876819Z] Running run-tests step. 02:58:57 INFO - Running pre-action listener: _resource_record_pre_action 02:58:57 INFO - Running main action method: run_tests 02:58:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:58:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:58:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:58:57 INFO - 2016-12-29 02:58:57.891 screenresolution[1627:7884] starting screenresolution argv=screenresolution get 02:58:57 INFO - 2016-12-29 02:58:57.893 screenresolution[1627:7884] Display 0: 1600x1200x32@60 02:58:57 INFO - 2016-12-29 02:58:57.899 screenresolution[1628:7887] starting screenresolution argv=screenresolution list 02:58:57 INFO - Available Modes on Display 0 02:58:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:58:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:58:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:58:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:58:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:58:58 INFO - Intel Iris: 02:58:58 INFO - Chipset Model: Intel Iris 02:58:58 INFO - Type: GPU 02:58:58 INFO - Bus: Built-In 02:58:58 INFO - VRAM (Dynamic, Max): 1536 MB 02:58:58 INFO - Vendor: Intel (0x8086) 02:58:58 INFO - Device ID: 0x0a2e 02:58:58 INFO - Revision ID: 0x0009 02:58:58 INFO - Displays: 02:58:58 INFO - Display: 02:58:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:58:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:58:58 INFO - Display Serial Number: 1600x1200 60 02:58:58 INFO - Main Display: Yes 02:58:58 INFO - Mirror: Off 02:58:58 INFO - Online: Yes 02:58:58 INFO - Rotation: Supported 02:58:58 INFO - Return code: 0 02:58:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:58:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:58:58 INFO - Python 2.7.3 02:58:58 INFO - Return code: 0 02:58:58 INFO - grabbing minidump binary from tooltool 02:58: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')]} 02:58:58 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 0x103512d30>, '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 0x103378db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10350ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:58:58 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 02:58:58 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 02:58:58 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 02:58:58 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:58:58 INFO - Return code: 0 02:58:58 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:58:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:58:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:58:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:58:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:58:58 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/UwDDOUtMQ6aneHiMr8MfZg/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0073', '--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 02:58:58 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/UwDDOUtMQ6aneHiMr8MfZg/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0073 --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 02:58:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FQa93TiuY6/Render', 02:58:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:58:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:58:58 INFO - 'HOME': '/Users/cltbld', 02:58:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:58:58 INFO - 'LOGNAME': 'cltbld', 02:58:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:58:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:58:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:58 INFO - 'MOZ_NO_REMOTE': '1', 02:58:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:58:58 INFO - 'NO_EM_RESTART': '1', 02:58:58 INFO - 'PAGER': '/bin/cat', 02:58:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:58:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:58 INFO - 'PWD': '/builds/slave/test', 02:58:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:58:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:58:58 INFO - 'SHELL': '/bin/bash', 02:58:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J0DKlzi9KG/Listeners', 02:58:58 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 02:58:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:58:58 INFO - 'USER': 'cltbld', 02:58:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:58:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:58:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:58 INFO - 'XPC_FLAGS': '0x0', 02:58:58 INFO - 'XPC_SERVICE_NAME': '0', 02:58:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:58:58 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/UwDDOUtMQ6aneHiMr8MfZg/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0073', '--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 02:58:58 INFO - mozversion application_buildid: 20161229005836 02:58:58 INFO - mozversion application_changeset: 08e289b7046a9fc826e75455d533cbb3f250df27 02:58:58 INFO - mozversion application_display_name: Firefox 02:58:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:58:58 INFO - mozversion application_name: Firefox 02:58:58 INFO - mozversion application_remotingname: firefox 02:58:58 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 02:58:58 INFO - mozversion application_vendor: Mozilla 02:58:58 INFO - mozversion application_version: 51.0 02:58:58 INFO - mozversion platform_buildid: 20161229005836 02:58:58 INFO - mozversion platform_changeset: 08e289b7046a9fc826e75455d533cbb3f250df27 02:58:58 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 02:58:58 INFO - mozversion platform_version: 51.0 02:58:58 INFO - using testdate: 1483009138 02:58:58 INFO - actual date: 1483009138 02:58:58 INFO - starting webserver on 'localhost:49249' 02:58:58 INFO - SUITE-START | Running 2 tests 02:58:58 INFO - TEST-START | dromaeo_css 02:58:58 INFO - operating with platform_type : mac_ 02:58:58 INFO - Initialising browser for dromaeo_css test... 02:58:58 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/tmp9LP_l3/profile http://localhost:49249/getInfo.html) 02:59:01 INFO - PROCESS | 1638 | __metrics Screen width/height:1600/1200 02:59:01 INFO - PROCESS | 1638 | colorDepth:24 02:59:01 INFO - PROCESS | 1638 | Browser inner width/height: 1024/689 02:59:01 INFO - PROCESS | 1638 | __metrics 02:59:01 ERROR - PROCESS | 1638 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3015: TypeError: this.tabs is undefined 02:59:01 INFO - TEST-INFO | 1638: exit 0 02:59:01 INFO - Browser initialized. 02:59:01 INFO - Running cycle 1/1 for dromaeo_css test... 02:59:01 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/tmp9LP_l3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:59:13 INFO - PROCESS | 1643 | RSS: Main: 175181824 02:59:13 INFO - PROCESS | 1643 | 03:00:03 INFO - PROCESS | 1643 | 1483009203630 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] 03:02:14 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49249/tests/dromaeo/cssquery-ext.html) 03:02:15 INFO - PROCESS | 1643 | RSS: Main: 186466304 03:02:15 INFO - PROCESS | 1643 | 03:05:17 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-ext.html (next: http://localhost:49249/tests/dromaeo/cssquery-jquery.html) 03:05:18 INFO - PROCESS | 1643 | RSS: Main: 198406144 03:05:18 INFO - PROCESS | 1643 | 03:08:20 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49249/tests/dromaeo/cssquery-mootools.html) 03:08:20 INFO - PROCESS | 1643 | RSS: Main: 200339456 03:08:20 INFO - PROCESS | 1643 | 03:11:22 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49249/tests/dromaeo/cssquery-prototype.html) 03:11:23 INFO - PROCESS | 1643 | RSS: Main: 204812288 03:11:23 INFO - PROCESS | 1643 | 03:14:25 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49249/tests/dromaeo/cssquery-yui.html) 03:14:26 INFO - PROCESS | 1643 | RSS: Main: 206934016 03:14:26 INFO - PROCESS | 1643 | 03:17:29 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-yui.html (next: http://localhost:49249/tests/dromaeo/cssquery-dojo.html) 03:17:29 INFO - PROCESS | 1643 | RSS: Main: 208412672 03:17:29 INFO - PROCESS | 1643 | 03:17:29 INFO - PROCESS | 1643 | __start_tp_report 03:17:29 INFO - PROCESS | 1643 | _x_x_mozilla_page_load 03:17:29 INFO - PROCESS | 1643 | _x_x_mozilla_page_load_details 03:17:29 INFO - PROCESS | 1643 | |i|pagename|runs| 03:17:29 INFO - PROCESS | 1643 | |0;dojo.html;3203.615566132064;3591.120175556989;3597.6582224688677;3612.9096772580683;3646.4894914711945;5874;5875.059990401532;5932.525397968163;5933.169356290123;5953.851153721159;5864.677442740658;5969.910451343222;5972.402759724026;5972.880542389161;6001.369856165105;5272.578193744501;5309.73451327434;5316.41519432864;5369.207653807492;5407.161889907071;5365.919511207335;5366.597505187107;5380.435054319299;5387.24578559002;5397.4062853086125;4311.849085282016;5236.476352364771;5246.711430871301;5381.67709937405;5410.729463526808;5302.867428314304;5375.11310633745;5375.489328513804;5376.059189641797;5414.972925135349;5200.193969934666;5314.707691076989;5319.3616765987945;5366.221897824794;5373.005993891104;5694.088945768699;5694.373618901917;5787.102999035156;5833.620814647077;6017.669028203447;5399.865003374908;6127.525510585588;6143.2662465203;6143.573288550997;6167.7532898684;6186.133941248228;6228.128062071313;6289.716962736642;6296.968515157395;6315.74737010519;5979.342272350038;6079.604825686316;6106;6106.847328816771;6110.908336375002;6296.992481203077;6327.778527751599;6340.017297318831;6342.8414289642205;6363.96818015907;6193.102000210034;6202.28673702521;6208.317085120633;6222.906656400067;6223.96888015557;6129.175413489909;6145.586515101551;6172.444479996821;6269.467095296951;6272.40412160844;6135.417135372132;6191.25704915404;6193.194884664965;6204.162438070893;6210.285817130997;6159.568830181934;6176;6196.969015154896;6210.50315974721;6315.179026726588;4937.1113199624415;4989.525995030466;5056;5060.746962651852;5064.848054558369;4481.686281960297;4501.774911254424;4544.590986811203;4575.611073058761;4636.258198688193;6021.909671354933;6079;6088.665123418166;6088.695565221721;6100.969495152496;6120.386183820725;6259.906101408483;6270.059491076375;6274.905876411857;6285.8742825143245;5915.319738230072;5958.195643588147;6036.486898613579;6064.75740970365;6107.006761825686;5535.6955367455175;5537.252470916455;5547.916781248285;5563.527100196528;5594.356648985337;5344.599155063308;6415.711292991827;6430.871382572323;6478;6487.935120648733;6135.600157732601;6147.200863887666;6151.907721384272;6155.753769849335;6200.56596038273;6470.708818103102;6487.156669632917;6487.44856687168;6502.804915852532;6509.479241660751;6214.720337584729;6218.471429928326;6219.253689557282;6219.595726277777;6224.688765561795;5926.496247818984;6104.603200791934;6156.815295541141;6159.907601385893;6273.059041143865;4330.935035974526;5197.7141257231215;6182.319944806158;6191.721372538156;6192.287886892885;6179.783707570214;6193.411625895533;6221.346758590464;6222.626642401289;6229.470495007794;5977.432143946318;6056.818295451144;6124.899720462962;6166.660833654013;6198.258546529319;6118.619179173342;6177.1969643945995;6195.907061393992;6229;6241;6113.480354169767;6141.201643786279;6202;6204.410580994799;6204.534659900616 03:17:29 INFO - PROCESS | 1643 | |1;ext.html;473.8341580446843;478.36855350936753;491.31461611052583;507.97206153661546;570.574921683346;40259.59740402595;42932.570674293245;43063.35404968928;43079.56920430795;43093.353599695954;44034.89912752183;44211;44459.77770111153;44533.77733111338;44646.55353446465;10021.298509104347;10035.247356448259;10188.23588230882;10215.591376344937;10262.076413122817;10008.39949603026;10054.09513143817;10107.848382274271;10116.190704743603;10147.543360548756;10034.147097496721;10068.949655251714;10130.898691013106;10154.3399679021;10166;10026.548805303742;10044.09603135714;10083.344582602143;10087.546060427298;10090.596376144946;9987.850182247272;10044.648437304659;10054.24593155509;10089.192864570818;10139.340942838766;41999.58000420018;42250.36624450636;42301.942451438656;42427;42501.1499770006;3296;3499.965000349989;3574.463830425431;3926.7447615904875;4198.538160802309;31583.210419739462;32455.6754432455;33061.83469082639;33188.50217246719;33320.66679333224;3178.411993781158;3264.265540253448;3283.1463819407127;3326.9833650831833;3353.279045005336;548324;554447;557934.2103289498;558134.9999999959;560598;68137;68516.6574167126;68693.65653171802;68697.31302687009;68944.6552767233;36216.637833621855;36575.63424365722;36990.260194795956;38805.41791873124;38864.41703374452;15061.698766024618;17630.294788208583;18137.909310453364;18150.910945343323;18177.545561361072;13640.386182621805;13742.65643358904;13750.65623359404;13773.242471664154;13776.311184440738;17948.102594870204;18384.98882561445;20506.692399614018;20644;20753.377398678065;6951;7242.23956484572;8175.223353781381;8432.241098301183;8456.661733530713;902.5893218585528;951.533748463248;980.2354163752285;1080.481368942896;1085.5494969587692;31167;31477.213069673442;31561.684383155876;32240.032799016066;32374.83812580922;939.2063706168277;1083.7073990022807;1107.4905543450104;1128.15388458656;1176.1825531255695;15957.601059973362;16720.74918876218;16761.580960475843;16919.492415227316;16950.660986780196;186768;187269;187662.1233787672;187925;188234;63040;63556;63577.68211158914;63703.04445433322;63794.362056379774;1374.6082366525493;1416.2493878244547;1417.3834382043638;1424;1430.049017403436;26267.737322627294;30212.69787302187;30230;31778.364432711678;32185.67814321827;54706.45293547014;54720.17919731128;55013.72493137509;55295.72352138213;55428;646021;646852;647458;647476;651140;28736.856315718287;29017.419651607273;29066.854665727384;29069.418611628073;29156.7084329154;50256.74358141076;50270;50718.7320316995;51787.223191652905;51788.74105629448;40907;40978.385324220755;41759.164816704106;41936.16127677368;42611;41853.372199417645;42196.578034220496;42272.788636056626;42591.787041065836;42611.93470163271;40987.59012409838;41019.79490102531;41052.79473602613;41128;42447.36328955006;33125.503117452776;36537.81731091328;36541.634583653824;36664;37014.25971480609;22382.776172238067;27163.32091697644;27343.58984615272;27378.726212737616;27531.862340688167 03:17:29 INFO - PROCESS | 1643 | |2;jquery.html;312.93428380040183;371.806660536521;384.9114703618168;387.6917850309004;410.9951169390841;20732.585348293043;21254.89372553135;21324.04041818118;21758.456038599044;21872.781272187272;21083.262085826962;21108.577828443424;21428;21514.677279840816;21612.783872161275;5918.260217472816;5977.983742763729;6045.848853778669;6113.296970848365;6128.8467788305425;4416.933745993812;4630.351750754897;6089.0866370044405;6097.878042439149;6531.183602049744;6754.189497260336;6807.523473356842;6834.179898412172;6842.863142737142;6868.107146071004;5659.745311460973;6574.14536110305;6674.332566743286;6701.463882889358;6768.950812624051;4544.613707834838;5520.834374968757;5812.099124635688;5954.702264886781;5956.7319470623925;25249.62125568118;25709.97160113593;25998.22005339843;25999.350016249555;26697.798599063088;2369.2655276864225;2799.468101060792;3032.4996375598;3152.133163380066;3226.080567038406;11972.98229650472;14396.136231826124;15024.948253622251;15051.548453546411;15731.449399271085;1787.2225581871796;1922.3464022232367;1934.7001214811726;2008.0160721246484;2013.4563667809755;116594;119443.40278298639;120484;121075;122825.99999999911;9686.564104615309;11145.665630031112;11160.274582152135;11377.658670239905;11557;14135.222562759147;14251.78622320666;14254.786178207336;14340.856591434162;14379.64050898715;8762.824743505094;8960;8994.595243214071;9010.684626038057;9031.954840225757;8944.105589441135;9069.231499857597;9072.274218062672;9134.862977055349;9234.86147707785;5720.914186287209;6805.557638753465;6901.309869013159;6923.6192009439965;6977.744006078853;1632.5347276026275;1702.8297170282872;1708;1900.6103748731477;1939.699346601279;907.8728977943093;924.6255266617031;925.1257561604353;940.83535381308;991.7371896447447;20884;21123.78876211218;21335.359939201848;21502.569948601253;21817.563648727253;857.7512521368858;865.8484765166071;913.3652111782247;951.3103000324709;959.1319855530755;10897.727556810985;11443.656690299138;11476.368799715929;11513.251638643462;11553.884461155281;525319;636429;641995;646481.7675911684;656871;134277.3286133563;136769;137770.6222937778;141156;141506.1698766019;975.9072888075622;978.7406337320616;989.6091044037709;995.6564985080136;996.7391250068669;18791.530211744815;19088;19098.427047188605;19242.615147697248;19267.421977340142;40762;55803.720981394836;56414;57498.7125064372;57635.71182144062;78007;79718.60140699259;80327;80333;81354;8236.50580965144;8294.502329860228;8454.196851299117;8476.152384761475;8541.53021583819;13002.609921702364;13222.4049917752;13419.060665753304;13448.193108413527;13811.861881381057;11610;11636.76726465449;11664.416779161178;11741.941290293835;11961.880381196424;11302.265352752045;11536.82694759596;11642.76714465723;11713.1800773945;11935.104867134825;11495.712607184552;11642.70893227676;11737.178397512092;11751.88248117542;11866.169368144147;7251;7570.621468926642;7754.147043825287;8422.747317580483;8490.787730306545;8318.126596707258;11185.66443006711;11681.474333654836;11719.589814356457;11821.349825759322 03:17:29 INFO - PROCESS | 1643 | |3;mootools.html;1468.2218424235157;1485.8737007354375;1743.6948534006547;1904.752382190315;1987.2249822569192;8102;8357.331413486922;8917.866232006525;9514.476703781298;9514.904850951489;8281.75154745357;9277.90722092779;9289.90710092899;9296.209822165125;9428.858567121482;2435.82949193557;2473.1220416751976;2473.998030797521;2479.293401380607;2481.8138639602103;2415.8792060397;2435.512897420514;2440.5722652248455;2478.946447759704;2483.379155211197;2459.446624509489;2464.852108873464;2472.5425796227755;2481.751824817522;2496.014074440595;2348.729896061958;2410.4696966667307;2411.626197939322;2438.8048956083558;2441.023590563771;2419.2106778954176;2425.3936515871032;2443.9389015274583;2460.360306320352;2466.136852101768;9371.34400591959;9376.296777741629;9445.952770236174;9448.149666530046;9495.525223738854;5440.4287549807495;5568;5589.133684278943;5615.438456154393;5628.634138780966;3501.562304711911;3681.484592157073;3700.1674623209833;3744.344739670547;3764.3976963685677;1066.3868275741402;1082.2640604389012;1099.2689861242263;1104.4422566603894;1121.3047910295668;12301.692457688629;12302.446389912475;12315.630531083993;12344.38278086092;12349.814752778715;4812.975935120302;4886.755662216875;4901.5588597026435;4984.601231901439;5003.374578177728;8073.506401315658;8365.372597055246;9307.883054033558;9779.41323520591;10385;4675.298705194248;5543.501084902378;5572.4706152915405;5576.079946808813;5582.441755824466;4603.58567728906;4711.1519926413575;4969.2546118081855;5072.087024335655;5096.643234973516;4094.3653733670735;4119.732217405859;4206.768627725504;4237.957620423756;4254.829806807693;1328.6147017364856;1333.613252156883;1342.4831439895515;1350.0751984890383;1360.53741727813;753.5629334985695;779.8089468080243;832.650286879512;836.7322456813882;850.961706723199;5032.949670503322;6006.249218847644;6060.181875446847;6125.908111378333;6128.448439640454;455.0058123001253;457.7093545598502;459.8896264896401;464.06722487799766;470.3368250766403;3241.4651582489096;3400.7619466637098;4026.3557830747527;4056.371262454324;4096.877093687194;10875.564977400816;11325.490352934137;11334.773304533863;11385.032272256785;11411.030062444619;9443;10668.946655266674;11033.393163376091;11314.434278286053;11365.147613928988;7303.744368947061;8356.832863342699;8404.915950840536;8436.957815211008;8589.398742088119;5480.671159730429;5975.535993681576;6086.939130608637;6091.238595175603;6187.226596675416;10107.595696172071;10265.897341026493;10547.894521054692;10661.573537058432;10671.626493072705;10598.04617584421;10780.407077610807;10808.621698240524;10841.241113122005;10846.620368287073;7174.605396703231;7402.33378995893;7663.731769388045;7891.250331218525;8034;8471.449355791854;8630.352723545633;8777.078406767452;8787.956060219658;8798.12018798115;7715.459917805924;7788.104367997526;7816.960915195387;7849.646765895434;7963.84072318562;7597.278258565428;7624.5425274483705;7647.426443016685;7662.348700360531;7675.808104797201;7192.532485388433;7196.712131514891;7229.891551626835;7251.1298644163035;7318.780436586911;4895.192293271571;5002.399712034579;5028.069807085701;5099.821506247264;5238.768889311085;5080.136376815876;5131.512506311894;5146.25379319989;5168.457311982338;5209.062368773657 03:17:29 INFO - PROCESS | 1643 | |4;prototype.html;290.1918157930165;313.33416489958836;314.76549970272146;319.67712610263635;322.5371591765816;4278.65770738341;5266.5786737061035;5503.559715222783;5609.775608975641;5670.914936275959;4834.501304595569;5173.939342434801;5309.867253318669;5465;5522.094877267346;4179.373094035904;4185.246655601991;4195;4224.767637779921;4231.365295205713;3301.6038075430984;3344.5986481622117;3473.027552285364;3711.962880371202;4231.069164783743;3248.805071695706;3391.321735652867;3645.398509245971;4142.627163555279;4193.559676233997;3476.8261586920553;4172.33242681171;4175.8077009569915;4200.432941552882;4200.516940551845;3659.835307411173;3677.669009789105;3681.9815900920594;3682.815859207029;3691.6123807000145;4383.3424986252;4503.662225333081;5220.060389129955;5350.308287281763;5360.356757189163;4063.553009168989;4860.562549370538;4865.686264708509;4877.975610121962;4899.240617704261;4919.064748201425;5058.772355244023;5385.761274906754;5503.889922201573;5815.244018277639;3242.7405807535574;3876.8643097491454;4003.8589002134254;4066.3493840985598;4075.205334959684;6113.541484388688;6144.8771024579255;6152.446279834791;6152.938470615281;6175.691215439255;4100.835966561363;4106.342985122366;4119.8970025748995;4120;4132.3841638566255;3939.7439166454087;4043.542770930812;4135.924659588529;4179.582041795796;4193.937090943638;4004.979975100106;4835.178019736653;4849.612031037508;4853.349861047261;4885.193942999436;5549.916751248735;5859.2382990211;5878.265216847894;5891.499222566044;5933.3473317934995;1154.9374575390661;1198.4786617821276;1291.063978615515;1417.6951955329653;1426.5306734063931;773.3426587400777;777.6928113395177;855.2516548020482;878.200837238123;881.558651604631;4635.65232607549;4649.395958394349;4662.200306749988;4665.883352916204;4675.4155730533685;4506.797194126272;4508.32375143731;4720.787564559603;4760.547747963938;5023.547880690682;4602.744655118968;4635.374224479652;4651.488336283006;4658.091672123971;4677.766111694402;2113.5667188226375;2244.4513285832722;2677.317284092544;2678.2367025397666;2685.9462810743676;4715.72675377653;4923.848736808445;5217.330454254602;5251.711155886463;5254.500822421864;4550.362949187116;4796.472388037313;4840.491748366441;4902.950970490321;5220.451852555503;4300.65594752419;5039.827513924622;5181.3782346118705;5230.29391032221;5252.422233554306;4666.693325868762;4669.929951050669;4679.461861885927;4808.639352048541;5072.123314373705;4179.749215047107;4512.571305725951;4694;4916.508349165055;4972.453030166751;4349.391085248131;4751.596114330182;4947.901041979068;5218.486638874684;5284.497972692588;3155.810651360834;3431.828408579611;3532.8871405507184;3575;3608.476770868262;4147.564505726976;4321.006168581307;4969.6272779542405;5022.3219865317715;5800.1589769484035;5167.83723662173;5897.587168898136;5923.318818335946;5930.555208359304;5942.376050514634;5888.263967004124;5914.290285165807;5928.67392293428;5937.7921772737745;5952.255968003999;4875.3429380988155;5319.494648008433;5613.607047506635;5756.913646295226;5824.514748739214;5006.274090256965;5915.822525324247;5922.437368449991;5950.464458198783;5977.880442391041;4995.450500445021;5474.644148130359;5703.686297253691;5795.768169273182;5806.229100124334 03:17:29 INFO - PROCESS | 1643 | |5;yui.html;678.9660516974152;699.7410957945561;751.4026349052506;758.3288789421364;877.978050548736;15348.462803801869;16545.57348234037;16633.916830415845;16689.332426702917;16731.665366692658;14941.252937353116;15038;15158.924205378959;15224.238788060607;15234.54296371108;720.3696765330336;741.784882384108;887.0287035695902;905.1491597897988;908.7682640926555;869.2481003931617;875.8686197070426;896.6951236579562;917.3807679816131;927.5918595817852;890.3366991591273;931.2177770672633;932.067932067932;932.6782260120282;933.9533023348805;919.3518569408584;924.9676261330854;925.2829057480507;925.4447331601053;929.1916033051255;662.8409181796334;691.695653912277;693.5145398221215;695.8399568099366;697.330562659842;14873.70252594942;14927.477538286108;15098.924505377512;15213.61965950849;15295.923520382326;14916.477923272741;14990.950633455663;15037.398504059824;15043.699126017418;15047.548573542812;11862.110341724405;12084.335361555111;12103.6368908932;12165.878341216563;12496.75006499874;3400.6939375456327;3909.159530700913;3932.1152740633415;3981.124152686404;3982.6017398260233;93082;103452.96547034508;104443.47778261136;124788;132361.6763832359;11489.885101149048;11574.01620862236;11686.972120487297;11728.648140555797;11757.412129393497;22951.655725164135;23168.42078948006;23202.3039308821;23239;23504.647430288558;6925.688344024531;8401.201885820838;8445.408821382443;8534.957325213334;8648.962124544969;4492.966617677887;4572.95427045732;4599.5400459953735;4687.7656117194;4767.61859051275;3542.3977923753023;3658.798766067892;3689.7048236141045;3690.0590349461254;3690.9077273068388;660.7224965514496;676.4757313082303;677.8510424829965;695.9408450281682;697.7662483068127;579.5537436174122;618.4341327685207;623.800383877164;629.468099455959;641.1376698340724;8146.348292136615;8913.777155571162;9514.524273786283;9543.713688589354;9556.378835375679;450.3362610160927;482.0888520695818;483.8935434204469;510.64510165434666;598.335847209597;4537.733318763853;4646.651501137429;4666.603338716247;4691.366665500182;4713.34013238147;171200.28799711843;173029;174246;175828;178115;133813;141845;142699;143878;144329;79616.20383796204;83409.16590834135;115102.84897151089;126873.7312626862;134210;7761.223877612194;8764.517951512473;8817.118288171132;8983.775405614912;8998.910010900068;58599;60893.69553152206;69436.65281673761;70238.16665666913;70305.64847175732;100068;100685;105113;105927.47036265078;110571;9124.817503650023;11214.327140371604;11327.376994265394;11359.716007099889;11391.829122563002;12021.158518903943;12319.815202771786;12390.75218495607;12520.874791252336;13037.608871733863;11369.147313951653;11471.713207169887;11913.702157446132;12092.334921579397;12362.44369003379;11893.702657433634;11958.581449649568;11959.820602691141;11959.94020029929;12377.938110309391;11573.247738896946;11886.643400697993;11915.52337906474;12117.515299387926;12408.069394795608;9798.167155791838;9948.55231514598;10068.295219334575;10109.292349535463;10447.738806529898;9935.801283974424;10213.08082272599;10302.33034852732;10304.175665946856;10329.812071611861 03:17:29 INFO - PROCESS | 1643 | __end_tp_report 03:17:29 INFO - PROCESS | 1643 | __start_cc_report 03:17:29 INFO - PROCESS | 1643 | _x_x_mozilla_cycle_collect,356 03:17:29 INFO - PROCESS | 1643 | __end_cc_report 03:17:29 INFO - PROCESS | 1643 | __startTimestamp1483010249382__endTimestamp 03:17:29 INFO - PROCESS | 1643 | 03:17:29 INFO - PROCESS | 1643 | ------- Summary: start ------- 03:17:29 INFO - PROCESS | 1643 | Number of tests: 6 03:17:29 INFO - PROCESS | 1643 | 03:17:29 INFO - PROCESS | 1643 | [#0] dojo.html Cycles:165 Average:5823.68 Median:6110.91 stddev:630.58 (10.3%) stddev-sans-first:598.08 03:17:29 INFO - PROCESS | 1643 | Values: 3203.6 3591.1 3597.7 3612.9 3646.5 5874.0 5875.1 5932.5 5933.2 5953.9 5864.7 5969.9 5972.4 5972.9 6001.4 5272.6 5309.7 5316.4 5369.2 5407.2 5365.9 5366.6 5380.4 5387.2 5397.4 4311.8 5236.5 5246.7 5381.7 5410.7 5302.9 5375.1 5375.5 5376.1 5415.0 5200.2 5314.7 5319.4 5366.2 5373.0 5694.1 5694.4 5787.1 5833.6 6017.7 5399.9 6127.5 6143.3 6143.6 6167.8 6186.1 6228.1 6289.7 6297.0 6315.7 5979.3 6079.6 6106.0 6106.8 6110.9 6297.0 6327.8 6340.0 6342.8 6364.0 6193.1 6202.3 6208.3 6222.9 6224.0 6129.2 6145.6 6172.4 6269.5 6272.4 6135.4 6191.3 6193.2 6204.2 6210.3 6159.6 6176.0 6197.0 6210.5 6315.2 4937.1 4989.5 5056.0 5060.7 5064.8 4481.7 4501.8 4544.6 4575.6 4636.3 6021.9 6079.0 6088.7 6088.7 6101.0 6120.4 6259.9 6270.1 6274.9 6285.9 5915.3 5958.2 6036.5 6064.8 6107.0 5535.7 5537.3 5547.9 5563.5 5594.4 5344.6 6415.7 6430.9 6478.0 6487.9 6135.6 6147.2 6151.9 6155.8 6200.6 6470.7 6487.2 6487.4 6502.8 6509.5 6214.7 6218.5 6219.3 6219.6 6224.7 5926.5 6104.6 6156.8 6159.9 6273.1 4330.9 5197.7 6182.3 6191.7 6192.3 6179.8 6193.4 6221.3 6222.6 6229.5 5977.4 6056.8 6124.9 6166.7 6198.3 6118.6 6177.2 6195.9 6229.0 6241.0 6113.5 6141.2 6202.0 6204.4 6204.5 03:17:29 INFO - PROCESS | 1643 | 03:17:29 INFO - PROCESS | 1643 | [#1] ext.html Cycles:180 Average:62334.73 Median:18336.97 stddev:135585.48 (739.4%) stddev-sans-first:135886.28 03:17:29 INFO - PROCESS | 1643 | Values: 473.8 478.4 491.3 508.0 570.6 40259.6 42932.6 43063.4 43079.6 43093.4 44034.9 44211.0 44459.8 44533.8 44646.6 10021.3 10035.2 10188.2 10215.6 10262.1 10008.4 10054.1 10107.8 10116.2 10147.5 10034.1 10068.9 10130.9 10154.3 10166.0 10026.5 10044.1 10083.3 10087.5 10090.6 9987.9 10044.6 10054.2 10089.2 10139.3 41999.6 42250.4 42301.9 42427.0 42501.1 3296.0 3500.0 3574.5 3926.7 4198.5 31583.2 32455.7 33061.8 33188.5 33320.7 3178.4 3264.3 3283.1 3327.0 3353.3 548324.0 554447.0 557934.2 558135.0 560598.0 68137.0 68516.7 68693.7 68697.3 68944.7 36216.6 36575.6 36990.3 38805.4 38864.4 15061.7 17630.3 18137.9 18150.9 18177.5 13640.4 13742.7 13750.7 13773.2 13776.3 17948.1 18385.0 20506.7 20644.0 20753.4 6951.0 7242.2 8175.2 8432.2 8456.7 902.6 951.5 980.2 1080.5 1085.5 31167.0 31477.2 31561.7 32240.0 32374.8 939.2 1083.7 1107.5 1128.2 1176.2 15957.6 16720.7 16761.6 16919.5 16950.7 186768.0 187269.0 187662.1 187925.0 188234.0 63040.0 63556.0 63577.7 63703.0 63794.4 1374.6 1416.2 1417.4 1424.0 1430.0 26267.7 30212.7 30230.0 31778.4 32185.7 54706.5 54720.2 55013.7 55295.7 55428.0 646021.0 646852.0 647458.0 647476.0 651140.0 28736.9 29017.4 29066.9 29069.4 29156.7 50256.7 50270.0 50718.7 51787.2 51788.7 40907.0 40978.4 41759.2 41936.2 42611.0 41853.4 42196.6 42272.8 42591.8 42611.9 40987.6 41019.8 41052.8 41128.0 42447.4 33125.5 36537.8 36541.6 36664.0 37014.3 22382.8 27163.3 27343.6 27378.7 27531.9 03:17:29 INFO - PROCESS | 1643 | 03:17:29 INFO - PROCESS | 1643 | [#2] jquery.html Cycles:180 Average:36505.56 Median:1672.72 stddev:104070.14 (6221.6%) stddev-sans-first:104326.60 03:17:29 INFO - PROCESS | 1643 | Values: 312.9 371.8 384.9 387.7 411.0 20732.6 21254.9 21324.0 21758.5 21872.8 21083.3 21108.6 21428.0 21514.7 21612.8 5918.3 5978.0 6045.8 6113.3 6128.8 4416.9 4630.4 6089.1 6097.9 6531.2 6754.2 6807.5 6834.2 6842.9 6868.1 5659.7 6574.1 6674.3 6701.5 6769.0 4544.6 5520.8 5812.1 5954.7 5956.7 25249.6 25710.0 25998.2 25999.4 26697.8 2369.3 2799.5 3032.5 3152.1 3226.1 11973.0 14396.1 15024.9 15051.5 15731.4 1787.2 1922.3 1934.7 2008.0 2013.5 116594.0 119443.4 120484.0 121075.0 122826.0 9686.6 11145.7 11160.3 11377.7 11557.0 14135.2 14251.8 14254.8 14340.9 14379.6 8762.8 8960.0 8994.6 9010.7 9032.0 8944.1 9069.2 9072.3 9134.9 9234.9 5720.9 6805.6 6901.3 6923.6 6977.7 1632.5 1702.8 1708.0 1900.6 1939.7 907.9 924.6 925.1 940.8 991.7 20884.0 21123.8 21335.4 21502.6 21817.6 857.8 865.8 913.4 951.3 959.1 10897.7 11443.7 11476.4 11513.3 11553.9 525319.0 636429.0 641995.0 646481.8 656871.0 134277.3 136769.0 137770.6 141156.0 141506.2 975.9 978.7 989.6 995.7 996.7 18791.5 19088.0 19098.4 19242.6 19267.4 40762.0 55803.7 56414.0 57498.7 57635.7 78007.0 79718.6 80327.0 80333.0 81354.0 8236.5 8294.5 8454.2 8476.2 8541.5 13002.6 13222.4 13419.1 13448.2 13811.9 11610.0 11636.8 11664.4 11741.9 11961.9 11302.3 11536.8 11642.8 11713.2 11935.1 11495.7 11642.7 11737.2 11751.9 11866.2 7251.0 7570.6 7754.1 8422.7 8490.8 8318.1 11185.7 11681.5 11719.6 11821.3 03:17:29 INFO - PROCESS | 1643 | 03:17:29 INFO - PROCESS | 1643 | [#3] mootools.html Cycles:180 Average:5876.10 Median:4898.38 stddev:3345.12 (68.3%) stddev-sans-first:3338.10 03:17:29 INFO - PROCESS | 1643 | Values: 1468.2 1485.9 1743.7 1904.8 1987.2 8102.0 8357.3 8917.9 9514.5 9514.9 8281.8 9277.9 9289.9 9296.2 9428.9 2435.8 2473.1 2474.0 2479.3 2481.8 2415.9 2435.5 2440.6 2478.9 2483.4 2459.4 2464.9 2472.5 2481.8 2496.0 2348.7 2410.5 2411.6 2438.8 2441.0 2419.2 2425.4 2443.9 2460.4 2466.1 9371.3 9376.3 9446.0 9448.1 9495.5 5440.4 5568.0 5589.1 5615.4 5628.6 3501.6 3681.5 3700.2 3744.3 3764.4 1066.4 1082.3 1099.3 1104.4 1121.3 12301.7 12302.4 12315.6 12344.4 12349.8 4813.0 4886.8 4901.6 4984.6 5003.4 8073.5 8365.4 9307.9 9779.4 10385.0 4675.3 5543.5 5572.5 5576.1 5582.4 4603.6 4711.2 4969.3 5072.1 5096.6 4094.4 4119.7 4206.8 4238.0 4254.8 1328.6 1333.6 1342.5 1350.1 1360.5 753.6 779.8 832.7 836.7 851.0 5032.9 6006.2 6060.2 6125.9 6128.4 455.0 457.7 459.9 464.1 470.3 3241.5 3400.8 4026.4 4056.4 4096.9 10875.6 11325.5 11334.8 11385.0 11411.0 9443.0 10668.9 11033.4 11314.4 11365.1 7303.7 8356.8 8404.9 8437.0 8589.4 5480.7 5975.5 6086.9 6091.2 6187.2 10107.6 10265.9 10547.9 10661.6 10671.6 10598.0 10780.4 10808.6 10841.2 10846.6 7174.6 7402.3 7663.7 7891.3 8034.0 8471.4 8630.4 8777.1 8788.0 8798.1 7715.5 7788.1 7817.0 7849.6 7963.8 7597.3 7624.5 7647.4 7662.3 7675.8 7192.5 7196.7 7229.9 7251.1 7318.8 4895.2 5002.4 5028.1 5099.8 5238.8 5080.1 5131.5 5146.3 5168.5 5209.1 03:17:29 INFO - PROCESS | 1643 | 03:17:29 INFO - PROCESS | 1643 | [#4] prototype.html Cycles:180 Average:4403.76 Median:4756.07 stddev:1367.40 (28.8%) stddev-sans-first:1335.93 03:17:29 INFO - PROCESS | 1643 | Values: 290.2 313.3 314.8 319.7 322.5 4278.7 5266.6 5503.6 5609.8 5670.9 4834.5 5173.9 5309.9 5465.0 5522.1 4179.4 4185.2 4195.0 4224.8 4231.4 3301.6 3344.6 3473.0 3712.0 4231.1 3248.8 3391.3 3645.4 4142.6 4193.6 3476.8 4172.3 4175.8 4200.4 4200.5 3659.8 3677.7 3682.0 3682.8 3691.6 4383.3 4503.7 5220.1 5350.3 5360.4 4063.6 4860.6 4865.7 4878.0 4899.2 4919.1 5058.8 5385.8 5503.9 5815.2 3242.7 3876.9 4003.9 4066.3 4075.2 6113.5 6144.9 6152.4 6152.9 6175.7 4100.8 4106.3 4119.9 4120.0 4132.4 3939.7 4043.5 4135.9 4179.6 4193.9 4005.0 4835.2 4849.6 4853.3 4885.2 5549.9 5859.2 5878.3 5891.5 5933.3 1154.9 1198.5 1291.1 1417.7 1426.5 773.3 777.7 855.3 878.2 881.6 4635.7 4649.4 4662.2 4665.9 4675.4 4506.8 4508.3 4720.8 4760.5 5023.5 4602.7 4635.4 4651.5 4658.1 4677.8 2113.6 2244.5 2677.3 2678.2 2685.9 4715.7 4923.8 5217.3 5251.7 5254.5 4550.4 4796.5 4840.5 4903.0 5220.5 4300.7 5039.8 5181.4 5230.3 5252.4 4666.7 4669.9 4679.5 4808.6 5072.1 4179.7 4512.6 4694.0 4916.5 4972.5 4349.4 4751.6 4947.9 5218.5 5284.5 3155.8 3431.8 3532.9 3575.0 3608.5 4147.6 4321.0 4969.6 5022.3 5800.2 5167.8 5897.6 5923.3 5930.6 5942.4 5888.3 5914.3 5928.7 5937.8 5952.3 4875.3 5319.5 5613.6 5756.9 5824.5 5006.3 5915.8 5922.4 5950.5 5977.9 4995.5 5474.6 5703.7 5795.8 5806.2 03:17:29 INFO - PROCESS | 1643 | 03:17:29 INFO - PROCESS | 1643 | [#5] yui.html Cycles:180 Average:26202.96 Median:3674.25 stddev:43839.08 (1193.1%) stddev-sans-first:43920.17 03:17:29 INFO - PROCESS | 1643 | Values: 679.0 699.7 751.4 758.3 878.0 15348.5 16545.6 16633.9 16689.3 16731.7 14941.3 15038.0 15158.9 15224.2 15234.5 720.4 741.8 887.0 905.1 908.8 869.2 875.9 896.7 917.4 927.6 890.3 931.2 932.1 932.7 934.0 919.4 925.0 925.3 925.4 929.2 662.8 691.7 693.5 695.8 697.3 14873.7 14927.5 15098.9 15213.6 15295.9 14916.5 14991.0 15037.4 15043.7 15047.5 11862.1 12084.3 12103.6 12165.9 12496.8 3400.7 3909.2 3932.1 3981.1 3982.6 93082.0 103453.0 104443.5 124788.0 132361.7 11489.9 11574.0 11687.0 11728.6 11757.4 22951.7 23168.4 23202.3 23239.0 23504.6 6925.7 8401.2 8445.4 8535.0 8649.0 4493.0 4573.0 4599.5 4687.8 4767.6 3542.4 3658.8 3689.7 3690.1 3690.9 660.7 676.5 677.9 695.9 697.8 579.6 618.4 623.8 629.5 641.1 8146.3 8913.8 9514.5 9543.7 9556.4 450.3 482.1 483.9 510.6 598.3 4537.7 4646.7 4666.6 4691.4 4713.3 171200.3 173029.0 174246.0 175828.0 178115.0 133813.0 141845.0 142699.0 143878.0 144329.0 79616.2 83409.2 115102.8 126873.7 134210.0 7761.2 8764.5 8817.1 8983.8 8998.9 58599.0 60893.7 69436.7 70238.2 70305.6 100068.0 100685.0 105113.0 105927.5 110571.0 9124.8 11214.3 11327.4 11359.7 11391.8 12021.2 12319.8 12390.8 12520.9 13037.6 11369.1 11471.7 11913.7 12092.3 12362.4 11893.7 11958.6 11959.8 11959.9 12377.9 11573.2 11886.6 11915.5 12117.5 12408.1 9798.2 9948.6 10068.3 10109.3 10447.7 9935.8 10213.1 10302.3 10304.2 10329.8 03:17:29 INFO - PROCESS | 1643 | -------- Summary: end -------- 03:17:29 INFO - PROCESS | 1643 | 03:17:29 INFO - TEST-INFO | 1643: exit 0 03:17:29 INFO - TEST-OK | dromaeo_css | took 1111448ms 03:17:29 INFO - TEST-START | kraken 03:17:29 INFO - operating with platform_type : mac_ 03:17:29 INFO - Initialising browser for kraken test... 03:17:29 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/tmp6PGTm7/profile http://localhost:49249/getInfo.html) 03:17:32 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 03:17:32 INFO - PROCESS | 1652 | colorDepth:24 03:17:32 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 03:17:32 INFO - PROCESS | 1652 | __metrics 03:17:32 ERROR - PROCESS | 1652 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3015: TypeError: this.tabs is undefined 03:17:32 INFO - PROCESS | 1652 | 03:17:32 INFO - PROCESS | 1652 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x10C0011,name=PVRManager::Msg_NotifyVSync) Channel error: cannot send/recv 03:17:32 INFO - PROCESS | 1652 | 03:17:33 INFO - TEST-INFO | 1652: exit 0 03:17:33 INFO - Browser initialized. 03:17:33 INFO - Running cycle 1/1 for kraken test... 03:17:33 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/tmp6PGTm7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:17:45 INFO - PROCESS | 1655 | RSS: Main: 175128576 03:17:45 INFO - PROCESS | 1655 | 03:17:47 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-beat-detection) 03:17:48 INFO - PROCESS | 1655 | RSS: Main: 186908672 03:17:48 INFO - PROCESS | 1655 | 03:17:51 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-dft) 03:17:52 INFO - PROCESS | 1655 | RSS: Main: 194912256 03:17:52 INFO - PROCESS | 1655 | 03:17:55 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-fft) 03:17:56 INFO - PROCESS | 1655 | RSS: Main: 198062080 03:17:56 INFO - PROCESS | 1655 | 03:17:58 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-oscillator) 03:17:58 INFO - PROCESS | 1655 | RSS: Main: 199442432 03:17:58 INFO - PROCESS | 1655 | 03:18:00 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:18:01 INFO - PROCESS | 1655 | RSS: Main: 199749632 03:18:01 INFO - PROCESS | 1655 | 03:18:04 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-darkroom) 03:18:05 INFO - PROCESS | 1655 | RSS: Main: 200441856 03:18:05 INFO - PROCESS | 1655 | 03:18:07 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-desaturate) 03:18:08 INFO - PROCESS | 1655 | RSS: Main: 200675328 03:18:08 INFO - PROCESS | 1655 | 03:18:11 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49249/tests/kraken/driver.html?testName=json-parse-financial) 03:18:12 INFO - PROCESS | 1655 | RSS: Main: 200597504 03:18:12 INFO - PROCESS | 1655 | 03:18:13 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49249/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:18:14 INFO - PROCESS | 1655 | RSS: Main: 200388608 03:18:14 INFO - PROCESS | 1655 | 03:18:16 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:18:17 INFO - PROCESS | 1655 | RSS: Main: 200462336 03:18:17 INFO - PROCESS | 1655 | 03:18:19 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:18:19 INFO - PROCESS | 1655 | RSS: Main: 200503296 03:18:19 INFO - PROCESS | 1655 | 03:18:22 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:18:23 INFO - PROCESS | 1655 | RSS: Main: 200859648 03:18:23 INFO - PROCESS | 1655 | 03:18:26 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:18:27 INFO - PROCESS | 1655 | RSS: Main: 200900608 03:18:27 INFO - PROCESS | 1655 | 03:18:28 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49249/tests/kraken/driver.html?testName=ai-astar) 03:18:29 INFO - PROCESS | 1655 | RSS: Main: 202178560 03:18:29 INFO - PROCESS | 1655 | 03:18:29 INFO - PROCESS | 1655 | __start_tp_report 03:18:29 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 03:18:29 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 03:18:29 INFO - PROCESS | 1655 | |i|pagename|runs| 03:18:29 INFO - PROCESS | 1655 | |0;ai-astar;105;117;118;117;118;117;117;118;118;120 03:18:29 INFO - PROCESS | 1655 | |1;audio-beat-detection;181;149;116;152;135;96;115;144;172;142 03:18:29 INFO - PROCESS | 1655 | |2;audio-dft;195;230;219;197;196;179;204;277;220;191 03:18:29 INFO - PROCESS | 1655 | |3;audio-fft;83;60;59;83;53;70;84;84;70;71 03:18:29 INFO - PROCESS | 1655 | |4;audio-oscillator;83;76;75;72;81;86;122;102;103;119 03:18:29 INFO - PROCESS | 1655 | |5;imaging-gaussian-blur;90;115;83;131;135;86;108;75;135;134 03:18:29 INFO - PROCESS | 1655 | |6;imaging-darkroom;96;96;101;153;124;95;95;95;96;96 03:18:29 INFO - PROCESS | 1655 | |7;imaging-desaturate;91;94;123;93;78;124;77;133;150;151 03:18:29 INFO - PROCESS | 1655 | |8;json-parse-financial;55;55;54;55;58;58;59;58;58;56 03:18:29 INFO - PROCESS | 1655 | |9;json-stringify-tinderbox;63;71;80;74;70;67;84;99;95;68 03:18:29 INFO - PROCESS | 1655 | |10;stanford-crypto-aes;82;85;102;91;83;83;84;82;83;80 03:18:29 INFO - PROCESS | 1655 | |11;stanford-crypto-ccm;158;162;149;160;149;151;140;156;198;154 03:18:29 INFO - PROCESS | 1655 | |12;stanford-crypto-pbkdf2;157;213;220;184;149;150;183;159;220;220 03:18:29 INFO - PROCESS | 1655 | |13;stanford-crypto-sha256-iterative;66;68;67;77;58;81;63;62;68;83 03:18:29 INFO - PROCESS | 1655 | __end_tp_report 03:18:29 INFO - PROCESS | 1655 | __start_cc_report 03:18:29 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,894 03:18:29 INFO - PROCESS | 1655 | __end_cc_report 03:18:29 INFO - PROCESS | 1655 | __startTimestamp1483010309068__endTimestamp 03:18:29 INFO - PROCESS | 1655 | 03:18:29 INFO - PROCESS | 1655 | ------- Summary: start ------- 03:18:29 INFO - PROCESS | 1655 | Number of tests: 14 03:18:29 INFO - PROCESS | 1655 | 03:18:29 INFO - PROCESS | 1655 | [#0] ai-astar Cycles:10 Average:116.50 Median:118.00 stddev:4.14 (3.5%) stddev-sans-first:0.97 03:18:29 INFO - PROCESS | 1655 | Values: 105.0 117.0 118.0 117.0 118.0 117.0 117.0 118.0 118.0 120.0 03:18:29 INFO - PROCESS | 1655 | 03:18:29 INFO - PROCESS | 1655 | [#1] audio-beat-detection Cycles:10 Average:140.20 Median:150.50 stddev:26.06 (17.3%) stddev-sans-first:23.08 03:18:29 INFO - PROCESS | 1655 | Values: 181.0 149.0 116.0 152.0 135.0 96.0 115.0 144.0 172.0 142.0 03:18:29 INFO - PROCESS | 1655 | 03:18:29 INFO - PROCESS | 1655 | [#2] audio-dft Cycles:10 Average:210.80 Median:211.50 stddev:27.91 (13.2%) stddev-sans-first:29.01 03:18:29 INFO - PROCESS | 1655 | Values: 195.0 230.0 219.0 197.0 196.0 179.0 204.0 277.0 220.0 191.0 03:18:29 INFO - PROCESS | 1655 | 03:18:29 INFO - PROCESS | 1655 | [#3] audio-fft Cycles:10 Average:71.70 Median:77.00 stddev:11.61 (15.1%) stddev-sans-first:11.57 03:18:29 INFO - PROCESS | 1655 | Values: 83.0 60.0 59.0 83.0 53.0 70.0 84.0 84.0 70.0 71.0 03:18:29 INFO - PROCESS | 1655 | 03:18:29 INFO - PROCESS | 1655 | [#4] audio-oscillator Cycles:10 Average:91.90 Median:75.50 stddev:18.36 (24.3%) stddev-sans-first:19.19 03:18:29 INFO - PROCESS | 1655 | Values: 83.0 76.0 75.0 72.0 81.0 86.0 122.0 102.0 103.0 119.0 03:18:29 INFO - PROCESS | 1655 | 03:18:29 INFO - PROCESS | 1655 | [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:105.00 stddev:24.08 (22.9%) stddev-sans-first:24.52 03:18:29 INFO - PROCESS | 1655 | Values: 90.0 115.0 83.0 131.0 135.0 86.0 108.0 75.0 135.0 134.0 03:18:29 INFO - PROCESS | 1655 | 03:18:29 INFO - PROCESS | 1655 | [#6] imaging-darkroom Cycles:10 Average:104.70 Median:95.50 stddev:19.16 (20.1%) stddev-sans-first:20.06 03:18:29 INFO - PROCESS | 1655 | Values: 96.0 96.0 101.0 153.0 124.0 95.0 95.0 95.0 96.0 96.0 03:18:29 INFO - PROCESS | 1655 | 03:18:29 INFO - PROCESS | 1655 | [#7] imaging-desaturate Cycles:10 Average:111.40 Median:77.50 stddev:28.23 (36.4%) stddev-sans-first:28.97 03:18:29 INFO - PROCESS | 1655 | Values: 91.0 94.0 123.0 93.0 78.0 124.0 77.0 133.0 150.0 151.0 03:18:29 INFO - PROCESS | 1655 | 03:18:29 INFO - PROCESS | 1655 | [#8] json-parse-financial Cycles:10 Average:56.60 Median:58.00 stddev:1.78 (3.1%) stddev-sans-first:1.79 03:18:29 INFO - PROCESS | 1655 | Values: 55.0 55.0 54.0 55.0 58.0 58.0 59.0 58.0 58.0 56.0 03:18:29 INFO - PROCESS | 1655 | 03:18:29 INFO - PROCESS | 1655 | [#9] json-stringify-tinderbox Cycles:10 Average:77.10 Median:77.00 stddev:12.19 (15.8%) stddev-sans-first:11.81 03:18:29 INFO - PROCESS | 1655 | Values: 63.0 71.0 80.0 74.0 70.0 67.0 84.0 99.0 95.0 68.0 03:18:29 INFO - PROCESS | 1655 | 03:18:29 INFO - PROCESS | 1655 | [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:83.00 stddev:6.49 (7.8%) stddev-sans-first:6.75 03:18:29 INFO - PROCESS | 1655 | Values: 82.0 85.0 102.0 91.0 83.0 83.0 84.0 82.0 83.0 80.0 03:18:29 INFO - PROCESS | 1655 | 03:18:29 INFO - PROCESS | 1655 | [#11] stanford-crypto-ccm Cycles:10 Average:157.70 Median:157.00 stddev:15.54 (9.9%) stddev-sans-first:16.48 03:18:29 INFO - PROCESS | 1655 | Values: 158.0 162.0 149.0 160.0 149.0 151.0 140.0 156.0 198.0 154.0 03:18:29 INFO - PROCESS | 1655 | 03:18:29 INFO - PROCESS | 1655 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.50 Median:198.50 stddev:30.63 (15.4%) stddev-sans-first:30.70 03:18:29 INFO - PROCESS | 1655 | Values: 157.0 213.0 220.0 184.0 149.0 150.0 183.0 159.0 220.0 220.0 03:18:29 INFO - PROCESS | 1655 | 03:18:29 INFO - PROCESS | 1655 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:68.00 stddev:8.33 (12.2%) stddev-sans-first:8.75 03:18:29 INFO - PROCESS | 1655 | Values: 66.0 68.0 67.0 77.0 58.0 81.0 63.0 62.0 68.0 83.0 03:18:29 INFO - PROCESS | 1655 | -------- Summary: end -------- 03:18:29 INFO - PROCESS | 1655 | 03:18:29 INFO - TEST-INFO | 1655: exit 0 03:18:29 INFO - TEST-OK | kraken | took 59887ms 03:18:29 INFO - SUITE-END | took 1171s 03:18:30 INFO - Completed test suite (00:19:31) 03:18:30 INFO - javascript benchmark 03:18:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7428.525074082974, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3203.615566132064, 3591.120175556989, 3597.6582224688677, 3612.9096772580683, 3646.4894914711945, 5874.0, 5875.059990401532, 5932.525397968163, 5933.169356290123, 5953.851153721159, 5864.677442740658, 5969.910451343222, 5972.402759724026, 5972.880542389161, 6001.369856165105, 5272.578193744501, 5309.73451327434, 5316.41519432864, 5369.207653807492, 5407.161889907071, 5365.919511207335, 5366.597505187107, 5380.435054319299, 5387.24578559002, 5397.4062853086125, 4311.849085282016, 5236.476352364771, 5246.711430871301, 5381.67709937405, 5410.729463526808, 5302.867428314304, 5375.11310633745, 5375.489328513804, 5376.059189641797, 5414.972925135349, 5200.193969934666, 5314.707691076989, 5319.3616765987945, 5366.221897824794, 5373.005993891104, 5694.088945768699, 5694.373618901917, 5787.102999035156, 5833.620814647077, 6017.669028203447, 5399.865003374908, 6127.525510585588, 6143.2662465203, 6143.573288550997, 6167.7532898684, 6186.133941248228, 6228.128062071313, 6289.716962736642, 6296.968515157395, 6315.74737010519, 5979.342272350038, 6079.604825686316, 6106.0, 6106.847328816771, 6110.908336375002, 6296.992481203077, 6327.778527751599, 6340.017297318831, 6342.8414289642205, 6363.96818015907, 6193.102000210034, 6202.28673702521, 6208.317085120633, 6222.906656400067, 6223.96888015557, 6129.175413489909, 6145.586515101551, 6172.444479996821, 6269.467095296951, 6272.40412160844, 6135.417135372132, 6191.25704915404, 6193.194884664965, 6204.162438070893, 6210.285817130997, 6159.568830181934, 6176.0, 6196.969015154896, 6210.50315974721, 6315.179026726588, 4937.1113199624415, 4989.525995030466, 5056.0, 5060.746962651852, 5064.848054558369, 4481.686281960297, 4501.774911254424, 4544.590986811203, 4575.611073058761, 4636.258198688193, 6021.909671354933, 6079.0, 6088.665123418166, 6088.695565221721, 6100.969495152496, 6120.386183820725, 6259.906101408483, 6270.059491076375, 6274.905876411857, 6285.8742825143245, 5915.319738230072, 5958.195643588147, 6036.486898613579, 6064.75740970365, 6107.006761825686, 5535.6955367455175, 5537.252470916455, 5547.916781248285, 5563.527100196528, 5594.356648985337, 5344.599155063308, 6415.711292991827, 6430.871382572323, 6478.0, 6487.935120648733, 6135.600157732601, 6147.200863887666, 6151.907721384272, 6155.753769849335, 6200.56596038273, 6470.708818103102, 6487.156669632917, 6487.44856687168, 6502.804915852532, 6509.479241660751, 6214.720337584729, 6218.471429928326, 6219.253689557282, 6219.595726277777, 6224.688765561795, 5926.496247818984, 6104.603200791934, 6156.815295541141, 6159.907601385893, 6273.059041143865, 4330.935035974526, 5197.7141257231215, 6182.319944806158, 6191.721372538156, 6192.287886892885, 6179.783707570214, 6193.411625895533, 6221.346758590464, 6222.626642401289, 6229.470495007794, 5977.432143946318, 6056.818295451144, 6124.899720462962, 6166.660833654013, 6198.258546529319, 6118.619179173342, 6177.1969643945995, 6195.907061393992, 6229.0, 6241.0, 6113.480354169767, 6141.201643786279, 6202.0, 6204.410580994799, 6204.534659900616], "value": 5786.801718374979, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [473.8341580446843, 478.36855350936753, 491.31461611052583, 507.97206153661546, 570.574921683346, 40259.59740402595, 42932.570674293245, 43063.35404968928, 43079.56920430795, 43093.353599695954, 44034.89912752183, 44211.0, 44459.77770111153, 44533.77733111338, 44646.55353446465, 10021.298509104347, 10035.247356448259, 10188.23588230882, 10215.591376344937, 10262.076413122817, 10008.39949603026, 10054.09513143817, 10107.848382274271, 10116.190704743603, 10147.543360548756, 10034.147097496721, 10068.949655251714, 10130.898691013106, 10154.3399679021, 10166.0, 10026.548805303742, 10044.09603135714, 10083.344582602143, 10087.546060427298, 10090.596376144946, 9987.850182247272, 10044.648437304659, 10054.24593155509, 10089.192864570818, 10139.340942838766, 41999.58000420018, 42250.36624450636, 42301.942451438656, 42427.0, 42501.1499770006, 3296.0, 3499.965000349989, 3574.463830425431, 3926.7447615904875, 4198.538160802309, 31583.210419739462, 32455.6754432455, 33061.83469082639, 33188.50217246719, 33320.66679333224, 3178.411993781158, 3264.265540253448, 3283.1463819407127, 3326.9833650831833, 3353.279045005336, 548324.0, 554447.0, 557934.2103289498, 558134.9999999959, 560598.0, 68137.0, 68516.6574167126, 68693.65653171802, 68697.31302687009, 68944.6552767233, 36216.637833621855, 36575.63424365722, 36990.260194795956, 38805.41791873124, 38864.41703374452, 15061.698766024618, 17630.294788208583, 18137.909310453364, 18150.910945343323, 18177.545561361072, 13640.386182621805, 13742.65643358904, 13750.65623359404, 13773.242471664154, 13776.311184440738, 17948.102594870204, 18384.98882561445, 20506.692399614018, 20644.0, 20753.377398678065, 6951.0, 7242.23956484572, 8175.223353781381, 8432.241098301183, 8456.661733530713, 902.5893218585528, 951.533748463248, 980.2354163752285, 1080.481368942896, 1085.5494969587692, 31167.0, 31477.213069673442, 31561.684383155876, 32240.032799016066, 32374.83812580922, 939.2063706168277, 1083.7073990022807, 1107.4905543450104, 1128.15388458656, 1176.1825531255695, 15957.601059973362, 16720.74918876218, 16761.580960475843, 16919.492415227316, 16950.660986780196, 186768.0, 187269.0, 187662.1233787672, 187925.0, 188234.0, 63040.0, 63556.0, 63577.68211158914, 63703.04445433322, 63794.362056379774, 1374.6082366525493, 1416.2493878244547, 1417.3834382043638, 1424.0, 1430.049017403436, 26267.737322627294, 30212.69787302187, 30230.0, 31778.364432711678, 32185.67814321827, 54706.45293547014, 54720.17919731128, 55013.72493137509, 55295.72352138213, 55428.0, 646021.0, 646852.0, 647458.0, 647476.0, 651140.0, 28736.856315718287, 29017.419651607273, 29066.854665727384, 29069.418611628073, 29156.7084329154, 50256.74358141076, 50270.0, 50718.7320316995, 51787.223191652905, 51788.74105629448, 40907.0, 40978.385324220755, 41759.164816704106, 41936.16127677368, 42611.0, 41853.372199417645, 42196.578034220496, 42272.788636056626, 42591.787041065836, 42611.93470163271, 40987.59012409838, 41019.79490102531, 41052.79473602613, 41128.0, 42447.36328955006, 33125.503117452776, 36537.81731091328, 36541.634583653824, 36664.0, 37014.25971480609, 22382.776172238067, 27163.32091697644, 27343.58984615272, 27378.726212737616, 27531.862340688167], "value": 20176.76825006633, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.93428380040183, 371.806660536521, 384.9114703618168, 387.6917850309004, 410.9951169390841, 20732.585348293043, 21254.89372553135, 21324.04041818118, 21758.456038599044, 21872.781272187272, 21083.262085826962, 21108.577828443424, 21428.0, 21514.677279840816, 21612.783872161275, 5918.260217472816, 5977.983742763729, 6045.848853778669, 6113.296970848365, 6128.8467788305425, 4416.933745993812, 4630.351750754897, 6089.0866370044405, 6097.878042439149, 6531.183602049744, 6754.189497260336, 6807.523473356842, 6834.179898412172, 6842.863142737142, 6868.107146071004, 5659.745311460973, 6574.14536110305, 6674.332566743286, 6701.463882889358, 6768.950812624051, 4544.613707834838, 5520.834374968757, 5812.099124635688, 5954.702264886781, 5956.7319470623925, 25249.62125568118, 25709.97160113593, 25998.22005339843, 25999.350016249555, 26697.798599063088, 2369.2655276864225, 2799.468101060792, 3032.4996375598, 3152.133163380066, 3226.080567038406, 11972.98229650472, 14396.136231826124, 15024.948253622251, 15051.548453546411, 15731.449399271085, 1787.2225581871796, 1922.3464022232367, 1934.7001214811726, 2008.0160721246484, 2013.4563667809755, 116594.0, 119443.40278298639, 120484.0, 121075.0, 122825.99999999911, 9686.564104615309, 11145.665630031112, 11160.274582152135, 11377.658670239905, 11557.0, 14135.222562759147, 14251.78622320666, 14254.786178207336, 14340.856591434162, 14379.64050898715, 8762.824743505094, 8960.0, 8994.595243214071, 9010.684626038057, 9031.954840225757, 8944.105589441135, 9069.231499857597, 9072.274218062672, 9134.862977055349, 9234.86147707785, 5720.914186287209, 6805.557638753465, 6901.309869013159, 6923.6192009439965, 6977.744006078853, 1632.5347276026275, 1702.8297170282872, 1708.0, 1900.6103748731477, 1939.699346601279, 907.8728977943093, 924.6255266617031, 925.1257561604353, 940.83535381308, 991.7371896447447, 20884.0, 21123.78876211218, 21335.359939201848, 21502.569948601253, 21817.563648727253, 857.7512521368858, 865.8484765166071, 913.3652111782247, 951.3103000324709, 959.1319855530755, 10897.727556810985, 11443.656690299138, 11476.368799715929, 11513.251638643462, 11553.884461155281, 525319.0, 636429.0, 641995.0, 646481.7675911684, 656871.0, 134277.3286133563, 136769.0, 137770.6222937778, 141156.0, 141506.1698766019, 975.9072888075622, 978.7406337320616, 989.6091044037709, 995.6564985080136, 996.7391250068669, 18791.530211744815, 19088.0, 19098.427047188605, 19242.615147697248, 19267.421977340142, 40762.0, 55803.720981394836, 56414.0, 57498.7125064372, 57635.71182144062, 78007.0, 79718.60140699259, 80327.0, 80333.0, 81354.0, 8236.50580965144, 8294.502329860228, 8454.196851299117, 8476.152384761475, 8541.53021583819, 13002.609921702364, 13222.4049917752, 13419.060665753304, 13448.193108413527, 13811.861881381057, 11610.0, 11636.76726465449, 11664.416779161178, 11741.941290293835, 11961.880381196424, 11302.265352752045, 11536.82694759596, 11642.76714465723, 11713.1800773945, 11935.104867134825, 11495.712607184552, 11642.70893227676, 11737.178397512092, 11751.88248117542, 11866.169368144147, 7251.0, 7570.621468926642, 7754.147043825287, 8422.747317580483, 8490.787730306545, 8318.126596707258, 11185.66443006711, 11681.474333654836, 11719.589814356457, 11821.349825759322], "value": 10052.102820363916, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1468.2218424235157, 1485.8737007354375, 1743.6948534006547, 1904.752382190315, 1987.2249822569192, 8102.0, 8357.331413486922, 8917.866232006525, 9514.476703781298, 9514.904850951489, 8281.75154745357, 9277.90722092779, 9289.90710092899, 9296.209822165125, 9428.858567121482, 2435.82949193557, 2473.1220416751976, 2473.998030797521, 2479.293401380607, 2481.8138639602103, 2415.8792060397, 2435.512897420514, 2440.5722652248455, 2478.946447759704, 2483.379155211197, 2459.446624509489, 2464.852108873464, 2472.5425796227755, 2481.751824817522, 2496.014074440595, 2348.729896061958, 2410.4696966667307, 2411.626197939322, 2438.8048956083558, 2441.023590563771, 2419.2106778954176, 2425.3936515871032, 2443.9389015274583, 2460.360306320352, 2466.136852101768, 9371.34400591959, 9376.296777741629, 9445.952770236174, 9448.149666530046, 9495.525223738854, 5440.4287549807495, 5568.0, 5589.133684278943, 5615.438456154393, 5628.634138780966, 3501.562304711911, 3681.484592157073, 3700.1674623209833, 3744.344739670547, 3764.3976963685677, 1066.3868275741402, 1082.2640604389012, 1099.2689861242263, 1104.4422566603894, 1121.3047910295668, 12301.692457688629, 12302.446389912475, 12315.630531083993, 12344.38278086092, 12349.814752778715, 4812.975935120302, 4886.755662216875, 4901.5588597026435, 4984.601231901439, 5003.374578177728, 8073.506401315658, 8365.372597055246, 9307.883054033558, 9779.41323520591, 10385.0, 4675.298705194248, 5543.501084902378, 5572.4706152915405, 5576.079946808813, 5582.441755824466, 4603.58567728906, 4711.1519926413575, 4969.2546118081855, 5072.087024335655, 5096.643234973516, 4094.3653733670735, 4119.732217405859, 4206.768627725504, 4237.957620423756, 4254.829806807693, 1328.6147017364856, 1333.613252156883, 1342.4831439895515, 1350.0751984890383, 1360.53741727813, 753.5629334985695, 779.8089468080243, 832.650286879512, 836.7322456813882, 850.961706723199, 5032.949670503322, 6006.249218847644, 6060.181875446847, 6125.908111378333, 6128.448439640454, 455.0058123001253, 457.7093545598502, 459.8896264896401, 464.06722487799766, 470.3368250766403, 3241.4651582489096, 3400.7619466637098, 4026.3557830747527, 4056.371262454324, 4096.877093687194, 10875.564977400816, 11325.490352934137, 11334.773304533863, 11385.032272256785, 11411.030062444619, 9443.0, 10668.946655266674, 11033.393163376091, 11314.434278286053, 11365.147613928988, 7303.744368947061, 8356.832863342699, 8404.915950840536, 8436.957815211008, 8589.398742088119, 5480.671159730429, 5975.535993681576, 6086.939130608637, 6091.238595175603, 6187.226596675416, 10107.595696172071, 10265.897341026493, 10547.894521054692, 10661.573537058432, 10671.626493072705, 10598.04617584421, 10780.407077610807, 10808.621698240524, 10841.241113122005, 10846.620368287073, 7174.605396703231, 7402.33378995893, 7663.731769388045, 7891.250331218525, 8034.0, 8471.449355791854, 8630.352723545633, 8777.078406767452, 8787.956060219658, 8798.12018798115, 7715.459917805924, 7788.104367997526, 7816.960915195387, 7849.646765895434, 7963.84072318562, 7597.278258565428, 7624.5425274483705, 7647.426443016685, 7662.348700360531, 7675.808104797201, 7192.532485388433, 7196.712131514891, 7229.891551626835, 7251.1298644163035, 7318.780436586911, 4895.192293271571, 5002.399712034579, 5028.069807085701, 5099.821506247264, 5238.768889311085, 5080.136376815876, 5131.512506311894, 5146.25379319989, 5168.457311982338, 5209.062368773657], "value": 4626.076540849344, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.1918157930165, 313.33416489958836, 314.76549970272146, 319.67712610263635, 322.5371591765816, 4278.65770738341, 5266.5786737061035, 5503.559715222783, 5609.775608975641, 5670.914936275959, 4834.501304595569, 5173.939342434801, 5309.867253318669, 5465.0, 5522.094877267346, 4179.373094035904, 4185.246655601991, 4195.0, 4224.767637779921, 4231.365295205713, 3301.6038075430984, 3344.5986481622117, 3473.027552285364, 3711.962880371202, 4231.069164783743, 3248.805071695706, 3391.321735652867, 3645.398509245971, 4142.627163555279, 4193.559676233997, 3476.8261586920553, 4172.33242681171, 4175.8077009569915, 4200.432941552882, 4200.516940551845, 3659.835307411173, 3677.669009789105, 3681.9815900920594, 3682.815859207029, 3691.6123807000145, 4383.3424986252, 4503.662225333081, 5220.060389129955, 5350.308287281763, 5360.356757189163, 4063.553009168989, 4860.562549370538, 4865.686264708509, 4877.975610121962, 4899.240617704261, 4919.064748201425, 5058.772355244023, 5385.761274906754, 5503.889922201573, 5815.244018277639, 3242.7405807535574, 3876.8643097491454, 4003.8589002134254, 4066.3493840985598, 4075.205334959684, 6113.541484388688, 6144.8771024579255, 6152.446279834791, 6152.938470615281, 6175.691215439255, 4100.835966561363, 4106.342985122366, 4119.8970025748995, 4120.0, 4132.3841638566255, 3939.7439166454087, 4043.542770930812, 4135.924659588529, 4179.582041795796, 4193.937090943638, 4004.979975100106, 4835.178019736653, 4849.612031037508, 4853.349861047261, 4885.193942999436, 5549.916751248735, 5859.2382990211, 5878.265216847894, 5891.499222566044, 5933.3473317934995, 1154.9374575390661, 1198.4786617821276, 1291.063978615515, 1417.6951955329653, 1426.5306734063931, 773.3426587400777, 777.6928113395177, 855.2516548020482, 878.200837238123, 881.558651604631, 4635.65232607549, 4649.395958394349, 4662.200306749988, 4665.883352916204, 4675.4155730533685, 4506.797194126272, 4508.32375143731, 4720.787564559603, 4760.547747963938, 5023.547880690682, 4602.744655118968, 4635.374224479652, 4651.488336283006, 4658.091672123971, 4677.766111694402, 2113.5667188226375, 2244.4513285832722, 2677.317284092544, 2678.2367025397666, 2685.9462810743676, 4715.72675377653, 4923.848736808445, 5217.330454254602, 5251.711155886463, 5254.500822421864, 4550.362949187116, 4796.472388037313, 4840.491748366441, 4902.950970490321, 5220.451852555503, 4300.65594752419, 5039.827513924622, 5181.3782346118705, 5230.29391032221, 5252.422233554306, 4666.693325868762, 4669.929951050669, 4679.461861885927, 4808.639352048541, 5072.123314373705, 4179.749215047107, 4512.571305725951, 4694.0, 4916.508349165055, 4972.453030166751, 4349.391085248131, 4751.596114330182, 4947.901041979068, 5218.486638874684, 5284.497972692588, 3155.810651360834, 3431.828408579611, 3532.8871405507184, 3575.0, 3608.476770868262, 4147.564505726976, 4321.006168581307, 4969.6272779542405, 5022.3219865317715, 5800.1589769484035, 5167.83723662173, 5897.587168898136, 5923.318818335946, 5930.555208359304, 5942.376050514634, 5888.263967004124, 5914.290285165807, 5928.67392293428, 5937.7921772737745, 5952.255968003999, 4875.3429380988155, 5319.494648008433, 5613.607047506635, 5756.913646295226, 5824.514748739214, 5006.274090256965, 5915.822525324247, 5922.437368449991, 5950.464458198783, 5977.880442391041, 4995.450500445021, 5474.644148130359, 5703.686297253691, 5795.768169273182, 5806.229100124334], "value": 3972.220181680913, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [678.9660516974152, 699.7410957945561, 751.4026349052506, 758.3288789421364, 877.978050548736, 15348.462803801869, 16545.57348234037, 16633.916830415845, 16689.332426702917, 16731.665366692658, 14941.252937353116, 15038.0, 15158.924205378959, 15224.238788060607, 15234.54296371108, 720.3696765330336, 741.784882384108, 887.0287035695902, 905.1491597897988, 908.7682640926555, 869.2481003931617, 875.8686197070426, 896.6951236579562, 917.3807679816131, 927.5918595817852, 890.3366991591273, 931.2177770672633, 932.067932067932, 932.6782260120282, 933.9533023348805, 919.3518569408584, 924.9676261330854, 925.2829057480507, 925.4447331601053, 929.1916033051255, 662.8409181796334, 691.695653912277, 693.5145398221215, 695.8399568099366, 697.330562659842, 14873.70252594942, 14927.477538286108, 15098.924505377512, 15213.61965950849, 15295.923520382326, 14916.477923272741, 14990.950633455663, 15037.398504059824, 15043.699126017418, 15047.548573542812, 11862.110341724405, 12084.335361555111, 12103.6368908932, 12165.878341216563, 12496.75006499874, 3400.6939375456327, 3909.159530700913, 3932.1152740633415, 3981.124152686404, 3982.6017398260233, 93082.0, 103452.96547034508, 104443.47778261136, 124788.0, 132361.6763832359, 11489.885101149048, 11574.01620862236, 11686.972120487297, 11728.648140555797, 11757.412129393497, 22951.655725164135, 23168.42078948006, 23202.3039308821, 23239.0, 23504.647430288558, 6925.688344024531, 8401.201885820838, 8445.408821382443, 8534.957325213334, 8648.962124544969, 4492.966617677887, 4572.95427045732, 4599.5400459953735, 4687.7656117194, 4767.61859051275, 3542.3977923753023, 3658.798766067892, 3689.7048236141045, 3690.0590349461254, 3690.9077273068388, 660.7224965514496, 676.4757313082303, 677.8510424829965, 695.9408450281682, 697.7662483068127, 579.5537436174122, 618.4341327685207, 623.800383877164, 629.468099455959, 641.1376698340724, 8146.348292136615, 8913.777155571162, 9514.524273786283, 9543.713688589354, 9556.378835375679, 450.3362610160927, 482.0888520695818, 483.8935434204469, 510.64510165434666, 598.335847209597, 4537.733318763853, 4646.651501137429, 4666.603338716247, 4691.366665500182, 4713.34013238147, 171200.28799711843, 173029.0, 174246.0, 175828.0, 178115.0, 133813.0, 141845.0, 142699.0, 143878.0, 144329.0, 79616.20383796204, 83409.16590834135, 115102.84897151089, 126873.7312626862, 134210.0, 7761.223877612194, 8764.517951512473, 8817.118288171132, 8983.775405614912, 8998.910010900068, 58599.0, 60893.69553152206, 69436.65281673761, 70238.16665666913, 70305.64847175732, 100068.0, 100685.0, 105113.0, 105927.47036265078, 110571.0, 9124.817503650023, 11214.327140371604, 11327.376994265394, 11359.716007099889, 11391.829122563002, 12021.158518903943, 12319.815202771786, 12390.75218495607, 12520.874791252336, 13037.608871733863, 11369.147313951653, 11471.713207169887, 11913.702157446132, 12092.334921579397, 12362.44369003379, 11893.702657433634, 11958.581449649568, 11959.820602691141, 11959.94020029929, 12377.938110309391, 11573.247738896946, 11886.643400697993, 11915.52337906474, 12117.515299387926, 12408.069394795608, 9798.167155791838, 9948.55231514598, 10068.295219334575, 10109.292349535463, 10447.738806529898, 9935.801283974424, 10213.08082272599, 10302.33034852732, 10304.175665946856, 10329.812071611861], "value": 7790.661944067671, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1588.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 118.0, 118.0, 120.0], "value": 116.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 149.0, 116.0, 152.0, 135.0, 96.0, 115.0, 144.0, 172.0, 142.0], "value": 140.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 230.0, 219.0, 197.0, 196.0, 179.0, 204.0, 277.0, 220.0, 191.0], "value": 210.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 60.0, 59.0, 83.0, 53.0, 70.0, 84.0, 84.0, 70.0, 71.0], "value": 71.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 76.0, 75.0, 72.0, 81.0, 86.0, 122.0, 102.0, 103.0, 119.0], "value": 91.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 115.0, 83.0, 131.0, 135.0, 86.0, 108.0, 75.0, 135.0, 134.0], "value": 109.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 101.0, 153.0, 124.0, 95.0, 95.0, 95.0, 96.0, 96.0], "value": 104.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 94.0, 123.0, 93.0, 78.0, 124.0, 77.0, 133.0, 150.0, 151.0], "value": 111.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 54.0, 55.0, 58.0, 58.0, 59.0, 58.0, 58.0, 56.0], "value": 56.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 71.0, 80.0, 74.0, 70.0, 67.0, 84.0, 99.0, 95.0, 68.0], "value": 77.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 85.0, 102.0, 91.0, 83.0, 83.0, 84.0, 82.0, 83.0, 80.0], "value": 85.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 162.0, 149.0, 160.0, 149.0, 151.0, 140.0, 156.0, 198.0, 154.0], "value": 157.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 213.0, 220.0, 184.0, 149.0, 150.0, 183.0, 159.0, 220.0, 220.0], "value": 185.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 67.0, 77.0, 58.0, 81.0, 63.0, 62.0, 68.0, 83.0], "value": 69.3, "unit": "score"}]}]} 03:18:30 INFO - Return code: 0 03:18:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:18:30 ERROR - # TBPL SUCCESS # 03:18:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:18:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:18:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:18:30 INFO - 2016-12-29 03:18:30.364 screenresolution[1660:11055] starting screenresolution argv=screenresolution get 03:18:30 INFO - 2016-12-29 03:18:30.367 screenresolution[1660:11055] Display 0: 1600x1200x32@60 03:18:30 INFO - 2016-12-29 03:18:30.372 screenresolution[1661:11058] starting screenresolution argv=screenresolution list 03:18:30 INFO - Available Modes on Display 0 03:18:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:18:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:18:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:18:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:18:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:18:30 INFO - Intel Iris: 03:18:30 INFO - Chipset Model: Intel Iris 03:18:30 INFO - Type: GPU 03:18:30 INFO - Bus: Built-In 03:18:30 INFO - VRAM (Dynamic, Max): 1536 MB 03:18:30 INFO - Vendor: Intel (0x8086) 03:18:30 INFO - Device ID: 0x0a2e 03:18:30 INFO - Revision ID: 0x0009 03:18:30 INFO - Displays: 03:18:30 INFO - Display: 03:18:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:18:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:18:30 INFO - Display Serial Number: 1600x1200 60 03:18:30 INFO - Main Display: Yes 03:18:30 INFO - Mirror: Off 03:18:30 INFO - Online: Yes 03:18:30 INFO - Rotation: Supported 03:18:30 INFO - Return code: 0 03:18:30 INFO - Running post-action listener: _resource_record_post_action 03:18:30 INFO - [mozharness: 2016-12-29 11:18:30.609288Z] Finished run-tests step (success) 03:18:30 INFO - Running post-run listener: _resource_record_post_run 03:18:30 INFO - Total resource usage - Wall time: 1194s; CPU: 54.0%; Read bytes: 33938432; Write bytes: 499194368; Read time: 321; Write time: 1908 03:18:30 INFO - TinderboxPrint: CPU usage
54.4% 03:18:30 INFO - TinderboxPrint: I/O read bytes / time
33,938,432 / 321 03:18:30 INFO - TinderboxPrint: I/O write bytes / time
499,194,368 / 1,908 03:18:30 INFO - TinderboxPrint: CPU idle
2,178.3 (45.6%) 03:18:30 INFO - TinderboxPrint: CPU system
969.1 (20.3%) 03:18:30 INFO - TinderboxPrint: CPU user
1,630.3 (34.1%) 03:18:30 INFO - TinderboxPrint: Swap in / out
224,808,960 / 0 03:18:30 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 193100288; Write bytes: 187869184; Read time: 17620; Write time: 417 03:18:30 INFO - run-tests - Wall time: 1173s; CPU: 54.0%; Read bytes: 31337472; Write bytes: 300085760; Read time: 287; Write time: 1454 03:18:31 INFO - Running post-run listener: _upload_blobber_files 03:18:31 INFO - Blob upload gear active. 03:18:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:18:31 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 03:18:31 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'] 03:18:31 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 03:18:31 INFO - (blobuploader) - INFO - Open directory for files ... 03:18:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:18:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:18:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:18:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:18:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:18:32 INFO - (blobuploader) - INFO - Done attempting. 03:18:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:18:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:18:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:18:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:18:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:18:34 INFO - (blobuploader) - INFO - Done attempting. 03:18:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:18:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:18:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:18:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:18:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:18:36 INFO - (blobuploader) - INFO - Done attempting. 03:18:36 INFO - (blobuploader) - INFO - Iteration through files over. 03:18:36 INFO - Return code: 0 03:18:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:18:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:18:36 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3e407ae790604b7731b9f94e59e17bad156ee70cb7e1bce10075f4c1772d2e997bbc18a8bf60996a35a7ba988857ce5fd727873188a10179b70d453b9b11b203", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6e3cbfa8a9ae751029a6ad44e3fa4daa3650853441dbde1b0dc6fd08693c2d9d6979ce28d8a72907bcf0d40c2a5c4a24f151abc72d69d4b6ec0fabb470086b68", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/75fbfed3f55cb24eb826acee1c022c5c459ad48ffac563bec3e1ca07d1c9b3ad5860fbf8ccf8304504214538ea56fd6a27213a111232a33bea4d5bf25516d53b"} 03:18:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:18:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:18:36 INFO - Contents: 03:18:36 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3e407ae790604b7731b9f94e59e17bad156ee70cb7e1bce10075f4c1772d2e997bbc18a8bf60996a35a7ba988857ce5fd727873188a10179b70d453b9b11b203", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6e3cbfa8a9ae751029a6ad44e3fa4daa3650853441dbde1b0dc6fd08693c2d9d6979ce28d8a72907bcf0d40c2a5c4a24f151abc72d69d4b6ec0fabb470086b68", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/75fbfed3f55cb24eb826acee1c022c5c459ad48ffac563bec3e1ca07d1c9b3ad5860fbf8ccf8304504214538ea56fd6a27213a111232a33bea4d5bf25516d53b"} 03:18:36 INFO - Running post-run listener: copy_logs_to_upload_dir 03:18:36 INFO - Copying logs to upload dir... 03:18:36 INFO - mkdir: /builds/slave/test/build/upload/logs 03:18:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.260078 ========= master_lag: 3.75 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-12-29 03:18:40.318038) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-29 03:18:40.325611) ========= 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.FQa93TiuY6/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.J0DKlzi9KG/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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/3e407ae790604b7731b9f94e59e17bad156ee70cb7e1bce10075f4c1772d2e997bbc18a8bf60996a35a7ba988857ce5fd727873188a10179b70d453b9b11b203", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6e3cbfa8a9ae751029a6ad44e3fa4daa3650853441dbde1b0dc6fd08693c2d9d6979ce28d8a72907bcf0d40c2a5c4a24f151abc72d69d4b6ec0fabb470086b68", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/75fbfed3f55cb24eb826acee1c022c5c459ad48ffac563bec3e1ca07d1c9b3ad5860fbf8ccf8304504214538ea56fd6a27213a111232a33bea4d5bf25516d53b"} build_url:https://queue.taskcluster.net/v1/task/UwDDOUtMQ6aneHiMr8MfZg/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010940 build_url: 'https://queue.taskcluster.net/v1/task/UwDDOUtMQ6aneHiMr8MfZg/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/3e407ae790604b7731b9f94e59e17bad156ee70cb7e1bce10075f4c1772d2e997bbc18a8bf60996a35a7ba988857ce5fd727873188a10179b70d453b9b11b203", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6e3cbfa8a9ae751029a6ad44e3fa4daa3650853441dbde1b0dc6fd08693c2d9d6979ce28d8a72907bcf0d40c2a5c4a24f151abc72d69d4b6ec0fabb470086b68", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/75fbfed3f55cb24eb826acee1c022c5c459ad48ffac563bec3e1ca07d1c9b3ad5860fbf8ccf8304504214538ea56fd6a27213a111232a33bea4d5bf25516d53b"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-29 03:18:40.361661) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 03:18:40.361950) ========= 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.FQa93TiuY6/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.J0DKlzi9KG/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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.005064 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 03:18:40.412927) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-29 03:18:40.416321) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-29 03:18:40.416632) ========= ========= Total master_lag: 3.99 =========