builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0084 starttime: 1488965882.58 results: success (0) buildid: 20170308004020 builduid: f190ad3202b04eb196b0682d427bb5c2 revision: 31cd77685e1c7646b19456fbd3e18ce521208bca ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-08 01:38:02.582859) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-08 01:38:02.583310) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-08 01:38:02.583580) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-08 01:38:02.610815) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 01:38:02.611208) ========= 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.5QFFkAG8Qy/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.TRoPGORKS2/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-08 01:38:02-- 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% 138M=0s 2017-03-08 01:38:02 (138 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.094964 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 01:38:02.730265) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 01:38:02.730576) ========= 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.5QFFkAG8Qy/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.TRoPGORKS2/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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.036703 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 01:38:02.788679) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-08 01:38:02.789040) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 31cd77685e1c7646b19456fbd3e18ce521208bca --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 31cd77685e1c7646b19456fbd3e18ce521208bca --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5QFFkAG8Qy/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.TRoPGORKS2/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-08 01:38:02,889 truncating revision to first 12 chars 2017-03-08 01:38:02,889 Setting DEBUG logging. 2017-03-08 01:38:02,889 attempt 1/10 2017-03-08 01:38:02,889 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/31cd77685e1c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-08 01:38:04,038 unpacking tar archive at: mozilla-aurora-31cd77685e1c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.422299 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-08 01:38:04.234817) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-08 01:38:04.235151) ========= script_repo_revision: 31cd77685e1c7646b19456fbd3e18ce521208bca ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-08 01:38:04.235530) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-08 01:38:04.235807) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-08 01:38:04.256000) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-03-08 01:38:04.256382) ========= /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.5QFFkAG8Qy/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.TRoPGORKS2/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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:38:04 INFO - MultiFileLogger online at 20170308 01:38:04 in /builds/slave/test 01:38:04 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:38:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:38:04 INFO - {'append_to_log': False, 01:38:04 INFO - 'base_work_dir': '/builds/slave/test', 01:38:04 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 01:38:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:38:04 INFO - 'branch': 'Mozilla-Aurora', 01:38:04 INFO - 'buildbot_json_path': 'buildprops.json', 01:38:04 INFO - 'config_files': ('talos/mac_config.py',), 01:38:04 INFO - 'default_actions': ('clobber', 01:38:04 INFO - 'read-buildbot-config', 01:38:04 INFO - 'download-and-extract', 01:38:04 INFO - 'populate-webroot', 01:38:04 INFO - 'create-virtualenv', 01:38:04 INFO - 'install', 01:38:04 INFO - 'run-tests'), 01:38:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:38:04 INFO - 'download_minidump_stackwalk': True, 01:38:04 INFO - 'download_symbols': 'ondemand', 01:38:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:38:04 INFO - 'tooltool.py': '/tools/tooltool.py', 01:38:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:38:04 INFO - '/tools/misc-python/virtualenv.py')}, 01:38:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:38:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:38:04 INFO - 'gecko_profile': False, 01:38:04 INFO - 'gecko_profile_interval': 0, 01:38:04 INFO - 'installer_path': 'installer.exe', 01:38:04 INFO - 'log_level': 'info', 01:38:04 INFO - 'log_name': 'talos', 01:38:04 INFO - 'log_to_console': True, 01:38:04 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:38:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:38:04 INFO - 'opt_config_files': (), 01:38:04 INFO - 'pip_index': False, 01:38:04 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:38:04 INFO - 'cmd': ('bash', 01:38:04 INFO - '-c', 01:38:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:38:04 INFO - 'enabled': True, 01:38:04 INFO - 'halt_on_failure': False, 01:38:04 INFO - 'name': 'check_screen_resolution'},), 01:38:04 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:38:04 INFO - 'cmd': ('bash', 01:38:04 INFO - '-c', 01:38:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:38:04 INFO - 'enabled': True, 01:38:04 INFO - 'halt_on_failure': False, 01:38:04 INFO - 'name': 'check_screen_resolution'},), 01:38:04 INFO - 'run_cmd_checks_enabled': True, 01:38:04 INFO - 'suite': 'dromaeojs-e10s', 01:38:04 INFO - 'system_bits': '32', 01:38:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:38:04 INFO - 'title': 't-yosemite-r7-0084', 01:38:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:38:04 INFO - 'use_talos_json': True, 01:38:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:38:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:38:04 INFO - 'work_dir': 'build'} 01:38:04 INFO - [mozharness: 2017-03-08 09:38:04.466880Z] Running clobber step. 01:38:04 INFO - Running pre-action listener: _resource_record_pre_action 01:38:04 INFO - Running main action method: clobber 01:38:04 INFO - rmtree: /builds/slave/test/build 01:38:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:38:06 INFO - Running post-action listener: _resource_record_post_action 01:38:06 INFO - [mozharness: 2017-03-08 09:38:06.993030Z] Finished clobber step (success) 01:38:06 INFO - [mozharness: 2017-03-08 09:38:06.993158Z] Running read-buildbot-config step. 01:38:06 INFO - Running pre-action listener: _resource_record_pre_action 01:38:06 INFO - Running main action method: read_buildbot_config 01:38:06 INFO - Using buildbot properties: 01:38:06 INFO - { 01:38:06 INFO - "project": "", 01:38:06 INFO - "product": "firefox", 01:38:06 INFO - "script_repo_revision": "production", 01:38:06 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 01:38:06 INFO - "repository": "", 01:38:06 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 01:38:06 INFO - "buildid": "20170308004020", 01:38:06 INFO - "stage_platform": "macosx64", 01:38:06 INFO - "basedir": "/builds/slave/test", 01:38:06 INFO - "nightly_build": "True", 01:38:06 INFO - "buildnumber": 62, 01:38:06 INFO - "slavename": "t-yosemite-r7-0084", 01:38:06 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 01:38:06 INFO - "platform": "yosemite_r7", 01:38:06 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 01:38:06 INFO - "branch": "mozilla-aurora", 01:38:06 INFO - "repo_path": "releases/mozilla-aurora", 01:38:06 INFO - "revision": "31cd77685e1c7646b19456fbd3e18ce521208bca", 01:38:06 INFO - "pgo_build": "False", 01:38:06 INFO - "builduid": "f190ad3202b04eb196b0682d427bb5c2", 01:38:06 INFO - "slavebuilddir": "test" 01:38:06 INFO - } 01:38:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/SZBRaHDJQL6-kXN991bI_Q/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 01:38:06 INFO - Running post-action listener: _resource_record_post_action 01:38:06 INFO - [mozharness: 2017-03-08 09:38:06.996365Z] Finished read-buildbot-config step (success) 01:38:06 INFO - [mozharness: 2017-03-08 09:38:06.996491Z] Running download-and-extract step. 01:38:06 INFO - Running pre-action listener: _resource_record_pre_action 01:38:06 INFO - Running main action method: download_and_extract 01:38:06 INFO - mkdir: /builds/slave/test/build/tests 01:38:06 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:38:06 INFO - trying https://queue.taskcluster.net/v1/task/SZBRaHDJQL6-kXN991bI_Q/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 01:38:06 INFO - Downloading https://queue.taskcluster.net/v1/task/SZBRaHDJQL6-kXN991bI_Q/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 01:38:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SZBRaHDJQL6-kXN991bI_Q/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json'}, attempt #1 01:38:07 INFO - Downloaded 1199 bytes. 01:38:07 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 01:38:07 INFO - Using the following test package requirements: 01:38:07 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 01:38:07 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:38:07 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 01:38:07 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:38:07 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 01:38:07 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:38:07 INFO - u'jsshell-mac.zip'], 01:38:07 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:38:07 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 01:38:07 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 01:38:07 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:38:07 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 01:38:07 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:38:07 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 01:38:07 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:38:07 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 01:38:07 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:38:07 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 01:38:07 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 01:38:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SZBRaHDJQL6-kXN991bI_Q/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 01:38:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SZBRaHDJQL6-kXN991bI_Q/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 01:38:07 INFO - Fetch https://queue.taskcluster.net/v1/task/SZBRaHDJQL6-kXN991bI_Q/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 01:38:09 INFO - Expected file size: 51777499 01:38:09 INFO - Obtained file size: 51777499 01:38:25 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip', u'firefox-54.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 01:38:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SZBRaHDJQL6-kXN991bI_Q/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 01:38:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SZBRaHDJQL6-kXN991bI_Q/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 01:38:25 INFO - Fetch https://queue.taskcluster.net/v1/task/SZBRaHDJQL6-kXN991bI_Q/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 01:38:27 INFO - Expected file size: 51777499 01:38:27 INFO - Obtained file size: 51777499 01:38:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SZBRaHDJQL6-kXN991bI_Q/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 01:38:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SZBRaHDJQL6-kXN991bI_Q/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 01:38:42 INFO - Fetch https://queue.taskcluster.net/v1/task/SZBRaHDJQL6-kXN991bI_Q/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 01:38:43 INFO - Expected file size: 14404424 01:38:43 INFO - Obtained file size: 14404424 01:38:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:38:43 INFO - trying https://queue.taskcluster.net/v1/task/SZBRaHDJQL6-kXN991bI_Q/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 01:38:43 INFO - Downloading https://queue.taskcluster.net/v1/task/SZBRaHDJQL6-kXN991bI_Q/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 01:38:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SZBRaHDJQL6-kXN991bI_Q/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg'}, attempt #1 01:38:45 INFO - Downloaded 74639344 bytes. 01:38:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SZBRaHDJQL6-kXN991bI_Q/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 01:38:45 INFO - mkdir: /builds/slave/test/properties 01:38:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:38:45 INFO - Writing to file /builds/slave/test/properties/build_url 01:38:45 INFO - Contents: 01:38:45 INFO - build_url:https://queue.taskcluster.net/v1/task/SZBRaHDJQL6-kXN991bI_Q/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 01:38:46 INFO - Running post-action listener: _resource_record_post_action 01:38:46 INFO - Running post-action listener: set_extra_try_arguments 01:38:47 INFO - [mozharness: 2017-03-08 09:38:47.000084Z] Finished download-and-extract step (success) 01:38:47 INFO - [mozharness: 2017-03-08 09:38:47.000213Z] Running populate-webroot step. 01:38:47 INFO - Running pre-action listener: _resource_record_pre_action 01:38:47 INFO - Running main action method: populate_webroot 01:38:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:38:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:38:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:38:47 INFO - '--tppagecycles', 01:38:47 INFO - '7'], 01:38:47 INFO - 'tests': ['tsvgm']}}, 01:38:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:38:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:38:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:38:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:38:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:38:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:38:47 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 01:38:47 INFO - 'talos_options': ['--disable-e10s'], 01:38:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:38:47 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 01:38:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:38:47 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 01:38:47 INFO - 'talos_options': ['--disable-e10s'], 01:38:47 INFO - 'tests': ['damp', 'tps']}, 01:38:47 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 01:38:47 INFO - 'tests': ['damp', 'tps']}, 01:38:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:38:47 INFO - 'tests': ['dromaeo_dom']}, 01:38:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:38:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:38:47 INFO - 'tests': ['basic_compositor_video']}, 01:38:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:38:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:38:47 INFO - 'tests': ['a11yr', 01:38:47 INFO - 'ts_paint', 01:38:47 INFO - 'tpaint', 01:38:47 INFO - 'sessionrestore', 01:38:47 INFO - 'sessionrestore_no_auto_restore', 01:38:47 INFO - 'tabpaint']}, 01:38:47 INFO - 'other-e10s': {'tests': ['a11yr', 01:38:47 INFO - 'ts_paint', 01:38:47 INFO - 'tpaint', 01:38:47 INFO - 'sessionrestore', 01:38:47 INFO - 'sessionrestore_no_auto_restore', 01:38:47 INFO - 'tabpaint']}, 01:38:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:38:47 INFO - 'ts_paint', 01:38:47 INFO - 'tpaint', 01:38:47 INFO - 'sessionrestore', 01:38:47 INFO - 'sessionrestore_no_auto_restore', 01:38:47 INFO - 'tabpaint']}, 01:38:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:38:47 INFO - 'ts_paint', 01:38:47 INFO - 'tpaint', 01:38:47 INFO - 'sessionrestore', 01:38:47 INFO - 'sessionrestore_no_auto_restore', 01:38:47 INFO - 'tabpaint']}, 01:38:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:38:47 INFO - 'tests': ['a11yr', 01:38:47 INFO - 'ts_paint', 01:38:47 INFO - 'tpaint', 01:38:47 INFO - 'sessionrestore', 01:38:47 INFO - 'sessionrestore_no_auto_restore', 01:38:47 INFO - 'tabpaint']}, 01:38:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:38:47 INFO - 'tests': ['a11yr', 01:38:47 INFO - 'ts_paint', 01:38:47 INFO - 'tpaint', 01:38:47 INFO - 'sessionrestore', 01:38:47 INFO - 'sessionrestore_no_auto_restore', 01:38:47 INFO - 'tabpaint']}, 01:38:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:38:47 INFO - 'tests': ['tsvgx', 01:38:47 INFO - 'tsvgr_opacity', 01:38:47 INFO - 'tart', 01:38:47 INFO - 'tscrollx', 01:38:47 INFO - 'cart', 01:38:47 INFO - 'tsvg_static']}, 01:38:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:38:47 INFO - 'tsvgr_opacity', 01:38:47 INFO - 'tart', 01:38:47 INFO - 'tscrollx', 01:38:47 INFO - 'cart', 01:38:47 INFO - 'tsvg_static']}, 01:38:47 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 01:38:47 INFO - 'talos_options': ['--disable-e10s'], 01:38:47 INFO - 'tests': ['tp5o']}, 01:38:47 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 01:38:47 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 01:38:47 INFO - 'talos_options': ['--disable-e10s', 01:38:47 INFO - '--xperf_path', 01:38:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:38:47 INFO - 'tests': ['tp5n']}, 01:38:47 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 01:38:47 INFO - 'talos_options': ['--xperf_path', 01:38:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:38:47 INFO - 'tests': ['tp5n']}}, 01:38:47 INFO - 'talos.zip': {'path': '', 01:38:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:38:47 INFO - Running post-action listener: _resource_record_post_action 01:38:47 INFO - [mozharness: 2017-03-08 09:38:47.018729Z] Finished populate-webroot step (success) 01:38:47 INFO - [mozharness: 2017-03-08 09:38:47.018847Z] Running create-virtualenv step. 01:38:47 INFO - Running pre-action listener: _resource_record_pre_action 01:38:47 INFO - Running main action method: create_virtualenv 01:38:47 INFO - Creating virtualenv /builds/slave/test/build/venv 01:38:47 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:38:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:38:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:38:47 INFO - Using real prefix '/tools/python27' 01:38:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:38:47 INFO - Installing distribute.............................................................................................................................................................................................done. 01:38:50 INFO - Installing pip.................done. 01:38:50 INFO - Return code: 0 01:38:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:38:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:38:51 INFO - Reading from file tmpfile_stdout 01:38:51 INFO - Output received: 01:38:51 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:38:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:38:51 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:38:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:38:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:51 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:38:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:38:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:51 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 0x10a118b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a11b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa13c937a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ef6d30>, '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 0x109e1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109eebbe8>, '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.5QFFkAG8Qy/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.TRoPGORKS2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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:38:51 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:38:51 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:38:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5QFFkAG8Qy/Render', 01:38:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:38:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:38:51 INFO - 'HOME': '/Users/cltbld', 01:38:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:38:51 INFO - 'LOGNAME': 'cltbld', 01:38:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:38:51 INFO - 'MOZ_NO_REMOTE': '1', 01:38:51 INFO - 'NO_EM_RESTART': '1', 01:38:51 INFO - 'PAGER': '/bin/cat', 01:38:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:38:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:38:51 INFO - 'PWD': '/builds/slave/test', 01:38:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:38:51 INFO - 'SHELL': '/bin/bash', 01:38:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TRoPGORKS2/Listeners', 01:38:51 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 01:38:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:38:51 INFO - 'USER': 'cltbld', 01:38:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:38:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:38:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:38:51 INFO - 'XPC_FLAGS': '0x0', 01:38:51 INFO - 'XPC_SERVICE_NAME': '0', 01:38:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:38:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:38:51 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:38:51 INFO - Cleaning up... 01:38:51 INFO - Return code: 0 01:38:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:38:51 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:38:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:38:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:51 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:38:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:38:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:51 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 0x10a118b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a11b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa13c937a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ef6d30>, '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 0x109e1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109eebbe8>, '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.5QFFkAG8Qy/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.TRoPGORKS2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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:38:51 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:38:51 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:38:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5QFFkAG8Qy/Render', 01:38:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:38:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:38:51 INFO - 'HOME': '/Users/cltbld', 01:38:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:38:51 INFO - 'LOGNAME': 'cltbld', 01:38:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:38:51 INFO - 'MOZ_NO_REMOTE': '1', 01:38:51 INFO - 'NO_EM_RESTART': '1', 01:38:51 INFO - 'PAGER': '/bin/cat', 01:38:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:38:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:38:51 INFO - 'PWD': '/builds/slave/test', 01:38:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:38:51 INFO - 'SHELL': '/bin/bash', 01:38:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TRoPGORKS2/Listeners', 01:38:51 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 01:38:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:38:51 INFO - 'USER': 'cltbld', 01:38:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:38:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:38:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:38:51 INFO - 'XPC_FLAGS': '0x0', 01:38:51 INFO - 'XPC_SERVICE_NAME': '0', 01:38:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:38:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:38:51 INFO - Downloading/unpacking psutil>=3.1.1 01:38:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:38:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:38:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:38:55 INFO - Installing collected packages: psutil 01:38:55 INFO - Running setup.py install for psutil 01:38:55 INFO - building 'psutil._psutil_osx' extension 01:38:55 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:38:55 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:38:55 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:38:55 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:38:56 INFO - building 'psutil._psutil_posix' extension 01:38:56 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:38:56 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:38:56 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:38:56 INFO - ^ 01:38:56 INFO - 1 warning generated. 01:38:56 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:38:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:38:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:38:56 INFO - Successfully installed psutil 01:38:56 INFO - Cleaning up... 01:38:56 INFO - Return code: 0 01:38:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:38:56 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:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:38:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:56 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:38:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:38:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:56 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 0x10a118b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a11b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa13c937a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ef6d30>, '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 0x109e1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109eebbe8>, '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.5QFFkAG8Qy/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.TRoPGORKS2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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:38:56 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:38:56 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:38:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5QFFkAG8Qy/Render', 01:38:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:38:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:38:56 INFO - 'HOME': '/Users/cltbld', 01:38:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:38:56 INFO - 'LOGNAME': 'cltbld', 01:38:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:38:56 INFO - 'MOZ_NO_REMOTE': '1', 01:38:56 INFO - 'NO_EM_RESTART': '1', 01:38:56 INFO - 'PAGER': '/bin/cat', 01:38:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:38:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:38:56 INFO - 'PWD': '/builds/slave/test', 01:38:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:38:56 INFO - 'SHELL': '/bin/bash', 01:38:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TRoPGORKS2/Listeners', 01:38:56 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 01:38:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:38:56 INFO - 'USER': 'cltbld', 01:38:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:38:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:38:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:38:56 INFO - 'XPC_FLAGS': '0x0', 01:38:56 INFO - 'XPC_SERVICE_NAME': '0', 01:38:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:38:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:38:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:38:56 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:38:56 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:38:56 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:38:56 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:38:56 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:38:56 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:38:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:38:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:38:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:38:59 INFO - Installing collected packages: mozsystemmonitor 01:38:59 INFO - Running setup.py install for mozsystemmonitor 01:38:59 INFO - Successfully installed mozsystemmonitor 01:38:59 INFO - Cleaning up... 01:38:59 INFO - Return code: 0 01:38:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:38:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:38:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:38:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:38:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:39: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a118b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a11b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa13c937a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ef6d30>, '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 0x109e1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109eebbe8>, '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.5QFFkAG8Qy/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.TRoPGORKS2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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:39: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==2.5.1'] in /builds/slave/test/build 01:39: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==2.5.1 01:39:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5QFFkAG8Qy/Render', 01:39:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:39:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:39:00 INFO - 'HOME': '/Users/cltbld', 01:39:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:39:00 INFO - 'LOGNAME': 'cltbld', 01:39:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:39:00 INFO - 'MOZ_NO_REMOTE': '1', 01:39:00 INFO - 'NO_EM_RESTART': '1', 01:39:00 INFO - 'PAGER': '/bin/cat', 01:39:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:39:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:39:00 INFO - 'PWD': '/builds/slave/test', 01:39:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:39:00 INFO - 'SHELL': '/bin/bash', 01:39:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TRoPGORKS2/Listeners', 01:39:00 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 01:39:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:39:00 INFO - 'USER': 'cltbld', 01:39:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:39:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:39:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:39:00 INFO - 'XPC_FLAGS': '0x0', 01:39:00 INFO - 'XPC_SERVICE_NAME': '0', 01:39:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:39:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:39:00 INFO - Downloading/unpacking jsonschema==2.5.1 01:39:00 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:39:00 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:39:00 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:39:00 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:39:00 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:39:00 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:39:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:39:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:39:03 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:39:03 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:39:03 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:39:03 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:39:03 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:39:03 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:39:03 INFO - Downloading functools32-3.2.3-2.tar.gz 01:39:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:39:03 INFO - warning: no files found matching '*.txt' 01:39:03 INFO - no previously-included directories found matching 'build' 01:39:03 INFO - no previously-included directories found matching 'dist' 01:39:03 INFO - no previously-included directories found matching '.git*' 01:39:03 INFO - Installing collected packages: jsonschema, functools32 01:39:03 INFO - Running setup.py install for functools32 01:39:04 INFO - warning: no files found matching '*.txt' 01:39:04 INFO - no previously-included directories found matching 'build' 01:39:04 INFO - no previously-included directories found matching 'dist' 01:39:04 INFO - no previously-included directories found matching '.git*' 01:39:04 INFO - Successfully installed jsonschema functools32 01:39:04 INFO - Cleaning up... 01:39:04 INFO - Return code: 0 01:39:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:39:04 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:39:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:39:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:39:04 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:39:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:39:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:39:04 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 0x10a118b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a11b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa13c937a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ef6d30>, '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 0x109e1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109eebbe8>, '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.5QFFkAG8Qy/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.TRoPGORKS2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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:39:04 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:39:04 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:39:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5QFFkAG8Qy/Render', 01:39:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:39:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:39:04 INFO - 'HOME': '/Users/cltbld', 01:39:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:39:04 INFO - 'LOGNAME': 'cltbld', 01:39:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:39:04 INFO - 'MOZ_NO_REMOTE': '1', 01:39:04 INFO - 'NO_EM_RESTART': '1', 01:39:04 INFO - 'PAGER': '/bin/cat', 01:39:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:39:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:39:04 INFO - 'PWD': '/builds/slave/test', 01:39:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:39:04 INFO - 'SHELL': '/bin/bash', 01:39:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TRoPGORKS2/Listeners', 01:39:04 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 01:39:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:39:04 INFO - 'USER': 'cltbld', 01:39:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:39:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:39:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:39:04 INFO - 'XPC_FLAGS': '0x0', 01:39:04 INFO - 'XPC_SERVICE_NAME': '0', 01:39:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:39:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:39:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:39:04 INFO - Cleaning up... 01:39:04 INFO - Return code: 0 01:39:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:39:04 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:39:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:39:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:39:04 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:39:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:39:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:39:04 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 0x10a118b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a11b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa13c937a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ef6d30>, '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 0x109e1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109eebbe8>, '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.5QFFkAG8Qy/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.TRoPGORKS2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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:39:04 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:39:04 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:39:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5QFFkAG8Qy/Render', 01:39:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:39:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:39:04 INFO - 'HOME': '/Users/cltbld', 01:39:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:39:04 INFO - 'LOGNAME': 'cltbld', 01:39:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:39:04 INFO - 'MOZ_NO_REMOTE': '1', 01:39:04 INFO - 'NO_EM_RESTART': '1', 01:39:04 INFO - 'PAGER': '/bin/cat', 01:39:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:39:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:39:04 INFO - 'PWD': '/builds/slave/test', 01:39:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:39:04 INFO - 'SHELL': '/bin/bash', 01:39:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TRoPGORKS2/Listeners', 01:39:04 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 01:39:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:39:04 INFO - 'USER': 'cltbld', 01:39:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:39:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:39:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:39:04 INFO - 'XPC_FLAGS': '0x0', 01:39:04 INFO - 'XPC_SERVICE_NAME': '0', 01:39:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:39:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:39:04 INFO - Downloading/unpacking blobuploader==1.2.4 01:39:04 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:39:04 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:39:04 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:39:04 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:39:04 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:39:04 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:39:07 INFO - Downloading blobuploader-1.2.4.tar.gz 01:39:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:39:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:39:07 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:39:07 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:39:07 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:39:07 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:39:07 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:39:07 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:39:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:39:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:39:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:39:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:39:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:39:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:39:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:39:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:39:08 INFO - Downloading docopt-0.6.1.tar.gz 01:39:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:39:08 INFO - Installing collected packages: blobuploader, requests, docopt 01:39:08 INFO - Running setup.py install for blobuploader 01:39:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:39:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:39:08 INFO - Running setup.py install for requests 01:39:09 INFO - Running setup.py install for docopt 01:39:09 INFO - Successfully installed blobuploader requests docopt 01:39:09 INFO - Cleaning up... 01:39:09 INFO - Return code: 0 01:39:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:39:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:39:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:39:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:39:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:39:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:39:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:39:09 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 0x10a118b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a11b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa13c937a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ef6d30>, '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 0x109e1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109eebbe8>, '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.5QFFkAG8Qy/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.TRoPGORKS2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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:39:09 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:39:09 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:39:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5QFFkAG8Qy/Render', 01:39:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:39:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:39:09 INFO - 'HOME': '/Users/cltbld', 01:39:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:39:09 INFO - 'LOGNAME': 'cltbld', 01:39:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:39:09 INFO - 'MOZ_NO_REMOTE': '1', 01:39:09 INFO - 'NO_EM_RESTART': '1', 01:39:09 INFO - 'PAGER': '/bin/cat', 01:39:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:39:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:39:09 INFO - 'PWD': '/builds/slave/test', 01:39:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:39:09 INFO - 'SHELL': '/bin/bash', 01:39:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TRoPGORKS2/Listeners', 01:39:09 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 01:39:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:39:09 INFO - 'USER': 'cltbld', 01:39:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:39:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:39:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:39:09 INFO - 'XPC_FLAGS': '0x0', 01:39:09 INFO - 'XPC_SERVICE_NAME': '0', 01:39:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:39:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:39:09 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-MlONsC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:39:09 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-akbUFC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:39:10 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-J1Xjg1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:39:10 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-LsqBFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:39:10 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-549lW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:39:10 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-Jjo3r1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:39:10 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-05ThGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:39:10 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-pFtuiL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:39:10 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-G1qIkI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:39:10 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-vIVlZz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:39:10 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-bDX5B3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:39:10 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-rTfSg0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:39:11 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-n7B6sa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:39:11 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-1RnbPG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:39:11 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-3QO3hd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:39:11 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-Y5Tx6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:39:11 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-oNrfNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:39:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:39:11 INFO - Running setup.py install for manifestparser 01:39:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:39:11 INFO - Running setup.py install for mozcrash 01:39:11 INFO - Running setup.py install for mozdebug 01:39:12 INFO - Running setup.py install for mozdevice 01:39:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:39:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:39:12 INFO - Running setup.py install for mozfile 01:39:12 INFO - Running setup.py install for mozhttpd 01:39:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:39:12 INFO - Running setup.py install for mozinfo 01:39:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:39:12 INFO - Running setup.py install for mozInstall 01:39:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:39:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:39:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:39:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:39:12 INFO - Running setup.py install for mozleak 01:39:12 INFO - Running setup.py install for mozlog 01:39:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:39:13 INFO - Running setup.py install for moznetwork 01:39:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:39:13 INFO - Running setup.py install for mozprocess 01:39:13 INFO - Running setup.py install for mozprofile 01:39:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:39:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:39:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:39:13 INFO - Running setup.py install for mozrunner 01:39:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:39:13 INFO - Running setup.py install for mozscreenshot 01:39:13 INFO - Running setup.py install for moztest 01:39:14 INFO - Running setup.py install for mozversion 01:39:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:39:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:39:14 INFO - Cleaning up... 01:39:14 INFO - Return code: 0 01:39:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:39:14 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:39:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:39:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:39:14 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:39:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:39:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:39:14 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 0x10a118b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a11b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa13c937a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ef6d30>, '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 0x109e1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109eebbe8>, '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.5QFFkAG8Qy/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.TRoPGORKS2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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:39:14 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:39:14 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:39:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5QFFkAG8Qy/Render', 01:39:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:39:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:39:14 INFO - 'HOME': '/Users/cltbld', 01:39:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:39:14 INFO - 'LOGNAME': 'cltbld', 01:39:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:39:14 INFO - 'MOZ_NO_REMOTE': '1', 01:39:14 INFO - 'NO_EM_RESTART': '1', 01:39:14 INFO - 'PAGER': '/bin/cat', 01:39:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:39:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:39:14 INFO - 'PWD': '/builds/slave/test', 01:39:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:39:14 INFO - 'SHELL': '/bin/bash', 01:39:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TRoPGORKS2/Listeners', 01:39:14 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 01:39:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:39:14 INFO - 'USER': 'cltbld', 01:39:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:39:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:39:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:39:14 INFO - 'XPC_FLAGS': '0x0', 01:39:14 INFO - 'XPC_SERVICE_NAME': '0', 01:39:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:39:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:39:14 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-rghpuO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:39:14 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:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:39:14 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-jGelnj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:39:14 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:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:39:14 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-LHthni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:39:14 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:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:39:14 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-uDJakZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:39:14 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:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:39:14 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-fMm_Sr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:39:15 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:39:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:39:15 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-OowODQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:39:15 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:39:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:39:15 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-uJCGX8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:39:15 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:39:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:39:15 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-12f4vc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:39:15 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:39:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:39:15 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-wrRmEP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:39:15 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:39:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:39:15 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-ikATly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:39:15 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:39:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:39:15 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-4kjizk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:39:15 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:39:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:39:15 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-tk_UDl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:39:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 01:39:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:39:15 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-8buwwT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:39:15 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:39:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:39:15 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-0J092z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:39:15 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:39:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:39:15 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-9aCFKd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:39:16 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:39:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:39:16 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-gxuv1Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:39:16 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:39:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:39:16 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-WDJT8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:39:16 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:39:16 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:39:16 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:39:16 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:39:16 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:39:16 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:39:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:39:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:39:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:39:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:39:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:39:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:39:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:39:18 INFO - Downloading blessings-1.6.tar.gz 01:39:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:39:18 INFO - Installing collected packages: blessings 01:39:18 INFO - Running setup.py install for blessings 01:39:19 INFO - Successfully installed blessings 01:39:19 INFO - Cleaning up... 01:39:19 INFO - Return code: 0 01:39:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:39:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:39:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:39:19 INFO - Reading from file tmpfile_stdout 01:39:19 INFO - Current package versions: 01:39:19 INFO - blessings == 1.6 01:39:19 INFO - blobuploader == 1.2.4 01:39:19 INFO - docopt == 0.6.1 01:39:19 INFO - functools32 == 3.2.3-2 01:39:19 INFO - jsonschema == 2.5.1 01:39:19 INFO - manifestparser == 1.1 01:39:19 INFO - mozInstall == 1.12 01:39:19 INFO - mozcrash == 1.0 01:39:19 INFO - mozdebug == 0.1 01:39:19 INFO - mozdevice == 0.49 01:39:19 INFO - mozfile == 1.2 01:39:19 INFO - mozhttpd == 0.7 01:39:19 INFO - mozinfo == 0.9 01:39:19 INFO - mozleak == 0.1 01:39:19 INFO - mozlog == 3.4 01:39:19 INFO - moznetwork == 0.27 01:39:19 INFO - mozprocess == 0.25 01:39:19 INFO - mozprofile == 0.28 01:39:19 INFO - mozrunner == 6.13 01:39:19 INFO - mozscreenshot == 0.1 01:39:19 INFO - mozsystemmonitor == 0.3 01:39:19 INFO - moztest == 0.8 01:39:19 INFO - mozversion == 1.4 01:39:19 INFO - psutil == 3.1.1 01:39:19 INFO - requests == 1.2.3 01:39:19 INFO - wsgiref == 0.1.2 01:39:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:39:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:39:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:39:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:39:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:39:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:39:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:39:19 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 0x10a118b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a11b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa13c937a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ef6d30>, '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 0x109e1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109eebbe8>, '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.5QFFkAG8Qy/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.TRoPGORKS2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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:39:19 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:39:19 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:39:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5QFFkAG8Qy/Render', 01:39:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:39:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:39:19 INFO - 'HOME': '/Users/cltbld', 01:39:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:39:19 INFO - 'LOGNAME': 'cltbld', 01:39:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:39:19 INFO - 'MOZ_NO_REMOTE': '1', 01:39:19 INFO - 'NO_EM_RESTART': '1', 01:39:19 INFO - 'PAGER': '/bin/cat', 01:39:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:39:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:39:19 INFO - 'PWD': '/builds/slave/test', 01:39:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:39:19 INFO - 'SHELL': '/bin/bash', 01:39:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TRoPGORKS2/Listeners', 01:39:19 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 01:39:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:39:19 INFO - 'USER': 'cltbld', 01:39:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:39:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:39:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:39:19 INFO - 'XPC_FLAGS': '0x0', 01:39:19 INFO - 'XPC_SERVICE_NAME': '0', 01:39:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:39:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:39:19 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:39:19 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:39:19 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:39:19 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:39:19 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:39:19 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:39:19 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:39:19 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:39:19 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:39:19 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:39:19 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:39:19 INFO - Cleaning up... 01:39:19 INFO - Return code: 0 01:39:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:39:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:39:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:39:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:39:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:39:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:39:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:39:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a118b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a11b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa13c937a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ef6d30>, '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 0x109e1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109eebbe8>, '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.5QFFkAG8Qy/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.TRoPGORKS2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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:39:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:39:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:39:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5QFFkAG8Qy/Render', 01:39:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:39:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:39:19 INFO - 'HOME': '/Users/cltbld', 01:39:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:39:19 INFO - 'LOGNAME': 'cltbld', 01:39:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:39:19 INFO - 'MOZ_NO_REMOTE': '1', 01:39:19 INFO - 'NO_EM_RESTART': '1', 01:39:19 INFO - 'PAGER': '/bin/cat', 01:39:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:39:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:39:19 INFO - 'PWD': '/builds/slave/test', 01:39:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:39:19 INFO - 'SHELL': '/bin/bash', 01:39:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TRoPGORKS2/Listeners', 01:39:19 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 01:39:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:39:19 INFO - 'USER': 'cltbld', 01:39:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:39:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:39:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:39:19 INFO - 'XPC_FLAGS': '0x0', 01:39:19 INFO - 'XPC_SERVICE_NAME': '0', 01:39:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:39:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:39:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:39:20 INFO - Cleaning up... 01:39:20 INFO - Return code: 0 01:39:20 INFO - Running post-action listener: _resource_record_post_action 01:39:20 INFO - Running post-action listener: _start_resource_monitoring 01:39:20 INFO - Starting resource monitoring. 01:39:20 INFO - [mozharness: 2017-03-08 09:39:20.083950Z] Finished create-virtualenv step (success) 01:39:20 INFO - [mozharness: 2017-03-08 09:39:20.084893Z] Running install step. 01:39:20 INFO - Running pre-action listener: _resource_record_pre_action 01:39:20 INFO - Running main action method: install 01:39:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:39:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:39:20 INFO - Reading from file tmpfile_stdout 01:39:20 INFO - Detecting whether we're running mozinstall >=1.0... 01:39:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:39:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:39:20 INFO - Reading from file tmpfile_stdout 01:39:20 INFO - Output received: 01:39:20 INFO - Usage: mozinstall [options] installer 01:39:20 INFO - Options: 01:39:20 INFO - -h, --help show this help message and exit 01:39:20 INFO - -d DEST, --destination=DEST 01:39:20 INFO - Directory to install application into. [default: 01:39:20 INFO - "/builds/slave/test"] 01:39:20 INFO - --app=APP Application being installed. [default: firefox] 01:39:20 INFO - mkdir: /builds/slave/test/build/application 01:39:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 01:39:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 01:39:40 INFO - Reading from file tmpfile_stdout 01:39:40 INFO - Output received: 01:39:40 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 01:39:40 INFO - Running post-action listener: _resource_record_post_action 01:39:40 INFO - [mozharness: 2017-03-08 09:39:40.637513Z] Finished install step (success) 01:39:40 INFO - [mozharness: 2017-03-08 09:39:40.637660Z] Running run-tests step. 01:39:40 INFO - Running pre-action listener: _resource_record_pre_action 01:39:40 INFO - Running main action method: run_tests 01:39:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:39:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:39:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:39:40 INFO - 2017-03-08 01:39:40.652 screenresolution[1622:7321] starting screenresolution argv=screenresolution get 01:39:40 INFO - 2017-03-08 01:39:40.654 screenresolution[1622:7321] Display 0: 1600x1200x32@60 01:39:40 INFO - 2017-03-08 01:39:40.660 screenresolution[1623:7323] starting screenresolution argv=screenresolution list 01:39:40 INFO - Available Modes on Display 0 01:39:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:39:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:39:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:39:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:39:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:39:40 INFO - Intel Iris: 01:39:40 INFO - Chipset Model: Intel Iris 01:39:40 INFO - Type: GPU 01:39:40 INFO - Bus: Built-In 01:39:40 INFO - VRAM (Dynamic, Max): 1536 MB 01:39:40 INFO - Vendor: Intel (0x8086) 01:39:40 INFO - Device ID: 0x0a2e 01:39:40 INFO - Revision ID: 0x0009 01:39:40 INFO - Displays: 01:39:40 INFO - Display: 01:39:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:39:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:39:40 INFO - Display Serial Number: 1600x1200 60 01:39:40 INFO - Main Display: Yes 01:39:40 INFO - Mirror: Off 01:39:40 INFO - Online: Yes 01:39:40 INFO - Rotation: Supported 01:39:40 INFO - Return code: 0 01:39:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:39:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:39:40 INFO - Python 2.7.3 01:39:40 INFO - Return code: 0 01:39:40 INFO - grabbing minidump binary from tooltool 01:39:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:39:40 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 0x109ef6d30>, '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 0x109e1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109eebbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:39:40 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:39:40 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:39:40 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:39:40 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:39:41 INFO - Return code: 0 01:39:41 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:39:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:39:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:39:41 INFO - ENV: RUST_BACKTRACE is now 1 01:39:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:39:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:39:41 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/SZBRaHDJQL6-kXN991bI_Q/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0084', '--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:39:41 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/SZBRaHDJQL6-kXN991bI_Q/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0084 --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:39:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5QFFkAG8Qy/Render', 01:39:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:39:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:39:41 INFO - 'HOME': '/Users/cltbld', 01:39:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:39:41 INFO - 'LOGNAME': 'cltbld', 01:39:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:39:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:39:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:39:41 INFO - 'MOZ_NO_REMOTE': '1', 01:39:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:39:41 INFO - 'NO_EM_RESTART': '1', 01:39:41 INFO - 'PAGER': '/bin/cat', 01:39:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:39:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:39:41 INFO - 'PWD': '/builds/slave/test', 01:39:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:39:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:39:41 INFO - 'RUST_BACKTRACE': '1', 01:39:41 INFO - 'SHELL': '/bin/bash', 01:39:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TRoPGORKS2/Listeners', 01:39:41 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 01:39:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:39:41 INFO - 'USER': 'cltbld', 01:39:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:39:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:39:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:39:41 INFO - 'XPC_FLAGS': '0x0', 01:39:41 INFO - 'XPC_SERVICE_NAME': '0', 01:39:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:39:41 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/SZBRaHDJQL6-kXN991bI_Q/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0084', '--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:39:41 INFO - mozversion application_buildid: 20170308004020 01:39:41 INFO - mozversion application_changeset: 31cd77685e1c7646b19456fbd3e18ce521208bca 01:39:41 INFO - mozversion application_display_name: FirefoxDeveloperEdition 01:39:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:39:41 INFO - mozversion application_name: Firefox 01:39:41 INFO - mozversion application_remotingname: firefox-dev 01:39:41 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:39:41 INFO - mozversion application_vendor: Mozilla 01:39:41 INFO - mozversion application_version: 54.0a2 01:39:41 INFO - mozversion platform_buildid: 20170308004020 01:39:41 INFO - mozversion platform_changeset: 31cd77685e1c7646b19456fbd3e18ce521208bca 01:39:41 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:39:41 INFO - mozversion platform_version: 54.0a2 01:39:41 INFO - using testdate: 1488965981 01:39:41 INFO - actual date: 1488965981 01:39:41 INFO - starting webserver on 'localhost:49243' 01:39:41 INFO - SUITE-START | Running 2 tests 01:39:41 INFO - TEST-START | dromaeo_css 01:39:41 INFO - operating with platform_type : mac_ 01:39:41 INFO - Initialising browser for dromaeo_css test... 01:39:41 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmp5rRUtc/profile http://localhost:49243/getInfo.html) 01:39:44 INFO - PROCESS | 1633 | 2017-03-08 01:39:44.648 plugin-container[1637:7516] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x934f, name = 'com.apple.tsm.portname' 01:39:44 INFO - PROCESS | 1633 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:39:44 INFO - PROCESS | 1633 | 2017-03-08 01:39:44.649 plugin-container[1637:7516] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x970b, name = 'com.apple.CFPasteboardClient' 01:39:44 INFO - PROCESS | 1633 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:39:44 INFO - PROCESS | 1633 | 2017-03-08 01:39:44.649 plugin-container[1637:7516] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 01:39:44 INFO - PROCESS | 1633 | __metrics Screen width/height:1600/1200 01:39:44 INFO - PROCESS | 1633 | colorDepth:24 01:39:44 INFO - PROCESS | 1633 | Browser inner width/height: 1024/689 01:39:44 INFO - PROCESS | 1633 | __metrics 01:39:44 ERROR - PROCESS | 1633 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 01:39:45 INFO - TEST-INFO | 1633: exit 0 01:39:45 INFO - Browser initialized. 01:39:45 INFO - Running cycle 1/1 for dromaeo_css test... 01:39:45 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmp5rRUtc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:39:48 INFO - PROCESS | 1638 | 2017-03-08 01:39:48.060 plugin-container[1639:7653] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 01:39:48 INFO - PROCESS | 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:39:48 INFO - PROCESS | 1638 | 2017-03-08 01:39:48.061 plugin-container[1639:7653] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 01:39:48 INFO - PROCESS | 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:39:48 INFO - PROCESS | 1638 | 2017-03-08 01:39:48.061 plugin-container[1639:7653] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 01:39:57 INFO - PROCESS | 1638 | RSS: Main: 220684288 01:39:57 INFO - PROCESS | 1638 | 01:43:01 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 01:43:02 INFO - PROCESS | 1638 | RSS: Main: 238280704 01:43:02 INFO - PROCESS | 1638 | 01:44:45 INFO - PROCESS | 1638 | ************************* 01:44:45 INFO - PROCESS | 1638 | A coding exception was thrown and uncaught in a Task. 01:44:45 INFO - PROCESS | 1638 | 01:44:45 ERROR - PROCESS | 1638 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:44:45 INFO - PROCESS | 1638 | Full stack: 01:44:45 INFO - PROCESS | 1638 | ************************* 01:46:05 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 01:46:05 INFO - PROCESS | 1638 | RSS: Main: 249098240 01:46:05 INFO - PROCESS | 1638 | 01:49:08 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 01:49:08 INFO - PROCESS | 1638 | RSS: Main: 255619072 01:49:08 INFO - PROCESS | 1638 | 01:52:10 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 01:52:11 INFO - PROCESS | 1638 | RSS: Main: 251916288 01:52:11 INFO - PROCESS | 1638 | 01:55:14 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 01:55:14 INFO - PROCESS | 1638 | RSS: Main: 256819200 01:55:14 INFO - PROCESS | 1638 | 01:58:18 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 01:58:18 INFO - PROCESS | 1638 | RSS: Main: 253231104 01:58:18 INFO - PROCESS | 1638 | 01:58:18 INFO - PROCESS | 1638 | __start_tp_report 01:58:18 INFO - PROCESS | 1638 | _x_x_mozilla_page_load 01:58:18 INFO - PROCESS | 1638 | _x_x_mozilla_page_load_details 01:58:18 INFO - PROCESS | 1638 | |i|pagename|runs| 01:58:18 INFO - PROCESS | 1638 | |0;dojo.html;2700.257429206968;3251.577294951657;3471.375152472555;3479.61724210337;3492.807895565744;5916.733746981386;6022.819315420534;6066.8483287917825;6082.604630699013;6107.725152368143;6031.638101713889;6041.848953776158;6103.877922441548;6110.297315808683;6116.235470566179;5466.753996070176;5483.835484935458;5503.669779813204;5545.77816887326;5601.271834661488;5562.721863906789;5575.637583557076;5581.413951535092;5611.691356975365;5653.095504719226;5341.519263266306;5385.703786291752;5452.127659574468;5557.555395568365;5569.053260945649;5456.399796022434;5467.617266791326;5501.504864562168;5508.55931525481;5541.0580201365465;5391;5518.889622207534;5530.778768849241;5550.91673624896;5577.498025177753;6012.098185272244;6209.068639704035;6240.594361366497;6241.21984751906;6246.125542424064;6319.8736025279695;6327.810165695037;6347.650879201642;6349.777757778502;6427.453666438359;6485.0596663484;6492.09110724499;6510;6514.706838192245;6529.020646902955;6121.418465245794;6203.751849925952;6223;6243.9999999999545;6266.686665666698;6101.145839582462;6165.67438000823;6270.435660790551;6343.777967771106;6344.968275158687;5289.523942845085;6306.148669929593;6309.495240380758;6328.905066424008;6339.207599050119;6443.323451037667;6468.288488266287;6469.385408386196;6470.352964703586;6475.870482590321;5526.336839579276;6277.623342599459;6339.985602303609;6362.077498762654;6408.871822563616;6290.528210384239;6325.841853953596;6328.873422531524;6330.8100756977365;6349.952257877491;4323.48118225815;4766.404199475066;4991.0766508195375;5127.66670166438;5213.374395072616;4588.898664320539;4596.052415318188;4605.424321959755;4627.5835174833755;4653.697509661861;5823.039198532279;5932.8813423732145;5969.641821490724;6075.1798507200965;6086.756529738849;6289.182406287245;6309.148264984168;6318.557700960889;6329.968350158312;6404.551681382259;5439.075357189287;5544.805931792449;6120.508083830795;6135.2326666699655;6136.733532366159;5676.914846277309;5687.857803554944;5700.714964251853;5712.6286791358425;5721.170430287585;6329.177206963065;6360.713767880364;6540.771073012422;6582.572132811543;6714.0600315954825;6424.807255782334;6479.708413121327;6486.772962946275;6492.448141907991;6505.544611877123;6664.966675166593;6678.465722742266;6701.631410272482;6712.798616041527;6712.93287067123;6204.844878878064;6206.224221972254;6269.247690277196;6275.905861411991;6362.872742545216;6478.0282957554855;6488.870222595616;6496.902546461902;6510.056041873996;6510.3489651034515;6300.495960323072;6305.337939516285;6307.180066591313;6314.084457753508;6338.778142764981;6135.477655820289;6187.133801267916;6235.812925612239;6301.6219026858535;6304.810855674154;6146.862830376394;6228.34602366745;6355.078513615407;6358.237011558643;6375.171227740364;5158.561522270649;5893.6463812171405;6327.746890124344;6336.112944187909;6353.332900045429;6040.184575082483;6043.667598282137;6092.086187071975;6095.725692343766;6262.2172228471445 01:58:18 INFO - PROCESS | 1638 | |1;ext.html;710.282614559295;744.8306159329851;822.1655020154542;931.287565012765;966.5215718219482;32671.67328326716;39108.60891391085;40951.79524102383;41165.79417102918;41214.793926030405;39323.41014884779;39442.21115577694;39517;39581;39592.40611390831;8695.95652021739;8886.289096872235;9063.274938004977;9093.818123637524;9104.226140778042;8919.241864441497;8955.417897836653;9011.54942252888;9024.954875225647;9028.277737780962;9005.009448960609;9030.27757779376;9037.051109633492;9039.141281578273;9043.412178208428;7781.572013539253;8103.837923241532;8917.598708058153;9002.009778924314;9013.639454421815;8761.693340733043;8794.208521233055;8801.339899507562;8836.248918841906;8853.601587928495;34080.48879266813;34310.97067087991;34438.48342274868;34497.13757156066;34812;3733.45864849598;3785;3786.413105968579;3800.5059342285604;3847.6921846252235;25310.86101125454;25358.492830143477;25790.355241118934;26768.59847102295;26855.328616784736;2798;3022.576839242508;3112.6420461646976;3238.3847069056806;3269.395161895033;355016;365940;366255;371738;372567;44431.77784111124;44468.11063778706;44510.33234501485;44551;44556.77721611436;45760.31359529543;46101.53898461039;46326.536734632224;46416;46423.83940401517;13683.31583420825;13758.793618095737;13770;13776.380062897193;13805.861941380457;11869.643910682693;11953.760924781456;11963.521459141537;11965.162438629213;11992.64022079339;11753.236039657395;11948.462319195656;11962.641120766391;12047.397630118634;12071.094667899943;4736.810527578928;4801.5438533339275;4815.3499277597075;5589.882023595297;5632.211490391349;1079.4171147580219;1095.8630171228597;1137.1869113583662;1143.8684551276542;1178.9705257368635;22859.88570057139;24860.840453705237;25901.481970360488;26309.34226644311;26342.73657263441;1035.2390992620417;1084.5878566144972;1249.8126779559454;1278.3735969374939;1284.8991898246247;11927.403629818475;13285.335733213495;13737.519186828413;13873.86126138746;13973.79039314411;523928.38035809575;526238;526390;526935.7306426887;528476;48165;48565.514344856805;48581.271280930814;48741.51258487441;49000.509994900305;1384.9930750346384;1427.5003748688084;1435.727211829728;1435.777454494555;1443.5164219986423;22033.889830551387;24885.253442396755;25183.74816251814;25530.872345638152;25735;40530.594694052685;40748.388774169005;40855;40876.79561602173;40978.5657501986;502674;503794;505484;507906;509506;29358.706412935597;29603.815847365866;38525;38551.03622409462;39660.2067958645;46740.53259467362;47447.76276118597;47498.28752568783;48752.5124748748;49169;37660.62339376571;38387.232255355295;39393.40909886411;40014.79992600018;40793.59206407898;38619;38929.8321050369;39746.60253397429;39929.80035099922;40408.79795601003;38177.809110954266;39430.408543872436;39875.800620996706;39950.60049399469;40335.39496907607;33398.666013339556;35214.823925880206;35520.934371968884;35601.46597801087;35780.28439431249;24288.51422971566;25485.81427321585;26040.34899127537;26207.21378358576;26477.33806654772 01:58:18 INFO - PROCESS | 1638 | |2;jquery.html;413.77862843378796;419.50917426610863;421.5594703534806;433.4776594203984;460.6153861525626;19864.503387415305;20574.588508229826;21206.36380908573;21396.4650883728;21590.24434144805;20291;21105.788942110576;22536.873156342157;22826;22869.199578014774;6483.124778154959;6717.16035495563;6718.66406679664;6730.83172920676;6741.93258067418;6317.715702793385;6521.347865213488;6554.7705830295945;6557.114789503427;6578.901316480256;6500.804975850732;6500.9674951625175;6551.57414768041;6570.901436478457;6580.243272023707;6333.366663333676;6509.772157974448;6517.511186660972;6532.150820393343;6579.17760279965;6364.140840986453;6889;7179.605121718303;7215.855682886366;7219.7473088442175;20672.483187920272;25711.97152113932;25919.35201619956;26243.212703618923;26590.6011409829;2861.6566012078474;2973.108067579739;2978.300099476621;2984.6716861145255;2991.5961345218334;15932.203389830462;16222;16249.756253656205;16443.917780411022;16682.314868455218;2017.9192832286692;2019.6162729081575;2020.2626041494748;2025.4733769220109;2031.5936812637383;144974;146229.2688536561;163400;168331.1583442075;169505;20346.593068138554;21733.565328693338;21899.6860188386;21962.670559941613;21968.231111911326;33802;33906.66093339084;33972.49041264383;34015.489767653504;34035.48946765801;8156.796080097926;8677.479351238946;9967.853696824957;10803.621873234399;10890.346579205274;6783.93216067833;7195.352418282379;7854.764357069297;8848.159424854628;8988.966268879032;9970.351927124859;9977.054474377426;9995.000499949947;10107.58493810867;10130.898691013143;4346.978265108654;4389.3635422864145;4401.449818772653;4412.977935110368;4424.805302568353;993.7316924430363;1015.827309357411;1025.3591505309182;1026.2764750850633;1062.1078294232882;17887.552811179823;20341;20534.486637833874;20658.483537911372;20668.689969650466;1008.5461542305992;1010.4089107871977;1040.958361665525;1041.4844651897208;1042.9843552346722;10143.289969702199;10679.149947986267;10750.139988800876;10754.623588174376;10805.297655652357;748229;749544;755158;777868;778199;134792;142299.28850355683;159960;163912.18043909705;165721;1193.886580774825;1219.5792451604182;1242.3974372429363;1253.091508656217;1261.1172179474222;16678;16937.06846123475;16992.575185619964;18241.817581824012;18380.17289222015;63254.683726581075;63433.04850427155;63986;64496.677516612115;64506.35493645191;87755;88130;89006;89206.55396722975;90369.64445533454;11130.666080017612;11395.088392928712;11519.078473721915;11556.075513959031;11821.82267266009;12309.076819238771;12453.75092498163;12729.681757956125;12767.744645107232;12876.163049401759;11050.06074483678;11139.665810025712;11319.603813866475;11424.086073114297;11645.359505227294;9479.57806329056;11003.944980275048;11050.33697978124;11357.4889129991;11399.829002565135;9769.462679552693;11287.097032237565;11512.654620361403;11791.941040294743;11815.82276265874;11342.262752921033;11492.770144597229;11715.062794976551;11791;11954.043676506033;10121.998663301632;11045.447727613748;11072.446377680923;11167.664970050912;11514.30914145154 01:58:18 INFO - PROCESS | 1638 | |3;mootools.html;1517.3020410611118;1557.548310989813;1571.1594297051072;1583.8653714434272;1588.0074953154276;10875.83686244706;11377.544898204083;11586.478608462618;11612.24520406173;11621.418929053545;11405.20163588549;11563;11614.303141811497;11621.244619099774;11663.241889277213;2437.4028363051034;2469.172827102923;2469.7036355637347;2471.505698860226;2471.6292556116546;2411.710594728635;2445.58425067738;2445.608702607583;2449.326435230317;2456.815738819587;2393.904243830245;2427.368884090132;2432.914847980321;2434.7200071991683;2445.3886528367907;2332.346942856003;2344.1443872986324;2353.305774796439;2359.6696462495265;2364.7044119484976;2325.720913490392;2329.045091512489;2377.4531857672832;2385.9761402386102;2401.2436082633913;11360.886391136066;11433.142514311377;11445.313281203154;11451.484683189277;11465.541378344857;5417.970585588726;5862.50168735658;5934.37689042653;6010.609310394811;6151.969240153815;3628.8911332660064;3694.9261014779554;3726.720495962814;3761.4357846322996;3780.584135745066;1036.5180191211048;1196.9820452693216;1224.412282104586;1237.962861114168;1269.1877198592908;11623.59317423886;14253.572392828128;14892.99999999989;15546.911716179871;15618.687626247525;4782.569568738831;4853.150698627726;4876.097921884463;4881.316615673809;4881.585065269492;11867.109966752529;11917.284962902253;11920.52317907274;11920.642380728592;11930.701732456759;4842.782074806642;5598.356189038313;5610.214569960209;5619.494245517923;5635.351934527582;5206.921896171561;5395.973020134874;5416.91874621881;5429.484199001088;5436.972815135899;3960.4825170074896;4030.717849750548;4065.8170382332864;4123.546409894909;4129.545749967501;1089.8310761831929;1091.1816137896578;1097.204526718123;1097.9231453798318;1100.9284396514201;825.636719843279;837.4723923928008;848.8599381102049;860.6729442811817;869.7086476030474;4842.370491836039;5109.904938975003;5212.687238765686;5414.187871819258;5434.864128396743;847.2417186617943;990.0792263195153;992.6376872441507;995.2933417273672;1009.1775203209361;3974.940375894364;4032.7781971991235;4073.135589009823;4130.607592278729;4183.372494125905;13560.660983475493;13889.722205555832;13991.160530368006;14004.649883752987;14042.36809343582;13844.861551384558;13882.305884705724;14010.719785604435;14021.298935053206;14056;10013.599456021822;10156.695299141038;10265.435401053013;10355.689329319981;10370.377777333384;6353.777617783356;6379.457746091449;6412.807615771534;6423.678816059271;6562.376574225441;12401.565945191875;12452.81320780171;12619.747605047663;12622.810657840324;12808.231506109663;11515.021223196121;11903.285802851857;12345.876541234473;12775.80836287475;13026.869731302566;9225.446473211628;9504;9527.761805954906;9647.469389183661;9653.276004299565;8744.387892847439;10463.529141188512;10468.528916198637;10566.31318964265;10566.8414973777;9374.531273436165;9388.718338449857;9405.952970235105;9611.231101511723;9630.085141911508;9191.172794448532;9226.815463690822;9240.722778316662;9308.906910930804;9361.017093205115;6603.537752357289;8005.359571234404;8011.919880801117;8019.959900200462;8035.357171426155;5739.540836732968;5771.971140144273;5785.623934444247;5951.523878089829;6018.939810601838;5871.7651293947765;5961.195238642727;6002.459778619946;6080.452759251689;6149.108379284889 01:58:18 INFO - PROCESS | 1638 | |4;prototype.html;316.96830316968294;324.655924472683;373.98878033658985;397.45151690666876;401.04951265500756;5088.338515992916;5139.280500729901;5400.864978375537;5428.267183930168;5494.642848214873;4128.318827393477;4597.5402459754005;4644.651651126171;4826.2519309507;4849.448176583494;3899.1146551551788;4032.899177520556;4128.174365126972;4388.6050255477;4436.889077773049;4169.60388763067;4413.360062790894;4425.867223983286;4460.502118813475;4461.509233984275;3544.5923718772415;3966.093398002965;4515.548445155491;4561.7491037992895;4628.583427491525;3832.616738326173;4000.799960002003;4400.9559904401185;4603.9769801151115;4613.700109492872;3740.971232910944;3910.7485604606536;3931.606839316074;4396.724949764564;4455.44059579148;4946.678465899741;5063.746812659352;5093.388793344822;5100.69932167295;5130.486951304877;4609.861704148847;4679.27471241958;4785.712857228577;4851.902961940777;5387;5199.766010529535;5506.724663766796;5603.579731520153;5631.380548139701;5726.5418766499;3808.6762625176616;4395.384646149541;4860.198067318888;4959.82640607577;5015.749212539395;5301.693763213015;5392.514673679388;5743.16724075011;6073.483753880925;6103.786367477117;4219.409282700424;4624.930626040612;4684.133435314409;4942.505749425029;5002.799328161288;5085.262636917626;5086.516780905808;5091.770870310845;5131.794728210904;5156.432792392834;4280.89297767552;4551.40831691878;5092.6435149539175;5343.332083489564;5458.506555804289;5117.820876269313;5199.388189661217;5556.749946252428;5573.247611572467;5727.284089488814;1504.8946573739952;1564.5853848730096;1614.5802091456071;1738.2699266308182;1751.5796208910024;1178.7878181927335;1289.1362786932777;1301.264785396248;1307.457405176841;1341.4768240386256;4491.595756381941;4882.853514394574;4888.364512613338;5067.756635753121;5263.789208532426;5079.6698214615935;5733.655980641175;5800.50695690871;5846.532277417797;5909.763609455659;4459.955400446019;4775.21209000511;5063.835611081772;5162.845114646567;5261.447548007481;2476.798752604985;2544.3257536752776;3024.7277745003057;3029.5910052143117;3066.4633689104317;5598.440155984369;5664;5955.686971809895;6092.268927728701;6135.5398345124295;5182.663126896739;5617.831465056055;5888.705564721747;5998.920194365056;6078.574499785061;5346.1980702893325;6057.666828324484;6097.932861749265;6207.534434917399;6241.843953901189;4799.952000479951;5568.721563921868;5679.233303504139;5817.970910145422;5835.620684655484;5596.524295434933;5816.883662326645;5843.590948633725;5856.531477481876;5869.236999190078;5295.841124766263;5797;5980.671063091571;6079.392060793885;6157.9384206157365;4203;4291.206126866539;4643.930341044819;4699.953000469952;4709.952900470951;5472.5621950243085;5729.312482502127;5772.163036359789;5846.473817356458;5893.734781934909;5423.701696406735;5457.881134367524;5500.532454741392;5590.2453168821685;5615.129654903497;5058.482455263333;5097.661032024031;5457.26177568367;5638.126090455986;5661.858453538694;4983.43627037139;5114.539691427789;5288.8413347599635;5440.80302333486;5528.695921724344;4880.023590445875;5452.963936852144;5513.669179849222;5617.578681598815;5659.547236221175;4330.17726631939;4627.400844977615;5310.920336195038;5375.59683023767;5626.902753962938 01:58:18 INFO - PROCESS | 1638 | |5;yui.html;713.2653367031959;722.8482018776057;748.9662965166568;774.0711146624053;819.8070162315804;15247.542573722792;16104.838951610494;16117.597060073504;16119.194040297967;16321.673566528678;14857.257137143126;15068.47260345888;15073.321700523475;15093.169875656835;15996.680066398665;661.3750006244102;679.952403331767;927.9072092790701;930.5347326336831;953.9046095390474;949.4350861237588;955.0878910640322;961.3895176562897;965.8696076029717;968.3028219681818;1000.4297550396277;1020.7346090016575;1020.8162530744463;1022.8874823769379;1023.6980090873174;1012.6810054832704;1014.3204053284318;1014.8274793285123;1015.0610685116275;1016.7508960304699;749.6701451361383;755.3692666623376;756.2362014365531;756.4251169111515;757.2730179028084;16338.918305408515;16389.754153687703;16390.918045409817;16863.747043794352;17072.146392680315;13921.095128816696;13924.791128133085;13973.510927117502;13974.720505589832;14253.78619320711;11709.94145029278;11859.703507412298;11872.406379681068;11879.524819007229;11914.821277680841;3592.9281414371826;3638.6907112895437;3678.834452449646;3692.187718701908;3832.616738326145;105684.94315056827;108240.91759082387;109225.36161957576;109989;110659;10216.233782466195;10468.52891619879;10520.947395263127;10526.894731052591;10608.522616482276;22897.88551057234;22952;22990.310290691305;23076;23404.7659523406;7531.096268447822;7533.2466753325325;7604.315611594983;7629.131406674215;7733.304002639677;3572.8928132156075;4261.062566235423;4322.212173148365;4358.738475691469;4419.867403977822;3392.5928888533535;3443.2252743133095;3443.7589368744448;3454.1191996040848;3482.3035392921515;515.6725479320584;609.8597322615734;622.2532960447481;623.6663385089047;638.5944924972675;542.940276569577;666.3236814633151;668.5286872754697;675.7330854312519;681.8374671185617;9681.080297371738;9784.412935223767;9842.917279099293;9933.403995760278;9937.45344006072;631.7630888416844;653.506602515098;661.6559389117632;664.3821246241042;664.8703502816904;4642.65180111493;4794.736289504111;4819.927701084486;4824.8793780155775;4843.709377437365;94224.05775942153;110972;111431;111538;111594;75438.81575987281;77339;80409.19590804134;93232.53383733038;95382;84121;84577.57711211282;85251.57374213214;86164;88025;7447;8849.69026084084;9228.769280768034;9279.489628070522;9367.907624925561;46104.538954611366;47284;51599;51730.74134629303;54114.458855412515;54169;68863.65568172127;70590.64704676444;73284;74663.62668186841;12336.136470446983;12680.11239213283;12939.223646581235;12998.805017924928;13011.414486348327;14566.854331456974;14720.043197192148;14976.625584360043;15321.923390382977;15479.84520154784;12349.32078735678;12355.62933112008;13088.607341779762;13268.734625307632;13579.720210338406;13217.603471895858;13750.037497375088;13790.586282411543;14157.36291866848;14398.568042958728;12186.57346992851;12578.30819304947;12873.163244389085;12977.870221297666;13124;9825.263105266991;11276;11310.967460922602;11449.084073274285;11677.240979336317;10026.047525485068;10082.99170083015;10795.244332896622;10812.729681758019;10834.729131771768 01:58:18 INFO - PROCESS | 1638 | __end_tp_report 01:58:18 INFO - PROCESS | 1638 | __start_cc_report 01:58:18 INFO - PROCESS | 1638 | _x_x_mozilla_cycle_collect,413 01:58:18 INFO - PROCESS | 1638 | __end_cc_report 01:58:18 INFO - PROCESS | 1638 | __startTimestamp1488967098282__endTimestamp 01:58:18 INFO - PROCESS | 1638 | 01:58:18 INFO - PROCESS | 1638 | ------- Summary: start ------- 01:58:18 INFO - PROCESS | 1638 | Number of tests: 6 01:58:18 INFO - PROCESS | 1638 | 01:58:18 INFO - PROCESS | 1638 | [#0] dojo.html Cycles:165 Average:5950.35 Median:6206.22 stddev:680.60 (11.0%) stddev-sans-first:633.14 01:58:18 INFO - PROCESS | 1638 | Values: 2700.3 3251.6 3471.4 3479.6 3492.8 5916.7 6022.8 6066.8 6082.6 6107.7 6031.6 6041.8 6103.9 6110.3 6116.2 5466.8 5483.8 5503.7 5545.8 5601.3 5562.7 5575.6 5581.4 5611.7 5653.1 5341.5 5385.7 5452.1 5557.6 5569.1 5456.4 5467.6 5501.5 5508.6 5541.1 5391.0 5518.9 5530.8 5550.9 5577.5 6012.1 6209.1 6240.6 6241.2 6246.1 6319.9 6327.8 6347.7 6349.8 6427.5 6485.1 6492.1 6510.0 6514.7 6529.0 6121.4 6203.8 6223.0 6244.0 6266.7 6101.1 6165.7 6270.4 6343.8 6345.0 5289.5 6306.1 6309.5 6328.9 6339.2 6443.3 6468.3 6469.4 6470.4 6475.9 5526.3 6277.6 6340.0 6362.1 6408.9 6290.5 6325.8 6328.9 6330.8 6350.0 4323.5 4766.4 4991.1 5127.7 5213.4 4588.9 4596.1 4605.4 4627.6 4653.7 5823.0 5932.9 5969.6 6075.2 6086.8 6289.2 6309.1 6318.6 6330.0 6404.6 5439.1 5544.8 6120.5 6135.2 6136.7 5676.9 5687.9 5700.7 5712.6 5721.2 6329.2 6360.7 6540.8 6582.6 6714.1 6424.8 6479.7 6486.8 6492.4 6505.5 6665.0 6678.5 6701.6 6712.8 6712.9 6204.8 6206.2 6269.2 6275.9 6362.9 6478.0 6488.9 6496.9 6510.1 6510.3 6300.5 6305.3 6307.2 6314.1 6338.8 6135.5 6187.1 6235.8 6301.6 6304.8 6146.9 6228.3 6355.1 6358.2 6375.2 5158.6 5893.6 6327.7 6336.1 6353.3 6040.2 6043.7 6092.1 6095.7 6262.2 01:58:18 INFO - PROCESS | 1638 | 01:58:18 INFO - PROCESS | 1638 | [#1] ext.html Cycles:180 Average:59492.29 Median:39216.01 stddev:125668.89 (320.5%) stddev-sans-first:125943.93 01:58:18 INFO - PROCESS | 1638 | Values: 710.3 744.8 822.2 931.3 966.5 32671.7 39108.6 40951.8 41165.8 41214.8 39323.4 39442.2 39517.0 39581.0 39592.4 8696.0 8886.3 9063.3 9093.8 9104.2 8919.2 8955.4 9011.5 9025.0 9028.3 9005.0 9030.3 9037.1 9039.1 9043.4 7781.6 8103.8 8917.6 9002.0 9013.6 8761.7 8794.2 8801.3 8836.2 8853.6 34080.5 34311.0 34438.5 34497.1 34812.0 3733.5 3785.0 3786.4 3800.5 3847.7 25310.9 25358.5 25790.4 26768.6 26855.3 2798.0 3022.6 3112.6 3238.4 3269.4 355016.0 365940.0 366255.0 371738.0 372567.0 44431.8 44468.1 44510.3 44551.0 44556.8 45760.3 46101.5 46326.5 46416.0 46423.8 13683.3 13758.8 13770.0 13776.4 13805.9 11869.6 11953.8 11963.5 11965.2 11992.6 11753.2 11948.5 11962.6 12047.4 12071.1 4736.8 4801.5 4815.3 5589.9 5632.2 1079.4 1095.9 1137.2 1143.9 1179.0 22859.9 24860.8 25901.5 26309.3 26342.7 1035.2 1084.6 1249.8 1278.4 1284.9 11927.4 13285.3 13737.5 13873.9 13973.8 523928.4 526238.0 526390.0 526935.7 528476.0 48165.0 48565.5 48581.3 48741.5 49000.5 1385.0 1427.5 1435.7 1435.8 1443.5 22033.9 24885.3 25183.7 25530.9 25735.0 40530.6 40748.4 40855.0 40876.8 40978.6 502674.0 503794.0 505484.0 507906.0 509506.0 29358.7 29603.8 38525.0 38551.0 39660.2 46740.5 47447.8 47498.3 48752.5 49169.0 37660.6 38387.2 39393.4 40014.8 40793.6 38619.0 38929.8 39746.6 39929.8 40408.8 38177.8 39430.4 39875.8 39950.6 40335.4 33398.7 35214.8 35520.9 35601.5 35780.3 24288.5 25485.8 26040.3 26207.2 26477.3 01:58:18 INFO - PROCESS | 1638 | 01:58:18 INFO - PROCESS | 1638 | [#2] jquery.html Cycles:180 Average:43566.08 Median:20889.14 stddev:127149.31 (608.7%) stddev-sans-first:127464.71 01:58:18 INFO - PROCESS | 1638 | Values: 413.8 419.5 421.6 433.5 460.6 19864.5 20574.6 21206.4 21396.5 21590.2 20291.0 21105.8 22536.9 22826.0 22869.2 6483.1 6717.2 6718.7 6730.8 6741.9 6317.7 6521.3 6554.8 6557.1 6578.9 6500.8 6501.0 6551.6 6570.9 6580.2 6333.4 6509.8 6517.5 6532.2 6579.2 6364.1 6889.0 7179.6 7215.9 7219.7 20672.5 25712.0 25919.4 26243.2 26590.6 2861.7 2973.1 2978.3 2984.7 2991.6 15932.2 16222.0 16249.8 16443.9 16682.3 2017.9 2019.6 2020.3 2025.5 2031.6 144974.0 146229.3 163400.0 168331.2 169505.0 20346.6 21733.6 21899.7 21962.7 21968.2 33802.0 33906.7 33972.5 34015.5 34035.5 8156.8 8677.5 9967.9 10803.6 10890.3 6783.9 7195.4 7854.8 8848.2 8989.0 9970.4 9977.1 9995.0 10107.6 10130.9 4347.0 4389.4 4401.4 4413.0 4424.8 993.7 1015.8 1025.4 1026.3 1062.1 17887.6 20341.0 20534.5 20658.5 20668.7 1008.5 1010.4 1041.0 1041.5 1043.0 10143.3 10679.1 10750.1 10754.6 10805.3 748229.0 749544.0 755158.0 777868.0 778199.0 134792.0 142299.3 159960.0 163912.2 165721.0 1193.9 1219.6 1242.4 1253.1 1261.1 16678.0 16937.1 16992.6 18241.8 18380.2 63254.7 63433.0 63986.0 64496.7 64506.4 87755.0 88130.0 89006.0 89206.6 90369.6 11130.7 11395.1 11519.1 11556.1 11821.8 12309.1 12453.8 12729.7 12767.7 12876.2 11050.1 11139.7 11319.6 11424.1 11645.4 9479.6 11003.9 11050.3 11357.5 11399.8 9769.5 11287.1 11512.7 11791.9 11815.8 11342.3 11492.8 11715.1 11791.0 11954.0 10122.0 11045.4 11072.4 11167.7 11514.3 01:58:18 INFO - PROCESS | 1638 | 01:58:18 INFO - PROCESS | 1638 | [#3] mootools.html Cycles:180 Average:6791.69 Median:2462.99 stddev:4285.10 (174.0%) stddev-sans-first:4278.79 01:58:18 INFO - PROCESS | 1638 | Values: 1517.3 1557.5 1571.2 1583.9 1588.0 10875.8 11377.5 11586.5 11612.2 11621.4 11405.2 11563.0 11614.3 11621.2 11663.2 2437.4 2469.2 2469.7 2471.5 2471.6 2411.7 2445.6 2445.6 2449.3 2456.8 2393.9 2427.4 2432.9 2434.7 2445.4 2332.3 2344.1 2353.3 2359.7 2364.7 2325.7 2329.0 2377.5 2386.0 2401.2 11360.9 11433.1 11445.3 11451.5 11465.5 5418.0 5862.5 5934.4 6010.6 6152.0 3628.9 3694.9 3726.7 3761.4 3780.6 1036.5 1197.0 1224.4 1238.0 1269.2 11623.6 14253.6 14893.0 15546.9 15618.7 4782.6 4853.2 4876.1 4881.3 4881.6 11867.1 11917.3 11920.5 11920.6 11930.7 4842.8 5598.4 5610.2 5619.5 5635.4 5206.9 5396.0 5416.9 5429.5 5437.0 3960.5 4030.7 4065.8 4123.5 4129.5 1089.8 1091.2 1097.2 1097.9 1100.9 825.6 837.5 848.9 860.7 869.7 4842.4 5109.9 5212.7 5414.2 5434.9 847.2 990.1 992.6 995.3 1009.2 3974.9 4032.8 4073.1 4130.6 4183.4 13560.7 13889.7 13991.2 14004.6 14042.4 13844.9 13882.3 14010.7 14021.3 14056.0 10013.6 10156.7 10265.4 10355.7 10370.4 6353.8 6379.5 6412.8 6423.7 6562.4 12401.6 12452.8 12619.7 12622.8 12808.2 11515.0 11903.3 12345.9 12775.8 13026.9 9225.4 9504.0 9527.8 9647.5 9653.3 8744.4 10463.5 10468.5 10566.3 10566.8 9374.5 9388.7 9406.0 9611.2 9630.1 9191.2 9226.8 9240.7 9308.9 9361.0 6603.5 8005.4 8011.9 8020.0 8035.4 5739.5 5772.0 5785.6 5951.5 6018.9 5871.8 5961.2 6002.5 6080.5 6149.1 01:58:18 INFO - PROCESS | 1638 | 01:58:18 INFO - PROCESS | 1638 | [#4] prototype.html Cycles:180 Average:4735.14 Median:5092.21 stddev:1314.74 (25.8%) stddev-sans-first:1275.92 01:58:18 INFO - PROCESS | 1638 | Values: 317.0 324.7 374.0 397.5 401.0 5088.3 5139.3 5400.9 5428.3 5494.6 4128.3 4597.5 4644.7 4826.3 4849.4 3899.1 4032.9 4128.2 4388.6 4436.9 4169.6 4413.4 4425.9 4460.5 4461.5 3544.6 3966.1 4515.5 4561.7 4628.6 3832.6 4000.8 4401.0 4604.0 4613.7 3741.0 3910.7 3931.6 4396.7 4455.4 4946.7 5063.7 5093.4 5100.7 5130.5 4609.9 4679.3 4785.7 4851.9 5387.0 5199.8 5506.7 5603.6 5631.4 5726.5 3808.7 4395.4 4860.2 4959.8 5015.7 5301.7 5392.5 5743.2 6073.5 6103.8 4219.4 4624.9 4684.1 4942.5 5002.8 5085.3 5086.5 5091.8 5131.8 5156.4 4280.9 4551.4 5092.6 5343.3 5458.5 5117.8 5199.4 5556.7 5573.2 5727.3 1504.9 1564.6 1614.6 1738.3 1751.6 1178.8 1289.1 1301.3 1307.5 1341.5 4491.6 4882.9 4888.4 5067.8 5263.8 5079.7 5733.7 5800.5 5846.5 5909.8 4460.0 4775.2 5063.8 5162.8 5261.4 2476.8 2544.3 3024.7 3029.6 3066.5 5598.4 5664.0 5955.7 6092.3 6135.5 5182.7 5617.8 5888.7 5998.9 6078.6 5346.2 6057.7 6097.9 6207.5 6241.8 4800.0 5568.7 5679.2 5818.0 5835.6 5596.5 5816.9 5843.6 5856.5 5869.2 5295.8 5797.0 5980.7 6079.4 6157.9 4203.0 4291.2 4643.9 4700.0 4710.0 5472.6 5729.3 5772.2 5846.5 5893.7 5423.7 5457.9 5500.5 5590.2 5615.1 5058.5 5097.7 5457.3 5638.1 5661.9 4983.4 5114.5 5288.8 5440.8 5528.7 4880.0 5453.0 5513.7 5617.6 5659.5 4330.2 4627.4 5310.9 5375.6 5626.9 01:58:18 INFO - PROCESS | 1638 | 01:58:18 INFO - PROCESS | 1638 | [#5] yui.html Cycles:180 Average:20860.05 Median:3448.94 stddev:30281.00 (878.0%) stddev-sans-first:30328.16 01:58:18 INFO - PROCESS | 1638 | Values: 713.3 722.8 749.0 774.1 819.8 15247.5 16104.8 16117.6 16119.2 16321.7 14857.3 15068.5 15073.3 15093.2 15996.7 661.4 680.0 927.9 930.5 953.9 949.4 955.1 961.4 965.9 968.3 1000.4 1020.7 1020.8 1022.9 1023.7 1012.7 1014.3 1014.8 1015.1 1016.8 749.7 755.4 756.2 756.4 757.3 16338.9 16389.8 16390.9 16863.7 17072.1 13921.1 13924.8 13973.5 13974.7 14253.8 11709.9 11859.7 11872.4 11879.5 11914.8 3592.9 3638.7 3678.8 3692.2 3832.6 105684.9 108240.9 109225.4 109989.0 110659.0 10216.2 10468.5 10520.9 10526.9 10608.5 22897.9 22952.0 22990.3 23076.0 23404.8 7531.1 7533.2 7604.3 7629.1 7733.3 3572.9 4261.1 4322.2 4358.7 4419.9 3392.6 3443.2 3443.8 3454.1 3482.3 515.7 609.9 622.3 623.7 638.6 542.9 666.3 668.5 675.7 681.8 9681.1 9784.4 9842.9 9933.4 9937.5 631.8 653.5 661.7 664.4 664.9 4642.7 4794.7 4819.9 4824.9 4843.7 94224.1 110972.0 111431.0 111538.0 111594.0 75438.8 77339.0 80409.2 93232.5 95382.0 84121.0 84577.6 85251.6 86164.0 88025.0 7447.0 8849.7 9228.8 9279.5 9367.9 46104.5 47284.0 51599.0 51730.7 54114.5 54169.0 68863.7 70590.6 73284.0 74663.6 12336.1 12680.1 12939.2 12998.8 13011.4 14566.9 14720.0 14976.6 15321.9 15479.8 12349.3 12355.6 13088.6 13268.7 13579.7 13217.6 13750.0 13790.6 14157.4 14398.6 12186.6 12578.3 12873.2 12977.9 13124.0 9825.3 11276.0 11311.0 11449.1 11677.2 10026.0 10083.0 10795.2 10812.7 10834.7 01:58:18 INFO - PROCESS | 1638 | -------- Summary: end -------- 01:58:18 INFO - PROCESS | 1638 | 01:58:18 INFO - TEST-INFO | 1638: exit 0 01:58:18 INFO - TEST-OK | dromaeo_css | took 1117749ms 01:58:19 INFO - TEST-START | kraken 01:58:19 INFO - operating with platform_type : mac_ 01:58:19 INFO - Initialising browser for kraken test... 01:58:19 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmpTGFuw6/profile http://localhost:49243/getInfo.html) 01:58:21 INFO - PROCESS | 1649 | 2017-03-08 01:58:21.616 plugin-container[1651:10201] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b43, name = 'com.apple.tsm.portname' 01:58:21 INFO - PROCESS | 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:58:21 INFO - PROCESS | 1649 | 2017-03-08 01:58:21.617 plugin-container[1651:10201] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x910b, name = 'com.apple.CFPasteboardClient' 01:58:21 INFO - PROCESS | 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:58:21 INFO - PROCESS | 1649 | 2017-03-08 01:58:21.617 plugin-container[1651:10201] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 01:58:21 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 01:58:21 INFO - PROCESS | 1649 | colorDepth:24 01:58:21 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 01:58:21 INFO - PROCESS | 1649 | __metrics 01:58:21 ERROR - PROCESS | 1649 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 01:58:22 INFO - TEST-INFO | 1649: exit 0 01:58:22 INFO - Browser initialized. 01:58:22 INFO - Running cycle 1/1 for kraken test... 01:58:22 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmpTGFuw6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:58:24 INFO - PROCESS | 1652 | 2017-03-08 01:58:24.932 plugin-container[1653:10323] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a43, name = 'com.apple.tsm.portname' 01:58:24 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:58:24 INFO - PROCESS | 1652 | 2017-03-08 01:58:24.933 plugin-container[1653:10323] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c27, name = 'com.apple.CFPasteboardClient' 01:58:24 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:58:24 INFO - PROCESS | 1652 | 2017-03-08 01:58:24.933 plugin-container[1653:10323] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 01:58:34 INFO - PROCESS | 1652 | RSS: Main: 220381184 01:58:34 INFO - PROCESS | 1652 | 01:58:37 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 01:58:38 INFO - PROCESS | 1652 | RSS: Main: 234692608 01:58:38 INFO - PROCESS | 1652 | 01:58:41 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 01:58:41 INFO - PROCESS | 1652 | RSS: Main: 242855936 01:58:41 INFO - PROCESS | 1652 | 01:58:45 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 01:58:45 INFO - PROCESS | 1652 | RSS: Main: 246726656 01:58:45 INFO - PROCESS | 1652 | 01:58:47 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 01:58:48 INFO - PROCESS | 1652 | RSS: Main: 247025664 01:58:48 INFO - PROCESS | 1652 | 01:58:50 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:58:51 INFO - PROCESS | 1652 | RSS: Main: 247037952 01:58:51 INFO - PROCESS | 1652 | 01:58:54 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 01:58:55 INFO - PROCESS | 1652 | RSS: Main: 252506112 01:58:55 INFO - PROCESS | 1652 | 01:58:58 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 01:58:59 INFO - PROCESS | 1652 | RSS: Main: 251805696 01:58:59 INFO - PROCESS | 1652 | 01:59:02 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 01:59:03 INFO - PROCESS | 1652 | RSS: Main: 251301888 01:59:03 INFO - PROCESS | 1652 | 01:59:04 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:59:05 INFO - PROCESS | 1652 | RSS: Main: 251531264 01:59:05 INFO - PROCESS | 1652 | 01:59:07 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:59:07 INFO - PROCESS | 1652 | RSS: Main: 251424768 01:59:07 INFO - PROCESS | 1652 | 01:59:10 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:59:10 INFO - PROCESS | 1652 | RSS: Main: 251445248 01:59:10 INFO - PROCESS | 1652 | 01:59:13 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:59:14 INFO - PROCESS | 1652 | RSS: Main: 251805696 01:59:14 INFO - PROCESS | 1652 | 01:59:17 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:59:18 INFO - PROCESS | 1652 | RSS: Main: 251588608 01:59:18 INFO - PROCESS | 1652 | 01:59:20 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 01:59:20 INFO - PROCESS | 1652 | RSS: Main: 255053824 01:59:20 INFO - PROCESS | 1652 | 01:59:20 INFO - PROCESS | 1652 | __start_tp_report 01:59:20 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 01:59:20 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 01:59:20 INFO - PROCESS | 1652 | |i|pagename|runs| 01:59:20 INFO - PROCESS | 1652 | |0;ai-astar;105;119;119;119;118;121;120;119;119;121 01:59:20 INFO - PROCESS | 1652 | |1;audio-beat-detection;146;112;112;149;118;112;100;106;154;96 01:59:20 INFO - PROCESS | 1652 | |2;audio-dft;206;196;200;200;197;198;198;197;199;200 01:59:20 INFO - PROCESS | 1652 | |3;audio-fft;81;68;84;113;54;74;53;69;96;85 01:59:20 INFO - PROCESS | 1652 | |4;audio-oscillator;83;85;87;64;103;101;116;102;88;83 01:59:20 INFO - PROCESS | 1652 | |5;imaging-gaussian-blur;88;89;90;116;89;90;91;89;94;86 01:59:20 INFO - PROCESS | 1652 | |6;imaging-darkroom;101;97;96;99;97;117;101;150;154;96 01:59:20 INFO - PROCESS | 1652 | |7;imaging-desaturate;99;92;90;92;106;102;140;91;129;141 01:59:20 INFO - PROCESS | 1652 | |8;json-parse-financial;67;65;65;70;70;69;68;68;69;70 01:59:20 INFO - PROCESS | 1652 | |9;json-stringify-tinderbox;59;64;63;64;60;57;59;60;61;61 01:59:20 INFO - PROCESS | 1652 | |10;stanford-crypto-aes;89;91;101;96;84;84;84;85;83;88 01:59:20 INFO - PROCESS | 1652 | |11;stanford-crypto-ccm;149;136;145;146;146;154;160;161;181;185 01:59:20 INFO - PROCESS | 1652 | |12;stanford-crypto-pbkdf2;165;164;196;161;161;158;228;225;190;171 01:59:20 INFO - PROCESS | 1652 | |13;stanford-crypto-sha256-iterative;67;70;66;69;67;62;66;65;67;66 01:59:20 INFO - PROCESS | 1652 | __end_tp_report 01:59:20 INFO - PROCESS | 1652 | __start_cc_report 01:59:20 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,1015 01:59:20 INFO - PROCESS | 1652 | __end_cc_report 01:59:20 INFO - PROCESS | 1652 | __startTimestamp1488967160272__endTimestamp 01:59:20 INFO - PROCESS | 1652 | 01:59:20 INFO - PROCESS | 1652 | ------- Summary: start ------- 01:59:20 INFO - PROCESS | 1652 | Number of tests: 14 01:59:20 INFO - PROCESS | 1652 | 01:59:20 INFO - PROCESS | 1652 | [#0] ai-astar Cycles:10 Average:118.00 Median:119.00 stddev:4.67 (3.9%) stddev-sans-first:1.01 01:59:20 INFO - PROCESS | 1652 | Values: 105.0 119.0 119.0 119.0 118.0 121.0 120.0 119.0 119.0 121.0 01:59:20 INFO - PROCESS | 1652 | 01:59:20 INFO - PROCESS | 1652 | [#1] audio-beat-detection Cycles:10 Average:120.50 Median:132.00 stddev:21.18 (16.0%) stddev-sans-first:20.36 01:59:20 INFO - PROCESS | 1652 | Values: 146.0 112.0 112.0 149.0 118.0 112.0 100.0 106.0 154.0 96.0 01:59:20 INFO - PROCESS | 1652 | 01:59:20 INFO - PROCESS | 1652 | [#2] audio-dft Cycles:10 Average:199.10 Median:199.50 stddev:2.81 (1.4%) stddev-sans-first:1.50 01:59:20 INFO - PROCESS | 1652 | Values: 206.0 196.0 200.0 200.0 197.0 198.0 198.0 197.0 199.0 200.0 01:59:20 INFO - PROCESS | 1652 | 01:59:20 INFO - PROCESS | 1652 | [#3] audio-fft Cycles:10 Average:77.70 Median:77.50 stddev:18.38 (23.7%) stddev-sans-first:19.46 01:59:20 INFO - PROCESS | 1652 | Values: 81.0 68.0 84.0 113.0 54.0 74.0 53.0 69.0 96.0 85.0 01:59:20 INFO - PROCESS | 1652 | 01:59:20 INFO - PROCESS | 1652 | [#4] audio-oscillator Cycles:10 Average:91.20 Median:83.00 stddev:14.56 (17.5%) stddev-sans-first:15.14 01:59:20 INFO - PROCESS | 1652 | Values: 83.0 85.0 87.0 64.0 103.0 101.0 116.0 102.0 88.0 83.0 01:59:20 INFO - PROCESS | 1652 | 01:59:20 INFO - PROCESS | 1652 | [#5] imaging-gaussian-blur Cycles:10 Average:92.20 Median:89.50 stddev:8.61 (9.6%) stddev-sans-first:9.00 01:59:20 INFO - PROCESS | 1652 | Values: 88.0 89.0 90.0 116.0 89.0 90.0 91.0 89.0 94.0 86.0 01:59:20 INFO - PROCESS | 1652 | 01:59:20 INFO - PROCESS | 1652 | [#6] imaging-darkroom Cycles:10 Average:110.80 Median:96.00 stddev:22.59 (23.5%) stddev-sans-first:23.68 01:59:20 INFO - PROCESS | 1652 | Values: 101.0 97.0 96.0 99.0 97.0 117.0 101.0 150.0 154.0 96.0 01:59:20 INFO - PROCESS | 1652 | 01:59:20 INFO - PROCESS | 1652 | [#7] imaging-desaturate Cycles:10 Average:108.20 Median:90.50 stddev:20.55 (22.7%) stddev-sans-first:21.52 01:59:20 INFO - PROCESS | 1652 | Values: 99.0 92.0 90.0 92.0 106.0 102.0 140.0 91.0 129.0 141.0 01:59:20 INFO - PROCESS | 1652 | 01:59:20 INFO - PROCESS | 1652 | [#8] json-parse-financial Cycles:10 Average:68.10 Median:69.00 stddev:1.91 (2.8%) stddev-sans-first:1.99 01:59:20 INFO - PROCESS | 1652 | Values: 67.0 65.0 65.0 70.0 70.0 69.0 68.0 68.0 69.0 70.0 01:59:20 INFO - PROCESS | 1652 | 01:59:20 INFO - PROCESS | 1652 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:61.00 stddev:2.30 (3.8%) stddev-sans-first:2.35 01:59:20 INFO - PROCESS | 1652 | Values: 59.0 64.0 63.0 64.0 60.0 57.0 59.0 60.0 61.0 61.0 01:59:20 INFO - PROCESS | 1652 | 01:59:20 INFO - PROCESS | 1652 | [#10] stanford-crypto-aes Cycles:10 Average:88.50 Median:86.50 stddev:5.99 (6.9%) stddev-sans-first:6.35 01:59:20 INFO - PROCESS | 1652 | Values: 89.0 91.0 101.0 96.0 84.0 84.0 84.0 85.0 83.0 88.0 01:59:20 INFO - PROCESS | 1652 | 01:59:20 INFO - PROCESS | 1652 | [#11] stanford-crypto-ccm Cycles:10 Average:156.30 Median:157.00 stddev:15.92 (10.1%) stddev-sans-first:16.66 01:59:20 INFO - PROCESS | 1652 | Values: 149.0 136.0 145.0 146.0 146.0 154.0 160.0 161.0 181.0 185.0 01:59:20 INFO - PROCESS | 1652 | 01:59:20 INFO - PROCESS | 1652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.90 Median:180.50 stddev:26.70 (14.8%) stddev-sans-first:27.61 01:59:20 INFO - PROCESS | 1652 | Values: 165.0 164.0 196.0 161.0 161.0 158.0 228.0 225.0 190.0 171.0 01:59:20 INFO - PROCESS | 1652 | 01:59:20 INFO - PROCESS | 1652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:67.00 stddev:2.17 (3.2%) stddev-sans-first:2.30 01:59:20 INFO - PROCESS | 1652 | Values: 67.0 70.0 66.0 69.0 67.0 62.0 66.0 65.0 67.0 66.0 01:59:20 INFO - PROCESS | 1652 | -------- Summary: end -------- 01:59:20 INFO - PROCESS | 1652 | 01:59:21 INFO - TEST-INFO | 1652: exit 0 01:59:21 INFO - TEST-OK | kraken | took 62201ms 01:59:21 INFO - SUITE-END | took 1179s 01:59:21 INFO - Completed test suite (00:19:40) 01:59:21 INFO - javascript benchmark 01:59:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7745.2800469911745, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2700.257429206968, 3251.577294951657, 3471.375152472555, 3479.61724210337, 3492.807895565744, 5916.733746981386, 6022.819315420534, 6066.8483287917825, 6082.604630699013, 6107.725152368143, 6031.638101713889, 6041.848953776158, 6103.877922441548, 6110.297315808683, 6116.235470566179, 5466.753996070176, 5483.835484935458, 5503.669779813204, 5545.77816887326, 5601.271834661488, 5562.721863906789, 5575.637583557076, 5581.413951535092, 5611.691356975365, 5653.095504719226, 5341.519263266306, 5385.703786291752, 5452.127659574468, 5557.555395568365, 5569.053260945649, 5456.399796022434, 5467.617266791326, 5501.504864562168, 5508.55931525481, 5541.0580201365465, 5391.0, 5518.889622207534, 5530.778768849241, 5550.91673624896, 5577.498025177753, 6012.098185272244, 6209.068639704035, 6240.594361366497, 6241.21984751906, 6246.125542424064, 6319.8736025279695, 6327.810165695037, 6347.650879201642, 6349.777757778502, 6427.453666438359, 6485.0596663484, 6492.09110724499, 6510.0, 6514.706838192245, 6529.020646902955, 6121.418465245794, 6203.751849925952, 6223.0, 6243.9999999999545, 6266.686665666698, 6101.145839582462, 6165.67438000823, 6270.435660790551, 6343.777967771106, 6344.968275158687, 5289.523942845085, 6306.148669929593, 6309.495240380758, 6328.905066424008, 6339.207599050119, 6443.323451037667, 6468.288488266287, 6469.385408386196, 6470.352964703586, 6475.870482590321, 5526.336839579276, 6277.623342599459, 6339.985602303609, 6362.077498762654, 6408.871822563616, 6290.528210384239, 6325.841853953596, 6328.873422531524, 6330.8100756977365, 6349.952257877491, 4323.48118225815, 4766.404199475066, 4991.0766508195375, 5127.66670166438, 5213.374395072616, 4588.898664320539, 4596.052415318188, 4605.424321959755, 4627.5835174833755, 4653.697509661861, 5823.039198532279, 5932.8813423732145, 5969.641821490724, 6075.1798507200965, 6086.756529738849, 6289.182406287245, 6309.148264984168, 6318.557700960889, 6329.968350158312, 6404.551681382259, 5439.075357189287, 5544.805931792449, 6120.508083830795, 6135.2326666699655, 6136.733532366159, 5676.914846277309, 5687.857803554944, 5700.714964251853, 5712.6286791358425, 5721.170430287585, 6329.177206963065, 6360.713767880364, 6540.771073012422, 6582.572132811543, 6714.0600315954825, 6424.807255782334, 6479.708413121327, 6486.772962946275, 6492.448141907991, 6505.544611877123, 6664.966675166593, 6678.465722742266, 6701.631410272482, 6712.798616041527, 6712.93287067123, 6204.844878878064, 6206.224221972254, 6269.247690277196, 6275.905861411991, 6362.872742545216, 6478.0282957554855, 6488.870222595616, 6496.902546461902, 6510.056041873996, 6510.3489651034515, 6300.495960323072, 6305.337939516285, 6307.180066591313, 6314.084457753508, 6338.778142764981, 6135.477655820289, 6187.133801267916, 6235.812925612239, 6301.6219026858535, 6304.810855674154, 6146.862830376394, 6228.34602366745, 6355.078513615407, 6358.237011558643, 6375.171227740364, 5158.561522270649, 5893.6463812171405, 6327.746890124344, 6336.112944187909, 6353.332900045429, 6040.184575082483, 6043.667598282137, 6092.086187071975, 6095.725692343766, 6262.2172228471445], "value": 5904.84917016436, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.282614559295, 744.8306159329851, 822.1655020154542, 931.287565012765, 966.5215718219482, 32671.67328326716, 39108.60891391085, 40951.79524102383, 41165.79417102918, 41214.793926030405, 39323.41014884779, 39442.21115577694, 39517.0, 39581.0, 39592.40611390831, 8695.95652021739, 8886.289096872235, 9063.274938004977, 9093.818123637524, 9104.226140778042, 8919.241864441497, 8955.417897836653, 9011.54942252888, 9024.954875225647, 9028.277737780962, 9005.009448960609, 9030.27757779376, 9037.051109633492, 9039.141281578273, 9043.412178208428, 7781.572013539253, 8103.837923241532, 8917.598708058153, 9002.009778924314, 9013.639454421815, 8761.693340733043, 8794.208521233055, 8801.339899507562, 8836.248918841906, 8853.601587928495, 34080.48879266813, 34310.97067087991, 34438.48342274868, 34497.13757156066, 34812.0, 3733.45864849598, 3785.0, 3786.413105968579, 3800.5059342285604, 3847.6921846252235, 25310.86101125454, 25358.492830143477, 25790.355241118934, 26768.59847102295, 26855.328616784736, 2798.0, 3022.576839242508, 3112.6420461646976, 3238.3847069056806, 3269.395161895033, 355016.0, 365940.0, 366255.0, 371738.0, 372567.0, 44431.77784111124, 44468.11063778706, 44510.33234501485, 44551.0, 44556.77721611436, 45760.31359529543, 46101.53898461039, 46326.536734632224, 46416.0, 46423.83940401517, 13683.31583420825, 13758.793618095737, 13770.0, 13776.380062897193, 13805.861941380457, 11869.643910682693, 11953.760924781456, 11963.521459141537, 11965.162438629213, 11992.64022079339, 11753.236039657395, 11948.462319195656, 11962.641120766391, 12047.397630118634, 12071.094667899943, 4736.810527578928, 4801.5438533339275, 4815.3499277597075, 5589.882023595297, 5632.211490391349, 1079.4171147580219, 1095.8630171228597, 1137.1869113583662, 1143.8684551276542, 1178.9705257368635, 22859.88570057139, 24860.840453705237, 25901.481970360488, 26309.34226644311, 26342.73657263441, 1035.2390992620417, 1084.5878566144972, 1249.8126779559454, 1278.3735969374939, 1284.8991898246247, 11927.403629818475, 13285.335733213495, 13737.519186828413, 13873.86126138746, 13973.79039314411, 523928.38035809575, 526238.0, 526390.0, 526935.7306426887, 528476.0, 48165.0, 48565.514344856805, 48581.271280930814, 48741.51258487441, 49000.509994900305, 1384.9930750346384, 1427.5003748688084, 1435.727211829728, 1435.777454494555, 1443.5164219986423, 22033.889830551387, 24885.253442396755, 25183.74816251814, 25530.872345638152, 25735.0, 40530.594694052685, 40748.388774169005, 40855.0, 40876.79561602173, 40978.5657501986, 502674.0, 503794.0, 505484.0, 507906.0, 509506.0, 29358.706412935597, 29603.815847365866, 38525.0, 38551.03622409462, 39660.2067958645, 46740.53259467362, 47447.76276118597, 47498.28752568783, 48752.5124748748, 49169.0, 37660.62339376571, 38387.232255355295, 39393.40909886411, 40014.79992600018, 40793.59206407898, 38619.0, 38929.8321050369, 39746.60253397429, 39929.80035099922, 40408.79795601003, 38177.809110954266, 39430.408543872436, 39875.800620996706, 39950.60049399469, 40335.39496907607, 33398.666013339556, 35214.823925880206, 35520.934371968884, 35601.46597801087, 35780.28439431249, 24288.51422971566, 25485.81427321585, 26040.34899127537, 26207.21378358576, 26477.33806654772], "value": 18530.139135826827, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [413.77862843378796, 419.50917426610863, 421.5594703534806, 433.4776594203984, 460.6153861525626, 19864.503387415305, 20574.588508229826, 21206.36380908573, 21396.4650883728, 21590.24434144805, 20291.0, 21105.788942110576, 22536.873156342157, 22826.0, 22869.199578014774, 6483.124778154959, 6717.16035495563, 6718.66406679664, 6730.83172920676, 6741.93258067418, 6317.715702793385, 6521.347865213488, 6554.7705830295945, 6557.114789503427, 6578.901316480256, 6500.804975850732, 6500.9674951625175, 6551.57414768041, 6570.901436478457, 6580.243272023707, 6333.366663333676, 6509.772157974448, 6517.511186660972, 6532.150820393343, 6579.17760279965, 6364.140840986453, 6889.0, 7179.605121718303, 7215.855682886366, 7219.7473088442175, 20672.483187920272, 25711.97152113932, 25919.35201619956, 26243.212703618923, 26590.6011409829, 2861.6566012078474, 2973.108067579739, 2978.300099476621, 2984.6716861145255, 2991.5961345218334, 15932.203389830462, 16222.0, 16249.756253656205, 16443.917780411022, 16682.314868455218, 2017.9192832286692, 2019.6162729081575, 2020.2626041494748, 2025.4733769220109, 2031.5936812637383, 144974.0, 146229.2688536561, 163400.0, 168331.1583442075, 169505.0, 20346.593068138554, 21733.565328693338, 21899.6860188386, 21962.670559941613, 21968.231111911326, 33802.0, 33906.66093339084, 33972.49041264383, 34015.489767653504, 34035.48946765801, 8156.796080097926, 8677.479351238946, 9967.853696824957, 10803.621873234399, 10890.346579205274, 6783.93216067833, 7195.352418282379, 7854.764357069297, 8848.159424854628, 8988.966268879032, 9970.351927124859, 9977.054474377426, 9995.000499949947, 10107.58493810867, 10130.898691013143, 4346.978265108654, 4389.3635422864145, 4401.449818772653, 4412.977935110368, 4424.805302568353, 993.7316924430363, 1015.827309357411, 1025.3591505309182, 1026.2764750850633, 1062.1078294232882, 17887.552811179823, 20341.0, 20534.486637833874, 20658.483537911372, 20668.689969650466, 1008.5461542305992, 1010.4089107871977, 1040.958361665525, 1041.4844651897208, 1042.9843552346722, 10143.289969702199, 10679.149947986267, 10750.139988800876, 10754.623588174376, 10805.297655652357, 748229.0, 749544.0, 755158.0, 777868.0, 778199.0, 134792.0, 142299.28850355683, 159960.0, 163912.18043909705, 165721.0, 1193.886580774825, 1219.5792451604182, 1242.3974372429363, 1253.091508656217, 1261.1172179474222, 16678.0, 16937.06846123475, 16992.575185619964, 18241.817581824012, 18380.17289222015, 63254.683726581075, 63433.04850427155, 63986.0, 64496.677516612115, 64506.35493645191, 87755.0, 88130.0, 89006.0, 89206.55396722975, 90369.64445533454, 11130.666080017612, 11395.088392928712, 11519.078473721915, 11556.075513959031, 11821.82267266009, 12309.076819238771, 12453.75092498163, 12729.681757956125, 12767.744645107232, 12876.163049401759, 11050.06074483678, 11139.665810025712, 11319.603813866475, 11424.086073114297, 11645.359505227294, 9479.57806329056, 11003.944980275048, 11050.33697978124, 11357.4889129991, 11399.829002565135, 9769.462679552693, 11287.097032237565, 11512.654620361403, 11791.941040294743, 11815.82276265874, 11342.262752921033, 11492.770144597229, 11715.062794976551, 11791.0, 11954.043676506033, 10121.998663301632, 11045.447727613748, 11072.446377680923, 11167.664970050912, 11514.30914145154], "value": 11588.484907648588, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1517.3020410611118, 1557.548310989813, 1571.1594297051072, 1583.8653714434272, 1588.0074953154276, 10875.83686244706, 11377.544898204083, 11586.478608462618, 11612.24520406173, 11621.418929053545, 11405.20163588549, 11563.0, 11614.303141811497, 11621.244619099774, 11663.241889277213, 2437.4028363051034, 2469.172827102923, 2469.7036355637347, 2471.505698860226, 2471.6292556116546, 2411.710594728635, 2445.58425067738, 2445.608702607583, 2449.326435230317, 2456.815738819587, 2393.904243830245, 2427.368884090132, 2432.914847980321, 2434.7200071991683, 2445.3886528367907, 2332.346942856003, 2344.1443872986324, 2353.305774796439, 2359.6696462495265, 2364.7044119484976, 2325.720913490392, 2329.045091512489, 2377.4531857672832, 2385.9761402386102, 2401.2436082633913, 11360.886391136066, 11433.142514311377, 11445.313281203154, 11451.484683189277, 11465.541378344857, 5417.970585588726, 5862.50168735658, 5934.37689042653, 6010.609310394811, 6151.969240153815, 3628.8911332660064, 3694.9261014779554, 3726.720495962814, 3761.4357846322996, 3780.584135745066, 1036.5180191211048, 1196.9820452693216, 1224.412282104586, 1237.962861114168, 1269.1877198592908, 11623.59317423886, 14253.572392828128, 14892.99999999989, 15546.911716179871, 15618.687626247525, 4782.569568738831, 4853.150698627726, 4876.097921884463, 4881.316615673809, 4881.585065269492, 11867.109966752529, 11917.284962902253, 11920.52317907274, 11920.642380728592, 11930.701732456759, 4842.782074806642, 5598.356189038313, 5610.214569960209, 5619.494245517923, 5635.351934527582, 5206.921896171561, 5395.973020134874, 5416.91874621881, 5429.484199001088, 5436.972815135899, 3960.4825170074896, 4030.717849750548, 4065.8170382332864, 4123.546409894909, 4129.545749967501, 1089.8310761831929, 1091.1816137896578, 1097.204526718123, 1097.9231453798318, 1100.9284396514201, 825.636719843279, 837.4723923928008, 848.8599381102049, 860.6729442811817, 869.7086476030474, 4842.370491836039, 5109.904938975003, 5212.687238765686, 5414.187871819258, 5434.864128396743, 847.2417186617943, 990.0792263195153, 992.6376872441507, 995.2933417273672, 1009.1775203209361, 3974.940375894364, 4032.7781971991235, 4073.135589009823, 4130.607592278729, 4183.372494125905, 13560.660983475493, 13889.722205555832, 13991.160530368006, 14004.649883752987, 14042.36809343582, 13844.861551384558, 13882.305884705724, 14010.719785604435, 14021.298935053206, 14056.0, 10013.599456021822, 10156.695299141038, 10265.435401053013, 10355.689329319981, 10370.377777333384, 6353.777617783356, 6379.457746091449, 6412.807615771534, 6423.678816059271, 6562.376574225441, 12401.565945191875, 12452.81320780171, 12619.747605047663, 12622.810657840324, 12808.231506109663, 11515.021223196121, 11903.285802851857, 12345.876541234473, 12775.80836287475, 13026.869731302566, 9225.446473211628, 9504.0, 9527.761805954906, 9647.469389183661, 9653.276004299565, 8744.387892847439, 10463.529141188512, 10468.528916198637, 10566.31318964265, 10566.8414973777, 9374.531273436165, 9388.718338449857, 9405.952970235105, 9611.231101511723, 9630.085141911508, 9191.172794448532, 9226.815463690822, 9240.722778316662, 9308.906910930804, 9361.017093205115, 6603.537752357289, 8005.359571234404, 8011.919880801117, 8019.959900200462, 8035.357171426155, 5739.540836732968, 5771.971140144273, 5785.623934444247, 5951.523878089829, 6018.939810601838, 5871.7651293947765, 5961.195238642727, 6002.459778619946, 6080.452759251689, 6149.108379284889], "value": 5153.893513689457, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.96830316968294, 324.655924472683, 373.98878033658985, 397.45151690666876, 401.04951265500756, 5088.338515992916, 5139.280500729901, 5400.864978375537, 5428.267183930168, 5494.642848214873, 4128.318827393477, 4597.5402459754005, 4644.651651126171, 4826.2519309507, 4849.448176583494, 3899.1146551551788, 4032.899177520556, 4128.174365126972, 4388.6050255477, 4436.889077773049, 4169.60388763067, 4413.360062790894, 4425.867223983286, 4460.502118813475, 4461.509233984275, 3544.5923718772415, 3966.093398002965, 4515.548445155491, 4561.7491037992895, 4628.583427491525, 3832.616738326173, 4000.799960002003, 4400.9559904401185, 4603.9769801151115, 4613.700109492872, 3740.971232910944, 3910.7485604606536, 3931.606839316074, 4396.724949764564, 4455.44059579148, 4946.678465899741, 5063.746812659352, 5093.388793344822, 5100.69932167295, 5130.486951304877, 4609.861704148847, 4679.27471241958, 4785.712857228577, 4851.902961940777, 5387.0, 5199.766010529535, 5506.724663766796, 5603.579731520153, 5631.380548139701, 5726.5418766499, 3808.6762625176616, 4395.384646149541, 4860.198067318888, 4959.82640607577, 5015.749212539395, 5301.693763213015, 5392.514673679388, 5743.16724075011, 6073.483753880925, 6103.786367477117, 4219.409282700424, 4624.930626040612, 4684.133435314409, 4942.505749425029, 5002.799328161288, 5085.262636917626, 5086.516780905808, 5091.770870310845, 5131.794728210904, 5156.432792392834, 4280.89297767552, 4551.40831691878, 5092.6435149539175, 5343.332083489564, 5458.506555804289, 5117.820876269313, 5199.388189661217, 5556.749946252428, 5573.247611572467, 5727.284089488814, 1504.8946573739952, 1564.5853848730096, 1614.5802091456071, 1738.2699266308182, 1751.5796208910024, 1178.7878181927335, 1289.1362786932777, 1301.264785396248, 1307.457405176841, 1341.4768240386256, 4491.595756381941, 4882.853514394574, 4888.364512613338, 5067.756635753121, 5263.789208532426, 5079.6698214615935, 5733.655980641175, 5800.50695690871, 5846.532277417797, 5909.763609455659, 4459.955400446019, 4775.21209000511, 5063.835611081772, 5162.845114646567, 5261.447548007481, 2476.798752604985, 2544.3257536752776, 3024.7277745003057, 3029.5910052143117, 3066.4633689104317, 5598.440155984369, 5664.0, 5955.686971809895, 6092.268927728701, 6135.5398345124295, 5182.663126896739, 5617.831465056055, 5888.705564721747, 5998.920194365056, 6078.574499785061, 5346.1980702893325, 6057.666828324484, 6097.932861749265, 6207.534434917399, 6241.843953901189, 4799.952000479951, 5568.721563921868, 5679.233303504139, 5817.970910145422, 5835.620684655484, 5596.524295434933, 5816.883662326645, 5843.590948633725, 5856.531477481876, 5869.236999190078, 5295.841124766263, 5797.0, 5980.671063091571, 6079.392060793885, 6157.9384206157365, 4203.0, 4291.206126866539, 4643.930341044819, 4699.953000469952, 4709.952900470951, 5472.5621950243085, 5729.312482502127, 5772.163036359789, 5846.473817356458, 5893.734781934909, 5423.701696406735, 5457.881134367524, 5500.532454741392, 5590.2453168821685, 5615.129654903497, 5058.482455263333, 5097.661032024031, 5457.26177568367, 5638.126090455986, 5661.858453538694, 4983.43627037139, 5114.539691427789, 5288.8413347599635, 5440.80302333486, 5528.695921724344, 4880.023590445875, 5452.963936852144, 5513.669179849222, 5617.578681598815, 5659.547236221175, 4330.17726631939, 4627.400844977615, 5310.920336195038, 5375.59683023767, 5626.902753962938], "value": 4351.445734756421, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [713.2653367031959, 722.8482018776057, 748.9662965166568, 774.0711146624053, 819.8070162315804, 15247.542573722792, 16104.838951610494, 16117.597060073504, 16119.194040297967, 16321.673566528678, 14857.257137143126, 15068.47260345888, 15073.321700523475, 15093.169875656835, 15996.680066398665, 661.3750006244102, 679.952403331767, 927.9072092790701, 930.5347326336831, 953.9046095390474, 949.4350861237588, 955.0878910640322, 961.3895176562897, 965.8696076029717, 968.3028219681818, 1000.4297550396277, 1020.7346090016575, 1020.8162530744463, 1022.8874823769379, 1023.6980090873174, 1012.6810054832704, 1014.3204053284318, 1014.8274793285123, 1015.0610685116275, 1016.7508960304699, 749.6701451361383, 755.3692666623376, 756.2362014365531, 756.4251169111515, 757.2730179028084, 16338.918305408515, 16389.754153687703, 16390.918045409817, 16863.747043794352, 17072.146392680315, 13921.095128816696, 13924.791128133085, 13973.510927117502, 13974.720505589832, 14253.78619320711, 11709.94145029278, 11859.703507412298, 11872.406379681068, 11879.524819007229, 11914.821277680841, 3592.9281414371826, 3638.6907112895437, 3678.834452449646, 3692.187718701908, 3832.616738326145, 105684.94315056827, 108240.91759082387, 109225.36161957576, 109989.0, 110659.0, 10216.233782466195, 10468.52891619879, 10520.947395263127, 10526.894731052591, 10608.522616482276, 22897.88551057234, 22952.0, 22990.310290691305, 23076.0, 23404.7659523406, 7531.096268447822, 7533.2466753325325, 7604.315611594983, 7629.131406674215, 7733.304002639677, 3572.8928132156075, 4261.062566235423, 4322.212173148365, 4358.738475691469, 4419.867403977822, 3392.5928888533535, 3443.2252743133095, 3443.7589368744448, 3454.1191996040848, 3482.3035392921515, 515.6725479320584, 609.8597322615734, 622.2532960447481, 623.6663385089047, 638.5944924972675, 542.940276569577, 666.3236814633151, 668.5286872754697, 675.7330854312519, 681.8374671185617, 9681.080297371738, 9784.412935223767, 9842.917279099293, 9933.403995760278, 9937.45344006072, 631.7630888416844, 653.506602515098, 661.6559389117632, 664.3821246241042, 664.8703502816904, 4642.65180111493, 4794.736289504111, 4819.927701084486, 4824.8793780155775, 4843.709377437365, 94224.05775942153, 110972.0, 111431.0, 111538.0, 111594.0, 75438.81575987281, 77339.0, 80409.19590804134, 93232.53383733038, 95382.0, 84121.0, 84577.57711211282, 85251.57374213214, 86164.0, 88025.0, 7447.0, 8849.69026084084, 9228.769280768034, 9279.489628070522, 9367.907624925561, 46104.538954611366, 47284.0, 51599.0, 51730.74134629303, 54114.458855412515, 54169.0, 68863.65568172127, 70590.64704676444, 73284.0, 74663.62668186841, 12336.136470446983, 12680.11239213283, 12939.223646581235, 12998.805017924928, 13011.414486348327, 14566.854331456974, 14720.043197192148, 14976.625584360043, 15321.923390382977, 15479.84520154784, 12349.32078735678, 12355.62933112008, 13088.607341779762, 13268.734625307632, 13579.720210338406, 13217.603471895858, 13750.037497375088, 13790.586282411543, 14157.36291866848, 14398.568042958728, 12186.57346992851, 12578.30819304947, 12873.163244389085, 12977.870221297666, 13124.0, 9825.263105266991, 11276.0, 11310.967460922602, 11449.084073274285, 11677.240979336317, 10026.047525485068, 10082.99170083015, 10795.244332896622, 10812.729681758019, 10834.729131771768], "value": 7591.022675591696, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1539.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 119.0, 119.0, 119.0, 118.0, 121.0, 120.0, 119.0, 119.0, 121.0], "value": 118.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 112.0, 112.0, 149.0, 118.0, 112.0, 100.0, 106.0, 154.0, 96.0], "value": 120.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [206.0, 196.0, 200.0, 200.0, 197.0, 198.0, 198.0, 197.0, 199.0, 200.0], "value": 199.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 68.0, 84.0, 113.0, 54.0, 74.0, 53.0, 69.0, 96.0, 85.0], "value": 77.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 87.0, 64.0, 103.0, 101.0, 116.0, 102.0, 88.0, 83.0], "value": 91.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 89.0, 90.0, 116.0, 89.0, 90.0, 91.0, 89.0, 94.0, 86.0], "value": 92.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 97.0, 96.0, 99.0, 97.0, 117.0, 101.0, 150.0, 154.0, 96.0], "value": 110.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 92.0, 90.0, 92.0, 106.0, 102.0, 140.0, 91.0, 129.0, 141.0], "value": 108.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 65.0, 70.0, 70.0, 69.0, 68.0, 68.0, 69.0, 70.0], "value": 68.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 64.0, 63.0, 64.0, 60.0, 57.0, 59.0, 60.0, 61.0, 61.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 91.0, 101.0, 96.0, 84.0, 84.0, 84.0, 85.0, 83.0, 88.0], "value": 88.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 136.0, 145.0, 146.0, 146.0, 154.0, 160.0, 161.0, 181.0, 185.0], "value": 156.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 196.0, 161.0, 161.0, 158.0, 228.0, 225.0, 190.0, 171.0], "value": 181.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 66.0, 69.0, 67.0, 62.0, 66.0, 65.0, 67.0, 66.0], "value": 66.5, "unit": "score"}]}]} 01:59:21 INFO - Return code: 0 01:59:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:59:21 ERROR - # TBPL SUCCESS # 01:59:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:59:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:59:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:59:21 INFO - 2017-03-08 01:59:21.623 screenresolution[1657:10713] starting screenresolution argv=screenresolution get 01:59:21 INFO - 2017-03-08 01:59:21.626 screenresolution[1657:10713] Display 0: 1600x1200x32@60 01:59:21 INFO - 2017-03-08 01:59:21.632 screenresolution[1658:10716] starting screenresolution argv=screenresolution list 01:59:21 INFO - Available Modes on Display 0 01:59:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:59:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:59:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:59:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:59:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:59:21 INFO - Intel Iris: 01:59:21 INFO - Chipset Model: Intel Iris 01:59:21 INFO - Type: GPU 01:59:21 INFO - Bus: Built-In 01:59:21 INFO - VRAM (Dynamic, Max): 1536 MB 01:59:21 INFO - Vendor: Intel (0x8086) 01:59:21 INFO - Device ID: 0x0a2e 01:59:21 INFO - Revision ID: 0x0009 01:59:21 INFO - Displays: 01:59:21 INFO - Display: 01:59:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:59:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:59:21 INFO - Display Serial Number: 1600x1200 60 01:59:21 INFO - Main Display: Yes 01:59:21 INFO - Mirror: Off 01:59:21 INFO - Online: Yes 01:59:21 INFO - Rotation: Supported 01:59:21 INFO - Return code: 0 01:59:21 INFO - Running post-action listener: _resource_record_post_action 01:59:21 INFO - [mozharness: 2017-03-08 09:59:21.869074Z] Finished run-tests step (success) 01:59:21 INFO - Running post-run listener: _resource_record_post_run 01:59:21 INFO - Total resource usage - Wall time: 1201s; CPU: 55.0%; Read bytes: 46729728; Write bytes: 515992576; Read time: 439; Write time: 1666 01:59:21 INFO - TinderboxPrint: CPU usage
54.7% 01:59:21 INFO - TinderboxPrint: I/O read bytes / time
46,729,728 / 439 01:59:21 INFO - TinderboxPrint: I/O write bytes / time
515,992,576 / 1,666 01:59:21 INFO - TinderboxPrint: CPU idle
2,178.3 (45.3%) 01:59:21 INFO - TinderboxPrint: CPU system
965.8 (20.1%) 01:59:21 INFO - TinderboxPrint: CPU user
1,661.7 (34.6%) 01:59:21 INFO - TinderboxPrint: Swap in / out
262,885,376 / 0 01:59:21 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 204110336; Write bytes: 203180032; Read time: 15702; Write time: 420 01:59:21 INFO - run-tests - Wall time: 1181s; CPU: 55.0%; Read bytes: 44780032; Write bytes: 302056448; Read time: 417; Write time: 1218 01:59:22 INFO - Running post-run listener: _upload_blobber_files 01:59:22 INFO - Blob upload gear active. 01:59:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:59:22 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:59:22 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:59:22 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:59:22 INFO - (blobuploader) - INFO - Open directory for files ... 01:59:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:59:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:59:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:59:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:59:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:59:24 INFO - (blobuploader) - INFO - Done attempting. 01:59:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:59:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:59:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:59:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:59:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:59:24 INFO - (blobuploader) - INFO - Done attempting. 01:59:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 01:59:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:59:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:59:26 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 01:59:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:59:26 INFO - (blobuploader) - INFO - Done attempting. 01:59:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:59:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:59:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:59:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:59:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:59:28 INFO - (blobuploader) - INFO - Done attempting. 01:59:28 INFO - (blobuploader) - INFO - Iteration through files over. 01:59:28 INFO - Return code: 0 01:59:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:59:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:59:28 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/66690921430a693d3daf6a5ccb5077ba1e0e25938a1d246e543f26b167f0f44ae63df15ba86ef2abd8cfbe3384b879d21db77e463957d09cdcb35ac3e5f416f3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/62a51aee01930f22f753bd2598060ab3a237e26ee52e917bcccf787ed18b9721803189a99262be85e091576017a8e661119b6d3421d25f200a8a227282365670", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b53ae97381b1bcc7c1e54e237aa21a0cd2dc2d7f7de5697b2d166151351acba774c60b8b81cd763e4e03aef6e49e4b179e09f27fd7f2f8cd400664aadf2a8081", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/211c44d35d0698cbd163d1d10b9d380e67a2d3635e8d6e1236d6a8cd34a6c9b19ccf058f2f00eef7dd310dbabea737cf430b1446ac71996b8c4561f5a6a62e57"} 01:59:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:59:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:59:28 INFO - Contents: 01:59:28 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/66690921430a693d3daf6a5ccb5077ba1e0e25938a1d246e543f26b167f0f44ae63df15ba86ef2abd8cfbe3384b879d21db77e463957d09cdcb35ac3e5f416f3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/62a51aee01930f22f753bd2598060ab3a237e26ee52e917bcccf787ed18b9721803189a99262be85e091576017a8e661119b6d3421d25f200a8a227282365670", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b53ae97381b1bcc7c1e54e237aa21a0cd2dc2d7f7de5697b2d166151351acba774c60b8b81cd763e4e03aef6e49e4b179e09f27fd7f2f8cd400664aadf2a8081", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/211c44d35d0698cbd163d1d10b9d380e67a2d3635e8d6e1236d6a8cd34a6c9b19ccf058f2f00eef7dd310dbabea737cf430b1446ac71996b8c4561f5a6a62e57"} 01:59:28 INFO - Running post-run listener: copy_logs_to_upload_dir 01:59:28 INFO - Copying logs to upload dir... 01:59:28 INFO - mkdir: /builds/slave/test/build/upload/logs 01:59:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1283.923637 ========= master_lag: 0.53 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-03-08 01:59:28.714122) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-08 01:59:28.719567) ========= 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.5QFFkAG8Qy/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.TRoPGORKS2/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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/66690921430a693d3daf6a5ccb5077ba1e0e25938a1d246e543f26b167f0f44ae63df15ba86ef2abd8cfbe3384b879d21db77e463957d09cdcb35ac3e5f416f3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/62a51aee01930f22f753bd2598060ab3a237e26ee52e917bcccf787ed18b9721803189a99262be85e091576017a8e661119b6d3421d25f200a8a227282365670", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b53ae97381b1bcc7c1e54e237aa21a0cd2dc2d7f7de5697b2d166151351acba774c60b8b81cd763e4e03aef6e49e4b179e09f27fd7f2f8cd400664aadf2a8081", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/211c44d35d0698cbd163d1d10b9d380e67a2d3635e8d6e1236d6a8cd34a6c9b19ccf058f2f00eef7dd310dbabea737cf430b1446ac71996b8c4561f5a6a62e57"} build_url:https://queue.taskcluster.net/v1/task/SZBRaHDJQL6-kXN991bI_Q/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011242 build_url: 'https://queue.taskcluster.net/v1/task/SZBRaHDJQL6-kXN991bI_Q/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/66690921430a693d3daf6a5ccb5077ba1e0e25938a1d246e543f26b167f0f44ae63df15ba86ef2abd8cfbe3384b879d21db77e463957d09cdcb35ac3e5f416f3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/62a51aee01930f22f753bd2598060ab3a237e26ee52e917bcccf787ed18b9721803189a99262be85e091576017a8e661119b6d3421d25f200a8a227282365670", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b53ae97381b1bcc7c1e54e237aa21a0cd2dc2d7f7de5697b2d166151351acba774c60b8b81cd763e4e03aef6e49e4b179e09f27fd7f2f8cd400664aadf2a8081", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/211c44d35d0698cbd163d1d10b9d380e67a2d3635e8d6e1236d6a8cd34a6c9b19ccf058f2f00eef7dd310dbabea737cf430b1446ac71996b8c4561f5a6a62e57"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-08 01:59:28.754859) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 01:59:28.755195) ========= 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.5QFFkAG8Qy/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.TRoPGORKS2/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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.005179 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 01:59:28.805079) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-08 01:59:28.805539) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-08 01:59:28.806093) ========= ========= Total master_lag: 0.67 =========