builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0034 starttime: 1490478879.87 results: success (0) buildid: 20170325141615 builduid: 1bf813195a61458f80abe500864174e4 revision: 997b98cce1aebf76641e14c79ac250cdb147041c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-25 14:54:39.872546) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-25 14:54:39.873011) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-25 14:54:39.873331) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-25 14:54:39.901634) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-25 14:54:39.901989) ========= 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.SfwcAGVc2L/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.puJqDqQnKx/Listeners TMPDIR=/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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-25 14:54:39-- 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% 143M=0s 2017-03-25 14:54:40 (143 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.616971 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-25 14:54:40.545078) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-25 14:54:40.545398) ========= 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.SfwcAGVc2L/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.puJqDqQnKx/Listeners TMPDIR=/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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.029993 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-25 14:54:40.597585) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-25 14:54:40.597921) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 997b98cce1aebf76641e14c79ac250cdb147041c --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 997b98cce1aebf76641e14c79ac250cdb147041c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SfwcAGVc2L/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.puJqDqQnKx/Listeners TMPDIR=/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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-25 14:54:40,711 truncating revision to first 12 chars 2017-03-25 14:54:40,711 Setting DEBUG logging. 2017-03-25 14:54:40,711 attempt 1/10 2017-03-25 14:54:40,711 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/997b98cce1ae?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-25 14:54:42,750 unpacking tar archive at: mozilla-aurora-997b98cce1ae/testing/mozharness/ program finished with exit code 0 elapsedTime=2.319606 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-25 14:54:42.943479) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-25 14:54:42.943890) ========= script_repo_revision: 997b98cce1aebf76641e14c79ac250cdb147041c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-25 14:54:42.944473) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-25 14:54:42.944909) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-25 14:54:42.966442) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-03-25 14:54:42.967010) ========= /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.SfwcAGVc2L/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.puJqDqQnKx/Listeners TMPDIR=/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 14:54:43 INFO - MultiFileLogger online at 20170325 14:54:43 in /builds/slave/test 14:54:43 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 14:54:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:54:43 INFO - {'append_to_log': False, 14:54:43 INFO - 'base_work_dir': '/builds/slave/test', 14:54:43 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 14:54:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:54:43 INFO - 'branch': 'Mozilla-Aurora', 14:54:43 INFO - 'buildbot_json_path': 'buildprops.json', 14:54:43 INFO - 'config_files': ('talos/mac_config.py',), 14:54:43 INFO - 'default_actions': ('clobber', 14:54:43 INFO - 'read-buildbot-config', 14:54:43 INFO - 'download-and-extract', 14:54:43 INFO - 'populate-webroot', 14:54:43 INFO - 'create-virtualenv', 14:54:43 INFO - 'install', 14:54:43 INFO - 'run-tests'), 14:54:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:54:43 INFO - 'download_minidump_stackwalk': True, 14:54:43 INFO - 'download_symbols': 'ondemand', 14:54:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:54:43 INFO - 'tooltool.py': '/tools/tooltool.py', 14:54:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:54:43 INFO - '/tools/misc-python/virtualenv.py')}, 14:54:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:54:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:54:43 INFO - 'gecko_profile': False, 14:54:43 INFO - 'gecko_profile_interval': 0, 14:54:43 INFO - 'installer_path': 'installer.exe', 14:54:43 INFO - 'log_level': 'info', 14:54:43 INFO - 'log_name': 'talos', 14:54:43 INFO - 'log_to_console': True, 14:54:43 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:54:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:54:43 INFO - 'opt_config_files': (), 14:54:43 INFO - 'pip_index': False, 14:54:43 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:54:43 INFO - 'cmd': ('bash', 14:54:43 INFO - '-c', 14:54:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:54:43 INFO - 'enabled': True, 14:54:43 INFO - 'halt_on_failure': False, 14:54:43 INFO - 'name': 'check_screen_resolution'},), 14:54:43 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:54:43 INFO - 'cmd': ('bash', 14:54:43 INFO - '-c', 14:54:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:54:43 INFO - 'enabled': True, 14:54:43 INFO - 'halt_on_failure': False, 14:54:43 INFO - 'name': 'check_screen_resolution'},), 14:54:43 INFO - 'run_cmd_checks_enabled': True, 14:54:43 INFO - 'suite': 'dromaeojs-e10s', 14:54:43 INFO - 'system_bits': '32', 14:54:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:54:43 INFO - 'title': 't-yosemite-r7-0034', 14:54:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:54:43 INFO - 'use_talos_json': True, 14:54:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:54:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:54:43 INFO - 'work_dir': 'build'} 14:54:43 INFO - [mozharness: 2017-03-25 21:54:43.209464Z] Running clobber step. 14:54:43 INFO - Running pre-action listener: _resource_record_pre_action 14:54:43 INFO - Running main action method: clobber 14:54:43 INFO - rmtree: /builds/slave/test/build 14:54:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:54:45 INFO - Running post-action listener: _resource_record_post_action 14:54:45 INFO - [mozharness: 2017-03-25 21:54:45.940652Z] Finished clobber step (success) 14:54:45 INFO - [mozharness: 2017-03-25 21:54:45.940913Z] Running read-buildbot-config step. 14:54:45 INFO - Running pre-action listener: _resource_record_pre_action 14:54:45 INFO - Running main action method: read_buildbot_config 14:54:45 INFO - Using buildbot properties: 14:54:45 INFO - { 14:54:45 INFO - "project": "", 14:54:45 INFO - "product": "firefox", 14:54:45 INFO - "script_repo_revision": "production", 14:54:45 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 14:54:45 INFO - "repository": "", 14:54:45 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 14:54:45 INFO - "buildid": "20170325141615", 14:54:45 INFO - "pgo_build": "False", 14:54:45 INFO - "basedir": "/builds/slave/test", 14:54:45 INFO - "buildnumber": 87, 14:54:45 INFO - "slavename": "t-yosemite-r7-0034", 14:54:45 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 14:54:45 INFO - "platform": "yosemite_r7", 14:54:45 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 14:54:45 INFO - "branch": "mozilla-aurora", 14:54:45 INFO - "repo_path": "releases/mozilla-aurora", 14:54:45 INFO - "revision": "997b98cce1aebf76641e14c79ac250cdb147041c", 14:54:45 INFO - "stage_platform": "macosx64", 14:54:45 INFO - "builduid": "1bf813195a61458f80abe500864174e4", 14:54:45 INFO - "slavebuilddir": "test" 14:54:45 INFO - } 14:54:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/Mc7G7MfaRpOSnugAKTxNlw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 14:54:45 INFO - Running post-action listener: _resource_record_post_action 14:54:45 INFO - [mozharness: 2017-03-25 21:54:45.949135Z] Finished read-buildbot-config step (success) 14:54:45 INFO - [mozharness: 2017-03-25 21:54:45.949342Z] Running download-and-extract step. 14:54:45 INFO - Running pre-action listener: _resource_record_pre_action 14:54:45 INFO - Running main action method: download_and_extract 14:54:45 INFO - mkdir: /builds/slave/test/build/tests 14:54:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:54:45 INFO - trying https://queue.taskcluster.net/v1/task/Mc7G7MfaRpOSnugAKTxNlw/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 14:54:45 INFO - Downloading https://queue.taskcluster.net/v1/task/Mc7G7MfaRpOSnugAKTxNlw/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 14:54:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Mc7G7MfaRpOSnugAKTxNlw/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 14:54:46 INFO - Downloaded 1199 bytes. 14:54:46 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 14:54:46 INFO - Using the following test package requirements: 14:54:46 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 14:54:46 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 14:54:46 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 14:54:46 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 14:54:46 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 14:54:46 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 14:54:46 INFO - u'jsshell-mac.zip'], 14:54:46 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 14:54:46 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 14:54:46 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 14:54:46 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 14:54:46 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 14:54:46 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 14:54:46 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 14:54:46 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 14:54:46 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 14:54:46 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 14:54:46 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 14:54:46 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 14:54:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Mc7G7MfaRpOSnugAKTxNlw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 14:54:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Mc7G7MfaRpOSnugAKTxNlw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 14:54:46 INFO - Fetch https://queue.taskcluster.net/v1/task/Mc7G7MfaRpOSnugAKTxNlw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 14:54:48 INFO - Expected file size: 51786892 14:54:48 INFO - Obtained file size: 51786892 14:55:05 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 14:55:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Mc7G7MfaRpOSnugAKTxNlw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 14:55:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Mc7G7MfaRpOSnugAKTxNlw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 14:55:05 INFO - Fetch https://queue.taskcluster.net/v1/task/Mc7G7MfaRpOSnugAKTxNlw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 14:55:07 INFO - Expected file size: 51786892 14:55:07 INFO - Obtained file size: 51786892 14:55:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Mc7G7MfaRpOSnugAKTxNlw/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 14:55:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Mc7G7MfaRpOSnugAKTxNlw/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 14:55:23 INFO - Fetch https://queue.taskcluster.net/v1/task/Mc7G7MfaRpOSnugAKTxNlw/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 14:55:24 INFO - Expected file size: 14404438 14:55:24 INFO - Obtained file size: 14404438 14:55:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:55:24 INFO - trying https://queue.taskcluster.net/v1/task/Mc7G7MfaRpOSnugAKTxNlw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 14:55:24 INFO - Downloading https://queue.taskcluster.net/v1/task/Mc7G7MfaRpOSnugAKTxNlw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 14:55:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Mc7G7MfaRpOSnugAKTxNlw/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 14:55:27 INFO - Downloaded 74666998 bytes. 14:55:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Mc7G7MfaRpOSnugAKTxNlw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 14:55:27 INFO - mkdir: /builds/slave/test/properties 14:55:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:55:27 INFO - Writing to file /builds/slave/test/properties/build_url 14:55:27 INFO - Contents: 14:55:27 INFO - build_url:https://queue.taskcluster.net/v1/task/Mc7G7MfaRpOSnugAKTxNlw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 14:55:27 INFO - Running post-action listener: _resource_record_post_action 14:55:27 INFO - Running post-action listener: set_extra_try_arguments 14:55:27 INFO - [mozharness: 2017-03-25 21:55:27.833975Z] Finished download-and-extract step (success) 14:55:27 INFO - [mozharness: 2017-03-25 21:55:27.834130Z] Running populate-webroot step. 14:55:27 INFO - Running pre-action listener: _resource_record_pre_action 14:55:27 INFO - Running main action method: populate_webroot 14:55:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:55:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:55:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:55:27 INFO - '--tppagecycles', 14:55:27 INFO - '7'], 14:55:27 INFO - 'tests': ['tsvgm']}}, 14:55:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:55:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:55:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:55:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:55:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:55:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:55:27 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:55:27 INFO - 'talos_options': ['--disable-e10s'], 14:55:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:55:27 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:55:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:55:27 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:55:27 INFO - 'talos_options': ['--disable-e10s'], 14:55:27 INFO - 'tests': ['damp', 'tps']}, 14:55:27 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:55:27 INFO - 'tests': ['damp', 'tps']}, 14:55:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:55:27 INFO - 'tests': ['dromaeo_dom']}, 14:55:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:55:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:55:27 INFO - 'tests': ['basic_compositor_video']}, 14:55:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:55:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:55:27 INFO - 'tests': ['a11yr', 14:55:27 INFO - 'ts_paint', 14:55:27 INFO - 'tpaint', 14:55:27 INFO - 'sessionrestore', 14:55:27 INFO - 'sessionrestore_no_auto_restore', 14:55:27 INFO - 'tabpaint']}, 14:55:27 INFO - 'other-e10s': {'tests': ['a11yr', 14:55:27 INFO - 'ts_paint', 14:55:27 INFO - 'tpaint', 14:55:27 INFO - 'sessionrestore', 14:55:27 INFO - 'sessionrestore_no_auto_restore', 14:55:27 INFO - 'tabpaint']}, 14:55:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:55:27 INFO - 'ts_paint', 14:55:27 INFO - 'tpaint', 14:55:27 INFO - 'sessionrestore', 14:55:27 INFO - 'sessionrestore_no_auto_restore', 14:55:27 INFO - 'tabpaint']}, 14:55:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:55:27 INFO - 'ts_paint', 14:55:27 INFO - 'tpaint', 14:55:27 INFO - 'sessionrestore', 14:55:27 INFO - 'sessionrestore_no_auto_restore', 14:55:27 INFO - 'tabpaint']}, 14:55:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:55:27 INFO - 'tests': ['a11yr', 14:55:27 INFO - 'ts_paint', 14:55:27 INFO - 'tpaint', 14:55:27 INFO - 'sessionrestore', 14:55:27 INFO - 'sessionrestore_no_auto_restore', 14:55:27 INFO - 'tabpaint']}, 14:55:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:55:27 INFO - 'tests': ['a11yr', 14:55:27 INFO - 'ts_paint', 14:55:27 INFO - 'tpaint', 14:55:27 INFO - 'sessionrestore', 14:55:27 INFO - 'sessionrestore_no_auto_restore', 14:55:27 INFO - 'tabpaint']}, 14:55:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:55:27 INFO - 'tests': ['tsvgx', 14:55:27 INFO - 'tsvgr_opacity', 14:55:27 INFO - 'tart', 14:55:27 INFO - 'tscrollx', 14:55:27 INFO - 'cart', 14:55:27 INFO - 'tsvg_static']}, 14:55:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:55:27 INFO - 'tsvgr_opacity', 14:55:27 INFO - 'tart', 14:55:27 INFO - 'tscrollx', 14:55:27 INFO - 'cart', 14:55:27 INFO - 'tsvg_static']}, 14:55:27 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:55:27 INFO - 'talos_options': ['--disable-e10s'], 14:55:27 INFO - 'tests': ['tp5o']}, 14:55:27 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:55:27 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:55:27 INFO - 'talos_options': ['--disable-e10s', 14:55:27 INFO - '--xperf_path', 14:55:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:55:27 INFO - 'tests': ['tp5n']}, 14:55:27 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:55:27 INFO - 'talos_options': ['--xperf_path', 14:55:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:55:27 INFO - 'tests': ['tp5n']}}, 14:55:27 INFO - 'talos.zip': {'path': '', 14:55:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:55:27 INFO - Running post-action listener: _resource_record_post_action 14:55:27 INFO - [mozharness: 2017-03-25 21:55:27.853219Z] Finished populate-webroot step (success) 14:55:27 INFO - [mozharness: 2017-03-25 21:55:27.853337Z] Running create-virtualenv step. 14:55:27 INFO - Running pre-action listener: _resource_record_pre_action 14:55:27 INFO - Running main action method: create_virtualenv 14:55:27 INFO - Creating virtualenv /builds/slave/test/build/venv 14:55:27 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:55:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:55:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:55:27 INFO - Using real prefix '/tools/python27' 14:55:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:55:28 INFO - Installing distribute.............................................................................................................................................................................................done. 14:55:31 INFO - Installing pip.................done. 14:55:31 INFO - Return code: 0 14:55:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:55:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:55:32 INFO - Reading from file tmpfile_stdout 14:55:32 INFO - Output received: 14:55:32 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 14:55:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:55:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:55:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:55:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:55:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:55:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1074f3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074f6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf305b09f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072d1d30>, '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 0x1071f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1072c6be8>, '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.SfwcAGVc2L/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.puJqDqQnKx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:55:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:55:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:55:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SfwcAGVc2L/Render', 14:55:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:55:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:55:32 INFO - 'HOME': '/Users/cltbld', 14:55:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:55:32 INFO - 'LOGNAME': 'cltbld', 14:55:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:55:32 INFO - 'MOZ_NO_REMOTE': '1', 14:55:32 INFO - 'NO_EM_RESTART': '1', 14:55:32 INFO - 'PAGER': '/bin/cat', 14:55:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:55:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:55:32 INFO - 'PWD': '/builds/slave/test', 14:55:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:55:32 INFO - 'SHELL': '/bin/bash', 14:55:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.puJqDqQnKx/Listeners', 14:55:32 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 14:55:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:55:32 INFO - 'USER': 'cltbld', 14:55:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:55:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:55:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:55:32 INFO - 'XPC_FLAGS': '0x0', 14:55:32 INFO - 'XPC_SERVICE_NAME': '0', 14:55:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:55:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:55:32 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:55:32 INFO - Cleaning up... 14:55:32 INFO - Return code: 0 14:55:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:55:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:55:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:55:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:55:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:55:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1074f3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074f6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf305b09f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072d1d30>, '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 0x1071f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1072c6be8>, '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.SfwcAGVc2L/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.puJqDqQnKx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:55:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:55:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:55:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SfwcAGVc2L/Render', 14:55:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:55:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:55:32 INFO - 'HOME': '/Users/cltbld', 14:55:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:55:32 INFO - 'LOGNAME': 'cltbld', 14:55:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:55:32 INFO - 'MOZ_NO_REMOTE': '1', 14:55:32 INFO - 'NO_EM_RESTART': '1', 14:55:32 INFO - 'PAGER': '/bin/cat', 14:55:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:55:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:55:32 INFO - 'PWD': '/builds/slave/test', 14:55:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:55:32 INFO - 'SHELL': '/bin/bash', 14:55:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.puJqDqQnKx/Listeners', 14:55:32 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 14:55:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:55:32 INFO - 'USER': 'cltbld', 14:55:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:55:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:55:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:55:32 INFO - 'XPC_FLAGS': '0x0', 14:55:32 INFO - 'XPC_SERVICE_NAME': '0', 14:55:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:55:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:55:32 INFO - Downloading/unpacking psutil>=3.1.1 14:55:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:55:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:55:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:55:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:55:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:55:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:55:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:55:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:55:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:55:36 INFO - Installing collected packages: psutil 14:55:36 INFO - Running setup.py install for psutil 14:55:36 INFO - building 'psutil._psutil_osx' extension 14:55:36 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 14:55:37 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 14:55:37 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 14:55:37 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 14:55:37 INFO - building 'psutil._psutil_posix' extension 14:55:37 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 14:55:37 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:55:37 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:55:37 INFO - ^ 14:55:37 INFO - 1 warning generated. 14:55:37 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 14:55:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:55:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:55:37 INFO - Successfully installed psutil 14:55:37 INFO - Cleaning up... 14:55:37 INFO - Return code: 0 14:55:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:55:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:55:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:55:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:55:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:55:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:37 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 0x1074f3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074f6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf305b09f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072d1d30>, '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 0x1071f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1072c6be8>, '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.SfwcAGVc2L/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.puJqDqQnKx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:55:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:55:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:55:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SfwcAGVc2L/Render', 14:55:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:55:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:55:37 INFO - 'HOME': '/Users/cltbld', 14:55:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:55:37 INFO - 'LOGNAME': 'cltbld', 14:55:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:55:37 INFO - 'MOZ_NO_REMOTE': '1', 14:55:37 INFO - 'NO_EM_RESTART': '1', 14:55:37 INFO - 'PAGER': '/bin/cat', 14:55:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:55:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:55:37 INFO - 'PWD': '/builds/slave/test', 14:55:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:55:37 INFO - 'SHELL': '/bin/bash', 14:55:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.puJqDqQnKx/Listeners', 14:55:37 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 14:55:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:55:37 INFO - 'USER': 'cltbld', 14:55:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:55:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:55:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:55:37 INFO - 'XPC_FLAGS': '0x0', 14:55:37 INFO - 'XPC_SERVICE_NAME': '0', 14:55:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:55:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:55:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:55:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:55:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:55:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:55:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:55:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:55:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:55:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:55:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:55:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:55:40 INFO - Installing collected packages: mozsystemmonitor 14:55:40 INFO - Running setup.py install for mozsystemmonitor 14:55:41 INFO - Successfully installed mozsystemmonitor 14:55:41 INFO - Cleaning up... 14:55:41 INFO - Return code: 0 14:55:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:55:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:55:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:55:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:55:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:55:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1074f3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074f6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf305b09f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072d1d30>, '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 0x1071f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1072c6be8>, '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.SfwcAGVc2L/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.puJqDqQnKx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:55:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:55:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:55:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SfwcAGVc2L/Render', 14:55:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:55:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:55:41 INFO - 'HOME': '/Users/cltbld', 14:55:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:55:41 INFO - 'LOGNAME': 'cltbld', 14:55:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:55:41 INFO - 'MOZ_NO_REMOTE': '1', 14:55:41 INFO - 'NO_EM_RESTART': '1', 14:55:41 INFO - 'PAGER': '/bin/cat', 14:55:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:55:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:55:41 INFO - 'PWD': '/builds/slave/test', 14:55:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:55:41 INFO - 'SHELL': '/bin/bash', 14:55:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.puJqDqQnKx/Listeners', 14:55:41 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 14:55:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:55:41 INFO - 'USER': 'cltbld', 14:55:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:55:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:55:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:55:41 INFO - 'XPC_FLAGS': '0x0', 14:55:41 INFO - 'XPC_SERVICE_NAME': '0', 14:55:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:55:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:55:41 INFO - Downloading/unpacking jsonschema==2.5.1 14:55:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:55:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:55:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:55:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:55:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:55:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:55:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:55:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:55:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:55:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:55:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:55:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:55:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:55:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:55:44 INFO - Downloading functools32-3.2.3-2.tar.gz 14:55:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:55:44 INFO - warning: no files found matching '*.txt' 14:55:44 INFO - no previously-included directories found matching 'build' 14:55:44 INFO - no previously-included directories found matching 'dist' 14:55:44 INFO - no previously-included directories found matching '.git*' 14:55:44 INFO - Installing collected packages: jsonschema, functools32 14:55:44 INFO - Running setup.py install for functools32 14:55:44 INFO - warning: no files found matching '*.txt' 14:55:44 INFO - no previously-included directories found matching 'build' 14:55:44 INFO - no previously-included directories found matching 'dist' 14:55:44 INFO - no previously-included directories found matching '.git*' 14:55:44 INFO - Successfully installed jsonschema functools32 14:55:44 INFO - Cleaning up... 14:55:44 INFO - Return code: 0 14:55:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:55:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:55:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:55:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:55:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:55:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:44 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 0x1074f3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074f6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf305b09f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072d1d30>, '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 0x1071f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1072c6be8>, '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.SfwcAGVc2L/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.puJqDqQnKx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:55:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:55:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:55:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SfwcAGVc2L/Render', 14:55:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:55:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:55:44 INFO - 'HOME': '/Users/cltbld', 14:55:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:55:44 INFO - 'LOGNAME': 'cltbld', 14:55:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:55:44 INFO - 'MOZ_NO_REMOTE': '1', 14:55:44 INFO - 'NO_EM_RESTART': '1', 14:55:44 INFO - 'PAGER': '/bin/cat', 14:55:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:55:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:55:44 INFO - 'PWD': '/builds/slave/test', 14:55:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:55:44 INFO - 'SHELL': '/bin/bash', 14:55:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.puJqDqQnKx/Listeners', 14:55:44 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 14:55:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:55:44 INFO - 'USER': 'cltbld', 14:55:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:55:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:55:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:55:44 INFO - 'XPC_FLAGS': '0x0', 14:55:44 INFO - 'XPC_SERVICE_NAME': '0', 14:55:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:55:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:55:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:55:45 INFO - Cleaning up... 14:55:45 INFO - Return code: 0 14:55:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:55:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:55:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:55:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:55:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:55:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1074f3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074f6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf305b09f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072d1d30>, '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 0x1071f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1072c6be8>, '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.SfwcAGVc2L/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.puJqDqQnKx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:55:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:55:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:55:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SfwcAGVc2L/Render', 14:55:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:55:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:55:45 INFO - 'HOME': '/Users/cltbld', 14:55:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:55:45 INFO - 'LOGNAME': 'cltbld', 14:55:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:55:45 INFO - 'MOZ_NO_REMOTE': '1', 14:55:45 INFO - 'NO_EM_RESTART': '1', 14:55:45 INFO - 'PAGER': '/bin/cat', 14:55:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:55:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:55:45 INFO - 'PWD': '/builds/slave/test', 14:55:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:55:45 INFO - 'SHELL': '/bin/bash', 14:55:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.puJqDqQnKx/Listeners', 14:55:45 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 14:55:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:55:45 INFO - 'USER': 'cltbld', 14:55:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:55:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:55:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:55:45 INFO - 'XPC_FLAGS': '0x0', 14:55:45 INFO - 'XPC_SERVICE_NAME': '0', 14:55:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:55:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:55:45 INFO - Downloading/unpacking blobuploader==1.2.4 14:55:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:55:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:55:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:55:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:55:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:55:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:55:48 INFO - Downloading blobuploader-1.2.4.tar.gz 14:55:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:55:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:55:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:55:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:55:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:55:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:55:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:55:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:55:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:55:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:55:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:55:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:55:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:55:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:55:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:55:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:55:49 INFO - Downloading docopt-0.6.1.tar.gz 14:55:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:55:49 INFO - Installing collected packages: blobuploader, requests, docopt 14:55:49 INFO - Running setup.py install for blobuploader 14:55:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:55:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:55:49 INFO - Running setup.py install for requests 14:55:50 INFO - Running setup.py install for docopt 14:55:50 INFO - Successfully installed blobuploader requests docopt 14:55:50 INFO - Cleaning up... 14:55:50 INFO - Return code: 0 14:55:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:55:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:55:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:55:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:55:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:55:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1074f3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074f6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf305b09f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072d1d30>, '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 0x1071f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1072c6be8>, '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.SfwcAGVc2L/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.puJqDqQnKx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:55:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:55:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:55:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SfwcAGVc2L/Render', 14:55:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:55:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:55:50 INFO - 'HOME': '/Users/cltbld', 14:55:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:55:50 INFO - 'LOGNAME': 'cltbld', 14:55:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:55:50 INFO - 'MOZ_NO_REMOTE': '1', 14:55:50 INFO - 'NO_EM_RESTART': '1', 14:55:50 INFO - 'PAGER': '/bin/cat', 14:55:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:55:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:55:50 INFO - 'PWD': '/builds/slave/test', 14:55:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:55:50 INFO - 'SHELL': '/bin/bash', 14:55:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.puJqDqQnKx/Listeners', 14:55:50 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 14:55:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:55:50 INFO - 'USER': 'cltbld', 14:55:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:55:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:55:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:55:50 INFO - 'XPC_FLAGS': '0x0', 14:55:50 INFO - 'XPC_SERVICE_NAME': '0', 14:55:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:55:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:55:50 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-jPGEm8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:55:50 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-SD2WsZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:55:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:55:50 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-J8rNW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:55:51 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-lddQ1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:55:51 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-YdJrrZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:55:51 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-Wt5E0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:55:51 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-ggNShB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:55:51 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-VdqYwh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:55:51 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-9xjecK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:55:51 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-hP99Fp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:55:51 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-uvLeHK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:55:51 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-T98IDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:55:52 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-siy1up-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:55:52 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-gfl75i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:55:52 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-f94Z7P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:55:52 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-LslDfa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:55:52 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-FKuxip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:55:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:55:52 INFO - Running setup.py install for manifestparser 14:55:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:55:52 INFO - Running setup.py install for mozcrash 14:55:52 INFO - Running setup.py install for mozdebug 14:55:53 INFO - Running setup.py install for mozdevice 14:55:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:55:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:55:53 INFO - Running setup.py install for mozfile 14:55:53 INFO - Running setup.py install for mozhttpd 14:55:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:55:53 INFO - Running setup.py install for mozinfo 14:55:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:55:53 INFO - Running setup.py install for mozInstall 14:55:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:55:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:55:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:55:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:55:53 INFO - Running setup.py install for mozleak 14:55:53 INFO - Running setup.py install for mozlog 14:55:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:55:54 INFO - Running setup.py install for moznetwork 14:55:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:55:54 INFO - Running setup.py install for mozprocess 14:55:54 INFO - Running setup.py install for mozprofile 14:55:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:55:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:55:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:55:54 INFO - Running setup.py install for mozrunner 14:55:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:55:54 INFO - Running setup.py install for mozscreenshot 14:55:54 INFO - Running setup.py install for moztest 14:55:55 INFO - Running setup.py install for mozversion 14:55:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:55:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:55:55 INFO - Cleaning up... 14:55:55 INFO - Return code: 0 14:55:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:55:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:55:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:55:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:55:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:55:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1074f3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074f6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf305b09f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072d1d30>, '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 0x1071f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1072c6be8>, '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.SfwcAGVc2L/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.puJqDqQnKx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:55:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:55:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:55:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SfwcAGVc2L/Render', 14:55:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:55:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:55:55 INFO - 'HOME': '/Users/cltbld', 14:55:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:55:55 INFO - 'LOGNAME': 'cltbld', 14:55:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:55:55 INFO - 'MOZ_NO_REMOTE': '1', 14:55:55 INFO - 'NO_EM_RESTART': '1', 14:55:55 INFO - 'PAGER': '/bin/cat', 14:55:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:55:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:55:55 INFO - 'PWD': '/builds/slave/test', 14:55:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:55:55 INFO - 'SHELL': '/bin/bash', 14:55:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.puJqDqQnKx/Listeners', 14:55:55 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 14:55:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:55:55 INFO - 'USER': 'cltbld', 14:55:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:55:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:55:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:55:55 INFO - 'XPC_FLAGS': '0x0', 14:55:55 INFO - 'XPC_SERVICE_NAME': '0', 14:55:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:55:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:55:55 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-FMJgaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:55:55 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:55:55 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-q3zcw6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:55:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:55:55 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-J5y2Hr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:55:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:55:55 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-4Bd1uD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:55:56 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)) 14:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:55:56 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-iNAtwq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:55:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:55:56 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-ksoN58-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:55:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:55:56 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-hSuqzW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:55:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:55:56 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-1oPCEg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:55:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:55:56 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-qrLjLT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:55:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:55:56 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-cXFOQR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:55:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:55:56 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-slejE1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:55:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:55:56 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-xvZNgn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:55:56 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)) 14:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:55:56 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-mm46Pe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:55:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:55:57 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-wn8D9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:55:57 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)) 14:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:55:57 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-OlAiVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:55:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:55:57 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-DdYxI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:55:57 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)) 14:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:55:57 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-gCvxJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:55:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:55:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:55:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:55:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:55:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:55:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:55:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:55:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:55:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:55:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:55:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:56:00 INFO - Downloading blessings-1.6.tar.gz 14:56:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:56:00 INFO - Installing collected packages: blessings 14:56:00 INFO - Running setup.py install for blessings 14:56:00 INFO - Successfully installed blessings 14:56:00 INFO - Cleaning up... 14:56:00 INFO - Return code: 0 14:56:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:56:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:56:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:56:00 INFO - Reading from file tmpfile_stdout 14:56:00 INFO - Current package versions: 14:56:00 INFO - blessings == 1.6 14:56:00 INFO - blobuploader == 1.2.4 14:56:00 INFO - docopt == 0.6.1 14:56:00 INFO - functools32 == 3.2.3-2 14:56:00 INFO - jsonschema == 2.5.1 14:56:00 INFO - manifestparser == 1.1 14:56:00 INFO - mozInstall == 1.12 14:56:00 INFO - mozcrash == 1.0 14:56:00 INFO - mozdebug == 0.1 14:56:00 INFO - mozdevice == 0.49 14:56:00 INFO - mozfile == 1.2 14:56:00 INFO - mozhttpd == 0.7 14:56:00 INFO - mozinfo == 0.9 14:56:00 INFO - mozleak == 0.1 14:56:00 INFO - mozlog == 3.4 14:56:00 INFO - moznetwork == 0.27 14:56:00 INFO - mozprocess == 0.25 14:56:00 INFO - mozprofile == 0.28 14:56:00 INFO - mozrunner == 6.13 14:56:00 INFO - mozscreenshot == 0.1 14:56:00 INFO - mozsystemmonitor == 0.3 14:56:00 INFO - moztest == 0.8 14:56:00 INFO - mozversion == 1.4 14:56:00 INFO - psutil == 3.1.1 14:56:00 INFO - requests == 1.2.3 14:56:00 INFO - wsgiref == 0.1.2 14:56:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:56:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:56:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:56:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:56:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1074f3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074f6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf305b09f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072d1d30>, '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 0x1071f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1072c6be8>, '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.SfwcAGVc2L/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.puJqDqQnKx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:56:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:56:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:56:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SfwcAGVc2L/Render', 14:56:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:56:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:56:00 INFO - 'HOME': '/Users/cltbld', 14:56:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:56:00 INFO - 'LOGNAME': 'cltbld', 14:56:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:56:00 INFO - 'MOZ_NO_REMOTE': '1', 14:56:00 INFO - 'NO_EM_RESTART': '1', 14:56:00 INFO - 'PAGER': '/bin/cat', 14:56:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:56:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:56:00 INFO - 'PWD': '/builds/slave/test', 14:56:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:56:00 INFO - 'SHELL': '/bin/bash', 14:56:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.puJqDqQnKx/Listeners', 14:56:00 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 14:56:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:56:00 INFO - 'USER': 'cltbld', 14:56:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:56:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:56:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:56:00 INFO - 'XPC_FLAGS': '0x0', 14:56:00 INFO - 'XPC_SERVICE_NAME': '0', 14:56:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:56:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:56:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:56:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:56:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:56:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:56:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:56:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:56:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:56:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:56:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:56:01 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:56:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:56:01 INFO - Cleaning up... 14:56:01 INFO - Return code: 0 14:56:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:56:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:56:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:56:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:56:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:01 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 0x1074f3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074f6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf305b09f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072d1d30>, '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 0x1071f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1072c6be8>, '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.SfwcAGVc2L/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.puJqDqQnKx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:56:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:56:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:56:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SfwcAGVc2L/Render', 14:56:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:56:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:56:01 INFO - 'HOME': '/Users/cltbld', 14:56:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:56:01 INFO - 'LOGNAME': 'cltbld', 14:56:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:56:01 INFO - 'MOZ_NO_REMOTE': '1', 14:56:01 INFO - 'NO_EM_RESTART': '1', 14:56:01 INFO - 'PAGER': '/bin/cat', 14:56:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:56:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:56:01 INFO - 'PWD': '/builds/slave/test', 14:56:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:56:01 INFO - 'SHELL': '/bin/bash', 14:56:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.puJqDqQnKx/Listeners', 14:56:01 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 14:56:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:56:01 INFO - 'USER': 'cltbld', 14:56:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:56:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:56:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:56:01 INFO - 'XPC_FLAGS': '0x0', 14:56:01 INFO - 'XPC_SERVICE_NAME': '0', 14:56:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:56:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:56:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:56:01 INFO - Cleaning up... 14:56:01 INFO - Return code: 0 14:56:01 INFO - Running post-action listener: _resource_record_post_action 14:56:01 INFO - Running post-action listener: _start_resource_monitoring 14:56:01 INFO - Starting resource monitoring. 14:56:01 INFO - [mozharness: 2017-03-25 21:56:01.496324Z] Finished create-virtualenv step (success) 14:56:01 INFO - [mozharness: 2017-03-25 21:56:01.497337Z] Running install step. 14:56:01 INFO - Running pre-action listener: _resource_record_pre_action 14:56:01 INFO - Running main action method: install 14:56:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:56:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:56:01 INFO - Reading from file tmpfile_stdout 14:56:01 INFO - Detecting whether we're running mozinstall >=1.0... 14:56:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:56:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:56:01 INFO - Reading from file tmpfile_stdout 14:56:01 INFO - Output received: 14:56:01 INFO - Usage: mozinstall [options] installer 14:56:01 INFO - Options: 14:56:01 INFO - -h, --help show this help message and exit 14:56:01 INFO - -d DEST, --destination=DEST 14:56:01 INFO - Directory to install application into. [default: 14:56:01 INFO - "/builds/slave/test"] 14:56:01 INFO - --app=APP Application being installed. [default: firefox] 14:56:01 INFO - mkdir: /builds/slave/test/build/application 14:56:01 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'] 14:56:01 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 14:56:22 INFO - Reading from file tmpfile_stdout 14:56:22 INFO - Output received: 14:56:22 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 14:56:22 INFO - Running post-action listener: _resource_record_post_action 14:56:22 INFO - [mozharness: 2017-03-25 21:56:22.493131Z] Finished install step (success) 14:56:22 INFO - [mozharness: 2017-03-25 21:56:22.493305Z] Running run-tests step. 14:56:22 INFO - Running pre-action listener: _resource_record_pre_action 14:56:22 INFO - Running main action method: run_tests 14:56:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:56:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:56:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:56:22 INFO - 2017-03-25 14:56:22.508 screenresolution[1632:9353] starting screenresolution argv=screenresolution get 14:56:22 INFO - 2017-03-25 14:56:22.511 screenresolution[1632:9353] Display 0: 1600x1200x32@60 14:56:22 INFO - 2017-03-25 14:56:22.517 screenresolution[1633:9355] starting screenresolution argv=screenresolution list 14:56:22 INFO - Available Modes on Display 0 14:56:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:56:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:56:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:56:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:56:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:56:22 INFO - Intel Iris: 14:56:22 INFO - Chipset Model: Intel Iris 14:56:22 INFO - Type: GPU 14:56:22 INFO - Bus: Built-In 14:56:22 INFO - VRAM (Dynamic, Max): 1536 MB 14:56:22 INFO - Vendor: Intel (0x8086) 14:56:22 INFO - Device ID: 0x0a2e 14:56:22 INFO - Revision ID: 0x0009 14:56:22 INFO - Displays: 14:56:22 INFO - Display: 14:56:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:56:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:56:22 INFO - Display Serial Number: 1600x1200 60 14:56:22 INFO - Main Display: Yes 14:56:22 INFO - Mirror: Off 14:56:22 INFO - Online: Yes 14:56:22 INFO - Rotation: Supported 14:56:22 INFO - Return code: 0 14:56:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:56:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:56:22 INFO - Python 2.7.3 14:56:22 INFO - Return code: 0 14:56:22 INFO - grabbing minidump binary from tooltool 14:56:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:56:22 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 0x1072d1d30>, '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 0x1071f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1072c6be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:56:22 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:56:22 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 14:56:22 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:56:22 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:56:22 INFO - Return code: 0 14:56:22 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:56:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:56:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:56:22 INFO - ENV: RUST_BACKTRACE is now 1 14:56:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:56:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:56:22 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/Mc7G7MfaRpOSnugAKTxNlw/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0034', '--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 14:56:22 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/Mc7G7MfaRpOSnugAKTxNlw/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0034 --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 14:56:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SfwcAGVc2L/Render', 14:56:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:56:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:56:22 INFO - 'HOME': '/Users/cltbld', 14:56:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:56:22 INFO - 'LOGNAME': 'cltbld', 14:56:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:56:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:56:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:56:22 INFO - 'MOZ_NO_REMOTE': '1', 14:56:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:56:22 INFO - 'NO_EM_RESTART': '1', 14:56:22 INFO - 'PAGER': '/bin/cat', 14:56:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:56:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:56:22 INFO - 'PWD': '/builds/slave/test', 14:56:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:56:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:56:22 INFO - 'RUST_BACKTRACE': '1', 14:56:22 INFO - 'SHELL': '/bin/bash', 14:56:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.puJqDqQnKx/Listeners', 14:56:22 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 14:56:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:56:22 INFO - 'USER': 'cltbld', 14:56:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:56:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:56:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:56:22 INFO - 'XPC_FLAGS': '0x0', 14:56:22 INFO - 'XPC_SERVICE_NAME': '0', 14:56:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:56:22 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/Mc7G7MfaRpOSnugAKTxNlw/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0034', '--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 14:56:23 INFO - mozversion application_buildid: 20170325141615 14:56:23 INFO - mozversion application_changeset: 997b98cce1aebf76641e14c79ac250cdb147041c 14:56:23 INFO - mozversion application_display_name: FirefoxDeveloperEdition 14:56:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:56:23 INFO - mozversion application_name: Firefox 14:56:23 INFO - mozversion application_remotingname: firefox-dev 14:56:23 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:56:23 INFO - mozversion application_vendor: Mozilla 14:56:23 INFO - mozversion application_version: 54.0a2 14:56:23 INFO - mozversion platform_buildid: 20170325141615 14:56:23 INFO - mozversion platform_changeset: 997b98cce1aebf76641e14c79ac250cdb147041c 14:56:23 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:56:23 INFO - mozversion platform_version: 54.0a2 14:56:23 INFO - using testdate: 1490478983 14:56:23 INFO - actual date: 1490478983 14:56:23 INFO - starting webserver on 'localhost:49245' 14:56:23 INFO - SUITE-START | Running 2 tests 14:56:23 INFO - TEST-START | dromaeo_css 14:56:23 INFO - operating with platform_type : mac_ 14:56:23 INFO - Initialising browser for dromaeo_css test... 14:56:23 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/tmpnYT9xv/profile http://localhost:49245/getInfo.html) 14:56:26 INFO - PROCESS | 1643 | 2017-03-25 14:56:26.322 plugin-container[1645:9531] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9247, name = 'com.apple.tsm.portname' 14:56:26 INFO - PROCESS | 1643 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:56:26 INFO - PROCESS | 1643 | 2017-03-25 14:56:26.325 plugin-container[1645:9531] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4917, name = 'com.apple.CFPasteboardClient' 14:56:26 INFO - PROCESS | 1643 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:56:26 INFO - PROCESS | 1643 | 2017-03-25 14:56:26.325 plugin-container[1645:9531] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:56:26 INFO - PROCESS | 1643 | __metrics Screen width/height:1600/1200 14:56:26 INFO - PROCESS | 1643 | colorDepth:24 14:56:26 INFO - PROCESS | 1643 | Browser inner width/height: 1024/689 14:56:26 INFO - PROCESS | 1643 | __metrics 14:56:26 ERROR - PROCESS | 1643 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 14:56:27 INFO - TEST-INFO | 1643: exit 0 14:56:27 INFO - Browser initialized. 14:56:27 INFO - Running cycle 1/1 for dromaeo_css test... 14:56:27 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/tmpnYT9xv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:56:30 INFO - PROCESS | 1647 | 2017-03-25 14:56:30.257 plugin-container[1648:9657] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x434b, name = 'com.apple.tsm.portname' 14:56:30 INFO - PROCESS | 1647 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:56:30 INFO - PROCESS | 1647 | 2017-03-25 14:56:30.257 plugin-container[1648:9657] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4617, name = 'com.apple.CFPasteboardClient' 14:56:30 INFO - PROCESS | 1647 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:56:30 INFO - PROCESS | 1647 | 2017-03-25 14:56:30.257 plugin-container[1648:9657] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:56:39 INFO - PROCESS | 1647 | RSS: Main: 221077504 14:56:39 INFO - PROCESS | 1647 | 14:59:41 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49245/tests/dromaeo/cssquery-ext.html) 14:59:42 INFO - PROCESS | 1647 | RSS: Main: 239177728 14:59:42 INFO - PROCESS | 1647 | 15:01:27 INFO - PROCESS | 1647 | ************************* 15:01:27 INFO - PROCESS | 1647 | A coding exception was thrown and uncaught in a Task. 15:01:27 INFO - PROCESS | 1647 | 15:01:27 ERROR - PROCESS | 1647 | Full message: TypeError: NetworkError when attempting to fetch resource. 15:01:27 INFO - PROCESS | 1647 | Full stack: 15:01:27 INFO - PROCESS | 1647 | ************************* 15:02:44 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-ext.html (next: http://localhost:49245/tests/dromaeo/cssquery-jquery.html) 15:02:45 INFO - PROCESS | 1647 | RSS: Main: 248639488 15:02:45 INFO - PROCESS | 1647 | 15:05:47 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49245/tests/dromaeo/cssquery-mootools.html) 15:05:48 INFO - PROCESS | 1647 | RSS: Main: 256512000 15:05:48 INFO - PROCESS | 1647 | 15:08:50 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49245/tests/dromaeo/cssquery-prototype.html) 15:08:51 INFO - PROCESS | 1647 | RSS: Main: 253296640 15:08:51 INFO - PROCESS | 1647 | 15:11:54 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49245/tests/dromaeo/cssquery-yui.html) 15:11:54 INFO - PROCESS | 1647 | RSS: Main: 260141056 15:11:54 INFO - PROCESS | 1647 | 15:14:57 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-yui.html (next: http://localhost:49245/tests/dromaeo/cssquery-dojo.html) 15:14:57 INFO - PROCESS | 1647 | RSS: Main: 256315392 15:14:57 INFO - PROCESS | 1647 | 15:14:57 INFO - PROCESS | 1647 | __start_tp_report 15:14:57 INFO - PROCESS | 1647 | _x_x_mozilla_page_load 15:14:57 INFO - PROCESS | 1647 | _x_x_mozilla_page_load_details 15:14:57 INFO - PROCESS | 1647 | |i|pagename|runs| 15:14:57 INFO - PROCESS | 1647 | |0;dojo.html;2241.686163937048;2785.913493737442;2809.2695899066243;2848.9715102848977;2849.52982757845;4021.879343619689;4806.327114204014;4886.291487734281;4896.779644915979;4923.729194894279;4824.7105173689515;4829.396325459317;4831.516848315176;4901.3138160657445;4913.164761990462;4463.018136010072;4481.932771008429;4519.367288579585;4539.795709193094;4592.173408786417;4468.039371535119;4488.798004089807;4489.2817149256125;4518.661100417466;4541.000979784442;4320.243957307474;4491.752953587551;4497.617702495292;4511.255642818947;4554.476235232957;4347.891302717426;4432.601065904084;4457.907812585905;4552.658550608718;4583.03756211196;4442.711223770477;4478.395416618748;4482.798274077674;4485.932711009337;4525.094981003779;4745.620350371996;4848.418189817245;4901.166801643729;4907.214845624683;4941;5110.207917772751;5166.405863325691;5211.609129315279;5244.370675518962;5262.500062494057;5451.918221226685;5453.15476101205;5489.752961116719;5491.725413729338;5496.31296087989;5064.848054558369;5087.97456012725;5094.4650811664615;5096.311997880312;5130.512601302833;5207.218917162456;5276.208568714724;5472.945270547323;5502.724863756796;5526;5134.691918484903;5232.895342093213;5316.760745766373;5320.866978325573;5327.041132596092;5238.345206849144;5363.892722145613;5369.00673375419;5378.462153784669;5402.567794576425;5280.815171469057;5328.733563321818;5336.573074154058;5354.330708661418;5363.30277063987;5119.411267704188;5163.044836705221;5198.532132108128;5297.655652382583;5355.946440535623;3792.1657235408165;4092;4398.780060996937;4420.115976804652;4433.800478978454;3903.0632648164237;3910.7849068300948;3914.1780226152828;3915.8237879295502;3932.0563064864227;4584.358189853423;4664.580187783115;4871.3667223260745;4878.682885612495;4878.707277563358;5231.973840130775;5263.368395792453;5344.9732751336;5345.572354211654;5351.946480535223;4846.733429661332;4850.708957462563;4850.902981940412;4862.489438608965;4895.437024742129;4541.182587134282;4693.9765301173275;4727.573690718376;4728;4761.857144285677;5464.699441530754;5489.505944465017;5493.066178749542;5532.197831314517;5569;5368.973155134356;5384.246205531151;5387.057264978692;5396.325459317585;5405.513503784521;5468.28912241406;5531.170324451365;5574.609777315549;5576.9163462547285;5599.32808063035;5020.146575082172;5092.3889133302755;5150.072986862401;5165.896682066413;5289.550388217045;5363.946360536344;5383.273258110105;5419.539339156216;5425.050616142238;5451.264079349396;4977.800887964441;5016.799328026838;5154.098032844162;5194.7922083116255;5226.163813789775;3899.7660140391667;4366.628836548929;4376.015396535754;4389.780510974375;4897.240927656219;4225.535191128912;4463.464384273778;5092.898142037213;5114.207297868837;5160.690358578498;4486.0803535275845;4994.850154495371;5189.6886186828915;5193.974030129825;5202.531772140525;5061.291419201389;5094.7962081516325;5102.336696229467;5135.818761684908;5141.588672906233 15:14:57 INFO - PROCESS | 1647 | |1;ext.html;720.9711611535539;763.2291385700443;788.6805843633329;910.7677542226731;911.3210658059746;30956;36686.44970325444;37096.258074838486;38195;38257.234855302944;36969.44545831808;37362.87911362664;37402.438963415574;37489.43765843515;37542;8147.837043259131;8496.490210587353;8560.529170895597;8593.484390936532;8616.612252448624;8401.663933442655;8474.87287690682;8492.447990880604;8498.532580708059;8522.914770852305;7465.776026719207;7800.2979731824125;8019.599020049003;8520.659173633047;8527.829443411129;8410.03284622264;8428.072911979678;8466.66133354668;8470.957645211765;8471.364647651451;7301.379382752472;8165.8366832663605;8230.341572674171;8243.958780206121;8259.091499935003;28067.719322806715;30801;32355.6764432355;32469.675303246902;32516.18709532257;3502.2995400919917;3514.912127196815;3572.5891522474726;3613.0606042428894;3724.7951362675044;20414.89792551028;23291.3012609622;24138.758612413825;24268.39329016771;25052.248432547054;2707;2862.69747264996;2952.8818847246084;2976.434477449278;3017.1401150671954;338027;338036;338408;340141;342100;41569.79215103905;42177.15645687131;42246.57753422488;42277.57722422798;42296.788516057226;43869.341959870624;44316.11367772691;44366.89082772892;44385.556144438146;44501;12986.870131298756;13256.469741210243;13257.801132983013;13267.535636252878;13287.402066907012;11423.771524569462;11461.656150315337;11463.197576169754;11468.827967580493;11469.0251328638;11198.936101070385;11351.035162011322;11364.261323013978;11465.31208127515;11481.425928703531;5280.471952804689;5403.540699040625;5420.937170498656;5424.945750542444;5429.294191755047;943.8772959515356;952.8189643967625;995.00002497491;1002.6691191906654;1043.1967385113421;21785.019674114705;24681.382965426008;26066.86966565155;26119.347016324366;26151.346216344744;976.5800705696619;1042.4266653340633;1065.1106326217696;1104.4808939798281;1109.9278546894427;10830.837537436944;12923.095383323265;13577.321133943264;13597.252151131584;13635.318234088454;458548;466428;477841;492724;578128;38634.42048369277;39322.213555728726;45920;46142.84642883888;46158.76920615443;1306.151001848806;1339.5378594384922;1342.6911810283493;1353.3301015997145;1354.3499120422055;22230.333090007327;24441.144559940316;25957;26023.479530409666;26209.213723588324;38954.831355059396;39279.018024549616;39280.80359598184;39374.80312598419;39375.80312098536;389308;443282.5671743241;451202;452283;454787;27481.86259068692;27785.610719464352;27864.721352787023;28129.859350703115;28170.43659126847;34421;34778.13054673653;35504.64495355013;35638.8218058908;35679.28641427105;21218.78781212168;23461.59230446179;24527.754722452548;26033.349166270236;26275.343116422242;21363.679544806528;24863.502729945663;25226.243212703648;25801.838917248395;26047.73952260453;29268.414631707674;29611.667474963248;29714;29840.552391713707;29924.85037574798;21019.369418917457;21501.6774748382;24812;25201.739913004643;25944.221673349828;16139;20375.57370984017;21176.470588235417;21232.681509777674;21330 15:14:57 INFO - PROCESS | 1647 | |2;jquery.html;354.2878813584696;359.39442040162345;379.7835233916668;388.2661769256106;413.6246978795506;18846.905765471172;19675.5081122972;19774.7033794493;20146;20323;20911.268105616306;21020.159193632237;21564.245251416163;21654;21913.780862191372;6307.810765677037;6420.1653785008;6532.542722009462;6540.051692504584;6628.60228386296;6413.390727880844;6531.281559028503;6545.770898018571;6571.835704107388;6903.4132098771415;7334;7400.814979625526;7403.2226616205335;7414.703411863519;7418.554886706815;6258.280297765769;7086.71653133874;7365.594892280922;7373.446991475661;7400.555966642019;6383.138276332682;7076.787696369117;7079.504434689574;7159.176694680126;7159.212486626467;24102.397440063964;24683.25950221496;24829.130980415597;24887;25338.619920701203;3160.5259211118287;3186.85659145339;3200.6159260888844;3239.060672405;3249.3501299740146;12973.962083033335;13235.602931912059;14139.293035348192;15384.923055386127;15822.208889555477;1887.631911777204;1889.2159753702335;1954.482062253504;1962.1268535501708;1970.3793305108845;152881.23559382244;155771;162872;162883.18558407252;165199.17400413041;18128.45614631563;19253.422397328104;19855.305064322678;19969.60060798776;20023.699644505345;23618.763812362;29149.56275655867;29534.55698164529;29783.40433191324;29840.55239171414;9734;9881.604735810632;10017.549210285555;10037.247206459544;10185.33795303303;6921.653917304115;7485.737999170003;8066.717664881701;8565.443246188977;8567;9011.143941325563;9016.368854180144;9174.449533028039;9181.449113053239;9196.264298856075;3616.81915904209;3981.243563722883;4002.779847108437;4116.897077573085;4119.691023173274;827.9089300177096;852.3564708644933;866.8829707989466;869.9217070463689;875.1557438325442;19868.30460933889;20074.799252007586;20336.88147151921;20407.693884591743;20413;709.9467539934526;790.9881351779728;855.5978690015683;887.1527691055027;925.8796356473615;8963;9332.90667093334;10577.565822948858;10665.786684266272;10726.302790318605;642407;716418;724295;735854;738563;117080.82919170869;143217.28391357977;143272.28363858323;144472;146997.7950330746;1083.7994970930404;1087.065123993365;1111.8332250162377;1115.275071203724;1116.3023110556064;16771.580710482336;17689.02710350943;17737.556561086076;17763.73354399711;18070.728939066186;55989.44010559842;56367.308980730646;56676.433235667115;57073;57488.71255643695;81243.18756812357;82106.58946705467;83235.5838220805;83437.58281208797;85732.57133714292;11156.10751139923;11321.150913681342;11360.829587556029;11542.480588373375;11645.77719339491;12414.937925310676;12439.129260951646;12452.252864828139;12509.499620015098;12749.49002039908;9279.72160835176;10653.987871152229;10665.626703065356;10800.541926839776;10904.345739255352;9882.061204185591;10072.294939354175;10093;10336.17310615134;10360.481975901326;10880.020798128206;11075.446227688422;11153.55385784592;11232.4383780809;11269.943650281695;10279.280450368402;11222.933821286964;11480.311181329147;11575.536978520764;11576.24754390962;8735.30117590604;8891.555422228734;9171;9574.808503830023;10126.696199114038 15:14:57 INFO - PROCESS | 1647 | |3;mootools.html;1221.1635030004447;1333.6265845563246;1487.6652753130547;1492.8581784730454;1499.2054211268032;9291.814163716721;10184.541695623697;10395.168386529078;10633.989770971764;10737.141028717704;10491.42297173655;10691.625793097242;10731.83902241467;10738.785224295509;10762.623308184215;2291.450051987519;2313.144136669435;2314.7222333320024;2316.4672125411166;2317.0615900560215;1935.7870634230223;2185.7923497267734;2286.211257116292;2290.8510946788488;2305.561943230789;2202.8347873909443;2267.2064777327887;2275.1581914691587;2275.681404603357;2286.0969916882905;1694.7712058872141;2237.675537047119;2245.8877056147207;2258.954820903581;2265.7734226577295;1878.4552479780984;1964.8428125749906;2248.291788086764;2251.279590531031;2277.350954977823;10366.274360794747;10666.893331066667;10781.514831832586;10813.297135686154;10849.728756781065;5519.558435325164;5704.458076482769;5721.113227449752;5726;5747.425257474261;3348.7488438366977;3439.6216416194197;3442.431998720208;3499.527563778908;3500.789952602852;1105.4528008635696;1117.0728295514702;1130.1467392118898;1164.1094562659573;1176.1120354132574;14687.63280917975;14793.926030369887;14861.331240094221;14878.479253226085;14898.851011489854;4166.791660416967;4466.196084704784;4491.101779644085;4575.2450845610765;4592.632589392841;10918.890811091787;10956.890431095746;10971.177161712743;10993.450327483593;11015.173861960386;5377.032134215879;5388.676679399248;5400.567954563626;5403.081476149064;5407.70257635826;4725.574698277172;4877.878053048631;4995.650304478724;5063.696178229318;5068.543831055223;3632.54593175853;3703.7962912039557;3703.9814800925824;3778.7543809652284;3785.886423407302;972.5429048347265;988.6589126751403;993.7515621094726;993.8409854423257;1010.6159659329408;618.1407843098098;798.9960050199712;815.7600447320041;843.1821133500495;856.9742907712779;5811.912821307684;6027.21646185993;6412.583182093149;6488.416042556099;6548.738050478023;816.2042009041137;894.2041582991143;916.5142474488532;973.600823662295;980.352967041749;3728.3848165052464;3983.063979964706;4030.153667729751;4090.8568200112854;4093.5497095319492;12770.68073298175;13352.532661356807;13399.196048236941;13408.664783380493;13452.46190152383;12511.186772859735;13279.933600331937;13294.734105317839;13297.002724795679;13314.201147931155;9539.284553658503;9776.462294573725;9854.014598540089;9857.162141218078;9873.654422095193;4931;6473;6509.576877502947;6675.032120342426;6698.899516507159;11600.477978491157;11907.583234586747;12144.817827732768;12168.452419641315;12204.755904881675;11490.94254528722;11806.645800625995;11866.288022718665;12049.216800907912;12271.69320766988;8171.836563268583;8178.304844088319;8261.339092872435;8281.420300578902;8328.208820162075;9853.901460985298;10025.047620476043;10030.99690030991;10033.19734421259;10052.54763535628;7299.963500182465;8427.030891447563;8507.149285071444;8511.574421279036;8590.65637374498;8271.296939759946;8273.33813294923;8369.121242269473;8456.323494120332;8498.660053597787;6632.2372927114;7491.213422590549;7618.6190690466365;7700.499467534592;7735.6905723770415;5518.724063796713;5578.2748242728185;5684.005299072563;5832.445917637818;5835.649861008353;5660.094384898396;5680;5797.710114494343;5831.096180092092;5853.560982926383 15:14:57 INFO - PROCESS | 1647 | |4;prototype.html;327.6772379206483;332.3884053341852;345.29559698215644;348.63393436891266;356.53116152259776;4011.8194681239343;4060.736052156615;4067.942334992901;4114.5599040335865;4425.822967081317;3478.65213478652;4147.460830092084;4224.711463003782;4246.278132717438;4291.613754762071;3387.762856600033;3556.413191823346;3569.607343192247;3586.5875424326277;3670.3026424979303;3449.0687514371107;3463.4977928200524;3534.8586056557706;3593.7125029997537;3612.8554857805657;2939.4855900217485;3082.8766849326;3598.874039408608;3604.981975090121;3645.5807582127995;3183.522471629251;3451.3097380523745;3611.6388361163936;3618.855245790165;3643.708503319728;2764.9723502764914;2820.873060712273;3273.5580696605894;3319.867205311785;3327.584051993501;3494.947575786365;3852.5184351956004;3944.053427177457;4080.9183816323803;4081.89795255121;3918.119302734675;4200.558941311149;4257.680673949466;4276.550962148961;4313.956860431387;4030.576789437096;4180.581941805795;4339.305711086211;4589.04006915541;4611.654125940568;3229.418704633165;3690.944635830465;3761.699064074895;3775.716821238391;3806.7144964127524;4170.811318774135;4396.978015109904;4597.42532183477;4745.881352966204;4753.3107699383745;3367.6800703933086;3577.4633804929467;3770.7368031709684;3771.6039815818945;3843.6925045996254;3333.1333853198344;3843.7693738375788;3849.557300910431;3855.8650447234772;3912.0415498203124;3407.437772767515;3592.317459682652;4130.6282434581035;4159.876833255004;4186.246475634354;4349.3041113421705;4515.14212299662;4548.681592288574;4613.385315139674;4630.360694404225;1133.7732453509332;1320.0165876422127;1321.4648067532664;1326.5091915991145;1328.9434899255116;868.431177578687;930.7254359963827;958.8082383523184;970.5923512124924;1014.9039037839116;3870.477485539416;3891.5135608048995;4076.5120730932995;4077.7145599808323;4102.343625019982;4200.266636041842;4230.181022160439;4689.179393606105;4707.599854012379;4761.642876784185;3664.1755604988666;3675.448682697563;4123.217068200873;4153.709240353146;4161.729487583298;2111.6410210263984;2213.8339624528226;2233.396982814631;2449.2774631483753;2480.875956202183;4351.782410879443;4425.668074894395;4825.686330388514;4956.431369414016;4984.252362145708;4309.59058889405;4508.797104130322;4952.777125029383;4964.925526117111;4979.975100124476;4358.607725304738;4574.4968053514085;4810.845397104739;4878.78045487961;4990.456775689301;4345.326474396474;4663.836765713184;4711.691271277118;4716.693414928019;4729.8108075677965;3899.395593682984;4158.708890377766;4274.2733735264455;4483.327500874895;4624.075184962953;4560.635149188123;4570.874543337364;4668.789904454376;4918.712798548692;4937.407511098548;3467.618561958233;3901.853980310761;4102.446169767162;4225.8309667614185;4271.2738834397605;4038.273110840077;4392.484592815601;4400.141972315368;4701.130290896195;4749.810007599657;4451.376807246923;4516.567408769424;4635.261776833688;4649.3026046092;4666.173737535189;4214.4406569569455;4439;4501.954980450154;4638.750206149947;4645.326427667902;4076.980754811297;4179.97910010448;4541;4542.454905411372;4602.401687780567;4141.275276826604;4204.192197355167;4607.585317321457;4642.767861606973;4655.2784318430695;3975.2372101389255;4205.810738516835;4369.563043695605;4501.6848820582245;4542.409486766699 15:14:57 INFO - PROCESS | 1647 | |5;yui.html;677.6476232359173;708.7731925783751;748.1657951384204;788.5899332347179;790.3124281874769;14537.200453975027;14741.336639851206;15179.544613661608;15529;15537.223138843055;16810.411635592758;16948.49154525363;16952.06763628;16982.915085424585;17065.14674266288;859.6503489521454;904.6833608237097;906.0350726476298;941.5527624378434;942.5946842857569;870.251583638074;920.6087412849546;942.2462030375706;942.4109931292942;943.4763706143087;981.8379967305422;984.8522721591783;985.526947065409;987.8271302522065;989.4211886046671;850.5662112322728;978.295627148452;979.5200351827624;979.9755006124833;981.2836629260609;722.8734971379987;725.575538310084;728.3481284250566;729.7081167533029;730.8940203670438;14827.555173344817;15691.686166276724;15753.842461575352;16010.799190060792;16054.5986350341;10523.000314970066;12746.421552083562;13498.122622029636;13505.594832155051;13655.795163072562;11042.889571104266;11244.212905096647;11530.884691153065;11604.30374177552;12063.336516491589;3409.113630456099;3453.568303962005;3484.61669216386;3495.10874726943;3616.077900135475;79662;109085;110254;111241;113562.43218783935;10361.844572331422;10465.058144767008;10704.625338113128;10712.089472394933;10831.891681083089;19683.606327873364;19798;19819.504512387306;19861.30485433003;20540;6974;7021.254308474224;7437.330640242296;7514.511556748794;7621.847563048708;3813.637704418076;4038.676905847525;4125.23683118624;4138.586141385837;4144.70987030911;3315.751318651111;3360.5631267935014;3401.795892246473;3413.419718647836;3420.504026916133;525.8632755483525;617.0928734759896;623.3236937922314;625.6308777821016;634.6192284629185;492.9112759703288;494.75756879128966;587.9235699359056;596.385722705614;620.5376994139395;8738.563071846509;9583.904160958302;9599.47202903833;9606.855897161548;9725.951370243245;584.8596336879118;595.2440400691098;624.6127401011402;634.5716641267127;653.6535636112868;3727.310447567209;4246.766427846436;4319.805608747551;4750;4824.252240902666;79818.6009069951;82791.58604206941;83027.58486207652;88683.11316886877;90044.549777252;75771.62114189393;79704.31449278214;82813.343733125;83289.16710832935;83451.5827420859;73142.63428682822;75527.24472755312;76588.61705691436;77407;78407.60796195868;9221.953890230507;9492.715218543455;9953.402795832273;10655.467226638482;10688.519016644113;43494.56505434905;46557.76721116373;47266.291005635634;48457.75771121122;48460.273095902885;43644.47244346433;53730.73134634302;61193.69403152956;61734.69132654308;61883.07175392283;11899.524019039141;11926.761464770829;12032.217905836093;12109.33398663082;12214.450349734105;13326.40031198579;13514.729705406033;13816.447342106203;13976.720465590428;14373.20947347864;12723.172993755376;12729.55446559366;13149.868501314864;13452.192868427926;13546.514811367293;12234;12909.483620655068;12940.288284144463;13149;13505.324733763076;11902.226355286879;12586.811197832223;13133.146345487512;13188;13318.800217996932;9303.72088837336;9355.81288374215;9397.29520285995;9543.47510886908;9580.76048098803;7040.612766297902;9672.613095476103;10378.42918639482;10410.739731506774;10841.18691098155 15:14:57 INFO - PROCESS | 1647 | __end_tp_report 15:14:57 INFO - PROCESS | 1647 | __start_cc_report 15:14:57 INFO - PROCESS | 1647 | _x_x_mozilla_cycle_collect,439 15:14:57 INFO - PROCESS | 1647 | __end_cc_report 15:14:57 INFO - PROCESS | 1647 | __startTimestamp1490480097831__endTimestamp 15:14:57 INFO - PROCESS | 1647 | 15:14:57 INFO - PROCESS | 1647 | ------- Summary: start ------- 15:14:57 INFO - PROCESS | 1647 | Number of tests: 6 15:14:57 INFO - PROCESS | 1647 | 15:14:57 INFO - PROCESS | 1647 | [#0] dojo.html Cycles:165 Average:4883.32 Median:5061.29 stddev:580.79 (11.5%) stddev-sans-first:544.34 15:14:57 INFO - PROCESS | 1647 | Values: 2241.7 2785.9 2809.3 2849.0 2849.5 4021.9 4806.3 4886.3 4896.8 4923.7 4824.7 4829.4 4831.5 4901.3 4913.2 4463.0 4481.9 4519.4 4539.8 4592.2 4468.0 4488.8 4489.3 4518.7 4541.0 4320.2 4491.8 4497.6 4511.3 4554.5 4347.9 4432.6 4457.9 4552.7 4583.0 4442.7 4478.4 4482.8 4485.9 4525.1 4745.6 4848.4 4901.2 4907.2 4941.0 5110.2 5166.4 5211.6 5244.4 5262.5 5451.9 5453.2 5489.8 5491.7 5496.3 5064.8 5088.0 5094.5 5096.3 5130.5 5207.2 5276.2 5472.9 5502.7 5526.0 5134.7 5232.9 5316.8 5320.9 5327.0 5238.3 5363.9 5369.0 5378.5 5402.6 5280.8 5328.7 5336.6 5354.3 5363.3 5119.4 5163.0 5198.5 5297.7 5355.9 3792.2 4092.0 4398.8 4420.1 4433.8 3903.1 3910.8 3914.2 3915.8 3932.1 4584.4 4664.6 4871.4 4878.7 4878.7 5232.0 5263.4 5345.0 5345.6 5351.9 4846.7 4850.7 4850.9 4862.5 4895.4 4541.2 4694.0 4727.6 4728.0 4761.9 5464.7 5489.5 5493.1 5532.2 5569.0 5369.0 5384.2 5387.1 5396.3 5405.5 5468.3 5531.2 5574.6 5576.9 5599.3 5020.1 5092.4 5150.1 5165.9 5289.6 5363.9 5383.3 5419.5 5425.1 5451.3 4977.8 5016.8 5154.1 5194.8 5226.2 3899.8 4366.6 4376.0 4389.8 4897.2 4225.5 4463.5 5092.9 5114.2 5160.7 4486.1 4994.9 5189.7 5194.0 5202.5 5061.3 5094.8 5102.3 5135.8 5141.6 15:14:57 INFO - PROCESS | 1647 | 15:14:57 INFO - PROCESS | 1647 | [#1] ext.html Cycles:180 Average:53093.57 Median:341120.50 stddev:114780.24 (33.6%) stddev-sans-first:115034.87 15:14:57 INFO - PROCESS | 1647 | Values: 721.0 763.2 788.7 910.8 911.3 30956.0 36686.4 37096.3 38195.0 38257.2 36969.4 37362.9 37402.4 37489.4 37542.0 8147.8 8496.5 8560.5 8593.5 8616.6 8401.7 8474.9 8492.4 8498.5 8522.9 7465.8 7800.3 8019.6 8520.7 8527.8 8410.0 8428.1 8466.7 8471.0 8471.4 7301.4 8165.8 8230.3 8244.0 8259.1 28067.7 30801.0 32355.7 32469.7 32516.2 3502.3 3514.9 3572.6 3613.1 3724.8 20414.9 23291.3 24138.8 24268.4 25052.2 2707.0 2862.7 2952.9 2976.4 3017.1 338027.0 338036.0 338408.0 340141.0 342100.0 41569.8 42177.2 42246.6 42277.6 42296.8 43869.3 44316.1 44366.9 44385.6 44501.0 12986.9 13256.5 13257.8 13267.5 13287.4 11423.8 11461.7 11463.2 11468.8 11469.0 11198.9 11351.0 11364.3 11465.3 11481.4 5280.5 5403.5 5420.9 5424.9 5429.3 943.9 952.8 995.0 1002.7 1043.2 21785.0 24681.4 26066.9 26119.3 26151.3 976.6 1042.4 1065.1 1104.5 1109.9 10830.8 12923.1 13577.3 13597.3 13635.3 458548.0 466428.0 477841.0 492724.0 578128.0 38634.4 39322.2 45920.0 46142.8 46158.8 1306.2 1339.5 1342.7 1353.3 1354.3 22230.3 24441.1 25957.0 26023.5 26209.2 38954.8 39279.0 39280.8 39374.8 39375.8 389308.0 443282.6 451202.0 452283.0 454787.0 27481.9 27785.6 27864.7 28129.9 28170.4 34421.0 34778.1 35504.6 35638.8 35679.3 21218.8 23461.6 24527.8 26033.3 26275.3 21363.7 24863.5 25226.2 25801.8 26047.7 29268.4 29611.7 29714.0 29840.6 29924.9 21019.4 21501.7 24812.0 25201.7 25944.2 16139.0 20375.6 21176.5 21232.7 21330.0 15:14:57 INFO - PROCESS | 1647 | 15:14:57 INFO - PROCESS | 1647 | [#2] jquery.html Cycles:180 Average:41007.56 Median:27244.09 stddev:119024.42 (436.9%) stddev-sans-first:119319.18 15:14:57 INFO - PROCESS | 1647 | Values: 354.3 359.4 379.8 388.3 413.6 18846.9 19675.5 19774.7 20146.0 20323.0 20911.3 21020.2 21564.2 21654.0 21913.8 6307.8 6420.2 6532.5 6540.1 6628.6 6413.4 6531.3 6545.8 6571.8 6903.4 7334.0 7400.8 7403.2 7414.7 7418.6 6258.3 7086.7 7365.6 7373.4 7400.6 6383.1 7076.8 7079.5 7159.2 7159.2 24102.4 24683.3 24829.1 24887.0 25338.6 3160.5 3186.9 3200.6 3239.1 3249.4 12974.0 13235.6 14139.3 15384.9 15822.2 1887.6 1889.2 1954.5 1962.1 1970.4 152881.2 155771.0 162872.0 162883.2 165199.2 18128.5 19253.4 19855.3 19969.6 20023.7 23618.8 29149.6 29534.6 29783.4 29840.6 9734.0 9881.6 10017.5 10037.2 10185.3 6921.7 7485.7 8066.7 8565.4 8567.0 9011.1 9016.4 9174.4 9181.4 9196.3 3616.8 3981.2 4002.8 4116.9 4119.7 827.9 852.4 866.9 869.9 875.2 19868.3 20074.8 20336.9 20407.7 20413.0 709.9 791.0 855.6 887.2 925.9 8963.0 9332.9 10577.6 10665.8 10726.3 642407.0 716418.0 724295.0 735854.0 738563.0 117080.8 143217.3 143272.3 144472.0 146997.8 1083.8 1087.1 1111.8 1115.3 1116.3 16771.6 17689.0 17737.6 17763.7 18070.7 55989.4 56367.3 56676.4 57073.0 57488.7 81243.2 82106.6 83235.6 83437.6 85732.6 11156.1 11321.2 11360.8 11542.5 11645.8 12414.9 12439.1 12452.3 12509.5 12749.5 9279.7 10654.0 10665.6 10800.5 10904.3 9882.1 10072.3 10093.0 10336.2 10360.5 10880.0 11075.4 11153.6 11232.4 11269.9 10279.3 11222.9 11480.3 11575.5 11576.2 8735.3 8891.6 9171.0 9574.8 10126.7 15:14:57 INFO - PROCESS | 1647 | 15:14:57 INFO - PROCESS | 1647 | [#3] mootools.html Cycles:180 Average:6436.79 Median:3703.89 stddev:4084.39 (110.3%) stddev-sans-first:4077.04 15:14:57 INFO - PROCESS | 1647 | Values: 1221.2 1333.6 1487.7 1492.9 1499.2 9291.8 10184.5 10395.2 10634.0 10737.1 10491.4 10691.6 10731.8 10738.8 10762.6 2291.5 2313.1 2314.7 2316.5 2317.1 1935.8 2185.8 2286.2 2290.9 2305.6 2202.8 2267.2 2275.2 2275.7 2286.1 1694.8 2237.7 2245.9 2259.0 2265.8 1878.5 1964.8 2248.3 2251.3 2277.4 10366.3 10666.9 10781.5 10813.3 10849.7 5519.6 5704.5 5721.1 5726.0 5747.4 3348.7 3439.6 3442.4 3499.5 3500.8 1105.5 1117.1 1130.1 1164.1 1176.1 14687.6 14793.9 14861.3 14878.5 14898.9 4166.8 4466.2 4491.1 4575.2 4592.6 10918.9 10956.9 10971.2 10993.5 11015.2 5377.0 5388.7 5400.6 5403.1 5407.7 4725.6 4877.9 4995.7 5063.7 5068.5 3632.5 3703.8 3704.0 3778.8 3785.9 972.5 988.7 993.8 993.8 1010.6 618.1 799.0 815.8 843.2 857.0 5811.9 6027.2 6412.6 6488.4 6548.7 816.2 894.2 916.5 973.6 980.4 3728.4 3983.1 4030.2 4090.9 4093.5 12770.7 13352.5 13399.2 13408.7 13452.5 12511.2 13279.9 13294.7 13297.0 13314.2 9539.3 9776.5 9854.0 9857.2 9873.7 4931.0 6473.0 6509.6 6675.0 6698.9 11600.5 11907.6 12144.8 12168.5 12204.8 11490.9 11806.6 11866.3 12049.2 12271.7 8171.8 8178.3 8261.3 8281.4 8328.2 9853.9 10025.0 10031.0 10033.2 10052.5 7300.0 8427.0 8507.1 8511.6 8590.7 8271.3 8273.3 8369.1 8456.3 8498.7 6632.2 7491.2 7618.6 7700.5 7735.7 5518.7 5578.3 5684.0 5832.4 5835.6 5660.1 5680.0 5797.7 5831.1 5853.6 15:14:57 INFO - PROCESS | 1647 | 15:14:57 INFO - PROCESS | 1647 | [#4] prototype.html Cycles:180 Average:3822.42 Median:4160.80 stddev:1061.91 (25.5%) stddev-sans-first:1031.99 15:14:57 INFO - PROCESS | 1647 | Values: 327.7 332.4 345.3 348.6 356.5 4011.8 4060.7 4067.9 4114.6 4425.8 3478.7 4147.5 4224.7 4246.3 4291.6 3387.8 3556.4 3569.6 3586.6 3670.3 3449.1 3463.5 3534.9 3593.7 3612.9 2939.5 3082.9 3598.9 3605.0 3645.6 3183.5 3451.3 3611.6 3618.9 3643.7 2765.0 2820.9 3273.6 3319.9 3327.6 3494.9 3852.5 3944.1 4080.9 4081.9 3918.1 4200.6 4257.7 4276.6 4314.0 4030.6 4180.6 4339.3 4589.0 4611.7 3229.4 3690.9 3761.7 3775.7 3806.7 4170.8 4397.0 4597.4 4745.9 4753.3 3367.7 3577.5 3770.7 3771.6 3843.7 3333.1 3843.8 3849.6 3855.9 3912.0 3407.4 3592.3 4130.6 4159.9 4186.2 4349.3 4515.1 4548.7 4613.4 4630.4 1133.8 1320.0 1321.5 1326.5 1328.9 868.4 930.7 958.8 970.6 1014.9 3870.5 3891.5 4076.5 4077.7 4102.3 4200.3 4230.2 4689.2 4707.6 4761.6 3664.2 3675.4 4123.2 4153.7 4161.7 2111.6 2213.8 2233.4 2449.3 2480.9 4351.8 4425.7 4825.7 4956.4 4984.3 4309.6 4508.8 4952.8 4964.9 4980.0 4358.6 4574.5 4810.8 4878.8 4990.5 4345.3 4663.8 4711.7 4716.7 4729.8 3899.4 4158.7 4274.3 4483.3 4624.1 4560.6 4570.9 4668.8 4918.7 4937.4 3467.6 3901.9 4102.4 4225.8 4271.3 4038.3 4392.5 4400.1 4701.1 4749.8 4451.4 4516.6 4635.3 4649.3 4666.2 4214.4 4439.0 4502.0 4638.8 4645.3 4077.0 4180.0 4541.0 4542.5 4602.4 4141.3 4204.2 4607.6 4642.8 4655.3 3975.2 4205.8 4369.6 4501.7 4542.4 15:14:57 INFO - PROCESS | 1647 | 15:14:57 INFO - PROCESS | 1647 | [#5] yui.html Cycles:180 Average:19045.36 Median:26008.15 stddev:26955.89 (103.6%) stddev-sans-first:26996.22 15:14:57 INFO - PROCESS | 1647 | Values: 677.6 708.8 748.2 788.6 790.3 14537.2 14741.3 15179.5 15529.0 15537.2 16810.4 16948.5 16952.1 16982.9 17065.1 859.7 904.7 906.0 941.6 942.6 870.3 920.6 942.2 942.4 943.5 981.8 984.9 985.5 987.8 989.4 850.6 978.3 979.5 980.0 981.3 722.9 725.6 728.3 729.7 730.9 14827.6 15691.7 15753.8 16010.8 16054.6 10523.0 12746.4 13498.1 13505.6 13655.8 11042.9 11244.2 11530.9 11604.3 12063.3 3409.1 3453.6 3484.6 3495.1 3616.1 79662.0 109085.0 110254.0 111241.0 113562.4 10361.8 10465.1 10704.6 10712.1 10831.9 19683.6 19798.0 19819.5 19861.3 20540.0 6974.0 7021.3 7437.3 7514.5 7621.8 3813.6 4038.7 4125.2 4138.6 4144.7 3315.8 3360.6 3401.8 3413.4 3420.5 525.9 617.1 623.3 625.6 634.6 492.9 494.8 587.9 596.4 620.5 8738.6 9583.9 9599.5 9606.9 9726.0 584.9 595.2 624.6 634.6 653.7 3727.3 4246.8 4319.8 4750.0 4824.3 79818.6 82791.6 83027.6 88683.1 90044.5 75771.6 79704.3 82813.3 83289.2 83451.6 73142.6 75527.2 76588.6 77407.0 78407.6 9222.0 9492.7 9953.4 10655.5 10688.5 43494.6 46557.8 47266.3 48457.8 48460.3 43644.5 53730.7 61193.7 61734.7 61883.1 11899.5 11926.8 12032.2 12109.3 12214.5 13326.4 13514.7 13816.4 13976.7 14373.2 12723.2 12729.6 13149.9 13452.2 13546.5 12234.0 12909.5 12940.3 13149.0 13505.3 11902.2 12586.8 13133.1 13188.0 13318.8 9303.7 9355.8 9397.3 9543.5 9580.8 7040.6 9672.6 10378.4 10410.7 10841.2 15:14:57 INFO - PROCESS | 1647 | -------- Summary: end -------- 15:14:57 INFO - PROCESS | 1647 | 15:14:58 INFO - TEST-INFO | 1647: exit 0 15:14:58 INFO - TEST-OK | dromaeo_css | took 1115433ms 15:14:58 INFO - TEST-START | kraken 15:14:58 INFO - operating with platform_type : mac_ 15:14:58 INFO - Initialising browser for kraken test... 15:14:58 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/tmpzTARcn/profile http://localhost:49245/getInfo.html) 15:15:01 INFO - PROCESS | 1655 | 2017-03-25 15:15:01.715 plugin-container[1656:12038] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x444b, name = 'com.apple.tsm.portname' 15:15:01 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:15:01 INFO - PROCESS | 1655 | 2017-03-25 15:15:01.720 plugin-container[1656:12038] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x910b, name = 'com.apple.CFPasteboardClient' 15:15:01 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:15:01 INFO - PROCESS | 1655 | 2017-03-25 15:15:01.720 plugin-container[1656:12038] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:15:01 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 15:15:01 INFO - PROCESS | 1655 | colorDepth:24 15:15:01 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 15:15:01 INFO - PROCESS | 1655 | __metrics 15:15:01 ERROR - PROCESS | 1655 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 15:15:02 INFO - TEST-INFO | 1655: exit 0 15:15:02 INFO - Browser initialized. 15:15:02 INFO - Running cycle 1/1 for kraken test... 15:15:02 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/tmpzTARcn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:15:05 INFO - PROCESS | 1657 | 2017-03-25 15:15:05.424 plugin-container[1658:12160] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 15:15:05 INFO - PROCESS | 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:15:05 INFO - PROCESS | 1657 | 2017-03-25 15:15:05.425 plugin-container[1658:12160] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x431b, name = 'com.apple.CFPasteboardClient' 15:15:05 INFO - PROCESS | 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:15:05 INFO - PROCESS | 1657 | 2017-03-25 15:15:05.425 plugin-container[1658:12160] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:15:15 INFO - PROCESS | 1657 | RSS: Main: 220753920 15:15:15 INFO - PROCESS | 1657 | 15:15:18 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-beat-detection) 15:15:19 INFO - PROCESS | 1657 | RSS: Main: 235335680 15:15:19 INFO - PROCESS | 1657 | 15:15:22 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-dft) 15:15:22 INFO - PROCESS | 1657 | RSS: Main: 243269632 15:15:22 INFO - PROCESS | 1657 | 15:15:26 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-fft) 15:15:27 INFO - PROCESS | 1657 | RSS: Main: 244903936 15:15:27 INFO - PROCESS | 1657 | 15:15:29 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-oscillator) 15:15:29 INFO - PROCESS | 1657 | RSS: Main: 247517184 15:15:29 INFO - PROCESS | 1657 | 15:15:31 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49245/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:15:32 INFO - PROCESS | 1657 | RSS: Main: 247947264 15:15:32 INFO - PROCESS | 1657 | 15:15:35 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49245/tests/kraken/driver.html?testName=imaging-darkroom) 15:15:36 INFO - PROCESS | 1657 | RSS: Main: 252358656 15:15:36 INFO - PROCESS | 1657 | 15:15:39 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49245/tests/kraken/driver.html?testName=imaging-desaturate) 15:15:40 INFO - PROCESS | 1657 | RSS: Main: 251760640 15:15:40 INFO - PROCESS | 1657 | 15:15:43 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49245/tests/kraken/driver.html?testName=json-parse-financial) 15:15:44 INFO - PROCESS | 1657 | RSS: Main: 251936768 15:15:44 INFO - PROCESS | 1657 | 15:15:46 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49245/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:15:46 INFO - PROCESS | 1657 | RSS: Main: 251760640 15:15:46 INFO - PROCESS | 1657 | 15:15:48 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:15:49 INFO - PROCESS | 1657 | RSS: Main: 251584512 15:15:49 INFO - PROCESS | 1657 | 15:15:51 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:15:52 INFO - PROCESS | 1657 | RSS: Main: 251715584 15:15:52 INFO - PROCESS | 1657 | 15:15:55 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:15:56 INFO - PROCESS | 1657 | RSS: Main: 252456960 15:15:56 INFO - PROCESS | 1657 | 15:15:59 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:16:00 INFO - PROCESS | 1657 | RSS: Main: 252059648 15:16:00 INFO - PROCESS | 1657 | 15:16:01 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49245/tests/kraken/driver.html?testName=ai-astar) 15:16:02 INFO - PROCESS | 1657 | RSS: Main: 255471616 15:16:02 INFO - PROCESS | 1657 | 15:16:02 INFO - PROCESS | 1657 | __start_tp_report 15:16:02 INFO - PROCESS | 1657 | _x_x_mozilla_page_load 15:16:02 INFO - PROCESS | 1657 | _x_x_mozilla_page_load_details 15:16:02 INFO - PROCESS | 1657 | |i|pagename|runs| 15:16:02 INFO - PROCESS | 1657 | |0;ai-astar;110;124;126;139;128;172;112;174;182;159 15:16:02 INFO - PROCESS | 1657 | |1;audio-beat-detection;140;123;115;155;126;150;154;120;168;106 15:16:02 INFO - PROCESS | 1657 | |2;audio-dft;229;231;249;227;233;229;228;229;231;231 15:16:02 INFO - PROCESS | 1657 | |3;audio-fft;87;64;65;92;68;66;64;65;78;66 15:16:02 INFO - PROCESS | 1657 | |4;audio-oscillator;89;71;88;80;75;74;87;74;76;88 15:16:02 INFO - PROCESS | 1657 | |5;imaging-gaussian-blur;91;93;114;105;98;91;90;92;91;113 15:16:02 INFO - PROCESS | 1657 | |6;imaging-darkroom;100;99;105;100;100;131;119;151;157;160 15:16:02 INFO - PROCESS | 1657 | |7;imaging-desaturate;105;111;107;110;160;108;106;134;109;159 15:16:02 INFO - PROCESS | 1657 | |8;json-parse-financial;68;70;68;71;80;104;107;109;107;74 15:16:02 INFO - PROCESS | 1657 | |9;json-stringify-tinderbox;62;67;63;69;68;62;60;61;66;66 15:16:02 INFO - PROCESS | 1657 | |10;stanford-crypto-aes;89;108;106;105;89;91;89;91;87;111 15:16:02 INFO - PROCESS | 1657 | |11;stanford-crypto-ccm;151;152;162;160;153;160;156;158;207;184 15:16:02 INFO - PROCESS | 1657 | |12;stanford-crypto-pbkdf2;176;184;202;183;177;181;175;174;182;178 15:16:02 INFO - PROCESS | 1657 | |13;stanford-crypto-sha256-iterative;70;71;74;69;72;73;72;70;69;67 15:16:02 INFO - PROCESS | 1657 | __end_tp_report 15:16:02 INFO - PROCESS | 1657 | __start_cc_report 15:16:02 INFO - PROCESS | 1657 | _x_x_mozilla_cycle_collect,1041 15:16:02 INFO - PROCESS | 1657 | __end_cc_report 15:16:02 INFO - PROCESS | 1657 | __startTimestamp1490480162067__endTimestamp 15:16:02 INFO - PROCESS | 1657 | 15:16:02 INFO - PROCESS | 1657 | ------- Summary: start ------- 15:16:02 INFO - PROCESS | 1657 | Number of tests: 14 15:16:02 INFO - PROCESS | 1657 | 15:16:02 INFO - PROCESS | 1657 | [#0] ai-astar Cycles:10 Average:142.60 Median:149.00 stddev:26.91 (18.1%) stddev-sans-first:25.83 15:16:02 INFO - PROCESS | 1657 | Values: 110.0 124.0 126.0 139.0 128.0 172.0 112.0 174.0 182.0 159.0 15:16:02 INFO - PROCESS | 1657 | 15:16:02 INFO - PROCESS | 1657 | [#1] audio-beat-detection Cycles:10 Average:135.70 Median:145.00 stddev:20.51 (14.1%) stddev-sans-first:21.70 15:16:02 INFO - PROCESS | 1657 | Values: 140.0 123.0 115.0 155.0 126.0 150.0 154.0 120.0 168.0 106.0 15:16:02 INFO - PROCESS | 1657 | 15:16:02 INFO - PROCESS | 1657 | [#2] audio-dft Cycles:10 Average:231.70 Median:231.00 stddev:6.33 (2.7%) stddev-sans-first:6.63 15:16:02 INFO - PROCESS | 1657 | Values: 229.0 231.0 249.0 227.0 233.0 229.0 228.0 229.0 231.0 231.0 15:16:02 INFO - PROCESS | 1657 | 15:16:02 INFO - PROCESS | 1657 | [#3] audio-fft Cycles:10 Average:71.50 Median:67.00 stddev:10.39 (15.5%) stddev-sans-first:9.39 15:16:02 INFO - PROCESS | 1657 | Values: 87.0 64.0 65.0 92.0 68.0 66.0 64.0 65.0 78.0 66.0 15:16:02 INFO - PROCESS | 1657 | 15:16:02 INFO - PROCESS | 1657 | [#4] audio-oscillator Cycles:10 Average:80.20 Median:83.50 stddev:7.08 (8.5%) stddev-sans-first:6.76 15:16:02 INFO - PROCESS | 1657 | Values: 89.0 71.0 88.0 80.0 75.0 74.0 87.0 74.0 76.0 88.0 15:16:02 INFO - PROCESS | 1657 | 15:16:02 INFO - PROCESS | 1657 | [#5] imaging-gaussian-blur Cycles:10 Average:97.80 Median:91.00 stddev:9.44 (10.4%) stddev-sans-first:9.68 15:16:02 INFO - PROCESS | 1657 | Values: 91.0 93.0 114.0 105.0 98.0 91.0 90.0 92.0 91.0 113.0 15:16:02 INFO - PROCESS | 1657 | 15:16:02 INFO - PROCESS | 1657 | [#6] imaging-darkroom Cycles:10 Average:122.20 Median:141.00 stddev:25.54 (18.1%) stddev-sans-first:25.79 15:16:02 INFO - PROCESS | 1657 | Values: 100.0 99.0 105.0 100.0 100.0 131.0 119.0 151.0 157.0 160.0 15:16:02 INFO - PROCESS | 1657 | 15:16:02 INFO - PROCESS | 1657 | [#7] imaging-desaturate Cycles:10 Average:120.90 Median:110.50 stddev:21.97 (19.9%) stddev-sans-first:22.54 15:16:02 INFO - PROCESS | 1657 | Values: 105.0 111.0 107.0 110.0 160.0 108.0 106.0 134.0 109.0 159.0 15:16:02 INFO - PROCESS | 1657 | 15:16:02 INFO - PROCESS | 1657 | [#8] json-parse-financial Cycles:10 Average:85.80 Median:69.00 stddev:18.39 (26.7%) stddev-sans-first:18.34 15:16:02 INFO - PROCESS | 1657 | Values: 68.0 70.0 68.0 71.0 80.0 104.0 107.0 109.0 107.0 74.0 15:16:02 INFO - PROCESS | 1657 | 15:16:02 INFO - PROCESS | 1657 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:66.00 stddev:3.17 (4.8%) stddev-sans-first:3.24 15:16:02 INFO - PROCESS | 1657 | Values: 62.0 67.0 63.0 69.0 68.0 62.0 60.0 61.0 66.0 66.0 15:16:02 INFO - PROCESS | 1657 | 15:16:02 INFO - PROCESS | 1657 | [#10] stanford-crypto-aes Cycles:10 Average:96.60 Median:89.00 stddev:9.57 (10.8%) stddev-sans-first:9.75 15:16:02 INFO - PROCESS | 1657 | Values: 89.0 108.0 106.0 105.0 89.0 91.0 89.0 91.0 87.0 111.0 15:16:02 INFO - PROCESS | 1657 | 15:16:02 INFO - PROCESS | 1657 | [#11] stanford-crypto-ccm Cycles:10 Average:164.30 Median:160.00 stddev:17.70 (11.1%) stddev-sans-first:18.10 15:16:02 INFO - PROCESS | 1657 | Values: 151.0 152.0 162.0 160.0 153.0 160.0 156.0 158.0 207.0 184.0 15:16:02 INFO - PROCESS | 1657 | 15:16:02 INFO - PROCESS | 1657 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.20 Median:181.50 stddev:8.09 (4.5%) stddev-sans-first:8.36 15:16:02 INFO - PROCESS | 1657 | Values: 176.0 184.0 202.0 183.0 177.0 181.0 175.0 174.0 182.0 178.0 15:16:02 INFO - PROCESS | 1657 | 15:16:02 INFO - PROCESS | 1657 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.70 Median:71.50 stddev:2.11 (3.0%) stddev-sans-first:2.22 15:16:02 INFO - PROCESS | 1657 | Values: 70.0 71.0 74.0 69.0 72.0 73.0 72.0 70.0 69.0 67.0 15:16:02 INFO - PROCESS | 1657 | -------- Summary: end -------- 15:16:02 INFO - PROCESS | 1657 | 15:16:03 INFO - TEST-INFO | 1657: exit 0 15:16:03 INFO - TEST-OK | kraken | took 64649ms 15:16:03 INFO - SUITE-END | took 1180s 15:16:03 INFO - Completed test suite (00:19:40) 15:16:03 INFO - javascript benchmark 15:16:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6907.573856984365, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2241.686163937048, 2785.913493737442, 2809.2695899066243, 2848.9715102848977, 2849.52982757845, 4021.879343619689, 4806.327114204014, 4886.291487734281, 4896.779644915979, 4923.729194894279, 4824.7105173689515, 4829.396325459317, 4831.516848315176, 4901.3138160657445, 4913.164761990462, 4463.018136010072, 4481.932771008429, 4519.367288579585, 4539.795709193094, 4592.173408786417, 4468.039371535119, 4488.798004089807, 4489.2817149256125, 4518.661100417466, 4541.000979784442, 4320.243957307474, 4491.752953587551, 4497.617702495292, 4511.255642818947, 4554.476235232957, 4347.891302717426, 4432.601065904084, 4457.907812585905, 4552.658550608718, 4583.03756211196, 4442.711223770477, 4478.395416618748, 4482.798274077674, 4485.932711009337, 4525.094981003779, 4745.620350371996, 4848.418189817245, 4901.166801643729, 4907.214845624683, 4941.0, 5110.207917772751, 5166.405863325691, 5211.609129315279, 5244.370675518962, 5262.500062494057, 5451.918221226685, 5453.15476101205, 5489.752961116719, 5491.725413729338, 5496.31296087989, 5064.848054558369, 5087.97456012725, 5094.4650811664615, 5096.311997880312, 5130.512601302833, 5207.218917162456, 5276.208568714724, 5472.945270547323, 5502.724863756796, 5526.0, 5134.691918484903, 5232.895342093213, 5316.760745766373, 5320.866978325573, 5327.041132596092, 5238.345206849144, 5363.892722145613, 5369.00673375419, 5378.462153784669, 5402.567794576425, 5280.815171469057, 5328.733563321818, 5336.573074154058, 5354.330708661418, 5363.30277063987, 5119.411267704188, 5163.044836705221, 5198.532132108128, 5297.655652382583, 5355.946440535623, 3792.1657235408165, 4092.0, 4398.780060996937, 4420.115976804652, 4433.800478978454, 3903.0632648164237, 3910.7849068300948, 3914.1780226152828, 3915.8237879295502, 3932.0563064864227, 4584.358189853423, 4664.580187783115, 4871.3667223260745, 4878.682885612495, 4878.707277563358, 5231.973840130775, 5263.368395792453, 5344.9732751336, 5345.572354211654, 5351.946480535223, 4846.733429661332, 4850.708957462563, 4850.902981940412, 4862.489438608965, 4895.437024742129, 4541.182587134282, 4693.9765301173275, 4727.573690718376, 4728.0, 4761.857144285677, 5464.699441530754, 5489.505944465017, 5493.066178749542, 5532.197831314517, 5569.0, 5368.973155134356, 5384.246205531151, 5387.057264978692, 5396.325459317585, 5405.513503784521, 5468.28912241406, 5531.170324451365, 5574.609777315549, 5576.9163462547285, 5599.32808063035, 5020.146575082172, 5092.3889133302755, 5150.072986862401, 5165.896682066413, 5289.550388217045, 5363.946360536344, 5383.273258110105, 5419.539339156216, 5425.050616142238, 5451.264079349396, 4977.800887964441, 5016.799328026838, 5154.098032844162, 5194.7922083116255, 5226.163813789775, 3899.7660140391667, 4366.628836548929, 4376.015396535754, 4389.780510974375, 4897.240927656219, 4225.535191128912, 4463.464384273778, 5092.898142037213, 5114.207297868837, 5160.690358578498, 4486.0803535275845, 4994.850154495371, 5189.6886186828915, 5193.974030129825, 5202.531772140525, 5061.291419201389, 5094.7962081516325, 5102.336696229467, 5135.818761684908, 5141.588672906233], "value": 4844.434531674272, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [720.9711611535539, 763.2291385700443, 788.6805843633329, 910.7677542226731, 911.3210658059746, 30956.0, 36686.44970325444, 37096.258074838486, 38195.0, 38257.234855302944, 36969.44545831808, 37362.87911362664, 37402.438963415574, 37489.43765843515, 37542.0, 8147.837043259131, 8496.490210587353, 8560.529170895597, 8593.484390936532, 8616.612252448624, 8401.663933442655, 8474.87287690682, 8492.447990880604, 8498.532580708059, 8522.914770852305, 7465.776026719207, 7800.2979731824125, 8019.599020049003, 8520.659173633047, 8527.829443411129, 8410.03284622264, 8428.072911979678, 8466.66133354668, 8470.957645211765, 8471.364647651451, 7301.379382752472, 8165.8366832663605, 8230.341572674171, 8243.958780206121, 8259.091499935003, 28067.719322806715, 30801.0, 32355.6764432355, 32469.675303246902, 32516.18709532257, 3502.2995400919917, 3514.912127196815, 3572.5891522474726, 3613.0606042428894, 3724.7951362675044, 20414.89792551028, 23291.3012609622, 24138.758612413825, 24268.39329016771, 25052.248432547054, 2707.0, 2862.69747264996, 2952.8818847246084, 2976.434477449278, 3017.1401150671954, 338027.0, 338036.0, 338408.0, 340141.0, 342100.0, 41569.79215103905, 42177.15645687131, 42246.57753422488, 42277.57722422798, 42296.788516057226, 43869.341959870624, 44316.11367772691, 44366.89082772892, 44385.556144438146, 44501.0, 12986.870131298756, 13256.469741210243, 13257.801132983013, 13267.535636252878, 13287.402066907012, 11423.771524569462, 11461.656150315337, 11463.197576169754, 11468.827967580493, 11469.0251328638, 11198.936101070385, 11351.035162011322, 11364.261323013978, 11465.31208127515, 11481.425928703531, 5280.471952804689, 5403.540699040625, 5420.937170498656, 5424.945750542444, 5429.294191755047, 943.8772959515356, 952.8189643967625, 995.00002497491, 1002.6691191906654, 1043.1967385113421, 21785.019674114705, 24681.382965426008, 26066.86966565155, 26119.347016324366, 26151.346216344744, 976.5800705696619, 1042.4266653340633, 1065.1106326217696, 1104.4808939798281, 1109.9278546894427, 10830.837537436944, 12923.095383323265, 13577.321133943264, 13597.252151131584, 13635.318234088454, 458548.0, 466428.0, 477841.0, 492724.0, 578128.0, 38634.42048369277, 39322.213555728726, 45920.0, 46142.84642883888, 46158.76920615443, 1306.151001848806, 1339.5378594384922, 1342.6911810283493, 1353.3301015997145, 1354.3499120422055, 22230.333090007327, 24441.144559940316, 25957.0, 26023.479530409666, 26209.213723588324, 38954.831355059396, 39279.018024549616, 39280.80359598184, 39374.80312598419, 39375.80312098536, 389308.0, 443282.5671743241, 451202.0, 452283.0, 454787.0, 27481.86259068692, 27785.610719464352, 27864.721352787023, 28129.859350703115, 28170.43659126847, 34421.0, 34778.13054673653, 35504.64495355013, 35638.8218058908, 35679.28641427105, 21218.78781212168, 23461.59230446179, 24527.754722452548, 26033.349166270236, 26275.343116422242, 21363.679544806528, 24863.502729945663, 25226.243212703648, 25801.838917248395, 26047.73952260453, 29268.414631707674, 29611.667474963248, 29714.0, 29840.552391713707, 29924.85037574798, 21019.369418917457, 21501.6774748382, 24812.0, 25201.739913004643, 25944.221673349828, 16139.0, 20375.57370984017, 21176.470588235417, 21232.681509777674, 21330.0], "value": 16500.595494916517, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.2878813584696, 359.39442040162345, 379.7835233916668, 388.2661769256106, 413.6246978795506, 18846.905765471172, 19675.5081122972, 19774.7033794493, 20146.0, 20323.0, 20911.268105616306, 21020.159193632237, 21564.245251416163, 21654.0, 21913.780862191372, 6307.810765677037, 6420.1653785008, 6532.542722009462, 6540.051692504584, 6628.60228386296, 6413.390727880844, 6531.281559028503, 6545.770898018571, 6571.835704107388, 6903.4132098771415, 7334.0, 7400.814979625526, 7403.2226616205335, 7414.703411863519, 7418.554886706815, 6258.280297765769, 7086.71653133874, 7365.594892280922, 7373.446991475661, 7400.555966642019, 6383.138276332682, 7076.787696369117, 7079.504434689574, 7159.176694680126, 7159.212486626467, 24102.397440063964, 24683.25950221496, 24829.130980415597, 24887.0, 25338.619920701203, 3160.5259211118287, 3186.85659145339, 3200.6159260888844, 3239.060672405, 3249.3501299740146, 12973.962083033335, 13235.602931912059, 14139.293035348192, 15384.923055386127, 15822.208889555477, 1887.631911777204, 1889.2159753702335, 1954.482062253504, 1962.1268535501708, 1970.3793305108845, 152881.23559382244, 155771.0, 162872.0, 162883.18558407252, 165199.17400413041, 18128.45614631563, 19253.422397328104, 19855.305064322678, 19969.60060798776, 20023.699644505345, 23618.763812362, 29149.56275655867, 29534.55698164529, 29783.40433191324, 29840.55239171414, 9734.0, 9881.604735810632, 10017.549210285555, 10037.247206459544, 10185.33795303303, 6921.653917304115, 7485.737999170003, 8066.717664881701, 8565.443246188977, 8567.0, 9011.143941325563, 9016.368854180144, 9174.449533028039, 9181.449113053239, 9196.264298856075, 3616.81915904209, 3981.243563722883, 4002.779847108437, 4116.897077573085, 4119.691023173274, 827.9089300177096, 852.3564708644933, 866.8829707989466, 869.9217070463689, 875.1557438325442, 19868.30460933889, 20074.799252007586, 20336.88147151921, 20407.693884591743, 20413.0, 709.9467539934526, 790.9881351779728, 855.5978690015683, 887.1527691055027, 925.8796356473615, 8963.0, 9332.90667093334, 10577.565822948858, 10665.786684266272, 10726.302790318605, 642407.0, 716418.0, 724295.0, 735854.0, 738563.0, 117080.82919170869, 143217.28391357977, 143272.28363858323, 144472.0, 146997.7950330746, 1083.7994970930404, 1087.065123993365, 1111.8332250162377, 1115.275071203724, 1116.3023110556064, 16771.580710482336, 17689.02710350943, 17737.556561086076, 17763.73354399711, 18070.728939066186, 55989.44010559842, 56367.308980730646, 56676.433235667115, 57073.0, 57488.71255643695, 81243.18756812357, 82106.58946705467, 83235.5838220805, 83437.58281208797, 85732.57133714292, 11156.10751139923, 11321.150913681342, 11360.829587556029, 11542.480588373375, 11645.77719339491, 12414.937925310676, 12439.129260951646, 12452.252864828139, 12509.499620015098, 12749.49002039908, 9279.72160835176, 10653.987871152229, 10665.626703065356, 10800.541926839776, 10904.345739255352, 9882.061204185591, 10072.294939354175, 10093.0, 10336.17310615134, 10360.481975901326, 10880.020798128206, 11075.446227688422, 11153.55385784592, 11232.4383780809, 11269.943650281695, 10279.280450368402, 11222.933821286964, 11480.311181329147, 11575.536978520764, 11576.24754390962, 8735.30117590604, 8891.555422228734, 9171.0, 9574.808503830023, 10126.696199114038], "value": 11014.589108387885, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1221.1635030004447, 1333.6265845563246, 1487.6652753130547, 1492.8581784730454, 1499.2054211268032, 9291.814163716721, 10184.541695623697, 10395.168386529078, 10633.989770971764, 10737.141028717704, 10491.42297173655, 10691.625793097242, 10731.83902241467, 10738.785224295509, 10762.623308184215, 2291.450051987519, 2313.144136669435, 2314.7222333320024, 2316.4672125411166, 2317.0615900560215, 1935.7870634230223, 2185.7923497267734, 2286.211257116292, 2290.8510946788488, 2305.561943230789, 2202.8347873909443, 2267.2064777327887, 2275.1581914691587, 2275.681404603357, 2286.0969916882905, 1694.7712058872141, 2237.675537047119, 2245.8877056147207, 2258.954820903581, 2265.7734226577295, 1878.4552479780984, 1964.8428125749906, 2248.291788086764, 2251.279590531031, 2277.350954977823, 10366.274360794747, 10666.893331066667, 10781.514831832586, 10813.297135686154, 10849.728756781065, 5519.558435325164, 5704.458076482769, 5721.113227449752, 5726.0, 5747.425257474261, 3348.7488438366977, 3439.6216416194197, 3442.431998720208, 3499.527563778908, 3500.789952602852, 1105.4528008635696, 1117.0728295514702, 1130.1467392118898, 1164.1094562659573, 1176.1120354132574, 14687.63280917975, 14793.926030369887, 14861.331240094221, 14878.479253226085, 14898.851011489854, 4166.791660416967, 4466.196084704784, 4491.101779644085, 4575.2450845610765, 4592.632589392841, 10918.890811091787, 10956.890431095746, 10971.177161712743, 10993.450327483593, 11015.173861960386, 5377.032134215879, 5388.676679399248, 5400.567954563626, 5403.081476149064, 5407.70257635826, 4725.574698277172, 4877.878053048631, 4995.650304478724, 5063.696178229318, 5068.543831055223, 3632.54593175853, 3703.7962912039557, 3703.9814800925824, 3778.7543809652284, 3785.886423407302, 972.5429048347265, 988.6589126751403, 993.7515621094726, 993.8409854423257, 1010.6159659329408, 618.1407843098098, 798.9960050199712, 815.7600447320041, 843.1821133500495, 856.9742907712779, 5811.912821307684, 6027.21646185993, 6412.583182093149, 6488.416042556099, 6548.738050478023, 816.2042009041137, 894.2041582991143, 916.5142474488532, 973.600823662295, 980.352967041749, 3728.3848165052464, 3983.063979964706, 4030.153667729751, 4090.8568200112854, 4093.5497095319492, 12770.68073298175, 13352.532661356807, 13399.196048236941, 13408.664783380493, 13452.46190152383, 12511.186772859735, 13279.933600331937, 13294.734105317839, 13297.002724795679, 13314.201147931155, 9539.284553658503, 9776.462294573725, 9854.014598540089, 9857.162141218078, 9873.654422095193, 4931.0, 6473.0, 6509.576877502947, 6675.032120342426, 6698.899516507159, 11600.477978491157, 11907.583234586747, 12144.817827732768, 12168.452419641315, 12204.755904881675, 11490.94254528722, 11806.645800625995, 11866.288022718665, 12049.216800907912, 12271.69320766988, 8171.836563268583, 8178.304844088319, 8261.339092872435, 8281.420300578902, 8328.208820162075, 9853.901460985298, 10025.047620476043, 10030.99690030991, 10033.19734421259, 10052.54763535628, 7299.963500182465, 8427.030891447563, 8507.149285071444, 8511.574421279036, 8590.65637374498, 8271.296939759946, 8273.33813294923, 8369.121242269473, 8456.323494120332, 8498.660053597787, 6632.2372927114, 7491.213422590549, 7618.6190690466365, 7700.499467534592, 7735.6905723770415, 5518.724063796713, 5578.2748242728185, 5684.005299072563, 5832.445917637818, 5835.649861008353, 5660.094384898396, 5680.0, 5797.710114494343, 5831.096180092092, 5853.560982926383], "value": 4860.437287037141, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.6772379206483, 332.3884053341852, 345.29559698215644, 348.63393436891266, 356.53116152259776, 4011.8194681239343, 4060.736052156615, 4067.942334992901, 4114.5599040335865, 4425.822967081317, 3478.65213478652, 4147.460830092084, 4224.711463003782, 4246.278132717438, 4291.613754762071, 3387.762856600033, 3556.413191823346, 3569.607343192247, 3586.5875424326277, 3670.3026424979303, 3449.0687514371107, 3463.4977928200524, 3534.8586056557706, 3593.7125029997537, 3612.8554857805657, 2939.4855900217485, 3082.8766849326, 3598.874039408608, 3604.981975090121, 3645.5807582127995, 3183.522471629251, 3451.3097380523745, 3611.6388361163936, 3618.855245790165, 3643.708503319728, 2764.9723502764914, 2820.873060712273, 3273.5580696605894, 3319.867205311785, 3327.584051993501, 3494.947575786365, 3852.5184351956004, 3944.053427177457, 4080.9183816323803, 4081.89795255121, 3918.119302734675, 4200.558941311149, 4257.680673949466, 4276.550962148961, 4313.956860431387, 4030.576789437096, 4180.581941805795, 4339.305711086211, 4589.04006915541, 4611.654125940568, 3229.418704633165, 3690.944635830465, 3761.699064074895, 3775.716821238391, 3806.7144964127524, 4170.811318774135, 4396.978015109904, 4597.42532183477, 4745.881352966204, 4753.3107699383745, 3367.6800703933086, 3577.4633804929467, 3770.7368031709684, 3771.6039815818945, 3843.6925045996254, 3333.1333853198344, 3843.7693738375788, 3849.557300910431, 3855.8650447234772, 3912.0415498203124, 3407.437772767515, 3592.317459682652, 4130.6282434581035, 4159.876833255004, 4186.246475634354, 4349.3041113421705, 4515.14212299662, 4548.681592288574, 4613.385315139674, 4630.360694404225, 1133.7732453509332, 1320.0165876422127, 1321.4648067532664, 1326.5091915991145, 1328.9434899255116, 868.431177578687, 930.7254359963827, 958.8082383523184, 970.5923512124924, 1014.9039037839116, 3870.477485539416, 3891.5135608048995, 4076.5120730932995, 4077.7145599808323, 4102.343625019982, 4200.266636041842, 4230.181022160439, 4689.179393606105, 4707.599854012379, 4761.642876784185, 3664.1755604988666, 3675.448682697563, 4123.217068200873, 4153.709240353146, 4161.729487583298, 2111.6410210263984, 2213.8339624528226, 2233.396982814631, 2449.2774631483753, 2480.875956202183, 4351.782410879443, 4425.668074894395, 4825.686330388514, 4956.431369414016, 4984.252362145708, 4309.59058889405, 4508.797104130322, 4952.777125029383, 4964.925526117111, 4979.975100124476, 4358.607725304738, 4574.4968053514085, 4810.845397104739, 4878.78045487961, 4990.456775689301, 4345.326474396474, 4663.836765713184, 4711.691271277118, 4716.693414928019, 4729.8108075677965, 3899.395593682984, 4158.708890377766, 4274.2733735264455, 4483.327500874895, 4624.075184962953, 4560.635149188123, 4570.874543337364, 4668.789904454376, 4918.712798548692, 4937.407511098548, 3467.618561958233, 3901.853980310761, 4102.446169767162, 4225.8309667614185, 4271.2738834397605, 4038.273110840077, 4392.484592815601, 4400.141972315368, 4701.130290896195, 4749.810007599657, 4451.376807246923, 4516.567408769424, 4635.261776833688, 4649.3026046092, 4666.173737535189, 4214.4406569569455, 4439.0, 4501.954980450154, 4638.750206149947, 4645.326427667902, 4076.980754811297, 4179.97910010448, 4541.0, 4542.454905411372, 4602.401687780567, 4141.275276826604, 4204.192197355167, 4607.585317321457, 4642.767861606973, 4655.2784318430695, 3975.2372101389255, 4205.810738516835, 4369.563043695605, 4501.6848820582245, 4542.409486766699], "value": 3518.652908365741, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [677.6476232359173, 708.7731925783751, 748.1657951384204, 788.5899332347179, 790.3124281874769, 14537.200453975027, 14741.336639851206, 15179.544613661608, 15529.0, 15537.223138843055, 16810.411635592758, 16948.49154525363, 16952.06763628, 16982.915085424585, 17065.14674266288, 859.6503489521454, 904.6833608237097, 906.0350726476298, 941.5527624378434, 942.5946842857569, 870.251583638074, 920.6087412849546, 942.2462030375706, 942.4109931292942, 943.4763706143087, 981.8379967305422, 984.8522721591783, 985.526947065409, 987.8271302522065, 989.4211886046671, 850.5662112322728, 978.295627148452, 979.5200351827624, 979.9755006124833, 981.2836629260609, 722.8734971379987, 725.575538310084, 728.3481284250566, 729.7081167533029, 730.8940203670438, 14827.555173344817, 15691.686166276724, 15753.842461575352, 16010.799190060792, 16054.5986350341, 10523.000314970066, 12746.421552083562, 13498.122622029636, 13505.594832155051, 13655.795163072562, 11042.889571104266, 11244.212905096647, 11530.884691153065, 11604.30374177552, 12063.336516491589, 3409.113630456099, 3453.568303962005, 3484.61669216386, 3495.10874726943, 3616.077900135475, 79662.0, 109085.0, 110254.0, 111241.0, 113562.43218783935, 10361.844572331422, 10465.058144767008, 10704.625338113128, 10712.089472394933, 10831.891681083089, 19683.606327873364, 19798.0, 19819.504512387306, 19861.30485433003, 20540.0, 6974.0, 7021.254308474224, 7437.330640242296, 7514.511556748794, 7621.847563048708, 3813.637704418076, 4038.676905847525, 4125.23683118624, 4138.586141385837, 4144.70987030911, 3315.751318651111, 3360.5631267935014, 3401.795892246473, 3413.419718647836, 3420.504026916133, 525.8632755483525, 617.0928734759896, 623.3236937922314, 625.6308777821016, 634.6192284629185, 492.9112759703288, 494.75756879128966, 587.9235699359056, 596.385722705614, 620.5376994139395, 8738.563071846509, 9583.904160958302, 9599.47202903833, 9606.855897161548, 9725.951370243245, 584.8596336879118, 595.2440400691098, 624.6127401011402, 634.5716641267127, 653.6535636112868, 3727.310447567209, 4246.766427846436, 4319.805608747551, 4750.0, 4824.252240902666, 79818.6009069951, 82791.58604206941, 83027.58486207652, 88683.11316886877, 90044.549777252, 75771.62114189393, 79704.31449278214, 82813.343733125, 83289.16710832935, 83451.5827420859, 73142.63428682822, 75527.24472755312, 76588.61705691436, 77407.0, 78407.60796195868, 9221.953890230507, 9492.715218543455, 9953.402795832273, 10655.467226638482, 10688.519016644113, 43494.56505434905, 46557.76721116373, 47266.291005635634, 48457.75771121122, 48460.273095902885, 43644.47244346433, 53730.73134634302, 61193.69403152956, 61734.69132654308, 61883.07175392283, 11899.524019039141, 11926.761464770829, 12032.217905836093, 12109.33398663082, 12214.450349734105, 13326.40031198579, 13514.729705406033, 13816.447342106203, 13976.720465590428, 14373.20947347864, 12723.172993755376, 12729.55446559366, 13149.868501314864, 13452.192868427926, 13546.514811367293, 12234.0, 12909.483620655068, 12940.288284144463, 13149.0, 13505.324733763076, 11902.226355286879, 12586.811197832223, 13133.146345487512, 13188.0, 13318.800217996932, 9303.72088837336, 9355.81288374215, 9397.29520285995, 9543.47510886908, 9580.76048098803, 7040.612766297902, 9672.613095476103, 10378.42918639482, 10410.739731506774, 10841.18691098155], "value": 7213.388219151908, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1665.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 124.0, 126.0, 139.0, 128.0, 172.0, 112.0, 174.0, 182.0, 159.0], "value": 142.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 123.0, 115.0, 155.0, 126.0, 150.0, 154.0, 120.0, 168.0, 106.0], "value": 135.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [229.0, 231.0, 249.0, 227.0, 233.0, 229.0, 228.0, 229.0, 231.0, 231.0], "value": 231.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 64.0, 65.0, 92.0, 68.0, 66.0, 64.0, 65.0, 78.0, 66.0], "value": 71.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 71.0, 88.0, 80.0, 75.0, 74.0, 87.0, 74.0, 76.0, 88.0], "value": 80.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 93.0, 114.0, 105.0, 98.0, 91.0, 90.0, 92.0, 91.0, 113.0], "value": 97.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 99.0, 105.0, 100.0, 100.0, 131.0, 119.0, 151.0, 157.0, 160.0], "value": 122.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 111.0, 107.0, 110.0, 160.0, 108.0, 106.0, 134.0, 109.0, 159.0], "value": 120.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 68.0, 71.0, 80.0, 104.0, 107.0, 109.0, 107.0, 74.0], "value": 85.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 67.0, 63.0, 69.0, 68.0, 62.0, 60.0, 61.0, 66.0, 66.0], "value": 64.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 108.0, 106.0, 105.0, 89.0, 91.0, 89.0, 91.0, 87.0, 111.0], "value": 96.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 152.0, 162.0, 160.0, 153.0, 160.0, 156.0, 158.0, 207.0, 184.0], "value": 164.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 184.0, 202.0, 183.0, 177.0, 181.0, 175.0, 174.0, 182.0, 178.0], "value": 181.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 74.0, 69.0, 72.0, 73.0, 72.0, 70.0, 69.0, 67.0], "value": 70.7, "unit": "score"}]}]} 15:16:03 INFO - Return code: 0 15:16:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:16:03 ERROR - # TBPL SUCCESS # 15:16:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:16:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:16:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:16:03 INFO - 2017-03-25 15:16:03.409 screenresolution[1662:12742] starting screenresolution argv=screenresolution get 15:16:03 INFO - 2017-03-25 15:16:03.412 screenresolution[1662:12742] Display 0: 1600x1200x32@60 15:16:03 INFO - 2017-03-25 15:16:03.418 screenresolution[1663:12745] starting screenresolution argv=screenresolution list 15:16:03 INFO - Available Modes on Display 0 15:16:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:16:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:16:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:16:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:16:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:16:03 INFO - Intel Iris: 15:16:03 INFO - Chipset Model: Intel Iris 15:16:03 INFO - Type: GPU 15:16:03 INFO - Bus: Built-In 15:16:03 INFO - VRAM (Dynamic, Max): 1536 MB 15:16:03 INFO - Vendor: Intel (0x8086) 15:16:03 INFO - Device ID: 0x0a2e 15:16:03 INFO - Revision ID: 0x0009 15:16:03 INFO - Displays: 15:16:03 INFO - Display: 15:16:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:16:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:16:03 INFO - Display Serial Number: 1600x1200 60 15:16:03 INFO - Main Display: Yes 15:16:03 INFO - Mirror: Off 15:16:03 INFO - Online: Yes 15:16:03 INFO - Rotation: Supported 15:16:03 INFO - Return code: 0 15:16:03 INFO - Running post-action listener: _resource_record_post_action 15:16:03 INFO - [mozharness: 2017-03-25 22:16:03.670679Z] Finished run-tests step (success) 15:16:03 INFO - Running post-run listener: _resource_record_post_run 15:16:03 INFO - Total resource usage - Wall time: 1201s; CPU: 55.0%; Read bytes: 33915392; Write bytes: 513404928; Read time: 318; Write time: 1817 15:16:03 INFO - TinderboxPrint: CPU usage
55.0% 15:16:03 INFO - TinderboxPrint: I/O read bytes / time
33,915,392 / 318 15:16:03 INFO - TinderboxPrint: I/O write bytes / time
513,404,928 / 1,817 15:16:03 INFO - TinderboxPrint: CPU idle
2,163.0 (45.0%) 15:16:03 INFO - TinderboxPrint: CPU system
977.0 (20.3%) 15:16:03 INFO - TinderboxPrint: CPU user
1,665.7 (34.7%) 15:16:03 INFO - TinderboxPrint: Swap in / out
237,879,296 / 0 15:16:03 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 196977152; Write bytes: 188792832; Read time: 15598; Write time: 346 15:16:03 INFO - run-tests - Wall time: 1181s; CPU: 55.0%; Read bytes: 32973312; Write bytes: 303796224; Read time: 302; Write time: 1414 15:16:04 INFO - Running post-run listener: _upload_blobber_files 15:16:04 INFO - Blob upload gear active. 15:16:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:16:04 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 15:16:04 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'] 15:16:04 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 15:16:04 INFO - (blobuploader) - INFO - Open directory for files ... 15:16:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:16:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:16:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:16:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:16:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:16:05 INFO - (blobuploader) - INFO - Done attempting. 15:16:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:16:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:16:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:16:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:16:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:16:06 INFO - (blobuploader) - INFO - Done attempting. 15:16:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:16:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:16:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:16:07 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:16:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:16:07 INFO - (blobuploader) - INFO - Done attempting. 15:16:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:16:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:16:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:16:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:16:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:16:09 INFO - (blobuploader) - INFO - Done attempting. 15:16:09 INFO - (blobuploader) - INFO - Iteration through files over. 15:16:09 INFO - Return code: 0 15:16:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:16:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:16:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f42bfd62fa4a1206e91b3d6d3a20d003e2971d9fcf02944132ff5e75ae870c60b20deba985f7a59ef0fc42af96d89899c2b833847ab99ccb12d8f7dbf152f7ef", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/549d2666c601b6d7fcdfb4d366781970543b18a8ba8092b4ff2afdd6ab9ec7fe43ca926b6b4b14d6d7491338083b08a8b3a3afb515463804a6727d1637dbe283", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/648bfa367e40e1783f224d4a1f118914b078fbc908302ef0b2dd0c6022b7042156f4ef20b772314edfc2412ddbf284588aaa442540d31c2842edd81d3441749c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/29e255e18d93afdfe4c291758fdea239c29b9026e7fcc34f3f191bcf7671b43d3d08568eee29ad039419a1717807378f04487d5edc1d24c73cfdf7a014de1018"} 15:16:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:16:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:16:09 INFO - Contents: 15:16:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f42bfd62fa4a1206e91b3d6d3a20d003e2971d9fcf02944132ff5e75ae870c60b20deba985f7a59ef0fc42af96d89899c2b833847ab99ccb12d8f7dbf152f7ef", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/549d2666c601b6d7fcdfb4d366781970543b18a8ba8092b4ff2afdd6ab9ec7fe43ca926b6b4b14d6d7491338083b08a8b3a3afb515463804a6727d1637dbe283", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/648bfa367e40e1783f224d4a1f118914b078fbc908302ef0b2dd0c6022b7042156f4ef20b772314edfc2412ddbf284588aaa442540d31c2842edd81d3441749c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/29e255e18d93afdfe4c291758fdea239c29b9026e7fcc34f3f191bcf7671b43d3d08568eee29ad039419a1717807378f04487d5edc1d24c73cfdf7a014de1018"} 15:16:09 INFO - Running post-run listener: copy_logs_to_upload_dir 15:16:09 INFO - Copying logs to upload dir... 15:16:09 INFO - mkdir: /builds/slave/test/build/upload/logs 15:16:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1286.920561 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-03-25 15:16:09.941336) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-25 15:16:09.945181) ========= 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.SfwcAGVc2L/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.puJqDqQnKx/Listeners TMPDIR=/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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/f42bfd62fa4a1206e91b3d6d3a20d003e2971d9fcf02944132ff5e75ae870c60b20deba985f7a59ef0fc42af96d89899c2b833847ab99ccb12d8f7dbf152f7ef", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/549d2666c601b6d7fcdfb4d366781970543b18a8ba8092b4ff2afdd6ab9ec7fe43ca926b6b4b14d6d7491338083b08a8b3a3afb515463804a6727d1637dbe283", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/648bfa367e40e1783f224d4a1f118914b078fbc908302ef0b2dd0c6022b7042156f4ef20b772314edfc2412ddbf284588aaa442540d31c2842edd81d3441749c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/29e255e18d93afdfe4c291758fdea239c29b9026e7fcc34f3f191bcf7671b43d3d08568eee29ad039419a1717807378f04487d5edc1d24c73cfdf7a014de1018"} build_url:https://queue.taskcluster.net/v1/task/Mc7G7MfaRpOSnugAKTxNlw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011928 build_url: 'https://queue.taskcluster.net/v1/task/Mc7G7MfaRpOSnugAKTxNlw/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/f42bfd62fa4a1206e91b3d6d3a20d003e2971d9fcf02944132ff5e75ae870c60b20deba985f7a59ef0fc42af96d89899c2b833847ab99ccb12d8f7dbf152f7ef", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/549d2666c601b6d7fcdfb4d366781970543b18a8ba8092b4ff2afdd6ab9ec7fe43ca926b6b4b14d6d7491338083b08a8b3a3afb515463804a6727d1637dbe283", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/648bfa367e40e1783f224d4a1f118914b078fbc908302ef0b2dd0c6022b7042156f4ef20b772314edfc2412ddbf284588aaa442540d31c2842edd81d3441749c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/29e255e18d93afdfe4c291758fdea239c29b9026e7fcc34f3f191bcf7671b43d3d08568eee29ad039419a1717807378f04487d5edc1d24c73cfdf7a014de1018"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-25 15:16:09.980810) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-25 15:16:09.981115) ========= 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.SfwcAGVc2L/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.puJqDqQnKx/Listeners TMPDIR=/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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.004815 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-25 15:16:10.029550) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-25 15:16:10.029867) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-25 15:16:10.030185) ========= ========= Total master_lag: 0.20 =========