builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0300 starttime: 1488557386.06 results: success (0) buildid: 20170303070751 builduid: b04c11619b59477ba36ae4c31c0c7d40 revision: d9d91d6e389ef19bd48eb5153c9e32a122a1eecc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-03 08:09:46.055512) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-03 08:09:46.055976) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-03 08:09:46.056250) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-03 08:09:46.156826) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 08:09:46.157078) ========= 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.MNXHah2HzH/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.5PwKMQxzEW/Listeners TMPDIR=/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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-03 08:09:46-- 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% 9.48M=0.001s 2017-03-03 08:09:46 (9.48 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.499922 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 08:09:46.680931) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 08:09:46.681244) ========= 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.MNXHah2HzH/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.5PwKMQxzEW/Listeners TMPDIR=/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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.021049 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 08:09:46.730175) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-03 08:09:46.730552) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d9d91d6e389ef19bd48eb5153c9e32a122a1eecc --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 d9d91d6e389ef19bd48eb5153c9e32a122a1eecc --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.MNXHah2HzH/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.5PwKMQxzEW/Listeners TMPDIR=/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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-03 08:09:46,825 truncating revision to first 12 chars 2017-03-03 08:09:46,825 Setting DEBUG logging. 2017-03-03 08:09:46,825 attempt 1/10 2017-03-03 08:09:46,825 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d9d91d6e389e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-03 08:09:49,017 unpacking tar archive at: mozilla-aurora-d9d91d6e389e/testing/mozharness/ program finished with exit code 0 elapsedTime=2.445567 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-03 08:09:49.201474) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-03 08:09:49.201802) ========= script_repo_revision: d9d91d6e389ef19bd48eb5153c9e32a122a1eecc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-03 08:09:49.202212) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-03 08:09:49.202475) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-03 08:09:49.222213) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-03-03 08:09:49.222582) ========= /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.MNXHah2HzH/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.5PwKMQxzEW/Listeners TMPDIR=/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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 08:09:49 INFO - MultiFileLogger online at 20170303 08:09:49 in /builds/slave/test 08:09:49 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 08:09:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:09:49 INFO - {'append_to_log': False, 08:09:49 INFO - 'base_work_dir': '/builds/slave/test', 08:09:49 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:09:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:09:49 INFO - 'branch': 'Mozilla-Aurora', 08:09:49 INFO - 'buildbot_json_path': 'buildprops.json', 08:09:49 INFO - 'config_files': ('talos/mac_config.py',), 08:09:49 INFO - 'default_actions': ('clobber', 08:09:49 INFO - 'read-buildbot-config', 08:09:49 INFO - 'download-and-extract', 08:09:49 INFO - 'populate-webroot', 08:09:49 INFO - 'create-virtualenv', 08:09:49 INFO - 'install', 08:09:49 INFO - 'run-tests'), 08:09:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:09:49 INFO - 'download_minidump_stackwalk': True, 08:09:49 INFO - 'download_symbols': 'ondemand', 08:09:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:09:49 INFO - 'tooltool.py': '/tools/tooltool.py', 08:09:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:09:49 INFO - '/tools/misc-python/virtualenv.py')}, 08:09:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:09:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:09:49 INFO - 'installer_path': 'installer.exe', 08:09:49 INFO - 'log_level': 'info', 08:09:49 INFO - 'log_name': 'talos', 08:09:49 INFO - 'log_to_console': True, 08:09:49 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:09:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:09:49 INFO - 'opt_config_files': (), 08:09:49 INFO - 'pip_index': False, 08:09:49 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:09:49 INFO - 'cmd': ('bash', 08:09:49 INFO - '-c', 08:09:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:09:49 INFO - 'enabled': True, 08:09:49 INFO - 'halt_on_failure': False, 08:09:49 INFO - 'name': 'check_screen_resolution'},), 08:09:49 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:09:49 INFO - 'cmd': ('bash', 08:09:49 INFO - '-c', 08:09:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:09:49 INFO - 'enabled': True, 08:09:49 INFO - 'halt_on_failure': False, 08:09:49 INFO - 'name': 'check_screen_resolution'},), 08:09:49 INFO - 'run_cmd_checks_enabled': True, 08:09:49 INFO - 'sps_profile': False, 08:09:49 INFO - 'sps_profile_interval': 0, 08:09:49 INFO - 'suite': 'dromaeojs-e10s', 08:09:49 INFO - 'system_bits': '32', 08:09:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:09:49 INFO - 'title': 't-yosemite-r7-0300', 08:09:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:09:49 INFO - 'use_talos_json': True, 08:09:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:09:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:09:49 INFO - 'work_dir': 'build'} 08:09:49 INFO - [mozharness: 2017-03-03 16:09:49.437033Z] Running clobber step. 08:09:49 INFO - Running pre-action listener: _resource_record_pre_action 08:09:49 INFO - Running main action method: clobber 08:09:49 INFO - rmtree: /builds/slave/test/build 08:09:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:09:50 INFO - Running post-action listener: _resource_record_post_action 08:09:50 INFO - [mozharness: 2017-03-03 16:09:50.086928Z] Finished clobber step (success) 08:09:50 INFO - [mozharness: 2017-03-03 16:09:50.087125Z] Running read-buildbot-config step. 08:09:50 INFO - Running pre-action listener: _resource_record_pre_action 08:09:50 INFO - Running main action method: read_buildbot_config 08:09:50 INFO - Using buildbot properties: 08:09:50 INFO - { 08:09:50 INFO - "project": "", 08:09:50 INFO - "product": "firefox", 08:09:50 INFO - "script_repo_revision": "production", 08:09:50 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 08:09:50 INFO - "repository": "", 08:09:50 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 08:09:50 INFO - "buildid": "20170303070751", 08:09:50 INFO - "pgo_build": "False", 08:09:50 INFO - "basedir": "/builds/slave/test", 08:09:50 INFO - "buildnumber": 57, 08:09:50 INFO - "slavename": "t-yosemite-r7-0300", 08:09:50 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 08:09:50 INFO - "platform": "yosemite_r7", 08:09:50 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 08:09:50 INFO - "branch": "mozilla-aurora", 08:09:50 INFO - "repo_path": "releases/mozilla-aurora", 08:09:50 INFO - "revision": "d9d91d6e389ef19bd48eb5153c9e32a122a1eecc", 08:09:50 INFO - "stage_platform": "macosx64", 08:09:50 INFO - "builduid": "b04c11619b59477ba36ae4c31c0c7d40", 08:09:50 INFO - "slavebuilddir": "test" 08:09:50 INFO - } 08:09:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/LhGJ4O_TToGRuTDCEk4Snw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 08:09:50 INFO - Running post-action listener: _resource_record_post_action 08:09:50 INFO - [mozharness: 2017-03-03 16:09:50.092808Z] Finished read-buildbot-config step (success) 08:09:50 INFO - [mozharness: 2017-03-03 16:09:50.093046Z] Running download-and-extract step. 08:09:50 INFO - Running pre-action listener: _resource_record_pre_action 08:09:50 INFO - Running main action method: download_and_extract 08:09:50 INFO - mkdir: /builds/slave/test/build/tests 08:09: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')]} 08:09:50 INFO - trying https://queue.taskcluster.net/v1/task/LhGJ4O_TToGRuTDCEk4Snw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 08:09:50 INFO - Downloading https://queue.taskcluster.net/v1/task/LhGJ4O_TToGRuTDCEk4Snw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 08:09:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LhGJ4O_TToGRuTDCEk4Snw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 08:09:51 INFO - Downloaded 1199 bytes. 08:09:51 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 08:09:51 INFO - Using the following test package requirements: 08:09:51 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 08:09:51 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:09:51 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 08:09:51 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:09:51 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 08:09:51 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:09:51 INFO - u'jsshell-mac.zip'], 08:09:51 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:09:51 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 08:09:51 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 08:09:51 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:09:51 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 08:09:51 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:09:51 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 08:09:51 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:09:51 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 08:09:51 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:09:51 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 08:09:51 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 08:09:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LhGJ4O_TToGRuTDCEk4Snw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 08:09:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LhGJ4O_TToGRuTDCEk4Snw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:09:51 INFO - Fetch https://queue.taskcluster.net/v1/task/LhGJ4O_TToGRuTDCEk4Snw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 08:09:51 INFO - Expected file size: 16357779 08:09:51 INFO - Obtained file size: 16357779 08:09:58 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 08:09:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LhGJ4O_TToGRuTDCEk4Snw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 08:09:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LhGJ4O_TToGRuTDCEk4Snw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:09:58 INFO - Fetch https://queue.taskcluster.net/v1/task/LhGJ4O_TToGRuTDCEk4Snw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 08:09:59 INFO - Expected file size: 16357779 08:09:59 INFO - Obtained file size: 16357779 08:10:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LhGJ4O_TToGRuTDCEk4Snw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 08:10:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LhGJ4O_TToGRuTDCEk4Snw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 08:10:06 INFO - Fetch https://queue.taskcluster.net/v1/task/LhGJ4O_TToGRuTDCEk4Snw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 08:10:06 INFO - Expected file size: 14403650 08:10:06 INFO - Obtained file size: 14403650 08:10:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:10:07 INFO - trying https://queue.taskcluster.net/v1/task/LhGJ4O_TToGRuTDCEk4Snw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:10:07 INFO - Downloading https://queue.taskcluster.net/v1/task/LhGJ4O_TToGRuTDCEk4Snw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 08:10:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LhGJ4O_TToGRuTDCEk4Snw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 08:10:09 INFO - Downloaded 73905780 bytes. 08:10:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LhGJ4O_TToGRuTDCEk4Snw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:10:09 INFO - mkdir: /builds/slave/test/properties 08:10:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:10:09 INFO - Writing to file /builds/slave/test/properties/build_url 08:10:09 INFO - Contents: 08:10:09 INFO - build_url:https://queue.taskcluster.net/v1/task/LhGJ4O_TToGRuTDCEk4Snw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:10:10 INFO - Running post-action listener: _resource_record_post_action 08:10:10 INFO - Running post-action listener: set_extra_try_arguments 08:10:10 INFO - [mozharness: 2017-03-03 16:10:10.665515Z] Finished download-and-extract step (success) 08:10:10 INFO - [mozharness: 2017-03-03 16:10:10.665666Z] Running populate-webroot step. 08:10:10 INFO - Running pre-action listener: _resource_record_pre_action 08:10:10 INFO - Running main action method: populate_webroot 08:10:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:10:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:10:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:10:10 INFO - '--tppagecycles', 08:10:10 INFO - '7'], 08:10:10 INFO - 'tests': ['tsvgm']}}, 08:10:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:10:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:10:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:10:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:10:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:10:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:10:10 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:10:10 INFO - 'talos_options': ['--disable-e10s'], 08:10:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:10:10 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:10:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:10:10 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:10:10 INFO - 'talos_options': ['--disable-e10s'], 08:10:10 INFO - 'tests': ['damp', 'tps']}, 08:10:10 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:10:10 INFO - 'tests': ['damp', 'tps']}, 08:10:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:10:10 INFO - 'tests': ['dromaeo_dom']}, 08:10:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:10:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:10:10 INFO - 'tests': ['basic_compositor_video']}, 08:10:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:10:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:10:10 INFO - 'tests': ['a11yr', 08:10:10 INFO - 'ts_paint', 08:10:10 INFO - 'tpaint', 08:10:10 INFO - 'sessionrestore', 08:10:10 INFO - 'sessionrestore_no_auto_restore', 08:10:10 INFO - 'tabpaint']}, 08:10:10 INFO - 'other-e10s': {'tests': ['a11yr', 08:10:10 INFO - 'ts_paint', 08:10:10 INFO - 'tpaint', 08:10:10 INFO - 'sessionrestore', 08:10:10 INFO - 'sessionrestore_no_auto_restore', 08:10:10 INFO - 'tabpaint']}, 08:10:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:10:10 INFO - 'ts_paint', 08:10:10 INFO - 'tpaint', 08:10:10 INFO - 'sessionrestore', 08:10:10 INFO - 'sessionrestore_no_auto_restore', 08:10:10 INFO - 'tabpaint']}, 08:10:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:10:10 INFO - 'ts_paint', 08:10:10 INFO - 'tpaint', 08:10:10 INFO - 'sessionrestore', 08:10:10 INFO - 'sessionrestore_no_auto_restore', 08:10:10 INFO - 'tabpaint']}, 08:10:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:10:10 INFO - 'tests': ['a11yr', 08:10:10 INFO - 'ts_paint', 08:10:10 INFO - 'tpaint', 08:10:10 INFO - 'sessionrestore', 08:10:10 INFO - 'sessionrestore_no_auto_restore', 08:10:10 INFO - 'tabpaint']}, 08:10:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:10:10 INFO - 'tests': ['a11yr', 08:10:10 INFO - 'ts_paint', 08:10:10 INFO - 'tpaint', 08:10:10 INFO - 'sessionrestore', 08:10:10 INFO - 'sessionrestore_no_auto_restore', 08:10:10 INFO - 'tabpaint']}, 08:10:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:10:10 INFO - 'tests': ['tsvgx', 08:10:10 INFO - 'tsvgr_opacity', 08:10:10 INFO - 'tart', 08:10:10 INFO - 'tscrollx', 08:10:10 INFO - 'cart', 08:10:10 INFO - 'tsvg_static']}, 08:10:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:10:10 INFO - 'tsvgr_opacity', 08:10:10 INFO - 'tart', 08:10:10 INFO - 'tscrollx', 08:10:10 INFO - 'cart', 08:10:10 INFO - 'tsvg_static']}, 08:10:10 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:10:10 INFO - 'talos_options': ['--disable-e10s'], 08:10:10 INFO - 'tests': ['tp5o']}, 08:10:10 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:10:10 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:10:10 INFO - 'talos_options': ['--disable-e10s', 08:10:10 INFO - '--xperf_path', 08:10:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:10:10 INFO - 'tests': ['tp5n']}, 08:10:10 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:10:10 INFO - 'talos_options': ['--xperf_path', 08:10:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:10:10 INFO - 'tests': ['tp5n']}}, 08:10:10 INFO - 'talos.zip': {'path': '', 08:10:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:10:10 INFO - Running post-action listener: _resource_record_post_action 08:10:10 INFO - [mozharness: 2017-03-03 16:10:10.684485Z] Finished populate-webroot step (success) 08:10:10 INFO - [mozharness: 2017-03-03 16:10:10.684601Z] Running create-virtualenv step. 08:10:10 INFO - Running pre-action listener: _resource_record_pre_action 08:10:10 INFO - Running main action method: create_virtualenv 08:10:10 INFO - Creating virtualenv /builds/slave/test/build/venv 08:10:10 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 08:10:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:10:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:10:10 INFO - Using real prefix '/tools/python27' 08:10:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:10:11 INFO - Installing distribute.............................................................................................................................................................................................done. 08:10:14 INFO - Installing pip.................done. 08:10:14 INFO - Return code: 0 08:10:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:10:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:10:14 INFO - Reading from file tmpfile_stdout 08:10:14 INFO - Output received: 08:10:14 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) 08:10:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:10:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:10:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:10:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:14 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 0x10404ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10404d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe891d9b900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e28d30>, '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 0x103d4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e1dbe8>, '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.MNXHah2HzH/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.5PwKMQxzEW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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 08:10:14 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 08:10:14 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 08:10:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MNXHah2HzH/Render', 08:10:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:10:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:10:14 INFO - 'HOME': '/Users/cltbld', 08:10:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:10:14 INFO - 'LOGNAME': 'cltbld', 08:10:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:14 INFO - 'MOZ_NO_REMOTE': '1', 08:10:14 INFO - 'NO_EM_RESTART': '1', 08:10:14 INFO - 'PAGER': '/bin/cat', 08:10:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:10:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:14 INFO - 'PWD': '/builds/slave/test', 08:10:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:10:14 INFO - 'SHELL': '/bin/bash', 08:10:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5PwKMQxzEW/Listeners', 08:10:14 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 08:10:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:10:14 INFO - 'USER': 'cltbld', 08:10:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:10:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:10:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:14 INFO - 'XPC_FLAGS': '0x0', 08:10:14 INFO - 'XPC_SERVICE_NAME': '0', 08:10:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:10:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:14 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 08:10:14 INFO - Cleaning up... 08:10:14 INFO - Return code: 0 08:10:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:10:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:10:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:10:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:14 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 0x10404ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10404d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe891d9b900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e28d30>, '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 0x103d4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e1dbe8>, '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.MNXHah2HzH/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.5PwKMQxzEW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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 08:10:14 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 08:10:14 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 08:10:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MNXHah2HzH/Render', 08:10:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:10:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:10:14 INFO - 'HOME': '/Users/cltbld', 08:10:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:10:14 INFO - 'LOGNAME': 'cltbld', 08:10:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:14 INFO - 'MOZ_NO_REMOTE': '1', 08:10:14 INFO - 'NO_EM_RESTART': '1', 08:10:14 INFO - 'PAGER': '/bin/cat', 08:10:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:10:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:14 INFO - 'PWD': '/builds/slave/test', 08:10:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:10:14 INFO - 'SHELL': '/bin/bash', 08:10:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5PwKMQxzEW/Listeners', 08:10:14 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 08:10:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:10:14 INFO - 'USER': 'cltbld', 08:10:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:10:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:10:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:14 INFO - 'XPC_FLAGS': '0x0', 08:10:14 INFO - 'XPC_SERVICE_NAME': '0', 08:10:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:10:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:15 INFO - Downloading/unpacking psutil>=3.1.1 08:10:15 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 08:10:15 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 08:10:15 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 08:10:15 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 08:10:15 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 08:10:15 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 08:10:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:10:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:10:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:10:19 INFO - Installing collected packages: psutil 08:10:19 INFO - Running setup.py install for psutil 08:10:19 INFO - building 'psutil._psutil_osx' extension 08:10:19 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 08:10:19 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 08:10:19 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 08:10:19 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 08:10:19 INFO - building 'psutil._psutil_posix' extension 08:10:19 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 08:10:19 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:10:19 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:10:19 INFO - ^ 08:10:19 INFO - 1 warning generated. 08:10:19 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 08:10:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:10:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:10:20 INFO - Successfully installed psutil 08:10:20 INFO - Cleaning up... 08:10:20 INFO - Return code: 0 08:10:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:10:20 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')]} 08:10:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:20 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')]} 08:10:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:20 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 0x10404ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10404d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe891d9b900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e28d30>, '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 0x103d4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e1dbe8>, '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.MNXHah2HzH/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.5PwKMQxzEW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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 08:10:20 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 08:10:20 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 08:10:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MNXHah2HzH/Render', 08:10:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:10:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:10:20 INFO - 'HOME': '/Users/cltbld', 08:10:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:10:20 INFO - 'LOGNAME': 'cltbld', 08:10:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:20 INFO - 'MOZ_NO_REMOTE': '1', 08:10:20 INFO - 'NO_EM_RESTART': '1', 08:10:20 INFO - 'PAGER': '/bin/cat', 08:10:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:10:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:20 INFO - 'PWD': '/builds/slave/test', 08:10:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:10:20 INFO - 'SHELL': '/bin/bash', 08:10:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5PwKMQxzEW/Listeners', 08:10:20 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 08:10:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:10:20 INFO - 'USER': 'cltbld', 08:10:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:10:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:10:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:20 INFO - 'XPC_FLAGS': '0x0', 08:10:20 INFO - 'XPC_SERVICE_NAME': '0', 08:10:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:10:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:10:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:10:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:10:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:10:23 INFO - Installing collected packages: mozsystemmonitor 08:10:23 INFO - Running setup.py install for mozsystemmonitor 08:10:23 INFO - Successfully installed mozsystemmonitor 08:10:23 INFO - Cleaning up... 08:10:23 INFO - Return code: 0 08:10:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:10:23 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')]} 08:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:23 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')]} 08:10:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:23 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 0x10404ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10404d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe891d9b900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e28d30>, '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 0x103d4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e1dbe8>, '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.MNXHah2HzH/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.5PwKMQxzEW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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 08:10:23 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 08:10:23 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 08:10:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MNXHah2HzH/Render', 08:10:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:10:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:10:23 INFO - 'HOME': '/Users/cltbld', 08:10:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:10:23 INFO - 'LOGNAME': 'cltbld', 08:10:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:23 INFO - 'MOZ_NO_REMOTE': '1', 08:10:23 INFO - 'NO_EM_RESTART': '1', 08:10:23 INFO - 'PAGER': '/bin/cat', 08:10:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:10:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:23 INFO - 'PWD': '/builds/slave/test', 08:10:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:10:23 INFO - 'SHELL': '/bin/bash', 08:10:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5PwKMQxzEW/Listeners', 08:10:23 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 08:10:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:10:23 INFO - 'USER': 'cltbld', 08:10:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:10:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:10:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:23 INFO - 'XPC_FLAGS': '0x0', 08:10:23 INFO - 'XPC_SERVICE_NAME': '0', 08:10:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:10:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:23 INFO - Downloading/unpacking jsonschema==2.5.1 08:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:10:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:10:26 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 08:10:26 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 08:10:26 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 08:10:26 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 08:10:26 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 08:10:26 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 08:10:26 INFO - Downloading functools32-3.2.3-2.tar.gz 08:10:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:10:26 INFO - warning: no files found matching '*.txt' 08:10:26 INFO - no previously-included directories found matching 'build' 08:10:26 INFO - no previously-included directories found matching 'dist' 08:10:26 INFO - no previously-included directories found matching '.git*' 08:10:26 INFO - Installing collected packages: jsonschema, functools32 08:10:26 INFO - Running setup.py install for functools32 08:10:26 INFO - warning: no files found matching '*.txt' 08:10:26 INFO - no previously-included directories found matching 'build' 08:10:26 INFO - no previously-included directories found matching 'dist' 08:10:26 INFO - no previously-included directories found matching '.git*' 08:10:26 INFO - Successfully installed jsonschema functools32 08:10:26 INFO - Cleaning up... 08:10:27 INFO - Return code: 0 08:10:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:10:27 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')]} 08:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:27 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')]} 08:10:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:27 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 0x10404ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10404d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe891d9b900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e28d30>, '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 0x103d4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e1dbe8>, '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.MNXHah2HzH/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.5PwKMQxzEW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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 08:10:27 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 08:10:27 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 08:10:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MNXHah2HzH/Render', 08:10:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:10:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:10:27 INFO - 'HOME': '/Users/cltbld', 08:10:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:10:27 INFO - 'LOGNAME': 'cltbld', 08:10:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:27 INFO - 'MOZ_NO_REMOTE': '1', 08:10:27 INFO - 'NO_EM_RESTART': '1', 08:10:27 INFO - 'PAGER': '/bin/cat', 08:10:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:10:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:27 INFO - 'PWD': '/builds/slave/test', 08:10:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:10:27 INFO - 'SHELL': '/bin/bash', 08:10:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5PwKMQxzEW/Listeners', 08:10:27 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 08:10:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:10:27 INFO - 'USER': 'cltbld', 08:10:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:10:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:10:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:27 INFO - 'XPC_FLAGS': '0x0', 08:10:27 INFO - 'XPC_SERVICE_NAME': '0', 08:10:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:10:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:10:27 INFO - Cleaning up... 08:10:27 INFO - Return code: 0 08:10:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:10:27 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')]} 08:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:27 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')]} 08:10:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:27 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 0x10404ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10404d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe891d9b900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e28d30>, '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 0x103d4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e1dbe8>, '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.MNXHah2HzH/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.5PwKMQxzEW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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 08:10:27 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 08:10:27 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 08:10:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MNXHah2HzH/Render', 08:10:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:10:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:10:27 INFO - 'HOME': '/Users/cltbld', 08:10:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:10:27 INFO - 'LOGNAME': 'cltbld', 08:10:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:27 INFO - 'MOZ_NO_REMOTE': '1', 08:10:27 INFO - 'NO_EM_RESTART': '1', 08:10:27 INFO - 'PAGER': '/bin/cat', 08:10:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:10:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:27 INFO - 'PWD': '/builds/slave/test', 08:10:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:10:27 INFO - 'SHELL': '/bin/bash', 08:10:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5PwKMQxzEW/Listeners', 08:10:27 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 08:10:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:10:27 INFO - 'USER': 'cltbld', 08:10:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:10:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:10:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:27 INFO - 'XPC_FLAGS': '0x0', 08:10:27 INFO - 'XPC_SERVICE_NAME': '0', 08:10:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:10:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:27 INFO - Downloading/unpacking blobuploader==1.2.4 08:10:27 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 08:10:27 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 08:10:27 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 08:10:27 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 08:10:27 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 08:10:27 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 08:10:30 INFO - Downloading blobuploader-1.2.4.tar.gz 08:10:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:10:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:10:30 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 08:10:30 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 08:10:30 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 08:10:30 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 08:10:30 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 08:10:30 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 08:10:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:10:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:10:30 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 08:10:30 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 08:10:30 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 08:10:30 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 08:10:30 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 08:10:30 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 08:10:31 INFO - Downloading docopt-0.6.1.tar.gz 08:10:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:10:31 INFO - Installing collected packages: blobuploader, requests, docopt 08:10:31 INFO - Running setup.py install for blobuploader 08:10:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:10:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:10:31 INFO - Running setup.py install for requests 08:10:32 INFO - Running setup.py install for docopt 08:10:32 INFO - Successfully installed blobuploader requests docopt 08:10:32 INFO - Cleaning up... 08:10:32 INFO - Return code: 0 08:10:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:10: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')]} 08:10:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10: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')]} 08:10:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:32 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 0x10404ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10404d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe891d9b900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e28d30>, '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 0x103d4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e1dbe8>, '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.MNXHah2HzH/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.5PwKMQxzEW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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 08:10:32 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 08:10:32 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 08:10:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MNXHah2HzH/Render', 08:10:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:10:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:10:32 INFO - 'HOME': '/Users/cltbld', 08:10:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:10:32 INFO - 'LOGNAME': 'cltbld', 08:10:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:32 INFO - 'MOZ_NO_REMOTE': '1', 08:10:32 INFO - 'NO_EM_RESTART': '1', 08:10:32 INFO - 'PAGER': '/bin/cat', 08:10:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:10:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:32 INFO - 'PWD': '/builds/slave/test', 08:10:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:10:32 INFO - 'SHELL': '/bin/bash', 08:10:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5PwKMQxzEW/Listeners', 08:10:32 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 08:10:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:10:32 INFO - 'USER': 'cltbld', 08:10:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:10:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:10:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:32 INFO - 'XPC_FLAGS': '0x0', 08:10:32 INFO - 'XPC_SERVICE_NAME': '0', 08:10:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:10:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:10:32 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-CemnRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:10:32 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-2xSwhX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:10:32 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-4NhWQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:10:33 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-nRqnaZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:10:33 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-ANgO10-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:10:33 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-532ut7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:10:33 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-rRuM86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:10:33 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-qyATgA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:10:33 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-Gqchhl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:10:33 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-X5DbBP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:10:33 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-ODIuV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:10:33 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-SgtDYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:10:33 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-vAEqgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:10:34 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-0xSI7P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:10:34 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-FfhreJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:10:34 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-FkzFHD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:10:34 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-7ZqosF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:10:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:10:34 INFO - Running setup.py install for manifestparser 08:10:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:10:34 INFO - Running setup.py install for mozcrash 08:10:34 INFO - Running setup.py install for mozdebug 08:10:34 INFO - Running setup.py install for mozdevice 08:10:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:10:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:10:35 INFO - Running setup.py install for mozfile 08:10:35 INFO - Running setup.py install for mozhttpd 08:10:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:10:35 INFO - Running setup.py install for mozinfo 08:10:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:10:35 INFO - Running setup.py install for mozInstall 08:10:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:10:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:10:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:10:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:10:35 INFO - Running setup.py install for mozleak 08:10:35 INFO - Running setup.py install for mozlog 08:10:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:10:35 INFO - Running setup.py install for moznetwork 08:10:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:10:36 INFO - Running setup.py install for mozprocess 08:10:36 INFO - Running setup.py install for mozprofile 08:10:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:10:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:10:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:10:36 INFO - Running setup.py install for mozrunner 08:10:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:10:36 INFO - Running setup.py install for mozscreenshot 08:10:36 INFO - Running setup.py install for moztest 08:10:36 INFO - Running setup.py install for mozversion 08:10:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:10:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:10:37 INFO - Cleaning up... 08:10:37 INFO - Return code: 0 08:10:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:10: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')]} 08:10:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10: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')]} 08:10:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:37 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 0x10404ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10404d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe891d9b900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e28d30>, '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 0x103d4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e1dbe8>, '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.MNXHah2HzH/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.5PwKMQxzEW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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 08:10:37 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 08:10:37 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 08:10:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MNXHah2HzH/Render', 08:10:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:10:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:10:37 INFO - 'HOME': '/Users/cltbld', 08:10:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:10:37 INFO - 'LOGNAME': 'cltbld', 08:10:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:37 INFO - 'MOZ_NO_REMOTE': '1', 08:10:37 INFO - 'NO_EM_RESTART': '1', 08:10:37 INFO - 'PAGER': '/bin/cat', 08:10:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:10:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:37 INFO - 'PWD': '/builds/slave/test', 08:10:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:10:37 INFO - 'SHELL': '/bin/bash', 08:10:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5PwKMQxzEW/Listeners', 08:10:37 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 08:10:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:10:37 INFO - 'USER': 'cltbld', 08:10:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:10:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:10:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:37 INFO - 'XPC_FLAGS': '0x0', 08:10:37 INFO - 'XPC_SERVICE_NAME': '0', 08:10:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:10:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:10:37 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-tpdFsb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:10:37 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)) 08:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:10:37 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-uT9yqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:10:37 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)) 08:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:10:37 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-kYFmkY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:10:37 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)) 08:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:10:37 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-YdO0oR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:10:37 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)) 08:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:10:37 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-SjlzjB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:10:37 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)) 08:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:10:37 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-hkze_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:10:38 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)) 08:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:10:38 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-1G9Otk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:10:38 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)) 08:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:10:38 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-Dl5zll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:10:38 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)) 08:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:10:38 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-tGTsVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:10:38 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)) 08:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:10:38 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-AH8jxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:10:38 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)) 08:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:10:38 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-Qz8bLH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:10:38 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)) 08:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:10:38 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-PwAdok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:10:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:10:38 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-DDKs68-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:10:38 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)) 08:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:10:38 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-zzAqmb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:10:38 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)) 08:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:10:38 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-Ya0q6P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:10:38 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)) 08:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:10:38 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-5ECuxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:10:39 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)) 08:10:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:10:39 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-7DC4EQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:10:39 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)) 08:10:39 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)) 08:10:39 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)) 08:10:39 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)) 08:10:39 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)) 08:10:39 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)) 08:10:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:10:39 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 08:10:39 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 08:10:39 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 08:10:39 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 08:10:39 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 08:10:39 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 08:10:41 INFO - Downloading blessings-1.6.tar.gz 08:10:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:10:41 INFO - Installing collected packages: blessings 08:10:41 INFO - Running setup.py install for blessings 08:10:42 INFO - Successfully installed blessings 08:10:42 INFO - Cleaning up... 08:10:42 INFO - Return code: 0 08:10:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:10:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:10:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:10:42 INFO - Reading from file tmpfile_stdout 08:10:42 INFO - Current package versions: 08:10:42 INFO - blessings == 1.6 08:10:42 INFO - blobuploader == 1.2.4 08:10:42 INFO - docopt == 0.6.1 08:10:42 INFO - functools32 == 3.2.3-2 08:10:42 INFO - jsonschema == 2.5.1 08:10:42 INFO - manifestparser == 1.1 08:10:42 INFO - mozInstall == 1.12 08:10:42 INFO - mozcrash == 1.0 08:10:42 INFO - mozdebug == 0.1 08:10:42 INFO - mozdevice == 0.49 08:10:42 INFO - mozfile == 1.2 08:10:42 INFO - mozhttpd == 0.7 08:10:42 INFO - mozinfo == 0.9 08:10:42 INFO - mozleak == 0.1 08:10:42 INFO - mozlog == 3.4 08:10:42 INFO - moznetwork == 0.27 08:10:42 INFO - mozprocess == 0.24 08:10:42 INFO - mozprofile == 0.28 08:10:42 INFO - mozrunner == 6.13 08:10:42 INFO - mozscreenshot == 0.1 08:10:42 INFO - mozsystemmonitor == 0.3 08:10:42 INFO - moztest == 0.8 08:10:42 INFO - mozversion == 1.4 08:10:42 INFO - psutil == 3.1.1 08:10:42 INFO - requests == 1.2.3 08:10:42 INFO - wsgiref == 0.1.2 08:10:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:10:42 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')]} 08:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:42 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')]} 08:10:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:42 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 0x10404ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10404d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe891d9b900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e28d30>, '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 0x103d4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e1dbe8>, '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.MNXHah2HzH/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.5PwKMQxzEW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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 08:10:42 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 08:10:42 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 08:10:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MNXHah2HzH/Render', 08:10:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:10:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:10:42 INFO - 'HOME': '/Users/cltbld', 08:10:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:10:42 INFO - 'LOGNAME': 'cltbld', 08:10:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:42 INFO - 'MOZ_NO_REMOTE': '1', 08:10:42 INFO - 'NO_EM_RESTART': '1', 08:10:42 INFO - 'PAGER': '/bin/cat', 08:10:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:10:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:42 INFO - 'PWD': '/builds/slave/test', 08:10:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:10:42 INFO - 'SHELL': '/bin/bash', 08:10:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5PwKMQxzEW/Listeners', 08:10:42 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 08:10:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:10:42 INFO - 'USER': 'cltbld', 08:10:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:10:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:10:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:42 INFO - 'XPC_FLAGS': '0x0', 08:10:42 INFO - 'XPC_SERVICE_NAME': '0', 08:10:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:10:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:42 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)) 08:10:42 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)) 08:10:42 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)) 08:10:42 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)) 08:10:42 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)) 08:10:42 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)) 08:10:42 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)) 08:10:42 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)) 08:10:42 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)) 08:10:42 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)) 08:10:42 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)) 08:10:42 INFO - Cleaning up... 08:10:42 INFO - Return code: 0 08:10:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:10:42 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')]} 08:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:42 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')]} 08:10:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:42 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 0x10404ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10404d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe891d9b900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e28d30>, '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 0x103d4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e1dbe8>, '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.MNXHah2HzH/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.5PwKMQxzEW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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 08:10:42 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 08:10:42 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 08:10:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MNXHah2HzH/Render', 08:10:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:10:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:10:42 INFO - 'HOME': '/Users/cltbld', 08:10:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:10:42 INFO - 'LOGNAME': 'cltbld', 08:10:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:42 INFO - 'MOZ_NO_REMOTE': '1', 08:10:42 INFO - 'NO_EM_RESTART': '1', 08:10:42 INFO - 'PAGER': '/bin/cat', 08:10:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:10:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:42 INFO - 'PWD': '/builds/slave/test', 08:10:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:10:42 INFO - 'SHELL': '/bin/bash', 08:10:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5PwKMQxzEW/Listeners', 08:10:42 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 08:10:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:10:42 INFO - 'USER': 'cltbld', 08:10:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:10:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:10:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:42 INFO - 'XPC_FLAGS': '0x0', 08:10:42 INFO - 'XPC_SERVICE_NAME': '0', 08:10:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:10:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:10:43 INFO - Cleaning up... 08:10:43 INFO - Return code: 0 08:10:43 INFO - Running post-action listener: _resource_record_post_action 08:10:43 INFO - Running post-action listener: _start_resource_monitoring 08:10:43 INFO - Starting resource monitoring. 08:10:43 INFO - [mozharness: 2017-03-03 16:10:43.089140Z] Finished create-virtualenv step (success) 08:10:43 INFO - [mozharness: 2017-03-03 16:10:43.090126Z] Running install step. 08:10:43 INFO - Running pre-action listener: _resource_record_pre_action 08:10:43 INFO - Running main action method: install 08:10:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:10:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:10:43 INFO - Reading from file tmpfile_stdout 08:10:43 INFO - Detecting whether we're running mozinstall >=1.0... 08:10:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:10:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:10:43 INFO - Reading from file tmpfile_stdout 08:10:43 INFO - Output received: 08:10:43 INFO - Usage: mozinstall [options] installer 08:10:43 INFO - Options: 08:10:43 INFO - -h, --help show this help message and exit 08:10:43 INFO - -d DEST, --destination=DEST 08:10:43 INFO - Directory to install application into. [default: 08:10:43 INFO - "/builds/slave/test"] 08:10:43 INFO - --app=APP Application being installed. [default: firefox] 08:10:43 INFO - mkdir: /builds/slave/test/build/application 08:10:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:10:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 08:11:03 INFO - Reading from file tmpfile_stdout 08:11:03 INFO - Output received: 08:11:03 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 08:11:03 INFO - Running post-action listener: _resource_record_post_action 08:11:03 INFO - [mozharness: 2017-03-03 16:11:03.363771Z] Finished install step (success) 08:11:03 INFO - [mozharness: 2017-03-03 16:11:03.363910Z] Running run-tests step. 08:11:03 INFO - Running pre-action listener: _resource_record_pre_action 08:11:03 INFO - Running main action method: run_tests 08:11:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:11:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:11:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:11:03 INFO - 2017-03-03 08:11:03.378 screenresolution[6453:120776] starting screenresolution argv=screenresolution get 08:11:03 INFO - 2017-03-03 08:11:03.381 screenresolution[6453:120776] Display 0: 1600x1200x32@60 08:11:03 INFO - 2017-03-03 08:11:03.387 screenresolution[6454:120779] starting screenresolution argv=screenresolution list 08:11:03 INFO - Available Modes on Display 0 08:11:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:11:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:11:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:11:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:11:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:11:03 INFO - Intel Iris: 08:11:03 INFO - Chipset Model: Intel Iris 08:11:03 INFO - Type: GPU 08:11:03 INFO - Bus: Built-In 08:11:03 INFO - VRAM (Dynamic, Max): 1536 MB 08:11:03 INFO - Vendor: Intel (0x8086) 08:11:03 INFO - Device ID: 0x0a2e 08:11:03 INFO - Revision ID: 0x0009 08:11:03 INFO - Displays: 08:11:03 INFO - Display: 08:11:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:11:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:11:03 INFO - Display Serial Number: 1600x1200 60 08:11:03 INFO - Main Display: Yes 08:11:03 INFO - Mirror: Off 08:11:03 INFO - Online: Yes 08:11:03 INFO - Rotation: Supported 08:11:03 INFO - Return code: 0 08:11:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:11:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:11:03 INFO - Python 2.7.3 08:11:03 INFO - Return code: 0 08:11:03 INFO - grabbing minidump binary from tooltool 08:11:03 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')]} 08:11:03 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 0x103e28d30>, '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 0x103d4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e1dbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:11:03 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 08:11:03 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 08:11:03 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 08:11:03 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:11:03 INFO - Return code: 0 08:11:03 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:11:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:11:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:11:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:11:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:11:03 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/LhGJ4O_TToGRuTDCEk4Snw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0300', '--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 08:11:03 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/LhGJ4O_TToGRuTDCEk4Snw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0300 --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 08:11:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MNXHah2HzH/Render', 08:11:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:11:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:11:03 INFO - 'HOME': '/Users/cltbld', 08:11:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:11:03 INFO - 'LOGNAME': 'cltbld', 08:11:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:11:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:11:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:03 INFO - 'MOZ_NO_REMOTE': '1', 08:11:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:11:03 INFO - 'NO_EM_RESTART': '1', 08:11:03 INFO - 'PAGER': '/bin/cat', 08:11:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:11:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:03 INFO - 'PWD': '/builds/slave/test', 08:11:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:11:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:11:03 INFO - 'SHELL': '/bin/bash', 08:11:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5PwKMQxzEW/Listeners', 08:11:03 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 08:11:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:11:03 INFO - 'USER': 'cltbld', 08:11:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:11:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:11:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:03 INFO - 'XPC_FLAGS': '0x0', 08:11:03 INFO - 'XPC_SERVICE_NAME': '0', 08:11:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:11:03 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/LhGJ4O_TToGRuTDCEk4Snw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0300', '--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 08:11:03 INFO - mozversion application_buildid: 20170303070751 08:11:03 INFO - mozversion application_changeset: d9d91d6e389ef19bd48eb5153c9e32a122a1eecc 08:11:03 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:11:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:11:03 INFO - mozversion application_name: Firefox 08:11:03 INFO - mozversion application_remotingname: firefox-dev 08:11:03 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:11:03 INFO - mozversion application_vendor: Mozilla 08:11:03 INFO - mozversion application_version: 53.0a2 08:11:03 INFO - mozversion platform_buildid: 20170303070751 08:11:03 INFO - mozversion platform_changeset: d9d91d6e389ef19bd48eb5153c9e32a122a1eecc 08:11:03 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:11:03 INFO - mozversion platform_version: 53.0a2 08:11:03 INFO - using testdate: 1488557463 08:11:03 INFO - actual date: 1488557463 08:11:03 INFO - starting webserver on 'localhost:56858' 08:11:03 INFO - SUITE-START | Running 2 tests 08:11:03 INFO - TEST-START | dromaeo_css 08:11:03 INFO - operating with platform_type : mac_ 08:11:03 INFO - Initialising browser for dromaeo_css test... 08:11:03 INFO - TEST-INFO | started process 6464 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/tmpYLMue2/profile http://localhost:56858/getInfo.html) 08:11:06 INFO - PROCESS | 6464 | 2017-03-03 08:11:06.814 plugin-container[6466:120941] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x903f, name = 'com.apple.tsm.portname' 08:11:06 INFO - PROCESS | 6464 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:11:06 INFO - PROCESS | 6464 | 2017-03-03 08:11:06.817 plugin-container[6466:120941] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9517, name = 'com.apple.CFPasteboardClient' 08:11:06 INFO - PROCESS | 6464 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:11:06 INFO - PROCESS | 6464 | 2017-03-03 08:11:06.817 plugin-container[6466:120941] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:11:06 INFO - PROCESS | 6464 | __metrics Screen width/height:1600/1200 08:11:06 INFO - PROCESS | 6464 | colorDepth:24 08:11:06 INFO - PROCESS | 6464 | Browser inner width/height: 1024/689 08:11:06 INFO - PROCESS | 6464 | __metrics 08:11:06 ERROR - PROCESS | 6464 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 08:11:07 INFO - TEST-INFO | 6464: exit 0 08:11:07 INFO - Browser initialized. 08:11:07 INFO - Running cycle 1/1 for dromaeo_css test... 08:11:07 INFO - TEST-INFO | started process 6468 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/tmpYLMue2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:11:10 INFO - PROCESS | 6468 | 2017-03-03 08:11:10.459 plugin-container[6469:121075] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873f, name = 'com.apple.tsm.portname' 08:11:10 INFO - PROCESS | 6468 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:11:10 INFO - PROCESS | 6468 | 2017-03-03 08:11:10.460 plugin-container[6469:121075] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x471b, name = 'com.apple.CFPasteboardClient' 08:11:10 INFO - PROCESS | 6468 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:11:10 INFO - PROCESS | 6468 | 2017-03-03 08:11:10.460 plugin-container[6469:121075] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:11:20 INFO - PROCESS | 6468 | RSS: Main: 218554368 08:11:20 INFO - PROCESS | 6468 | 08:14:22 INFO - PROCESS | 6468 | Cycle 1(1): loaded http://localhost:56858/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56858/tests/dromaeo/cssquery-ext.html) 08:14:23 INFO - PROCESS | 6468 | RSS: Main: 239333376 08:14:23 INFO - PROCESS | 6468 | 08:16:08 INFO - PROCESS | 6468 | ************************* 08:16:08 INFO - PROCESS | 6468 | A coding exception was thrown and uncaught in a Task. 08:16:08 INFO - PROCESS | 6468 | 08:16:08 ERROR - PROCESS | 6468 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:16:08 INFO - PROCESS | 6468 | Full stack: 08:16:08 INFO - PROCESS | 6468 | ************************* 08:17:26 INFO - PROCESS | 6468 | Cycle 1(1): loaded http://localhost:56858/tests/dromaeo/cssquery-ext.html (next: http://localhost:56858/tests/dromaeo/cssquery-jquery.html) 08:17:26 INFO - PROCESS | 6468 | RSS: Main: 248000512 08:17:26 INFO - PROCESS | 6468 | 08:20:28 INFO - PROCESS | 6468 | Cycle 1(1): loaded http://localhost:56858/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56858/tests/dromaeo/cssquery-mootools.html) 08:20:29 INFO - PROCESS | 6468 | RSS: Main: 254300160 08:20:29 INFO - PROCESS | 6468 | 08:23:31 INFO - PROCESS | 6468 | Cycle 1(1): loaded http://localhost:56858/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56858/tests/dromaeo/cssquery-prototype.html) 08:23:31 INFO - PROCESS | 6468 | RSS: Main: 250777600 08:23:31 INFO - PROCESS | 6468 | 08:26:34 INFO - PROCESS | 6468 | Cycle 1(1): loaded http://localhost:56858/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56858/tests/dromaeo/cssquery-yui.html) 08:26:35 INFO - PROCESS | 6468 | RSS: Main: 254672896 08:26:35 INFO - PROCESS | 6468 | 08:29:38 INFO - PROCESS | 6468 | Cycle 1(1): loaded http://localhost:56858/tests/dromaeo/cssquery-yui.html (next: http://localhost:56858/tests/dromaeo/cssquery-dojo.html) 08:29:38 INFO - PROCESS | 6468 | RSS: Main: 256315392 08:29:38 INFO - PROCESS | 6468 | 08:29:38 INFO - PROCESS | 6468 | __start_tp_report 08:29:38 INFO - PROCESS | 6468 | _x_x_mozilla_page_load 08:29:38 INFO - PROCESS | 6468 | _x_x_mozilla_page_load_details 08:29:38 INFO - PROCESS | 6468 | |i|pagename|runs| 08:29:38 INFO - PROCESS | 6468 | |0;dojo.html;2457.6682147910033;3279.5244689520005;3290.42417576924;3316.121227874612;3330.55037569928;4370.38814565961;5455.345358556969;5569.3316801983765;5572.470615291546;5624.268845050148;5611.7755289788465;5628.380878103405;5636.971815140919;5665.688387138705;5681.914771278434;5128.769205385757;5193.610479214055;5197.584193264549;5213.530782229599;5227.08526007949;5190.429052804188;5230.738463076831;5231.398389185235;5244.868878278055;5283.8150664726745;5057.519535644108;5061.519155680205;5210.739463026853;5217.947820521803;5218.373795144588;5131.846044618667;5162.509561591662;5187.273781670569;5216.243644671539;5285.6300058995885;5142.460041695643;5175.353080864892;5179;5184.766685499161;5191.506806853381;5424.918626220609;5543.77824887004;5590.944090559083;5745.798897038583;5747.770089196427;6080.30076541199;6102.542309326818;6121.846953826145;6128.3258841527395;6205.5345849061505;6233;6237.656928868911;6270.968645156745;6302.779402720883;6305.085762564402;5753.913691294634;5767.740451679684;5772.797952071657;5788.479036886658;5816.97091514544;6153.323134455206;6181.072839074175;6185.567010309325;6221.160143380676;6242.968785156136;6087.3303936566945;6136.355682653347;6154.0911171705475;6165.475934545524;6168.290646575701;6219.129321894939;6232.594881332699;6279.309275979638;6296.496280297565;6304.401081897213;6017.789377371859;6097.512199024068;6120.44915957566;6126.111713801563;6241;6173.950428427178;6232.844178895564;6256.906146407808;6266.717997690115;6277.96861015692;4216.789160541961;4981.227909674007;4982.103221420107;4983.001166488894;5010.473900240495;4278.122984788111;4303.806328715215;4373.693841431069;4424.358468022118;4442.378067070613;4783.95216047842;5601.7759289628775;5649.491545760901;5678.914816277759;5715.057015592381;6229.56393052482;6237.064440333987;6251.249850018027;6255;6283.7800676976085;5593.468620481048;5622.437756224344;5645.971770141123;5659.915101273484;5761.53907687384;5401.405845357008;5403.216533602685;5412.458754124556;5416.0792665247;5441.673499590037;6266.122742816009;6271.905921411274;6286.968565157145;6287.591306564967;6294.213223347082;6099.359567245553;6119.350229749554;6131.96934015327;6138.265785110882;6249.281332646804;6198.132261483306;6222.782202622887;6262.185915830913;6263.3736626337;6267.341929097379;6075.422834830684;6146.661933593696;6150.077488376779;6155.815325540241;6166.167567378347;6135;6135.018317212141;6171.166892469639;6233.158523599256;6266.68666566679;6000.369961154016;6113.29387775398;6114.206128133811;6121.056693971993;6139.553468857771;5920.585559010828;5976.641401515923;6044.214252147192;6088.786892458743;6092.939070609237;4553;5601.103823388238;5833.766649333979;5887.793927212527;5967.045272756338;6005.579609427298;6024.277086749618;6054.515638748978;6121.5139442231075;6132.5400594956445;5897.882042359214;5916.940830591639;5928;5928.9110663339225;5943.702814859326 08:29:38 INFO - PROCESS | 6468 | |1;ext.html;449.77960799208375;471.3636590602687;490.8576512811285;499.84754649831797;536.0378121272316;30737.69262307379;40677;40791.592084079115;40799.59200408003;40912;36417.271654566895;38478.61521384785;38968.41547376791;42241;42524.57475425245;7947.960260198705;8352.206540378655;8567.143285671445;9325.673601423918;9371.95314023429;11027.44862756863;11306.038986686142;11337.659870203906;11456.713582160472;11457.885421145807;9867.210623150131;11408.942955285213;11446.198766086378;11489.712757181054;11495.655130346104;9610.375325603849;11346.886531134665;11414.657560273205;11420.42897855104;11422.771544569145;11288.774224515546;11377.146713996483;11380.71548211293;11393.829092563617;11396;40819.18361632751;41107.7944610275;41173.58826411727;41344.586554134374;41382.37926431106;3772.8679496217774;3884.8834534964;3941.9211615767813;3949.545802232751;3951.46655201547;25000.874995624905;29421.97023104181;29647.407051859056;30973.845130774203;31474.213144671336;3044.3911217756536;3171.2389026633673;3174.619045714529;3180.888668896601;3244.643089260203;369155;480032;483097.5845120787;484083;486339;63615.68192159102;64051.679741600994;64167;64201.67899160474;64245.678771605846;55679.721601391735;65620.37518499303;65630;66304;66451.33548664452;16162.111083890499;16679.499615011326;16741;16746.665066698843;16753.581160471087;11442.94278528602;11814.173007889538;12678.366081695878;12952.222866628032;12992.285424301754;16832.24254908532;17048.744268835977;17080.402185923434;17133.65732685364;17164.141792910305;6151.477124444473;6246.937530624636;7396.408287337;7448.888266676005;7464.290892365217;872.3588162700537;875.1554749666602;875.2166810704512;892.9107089291019;910.717677519971;30298.939537116537;30383.392332153235;30405.239869003453;30475.847620761753;30671.220018772397;1000.1598657128047;1045.1429827541494;1060.151878497199;1107.5182295701234;1203.9879601203875;11680;15672.373105075898;15854.365825367087;15915;15935.933743784875;549025;682477;701180;705407;900008;51485.7425712869;52103.69740756436;52146.21780673217;52293.73853130786;52437.213441798405;1282.435728279554;1362.3937347880296;1426.0730525158522;1436.8634979676915;1438.2736717957364;27371.726282737713;27697.030603928764;27783.30541736473;28209;28365.149045528666;32247.838760806048;34864.30271394608;44752.10495790131;44801;44919.32621010753;382689.08655456547;458955;462201;462534;463470;21689.891550542146;22207.222747204418;23669.28992130239;24122;24296.635550466402;41726.79136604298;41965.790171048946;42017;42304.57695423006;42672.78663606662;34411.483827743104;34596;34975.475367868996;35508.64491355053;35616.82191589129;34012.48981265233;34383.140421488664;34976;35410.46884296789;35466;33074;33620.3275934475;34237.82881085579;34411;34517.066049386085;24980.050653991057;28418.721157547545;31067.555882440494;31158.40893230966;31241.255246851706;20923.686144708146;23377.532449351256;23471.41321466977;23808.40478988039;23950.76049239555 08:29:38 INFO - PROCESS | 6468 | |2;jquery.html;350.6125731067171;391.19999600816345;393.373400986919;402.43457941592067;425.16030839092775;20231.696524552142;21707.348779536598;21722.13111475541;21738.91305434726;21975.011124499397;21368.358949231508;21475.140994360245;22046.448838779037;22049.11803527857;22269.331920042383;4901.289313049606;5392.865178370543;5760.74076666551;5767.971160144193;5771.797987070453;5471.616986810925;5658.321001479828;5690.317161940552;5709.543236541088;5759.049756790125;5687.317521897378;5695.572832037614;5701.401352857953;5708.514776244025;5710.343310519281;5415.377231618355;5614.63504872182;5692.203091567184;5696.917585658753;5702.4012478689765;5036.294918711384;5052.191649336125;5055.443901170868;5059.822906198302;5067.670601410933;21327.573448531097;25482.617760733603;26166;26641.733582664117;26925.326866828487;2643.365592257844;2689.880521812872;2695.528282550546;2731.508328500869;2733.098077634376;15621.609459763484;15830.129342886137;15933.681326373408;15991.440299589458;16336.75494867566;1805.2147315917618;1832.2945665918717;1845.8707890447674;1861.3206179744432;1866.701327787561;124509;126333;128170.35914820459;130143.34928325392;130791;11501.942490287494;11733.4719937603;11742.88257117435;11861.703457413461;11886.940565297118;14506.854931450762;14533.128012319296;14549.78175327371;14573.052751571115;14578.198199098939;8518.372574130579;8720.30237580992;8882.15619516145;9011.414258073204;9052.954735226282;7376.409887209011;7544.86826975958;8765.430247033923;8867.024627291123;8879.845620069349;7184.928150718426;7277.672504737194;7307.19620841707;7318.3047610476915;7343.228960959129;1938.709193620968;1980.6632872411724;1981.564055907698;1985.4043786863883;1986.0963261715885;987.7728122531714;1065.4672663668166;1081.551156270139;1087.608460954056;1102.944852757375;16544.917275413787;16887.746683799753;17416.954982701078;21712.674309885366;22873.19943801959;987.3532835992437;1078.5362294213564;1110.1451882050776;1114.9498272577753;1115.6876074699098;10835.133189344991;11137.832932505857;11183.04944079746;11979.46092425843;12019.038476921825;352385;631414;662532;709744;751347;113717.15707107389;122867;135508.3224583871;137695.31152344175;139525.30237348747;1028.1517747858047;1029.6550655530482;1047.120418848156;1049.37037777333;1051.8001579699833;17051.317947282467;19580.412587622395;19701.310454134036;19749.210031598574;19809.60380792405;43990.580518070536;52595;54848;55498.72250638721;55880;76788.61605691936;79402.80895786683;80949;82266.53200403997;82940;7959.721409750631;8083.878741818759;8257.876131858147;8429.536375499407;8599.828003440021;12462.750744985231;12749.235045897276;12947.676308092374;13048.804267935799;13361.331933403097;9455.338126331091;11111.83332250033;11178.27341222818;11316.37759923212;11456.312621242752;10898.891011090105;11038.779224415628;11167.664970050912;11617.302961822317;11769.470373833026;11209.159313051718;11220;11406.201565890307;11493.942530287295;11623.360715160747;8029.835673827379;8040.316573091352;8203.26170644621;8207.466514676527;8277.213664701843;10894.945525272324;11242.381669008282;11500.769984600429;11615.941920290345;11920.403979801149 08:29:38 INFO - PROCESS | 6468 | |3;mootools.html;1426.1870733681806;1433.7562614355559;1437.4250299880052;1445.6169115184475;1450.673598440351;7407.740729074483;7512.399008079355;7771.92228077719;8550.657973681053;8577.099404562525;7985.680572777096;8220.260176584121;8224.342052635775;8340.124286949858;8372.83254334913;1915.501969487936;1935.7193206984978;2050.364387040015;2311.7225932888077;2320.872352020638;2042.5914817036653;2130.7017017617545;2148.957020859582;2270.4550907782095;2293.1629955066446;2198.527316626925;2286.1998300594823;2292;2293.3693234360603;2309.642005489152;1946.776120746104;2296.0471404367167;2298.5747636687183;2316.30510846747;2328.6856274402994;2281.1673739085113;2292.5098685854164;2327.464683122891;2351.8236132289976;2363.196513185508;8384.03583587889;8453;8455.915440845574;8463.4075614707;8463.873041904377;5050.191969284933;5223.268742376071;5225.660332078441;5231.738413079331;5250.317458730379;3424.366492198951;3431.759776815624;3453.689167974869;3494.842732077037;3532.2405682778326;1119.3172164979355;1131.9264247823864;1181.2203945395997;1184.8400465937075;1223.076577184229;7835.725749598737;9407.717768466957;9419.24646028316;9510.334276600572;9527.714168574954;4342.782860856944;4415.448068991376;4491;4503.954960450354;4739.573438390561;7727.613619319011;9225.630974761069;9589.808203835884;9595.184409325286;9619.51902404877;5208.062548741263;5272.894542109137;5301.151815709468;5305.681659100466;5321.441248668912;4003.8398464061693;4659.324397962277;4704.600108990774;4811.78346974387;4851.708897466164;3861;3870.651641352292;3937.822797974098;3967.682585393162;4012.2376748417705;1177.087756988341;1219.2501611509035;1287.67808047988;1301.0177316126453;1303.1789972317379;663.9535232533773;736.6997249854012;767.823400617861;792.0614072324314;831.9875201871977;5561.555075593943;5565.9443405566235;5565.972170139124;5768.567357448208;5890.646561206341;872.581161042703;986.5659109991581;998.8401855703053;1009.2329829329616;1034.891336409666;3719.75821571597;3796.3166630006313;3799.4870692456716;3907.902302442405;3912.7456715313415;9354.298427617956;9859.507024648883;9862.605495780232;9866.358686685342;9870.30907836459;9774.973627768983;9802.36284641496;9805.509724513746;9810.362326448902;9826.16477599412;6362.236531616236;7725.072991241087;7756.6509507072315;7780.766577002699;7834.529928204326;4814.807407703793;5664.85837854057;5692.7722891083895;5706.771729130788;5866.970665146647;8945.329100317633;9110.225630821455;9249.907500925174;9338.206252468617;9355.391899526508;9108.544572771203;9212.986571476999;9358.953205233931;9479.573419196291;9489.335746497678;7084.893726594209;7317.963410182915;7321.231270716711;7326.96336518314;7328.633568321669;7841.490303130278;7841.941337919536;7880.448368614142;7906.090799557895;7945.48354356965;6301.842453938688;7082.699643471499;7134.536255143399;7181.030560874216;7279.8180045497165;7036.542624729581;7045.260247674126;7113.004179414783;7143.749968751069;7193.352598266181;6389.137466441971;6431.5819471734185;6439.967800160969;6474.1583594134345;6478.319776423407;4842.491538388418;4862.07620552094;4888.853334399973;4998.2002879539095;5107.668001579886;4883;4905.3623029006;4921.8523444296725;5052.797888084436;5087.643864929568 08:29:38 INFO - PROCESS | 6468 | |4;prototype.html;356.09196548800554;357.91052236940766;363.9490471334014;367.358958617213;373.0617496995058;5150.4334523202415;5306.548943339821;5414.648047876885;5423.918641220384;5571.470710282527;5142.66572672776;5247.2653828464045;5309.920351194735;5321.111005593017;5403.594730395226;4194.3498757692605;4203.327467605184;4230.751928181194;4246.851360202393;4250.9149817003645;3382.610999735025;3724.3110024645393;4207.158568286355;4264.339027450735;4299.613034826865;3482.268723568041;4147.854825081123;4150.796269081962;4179.707420480568;4193.601607847265;4153.089578793759;4155.376693495985;4160.750354978696;4205.5794420558;4209.621134097915;3139.6232452105664;3145.889893853704;3471.75697701161;3564.679178873888;3582.283543291352;4497.64018878489;4975.780933671237;5197.8440646780655;5231.764570594332;5240.423553409122;4321.891952701176;4872.65891387603;4894.241392584155;4894.4371397289415;4896.387951506062;5156.974215128937;5160.819371321985;5412.945870541323;5749.453801888814;5752.568557358215;3412.812295323756;3649.489071529988;3880.049387899983;3898.8245528951265;4151.256472281649;5481.75332110052;5509.5041446270025;5800.707476467426;6047.395260473962;6168.691565421711;3772.0389494246883;3958.5353419235066;3961.920761584752;3967.682585393219;3968.6626636735623;3697.5932647408763;3758.4550240215017;3795.3358162322033;3985.6811455083525;4019.070845993939;4106.425100485934;4584.7936842842155;4610.2623580227;4635.188841952645;4696.483386827446;5745.443277741449;5806.941930580725;5811.3316968548315;5819.505342045889;5823.650580965155;1075.930064545802;1088.6625146204701;1166.3993043582561;1212.2302338015247;1238.4365113873166;773.880048592469;848.7989494864821;878.1569693094573;878.4509681449094;879.6497376527001;4257.531671516131;5056.292119103328;5058.519440653132;5070.442251352349;5107.548376779093;4888.755562221874;5204.0449258563;5386.622936394415;5585.664860108406;5610.887782244332;4694.319323698045;4708.128041894442;4774.689645173122;5088.618353623493;5098;2518.597024476075;2835.560488124344;2865.7933391288593;2915.781316401278;2968.5101958177092;5023.472535383805;5301.416844147141;5836.358000619928;5852.648841069549;5895.263092113486;5045.646804723708;5173.042987047408;5390.622656414013;5753.913691294634;5770.971145144332;5177.352830896138;5255.527002569787;5440.259117082495;5769.7595017071535;5959.16939453756;4558.7948542316335;5199.55803756685;5232.555232805102;5385.946140538701;5524.751386187711;4495.52796956328;5294.761735721979;5347.893042139058;5800.8259752207505;5962.509372656836;5536.7785288588;6238.594491358047;6268.6179251884;6285.240132762834;6298.748050077946;3354.8993530194134;3412.334594753999;3955.8022098894367;3956.327424337927;3991.600839915985;5276.20856871457;5508.586855985897;5788.21859049023;5833.67914764692;5873.823785286449;5424.5660347172925;5551.694656793915;5616.4383561645145;5715.399883012224;5734.197212390185;4916.459189489082;5270.973645131749;5697.173909783141;5718.942810571841;5731.971340143273;4654.811454153915;4949.480304567968;5301.973490132525;5367.785288588413;5590.357108932525;4965.30485732005;5673.461021202979;5699.686517241592;5712.82937969431;5716.570457555606;4355.49911760139;5033.495021955403;5096.30517874538;5530.253415788978;5572.35917869434 08:29:38 INFO - PROCESS | 6468 | |5;yui.html;689.2969171445123;697.2051860878599;717.7882524655226;765.6975494679601;820.4789958376431;14678.706425871476;15269.6946061079;15274.38902443901;15279.847201527982;15290.46483373082;13960.930195349008;14070.296485175726;14102.717945641081;14132.434702611909;14140.57578272651;658.8814013477572;687.9002544631026;810.7324582887633;833.3083540661252;845.5222799118509;657.6777379084239;856.8029353248756;860.6385318166385;861.2937391339104;861.9439736417144;890.1943740914483;903.3902116071658;904.2178515584038;904.5296445848155;907.7503686486203;897.1477096758106;901.6393442622938;902.2015516268117;904.2946501728662;904.3036861616552;659.1990731261492;669.1468377818272;670.0619133213492;671.768239957214;675.7702381190419;15183.696326073527;15200.543983680507;15215.543533694006;15226.086434813946;15334.769978450333;14154;14508.564743057725;14521.564353069425;14524.782128268085;14618.70762584753;11333.659990200307;11703.23928944616;11739.178257521977;11741.706457338549;11850.466728997217;3570.1967057412135;3617.7467577269604;3648.616895226016;3687.9815600922093;3806.695464362872;108480.91519084865;108998.45500772525;112511;113401;114008;10381.84427233592;10441.269111162146;10535.367877927349;10576.048155666027;10605;19582.727122736975;19687.90156049239;21135.154593816074;21174.576508469745;21300.25449109305;7382.22486638906;7439.702411903571;7457.179710231871;7526.134494533089;7592.734254301184;4104.692148088905;4199.622034016953;4202.936955945664;4295.355696645528;4306.913861722811;3417.5386322846593;3420.863165473353;3449.758516903843;3486.18074752433;3494.371013217645;623.8845813524513;635.9109724638554;636.9394907483781;650.388634683396;656.5502630697987;601.9435890012999;614.7141579165709;634.552640388525;637.8309747916805;650.7071817682062;9552.57013434397;9605.903940960641;9654.179394751385;9692.46691431978;9810;598.7395482964924;606.5208485296566;635.731685580179;639.7536948274854;646.4602057282128;4499.662525310549;4793.784279707422;4815.711057336571;4856.247281671346;4857.587105096036;74829.5034099315;81655;93979.59030614409;103495;108139.37790933142;71593;82695.58652206701;95625.78432401872;98691;99951;67243.99134012994;83647;84564.99999999876;84788.57605711932;84870.5756471226;8080.216716115631;9230.400023998418;9324;9325.860112098188;9633.807323853624;49351.753241233564;49739.00521989612;50429.49570504248;52627.21059184192;54386;70640.64679676775;76716.61641691979;77338.44364928317;77957.220427795;79171.0621703363;14064.87809245292;14122;14194.574162775134;14334.426622934965;14432.42270309176;14651;14917.552473425814;14926.925365373538;15019.624509387353;15550.300236489611;13787.586372408843;13939.790903136258;13972.720545588829;14119.152850828983;14419.639509012359;13018.153820002048;13310.933445332712;13903.165810051429;14121.223332716389;14241.64395890111;13185.670358241121;13663.521776737767;13747.931260343634;13782.586522404345;13810.65473363174;10859.2398532102;11082.445877706245;11168.329900206014;11224.94387528057;11571.074314054687;10223.284370094021;10291.588336466757;11145.2198346115;11483.942580287045;11523.942380288045 08:29:38 INFO - PROCESS | 6468 | __end_tp_report 08:29:38 INFO - PROCESS | 6468 | __start_cc_report 08:29:38 INFO - PROCESS | 6468 | _x_x_mozilla_cycle_collect,391 08:29:38 INFO - PROCESS | 6468 | __end_cc_report 08:29:38 INFO - PROCESS | 6468 | __startTimestamp1488558578346__endTimestamp 08:29:38 INFO - PROCESS | 6468 | 08:29:38 INFO - PROCESS | 6468 | ------- Summary: start ------- 08:29:38 INFO - PROCESS | 6468 | Number of tests: 6 08:29:38 INFO - PROCESS | 6468 | 08:29:38 INFO - PROCESS | 6468 | [#0] dojo.html Cycles:165 Average:5681.68 Median:5928.00 stddev:684.54 (11.5%) stddev-sans-first:638.21 08:29:38 INFO - PROCESS | 6468 | Values: 2457.7 3279.5 3290.4 3316.1 3330.6 4370.4 5455.3 5569.3 5572.5 5624.3 5611.8 5628.4 5637.0 5665.7 5681.9 5128.8 5193.6 5197.6 5213.5 5227.1 5190.4 5230.7 5231.4 5244.9 5283.8 5057.5 5061.5 5210.7 5217.9 5218.4 5131.8 5162.5 5187.3 5216.2 5285.6 5142.5 5175.4 5179.0 5184.8 5191.5 5424.9 5543.8 5590.9 5745.8 5747.8 6080.3 6102.5 6121.8 6128.3 6205.5 6233.0 6237.7 6271.0 6302.8 6305.1 5753.9 5767.7 5772.8 5788.5 5817.0 6153.3 6181.1 6185.6 6221.2 6243.0 6087.3 6136.4 6154.1 6165.5 6168.3 6219.1 6232.6 6279.3 6296.5 6304.4 6017.8 6097.5 6120.4 6126.1 6241.0 6174.0 6232.8 6256.9 6266.7 6278.0 4216.8 4981.2 4982.1 4983.0 5010.5 4278.1 4303.8 4373.7 4424.4 4442.4 4784.0 5601.8 5649.5 5678.9 5715.1 6229.6 6237.1 6251.2 6255.0 6283.8 5593.5 5622.4 5646.0 5659.9 5761.5 5401.4 5403.2 5412.5 5416.1 5441.7 6266.1 6271.9 6287.0 6287.6 6294.2 6099.4 6119.4 6132.0 6138.3 6249.3 6198.1 6222.8 6262.2 6263.4 6267.3 6075.4 6146.7 6150.1 6155.8 6166.2 6135.0 6135.0 6171.2 6233.2 6266.7 6000.4 6113.3 6114.2 6121.1 6139.6 5920.6 5976.6 6044.2 6088.8 6092.9 4553.0 5601.1 5833.8 5887.8 5967.0 6005.6 6024.3 6054.5 6121.5 6132.5 5897.9 5916.9 5928.0 5928.9 5943.7 08:29:38 INFO - PROCESS | 6468 | 08:29:38 INFO - PROCESS | 6468 | [#1] ext.html Cycles:180 Average:66555.35 Median:34411.24 stddev:149185.74 (433.5%) stddev-sans-first:149521.68 08:29:38 INFO - PROCESS | 6468 | Values: 449.8 471.4 490.9 499.8 536.0 30737.7 40677.0 40791.6 40799.6 40912.0 36417.3 38478.6 38968.4 42241.0 42524.6 7948.0 8352.2 8567.1 9325.7 9372.0 11027.4 11306.0 11337.7 11456.7 11457.9 9867.2 11408.9 11446.2 11489.7 11495.7 9610.4 11346.9 11414.7 11420.4 11422.8 11288.8 11377.1 11380.7 11393.8 11396.0 40819.2 41107.8 41173.6 41344.6 41382.4 3772.9 3884.9 3941.9 3949.5 3951.5 25000.9 29422.0 29647.4 30973.8 31474.2 3044.4 3171.2 3174.6 3180.9 3244.6 369155.0 480032.0 483097.6 484083.0 486339.0 63615.7 64051.7 64167.0 64201.7 64245.7 55679.7 65620.4 65630.0 66304.0 66451.3 16162.1 16679.5 16741.0 16746.7 16753.6 11442.9 11814.2 12678.4 12952.2 12992.3 16832.2 17048.7 17080.4 17133.7 17164.1 6151.5 6246.9 7396.4 7448.9 7464.3 872.4 875.2 875.2 892.9 910.7 30298.9 30383.4 30405.2 30475.8 30671.2 1000.2 1045.1 1060.2 1107.5 1204.0 11680.0 15672.4 15854.4 15915.0 15935.9 549025.0 682477.0 701180.0 705407.0 900008.0 51485.7 52103.7 52146.2 52293.7 52437.2 1282.4 1362.4 1426.1 1436.9 1438.3 27371.7 27697.0 27783.3 28209.0 28365.1 32247.8 34864.3 44752.1 44801.0 44919.3 382689.1 458955.0 462201.0 462534.0 463470.0 21689.9 22207.2 23669.3 24122.0 24296.6 41726.8 41965.8 42017.0 42304.6 42672.8 34411.5 34596.0 34975.5 35508.6 35616.8 34012.5 34383.1 34976.0 35410.5 35466.0 33074.0 33620.3 34237.8 34411.0 34517.1 24980.1 28418.7 31067.6 31158.4 31241.3 20923.7 23377.5 23471.4 23808.4 23950.8 08:29:38 INFO - PROCESS | 6468 | 08:29:38 INFO - PROCESS | 6468 | [#2] jquery.html Cycles:180 Average:36370.75 Median:21717.40 stddev:106393.80 (489.9%) stddev-sans-first:106657.88 08:29:38 INFO - PROCESS | 6468 | Values: 350.6 391.2 393.4 402.4 425.2 20231.7 21707.3 21722.1 21738.9 21975.0 21368.4 21475.1 22046.4 22049.1 22269.3 4901.3 5392.9 5760.7 5768.0 5771.8 5471.6 5658.3 5690.3 5709.5 5759.0 5687.3 5695.6 5701.4 5708.5 5710.3 5415.4 5614.6 5692.2 5696.9 5702.4 5036.3 5052.2 5055.4 5059.8 5067.7 21327.6 25482.6 26166.0 26641.7 26925.3 2643.4 2689.9 2695.5 2731.5 2733.1 15621.6 15830.1 15933.7 15991.4 16336.8 1805.2 1832.3 1845.9 1861.3 1866.7 124509.0 126333.0 128170.4 130143.3 130791.0 11501.9 11733.5 11742.9 11861.7 11886.9 14506.9 14533.1 14549.8 14573.1 14578.2 8518.4 8720.3 8882.2 9011.4 9053.0 7376.4 7544.9 8765.4 8867.0 8879.8 7184.9 7277.7 7307.2 7318.3 7343.2 1938.7 1980.7 1981.6 1985.4 1986.1 987.8 1065.5 1081.6 1087.6 1102.9 16544.9 16887.7 17417.0 21712.7 22873.2 987.4 1078.5 1110.1 1114.9 1115.7 10835.1 11137.8 11183.0 11979.5 12019.0 352385.0 631414.0 662532.0 709744.0 751347.0 113717.2 122867.0 135508.3 137695.3 139525.3 1028.2 1029.7 1047.1 1049.4 1051.8 17051.3 19580.4 19701.3 19749.2 19809.6 43990.6 52595.0 54848.0 55498.7 55880.0 76788.6 79402.8 80949.0 82266.5 82940.0 7959.7 8083.9 8257.9 8429.5 8599.8 12462.8 12749.2 12947.7 13048.8 13361.3 9455.3 11111.8 11178.3 11316.4 11456.3 10898.9 11038.8 11167.7 11617.3 11769.5 11209.2 11220.0 11406.2 11493.9 11623.4 8029.8 8040.3 8203.3 8207.5 8277.2 10894.9 11242.4 11500.8 11615.9 11920.4 08:29:38 INFO - PROCESS | 6468 | 08:29:38 INFO - PROCESS | 6468 | [#3] mootools.html Cycles:180 Average:5357.82 Median:5615.42 stddev:2873.35 (51.2%) stddev-sans-first:2866.22 08:29:38 INFO - PROCESS | 6468 | Values: 1426.2 1433.8 1437.4 1445.6 1450.7 7407.7 7512.4 7771.9 8550.7 8577.1 7985.7 8220.3 8224.3 8340.1 8372.8 1915.5 1935.7 2050.4 2311.7 2320.9 2042.6 2130.7 2149.0 2270.5 2293.2 2198.5 2286.2 2292.0 2293.4 2309.6 1946.8 2296.0 2298.6 2316.3 2328.7 2281.2 2292.5 2327.5 2351.8 2363.2 8384.0 8453.0 8455.9 8463.4 8463.9 5050.2 5223.3 5225.7 5231.7 5250.3 3424.4 3431.8 3453.7 3494.8 3532.2 1119.3 1131.9 1181.2 1184.8 1223.1 7835.7 9407.7 9419.2 9510.3 9527.7 4342.8 4415.4 4491.0 4504.0 4739.6 7727.6 9225.6 9589.8 9595.2 9619.5 5208.1 5272.9 5301.2 5305.7 5321.4 4003.8 4659.3 4704.6 4811.8 4851.7 3861.0 3870.7 3937.8 3967.7 4012.2 1177.1 1219.3 1287.7 1301.0 1303.2 664.0 736.7 767.8 792.1 832.0 5561.6 5565.9 5566.0 5768.6 5890.6 872.6 986.6 998.8 1009.2 1034.9 3719.8 3796.3 3799.5 3907.9 3912.7 9354.3 9859.5 9862.6 9866.4 9870.3 9775.0 9802.4 9805.5 9810.4 9826.2 6362.2 7725.1 7756.7 7780.8 7834.5 4814.8 5664.9 5692.8 5706.8 5867.0 8945.3 9110.2 9249.9 9338.2 9355.4 9108.5 9213.0 9359.0 9479.6 9489.3 7084.9 7318.0 7321.2 7327.0 7328.6 7841.5 7841.9 7880.4 7906.1 7945.5 6301.8 7082.7 7134.5 7181.0 7279.8 7036.5 7045.3 7113.0 7143.7 7193.4 6389.1 6431.6 6440.0 6474.2 6478.3 4842.5 4862.1 4888.9 4998.2 5107.7 4883.0 4905.4 4921.9 5052.8 5087.6 08:29:38 INFO - PROCESS | 6468 | 08:29:38 INFO - PROCESS | 6468 | [#4] prototype.html Cycles:180 Average:4534.44 Median:5092.46 stddev:1397.14 (27.4%) stddev-sans-first:1365.41 08:29:38 INFO - PROCESS | 6468 | Values: 356.1 357.9 363.9 367.4 373.1 5150.4 5306.5 5414.6 5423.9 5571.5 5142.7 5247.3 5309.9 5321.1 5403.6 4194.3 4203.3 4230.8 4246.9 4250.9 3382.6 3724.3 4207.2 4264.3 4299.6 3482.3 4147.9 4150.8 4179.7 4193.6 4153.1 4155.4 4160.8 4205.6 4209.6 3139.6 3145.9 3471.8 3564.7 3582.3 4497.6 4975.8 5197.8 5231.8 5240.4 4321.9 4872.7 4894.2 4894.4 4896.4 5157.0 5160.8 5412.9 5749.5 5752.6 3412.8 3649.5 3880.0 3898.8 4151.3 5481.8 5509.5 5800.7 6047.4 6168.7 3772.0 3958.5 3961.9 3967.7 3968.7 3697.6 3758.5 3795.3 3985.7 4019.1 4106.4 4584.8 4610.3 4635.2 4696.5 5745.4 5806.9 5811.3 5819.5 5823.7 1075.9 1088.7 1166.4 1212.2 1238.4 773.9 848.8 878.2 878.5 879.6 4257.5 5056.3 5058.5 5070.4 5107.5 4888.8 5204.0 5386.6 5585.7 5610.9 4694.3 4708.1 4774.7 5088.6 5098.0 2518.6 2835.6 2865.8 2915.8 2968.5 5023.5 5301.4 5836.4 5852.6 5895.3 5045.6 5173.0 5390.6 5753.9 5771.0 5177.4 5255.5 5440.3 5769.8 5959.2 4558.8 5199.6 5232.6 5385.9 5524.8 4495.5 5294.8 5347.9 5800.8 5962.5 5536.8 6238.6 6268.6 6285.2 6298.7 3354.9 3412.3 3955.8 3956.3 3991.6 5276.2 5508.6 5788.2 5833.7 5873.8 5424.6 5551.7 5616.4 5715.4 5734.2 4916.5 5271.0 5697.2 5718.9 5732.0 4654.8 4949.5 5302.0 5367.8 5590.4 4965.3 5673.5 5699.7 5712.8 5716.6 4355.5 5033.5 5096.3 5530.3 5572.4 08:29:38 INFO - PROCESS | 6468 | 08:29:38 INFO - PROCESS | 6468 | [#5] yui.html Cycles:180 Average:20717.32 Median:4301.13 stddev:29910.36 (695.4%) stddev-sans-first:29956.46 08:29:38 INFO - PROCESS | 6468 | Values: 689.3 697.2 717.8 765.7 820.5 14678.7 15269.7 15274.4 15279.8 15290.5 13960.9 14070.3 14102.7 14132.4 14140.6 658.9 687.9 810.7 833.3 845.5 657.7 856.8 860.6 861.3 861.9 890.2 903.4 904.2 904.5 907.8 897.1 901.6 902.2 904.3 904.3 659.2 669.1 670.1 671.8 675.8 15183.7 15200.5 15215.5 15226.1 15334.8 14154.0 14508.6 14521.6 14524.8 14618.7 11333.7 11703.2 11739.2 11741.7 11850.5 3570.2 3617.7 3648.6 3688.0 3806.7 108480.9 108998.5 112511.0 113401.0 114008.0 10381.8 10441.3 10535.4 10576.0 10605.0 19582.7 19687.9 21135.2 21174.6 21300.3 7382.2 7439.7 7457.2 7526.1 7592.7 4104.7 4199.6 4202.9 4295.4 4306.9 3417.5 3420.9 3449.8 3486.2 3494.4 623.9 635.9 636.9 650.4 656.6 601.9 614.7 634.6 637.8 650.7 9552.6 9605.9 9654.2 9692.5 9810.0 598.7 606.5 635.7 639.8 646.5 4499.7 4793.8 4815.7 4856.2 4857.6 74829.5 81655.0 93979.6 103495.0 108139.4 71593.0 82695.6 95625.8 98691.0 99951.0 67244.0 83647.0 84565.0 84788.6 84870.6 8080.2 9230.4 9324.0 9325.9 9633.8 49351.8 49739.0 50429.5 52627.2 54386.0 70640.6 76716.6 77338.4 77957.2 79171.1 14064.9 14122.0 14194.6 14334.4 14432.4 14651.0 14917.6 14926.9 15019.6 15550.3 13787.6 13939.8 13972.7 14119.2 14419.6 13018.2 13310.9 13903.2 14121.2 14241.6 13185.7 13663.5 13747.9 13782.6 13810.7 10859.2 11082.4 11168.3 11224.9 11571.1 10223.3 10291.6 11145.2 11483.9 11523.9 08:29:38 INFO - PROCESS | 6468 | -------- Summary: end -------- 08:29:38 INFO - PROCESS | 6468 | 08:29:39 INFO - TEST-INFO | 6468: exit 0 08:29:39 INFO - TEST-OK | dromaeo_css | took 1115121ms 08:29:39 INFO - TEST-START | kraken 08:29:39 INFO - operating with platform_type : mac_ 08:29:39 INFO - Initialising browser for kraken test... 08:29:39 INFO - TEST-INFO | started process 6472 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/tmpr91bor/profile http://localhost:56858/getInfo.html) 08:29:41 INFO - PROCESS | 6472 | 2017-03-03 08:29:41.930 plugin-container[6473:123000] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4447, name = 'com.apple.tsm.portname' 08:29:41 INFO - PROCESS | 6472 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:29:41 INFO - PROCESS | 6472 | 2017-03-03 08:29:41.933 plugin-container[6473:123000] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 08:29:41 INFO - PROCESS | 6472 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:29:41 INFO - PROCESS | 6472 | 2017-03-03 08:29:41.933 plugin-container[6473:123000] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:29:41 INFO - PROCESS | 6472 | __metrics Screen width/height:1600/1200 08:29:41 INFO - PROCESS | 6472 | colorDepth:24 08:29:41 INFO - PROCESS | 6472 | Browser inner width/height: 1024/689 08:29:41 INFO - PROCESS | 6472 | __metrics 08:29:42 ERROR - PROCESS | 6472 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 08:29:42 INFO - TEST-INFO | 6472: exit 0 08:29:42 INFO - Browser initialized. 08:29:42 INFO - Running cycle 1/1 for kraken test... 08:29:42 INFO - TEST-INFO | started process 6474 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/tmpr91bor/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:29:45 INFO - PROCESS | 6474 | 2017-03-03 08:29:45.476 plugin-container[6475:123131] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8837, name = 'com.apple.tsm.portname' 08:29:45 INFO - PROCESS | 6474 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:29:45 INFO - PROCESS | 6474 | 2017-03-03 08:29:45.476 plugin-container[6475:123131] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0b, name = 'com.apple.CFPasteboardClient' 08:29:45 INFO - PROCESS | 6474 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:29:45 INFO - PROCESS | 6474 | 2017-03-03 08:29:45.477 plugin-container[6475:123131] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:29:55 INFO - PROCESS | 6474 | RSS: Main: 219062272 08:29:55 INFO - PROCESS | 6474 | 08:29:57 INFO - PROCESS | 6474 | Cycle 1(1): loaded http://localhost:56858/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56858/tests/kraken/driver.html?testName=audio-beat-detection) 08:29:58 INFO - PROCESS | 6474 | RSS: Main: 233402368 08:29:58 INFO - PROCESS | 6474 | 08:30:01 INFO - PROCESS | 6474 | Cycle 1(1): loaded http://localhost:56858/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56858/tests/kraken/driver.html?testName=audio-dft) 08:30:01 INFO - PROCESS | 6474 | RSS: Main: 241061888 08:30:01 INFO - PROCESS | 6474 | 08:30:05 INFO - PROCESS | 6474 | Cycle 1(1): loaded http://localhost:56858/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56858/tests/kraken/driver.html?testName=audio-fft) 08:30:05 INFO - PROCESS | 6474 | RSS: Main: 244760576 08:30:05 INFO - PROCESS | 6474 | 08:30:07 INFO - PROCESS | 6474 | Cycle 1(1): loaded http://localhost:56858/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56858/tests/kraken/driver.html?testName=audio-oscillator) 08:30:08 INFO - PROCESS | 6474 | RSS: Main: 246153216 08:30:08 INFO - PROCESS | 6474 | 08:30:10 INFO - PROCESS | 6474 | Cycle 1(1): loaded http://localhost:56858/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56858/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:30:11 INFO - PROCESS | 6474 | RSS: Main: 246534144 08:30:11 INFO - PROCESS | 6474 | 08:30:14 INFO - PROCESS | 6474 | Cycle 1(1): loaded http://localhost:56858/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56858/tests/kraken/driver.html?testName=imaging-darkroom) 08:30:14 INFO - PROCESS | 6474 | RSS: Main: 250621952 08:30:14 INFO - PROCESS | 6474 | 08:30:17 INFO - PROCESS | 6474 | Cycle 1(1): loaded http://localhost:56858/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56858/tests/kraken/driver.html?testName=imaging-desaturate) 08:30:18 INFO - PROCESS | 6474 | RSS: Main: 249741312 08:30:18 INFO - PROCESS | 6474 | 08:30:21 INFO - PROCESS | 6474 | Cycle 1(1): loaded http://localhost:56858/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56858/tests/kraken/driver.html?testName=json-parse-financial) 08:30:22 INFO - PROCESS | 6474 | RSS: Main: 249798656 08:30:22 INFO - PROCESS | 6474 | 08:30:23 INFO - PROCESS | 6474 | Cycle 1(1): loaded http://localhost:56858/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56858/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:30:24 INFO - PROCESS | 6474 | RSS: Main: 249151488 08:30:24 INFO - PROCESS | 6474 | 08:30:26 INFO - PROCESS | 6474 | Cycle 1(1): loaded http://localhost:56858/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56858/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:30:27 INFO - PROCESS | 6474 | RSS: Main: 249237504 08:30:27 INFO - PROCESS | 6474 | 08:30:29 INFO - PROCESS | 6474 | Cycle 1(1): loaded http://localhost:56858/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56858/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:30:29 INFO - PROCESS | 6474 | RSS: Main: 249184256 08:30:29 INFO - PROCESS | 6474 | 08:30:32 INFO - PROCESS | 6474 | Cycle 1(1): loaded http://localhost:56858/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56858/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:30:33 INFO - PROCESS | 6474 | RSS: Main: 249565184 08:30:33 INFO - PROCESS | 6474 | 08:30:36 INFO - PROCESS | 6474 | Cycle 1(1): loaded http://localhost:56858/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56858/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:30:37 INFO - PROCESS | 6474 | RSS: Main: 249643008 08:30:37 INFO - PROCESS | 6474 | 08:30:38 INFO - PROCESS | 6474 | Cycle 1(1): loaded http://localhost:56858/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56858/tests/kraken/driver.html?testName=ai-astar) 08:30:39 INFO - PROCESS | 6474 | RSS: Main: 251604992 08:30:39 INFO - PROCESS | 6474 | 08:30:39 INFO - PROCESS | 6474 | __start_tp_report 08:30:39 INFO - PROCESS | 6474 | _x_x_mozilla_page_load 08:30:39 INFO - PROCESS | 6474 | _x_x_mozilla_page_load_details 08:30:39 INFO - PROCESS | 6474 | |i|pagename|runs| 08:30:39 INFO - PROCESS | 6474 | |0;ai-astar;115;121;118;118;119;117;114;117;129;176 08:30:39 INFO - PROCESS | 6474 | |1;audio-beat-detection;137;113;115;147;112;113;113;115;131;111 08:30:39 INFO - PROCESS | 6474 | |2;audio-dft;194;203;200;187;200;197;198;201;201;198 08:30:39 INFO - PROCESS | 6474 | |3;audio-fft;84;60;60;96;86;77;61;60;74;68 08:30:39 INFO - PROCESS | 6474 | |4;audio-oscillator;89;71;85;73;76;96;75;74;59;93 08:30:39 INFO - PROCESS | 6474 | |5;imaging-gaussian-blur;94;115;88;106;80;133;136;101;88;85 08:30:39 INFO - PROCESS | 6474 | |6;imaging-darkroom;112;156;108;155;155;96;95;96;97;95 08:30:39 INFO - PROCESS | 6474 | |7;imaging-desaturate;92;94;95;106;95;126;151;131;95;98 08:30:39 INFO - PROCESS | 6474 | |8;json-parse-financial;60;59;60;64;64;63;63;63;64;61 08:30:39 INFO - PROCESS | 6474 | |9;json-stringify-tinderbox;89;72;72;81;81;73;70;72;75;71 08:30:39 INFO - PROCESS | 6474 | |10;stanford-crypto-aes;84;87;87;89;91;80;90;86;85;83 08:30:39 INFO - PROCESS | 6474 | |11;stanford-crypto-ccm;163;147;154;158;147;138;174;155;188;163 08:30:39 INFO - PROCESS | 6474 | |12;stanford-crypto-pbkdf2;172;174;169;172;172;170;176;175;171;167 08:30:39 INFO - PROCESS | 6474 | |13;stanford-crypto-sha256-iterative;69;71;68;67;69;79;85;88;91;71 08:30:39 INFO - PROCESS | 6474 | __end_tp_report 08:30:39 INFO - PROCESS | 6474 | __start_cc_report 08:30:39 INFO - PROCESS | 6474 | _x_x_mozilla_cycle_collect,976 08:30:39 INFO - PROCESS | 6474 | __end_cc_report 08:30:39 INFO - PROCESS | 6474 | __startTimestamp1488558639164__endTimestamp 08:30:39 INFO - PROCESS | 6474 | 08:30:39 INFO - PROCESS | 6474 | ------- Summary: start ------- 08:30:39 INFO - PROCESS | 6474 | Number of tests: 14 08:30:39 INFO - PROCESS | 6474 | 08:30:39 INFO - PROCESS | 6474 | [#0] ai-astar Cycles:10 Average:124.40 Median:118.50 stddev:18.60 (15.7%) stddev-sans-first:19.41 08:30:39 INFO - PROCESS | 6474 | Values: 115.0 121.0 118.0 118.0 119.0 117.0 114.0 117.0 129.0 176.0 08:30:39 INFO - PROCESS | 6474 | 08:30:39 INFO - PROCESS | 6474 | [#1] audio-beat-detection Cycles:10 Average:120.70 Median:115.00 stddev:12.81 (11.1%) stddev-sans-first:12.15 08:30:39 INFO - PROCESS | 6474 | Values: 137.0 113.0 115.0 147.0 112.0 113.0 113.0 115.0 131.0 111.0 08:30:39 INFO - PROCESS | 6474 | 08:30:39 INFO - PROCESS | 6474 | [#2] audio-dft Cycles:10 Average:197.90 Median:200.00 stddev:4.58 (2.3%) stddev-sans-first:4.64 08:30:39 INFO - PROCESS | 6474 | Values: 194.0 203.0 200.0 187.0 200.0 197.0 198.0 201.0 201.0 198.0 08:30:39 INFO - PROCESS | 6474 | 08:30:39 INFO - PROCESS | 6474 | [#3] audio-fft Cycles:10 Average:72.60 Median:75.50 stddev:12.95 (17.2%) stddev-sans-first:13.07 08:30:39 INFO - PROCESS | 6474 | Values: 84.0 60.0 60.0 96.0 86.0 77.0 61.0 60.0 74.0 68.0 08:30:39 INFO - PROCESS | 6474 | 08:30:39 INFO - PROCESS | 6474 | [#4] audio-oscillator Cycles:10 Average:79.10 Median:80.50 stddev:11.41 (14.2%) stddev-sans-first:11.52 08:30:39 INFO - PROCESS | 6474 | Values: 89.0 71.0 85.0 73.0 76.0 96.0 75.0 74.0 59.0 93.0 08:30:39 INFO - PROCESS | 6474 | 08:30:39 INFO - PROCESS | 6474 | [#5] imaging-gaussian-blur Cycles:10 Average:102.60 Median:82.50 stddev:19.80 (24.0%) stddev-sans-first:20.76 08:30:39 INFO - PROCESS | 6474 | Values: 94.0 115.0 88.0 106.0 80.0 133.0 136.0 101.0 88.0 85.0 08:30:39 INFO - PROCESS | 6474 | 08:30:39 INFO - PROCESS | 6474 | [#6] imaging-darkroom Cycles:10 Average:116.50 Median:95.00 stddev:27.41 (28.9%) stddev-sans-first:29.03 08:30:39 INFO - PROCESS | 6474 | Values: 112.0 156.0 108.0 155.0 155.0 96.0 95.0 96.0 97.0 95.0 08:30:39 INFO - PROCESS | 6474 | 08:30:39 INFO - PROCESS | 6474 | [#7] imaging-desaturate Cycles:10 Average:108.30 Median:94.50 stddev:20.45 (21.6%) stddev-sans-first:20.82 08:30:39 INFO - PROCESS | 6474 | Values: 92.0 94.0 95.0 106.0 95.0 126.0 151.0 131.0 95.0 98.0 08:30:39 INFO - PROCESS | 6474 | 08:30:39 INFO - PROCESS | 6474 | [#8] json-parse-financial Cycles:10 Average:62.10 Median:63.00 stddev:1.91 (3.0%) stddev-sans-first:1.87 08:30:39 INFO - PROCESS | 6474 | Values: 60.0 59.0 60.0 64.0 64.0 63.0 63.0 63.0 64.0 61.0 08:30:39 INFO - PROCESS | 6474 | 08:30:39 INFO - PROCESS | 6474 | [#9] json-stringify-tinderbox Cycles:10 Average:75.60 Median:74.00 stddev:6.11 (8.3%) stddev-sans-first:4.14 08:30:39 INFO - PROCESS | 6474 | Values: 89.0 72.0 72.0 81.0 81.0 73.0 70.0 72.0 75.0 71.0 08:30:39 INFO - PROCESS | 6474 | 08:30:39 INFO - PROCESS | 6474 | [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:87.00 stddev:3.36 (3.9%) stddev-sans-first:3.47 08:30:39 INFO - PROCESS | 6474 | Values: 84.0 87.0 87.0 89.0 91.0 80.0 90.0 86.0 85.0 83.0 08:30:39 INFO - PROCESS | 6474 | 08:30:39 INFO - PROCESS | 6474 | [#11] stanford-crypto-ccm Cycles:10 Average:158.70 Median:160.50 stddev:14.41 (9.0%) stddev-sans-first:15.20 08:30:39 INFO - PROCESS | 6474 | Values: 163.0 147.0 154.0 158.0 147.0 138.0 174.0 155.0 188.0 163.0 08:30:39 INFO - PROCESS | 6474 | 08:30:39 INFO - PROCESS | 6474 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.80 Median:172.00 stddev:2.74 (1.6%) stddev-sans-first:2.91 08:30:39 INFO - PROCESS | 6474 | Values: 172.0 174.0 169.0 172.0 172.0 170.0 176.0 175.0 171.0 167.0 08:30:39 INFO - PROCESS | 6474 | 08:30:39 INFO - PROCESS | 6474 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.80 Median:75.00 stddev:9.14 (12.2%) stddev-sans-first:9.36 08:30:39 INFO - PROCESS | 6474 | Values: 69.0 71.0 68.0 67.0 69.0 79.0 85.0 88.0 91.0 71.0 08:30:39 INFO - PROCESS | 6474 | -------- Summary: end -------- 08:30:39 INFO - PROCESS | 6474 | 08:30:40 INFO - TEST-INFO | 6474: exit 0 08:30:40 INFO - TEST-OK | kraken | took 61122ms 08:30:40 INFO - SUITE-END | took 1176s 08:30:40 INFO - Completed test suite (00:19:36) 08:30:40 INFO - javascript benchmark 08:30:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7251.612942692482, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2457.6682147910033, 3279.5244689520005, 3290.42417576924, 3316.121227874612, 3330.55037569928, 4370.38814565961, 5455.345358556969, 5569.3316801983765, 5572.470615291546, 5624.268845050148, 5611.7755289788465, 5628.380878103405, 5636.971815140919, 5665.688387138705, 5681.914771278434, 5128.769205385757, 5193.610479214055, 5197.584193264549, 5213.530782229599, 5227.08526007949, 5190.429052804188, 5230.738463076831, 5231.398389185235, 5244.868878278055, 5283.8150664726745, 5057.519535644108, 5061.519155680205, 5210.739463026853, 5217.947820521803, 5218.373795144588, 5131.846044618667, 5162.509561591662, 5187.273781670569, 5216.243644671539, 5285.6300058995885, 5142.460041695643, 5175.353080864892, 5179.0, 5184.766685499161, 5191.506806853381, 5424.918626220609, 5543.77824887004, 5590.944090559083, 5745.798897038583, 5747.770089196427, 6080.30076541199, 6102.542309326818, 6121.846953826145, 6128.3258841527395, 6205.5345849061505, 6233.0, 6237.656928868911, 6270.968645156745, 6302.779402720883, 6305.085762564402, 5753.913691294634, 5767.740451679684, 5772.797952071657, 5788.479036886658, 5816.97091514544, 6153.323134455206, 6181.072839074175, 6185.567010309325, 6221.160143380676, 6242.968785156136, 6087.3303936566945, 6136.355682653347, 6154.0911171705475, 6165.475934545524, 6168.290646575701, 6219.129321894939, 6232.594881332699, 6279.309275979638, 6296.496280297565, 6304.401081897213, 6017.789377371859, 6097.512199024068, 6120.44915957566, 6126.111713801563, 6241.0, 6173.950428427178, 6232.844178895564, 6256.906146407808, 6266.717997690115, 6277.96861015692, 4216.789160541961, 4981.227909674007, 4982.103221420107, 4983.001166488894, 5010.473900240495, 4278.122984788111, 4303.806328715215, 4373.693841431069, 4424.358468022118, 4442.378067070613, 4783.95216047842, 5601.7759289628775, 5649.491545760901, 5678.914816277759, 5715.057015592381, 6229.56393052482, 6237.064440333987, 6251.249850018027, 6255.0, 6283.7800676976085, 5593.468620481048, 5622.437756224344, 5645.971770141123, 5659.915101273484, 5761.53907687384, 5401.405845357008, 5403.216533602685, 5412.458754124556, 5416.0792665247, 5441.673499590037, 6266.122742816009, 6271.905921411274, 6286.968565157145, 6287.591306564967, 6294.213223347082, 6099.359567245553, 6119.350229749554, 6131.96934015327, 6138.265785110882, 6249.281332646804, 6198.132261483306, 6222.782202622887, 6262.185915830913, 6263.3736626337, 6267.341929097379, 6075.422834830684, 6146.661933593696, 6150.077488376779, 6155.815325540241, 6166.167567378347, 6135.0, 6135.018317212141, 6171.166892469639, 6233.158523599256, 6266.68666566679, 6000.369961154016, 6113.29387775398, 6114.206128133811, 6121.056693971993, 6139.553468857771, 5920.585559010828, 5976.641401515923, 6044.214252147192, 6088.786892458743, 6092.939070609237, 4553.0, 5601.103823388238, 5833.766649333979, 5887.793927212527, 5967.045272756338, 6005.579609427298, 6024.277086749618, 6054.515638748978, 6121.5139442231075, 6132.5400594956445, 5897.882042359214, 5916.940830591639, 5928.0, 5928.9110663339225, 5943.702814859326], "value": 5634.691108135436, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [449.77960799208375, 471.3636590602687, 490.8576512811285, 499.84754649831797, 536.0378121272316, 30737.69262307379, 40677.0, 40791.592084079115, 40799.59200408003, 40912.0, 36417.271654566895, 38478.61521384785, 38968.41547376791, 42241.0, 42524.57475425245, 7947.960260198705, 8352.206540378655, 8567.143285671445, 9325.673601423918, 9371.95314023429, 11027.44862756863, 11306.038986686142, 11337.659870203906, 11456.713582160472, 11457.885421145807, 9867.210623150131, 11408.942955285213, 11446.198766086378, 11489.712757181054, 11495.655130346104, 9610.375325603849, 11346.886531134665, 11414.657560273205, 11420.42897855104, 11422.771544569145, 11288.774224515546, 11377.146713996483, 11380.71548211293, 11393.829092563617, 11396.0, 40819.18361632751, 41107.7944610275, 41173.58826411727, 41344.586554134374, 41382.37926431106, 3772.8679496217774, 3884.8834534964, 3941.9211615767813, 3949.545802232751, 3951.46655201547, 25000.874995624905, 29421.97023104181, 29647.407051859056, 30973.845130774203, 31474.213144671336, 3044.3911217756536, 3171.2389026633673, 3174.619045714529, 3180.888668896601, 3244.643089260203, 369155.0, 480032.0, 483097.5845120787, 484083.0, 486339.0, 63615.68192159102, 64051.679741600994, 64167.0, 64201.67899160474, 64245.678771605846, 55679.721601391735, 65620.37518499303, 65630.0, 66304.0, 66451.33548664452, 16162.111083890499, 16679.499615011326, 16741.0, 16746.665066698843, 16753.581160471087, 11442.94278528602, 11814.173007889538, 12678.366081695878, 12952.222866628032, 12992.285424301754, 16832.24254908532, 17048.744268835977, 17080.402185923434, 17133.65732685364, 17164.141792910305, 6151.477124444473, 6246.937530624636, 7396.408287337, 7448.888266676005, 7464.290892365217, 872.3588162700537, 875.1554749666602, 875.2166810704512, 892.9107089291019, 910.717677519971, 30298.939537116537, 30383.392332153235, 30405.239869003453, 30475.847620761753, 30671.220018772397, 1000.1598657128047, 1045.1429827541494, 1060.151878497199, 1107.5182295701234, 1203.9879601203875, 11680.0, 15672.373105075898, 15854.365825367087, 15915.0, 15935.933743784875, 549025.0, 682477.0, 701180.0, 705407.0, 900008.0, 51485.7425712869, 52103.69740756436, 52146.21780673217, 52293.73853130786, 52437.213441798405, 1282.435728279554, 1362.3937347880296, 1426.0730525158522, 1436.8634979676915, 1438.2736717957364, 27371.726282737713, 27697.030603928764, 27783.30541736473, 28209.0, 28365.149045528666, 32247.838760806048, 34864.30271394608, 44752.10495790131, 44801.0, 44919.32621010753, 382689.08655456547, 458955.0, 462201.0, 462534.0, 463470.0, 21689.891550542146, 22207.222747204418, 23669.28992130239, 24122.0, 24296.635550466402, 41726.79136604298, 41965.790171048946, 42017.0, 42304.57695423006, 42672.78663606662, 34411.483827743104, 34596.0, 34975.475367868996, 35508.64491355053, 35616.82191589129, 34012.48981265233, 34383.140421488664, 34976.0, 35410.46884296789, 35466.0, 33074.0, 33620.3275934475, 34237.82881085579, 34411.0, 34517.066049386085, 24980.050653991057, 28418.721157547545, 31067.555882440494, 31158.40893230966, 31241.255246851706, 20923.686144708146, 23377.532449351256, 23471.41321466977, 23808.40478988039, 23950.76049239555], "value": 19379.88576774283, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.6125731067171, 391.19999600816345, 393.373400986919, 402.43457941592067, 425.16030839092775, 20231.696524552142, 21707.348779536598, 21722.13111475541, 21738.91305434726, 21975.011124499397, 21368.358949231508, 21475.140994360245, 22046.448838779037, 22049.11803527857, 22269.331920042383, 4901.289313049606, 5392.865178370543, 5760.74076666551, 5767.971160144193, 5771.797987070453, 5471.616986810925, 5658.321001479828, 5690.317161940552, 5709.543236541088, 5759.049756790125, 5687.317521897378, 5695.572832037614, 5701.401352857953, 5708.514776244025, 5710.343310519281, 5415.377231618355, 5614.63504872182, 5692.203091567184, 5696.917585658753, 5702.4012478689765, 5036.294918711384, 5052.191649336125, 5055.443901170868, 5059.822906198302, 5067.670601410933, 21327.573448531097, 25482.617760733603, 26166.0, 26641.733582664117, 26925.326866828487, 2643.365592257844, 2689.880521812872, 2695.528282550546, 2731.508328500869, 2733.098077634376, 15621.609459763484, 15830.129342886137, 15933.681326373408, 15991.440299589458, 16336.75494867566, 1805.2147315917618, 1832.2945665918717, 1845.8707890447674, 1861.3206179744432, 1866.701327787561, 124509.0, 126333.0, 128170.35914820459, 130143.34928325392, 130791.0, 11501.942490287494, 11733.4719937603, 11742.88257117435, 11861.703457413461, 11886.940565297118, 14506.854931450762, 14533.128012319296, 14549.78175327371, 14573.052751571115, 14578.198199098939, 8518.372574130579, 8720.30237580992, 8882.15619516145, 9011.414258073204, 9052.954735226282, 7376.409887209011, 7544.86826975958, 8765.430247033923, 8867.024627291123, 8879.845620069349, 7184.928150718426, 7277.672504737194, 7307.19620841707, 7318.3047610476915, 7343.228960959129, 1938.709193620968, 1980.6632872411724, 1981.564055907698, 1985.4043786863883, 1986.0963261715885, 987.7728122531714, 1065.4672663668166, 1081.551156270139, 1087.608460954056, 1102.944852757375, 16544.917275413787, 16887.746683799753, 17416.954982701078, 21712.674309885366, 22873.19943801959, 987.3532835992437, 1078.5362294213564, 1110.1451882050776, 1114.9498272577753, 1115.6876074699098, 10835.133189344991, 11137.832932505857, 11183.04944079746, 11979.46092425843, 12019.038476921825, 352385.0, 631414.0, 662532.0, 709744.0, 751347.0, 113717.15707107389, 122867.0, 135508.3224583871, 137695.31152344175, 139525.30237348747, 1028.1517747858047, 1029.6550655530482, 1047.120418848156, 1049.37037777333, 1051.8001579699833, 17051.317947282467, 19580.412587622395, 19701.310454134036, 19749.210031598574, 19809.60380792405, 43990.580518070536, 52595.0, 54848.0, 55498.72250638721, 55880.0, 76788.61605691936, 79402.80895786683, 80949.0, 82266.53200403997, 82940.0, 7959.721409750631, 8083.878741818759, 8257.876131858147, 8429.536375499407, 8599.828003440021, 12462.750744985231, 12749.235045897276, 12947.676308092374, 13048.804267935799, 13361.331933403097, 9455.338126331091, 11111.83332250033, 11178.27341222818, 11316.37759923212, 11456.312621242752, 10898.891011090105, 11038.779224415628, 11167.664970050912, 11617.302961822317, 11769.470373833026, 11209.159313051718, 11220.0, 11406.201565890307, 11493.942530287295, 11623.360715160747, 8029.835673827379, 8040.316573091352, 8203.26170644621, 8207.466514676527, 8277.213664701843, 10894.945525272324, 11242.381669008282, 11500.769984600429, 11615.941920290345, 11920.403979801149], "value": 10009.795139248092, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1426.1870733681806, 1433.7562614355559, 1437.4250299880052, 1445.6169115184475, 1450.673598440351, 7407.740729074483, 7512.399008079355, 7771.92228077719, 8550.657973681053, 8577.099404562525, 7985.680572777096, 8220.260176584121, 8224.342052635775, 8340.124286949858, 8372.83254334913, 1915.501969487936, 1935.7193206984978, 2050.364387040015, 2311.7225932888077, 2320.872352020638, 2042.5914817036653, 2130.7017017617545, 2148.957020859582, 2270.4550907782095, 2293.1629955066446, 2198.527316626925, 2286.1998300594823, 2292.0, 2293.3693234360603, 2309.642005489152, 1946.776120746104, 2296.0471404367167, 2298.5747636687183, 2316.30510846747, 2328.6856274402994, 2281.1673739085113, 2292.5098685854164, 2327.464683122891, 2351.8236132289976, 2363.196513185508, 8384.03583587889, 8453.0, 8455.915440845574, 8463.4075614707, 8463.873041904377, 5050.191969284933, 5223.268742376071, 5225.660332078441, 5231.738413079331, 5250.317458730379, 3424.366492198951, 3431.759776815624, 3453.689167974869, 3494.842732077037, 3532.2405682778326, 1119.3172164979355, 1131.9264247823864, 1181.2203945395997, 1184.8400465937075, 1223.076577184229, 7835.725749598737, 9407.717768466957, 9419.24646028316, 9510.334276600572, 9527.714168574954, 4342.782860856944, 4415.448068991376, 4491.0, 4503.954960450354, 4739.573438390561, 7727.613619319011, 9225.630974761069, 9589.808203835884, 9595.184409325286, 9619.51902404877, 5208.062548741263, 5272.894542109137, 5301.151815709468, 5305.681659100466, 5321.441248668912, 4003.8398464061693, 4659.324397962277, 4704.600108990774, 4811.78346974387, 4851.708897466164, 3861.0, 3870.651641352292, 3937.822797974098, 3967.682585393162, 4012.2376748417705, 1177.087756988341, 1219.2501611509035, 1287.67808047988, 1301.0177316126453, 1303.1789972317379, 663.9535232533773, 736.6997249854012, 767.823400617861, 792.0614072324314, 831.9875201871977, 5561.555075593943, 5565.9443405566235, 5565.972170139124, 5768.567357448208, 5890.646561206341, 872.581161042703, 986.5659109991581, 998.8401855703053, 1009.2329829329616, 1034.891336409666, 3719.75821571597, 3796.3166630006313, 3799.4870692456716, 3907.902302442405, 3912.7456715313415, 9354.298427617956, 9859.507024648883, 9862.605495780232, 9866.358686685342, 9870.30907836459, 9774.973627768983, 9802.36284641496, 9805.509724513746, 9810.362326448902, 9826.16477599412, 6362.236531616236, 7725.072991241087, 7756.6509507072315, 7780.766577002699, 7834.529928204326, 4814.807407703793, 5664.85837854057, 5692.7722891083895, 5706.771729130788, 5866.970665146647, 8945.329100317633, 9110.225630821455, 9249.907500925174, 9338.206252468617, 9355.391899526508, 9108.544572771203, 9212.986571476999, 9358.953205233931, 9479.573419196291, 9489.335746497678, 7084.893726594209, 7317.963410182915, 7321.231270716711, 7326.96336518314, 7328.633568321669, 7841.490303130278, 7841.941337919536, 7880.448368614142, 7906.090799557895, 7945.48354356965, 6301.842453938688, 7082.699643471499, 7134.536255143399, 7181.030560874216, 7279.8180045497165, 7036.542624729581, 7045.260247674126, 7113.004179414783, 7143.749968751069, 7193.352598266181, 6389.137466441971, 6431.5819471734185, 6439.967800160969, 6474.1583594134345, 6478.319776423407, 4842.491538388418, 4862.07620552094, 4888.853334399973, 4998.2002879539095, 5107.668001579886, 4883.0, 4905.3623029006, 4921.8523444296725, 5052.797888084436, 5087.643864929568], "value": 4357.082644001829, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.09196548800554, 357.91052236940766, 363.9490471334014, 367.358958617213, 373.0617496995058, 5150.4334523202415, 5306.548943339821, 5414.648047876885, 5423.918641220384, 5571.470710282527, 5142.66572672776, 5247.2653828464045, 5309.920351194735, 5321.111005593017, 5403.594730395226, 4194.3498757692605, 4203.327467605184, 4230.751928181194, 4246.851360202393, 4250.9149817003645, 3382.610999735025, 3724.3110024645393, 4207.158568286355, 4264.339027450735, 4299.613034826865, 3482.268723568041, 4147.854825081123, 4150.796269081962, 4179.707420480568, 4193.601607847265, 4153.089578793759, 4155.376693495985, 4160.750354978696, 4205.5794420558, 4209.621134097915, 3139.6232452105664, 3145.889893853704, 3471.75697701161, 3564.679178873888, 3582.283543291352, 4497.64018878489, 4975.780933671237, 5197.8440646780655, 5231.764570594332, 5240.423553409122, 4321.891952701176, 4872.65891387603, 4894.241392584155, 4894.4371397289415, 4896.387951506062, 5156.974215128937, 5160.819371321985, 5412.945870541323, 5749.453801888814, 5752.568557358215, 3412.812295323756, 3649.489071529988, 3880.049387899983, 3898.8245528951265, 4151.256472281649, 5481.75332110052, 5509.5041446270025, 5800.707476467426, 6047.395260473962, 6168.691565421711, 3772.0389494246883, 3958.5353419235066, 3961.920761584752, 3967.682585393219, 3968.6626636735623, 3697.5932647408763, 3758.4550240215017, 3795.3358162322033, 3985.6811455083525, 4019.070845993939, 4106.425100485934, 4584.7936842842155, 4610.2623580227, 4635.188841952645, 4696.483386827446, 5745.443277741449, 5806.941930580725, 5811.3316968548315, 5819.505342045889, 5823.650580965155, 1075.930064545802, 1088.6625146204701, 1166.3993043582561, 1212.2302338015247, 1238.4365113873166, 773.880048592469, 848.7989494864821, 878.1569693094573, 878.4509681449094, 879.6497376527001, 4257.531671516131, 5056.292119103328, 5058.519440653132, 5070.442251352349, 5107.548376779093, 4888.755562221874, 5204.0449258563, 5386.622936394415, 5585.664860108406, 5610.887782244332, 4694.319323698045, 4708.128041894442, 4774.689645173122, 5088.618353623493, 5098.0, 2518.597024476075, 2835.560488124344, 2865.7933391288593, 2915.781316401278, 2968.5101958177092, 5023.472535383805, 5301.416844147141, 5836.358000619928, 5852.648841069549, 5895.263092113486, 5045.646804723708, 5173.042987047408, 5390.622656414013, 5753.913691294634, 5770.971145144332, 5177.352830896138, 5255.527002569787, 5440.259117082495, 5769.7595017071535, 5959.16939453756, 4558.7948542316335, 5199.55803756685, 5232.555232805102, 5385.946140538701, 5524.751386187711, 4495.52796956328, 5294.761735721979, 5347.893042139058, 5800.8259752207505, 5962.509372656836, 5536.7785288588, 6238.594491358047, 6268.6179251884, 6285.240132762834, 6298.748050077946, 3354.8993530194134, 3412.334594753999, 3955.8022098894367, 3956.327424337927, 3991.600839915985, 5276.20856871457, 5508.586855985897, 5788.21859049023, 5833.67914764692, 5873.823785286449, 5424.5660347172925, 5551.694656793915, 5616.4383561645145, 5715.399883012224, 5734.197212390185, 4916.459189489082, 5270.973645131749, 5697.173909783141, 5718.942810571841, 5731.971340143273, 4654.811454153915, 4949.480304567968, 5301.973490132525, 5367.785288588413, 5590.357108932525, 4965.30485732005, 5673.461021202979, 5699.686517241592, 5712.82937969431, 5716.570457555606, 4355.49911760139, 5033.495021955403, 5096.30517874538, 5530.253415788978, 5572.35917869434], "value": 4094.3202643516083, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [689.2969171445123, 697.2051860878599, 717.7882524655226, 765.6975494679601, 820.4789958376431, 14678.706425871476, 15269.6946061079, 15274.38902443901, 15279.847201527982, 15290.46483373082, 13960.930195349008, 14070.296485175726, 14102.717945641081, 14132.434702611909, 14140.57578272651, 658.8814013477572, 687.9002544631026, 810.7324582887633, 833.3083540661252, 845.5222799118509, 657.6777379084239, 856.8029353248756, 860.6385318166385, 861.2937391339104, 861.9439736417144, 890.1943740914483, 903.3902116071658, 904.2178515584038, 904.5296445848155, 907.7503686486203, 897.1477096758106, 901.6393442622938, 902.2015516268117, 904.2946501728662, 904.3036861616552, 659.1990731261492, 669.1468377818272, 670.0619133213492, 671.768239957214, 675.7702381190419, 15183.696326073527, 15200.543983680507, 15215.543533694006, 15226.086434813946, 15334.769978450333, 14154.0, 14508.564743057725, 14521.564353069425, 14524.782128268085, 14618.70762584753, 11333.659990200307, 11703.23928944616, 11739.178257521977, 11741.706457338549, 11850.466728997217, 3570.1967057412135, 3617.7467577269604, 3648.616895226016, 3687.9815600922093, 3806.695464362872, 108480.91519084865, 108998.45500772525, 112511.0, 113401.0, 114008.0, 10381.84427233592, 10441.269111162146, 10535.367877927349, 10576.048155666027, 10605.0, 19582.727122736975, 19687.90156049239, 21135.154593816074, 21174.576508469745, 21300.25449109305, 7382.22486638906, 7439.702411903571, 7457.179710231871, 7526.134494533089, 7592.734254301184, 4104.692148088905, 4199.622034016953, 4202.936955945664, 4295.355696645528, 4306.913861722811, 3417.5386322846593, 3420.863165473353, 3449.758516903843, 3486.18074752433, 3494.371013217645, 623.8845813524513, 635.9109724638554, 636.9394907483781, 650.388634683396, 656.5502630697987, 601.9435890012999, 614.7141579165709, 634.552640388525, 637.8309747916805, 650.7071817682062, 9552.57013434397, 9605.903940960641, 9654.179394751385, 9692.46691431978, 9810.0, 598.7395482964924, 606.5208485296566, 635.731685580179, 639.7536948274854, 646.4602057282128, 4499.662525310549, 4793.784279707422, 4815.711057336571, 4856.247281671346, 4857.587105096036, 74829.5034099315, 81655.0, 93979.59030614409, 103495.0, 108139.37790933142, 71593.0, 82695.58652206701, 95625.78432401872, 98691.0, 99951.0, 67243.99134012994, 83647.0, 84564.99999999876, 84788.57605711932, 84870.5756471226, 8080.216716115631, 9230.400023998418, 9324.0, 9325.860112098188, 9633.807323853624, 49351.753241233564, 49739.00521989612, 50429.49570504248, 52627.21059184192, 54386.0, 70640.64679676775, 76716.61641691979, 77338.44364928317, 77957.220427795, 79171.0621703363, 14064.87809245292, 14122.0, 14194.574162775134, 14334.426622934965, 14432.42270309176, 14651.0, 14917.552473425814, 14926.925365373538, 15019.624509387353, 15550.300236489611, 13787.586372408843, 13939.790903136258, 13972.720545588829, 14119.152850828983, 14419.639509012359, 13018.153820002048, 13310.933445332712, 13903.165810051429, 14121.223332716389, 14241.64395890111, 13185.670358241121, 13663.521776737767, 13747.931260343634, 13782.586522404345, 13810.65473363174, 10859.2398532102, 11082.445877706245, 11168.329900206014, 11224.94387528057, 11571.074314054687, 10223.284370094021, 10291.588336466757, 11145.2198346115, 11483.942580287045, 11523.942380288045], "value": 7456.517731265537, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1552.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 121.0, 118.0, 118.0, 119.0, 117.0, 114.0, 117.0, 129.0, 176.0], "value": 124.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 113.0, 115.0, 147.0, 112.0, 113.0, 113.0, 115.0, 131.0, 111.0], "value": 120.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 203.0, 200.0, 187.0, 200.0, 197.0, 198.0, 201.0, 201.0, 198.0], "value": 197.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 60.0, 60.0, 96.0, 86.0, 77.0, 61.0, 60.0, 74.0, 68.0], "value": 72.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 71.0, 85.0, 73.0, 76.0, 96.0, 75.0, 74.0, 59.0, 93.0], "value": 79.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 115.0, 88.0, 106.0, 80.0, 133.0, 136.0, 101.0, 88.0, 85.0], "value": 102.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 156.0, 108.0, 155.0, 155.0, 96.0, 95.0, 96.0, 97.0, 95.0], "value": 116.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 94.0, 95.0, 106.0, 95.0, 126.0, 151.0, 131.0, 95.0, 98.0], "value": 108.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 60.0, 64.0, 64.0, 63.0, 63.0, 63.0, 64.0, 61.0], "value": 62.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 72.0, 72.0, 81.0, 81.0, 73.0, 70.0, 72.0, 75.0, 71.0], "value": 75.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 87.0, 87.0, 89.0, 91.0, 80.0, 90.0, 86.0, 85.0, 83.0], "value": 86.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 147.0, 154.0, 158.0, 147.0, 138.0, 174.0, 155.0, 188.0, 163.0], "value": 158.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 174.0, 169.0, 172.0, 172.0, 170.0, 176.0, 175.0, 171.0, 167.0], "value": 171.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 71.0, 68.0, 67.0, 69.0, 79.0, 85.0, 88.0, 91.0, 71.0], "value": 75.8, "unit": "score"}]}]} 08:30:40 INFO - Return code: 0 08:30:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:30:40 ERROR - # TBPL SUCCESS # 08:30:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:30:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:30:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:30:40 INFO - 2017-03-03 08:30:40.486 screenresolution[6480:123518] starting screenresolution argv=screenresolution get 08:30:40 INFO - 2017-03-03 08:30:40.489 screenresolution[6480:123518] Display 0: 1600x1200x32@60 08:30:40 INFO - 2017-03-03 08:30:40.495 screenresolution[6481:123521] starting screenresolution argv=screenresolution list 08:30:40 INFO - Available Modes on Display 0 08:30:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:30:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:30:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:30:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:30:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:30:40 INFO - Intel Iris: 08:30:40 INFO - Chipset Model: Intel Iris 08:30:40 INFO - Type: GPU 08:30:40 INFO - Bus: Built-In 08:30:40 INFO - VRAM (Dynamic, Max): 1536 MB 08:30:40 INFO - Vendor: Intel (0x8086) 08:30:40 INFO - Device ID: 0x0a2e 08:30:40 INFO - Revision ID: 0x0009 08:30:40 INFO - Displays: 08:30:40 INFO - Display: 08:30:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:30:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:30:40 INFO - Display Serial Number: 1600x1200 60 08:30:40 INFO - Main Display: Yes 08:30:40 INFO - Mirror: Off 08:30:40 INFO - Online: Yes 08:30:40 INFO - Rotation: Supported 08:30:40 INFO - Return code: 0 08:30:40 INFO - Running post-action listener: _resource_record_post_action 08:30:40 INFO - [mozharness: 2017-03-03 16:30:40.737019Z] Finished run-tests step (success) 08:30:40 INFO - Running post-run listener: _resource_record_post_run 08:30:40 INFO - Total resource usage - Wall time: 1197s; CPU: 54.0%; Read bytes: 1113088; Write bytes: 512235008; Read time: 15; Write time: 1626 08:30:40 INFO - TinderboxPrint: CPU usage
54.4% 08:30:40 INFO - TinderboxPrint: I/O read bytes / time
1,113,088 / 15 08:30:40 INFO - TinderboxPrint: I/O write bytes / time
512,235,008 / 1,626 08:30:40 INFO - TinderboxPrint: CPU idle
2,182.9 (45.6%) 08:30:40 INFO - TinderboxPrint: CPU system
966.2 (20.2%) 08:30:40 INFO - TinderboxPrint: CPU user
1,640.5 (34.3%) 08:30:40 INFO - TinderboxPrint: Swap in / out
209,768,448 / 0 08:30:40 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205353472; Write bytes: 200648192; Read time: 15742; Write time: 445 08:30:40 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 998400; Write bytes: 300486656; Read time: 13; Write time: 1141 08:30:41 INFO - Running post-run listener: _upload_blobber_files 08:30:41 INFO - Blob upload gear active. 08:30:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:30:41 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 08:30:41 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'] 08:30:41 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 08:30:41 INFO - (blobuploader) - INFO - Open directory for files ... 08:30:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:30:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:30:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:30:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:30:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:30:42 INFO - (blobuploader) - INFO - Done attempting. 08:30:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:30:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:30:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:30:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:30:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:30:43 INFO - (blobuploader) - INFO - Done attempting. 08:30:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:30:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:30:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:30:44 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:30:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:30:44 INFO - (blobuploader) - INFO - Done attempting. 08:30:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:30:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:30:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:30:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:30:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:30:46 INFO - (blobuploader) - INFO - Done attempting. 08:30:46 INFO - (blobuploader) - INFO - Iteration through files over. 08:30:46 INFO - Return code: 0 08:30:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:30:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:30:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/91804ead9dbcc0ea1c18e8987a1c39ba2f05ee31011f495358d9d2ac73a9b566d0aac31a7e924e687a47d65bf89451d118c604ae7c1a28d0c6fd948276276ed9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7f3b47cdacb4dcaf9d9ab299fab473d9dac9d3c4ce83fc66cfc8b7acfdda738ce0f1aaa388d0880fbe505e0a315b03ca1d1208c791adaa4738600f202a699a56", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/20eef01b01b6c09023300657b70393c1c4c1748e6c08525aeb06af15b15a3a657361e7d8d3c691d9634415b7465a6a90edcc61c0aff43903402ba244a62345ac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ae767c61d5a0e62e424bd5b291f05503deff53548bf84934c7ff5a861eff66327f43661c0c00d23bcf3fcfdf8888174013ad660708821a2b03b26ad07d4db99f"} 08:30:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:30:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:30:46 INFO - Contents: 08:30:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/91804ead9dbcc0ea1c18e8987a1c39ba2f05ee31011f495358d9d2ac73a9b566d0aac31a7e924e687a47d65bf89451d118c604ae7c1a28d0c6fd948276276ed9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7f3b47cdacb4dcaf9d9ab299fab473d9dac9d3c4ce83fc66cfc8b7acfdda738ce0f1aaa388d0880fbe505e0a315b03ca1d1208c791adaa4738600f202a699a56", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/20eef01b01b6c09023300657b70393c1c4c1748e6c08525aeb06af15b15a3a657361e7d8d3c691d9634415b7465a6a90edcc61c0aff43903402ba244a62345ac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ae767c61d5a0e62e424bd5b291f05503deff53548bf84934c7ff5a861eff66327f43661c0c00d23bcf3fcfdf8888174013ad660708821a2b03b26ad07d4db99f"} 08:30:46 INFO - Running post-run listener: copy_logs_to_upload_dir 08:30:46 INFO - Copying logs to upload dir... 08:30:46 INFO - mkdir: /builds/slave/test/build/upload/logs 08:30:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.570965 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-03-03 08:30:46.834464) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-03 08:30:46.838216) ========= 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.MNXHah2HzH/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.5PwKMQxzEW/Listeners TMPDIR=/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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/91804ead9dbcc0ea1c18e8987a1c39ba2f05ee31011f495358d9d2ac73a9b566d0aac31a7e924e687a47d65bf89451d118c604ae7c1a28d0c6fd948276276ed9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7f3b47cdacb4dcaf9d9ab299fab473d9dac9d3c4ce83fc66cfc8b7acfdda738ce0f1aaa388d0880fbe505e0a315b03ca1d1208c791adaa4738600f202a699a56", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/20eef01b01b6c09023300657b70393c1c4c1748e6c08525aeb06af15b15a3a657361e7d8d3c691d9634415b7465a6a90edcc61c0aff43903402ba244a62345ac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ae767c61d5a0e62e424bd5b291f05503deff53548bf84934c7ff5a861eff66327f43661c0c00d23bcf3fcfdf8888174013ad660708821a2b03b26ad07d4db99f"} build_url:https://queue.taskcluster.net/v1/task/LhGJ4O_TToGRuTDCEk4Snw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011296 build_url: 'https://queue.taskcluster.net/v1/task/LhGJ4O_TToGRuTDCEk4Snw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/91804ead9dbcc0ea1c18e8987a1c39ba2f05ee31011f495358d9d2ac73a9b566d0aac31a7e924e687a47d65bf89451d118c604ae7c1a28d0c6fd948276276ed9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7f3b47cdacb4dcaf9d9ab299fab473d9dac9d3c4ce83fc66cfc8b7acfdda738ce0f1aaa388d0880fbe505e0a315b03ca1d1208c791adaa4738600f202a699a56", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/20eef01b01b6c09023300657b70393c1c4c1748e6c08525aeb06af15b15a3a657361e7d8d3c691d9634415b7465a6a90edcc61c0aff43903402ba244a62345ac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ae767c61d5a0e62e424bd5b291f05503deff53548bf84934c7ff5a861eff66327f43661c0c00d23bcf3fcfdf8888174013ad660708821a2b03b26ad07d4db99f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-03 08:30:46.873787) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 08:30:46.874319) ========= 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.MNXHah2HzH/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.5PwKMQxzEW/Listeners TMPDIR=/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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.005318 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 08:30:46.923630) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-03 08:30:46.923957) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-03 08:30:46.924413) ========= ========= Total master_lag: 0.19 =========