builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0018 starttime: 1485509524.13 results: success (0) buildid: 20170127004004 builduid: 255069955f2c4b1c8dd0cfc64f18bb79 revision: 33447b9cb7d008da4f1f5b1a1f1777b712a5c254 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-27 01:32:04.127439) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-27 01:32:04.127899) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-27 01:32:04.128198) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-27 01:32:04.154646) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 01:32:04.155019) ========= 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.hSeyTExLMv/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.9mqsH1XaMJ/Listeners TMPDIR=/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-27 01:32:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 54.0M=0s 2017-01-27 01:32:04 (54.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.188475 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 01:32:04.367152) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 01:32:04.367448) ========= 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.hSeyTExLMv/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.9mqsH1XaMJ/Listeners TMPDIR=/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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.026323 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 01:32:04.416160) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-27 01:32:04.416570) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 33447b9cb7d008da4f1f5b1a1f1777b712a5c254 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 33447b9cb7d008da4f1f5b1a1f1777b712a5c254 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.hSeyTExLMv/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.9mqsH1XaMJ/Listeners TMPDIR=/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-27 01:32:04,500 truncating revision to first 12 chars 2017-01-27 01:32:04,500 Setting DEBUG logging. 2017-01-27 01:32:04,500 attempt 1/10 2017-01-27 01:32:04,500 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/33447b9cb7d0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-27 01:32:05,259 unpacking tar archive at: mozilla-aurora-33447b9cb7d0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.032131 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-27 01:32:05.472266) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-27 01:32:05.472619) ========= script_repo_revision: 33447b9cb7d008da4f1f5b1a1f1777b712a5c254 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-27 01:32:05.473042) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-27 01:32:05.473331) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-27 01:32:05.493052) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-01-27 01:32:05.493475) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.hSeyTExLMv/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.9mqsH1XaMJ/Listeners TMPDIR=/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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 01:32:05 INFO - MultiFileLogger online at 20170127 01:32:05 in /builds/slave/test 01:32:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 01:32:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:32:05 INFO - {'append_to_log': False, 01:32:05 INFO - 'base_work_dir': '/builds/slave/test', 01:32:05 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 01:32:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:32:05 INFO - 'branch': 'Mozilla-Aurora', 01:32:05 INFO - 'buildbot_json_path': 'buildprops.json', 01:32:05 INFO - 'config_files': ('talos/mac_config.py',), 01:32:05 INFO - 'default_actions': ('clobber', 01:32:05 INFO - 'read-buildbot-config', 01:32:05 INFO - 'download-and-extract', 01:32:05 INFO - 'populate-webroot', 01:32:05 INFO - 'create-virtualenv', 01:32:05 INFO - 'install', 01:32:05 INFO - 'run-tests'), 01:32:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:32:05 INFO - 'download_minidump_stackwalk': True, 01:32:05 INFO - 'download_symbols': 'ondemand', 01:32:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:32:05 INFO - 'tooltool.py': '/tools/tooltool.py', 01:32:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:32:05 INFO - '/tools/misc-python/virtualenv.py')}, 01:32:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:32:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:32:05 INFO - 'installer_path': 'installer.exe', 01:32:05 INFO - 'log_level': 'info', 01:32:05 INFO - 'log_name': 'talos', 01:32:05 INFO - 'log_to_console': True, 01:32:05 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:32:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:32:05 INFO - 'opt_config_files': (), 01:32:05 INFO - 'pip_index': False, 01:32:05 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:32:05 INFO - 'cmd': ('bash', 01:32:05 INFO - '-c', 01:32:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:32:05 INFO - 'enabled': True, 01:32:05 INFO - 'halt_on_failure': False, 01:32:05 INFO - 'name': 'check_screen_resolution'},), 01:32:05 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:32:05 INFO - 'cmd': ('bash', 01:32:05 INFO - '-c', 01:32:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:32:05 INFO - 'enabled': True, 01:32:05 INFO - 'halt_on_failure': False, 01:32:05 INFO - 'name': 'check_screen_resolution'},), 01:32:05 INFO - 'run_cmd_checks_enabled': True, 01:32:05 INFO - 'sps_profile': False, 01:32:05 INFO - 'sps_profile_interval': 0, 01:32:05 INFO - 'suite': 'dromaeojs-e10s', 01:32:05 INFO - 'system_bits': '32', 01:32:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:32:05 INFO - 'title': 't-yosemite-r7-0018', 01:32:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:32:05 INFO - 'use_talos_json': True, 01:32:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:32:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:32:05 INFO - 'work_dir': 'build'} 01:32:05 INFO - [mozharness: 2017-01-27 09:32:05.683898Z] Running clobber step. 01:32:05 INFO - Running pre-action listener: _resource_record_pre_action 01:32:05 INFO - Running main action method: clobber 01:32:05 INFO - rmtree: /builds/slave/test/build 01:32:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:32:08 INFO - Running post-action listener: _resource_record_post_action 01:32:08 INFO - [mozharness: 2017-01-27 09:32:08.208274Z] Finished clobber step (success) 01:32:08 INFO - [mozharness: 2017-01-27 09:32:08.208467Z] Running read-buildbot-config step. 01:32:08 INFO - Running pre-action listener: _resource_record_pre_action 01:32:08 INFO - Running main action method: read_buildbot_config 01:32:08 INFO - Using buildbot properties: 01:32:08 INFO - { 01:32:08 INFO - "project": "", 01:32:08 INFO - "product": "firefox", 01:32:08 INFO - "script_repo_revision": "production", 01:32:08 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 01:32:08 INFO - "repository": "", 01:32:08 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 01:32:08 INFO - "buildid": "20170127004004", 01:32:08 INFO - "stage_platform": "macosx64", 01:32:08 INFO - "basedir": "/builds/slave/test", 01:32:08 INFO - "nightly_build": "True", 01:32:08 INFO - "buildnumber": 24, 01:32:08 INFO - "slavename": "t-yosemite-r7-0018", 01:32:08 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 01:32:08 INFO - "platform": "yosemite_r7", 01:32:08 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 01:32:08 INFO - "branch": "mozilla-aurora", 01:32:08 INFO - "repo_path": "releases/mozilla-aurora", 01:32:08 INFO - "revision": "33447b9cb7d008da4f1f5b1a1f1777b712a5c254", 01:32:08 INFO - "pgo_build": "False", 01:32:08 INFO - "builduid": "255069955f2c4b1c8dd0cfc64f18bb79", 01:32:08 INFO - "slavebuilddir": "test" 01:32:08 INFO - } 01:32:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/NLVexwFuRSGVaVbhLuxVLg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 01:32:08 INFO - Running post-action listener: _resource_record_post_action 01:32:08 INFO - [mozharness: 2017-01-27 09:32:08.212134Z] Finished read-buildbot-config step (success) 01:32:08 INFO - [mozharness: 2017-01-27 09:32:08.212269Z] Running download-and-extract step. 01:32:08 INFO - Running pre-action listener: _resource_record_pre_action 01:32:08 INFO - Running main action method: download_and_extract 01:32:08 INFO - mkdir: /builds/slave/test/build/tests 01:32:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:32:08 INFO - trying https://queue.taskcluster.net/v1/task/NLVexwFuRSGVaVbhLuxVLg/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 01:32:08 INFO - Downloading https://queue.taskcluster.net/v1/task/NLVexwFuRSGVaVbhLuxVLg/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 01:32:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NLVexwFuRSGVaVbhLuxVLg/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 01:32:09 INFO - Downloaded 1199 bytes. 01:32:09 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 01:32:09 INFO - Using the following test package requirements: 01:32:09 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 01:32:09 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 01:32:09 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 01:32:09 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 01:32:09 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 01:32:09 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 01:32:09 INFO - u'jsshell-mac.zip'], 01:32:09 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 01:32:09 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 01:32:09 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 01:32:09 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 01:32:09 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 01:32:09 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 01:32:09 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 01:32:09 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 01:32:09 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 01:32:09 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 01:32:09 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 01:32:09 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 01:32:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NLVexwFuRSGVaVbhLuxVLg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 01:32:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NLVexwFuRSGVaVbhLuxVLg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 01:32:09 INFO - Fetch https://queue.taskcluster.net/v1/task/NLVexwFuRSGVaVbhLuxVLg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 01:32:10 INFO - Expected file size: 16349963 01:32:10 INFO - Obtained file size: 16349963 01:32:17 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 01:32:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NLVexwFuRSGVaVbhLuxVLg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 01:32:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NLVexwFuRSGVaVbhLuxVLg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 01:32:17 INFO - Fetch https://queue.taskcluster.net/v1/task/NLVexwFuRSGVaVbhLuxVLg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 01:32:18 INFO - Expected file size: 16349963 01:32:18 INFO - Obtained file size: 16349963 01:32:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NLVexwFuRSGVaVbhLuxVLg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 01:32:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NLVexwFuRSGVaVbhLuxVLg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 01:32:24 INFO - Fetch https://queue.taskcluster.net/v1/task/NLVexwFuRSGVaVbhLuxVLg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 01:32:25 INFO - Expected file size: 14403485 01:32:25 INFO - Obtained file size: 14403485 01:32: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')]} 01:32:25 INFO - trying https://queue.taskcluster.net/v1/task/NLVexwFuRSGVaVbhLuxVLg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 01:32:25 INFO - Downloading https://queue.taskcluster.net/v1/task/NLVexwFuRSGVaVbhLuxVLg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 01:32:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NLVexwFuRSGVaVbhLuxVLg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 01:32:28 INFO - Downloaded 73925315 bytes. 01:32:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NLVexwFuRSGVaVbhLuxVLg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 01:32:28 INFO - mkdir: /builds/slave/test/properties 01:32:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:32:28 INFO - Writing to file /builds/slave/test/properties/build_url 01:32:28 INFO - Contents: 01:32:28 INFO - build_url:https://queue.taskcluster.net/v1/task/NLVexwFuRSGVaVbhLuxVLg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 01:32:28 INFO - Running post-action listener: _resource_record_post_action 01:32:28 INFO - Running post-action listener: set_extra_try_arguments 01:32:28 INFO - [mozharness: 2017-01-27 09:32:28.727954Z] Finished download-and-extract step (success) 01:32:28 INFO - [mozharness: 2017-01-27 09:32:28.728100Z] Running populate-webroot step. 01:32:28 INFO - Running pre-action listener: _resource_record_pre_action 01:32:28 INFO - Running main action method: populate_webroot 01:32:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:32:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:32:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:32:28 INFO - '--tppagecycles', 01:32:28 INFO - '7'], 01:32:28 INFO - 'tests': ['tsvgm']}}, 01:32:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:32:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:32:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:32:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:32:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:32:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:32:28 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 01:32:28 INFO - 'talos_options': ['--disable-e10s'], 01:32:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:32:28 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 01:32:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:32:28 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 01:32:28 INFO - 'talos_options': ['--disable-e10s'], 01:32:28 INFO - 'tests': ['damp', 'tps']}, 01:32:28 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 01:32:28 INFO - 'tests': ['damp', 'tps']}, 01:32:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:32:28 INFO - 'tests': ['dromaeo_dom']}, 01:32:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:32:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:32:28 INFO - 'tests': ['basic_compositor_video']}, 01:32:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:32:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:32:28 INFO - 'tests': ['a11yr', 01:32:28 INFO - 'ts_paint', 01:32:28 INFO - 'tpaint', 01:32:28 INFO - 'sessionrestore', 01:32:28 INFO - 'sessionrestore_no_auto_restore', 01:32:28 INFO - 'tabpaint']}, 01:32:28 INFO - 'other-e10s': {'tests': ['a11yr', 01:32:28 INFO - 'ts_paint', 01:32:28 INFO - 'tpaint', 01:32:28 INFO - 'sessionrestore', 01:32:28 INFO - 'sessionrestore_no_auto_restore', 01:32:28 INFO - 'tabpaint']}, 01:32:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:32:28 INFO - 'ts_paint', 01:32:28 INFO - 'tpaint', 01:32:28 INFO - 'sessionrestore', 01:32:28 INFO - 'sessionrestore_no_auto_restore', 01:32:28 INFO - 'tabpaint']}, 01:32:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:32:28 INFO - 'ts_paint', 01:32:28 INFO - 'tpaint', 01:32:28 INFO - 'sessionrestore', 01:32:28 INFO - 'sessionrestore_no_auto_restore', 01:32:28 INFO - 'tabpaint']}, 01:32:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:32:28 INFO - 'tests': ['a11yr', 01:32:28 INFO - 'ts_paint', 01:32:28 INFO - 'tpaint', 01:32:28 INFO - 'sessionrestore', 01:32:28 INFO - 'sessionrestore_no_auto_restore', 01:32:28 INFO - 'tabpaint']}, 01:32:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:32:28 INFO - 'tests': ['a11yr', 01:32:28 INFO - 'ts_paint', 01:32:28 INFO - 'tpaint', 01:32:28 INFO - 'sessionrestore', 01:32:28 INFO - 'sessionrestore_no_auto_restore', 01:32:28 INFO - 'tabpaint']}, 01:32:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:32:28 INFO - 'tests': ['tsvgx', 01:32:28 INFO - 'tsvgr_opacity', 01:32:28 INFO - 'tart', 01:32:28 INFO - 'tscrollx', 01:32:28 INFO - 'cart', 01:32:28 INFO - 'tsvg_static']}, 01:32:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:32:28 INFO - 'tsvgr_opacity', 01:32:28 INFO - 'tart', 01:32:28 INFO - 'tscrollx', 01:32:28 INFO - 'cart', 01:32:28 INFO - 'tsvg_static']}, 01:32:28 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 01:32:28 INFO - 'talos_options': ['--disable-e10s'], 01:32:28 INFO - 'tests': ['tp5o']}, 01:32:28 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 01:32:28 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 01:32:28 INFO - 'talos_options': ['--disable-e10s', 01:32:28 INFO - '--xperf_path', 01:32:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:32:28 INFO - 'tests': ['tp5n']}, 01:32:28 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 01:32:28 INFO - 'talos_options': ['--xperf_path', 01:32:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:32:28 INFO - 'tests': ['tp5n']}}, 01:32:28 INFO - 'talos.zip': {'path': '', 01:32:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:32:28 INFO - Running post-action listener: _resource_record_post_action 01:32:28 INFO - [mozharness: 2017-01-27 09:32:28.746494Z] Finished populate-webroot step (success) 01:32:28 INFO - [mozharness: 2017-01-27 09:32:28.746626Z] Running create-virtualenv step. 01:32:28 INFO - Running pre-action listener: _resource_record_pre_action 01:32:28 INFO - Running main action method: create_virtualenv 01:32:28 INFO - Creating virtualenv /builds/slave/test/build/venv 01:32:28 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 01:32:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:32:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:32:28 INFO - Using real prefix '/tools/python27' 01:32:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:32:29 INFO - Installing distribute.............................................................................................................................................................................................done. 01:32:32 INFO - Installing pip.................done. 01:32:32 INFO - Return code: 0 01:32:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:32:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:32:32 INFO - Reading from file tmpfile_stdout 01:32:32 INFO - Output received: 01:32:32 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 01:32:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:32:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:32:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:32 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 0x10900fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109012768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff02bca2300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108dedd30>, '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 0x108d14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108de2be8>, '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.hSeyTExLMv/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.9mqsH1XaMJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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 01:32:32 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 01:32:32 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 01:32:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hSeyTExLMv/Render', 01:32:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:32:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:32:32 INFO - 'HOME': '/Users/cltbld', 01:32:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:32:32 INFO - 'LOGNAME': 'cltbld', 01:32:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:32 INFO - 'MOZ_NO_REMOTE': '1', 01:32:32 INFO - 'NO_EM_RESTART': '1', 01:32:32 INFO - 'PAGER': '/bin/cat', 01:32:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:32:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:32 INFO - 'PWD': '/builds/slave/test', 01:32:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:32:32 INFO - 'SHELL': '/bin/bash', 01:32:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9mqsH1XaMJ/Listeners', 01:32:32 INFO - 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/', 01:32:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:32:32 INFO - 'USER': 'cltbld', 01:32:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:32:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:32:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:32 INFO - 'XPC_FLAGS': '0x0', 01:32:32 INFO - 'XPC_SERVICE_NAME': '0', 01:32:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:32:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:32 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 01:32:32 INFO - Cleaning up... 01:32:32 INFO - Return code: 0 01:32:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:32:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:32:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:32 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 0x10900fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109012768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff02bca2300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108dedd30>, '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 0x108d14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108de2be8>, '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.hSeyTExLMv/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.9mqsH1XaMJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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 01:32:32 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 01:32:32 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 01:32:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hSeyTExLMv/Render', 01:32:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:32:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:32:32 INFO - 'HOME': '/Users/cltbld', 01:32:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:32:32 INFO - 'LOGNAME': 'cltbld', 01:32:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:32 INFO - 'MOZ_NO_REMOTE': '1', 01:32:32 INFO - 'NO_EM_RESTART': '1', 01:32:32 INFO - 'PAGER': '/bin/cat', 01:32:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:32:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:32 INFO - 'PWD': '/builds/slave/test', 01:32:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:32:32 INFO - 'SHELL': '/bin/bash', 01:32:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9mqsH1XaMJ/Listeners', 01:32:32 INFO - 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/', 01:32:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:32:32 INFO - 'USER': 'cltbld', 01:32:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:32:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:32:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:32 INFO - 'XPC_FLAGS': '0x0', 01:32:32 INFO - 'XPC_SERVICE_NAME': '0', 01:32:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:32:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:33 INFO - Downloading/unpacking psutil>=3.1.1 01:32:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:32:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:32:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:32:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:32:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:32:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:32:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:32:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:32:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:32:37 INFO - Installing collected packages: psutil 01:32:37 INFO - Running setup.py install for psutil 01:32:37 INFO - building 'psutil._psutil_osx' extension 01:32:37 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 01:32:37 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 01:32:37 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 01:32:37 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 01:32:38 INFO - building 'psutil._psutil_posix' extension 01:32:38 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 01:32:38 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:32:38 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:32:38 INFO - ^ 01:32:38 INFO - 1 warning generated. 01:32:38 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 01:32:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:32:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:32:38 INFO - Successfully installed psutil 01:32:38 INFO - Cleaning up... 01:32:38 INFO - Return code: 0 01:32:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:32:38 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')]} 01:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:38 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')]} 01:32:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:38 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 0x10900fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109012768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff02bca2300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108dedd30>, '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 0x108d14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108de2be8>, '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.hSeyTExLMv/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.9mqsH1XaMJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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 01:32:38 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 01:32:38 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 01:32:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hSeyTExLMv/Render', 01:32:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:32:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:32:38 INFO - 'HOME': '/Users/cltbld', 01:32:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:32:38 INFO - 'LOGNAME': 'cltbld', 01:32:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:38 INFO - 'MOZ_NO_REMOTE': '1', 01:32:38 INFO - 'NO_EM_RESTART': '1', 01:32:38 INFO - 'PAGER': '/bin/cat', 01:32:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:32:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:38 INFO - 'PWD': '/builds/slave/test', 01:32:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:32:38 INFO - 'SHELL': '/bin/bash', 01:32:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9mqsH1XaMJ/Listeners', 01:32:38 INFO - 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/', 01:32:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:32:38 INFO - 'USER': 'cltbld', 01:32:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:32:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:32:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:38 INFO - 'XPC_FLAGS': '0x0', 01:32:38 INFO - 'XPC_SERVICE_NAME': '0', 01:32:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:32:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:32:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:32:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:32:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:32:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:32:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:32:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:32:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:32:41 INFO - Installing collected packages: mozsystemmonitor 01:32:41 INFO - Running setup.py install for mozsystemmonitor 01:32:41 INFO - Successfully installed mozsystemmonitor 01:32:41 INFO - Cleaning up... 01:32:41 INFO - Return code: 0 01:32:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:32:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:32:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:32:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10900fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109012768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff02bca2300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108dedd30>, '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 0x108d14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108de2be8>, '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.hSeyTExLMv/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.9mqsH1XaMJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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 01:32:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 01:32:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 01:32:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hSeyTExLMv/Render', 01:32:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:32:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:32:41 INFO - 'HOME': '/Users/cltbld', 01:32:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:32:41 INFO - 'LOGNAME': 'cltbld', 01:32:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:41 INFO - 'MOZ_NO_REMOTE': '1', 01:32:41 INFO - 'NO_EM_RESTART': '1', 01:32:41 INFO - 'PAGER': '/bin/cat', 01:32:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:32:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:41 INFO - 'PWD': '/builds/slave/test', 01:32:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:32:41 INFO - 'SHELL': '/bin/bash', 01:32:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9mqsH1XaMJ/Listeners', 01:32:41 INFO - 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/', 01:32:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:32:41 INFO - 'USER': 'cltbld', 01:32:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:32:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:32:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:41 INFO - 'XPC_FLAGS': '0x0', 01:32:41 INFO - 'XPC_SERVICE_NAME': '0', 01:32:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:32:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:41 INFO - Downloading/unpacking jsonschema==2.5.1 01:32:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:32:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:32:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:32:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:32:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:32:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:32:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:32:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:32:44 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 01:32:44 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 01:32:44 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 01:32:44 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 01:32:44 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 01:32:44 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 01:32:44 INFO - Downloading functools32-3.2.3-2.tar.gz 01:32:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:32:44 INFO - warning: no files found matching '*.txt' 01:32:44 INFO - no previously-included directories found matching 'build' 01:32:44 INFO - no previously-included directories found matching 'dist' 01:32:44 INFO - no previously-included directories found matching '.git*' 01:32:44 INFO - Installing collected packages: jsonschema, functools32 01:32:44 INFO - Running setup.py install for functools32 01:32:45 INFO - warning: no files found matching '*.txt' 01:32:45 INFO - no previously-included directories found matching 'build' 01:32:45 INFO - no previously-included directories found matching 'dist' 01:32:45 INFO - no previously-included directories found matching '.git*' 01:32:45 INFO - Successfully installed jsonschema functools32 01:32:45 INFO - Cleaning up... 01:32:45 INFO - Return code: 0 01:32:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:32:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:32:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10900fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109012768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff02bca2300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108dedd30>, '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 0x108d14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108de2be8>, '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.hSeyTExLMv/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.9mqsH1XaMJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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 01:32:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 01:32:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 01:32:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hSeyTExLMv/Render', 01:32:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:32:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:32:45 INFO - 'HOME': '/Users/cltbld', 01:32:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:32:45 INFO - 'LOGNAME': 'cltbld', 01:32:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:45 INFO - 'MOZ_NO_REMOTE': '1', 01:32:45 INFO - 'NO_EM_RESTART': '1', 01:32:45 INFO - 'PAGER': '/bin/cat', 01:32:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:32:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:45 INFO - 'PWD': '/builds/slave/test', 01:32:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:32:45 INFO - 'SHELL': '/bin/bash', 01:32:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9mqsH1XaMJ/Listeners', 01:32:45 INFO - 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/', 01:32:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:32:45 INFO - 'USER': 'cltbld', 01:32:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:32:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:32:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:45 INFO - 'XPC_FLAGS': '0x0', 01:32:45 INFO - 'XPC_SERVICE_NAME': '0', 01:32:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:32:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:32:45 INFO - Cleaning up... 01:32:45 INFO - Return code: 0 01:32:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:32:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:32:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10900fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109012768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff02bca2300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108dedd30>, '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 0x108d14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108de2be8>, '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.hSeyTExLMv/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.9mqsH1XaMJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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 01:32:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:32:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:32:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hSeyTExLMv/Render', 01:32:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:32:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:32:45 INFO - 'HOME': '/Users/cltbld', 01:32:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:32:45 INFO - 'LOGNAME': 'cltbld', 01:32:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:45 INFO - 'MOZ_NO_REMOTE': '1', 01:32:45 INFO - 'NO_EM_RESTART': '1', 01:32:45 INFO - 'PAGER': '/bin/cat', 01:32:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:32:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:45 INFO - 'PWD': '/builds/slave/test', 01:32:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:32:45 INFO - 'SHELL': '/bin/bash', 01:32:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9mqsH1XaMJ/Listeners', 01:32:45 INFO - 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/', 01:32:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:32:45 INFO - 'USER': 'cltbld', 01:32:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:32:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:32:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:45 INFO - 'XPC_FLAGS': '0x0', 01:32:45 INFO - 'XPC_SERVICE_NAME': '0', 01:32:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:32:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:45 INFO - Downloading/unpacking blobuploader==1.2.4 01:32:45 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 01:32:45 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 01:32:45 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 01:32:45 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 01:32:45 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 01:32:45 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 01:32:48 INFO - Downloading blobuploader-1.2.4.tar.gz 01:32:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:32:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:32:48 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 01:32:48 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 01:32:48 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 01:32:48 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 01:32:48 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 01:32:48 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 01:32:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:32:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:32:49 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 01:32:49 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 01:32:49 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 01:32:49 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 01:32:49 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 01:32:49 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 01:32:49 INFO - Downloading docopt-0.6.1.tar.gz 01:32:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:32:49 INFO - Installing collected packages: blobuploader, requests, docopt 01:32:49 INFO - Running setup.py install for blobuploader 01:32:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:32:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:32:49 INFO - Running setup.py install for requests 01:32:50 INFO - Running setup.py install for docopt 01:32:50 INFO - Successfully installed blobuploader requests docopt 01:32:50 INFO - Cleaning up... 01:32:50 INFO - Return code: 0 01:32:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:32:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:32:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:32:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:50 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 0x10900fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109012768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff02bca2300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108dedd30>, '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 0x108d14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108de2be8>, '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.hSeyTExLMv/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.9mqsH1XaMJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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 01:32:50 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 01:32:50 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 01:32:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hSeyTExLMv/Render', 01:32:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:32:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:32:50 INFO - 'HOME': '/Users/cltbld', 01:32:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:32:50 INFO - 'LOGNAME': 'cltbld', 01:32:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:50 INFO - 'MOZ_NO_REMOTE': '1', 01:32:50 INFO - 'NO_EM_RESTART': '1', 01:32:50 INFO - 'PAGER': '/bin/cat', 01:32:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:32:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:50 INFO - 'PWD': '/builds/slave/test', 01:32:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:32:50 INFO - 'SHELL': '/bin/bash', 01:32:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9mqsH1XaMJ/Listeners', 01:32:50 INFO - 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/', 01:32:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:32:50 INFO - 'USER': 'cltbld', 01:32:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:32:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:32:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:50 INFO - 'XPC_FLAGS': '0x0', 01:32:50 INFO - 'XPC_SERVICE_NAME': '0', 01:32:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:32:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:32:50 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-SpQ3Ca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:32:50 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-ZxJRiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:32:50 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-OJTg1B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:32:51 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-VEveVC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:32:51 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-0M3_fo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:32:51 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-JxhKrO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:32:51 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-fGtsFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:32:51 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-sT4kcb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:32:51 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-7X0yv_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:32:51 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-83Lg7K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:32:51 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-6A1NsE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:32:51 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-WFiFdq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:32:51 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-qA76y5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:32:52 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-MAPgoj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:32:52 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-oukcf9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:32:52 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-a6Dzvl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:32:52 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-YWlXr8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:32:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:32:52 INFO - Running setup.py install for manifestparser 01:32:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:32:52 INFO - Running setup.py install for mozcrash 01:32:52 INFO - Running setup.py install for mozdebug 01:32:52 INFO - Running setup.py install for mozdevice 01:32:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:32:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:32:53 INFO - Running setup.py install for mozfile 01:32:53 INFO - Running setup.py install for mozhttpd 01:32:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:32:53 INFO - Running setup.py install for mozinfo 01:32:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:32:53 INFO - Running setup.py install for mozInstall 01:32:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:32:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:32:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:32:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:32:53 INFO - Running setup.py install for mozleak 01:32:53 INFO - Running setup.py install for mozlog 01:32:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:32:53 INFO - Running setup.py install for moznetwork 01:32:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:32:54 INFO - Running setup.py install for mozprocess 01:32:54 INFO - Running setup.py install for mozprofile 01:32:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:32:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:32:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:32:54 INFO - Running setup.py install for mozrunner 01:32:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:32:54 INFO - Running setup.py install for mozscreenshot 01:32:54 INFO - Running setup.py install for moztest 01:32:54 INFO - Running setup.py install for mozversion 01:32:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:32:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:32:55 INFO - Cleaning up... 01:32:55 INFO - Return code: 0 01:32:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:32:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:32:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:55 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 0x10900fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109012768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff02bca2300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108dedd30>, '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 0x108d14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108de2be8>, '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.hSeyTExLMv/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.9mqsH1XaMJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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 01:32:55 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 01:32:55 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 01:32:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hSeyTExLMv/Render', 01:32:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:32:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:32:55 INFO - 'HOME': '/Users/cltbld', 01:32:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:32:55 INFO - 'LOGNAME': 'cltbld', 01:32:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:55 INFO - 'MOZ_NO_REMOTE': '1', 01:32:55 INFO - 'NO_EM_RESTART': '1', 01:32:55 INFO - 'PAGER': '/bin/cat', 01:32:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:32:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:55 INFO - 'PWD': '/builds/slave/test', 01:32:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:32:55 INFO - 'SHELL': '/bin/bash', 01:32:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9mqsH1XaMJ/Listeners', 01:32:55 INFO - 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/', 01:32:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:32:55 INFO - 'USER': 'cltbld', 01:32:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:32:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:32:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:55 INFO - 'XPC_FLAGS': '0x0', 01:32:55 INFO - 'XPC_SERVICE_NAME': '0', 01:32:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:32:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:32:55 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-eCOjJx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:32:55 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)) 01:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:32:55 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-U8WwaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:32:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:32:55 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-iYOr5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:32:55 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)) 01:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:32:55 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-h8eaUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:32:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:32:55 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-uNr61I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:32:55 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)) 01:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:32:55 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-1184Od-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:32:55 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)) 01:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:32:55 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-OZR3f2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:32:56 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)) 01:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:32:56 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-KTnRSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:32:56 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)) 01:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:32:56 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-8Q03Fs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:32:56 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)) 01:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:32:56 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-Dw8VZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:32:56 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)) 01:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:32:56 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-IyrKgj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:32:56 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)) 01:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:32:56 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-YJ6Mqp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:32:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 01:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:32:56 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-lmjNWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:32:56 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)) 01:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:32:56 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-FnZmF5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:32:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 01:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:32:56 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-hkk3Xf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:32:56 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)) 01:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:32:56 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-ARBAZp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:32:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 01:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:32:56 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-Ts7oCB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:32:57 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)) 01:32:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:32:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:32:57 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)) 01:32:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:32:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:32:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:32:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:32:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:32:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:32:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:32:59 INFO - Downloading blessings-1.6.tar.gz 01:32:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:32:59 INFO - Installing collected packages: blessings 01:32:59 INFO - Running setup.py install for blessings 01:32:59 INFO - Successfully installed blessings 01:32:59 INFO - Cleaning up... 01:33:00 INFO - Return code: 0 01:33:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:33:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:33:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:33:00 INFO - Reading from file tmpfile_stdout 01:33:00 INFO - Current package versions: 01:33:00 INFO - blessings == 1.6 01:33:00 INFO - blobuploader == 1.2.4 01:33:00 INFO - docopt == 0.6.1 01:33:00 INFO - functools32 == 3.2.3-2 01:33:00 INFO - jsonschema == 2.5.1 01:33:00 INFO - manifestparser == 1.1 01:33:00 INFO - mozInstall == 1.12 01:33:00 INFO - mozcrash == 1.0 01:33:00 INFO - mozdebug == 0.1 01:33:00 INFO - mozdevice == 0.49 01:33:00 INFO - mozfile == 1.2 01:33:00 INFO - mozhttpd == 0.7 01:33:00 INFO - mozinfo == 0.9 01:33:00 INFO - mozleak == 0.1 01:33:00 INFO - mozlog == 3.4 01:33:00 INFO - moznetwork == 0.27 01:33:00 INFO - mozprocess == 0.24 01:33:00 INFO - mozprofile == 0.28 01:33:00 INFO - mozrunner == 6.13 01:33:00 INFO - mozscreenshot == 0.1 01:33:00 INFO - mozsystemmonitor == 0.3 01:33:00 INFO - moztest == 0.8 01:33:00 INFO - mozversion == 1.4 01:33:00 INFO - psutil == 3.1.1 01:33:00 INFO - requests == 1.2.3 01:33:00 INFO - wsgiref == 0.1.2 01:33:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:33: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')]} 01:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:33:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33: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')]} 01:33:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:33:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:00 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 0x10900fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109012768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff02bca2300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108dedd30>, '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 0x108d14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108de2be8>, '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.hSeyTExLMv/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.9mqsH1XaMJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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 01:33:00 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 01:33:00 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 01:33:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hSeyTExLMv/Render', 01:33:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:33:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:33:00 INFO - 'HOME': '/Users/cltbld', 01:33:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:33:00 INFO - 'LOGNAME': 'cltbld', 01:33:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:00 INFO - 'MOZ_NO_REMOTE': '1', 01:33:00 INFO - 'NO_EM_RESTART': '1', 01:33:00 INFO - 'PAGER': '/bin/cat', 01:33:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:33:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:33:00 INFO - 'PWD': '/builds/slave/test', 01:33:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:33:00 INFO - 'SHELL': '/bin/bash', 01:33:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9mqsH1XaMJ/Listeners', 01:33:00 INFO - 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/', 01:33:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:33:00 INFO - 'USER': 'cltbld', 01:33:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:33:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:33:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:00 INFO - 'XPC_FLAGS': '0x0', 01:33:00 INFO - 'XPC_SERVICE_NAME': '0', 01:33:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:33:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:33:00 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)) 01:33:00 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)) 01:33:00 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)) 01:33:00 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)) 01:33:00 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)) 01:33:00 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)) 01:33:00 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)) 01:33:00 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)) 01:33:00 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)) 01:33:00 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)) 01:33:00 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)) 01:33:00 INFO - Cleaning up... 01:33:00 INFO - Return code: 0 01:33:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:33: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')]} 01:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:33:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33: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')]} 01:33:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:33:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:00 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 0x10900fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109012768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff02bca2300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108dedd30>, '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 0x108d14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108de2be8>, '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.hSeyTExLMv/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.9mqsH1XaMJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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 01:33:00 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 01:33:00 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 01:33:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hSeyTExLMv/Render', 01:33:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:33:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:33:00 INFO - 'HOME': '/Users/cltbld', 01:33:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:33:00 INFO - 'LOGNAME': 'cltbld', 01:33:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:00 INFO - 'MOZ_NO_REMOTE': '1', 01:33:00 INFO - 'NO_EM_RESTART': '1', 01:33:00 INFO - 'PAGER': '/bin/cat', 01:33:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:33:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:33:00 INFO - 'PWD': '/builds/slave/test', 01:33:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:33:00 INFO - 'SHELL': '/bin/bash', 01:33:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9mqsH1XaMJ/Listeners', 01:33:00 INFO - 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/', 01:33:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:33:00 INFO - 'USER': 'cltbld', 01:33:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:33:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:33:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:00 INFO - 'XPC_FLAGS': '0x0', 01:33:00 INFO - 'XPC_SERVICE_NAME': '0', 01:33:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:33:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:33:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:33:00 INFO - Cleaning up... 01:33:00 INFO - Return code: 0 01:33:00 INFO - Running post-action listener: _resource_record_post_action 01:33:00 INFO - Running post-action listener: _start_resource_monitoring 01:33:00 INFO - Starting resource monitoring. 01:33:00 INFO - [mozharness: 2017-01-27 09:33:00.937305Z] Finished create-virtualenv step (success) 01:33:00 INFO - [mozharness: 2017-01-27 09:33:00.938260Z] Running install step. 01:33:00 INFO - Running pre-action listener: _resource_record_pre_action 01:33:00 INFO - Running main action method: install 01:33:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:33:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:33:01 INFO - Reading from file tmpfile_stdout 01:33:01 INFO - Detecting whether we're running mozinstall >=1.0... 01:33:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:33:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:33:01 INFO - Reading from file tmpfile_stdout 01:33:01 INFO - Output received: 01:33:01 INFO - Usage: mozinstall [options] installer 01:33:01 INFO - Options: 01:33:01 INFO - -h, --help show this help message and exit 01:33:01 INFO - -d DEST, --destination=DEST 01:33:01 INFO - Directory to install application into. [default: 01:33:01 INFO - "/builds/slave/test"] 01:33:01 INFO - --app=APP Application being installed. [default: firefox] 01:33:01 INFO - mkdir: /builds/slave/test/build/application 01:33:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 01:33:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 01:33:21 INFO - Reading from file tmpfile_stdout 01:33:21 INFO - Output received: 01:33:21 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 01:33:21 INFO - Running post-action listener: _resource_record_post_action 01:33:21 INFO - [mozharness: 2017-01-27 09:33:21.149306Z] Finished install step (success) 01:33:21 INFO - [mozharness: 2017-01-27 09:33:21.149461Z] Running run-tests step. 01:33:21 INFO - Running pre-action listener: _resource_record_pre_action 01:33:21 INFO - Running main action method: run_tests 01:33:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:33:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:33:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:33:21 INFO - 2017-01-27 01:33:21.163 screenresolution[1634:8040] starting screenresolution argv=screenresolution get 01:33:21 INFO - 2017-01-27 01:33:21.166 screenresolution[1634:8040] Display 0: 1600x1200x32@60 01:33:21 INFO - 2017-01-27 01:33:21.172 screenresolution[1635:8042] starting screenresolution argv=screenresolution list 01:33:21 INFO - Available Modes on Display 0 01:33:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:33:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:33:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:33:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:33:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:33:21 INFO - Intel Iris: 01:33:21 INFO - Chipset Model: Intel Iris 01:33:21 INFO - Type: GPU 01:33:21 INFO - Bus: Built-In 01:33:21 INFO - VRAM (Dynamic, Max): 1536 MB 01:33:21 INFO - Vendor: Intel (0x8086) 01:33:21 INFO - Device ID: 0x0a2e 01:33:21 INFO - Revision ID: 0x0009 01:33:21 INFO - Displays: 01:33:21 INFO - Display: 01:33:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:33:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:33:21 INFO - Display Serial Number: 1600x1200 60 01:33:21 INFO - Main Display: Yes 01:33:21 INFO - Mirror: Off 01:33:21 INFO - Online: Yes 01:33:21 INFO - Rotation: Supported 01:33:21 INFO - Return code: 0 01:33:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:33:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:33:21 INFO - Python 2.7.3 01:33:21 INFO - Return code: 0 01:33:21 INFO - grabbing minidump binary from tooltool 01:33:21 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')]} 01:33:21 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 0x108dedd30>, '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 0x108d14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108de2be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:33:21 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 01:33:21 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 01:33:21 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 01:33:21 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:33:21 INFO - Return code: 0 01:33:21 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:33:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:33:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:33:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:33:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:33:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NLVexwFuRSGVaVbhLuxVLg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0018', '--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 01:33:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NLVexwFuRSGVaVbhLuxVLg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0018 --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 01:33:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hSeyTExLMv/Render', 01:33:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:33:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:33:21 INFO - 'HOME': '/Users/cltbld', 01:33:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:33:21 INFO - 'LOGNAME': 'cltbld', 01:33:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:33:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:33:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:21 INFO - 'MOZ_NO_REMOTE': '1', 01:33:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:33:21 INFO - 'NO_EM_RESTART': '1', 01:33:21 INFO - 'PAGER': '/bin/cat', 01:33:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:33:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:33:21 INFO - 'PWD': '/builds/slave/test', 01:33:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:33:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:33:21 INFO - 'SHELL': '/bin/bash', 01:33:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9mqsH1XaMJ/Listeners', 01:33:21 INFO - 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/', 01:33:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:33:21 INFO - 'USER': 'cltbld', 01:33:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:33:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:33:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:21 INFO - 'XPC_FLAGS': '0x0', 01:33:21 INFO - 'XPC_SERVICE_NAME': '0', 01:33:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:33:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NLVexwFuRSGVaVbhLuxVLg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0018', '--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 01:33:21 INFO - mozversion application_buildid: 20170127004004 01:33:21 INFO - mozversion application_changeset: 33447b9cb7d008da4f1f5b1a1f1777b712a5c254 01:33:21 INFO - mozversion application_display_name: FirefoxDeveloperEdition 01:33:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:33:21 INFO - mozversion application_name: Firefox 01:33:21 INFO - mozversion application_remotingname: firefox-dev 01:33:21 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:33:21 INFO - mozversion application_vendor: Mozilla 01:33:21 INFO - mozversion application_version: 53.0a2 01:33:21 INFO - mozversion platform_buildid: 20170127004004 01:33:21 INFO - mozversion platform_changeset: 33447b9cb7d008da4f1f5b1a1f1777b712a5c254 01:33:21 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:33:21 INFO - mozversion platform_version: 53.0a2 01:33:21 INFO - using testdate: 1485509601 01:33:21 INFO - actual date: 1485509601 01:33:21 INFO - starting webserver on 'localhost:49241' 01:33:21 INFO - SUITE-START | Running 2 tests 01:33:21 INFO - TEST-START | dromaeo_css 01:33:21 INFO - operating with platform_type : mac_ 01:33:21 INFO - Initialising browser for dromaeo_css test... 01:33:21 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/tmpeUdKz7/profile http://localhost:49241/getInfo.html) 01:33:24 INFO - PROCESS | 1645 | 2017-01-27 01:33:24.692 plugin-container[1648:8209] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x933f, name = 'com.apple.tsm.portname' 01:33:24 INFO - PROCESS | 1645 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:33:24 INFO - PROCESS | 1645 | 2017-01-27 01:33:24.693 plugin-container[1648:8209] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x904b, name = 'com.apple.CFPasteboardClient' 01:33:24 INFO - PROCESS | 1645 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:33:24 INFO - PROCESS | 1645 | 2017-01-27 01:33:24.693 plugin-container[1648:8209] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 01:33:24 INFO - PROCESS | 1645 | __metrics Screen width/height:1600/1200 01:33:24 INFO - PROCESS | 1645 | colorDepth:24 01:33:24 INFO - PROCESS | 1645 | Browser inner width/height: 1024/663 01:33:24 INFO - PROCESS | 1645 | __metrics 01:33:24 ERROR - PROCESS | 1645 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 01:33:25 INFO - TEST-INFO | 1645: exit 0 01:33:25 INFO - Browser initialized. 01:33:25 INFO - Running cycle 1/1 for dromaeo_css test... 01:33:25 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/tmpeUdKz7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:33:27 INFO - PROCESS | 1650 | 2017-01-27 01:33:27.965 plugin-container[1651:8344] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 01:33:27 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:33:27 INFO - PROCESS | 1650 | 2017-01-27 01:33:27.965 plugin-container[1651:8344] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 01:33:27 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:33:27 INFO - PROCESS | 1650 | 2017-01-27 01:33:27.965 plugin-container[1651:8344] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 01:33:37 INFO - PROCESS | 1650 | RSS: Main: 229076992 01:33:37 INFO - PROCESS | 1650 | 01:36:39 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 01:36:41 INFO - PROCESS | 1650 | RSS: Main: 243150848 01:36:41 INFO - PROCESS | 1650 | 01:38:25 INFO - PROCESS | 1650 | ************************* 01:38:25 INFO - PROCESS | 1650 | A coding exception was thrown and uncaught in a Task. 01:38:25 INFO - PROCESS | 1650 | 01:38:25 ERROR - PROCESS | 1650 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:38:25 INFO - PROCESS | 1650 | Full stack: 01:38:25 INFO - PROCESS | 1650 | ************************* 01:39:43 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 01:39:44 INFO - PROCESS | 1650 | RSS: Main: 251150336 01:39:44 INFO - PROCESS | 1650 | 01:42:46 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 01:42:47 INFO - PROCESS | 1650 | RSS: Main: 258842624 01:42:47 INFO - PROCESS | 1650 | 01:45:49 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 01:45:49 INFO - PROCESS | 1650 | RSS: Main: 255307776 01:45:49 INFO - PROCESS | 1650 | 01:48:52 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 01:48:53 INFO - PROCESS | 1650 | RSS: Main: 259383296 01:48:53 INFO - PROCESS | 1650 | 01:51:55 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 01:51:55 INFO - PROCESS | 1650 | RSS: Main: 260603904 01:51:55 INFO - PROCESS | 1650 | 01:51:55 INFO - PROCESS | 1650 | __start_tp_report 01:51:55 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 01:51:55 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 01:51:55 INFO - PROCESS | 1650 | |i|pagename|runs| 01:51:55 INFO - PROCESS | 1650 | |0;dojo.html;3099.256178517156;3315.4032274190636;3355.4295769719147;3358.2779702363987;3416.794992300461;5636.09822428411;5649.180868774025;5670.262865827442;5729.455701708342;5742.885142297162;5622.100463925773;5710;5714.542836573075;5731.713414329277;5755.4244575542525;4479.977600111994;5098.413682426512;5168.638195326329;5229.137192363255;5237.47625237477;5216.113260745663;5277.70972596507;5294.1529355303155;5299.735013249341;5304.49607287309;5103.9489605103845;5149.382074151088;5206.76569554371;5244.213367994793;5266.078436273675;4011.799410029487;4162.229987452331;5143.742812859379;5191.558717509016;5218.739063046833;5115.8209462669;5152.562032227228;5152.716600586966;5166.7416629168765;5239.580833533309;4957.157283261854;5134.71632091977;5584.636998595079;5700.458456446631;5744.080947048494;6103.115048317969;6152.84617884552;6173;6216.937830621681;6236.064590311445;6174.197354343906;6193.287771906198;6196.349383314777;6209.316975132731;6210.472109870667;5914.526837852962;5950.464458198783;5953.3451320354725;5984.521238300882;6001;6114.631938157225;6171.228596425447;6211.689415529206;6223.253209614875;6233.2208473940755;6109.672817243557;6151.046587778901;6167.198264225622;6171.722272497748;6174.783882564088;5716.371199168088;6084.904717150866;6200.937990620036;6231.3145553989025;6287.371262873768;6054.636721796706;6114.449440885012;6119.143319935212;6144.078388241799;6192.164057852222;6248.187735594343;6259.499240060784;6268.686565671698;6274.592151510137;6290.842728931813;4868.3427737255015;4871.732054736953;4886.340344053508;4887.95112048882;4905.460399356068;4319.784010799447;4322.7190232634775;4361.3676016978;4375.037491751809;4404.691671582958;5619.578531610146;5690.6870122142855;5725.685087320154;5755.22304488897;5759;6266.242853144602;6277.843053923689;6292.433680968735;6309.148264984168;6315.621062736159;5642.04085305499;5665.943340566541;5699.487046165782;5705.5435565154685;5731.713414329267;5341.866453338697;5368.32895888014;5368.785248590091;5379.381371142291;5398.433164517748;6319.462845658079;6329.7151628175925;6336.429721325103;6347.746090156342;6350.65071421067;6126.51767379719;6169.537284703575;6190.2571691397325;6265.154204182377;6295.18162638854;6269.7178626962805;6294.276158241861;6325.272593651789;6351.2696039956;6365.395287447685;6182.783602574068;6213.689315534296;6214.25428948529;6218.968905155445;6243.094751261133;4864.185385582376;5811.476967072984;6194.81415557534;6202.968985155226;6321.1782468278825;6059.939400605937;6121.117656725397;6127.464420129145;6130.049842274455;6173.969130154321;6079.392060793885;6080.391960803884;6125.693715314305;6149.169862068564;6154.261488621394;5862.530997520274;5917.733701983335;5963.4334738199805;5982.551308651956;6046.062860256668;5193.714345711022;5481.150421684645;5817.272840894888;6119.663418512025;6153.4154255345675;5972.701364931823;6034.064719968412;6034.547408944259;6036.456718895321;6046.788362407295 01:51:55 INFO - PROCESS | 1650 | |1;ext.html;421.275406301162;487.36155636116666;489.75757000284864;491.923751818468;507.85526125054355;36323.818380908095;38278.80860595697;42530;42561.574384256186;42570.78714606423;43532.69401917948;44009.77995110028;44060;44159.77920110403;44284.55715442845;8602.784930376729;8795.604197811113;9404.01257867926;9629.133377995979;9673.274504412162;11488.71278218047;11788.46951887167;11818.527258909633;11948.103892208119;12003.279803211835;11697.415129243547;11723.765524689501;11782.175247732663;11794.174407791457;11815.645530634052;10377.79244415115;11533.480993355319;11730.296182229093;11802.527898884035;11806.291622502591;11655.825162622568;11663.59177428786;11726.35505047222;11741.765164696744;11750.471228794724;42174;42340;42448;42597;42697.57302426998;4026.1545075534173;4079.1841631673487;4133.2146892090705;4152.688548358855;4259.467566554181;30138.397232055457;30163.85599808636;31529.054128376185;31567.36865262705;31791.84104079488;3210.2295449092285;3229.7093261606333;3339.833008349573;3340.732741380708;3342.8161451120177;496663;497411;498581;498854;499149.9999999964;68494.31505684879;68543.97184042244;68953.3104668957;68978.65510672414;69116;63679.72640547163;71172;72527.54944901072;72993.54012919712;73415.63292183504;16742.74885876713;17196.742048869277;17213.913930430517;17256.74114888278;17270.309187632607;11586.13104017202;12197.573084941985;12789.872101278868;13090.672733181556;13202;19411.126499307284;19781.30765423232;19953.902535360696;19986.500337491678;20084.799152008585;6713.462922966151;6770.390664840188;6788.796336109925;6795.558288711218;6821.829454263584;770.5838847022545;871.9694810681596;912.9452232866049;927.6057675488025;930.6091441594547;28921.56617650695;30221;30732.231694207378;31414.21464463361;31489.527657085164;1053.994730026345;1069.7593041565585;1085.4572713643179;1110.2228440091967;1182.5979167083233;15468.767968480483;15773.05361678303;15852.76220856688;16020.67958640844;16037.438689645807;659231;662285;662760;665998;666162;55366.615834604454;55641.721791391596;55947.44052559504;55953.72023139858;56252.15621765677;1363.3455941148304;1369.705513314642;1387.0429403711407;1393.526201091654;1396.2250950722243;24778.380540486633;26156.869215653798;28908;29797.10608681743;29986.55020174743;46856.7657161712;48419.757901210265;48925.2661210075;49058.50941490539;50108.49891501039;550391;554534;554990;556619;559439;21828.672569911145;25227.369315767253;25447.10935117262;26058.478830422908;26937.73062269352;42970.78514607407;44086.55913440824;44174.779126104164;44506.777466112464;44612;36461.63538364582;36990.815045924595;37145;37473.81263093667;38056.42915356327;35787.46318805272;35873.103172420895;36199.457008144374;36643.63356366402;36723.816380918994;34963.47554786629;35369.82315088408;36009.0997725059;36108.63891361053;36112.91661250166;30907;32624;32705.509417359233;32824.34351313008;33032.66967330296;20738.066786994925;24315.756842432056;24414.389640259134;24542.877285613456;24717.87641061783 01:51:55 INFO - PROCESS | 1650 | |2;jquery.html;385.959474255203;396.6985091330588;405.33322684184515;405.4000079881775;417.7800821600925;18705.34531291405;20327.796722032774;20820.895895520538;21538.461538461546;21587.352379428623;21316.57366852662;21449.57100857982;21774.673379899315;21880.671789923163;22583;5783.363829978699;6092.421219984094;6094.8781024379705;6105.114758360035;6109.327973922865;5638.492535671789;5810.273715785527;5821;5948.821535353946;5997.250343707036;5899.734511946973;5904.2029326040865;5906.911396329058;5907.113932910076;5922.230110085683;5657.51911087556;5829.329627092896;5868.911966320508;5883.29400471944;5909.438603332676;5223.503767142153;5237.109691352441;5241.554467870235;5255.264263003182;5263.131583288753;26842.328941776417;27156.321091972663;27159;27543.07198496106;27557.75990080431;2721.21084885383;3078.599782028344;3150.1494596459056;3156.573862528552;3172.12766489215;15564.299606517734;15866.12736299503;15884.490973357513;15951.361945522165;16162.78779091561;1687.6118492746737;1861.8510519158435;1905.1712505060343;1913.3112079651314;1916.7891531931477;100900;119325;127492.36253818765;132123;137945.310273449;9888.802223955481;11626.883731162749;11938;11964.282143071443;12098.87901120995;14840.92579537117;14976.70046599062;14978.775318370233;14990.400383984737;14990.62523436901;8758.255548278341;8946.731598052069;8974.28205743539;9004.459732416077;9070.365074444857;8841.513716745512;8846.867296990551;8856.114388561222;8985.281177505783;9022.413543119808;7396.815079622945;7470.402367810562;7537.321641052222;7538.849223015509;7552.773416797505;1661.9169041547875;1944.4847115514401;1949.9567731263705;1986.9701954470695;2003.3989803059023;858.888344515209;864.9481031138151;961.4952150121243;1054.0724162736897;1092.3609688332256;23177.88411057968;23417.41456463602;23496.060157593503;23529;23588.64617030746;1116.1628778416189;1120.551779288275;1141.6517962021662;1159.7622487390233;1161.7095726068483;11773;12254.938725306316;12262.632121036384;12656.303903285409;12718.872811271955;434937;611740;637101;776169;788830;126538;135993.60015999482;143376.56623433842;162622;169864;1026.3226270661328;1069.4866464097122;1087.6247694545368;1088.2056099047738;1094.042712626452;20710;20868.060937257556;20892.686609700562;21229.044692989162;21291.89354053282;63026.68486657537;63159.6842015787;64320.356796433305;64784.67607661932;64804.35195647983;90015.54992224996;92373.5381323116;94539.5273023658;94544;95951;5874.911876321944;6418.550701450854;8416.410851240355;8539.530325832138;8594.957025214833;11014.559417623206;11376.601818936297;13294.933525332312;13371.26458044778;13800.37898294559;11524.366159861289;11575.363355015555;11690.357030363411;11778.705532361759;11892.46483908209;11268.985791278825;11470.770584588428;11565.132615054074;11594;11644.708882278012;11663.708407289885;11724.413779311171;11748.765024699629;11952;12132.818007730068;7383.261673832789;7841.764747057598;8402.201790829862;8784.341174412073;8879.33404994615;10860.891391086305;10881;11001.61494347694;11217.66347009591;11249.606263780728 01:51:55 INFO - PROCESS | 1650 | |3;mootools.html;1433.6129245103816;1439.1437094928515;1454.6363409147714;1455.7743549749787;1469.9338529766162;7683.078030636331;7903.565303908283;8239.505629662217;8673.392862499628;8675.132486751321;8155.388345874068;8395.076541580422;8422.11567785383;8519.148085191478;8530.146985301466;2295.265515035185;2323.372689373868;2324.1284518305633;2328.6507023946374;2334.2530390275033;2315.386422598013;2340.0990618611872;2345.8505332387176;2352.7764862338136;2354.6468029795496;2304.8617082975074;2310.699609050821;2327.94180145496;2335.7664233576675;2338.1232037985756;1803.9729404058949;1853.8424233940132;2027.401916434648;2212.1040978403694;2296.1619009061737;1933.3426634944187;2302.228753367624;2340.7776261255153;2341.356127065054;2347.0259842165483;7486.588237646927;8432.241098301183;8578.099299573518;8586.613602387908;8597.742067737916;5072.5434710875825;5157.200633901752;5203.531682148587;5216.947830521684;5236.476352364771;3321.368939901411;3347.2134048498583;3525.2420729543014;3574.874879379235;3580.964190358089;1205.572021932219;1226.558438961973;1256.3404212788269;1265.6772523006666;1287.594407761552;10933.453327333682;11071.16966227536;11107;11115.99999999992;11123.943225393574;4455.198064348384;4664.113818374498;4680.461746899082;4713.67004309695;4716.716996980193;8229.917700823034;9420;9676.322657414054;9680.951595241979;9698.612055517842;5206.71363075027;5249.763760630781;5258.39528454225;5260.763265652979;5261;4301.139772045603;4311.33174357975;4694.765261736899;4801.18379875415;4852.272159176152;3419.692227699519;3882.5535063468064;3934.586868378779;3954.8220330085214;4006.59934006597;1263.1852455166365;1275.8851703346743;1277.4570807406815;1284.3899147904858;1288.0661520397637;933.1368484152132;941.9826587285852;945.2532499325456;955;969.486172328667;5456.727163641802;5617.494425501643;5622.297212848394;5784.913226301609;5817.534597232211;581.1399129288676;585.4555263604889;591.4499515450672;597.3459062326746;598.9221401217814;3778.131029863147;3781.0925377909653;3825.5026846509777;3840.7695538267794;3916.686665066788;9598.32811703188;10032.548535315782;10132.797344053077;10141.949290253502;10148;9989.350692204984;10053.79892402148;10097.596096156218;10099.091081802673;10143;7826.1391246962785;8021.598920053974;8033.317168040665;8040.67837286502;8042.477238979564;5483.341998960151;5598.21624972496;5621.4659607337235;5652.010898092735;5664.291963504562;9208.861867071866;9296.72109836706;9302.860457093284;9438;9466.2427005838;8973.192412682889;9276.95361523215;9353.485558294358;9360.297977651568;9386.43681379092;6770.5599136056;6968.512204145661;7165.498415110892;7309.342159205697;7442.255774422514;7899.881501777593;8096.797580060545;8147.266745992889;8172.18278172178;8173.100958894635;7215.71137154508;7258.383037441877;7334.3032411920785;7433.739819106306;7454.329110380092;7110.288971102848;7198.136223653195;7202.71189152449;7211.062561866924;7218.89171662436;6423.454006409507;6523.6738163092605;6542.149520562297;6543.411093001652;6550.312217217123;4893.241547560134;4962.597343446058;5020.523050310215;5168.198929165986;5182.32629758129;5031.371078615173;5102.285680004728;5126.256692779601;5150.304708864255;5172.094883395315 01:51:55 INFO - PROCESS | 1650 | |4;prototype.html;306.82204321493526;330.28328527096204;367.6231862341098;378.48148037189054;380.45594799436793;4240.809163587638;4469.888252793682;4924.015196960604;5093.668911520753;5496.972515137424;4955.851324460263;5056.367954005749;5265.236540701596;5307.920381194275;5388.43421440749;3780.35733925232;4065.723195010796;4266.594673506028;4303.935440968372;4310.956890431087;3490.703290220334;3874.9806250968845;3915.6280153385383;4116.238495878272;4326.199653064194;4128.69034822388;4133.1527036957505;4135.669146468275;4153.813078411464;4165.291900376928;3490.4240800267926;3922.3920292354733;4014.959850401488;4119.361498967664;4136.66906647469;3191.930703214403;3586.22896077342;3596.7482276240676;3617;3617.4625784041677;4111.588841115894;4582.518835522255;5141.357330333708;5368.91946620801;5379.928727439925;3863.555691095532;4225.971533663858;4743.1738780569385;4743.478217396084;4779.068081724065;5384.73076346185;5745.913811292834;5754.510866576346;5856.707164641751;5931.792387266425;3081.7364880399155;3784.3566593679143;3813.6186381361917;3848.210037913139;3966.0481484443526;5570.192322113311;5722.167527074083;6132.448079672851;6158.9059719695515;6171.59884607499;3990.341593637075;3991.3214753491975;4019;4030.1939612077704;4039.1517781265675;3335.4329763940186;3856.537215534098;4068.145689405199;4084.223997440477;4090.427340172378;4698.214678422178;4722.716637001791;4744.146053710297;4755.690880092852;4756.738379389167;4969.726665033458;5460.645058071213;5823.242978412779;5914.9112763308585;5923.437273459014;1236.7341021680202;1238.7522495500937;1255.3409460033556;1263.204181365752;1263.570386068741;876.3033388456192;896.3053633434141;896.4442045931564;897.3583887520324;898.285862739124;4906.822362632943;4979.9582171309585;5030.270610761419;5036.992601479718;5246.868828279247;4659.347691323217;5419.756110974937;5779.942200577941;5798.362180160179;5843.5325173985975;5164.354455693038;5180.740962951837;5190.287205222343;5202.7918883245;5203.713795741271;2572.369769406507;2582.522233386792;2587.2923870245922;3003.174127115061;3003.594514740526;4748.957948082289;4853.757312134449;5747.712614369265;5805.88388232233;6029.914615369188;5183.637145399861;5711.116994969325;6235.781747638811;6245.5628106032145;6289.842753931189;5699.800506982236;5720.542356611461;5725.969325521446;5755.453231942959;6279.277883043508;5486.80796172148;5566.749496272759;5754.6547207167705;5987.31145918225;6102.481289090477;5690.544756419559;5909.23179986599;5962.791302304398;6005.939940600713;6029.8191054268445;4914.975425122994;5582.5533957282505;6127.387261273837;6245.500359971101;6252.874942501216;3382.306627141381;3762.6237376262156;3870.5548861881243;4033.6974726896187;4052.2705912935953;5314;5524.403530340734;5650.773969041193;6078.696065196811;6140.109684095871;5453.345598528202;5775.393583673654;5801.6213352525265;5824.504917082096;5848.385919478394;4960.801567937242;5036.862400351694;5515.503604675599;5861.1794348792055;5905.40945905406;5231.215317702375;5314.867128321823;5395.598958463446;5518.626990394169;5753.8561535961935;5576.163575463713;5831.825045248649;5854.970725146347;5887.7056147191615;5899.938011158033;4689.9296510551685;4821.46963833985;5497.862553436196;5718.370979192202;5718.971405143114 01:51:55 INFO - PROCESS | 1650 | |5;yui.html;710.2400431538252;725.927407259274;771.0015529888793;793.234528679824;835.4068611285986;15660.530184094481;15997.120158391313;16252.593685157848;16374.83625163748;16403.343866245352;14551.636209094779;14721.92639036806;14772.778408323857;14781.556553303391;14784.6303842404;680.8604236131581;712.7612249896291;862.3015357560365;879.147227189625;903.6520939438298;759.6239861268652;871.3943809052711;903.2818908967354;910.2035718746097;924.3252425729222;914.3416739947228;961.471190845036;969.3069455339431;969.398972636966;977.3207620703614;964.802215545815;968.9709308720714;969.7866469376726;970.9223262139012;978.1832170137943;677.7119724117231;706.4136766483806;726.4805663950248;727.3671905442299;728.4136270302405;15011.024283421651;15542.989705669208;15543.611409714735;15554.300056497485;15560.844391556053;14263.429462821474;14467;14629.41482340705;14679.266036698229;14737.926310368486;11272.943635281854;11397.886021139848;11485.425728713615;11926.701832454171;12084.274943503418;3756.4553139794575;3780.130569968895;3799.5630502492013;3830.272248272819;3918.0400801803457;112365.43817280943;112575;112651;115036;115368.4231578845;10973.50619222137;11057.557697692002;11101.944490277498;11165.441727913734;11311.038561722182;23151.189708360125;23478.826058696995;23513.88243058808;23532.764672353398;23554.88222558876;7841.764747057598;7899.486533375312;7900.762977110696;7990.360771138295;8089.39329550286;4205.873823785291;4354.129174165179;4361.9749358900635;4443.955560444354;4444.288913773846;3360.7815491993433;3412.4028295048265;3450.585929688403;3450.689437950546;3452.6202117767025;630.2279707358541;634.2325785799143;645.4352441613588;654.5123882707413;660.2440205964144;550.2736387967924;659.3703013622076;677.5663575311804;685.0067402266733;692.1037256752518;9865.06281903218;9866.901330986599;9882.160016398542;9895.752606184902;9961.701148965543;645.7901182115831;655.9245686746085;677.2076670295766;680.8263892707328;687.9621620810904;4781.569658730731;4865.294532292798;4868.707877527359;4875.414950205927;4887;67310;90708.5464572673;98950;113127;113340;80938.59530702309;83390.58304708438;88030;89062.10937890668;100218;74918.6254068737;77633;81238.59380703176;82737;83174.58412708019;10729.517171727135;11157.609483668033;11392.715182120182;11403.771924561297;11404.600838970597;51178.720531987;51329;51338.48661513337;51660.741696291276;52283.215751763;46129;53814.73092634512;64620.415183392135;68874.65562672155;68929;12617.87382126167;12992.5452609162;12992.935035324763;13031.283279419344;13177.472901084233;13818.032737708667;14362.425502979764;14765.557033289018;14826.77759833625;15496.92251538735;13011.934940325238;13334.933325333699;13781.655458613615;14354.856451435351;14458.783118253024;13294.86705132975;13362.324176671937;13690;13733.519326823513;14115.505957291445;13097.869021310045;13223.017514620517;13602.795958060438;13604.319784010562;13908.956828238124;10407.323523970917;10591.99361086172;11439.370834604177;11639.59261425846;12106.031517478405;11138.3873886937;11160.720981975515;11185.832212516656;11254.83117753218;11289.943550282196 01:51:55 INFO - PROCESS | 1650 | __end_tp_report 01:51:55 INFO - PROCESS | 1650 | __start_cc_report 01:51:55 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,375 01:51:55 INFO - PROCESS | 1650 | __end_cc_report 01:51:55 INFO - PROCESS | 1650 | __startTimestamp1485510715980__endTimestamp 01:51:55 INFO - PROCESS | 1650 | 01:51:55 INFO - PROCESS | 1650 | ------- Summary: start ------- 01:51:55 INFO - PROCESS | 1650 | Number of tests: 6 01:51:55 INFO - PROCESS | 1650 | 01:51:55 INFO - PROCESS | 1650 | [#0] dojo.html Cycles:165 Average:5695.93 Median:5972.70 stddev:683.06 (11.4%) stddev-sans-first:654.07 01:51:55 INFO - PROCESS | 1650 | Values: 3099.3 3315.4 3355.4 3358.3 3416.8 5636.1 5649.2 5670.3 5729.5 5742.9 5622.1 5710.0 5714.5 5731.7 5755.4 4480.0 5098.4 5168.6 5229.1 5237.5 5216.1 5277.7 5294.2 5299.7 5304.5 5103.9 5149.4 5206.8 5244.2 5266.1 4011.8 4162.2 5143.7 5191.6 5218.7 5115.8 5152.6 5152.7 5166.7 5239.6 4957.2 5134.7 5584.6 5700.5 5744.1 6103.1 6152.8 6173.0 6216.9 6236.1 6174.2 6193.3 6196.3 6209.3 6210.5 5914.5 5950.5 5953.3 5984.5 6001.0 6114.6 6171.2 6211.7 6223.3 6233.2 6109.7 6151.0 6167.2 6171.7 6174.8 5716.4 6084.9 6200.9 6231.3 6287.4 6054.6 6114.4 6119.1 6144.1 6192.2 6248.2 6259.5 6268.7 6274.6 6290.8 4868.3 4871.7 4886.3 4888.0 4905.5 4319.8 4322.7 4361.4 4375.0 4404.7 5619.6 5690.7 5725.7 5755.2 5759.0 6266.2 6277.8 6292.4 6309.1 6315.6 5642.0 5665.9 5699.5 5705.5 5731.7 5341.9 5368.3 5368.8 5379.4 5398.4 6319.5 6329.7 6336.4 6347.7 6350.7 6126.5 6169.5 6190.3 6265.2 6295.2 6269.7 6294.3 6325.3 6351.3 6365.4 6182.8 6213.7 6214.3 6219.0 6243.1 4864.2 5811.5 6194.8 6203.0 6321.2 6059.9 6121.1 6127.5 6130.0 6174.0 6079.4 6080.4 6125.7 6149.2 6154.3 5862.5 5917.7 5963.4 5982.6 6046.1 5193.7 5481.2 5817.3 6119.7 6153.4 5972.7 6034.1 6034.5 6036.5 6046.8 01:51:55 INFO - PROCESS | 1650 | 01:51:55 INFO - PROCESS | 1650 | [#1] ext.html Cycles:180 Average:70861.82 Median:36110.78 stddev:153983.91 (426.4%) stddev-sans-first:154325.06 01:51:55 INFO - PROCESS | 1650 | Values: 421.3 487.4 489.8 491.9 507.9 36323.8 38278.8 42530.0 42561.6 42570.8 43532.7 44009.8 44060.0 44159.8 44284.6 8602.8 8795.6 9404.0 9629.1 9673.3 11488.7 11788.5 11818.5 11948.1 12003.3 11697.4 11723.8 11782.2 11794.2 11815.6 10377.8 11533.5 11730.3 11802.5 11806.3 11655.8 11663.6 11726.4 11741.8 11750.5 42174.0 42340.0 42448.0 42597.0 42697.6 4026.2 4079.2 4133.2 4152.7 4259.5 30138.4 30163.9 31529.1 31567.4 31791.8 3210.2 3229.7 3339.8 3340.7 3342.8 496663.0 497411.0 498581.0 498854.0 499150.0 68494.3 68544.0 68953.3 68978.7 69116.0 63679.7 71172.0 72527.5 72993.5 73415.6 16742.7 17196.7 17213.9 17256.7 17270.3 11586.1 12197.6 12789.9 13090.7 13202.0 19411.1 19781.3 19953.9 19986.5 20084.8 6713.5 6770.4 6788.8 6795.6 6821.8 770.6 872.0 912.9 927.6 930.6 28921.6 30221.0 30732.2 31414.2 31489.5 1054.0 1069.8 1085.5 1110.2 1182.6 15468.8 15773.1 15852.8 16020.7 16037.4 659231.0 662285.0 662760.0 665998.0 666162.0 55366.6 55641.7 55947.4 55953.7 56252.2 1363.3 1369.7 1387.0 1393.5 1396.2 24778.4 26156.9 28908.0 29797.1 29986.6 46856.8 48419.8 48925.3 49058.5 50108.5 550391.0 554534.0 554990.0 556619.0 559439.0 21828.7 25227.4 25447.1 26058.5 26937.7 42970.8 44086.6 44174.8 44506.8 44612.0 36461.6 36990.8 37145.0 37473.8 38056.4 35787.5 35873.1 36199.5 36643.6 36723.8 34963.5 35369.8 36009.1 36108.6 36112.9 30907.0 32624.0 32705.5 32824.3 33032.7 20738.1 24315.8 24414.4 24542.9 24717.9 01:51:55 INFO - PROCESS | 1650 | 01:51:55 INFO - PROCESS | 1650 | [#2] jquery.html Cycles:180 Average:38510.39 Median:22880.44 stddev:110909.19 (484.7%) stddev-sans-first:111183.38 01:51:55 INFO - PROCESS | 1650 | Values: 386.0 396.7 405.3 405.4 417.8 18705.3 20327.8 20820.9 21538.5 21587.4 21316.6 21449.6 21774.7 21880.7 22583.0 5783.4 6092.4 6094.9 6105.1 6109.3 5638.5 5810.3 5821.0 5948.8 5997.3 5899.7 5904.2 5906.9 5907.1 5922.2 5657.5 5829.3 5868.9 5883.3 5909.4 5223.5 5237.1 5241.6 5255.3 5263.1 26842.3 27156.3 27159.0 27543.1 27557.8 2721.2 3078.6 3150.1 3156.6 3172.1 15564.3 15866.1 15884.5 15951.4 16162.8 1687.6 1861.9 1905.2 1913.3 1916.8 100900.0 119325.0 127492.4 132123.0 137945.3 9888.8 11626.9 11938.0 11964.3 12098.9 14840.9 14976.7 14978.8 14990.4 14990.6 8758.3 8946.7 8974.3 9004.5 9070.4 8841.5 8846.9 8856.1 8985.3 9022.4 7396.8 7470.4 7537.3 7538.8 7552.8 1661.9 1944.5 1950.0 1987.0 2003.4 858.9 864.9 961.5 1054.1 1092.4 23177.9 23417.4 23496.1 23529.0 23588.6 1116.2 1120.6 1141.7 1159.8 1161.7 11773.0 12254.9 12262.6 12656.3 12718.9 434937.0 611740.0 637101.0 776169.0 788830.0 126538.0 135993.6 143376.6 162622.0 169864.0 1026.3 1069.5 1087.6 1088.2 1094.0 20710.0 20868.1 20892.7 21229.0 21291.9 63026.7 63159.7 64320.4 64784.7 64804.4 90015.5 92373.5 94539.5 94544.0 95951.0 5874.9 6418.6 8416.4 8539.5 8595.0 11014.6 11376.6 13294.9 13371.3 13800.4 11524.4 11575.4 11690.4 11778.7 11892.5 11269.0 11470.8 11565.1 11594.0 11644.7 11663.7 11724.4 11748.8 11952.0 12132.8 7383.3 7841.8 8402.2 8784.3 8879.3 10860.9 10881.0 11001.6 11217.7 11249.6 01:51:55 INFO - PROCESS | 1650 | 01:51:55 INFO - PROCESS | 1650 | [#3] mootools.html Cycles:180 Average:5482.61 Median:5205.12 stddev:3015.64 (57.9%) stddev-sans-first:3008.75 01:51:55 INFO - PROCESS | 1650 | Values: 1433.6 1439.1 1454.6 1455.8 1469.9 7683.1 7903.6 8239.5 8673.4 8675.1 8155.4 8395.1 8422.1 8519.1 8530.1 2295.3 2323.4 2324.1 2328.7 2334.3 2315.4 2340.1 2345.9 2352.8 2354.6 2304.9 2310.7 2327.9 2335.8 2338.1 1804.0 1853.8 2027.4 2212.1 2296.2 1933.3 2302.2 2340.8 2341.4 2347.0 7486.6 8432.2 8578.1 8586.6 8597.7 5072.5 5157.2 5203.5 5216.9 5236.5 3321.4 3347.2 3525.2 3574.9 3581.0 1205.6 1226.6 1256.3 1265.7 1287.6 10933.5 11071.2 11107.0 11116.0 11123.9 4455.2 4664.1 4680.5 4713.7 4716.7 8229.9 9420.0 9676.3 9681.0 9698.6 5206.7 5249.8 5258.4 5260.8 5261.0 4301.1 4311.3 4694.8 4801.2 4852.3 3419.7 3882.6 3934.6 3954.8 4006.6 1263.2 1275.9 1277.5 1284.4 1288.1 933.1 942.0 945.3 955.0 969.5 5456.7 5617.5 5622.3 5784.9 5817.5 581.1 585.5 591.4 597.3 598.9 3778.1 3781.1 3825.5 3840.8 3916.7 9598.3 10032.5 10132.8 10141.9 10148.0 9989.4 10053.8 10097.6 10099.1 10143.0 7826.1 8021.6 8033.3 8040.7 8042.5 5483.3 5598.2 5621.5 5652.0 5664.3 9208.9 9296.7 9302.9 9438.0 9466.2 8973.2 9277.0 9353.5 9360.3 9386.4 6770.6 6968.5 7165.5 7309.3 7442.3 7899.9 8096.8 8147.3 8172.2 8173.1 7215.7 7258.4 7334.3 7433.7 7454.3 7110.3 7198.1 7202.7 7211.1 7218.9 6423.5 6523.7 6542.1 6543.4 6550.3 4893.2 4962.6 5020.5 5168.2 5182.3 5031.4 5102.3 5126.3 5150.3 5172.1 01:51:56 INFO - PROCESS | 1650 | 01:51:56 INFO - PROCESS | 1650 | [#4] prototype.html Cycles:180 Average:4604.62 Median:5117.51 stddev:1444.82 (28.2%) stddev-sans-first:1412.40 01:51:56 INFO - PROCESS | 1650 | Values: 306.8 330.3 367.6 378.5 380.5 4240.8 4469.9 4924.0 5093.7 5497.0 4955.9 5056.4 5265.2 5307.9 5388.4 3780.4 4065.7 4266.6 4303.9 4311.0 3490.7 3875.0 3915.6 4116.2 4326.2 4128.7 4133.2 4135.7 4153.8 4165.3 3490.4 3922.4 4015.0 4119.4 4136.7 3191.9 3586.2 3596.7 3617.0 3617.5 4111.6 4582.5 5141.4 5368.9 5379.9 3863.6 4226.0 4743.2 4743.5 4779.1 5384.7 5745.9 5754.5 5856.7 5931.8 3081.7 3784.4 3813.6 3848.2 3966.0 5570.2 5722.2 6132.4 6158.9 6171.6 3990.3 3991.3 4019.0 4030.2 4039.2 3335.4 3856.5 4068.1 4084.2 4090.4 4698.2 4722.7 4744.1 4755.7 4756.7 4969.7 5460.6 5823.2 5914.9 5923.4 1236.7 1238.8 1255.3 1263.2 1263.6 876.3 896.3 896.4 897.4 898.3 4906.8 4980.0 5030.3 5037.0 5246.9 4659.3 5419.8 5779.9 5798.4 5843.5 5164.4 5180.7 5190.3 5202.8 5203.7 2572.4 2582.5 2587.3 3003.2 3003.6 4749.0 4853.8 5747.7 5805.9 6029.9 5183.6 5711.1 6235.8 6245.6 6289.8 5699.8 5720.5 5726.0 5755.5 6279.3 5486.8 5566.7 5754.7 5987.3 6102.5 5690.5 5909.2 5962.8 6005.9 6029.8 4915.0 5582.6 6127.4 6245.5 6252.9 3382.3 3762.6 3870.6 4033.7 4052.3 5314.0 5524.4 5650.8 6078.7 6140.1 5453.3 5775.4 5801.6 5824.5 5848.4 4960.8 5036.9 5515.5 5861.2 5905.4 5231.2 5314.9 5395.6 5518.6 5753.9 5576.2 5831.8 5855.0 5887.7 5899.9 4689.9 4821.5 5497.9 5718.4 5719.0 01:51:56 INFO - PROCESS | 1650 | 01:51:56 INFO - PROCESS | 1650 | [#5] yui.html Cycles:180 Average:20588.74 Median:3814.92 stddev:29531.17 (774.1%) stddev-sans-first:29576.29 01:51:56 INFO - PROCESS | 1650 | Values: 710.2 725.9 771.0 793.2 835.4 15660.5 15997.1 16252.6 16374.8 16403.3 14551.6 14721.9 14772.8 14781.6 14784.6 680.9 712.8 862.3 879.1 903.7 759.6 871.4 903.3 910.2 924.3 914.3 961.5 969.3 969.4 977.3 964.8 969.0 969.8 970.9 978.2 677.7 706.4 726.5 727.4 728.4 15011.0 15543.0 15543.6 15554.3 15560.8 14263.4 14467.0 14629.4 14679.3 14737.9 11272.9 11397.9 11485.4 11926.7 12084.3 3756.5 3780.1 3799.6 3830.3 3918.0 112365.4 112575.0 112651.0 115036.0 115368.4 10973.5 11057.6 11101.9 11165.4 11311.0 23151.2 23478.8 23513.9 23532.8 23554.9 7841.8 7899.5 7900.8 7990.4 8089.4 4205.9 4354.1 4362.0 4444.0 4444.3 3360.8 3412.4 3450.6 3450.7 3452.6 630.2 634.2 645.4 654.5 660.2 550.3 659.4 677.6 685.0 692.1 9865.1 9866.9 9882.2 9895.8 9961.7 645.8 655.9 677.2 680.8 688.0 4781.6 4865.3 4868.7 4875.4 4887.0 67310.0 90708.5 98950.0 113127.0 113340.0 80938.6 83390.6 88030.0 89062.1 100218.0 74918.6 77633.0 81238.6 82737.0 83174.6 10729.5 11157.6 11392.7 11403.8 11404.6 51178.7 51329.0 51338.5 51660.7 52283.2 46129.0 53814.7 64620.4 68874.7 68929.0 12617.9 12992.5 12992.9 13031.3 13177.5 13818.0 14362.4 14765.6 14826.8 15496.9 13011.9 13334.9 13781.7 14354.9 14458.8 13294.9 13362.3 13690.0 13733.5 14115.5 13097.9 13223.0 13602.8 13604.3 13909.0 10407.3 10592.0 11439.4 11639.6 12106.0 11138.4 11160.7 11185.8 11254.8 11289.9 01:51:56 INFO - PROCESS | 1650 | -------- Summary: end -------- 01:51:56 INFO - PROCESS | 1650 | 01:51:56 INFO - TEST-INFO | 1650: exit 0 01:51:56 INFO - TEST-OK | dromaeo_css | took 1114951ms 01:51:56 INFO - TEST-START | kraken 01:51:56 INFO - operating with platform_type : mac_ 01:51:56 INFO - Initialising browser for kraken test... 01:51:56 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/tmp1xzSbz/profile http://localhost:49241/getInfo.html) 01:51:59 INFO - PROCESS | 1657 | 2017-01-27 01:51:59.731 plugin-container[1659:10530] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x893b, name = 'com.apple.tsm.portname' 01:51:59 INFO - PROCESS | 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:51:59 INFO - PROCESS | 1657 | 2017-01-27 01:51:59.732 plugin-container[1659:10530] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a57, name = 'com.apple.CFPasteboardClient' 01:51:59 INFO - PROCESS | 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:51:59 INFO - PROCESS | 1657 | 2017-01-27 01:51:59.732 plugin-container[1659:10530] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 01:51:59 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 01:51:59 INFO - PROCESS | 1657 | colorDepth:24 01:51:59 INFO - PROCESS | 1657 | Browser inner width/height: 1024/663 01:51:59 INFO - PROCESS | 1657 | __metrics 01:51:59 ERROR - PROCESS | 1657 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 01:52:00 INFO - TEST-INFO | 1657: exit 0 01:52:00 INFO - Browser initialized. 01:52:00 INFO - Running cycle 1/1 for kraken test... 01:52:00 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/tmp1xzSbz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:52:03 INFO - PROCESS | 1660 | 2017-01-27 01:52:03.047 plugin-container[1661:10656] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873f, name = 'com.apple.tsm.portname' 01:52:03 INFO - PROCESS | 1660 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:52:03 INFO - PROCESS | 1660 | 2017-01-27 01:52:03.048 plugin-container[1661:10656] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8743, name = 'com.apple.CFPasteboardClient' 01:52:03 INFO - PROCESS | 1660 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:52:03 INFO - PROCESS | 1660 | 2017-01-27 01:52:03.048 plugin-container[1661:10656] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 01:52:12 INFO - PROCESS | 1660 | RSS: Main: 229154816 01:52:12 INFO - PROCESS | 1660 | 01:52:15 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 01:52:16 INFO - PROCESS | 1660 | RSS: Main: 241750016 01:52:16 INFO - PROCESS | 1660 | 01:52:19 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 01:52:19 INFO - PROCESS | 1660 | RSS: Main: 248987648 01:52:19 INFO - PROCESS | 1660 | 01:52:23 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 01:52:24 INFO - PROCESS | 1660 | RSS: Main: 248274944 01:52:24 INFO - PROCESS | 1660 | 01:52:26 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 01:52:26 INFO - PROCESS | 1660 | RSS: Main: 249036800 01:52:26 INFO - PROCESS | 1660 | 01:52:28 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:52:29 INFO - PROCESS | 1660 | RSS: Main: 249896960 01:52:29 INFO - PROCESS | 1660 | 01:52:32 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 01:52:33 INFO - PROCESS | 1660 | RSS: Main: 253284352 01:52:33 INFO - PROCESS | 1660 | 01:52:36 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 01:52:36 INFO - PROCESS | 1660 | RSS: Main: 252448768 01:52:36 INFO - PROCESS | 1660 | 01:52:39 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 01:52:40 INFO - PROCESS | 1660 | RSS: Main: 252317696 01:52:40 INFO - PROCESS | 1660 | 01:52:42 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:52:42 INFO - PROCESS | 1660 | RSS: Main: 251994112 01:52:42 INFO - PROCESS | 1660 | 01:52:44 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:52:45 INFO - PROCESS | 1660 | RSS: Main: 251977728 01:52:45 INFO - PROCESS | 1660 | 01:52:47 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:52:48 INFO - PROCESS | 1660 | RSS: Main: 251879424 01:52:48 INFO - PROCESS | 1660 | 01:52:51 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:52:52 INFO - PROCESS | 1660 | RSS: Main: 252284928 01:52:52 INFO - PROCESS | 1660 | 01:52:55 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:52:55 INFO - PROCESS | 1660 | RSS: Main: 252104704 01:52:55 INFO - PROCESS | 1660 | 01:52:57 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 01:52:57 INFO - PROCESS | 1660 | RSS: Main: 254058496 01:52:57 INFO - PROCESS | 1660 | 01:52:57 INFO - PROCESS | 1660 | __start_tp_report 01:52:57 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 01:52:57 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 01:52:57 INFO - PROCESS | 1660 | |i|pagename|runs| 01:52:57 INFO - PROCESS | 1660 | |0;ai-astar;104;117;116;118;116;116;117;117;117;117 01:52:57 INFO - PROCESS | 1660 | |1;audio-beat-detection;142;111;112;158;140;152;116;118;133;112 01:52:57 INFO - PROCESS | 1660 | |2;audio-dft;267;274;182;276;259;227;217;284;189;271 01:52:57 INFO - PROCESS | 1660 | |3;audio-fft;84;55;65;78;63;82;81;49;82;56 01:52:57 INFO - PROCESS | 1660 | |4;audio-oscillator;90;60;98;93;100;105;114;101;75;80 01:52:57 INFO - PROCESS | 1660 | |5;imaging-gaussian-blur;136;119;88;98;136;107;89;102;105;85 01:52:57 INFO - PROCESS | 1660 | |6;imaging-darkroom;98;107;171;97;97;96;100;98;112;176 01:52:57 INFO - PROCESS | 1660 | |7;imaging-desaturate;93;91;94;93;96;78;147;141;93;96 01:52:57 INFO - PROCESS | 1660 | |8;json-parse-financial;58;57;59;70;95;95;85;93;91;62 01:52:57 INFO - PROCESS | 1660 | |9;json-stringify-tinderbox;68;75;73;73;75;71;69;70;71;73 01:52:57 INFO - PROCESS | 1660 | |10;stanford-crypto-aes;83;110;103;87;84;85;87;84;82;85 01:52:57 INFO - PROCESS | 1660 | |11;stanford-crypto-ccm;148;152;174;151;157;183;153;155;183;175 01:52:57 INFO - PROCESS | 1660 | |12;stanford-crypto-pbkdf2;226;184;166;168;169;167;164;167;194;232 01:52:57 INFO - PROCESS | 1660 | |13;stanford-crypto-sha256-iterative;67;66;67;67;67;67;67;66;69;68 01:52:57 INFO - PROCESS | 1660 | __end_tp_report 01:52:57 INFO - PROCESS | 1660 | __start_cc_report 01:52:57 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,925 01:52:57 INFO - PROCESS | 1660 | __end_cc_report 01:52:57 INFO - PROCESS | 1660 | __startTimestamp1485510777569__endTimestamp 01:52:57 INFO - PROCESS | 1660 | 01:52:57 INFO - PROCESS | 1660 | ------- Summary: start ------- 01:52:57 INFO - PROCESS | 1660 | Number of tests: 14 01:52:57 INFO - PROCESS | 1660 | 01:52:57 INFO - PROCESS | 1660 | [#0] ai-astar Cycles:10 Average:115.50 Median:117.00 stddev:4.09 (3.5%) stddev-sans-first:0.67 01:52:57 INFO - PROCESS | 1660 | Values: 104.0 117.0 116.0 118.0 116.0 116.0 117.0 117.0 117.0 117.0 01:52:57 INFO - PROCESS | 1660 | 01:52:57 INFO - PROCESS | 1660 | [#1] audio-beat-detection Cycles:10 Average:129.40 Median:136.50 stddev:17.85 (13.1%) stddev-sans-first:18.34 01:52:57 INFO - PROCESS | 1660 | Values: 142.0 111.0 112.0 158.0 140.0 152.0 116.0 118.0 133.0 112.0 01:52:57 INFO - PROCESS | 1660 | 01:52:57 INFO - PROCESS | 1660 | [#2] audio-dft Cycles:10 Average:244.60 Median:269.00 stddev:37.85 (14.1%) stddev-sans-first:39.26 01:52:57 INFO - PROCESS | 1660 | Values: 267.0 274.0 182.0 276.0 259.0 227.0 217.0 284.0 189.0 271.0 01:52:57 INFO - PROCESS | 1660 | 01:52:57 INFO - PROCESS | 1660 | [#3] audio-fft Cycles:10 Average:69.50 Median:79.50 stddev:13.34 (16.8%) stddev-sans-first:13.08 01:52:57 INFO - PROCESS | 1660 | Values: 84.0 55.0 65.0 78.0 63.0 82.0 81.0 49.0 82.0 56.0 01:52:57 INFO - PROCESS | 1660 | 01:52:57 INFO - PROCESS | 1660 | [#4] audio-oscillator Cycles:10 Average:91.60 Median:77.50 stddev:15.97 (20.6%) stddev-sans-first:16.92 01:52:57 INFO - PROCESS | 1660 | Values: 90.0 60.0 98.0 93.0 100.0 105.0 114.0 101.0 75.0 80.0 01:52:57 INFO - PROCESS | 1660 | 01:52:57 INFO - PROCESS | 1660 | [#5] imaging-gaussian-blur Cycles:10 Average:106.50 Median:110.50 stddev:18.57 (16.8%) stddev-sans-first:16.34 01:52:57 INFO - PROCESS | 1660 | Values: 136.0 119.0 88.0 98.0 136.0 107.0 89.0 102.0 105.0 85.0 01:52:57 INFO - PROCESS | 1660 | 01:52:57 INFO - PROCESS | 1660 | [#6] imaging-darkroom Cycles:10 Average:115.20 Median:96.50 stddev:31.17 (32.3%) stddev-sans-first:32.43 01:52:57 INFO - PROCESS | 1660 | Values: 98.0 107.0 171.0 97.0 97.0 96.0 100.0 98.0 112.0 176.0 01:52:57 INFO - PROCESS | 1660 | 01:52:57 INFO - PROCESS | 1660 | [#7] imaging-desaturate Cycles:10 Average:102.20 Median:93.00 stddev:22.66 (24.4%) stddev-sans-first:23.79 01:52:57 INFO - PROCESS | 1660 | Values: 93.0 91.0 94.0 93.0 96.0 78.0 147.0 141.0 93.0 96.0 01:52:57 INFO - PROCESS | 1660 | 01:52:57 INFO - PROCESS | 1660 | [#8] json-parse-financial Cycles:10 Average:76.50 Median:88.00 stddev:16.73 (19.0%) stddev-sans-first:16.36 01:52:57 INFO - PROCESS | 1660 | Values: 58.0 57.0 59.0 70.0 95.0 95.0 85.0 93.0 91.0 62.0 01:52:57 INFO - PROCESS | 1660 | 01:52:57 INFO - PROCESS | 1660 | [#9] json-stringify-tinderbox Cycles:10 Average:71.80 Median:73.00 stddev:2.39 (3.3%) stddev-sans-first:2.11 01:52:57 INFO - PROCESS | 1660 | Values: 68.0 75.0 73.0 73.0 75.0 71.0 69.0 70.0 71.0 73.0 01:52:57 INFO - PROCESS | 1660 | 01:52:57 INFO - PROCESS | 1660 | [#10] stanford-crypto-aes Cycles:10 Average:89.00 Median:84.50 stddev:9.50 (11.2%) stddev-sans-first:9.82 01:52:57 INFO - PROCESS | 1660 | Values: 83.0 110.0 103.0 87.0 84.0 85.0 87.0 84.0 82.0 85.0 01:52:57 INFO - PROCESS | 1660 | 01:52:57 INFO - PROCESS | 1660 | [#11] stanford-crypto-ccm Cycles:10 Average:163.10 Median:165.50 stddev:13.96 (8.4%) stddev-sans-first:13.70 01:52:57 INFO - PROCESS | 1660 | Values: 148.0 152.0 174.0 151.0 157.0 183.0 153.0 155.0 183.0 175.0 01:52:57 INFO - PROCESS | 1660 | 01:52:57 INFO - PROCESS | 1660 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.70 Median:176.50 stddev:25.71 (14.6%) stddev-sans-first:22.25 01:52:57 INFO - PROCESS | 1660 | Values: 226.0 184.0 166.0 168.0 169.0 167.0 164.0 167.0 194.0 232.0 01:52:57 INFO - PROCESS | 1660 | 01:52:57 INFO - PROCESS | 1660 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 01:52:57 INFO - PROCESS | 1660 | Values: 67.0 66.0 67.0 67.0 67.0 67.0 67.0 66.0 69.0 68.0 01:52:57 INFO - PROCESS | 1660 | -------- Summary: end -------- 01:52:57 INFO - PROCESS | 1660 | 01:52:58 INFO - TEST-INFO | 1660: exit 0 01:52:58 INFO - TEST-OK | kraken | took 61717ms 01:52:58 INFO - SUITE-END | took 1176s 01:52:58 INFO - Completed test suite (00:19:36) 01:52:58 INFO - javascript benchmark 01:52:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7421.755040542904, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3099.256178517156, 3315.4032274190636, 3355.4295769719147, 3358.2779702363987, 3416.794992300461, 5636.09822428411, 5649.180868774025, 5670.262865827442, 5729.455701708342, 5742.885142297162, 5622.100463925773, 5710.0, 5714.542836573075, 5731.713414329277, 5755.4244575542525, 4479.977600111994, 5098.413682426512, 5168.638195326329, 5229.137192363255, 5237.47625237477, 5216.113260745663, 5277.70972596507, 5294.1529355303155, 5299.735013249341, 5304.49607287309, 5103.9489605103845, 5149.382074151088, 5206.76569554371, 5244.213367994793, 5266.078436273675, 4011.799410029487, 4162.229987452331, 5143.742812859379, 5191.558717509016, 5218.739063046833, 5115.8209462669, 5152.562032227228, 5152.716600586966, 5166.7416629168765, 5239.580833533309, 4957.157283261854, 5134.71632091977, 5584.636998595079, 5700.458456446631, 5744.080947048494, 6103.115048317969, 6152.84617884552, 6173.0, 6216.937830621681, 6236.064590311445, 6174.197354343906, 6193.287771906198, 6196.349383314777, 6209.316975132731, 6210.472109870667, 5914.526837852962, 5950.464458198783, 5953.3451320354725, 5984.521238300882, 6001.0, 6114.631938157225, 6171.228596425447, 6211.689415529206, 6223.253209614875, 6233.2208473940755, 6109.672817243557, 6151.046587778901, 6167.198264225622, 6171.722272497748, 6174.783882564088, 5716.371199168088, 6084.904717150866, 6200.937990620036, 6231.3145553989025, 6287.371262873768, 6054.636721796706, 6114.449440885012, 6119.143319935212, 6144.078388241799, 6192.164057852222, 6248.187735594343, 6259.499240060784, 6268.686565671698, 6274.592151510137, 6290.842728931813, 4868.3427737255015, 4871.732054736953, 4886.340344053508, 4887.95112048882, 4905.460399356068, 4319.784010799447, 4322.7190232634775, 4361.3676016978, 4375.037491751809, 4404.691671582958, 5619.578531610146, 5690.6870122142855, 5725.685087320154, 5755.22304488897, 5759.0, 6266.242853144602, 6277.843053923689, 6292.433680968735, 6309.148264984168, 6315.621062736159, 5642.04085305499, 5665.943340566541, 5699.487046165782, 5705.5435565154685, 5731.713414329267, 5341.866453338697, 5368.32895888014, 5368.785248590091, 5379.381371142291, 5398.433164517748, 6319.462845658079, 6329.7151628175925, 6336.429721325103, 6347.746090156342, 6350.65071421067, 6126.51767379719, 6169.537284703575, 6190.2571691397325, 6265.154204182377, 6295.18162638854, 6269.7178626962805, 6294.276158241861, 6325.272593651789, 6351.2696039956, 6365.395287447685, 6182.783602574068, 6213.689315534296, 6214.25428948529, 6218.968905155445, 6243.094751261133, 4864.185385582376, 5811.476967072984, 6194.81415557534, 6202.968985155226, 6321.1782468278825, 6059.939400605937, 6121.117656725397, 6127.464420129145, 6130.049842274455, 6173.969130154321, 6079.392060793885, 6080.391960803884, 6125.693715314305, 6149.169862068564, 6154.261488621394, 5862.530997520274, 5917.733701983335, 5963.4334738199805, 5982.551308651956, 6046.062860256668, 5193.714345711022, 5481.150421684645, 5817.272840894888, 6119.663418512025, 6153.4154255345675, 5972.701364931823, 6034.064719968412, 6034.547408944259, 6036.456718895321, 6046.788362407295], "value": 5650.743678922035, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [421.275406301162, 487.36155636116666, 489.75757000284864, 491.923751818468, 507.85526125054355, 36323.818380908095, 38278.80860595697, 42530.0, 42561.574384256186, 42570.78714606423, 43532.69401917948, 44009.77995110028, 44060.0, 44159.77920110403, 44284.55715442845, 8602.784930376729, 8795.604197811113, 9404.01257867926, 9629.133377995979, 9673.274504412162, 11488.71278218047, 11788.46951887167, 11818.527258909633, 11948.103892208119, 12003.279803211835, 11697.415129243547, 11723.765524689501, 11782.175247732663, 11794.174407791457, 11815.645530634052, 10377.79244415115, 11533.480993355319, 11730.296182229093, 11802.527898884035, 11806.291622502591, 11655.825162622568, 11663.59177428786, 11726.35505047222, 11741.765164696744, 11750.471228794724, 42174.0, 42340.0, 42448.0, 42597.0, 42697.57302426998, 4026.1545075534173, 4079.1841631673487, 4133.2146892090705, 4152.688548358855, 4259.467566554181, 30138.397232055457, 30163.85599808636, 31529.054128376185, 31567.36865262705, 31791.84104079488, 3210.2295449092285, 3229.7093261606333, 3339.833008349573, 3340.732741380708, 3342.8161451120177, 496663.0, 497411.0, 498581.0, 498854.0, 499149.9999999964, 68494.31505684879, 68543.97184042244, 68953.3104668957, 68978.65510672414, 69116.0, 63679.72640547163, 71172.0, 72527.54944901072, 72993.54012919712, 73415.63292183504, 16742.74885876713, 17196.742048869277, 17213.913930430517, 17256.74114888278, 17270.309187632607, 11586.13104017202, 12197.573084941985, 12789.872101278868, 13090.672733181556, 13202.0, 19411.126499307284, 19781.30765423232, 19953.902535360696, 19986.500337491678, 20084.799152008585, 6713.462922966151, 6770.390664840188, 6788.796336109925, 6795.558288711218, 6821.829454263584, 770.5838847022545, 871.9694810681596, 912.9452232866049, 927.6057675488025, 930.6091441594547, 28921.56617650695, 30221.0, 30732.231694207378, 31414.21464463361, 31489.527657085164, 1053.994730026345, 1069.7593041565585, 1085.4572713643179, 1110.2228440091967, 1182.5979167083233, 15468.767968480483, 15773.05361678303, 15852.76220856688, 16020.67958640844, 16037.438689645807, 659231.0, 662285.0, 662760.0, 665998.0, 666162.0, 55366.615834604454, 55641.721791391596, 55947.44052559504, 55953.72023139858, 56252.15621765677, 1363.3455941148304, 1369.705513314642, 1387.0429403711407, 1393.526201091654, 1396.2250950722243, 24778.380540486633, 26156.869215653798, 28908.0, 29797.10608681743, 29986.55020174743, 46856.7657161712, 48419.757901210265, 48925.2661210075, 49058.50941490539, 50108.49891501039, 550391.0, 554534.0, 554990.0, 556619.0, 559439.0, 21828.672569911145, 25227.369315767253, 25447.10935117262, 26058.478830422908, 26937.73062269352, 42970.78514607407, 44086.55913440824, 44174.779126104164, 44506.777466112464, 44612.0, 36461.63538364582, 36990.815045924595, 37145.0, 37473.81263093667, 38056.42915356327, 35787.46318805272, 35873.103172420895, 36199.457008144374, 36643.63356366402, 36723.816380918994, 34963.47554786629, 35369.82315088408, 36009.0997725059, 36108.63891361053, 36112.91661250166, 30907.0, 32624.0, 32705.509417359233, 32824.34351313008, 33032.66967330296, 20738.066786994925, 24315.756842432056, 24414.389640259134, 24542.877285613456, 24717.87641061783], "value": 20391.86362854273, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.959474255203, 396.6985091330588, 405.33322684184515, 405.4000079881775, 417.7800821600925, 18705.34531291405, 20327.796722032774, 20820.895895520538, 21538.461538461546, 21587.352379428623, 21316.57366852662, 21449.57100857982, 21774.673379899315, 21880.671789923163, 22583.0, 5783.363829978699, 6092.421219984094, 6094.8781024379705, 6105.114758360035, 6109.327973922865, 5638.492535671789, 5810.273715785527, 5821.0, 5948.821535353946, 5997.250343707036, 5899.734511946973, 5904.2029326040865, 5906.911396329058, 5907.113932910076, 5922.230110085683, 5657.51911087556, 5829.329627092896, 5868.911966320508, 5883.29400471944, 5909.438603332676, 5223.503767142153, 5237.109691352441, 5241.554467870235, 5255.264263003182, 5263.131583288753, 26842.328941776417, 27156.321091972663, 27159.0, 27543.07198496106, 27557.75990080431, 2721.21084885383, 3078.599782028344, 3150.1494596459056, 3156.573862528552, 3172.12766489215, 15564.299606517734, 15866.12736299503, 15884.490973357513, 15951.361945522165, 16162.78779091561, 1687.6118492746737, 1861.8510519158435, 1905.1712505060343, 1913.3112079651314, 1916.7891531931477, 100900.0, 119325.0, 127492.36253818765, 132123.0, 137945.310273449, 9888.802223955481, 11626.883731162749, 11938.0, 11964.282143071443, 12098.87901120995, 14840.92579537117, 14976.70046599062, 14978.775318370233, 14990.400383984737, 14990.62523436901, 8758.255548278341, 8946.731598052069, 8974.28205743539, 9004.459732416077, 9070.365074444857, 8841.513716745512, 8846.867296990551, 8856.114388561222, 8985.281177505783, 9022.413543119808, 7396.815079622945, 7470.402367810562, 7537.321641052222, 7538.849223015509, 7552.773416797505, 1661.9169041547875, 1944.4847115514401, 1949.9567731263705, 1986.9701954470695, 2003.3989803059023, 858.888344515209, 864.9481031138151, 961.4952150121243, 1054.0724162736897, 1092.3609688332256, 23177.88411057968, 23417.41456463602, 23496.060157593503, 23529.0, 23588.64617030746, 1116.1628778416189, 1120.551779288275, 1141.6517962021662, 1159.7622487390233, 1161.7095726068483, 11773.0, 12254.938725306316, 12262.632121036384, 12656.303903285409, 12718.872811271955, 434937.0, 611740.0, 637101.0, 776169.0, 788830.0, 126538.0, 135993.60015999482, 143376.56623433842, 162622.0, 169864.0, 1026.3226270661328, 1069.4866464097122, 1087.6247694545368, 1088.2056099047738, 1094.042712626452, 20710.0, 20868.060937257556, 20892.686609700562, 21229.044692989162, 21291.89354053282, 63026.68486657537, 63159.6842015787, 64320.356796433305, 64784.67607661932, 64804.35195647983, 90015.54992224996, 92373.5381323116, 94539.5273023658, 94544.0, 95951.0, 5874.911876321944, 6418.550701450854, 8416.410851240355, 8539.530325832138, 8594.957025214833, 11014.559417623206, 11376.601818936297, 13294.933525332312, 13371.26458044778, 13800.37898294559, 11524.366159861289, 11575.363355015555, 11690.357030363411, 11778.705532361759, 11892.46483908209, 11268.985791278825, 11470.770584588428, 11565.132615054074, 11594.0, 11644.708882278012, 11663.708407289885, 11724.413779311171, 11748.765024699629, 11952.0, 12132.818007730068, 7383.261673832789, 7841.764747057598, 8402.201790829862, 8784.341174412073, 8879.33404994615, 10860.891391086305, 10881.0, 11001.61494347694, 11217.66347009591, 11249.606263780728], "value": 10387.748537851645, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1433.6129245103816, 1439.1437094928515, 1454.6363409147714, 1455.7743549749787, 1469.9338529766162, 7683.078030636331, 7903.565303908283, 8239.505629662217, 8673.392862499628, 8675.132486751321, 8155.388345874068, 8395.076541580422, 8422.11567785383, 8519.148085191478, 8530.146985301466, 2295.265515035185, 2323.372689373868, 2324.1284518305633, 2328.6507023946374, 2334.2530390275033, 2315.386422598013, 2340.0990618611872, 2345.8505332387176, 2352.7764862338136, 2354.6468029795496, 2304.8617082975074, 2310.699609050821, 2327.94180145496, 2335.7664233576675, 2338.1232037985756, 1803.9729404058949, 1853.8424233940132, 2027.401916434648, 2212.1040978403694, 2296.1619009061737, 1933.3426634944187, 2302.228753367624, 2340.7776261255153, 2341.356127065054, 2347.0259842165483, 7486.588237646927, 8432.241098301183, 8578.099299573518, 8586.613602387908, 8597.742067737916, 5072.5434710875825, 5157.200633901752, 5203.531682148587, 5216.947830521684, 5236.476352364771, 3321.368939901411, 3347.2134048498583, 3525.2420729543014, 3574.874879379235, 3580.964190358089, 1205.572021932219, 1226.558438961973, 1256.3404212788269, 1265.6772523006666, 1287.594407761552, 10933.453327333682, 11071.16966227536, 11107.0, 11115.99999999992, 11123.943225393574, 4455.198064348384, 4664.113818374498, 4680.461746899082, 4713.67004309695, 4716.716996980193, 8229.917700823034, 9420.0, 9676.322657414054, 9680.951595241979, 9698.612055517842, 5206.71363075027, 5249.763760630781, 5258.39528454225, 5260.763265652979, 5261.0, 4301.139772045603, 4311.33174357975, 4694.765261736899, 4801.18379875415, 4852.272159176152, 3419.692227699519, 3882.5535063468064, 3934.586868378779, 3954.8220330085214, 4006.59934006597, 1263.1852455166365, 1275.8851703346743, 1277.4570807406815, 1284.3899147904858, 1288.0661520397637, 933.1368484152132, 941.9826587285852, 945.2532499325456, 955.0, 969.486172328667, 5456.727163641802, 5617.494425501643, 5622.297212848394, 5784.913226301609, 5817.534597232211, 581.1399129288676, 585.4555263604889, 591.4499515450672, 597.3459062326746, 598.9221401217814, 3778.131029863147, 3781.0925377909653, 3825.5026846509777, 3840.7695538267794, 3916.686665066788, 9598.32811703188, 10032.548535315782, 10132.797344053077, 10141.949290253502, 10148.0, 9989.350692204984, 10053.79892402148, 10097.596096156218, 10099.091081802673, 10143.0, 7826.1391246962785, 8021.598920053974, 8033.317168040665, 8040.67837286502, 8042.477238979564, 5483.341998960151, 5598.21624972496, 5621.4659607337235, 5652.010898092735, 5664.291963504562, 9208.861867071866, 9296.72109836706, 9302.860457093284, 9438.0, 9466.2427005838, 8973.192412682889, 9276.95361523215, 9353.485558294358, 9360.297977651568, 9386.43681379092, 6770.5599136056, 6968.512204145661, 7165.498415110892, 7309.342159205697, 7442.255774422514, 7899.881501777593, 8096.797580060545, 8147.266745992889, 8172.18278172178, 8173.100958894635, 7215.71137154508, 7258.383037441877, 7334.3032411920785, 7433.739819106306, 7454.329110380092, 7110.288971102848, 7198.136223653195, 7202.71189152449, 7211.062561866924, 7218.89171662436, 6423.454006409507, 6523.6738163092605, 6542.149520562297, 6543.411093001652, 6550.312217217123, 4893.241547560134, 4962.597343446058, 5020.523050310215, 5168.198929165986, 5182.32629758129, 5031.371078615173, 5102.285680004728, 5126.256692779601, 5150.304708864255, 5172.094883395315], "value": 4404.269734208778, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.82204321493526, 330.28328527096204, 367.6231862341098, 378.48148037189054, 380.45594799436793, 4240.809163587638, 4469.888252793682, 4924.015196960604, 5093.668911520753, 5496.972515137424, 4955.851324460263, 5056.367954005749, 5265.236540701596, 5307.920381194275, 5388.43421440749, 3780.35733925232, 4065.723195010796, 4266.594673506028, 4303.935440968372, 4310.956890431087, 3490.703290220334, 3874.9806250968845, 3915.6280153385383, 4116.238495878272, 4326.199653064194, 4128.69034822388, 4133.1527036957505, 4135.669146468275, 4153.813078411464, 4165.291900376928, 3490.4240800267926, 3922.3920292354733, 4014.959850401488, 4119.361498967664, 4136.66906647469, 3191.930703214403, 3586.22896077342, 3596.7482276240676, 3617.0, 3617.4625784041677, 4111.588841115894, 4582.518835522255, 5141.357330333708, 5368.91946620801, 5379.928727439925, 3863.555691095532, 4225.971533663858, 4743.1738780569385, 4743.478217396084, 4779.068081724065, 5384.73076346185, 5745.913811292834, 5754.510866576346, 5856.707164641751, 5931.792387266425, 3081.7364880399155, 3784.3566593679143, 3813.6186381361917, 3848.210037913139, 3966.0481484443526, 5570.192322113311, 5722.167527074083, 6132.448079672851, 6158.9059719695515, 6171.59884607499, 3990.341593637075, 3991.3214753491975, 4019.0, 4030.1939612077704, 4039.1517781265675, 3335.4329763940186, 3856.537215534098, 4068.145689405199, 4084.223997440477, 4090.427340172378, 4698.214678422178, 4722.716637001791, 4744.146053710297, 4755.690880092852, 4756.738379389167, 4969.726665033458, 5460.645058071213, 5823.242978412779, 5914.9112763308585, 5923.437273459014, 1236.7341021680202, 1238.7522495500937, 1255.3409460033556, 1263.204181365752, 1263.570386068741, 876.3033388456192, 896.3053633434141, 896.4442045931564, 897.3583887520324, 898.285862739124, 4906.822362632943, 4979.9582171309585, 5030.270610761419, 5036.992601479718, 5246.868828279247, 4659.347691323217, 5419.756110974937, 5779.942200577941, 5798.362180160179, 5843.5325173985975, 5164.354455693038, 5180.740962951837, 5190.287205222343, 5202.7918883245, 5203.713795741271, 2572.369769406507, 2582.522233386792, 2587.2923870245922, 3003.174127115061, 3003.594514740526, 4748.957948082289, 4853.757312134449, 5747.712614369265, 5805.88388232233, 6029.914615369188, 5183.637145399861, 5711.116994969325, 6235.781747638811, 6245.5628106032145, 6289.842753931189, 5699.800506982236, 5720.542356611461, 5725.969325521446, 5755.453231942959, 6279.277883043508, 5486.80796172148, 5566.749496272759, 5754.6547207167705, 5987.31145918225, 6102.481289090477, 5690.544756419559, 5909.23179986599, 5962.791302304398, 6005.939940600713, 6029.8191054268445, 4914.975425122994, 5582.5533957282505, 6127.387261273837, 6245.500359971101, 6252.874942501216, 3382.306627141381, 3762.6237376262156, 3870.5548861881243, 4033.6974726896187, 4052.2705912935953, 5314.0, 5524.403530340734, 5650.773969041193, 6078.696065196811, 6140.109684095871, 5453.345598528202, 5775.393583673654, 5801.6213352525265, 5824.504917082096, 5848.385919478394, 4960.801567937242, 5036.862400351694, 5515.503604675599, 5861.1794348792055, 5905.40945905406, 5231.215317702375, 5314.867128321823, 5395.598958463446, 5518.626990394169, 5753.8561535961935, 5576.163575463713, 5831.825045248649, 5854.970725146347, 5887.7056147191615, 5899.938011158033, 4689.9296510551685, 4821.46963833985, 5497.862553436196, 5718.370979192202, 5718.971405143114], "value": 4153.777196840046, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.2400431538252, 725.927407259274, 771.0015529888793, 793.234528679824, 835.4068611285986, 15660.530184094481, 15997.120158391313, 16252.593685157848, 16374.83625163748, 16403.343866245352, 14551.636209094779, 14721.92639036806, 14772.778408323857, 14781.556553303391, 14784.6303842404, 680.8604236131581, 712.7612249896291, 862.3015357560365, 879.147227189625, 903.6520939438298, 759.6239861268652, 871.3943809052711, 903.2818908967354, 910.2035718746097, 924.3252425729222, 914.3416739947228, 961.471190845036, 969.3069455339431, 969.398972636966, 977.3207620703614, 964.802215545815, 968.9709308720714, 969.7866469376726, 970.9223262139012, 978.1832170137943, 677.7119724117231, 706.4136766483806, 726.4805663950248, 727.3671905442299, 728.4136270302405, 15011.024283421651, 15542.989705669208, 15543.611409714735, 15554.300056497485, 15560.844391556053, 14263.429462821474, 14467.0, 14629.41482340705, 14679.266036698229, 14737.926310368486, 11272.943635281854, 11397.886021139848, 11485.425728713615, 11926.701832454171, 12084.274943503418, 3756.4553139794575, 3780.130569968895, 3799.5630502492013, 3830.272248272819, 3918.0400801803457, 112365.43817280943, 112575.0, 112651.0, 115036.0, 115368.4231578845, 10973.50619222137, 11057.557697692002, 11101.944490277498, 11165.441727913734, 11311.038561722182, 23151.189708360125, 23478.826058696995, 23513.88243058808, 23532.764672353398, 23554.88222558876, 7841.764747057598, 7899.486533375312, 7900.762977110696, 7990.360771138295, 8089.39329550286, 4205.873823785291, 4354.129174165179, 4361.9749358900635, 4443.955560444354, 4444.288913773846, 3360.7815491993433, 3412.4028295048265, 3450.585929688403, 3450.689437950546, 3452.6202117767025, 630.2279707358541, 634.2325785799143, 645.4352441613588, 654.5123882707413, 660.2440205964144, 550.2736387967924, 659.3703013622076, 677.5663575311804, 685.0067402266733, 692.1037256752518, 9865.06281903218, 9866.901330986599, 9882.160016398542, 9895.752606184902, 9961.701148965543, 645.7901182115831, 655.9245686746085, 677.2076670295766, 680.8263892707328, 687.9621620810904, 4781.569658730731, 4865.294532292798, 4868.707877527359, 4875.414950205927, 4887.0, 67310.0, 90708.5464572673, 98950.0, 113127.0, 113340.0, 80938.59530702309, 83390.58304708438, 88030.0, 89062.10937890668, 100218.0, 74918.6254068737, 77633.0, 81238.59380703176, 82737.0, 83174.58412708019, 10729.517171727135, 11157.609483668033, 11392.715182120182, 11403.771924561297, 11404.600838970597, 51178.720531987, 51329.0, 51338.48661513337, 51660.741696291276, 52283.215751763, 46129.0, 53814.73092634512, 64620.415183392135, 68874.65562672155, 68929.0, 12617.87382126167, 12992.5452609162, 12992.935035324763, 13031.283279419344, 13177.472901084233, 13818.032737708667, 14362.425502979764, 14765.557033289018, 14826.77759833625, 15496.92251538735, 13011.934940325238, 13334.933325333699, 13781.655458613615, 14354.856451435351, 14458.783118253024, 13294.86705132975, 13362.324176671937, 13690.0, 13733.519326823513, 14115.505957291445, 13097.869021310045, 13223.017514620517, 13602.795958060438, 13604.319784010562, 13908.956828238124, 10407.323523970917, 10591.99361086172, 11439.370834604177, 11639.59261425846, 12106.031517478405, 11138.3873886937, 11160.720981975515, 11185.832212516656, 11254.83117753218, 11289.943550282196], "value": 7631.145131182913, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1625.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 117.0, 116.0, 118.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 115.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 111.0, 112.0, 158.0, 140.0, 152.0, 116.0, 118.0, 133.0, 112.0], "value": 129.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [267.0, 274.0, 182.0, 276.0, 259.0, 227.0, 217.0, 284.0, 189.0, 271.0], "value": 244.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 55.0, 65.0, 78.0, 63.0, 82.0, 81.0, 49.0, 82.0, 56.0], "value": 69.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 60.0, 98.0, 93.0, 100.0, 105.0, 114.0, 101.0, 75.0, 80.0], "value": 91.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 119.0, 88.0, 98.0, 136.0, 107.0, 89.0, 102.0, 105.0, 85.0], "value": 106.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 107.0, 171.0, 97.0, 97.0, 96.0, 100.0, 98.0, 112.0, 176.0], "value": 115.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 91.0, 94.0, 93.0, 96.0, 78.0, 147.0, 141.0, 93.0, 96.0], "value": 102.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 59.0, 70.0, 95.0, 95.0, 85.0, 93.0, 91.0, 62.0], "value": 76.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 75.0, 73.0, 73.0, 75.0, 71.0, 69.0, 70.0, 71.0, 73.0], "value": 71.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 110.0, 103.0, 87.0, 84.0, 85.0, 87.0, 84.0, 82.0, 85.0], "value": 89.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 152.0, 174.0, 151.0, 157.0, 183.0, 153.0, 155.0, 183.0, 175.0], "value": 163.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [226.0, 184.0, 166.0, 168.0, 169.0, 167.0, 164.0, 167.0, 194.0, 232.0], "value": 183.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 67.0, 67.0, 67.0, 67.0, 66.0, 69.0, 68.0], "value": 67.1, "unit": "score"}]}]} 01:52:58 INFO - Return code: 0 01:52:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:52:58 ERROR - # TBPL SUCCESS # 01:52:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:52:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:52:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:52:58 INFO - 2017-01-27 01:52:58.888 screenresolution[1665:11048] starting screenresolution argv=screenresolution get 01:52:58 INFO - 2017-01-27 01:52:58.891 screenresolution[1665:11048] Display 0: 1600x1200x32@60 01:52:58 INFO - 2017-01-27 01:52:58.897 screenresolution[1666:11051] starting screenresolution argv=screenresolution list 01:52:58 INFO - Available Modes on Display 0 01:52:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:52:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:52:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:52:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:52:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:52:59 INFO - Intel Iris: 01:52:59 INFO - Chipset Model: Intel Iris 01:52:59 INFO - Type: GPU 01:52:59 INFO - Bus: Built-In 01:52:59 INFO - VRAM (Dynamic, Max): 1536 MB 01:52:59 INFO - Vendor: Intel (0x8086) 01:52:59 INFO - Device ID: 0x0a2e 01:52:59 INFO - Revision ID: 0x0009 01:52:59 INFO - Displays: 01:52:59 INFO - Display: 01:52:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:52:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:52:59 INFO - Display Serial Number: 1600x1200 60 01:52:59 INFO - Main Display: Yes 01:52:59 INFO - Mirror: Off 01:52:59 INFO - Online: Yes 01:52:59 INFO - Rotation: Supported 01:52:59 INFO - Return code: 0 01:52:59 INFO - Running post-action listener: _resource_record_post_action 01:52:59 INFO - [mozharness: 2017-01-27 09:52:59.134318Z] Finished run-tests step (success) 01:52:59 INFO - Running post-run listener: _resource_record_post_run 01:52:59 INFO - Total resource usage - Wall time: 1197s; CPU: 54.0%; Read bytes: 33398784; Write bytes: 510525952; Read time: 320; Write time: 1632 01:52:59 INFO - TinderboxPrint: CPU usage
54.4% 01:52:59 INFO - TinderboxPrint: I/O read bytes / time
33,398,784 / 320 01:52:59 INFO - TinderboxPrint: I/O write bytes / time
510,525,952 / 1,632 01:52:59 INFO - TinderboxPrint: CPU idle
2,184.6 (45.6%) 01:52:59 INFO - TinderboxPrint: CPU system
970.3 (20.3%) 01:52:59 INFO - TinderboxPrint: CPU user
1,634.8 (34.1%) 01:52:59 INFO - TinderboxPrint: Swap in / out
236,797,952 / 0 01:52:59 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 207321600; Write bytes: 201426944; Read time: 16117; Write time: 428 01:52:59 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 31285248; Write bytes: 299067904; Read time: 296; Write time: 1164 01:52:59 INFO - Running post-run listener: _upload_blobber_files 01:52:59 INFO - Blob upload gear active. 01:52:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:52:59 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 01:52:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:52:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:53:00 INFO - (blobuploader) - INFO - Open directory for files ... 01:53:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:53:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:53:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:53:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:53:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:53:00 INFO - (blobuploader) - INFO - Done attempting. 01:53:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:53:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:53:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:53:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:53:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:53:01 INFO - (blobuploader) - INFO - Done attempting. 01:53:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 01:53:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:53:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:53:03 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 01:53:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:53:03 INFO - (blobuploader) - INFO - Done attempting. 01:53:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:53:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:53:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:53:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:53:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:53:05 INFO - (blobuploader) - INFO - Done attempting. 01:53:05 INFO - (blobuploader) - INFO - Iteration through files over. 01:53:05 INFO - Return code: 0 01:53:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:53:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:53:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/87d68ad4166da5dbbbc7d8c4e82305867cd11f46b2b32e6b919ba9e73a21ab8af6eb89693532bb198971a9f05de919124012b3c0e4585d787fac90eebf30e7cd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a5b1b79ac1ad5a0064a4ae820ddc41158c309610adbcb64b325520abaa71ca06e67f83c7a2f80cc78c6d12e44f05e066caff11e9bf6208967953013b557072f9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/584c650f1ebc622eb4d1d17f054dfdc89913f54175ee5a3d8353d07efdac48f07eb3d00cf084ddf5e43d0453dfabaa0ca90575723c3c459e7d3491cb90a73aca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/610b87b3a5ad36e681542eb096cfbcbe8c0d257a86e1eb4308281a993738dab18f8529870389f67581eb625b41220c02af92394a2ed6763ad2b991b7becc01fa"} 01:53:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:53:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:53:05 INFO - Contents: 01:53:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/87d68ad4166da5dbbbc7d8c4e82305867cd11f46b2b32e6b919ba9e73a21ab8af6eb89693532bb198971a9f05de919124012b3c0e4585d787fac90eebf30e7cd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a5b1b79ac1ad5a0064a4ae820ddc41158c309610adbcb64b325520abaa71ca06e67f83c7a2f80cc78c6d12e44f05e066caff11e9bf6208967953013b557072f9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/584c650f1ebc622eb4d1d17f054dfdc89913f54175ee5a3d8353d07efdac48f07eb3d00cf084ddf5e43d0453dfabaa0ca90575723c3c459e7d3491cb90a73aca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/610b87b3a5ad36e681542eb096cfbcbe8c0d257a86e1eb4308281a993738dab18f8529870389f67581eb625b41220c02af92394a2ed6763ad2b991b7becc01fa"} 01:53:05 INFO - Running post-run listener: copy_logs_to_upload_dir 01:53:05 INFO - Copying logs to upload dir... 01:53:05 INFO - mkdir: /builds/slave/test/build/upload/logs 01:53:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.729435 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-01-27 01:53:05.261928) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-27 01:53:05.266078) ========= 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.hSeyTExLMv/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.9mqsH1XaMJ/Listeners TMPDIR=/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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-Aurora/sha512/87d68ad4166da5dbbbc7d8c4e82305867cd11f46b2b32e6b919ba9e73a21ab8af6eb89693532bb198971a9f05de919124012b3c0e4585d787fac90eebf30e7cd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a5b1b79ac1ad5a0064a4ae820ddc41158c309610adbcb64b325520abaa71ca06e67f83c7a2f80cc78c6d12e44f05e066caff11e9bf6208967953013b557072f9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/584c650f1ebc622eb4d1d17f054dfdc89913f54175ee5a3d8353d07efdac48f07eb3d00cf084ddf5e43d0453dfabaa0ca90575723c3c459e7d3491cb90a73aca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/610b87b3a5ad36e681542eb096cfbcbe8c0d257a86e1eb4308281a993738dab18f8529870389f67581eb625b41220c02af92394a2ed6763ad2b991b7becc01fa"} build_url:https://queue.taskcluster.net/v1/task/NLVexwFuRSGVaVbhLuxVLg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010847 build_url: 'https://queue.taskcluster.net/v1/task/NLVexwFuRSGVaVbhLuxVLg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/87d68ad4166da5dbbbc7d8c4e82305867cd11f46b2b32e6b919ba9e73a21ab8af6eb89693532bb198971a9f05de919124012b3c0e4585d787fac90eebf30e7cd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a5b1b79ac1ad5a0064a4ae820ddc41158c309610adbcb64b325520abaa71ca06e67f83c7a2f80cc78c6d12e44f05e066caff11e9bf6208967953013b557072f9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/584c650f1ebc622eb4d1d17f054dfdc89913f54175ee5a3d8353d07efdac48f07eb3d00cf084ddf5e43d0453dfabaa0ca90575723c3c459e7d3491cb90a73aca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/610b87b3a5ad36e681542eb096cfbcbe8c0d257a86e1eb4308281a993738dab18f8529870389f67581eb625b41220c02af92394a2ed6763ad2b991b7becc01fa"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-27 01:53:05.301732) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 01:53:05.302253) ========= 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.hSeyTExLMv/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.9mqsH1XaMJ/Listeners TMPDIR=/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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.005240 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 01:53:05.351968) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-27 01:53:05.352342) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-27 01:53:05.352757) ========= ========= Total master_lag: 0.18 =========