builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0062 starttime: 1487253760.59 results: success (0) buildid: 20170216043118 builduid: 94a620bf2fad4285ac6a05677db76b12 revision: 28886b4c135760a6d8aedf7ab7ec8cae5a0c5821 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-16 06:02:40.592188) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-16 06:02:40.592623) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-16 06:02:40.592891) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-16 06:02:40.619399) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 06:02:40.619758) ========= 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.27JzeeSoFZ/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.3TIXSF1mzG/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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-02-16 06:02:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 21.4M=0.001s 2017-02-16 06:02:40 (21.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.150178 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 06:02:40.794136) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 06:02:40.794442) ========= 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.27JzeeSoFZ/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.3TIXSF1mzG/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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.026898 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 06:02:40.843332) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-16 06:02:40.843678) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 28886b4c135760a6d8aedf7ab7ec8cae5a0c5821 --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 28886b4c135760a6d8aedf7ab7ec8cae5a0c5821 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.27JzeeSoFZ/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.3TIXSF1mzG/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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-02-16 06:02:40,946 truncating revision to first 12 chars 2017-02-16 06:02:40,946 Setting DEBUG logging. 2017-02-16 06:02:40,946 attempt 1/10 2017-02-16 06:02:40,946 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/28886b4c1357?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-16 06:02:43,079 unpacking tar archive at: mozilla-aurora-28886b4c1357/testing/mozharness/ program finished with exit code 0 elapsedTime=2.395457 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-16 06:02:43.264320) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-16 06:02:43.264653) ========= script_repo_revision: 28886b4c135760a6d8aedf7ab7ec8cae5a0c5821 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-16 06:02:43.265031) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-16 06:02:43.265305) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-16 06:02:43.284870) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-02-16 06:02:43.285194) ========= /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.27JzeeSoFZ/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.3TIXSF1mzG/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 06:02:43 INFO - MultiFileLogger online at 20170216 06:02:43 in /builds/slave/test 06:02:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 06:02:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:02:43 INFO - {'append_to_log': False, 06:02:43 INFO - 'base_work_dir': '/builds/slave/test', 06:02:43 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 06:02:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:02:43 INFO - 'branch': 'Mozilla-Aurora', 06:02:43 INFO - 'buildbot_json_path': 'buildprops.json', 06:02:43 INFO - 'config_files': ('talos/mac_config.py',), 06:02:43 INFO - 'default_actions': ('clobber', 06:02:43 INFO - 'read-buildbot-config', 06:02:43 INFO - 'download-and-extract', 06:02:43 INFO - 'populate-webroot', 06:02:43 INFO - 'create-virtualenv', 06:02:43 INFO - 'install', 06:02:43 INFO - 'run-tests'), 06:02:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:02:43 INFO - 'download_minidump_stackwalk': True, 06:02:43 INFO - 'download_symbols': 'ondemand', 06:02:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:02:43 INFO - 'tooltool.py': '/tools/tooltool.py', 06:02:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:02:43 INFO - '/tools/misc-python/virtualenv.py')}, 06:02:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:02:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:02:43 INFO - 'installer_path': 'installer.exe', 06:02:43 INFO - 'log_level': 'info', 06:02:43 INFO - 'log_name': 'talos', 06:02:43 INFO - 'log_to_console': True, 06:02:43 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:02:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:02:43 INFO - 'opt_config_files': (), 06:02:43 INFO - 'pip_index': False, 06:02:43 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:02:43 INFO - 'cmd': ('bash', 06:02:43 INFO - '-c', 06:02:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:02:43 INFO - 'enabled': True, 06:02:43 INFO - 'halt_on_failure': False, 06:02:43 INFO - 'name': 'check_screen_resolution'},), 06:02:43 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:02:43 INFO - 'cmd': ('bash', 06:02:43 INFO - '-c', 06:02:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:02:43 INFO - 'enabled': True, 06:02:43 INFO - 'halt_on_failure': False, 06:02:43 INFO - 'name': 'check_screen_resolution'},), 06:02:43 INFO - 'run_cmd_checks_enabled': True, 06:02:43 INFO - 'sps_profile': False, 06:02:43 INFO - 'sps_profile_interval': 0, 06:02:43 INFO - 'suite': 'dromaeojs-e10s', 06:02:43 INFO - 'system_bits': '32', 06:02:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:02:43 INFO - 'title': 't-yosemite-r7-0062', 06:02:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:02:43 INFO - 'use_talos_json': True, 06:02:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:02:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:02:43 INFO - 'work_dir': 'build'} 06:02:43 INFO - [mozharness: 2017-02-16 14:02:43.497584Z] Running clobber step. 06:02:43 INFO - Running pre-action listener: _resource_record_pre_action 06:02:43 INFO - Running main action method: clobber 06:02:43 INFO - rmtree: /builds/slave/test/build 06:02:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:02:46 INFO - Running post-action listener: _resource_record_post_action 06:02:46 INFO - [mozharness: 2017-02-16 14:02:46.064880Z] Finished clobber step (success) 06:02:46 INFO - [mozharness: 2017-02-16 14:02:46.065004Z] Running read-buildbot-config step. 06:02:46 INFO - Running pre-action listener: _resource_record_pre_action 06:02:46 INFO - Running main action method: read_buildbot_config 06:02:46 INFO - Using buildbot properties: 06:02:46 INFO - { 06:02:46 INFO - "project": "", 06:02:46 INFO - "product": "firefox", 06:02:46 INFO - "script_repo_revision": "production", 06:02:46 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 06:02:46 INFO - "repository": "", 06:02:46 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 06:02:46 INFO - "buildid": "20170216043118", 06:02:46 INFO - "pgo_build": "False", 06:02:46 INFO - "basedir": "/builds/slave/test", 06:02:46 INFO - "buildnumber": 3, 06:02:46 INFO - "slavename": "t-yosemite-r7-0062", 06:02:46 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 06:02:46 INFO - "platform": "yosemite_r7", 06:02:46 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 06:02:46 INFO - "branch": "mozilla-aurora", 06:02:46 INFO - "repo_path": "releases/mozilla-aurora", 06:02:46 INFO - "revision": "28886b4c135760a6d8aedf7ab7ec8cae5a0c5821", 06:02:46 INFO - "stage_platform": "macosx64", 06:02:46 INFO - "builduid": "94a620bf2fad4285ac6a05677db76b12", 06:02:46 INFO - "slavebuilddir": "test" 06:02:46 INFO - } 06:02:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/Wk66E6LdQw-MKUCgbORCeA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 06:02:46 INFO - Running post-action listener: _resource_record_post_action 06:02:46 INFO - [mozharness: 2017-02-16 14:02:46.068281Z] Finished read-buildbot-config step (success) 06:02:46 INFO - [mozharness: 2017-02-16 14:02:46.068389Z] Running download-and-extract step. 06:02:46 INFO - Running pre-action listener: _resource_record_pre_action 06:02:46 INFO - Running main action method: download_and_extract 06:02:46 INFO - mkdir: /builds/slave/test/build/tests 06:02:46 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')]} 06:02:46 INFO - trying https://queue.taskcluster.net/v1/task/Wk66E6LdQw-MKUCgbORCeA/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 06:02:46 INFO - Downloading https://queue.taskcluster.net/v1/task/Wk66E6LdQw-MKUCgbORCeA/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 06:02:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Wk66E6LdQw-MKUCgbORCeA/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 06:02:46 INFO - Downloaded 1199 bytes. 06:02:46 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 06:02:46 INFO - Using the following test package requirements: 06:02:46 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 06:02:46 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 06:02:46 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 06:02:46 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 06:02:46 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 06:02:46 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 06:02:46 INFO - u'jsshell-mac.zip'], 06:02:46 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 06:02:46 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 06:02:46 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 06:02:46 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 06:02:46 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 06:02:46 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 06:02:46 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 06:02:46 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 06:02:46 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 06:02:46 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 06:02:46 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 06:02:46 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 06:02:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Wk66E6LdQw-MKUCgbORCeA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 06:02:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Wk66E6LdQw-MKUCgbORCeA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 06:02:46 INFO - Fetch https://queue.taskcluster.net/v1/task/Wk66E6LdQw-MKUCgbORCeA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 06:02:47 INFO - Expected file size: 16358325 06:02:47 INFO - Obtained file size: 16358325 06:02:54 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 06:02:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Wk66E6LdQw-MKUCgbORCeA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 06:02:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Wk66E6LdQw-MKUCgbORCeA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 06:02:54 INFO - Fetch https://queue.taskcluster.net/v1/task/Wk66E6LdQw-MKUCgbORCeA/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 06:02:55 INFO - Expected file size: 16358325 06:02:55 INFO - Obtained file size: 16358325 06:03:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Wk66E6LdQw-MKUCgbORCeA/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 06:03:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Wk66E6LdQw-MKUCgbORCeA/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 06:03:01 INFO - Fetch https://queue.taskcluster.net/v1/task/Wk66E6LdQw-MKUCgbORCeA/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 06:03:03 INFO - Expected file size: 14403485 06:03:03 INFO - Obtained file size: 14403485 06:03: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')]} 06:03:03 INFO - trying https://queue.taskcluster.net/v1/task/Wk66E6LdQw-MKUCgbORCeA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 06:03:03 INFO - Downloading https://queue.taskcluster.net/v1/task/Wk66E6LdQw-MKUCgbORCeA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 06:03:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Wk66E6LdQw-MKUCgbORCeA/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 06:03:05 INFO - Downloaded 73944356 bytes. 06:03:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Wk66E6LdQw-MKUCgbORCeA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 06:03:05 INFO - mkdir: /builds/slave/test/properties 06:03:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:03:05 INFO - Writing to file /builds/slave/test/properties/build_url 06:03:05 INFO - Contents: 06:03:05 INFO - build_url:https://queue.taskcluster.net/v1/task/Wk66E6LdQw-MKUCgbORCeA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 06:03:06 INFO - Running post-action listener: _resource_record_post_action 06:03:06 INFO - Running post-action listener: set_extra_try_arguments 06:03:06 INFO - [mozharness: 2017-02-16 14:03:06.421367Z] Finished download-and-extract step (success) 06:03:06 INFO - [mozharness: 2017-02-16 14:03:06.421492Z] Running populate-webroot step. 06:03:06 INFO - Running pre-action listener: _resource_record_pre_action 06:03:06 INFO - Running main action method: populate_webroot 06:03:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:03:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:03:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:03:06 INFO - '--tppagecycles', 06:03:06 INFO - '7'], 06:03:06 INFO - 'tests': ['tsvgm']}}, 06:03:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:03:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:03:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:03:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:03:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:03:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:03:06 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 06:03:06 INFO - 'talos_options': ['--disable-e10s'], 06:03:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:03:06 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:03:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:03:06 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 06:03:06 INFO - 'talos_options': ['--disable-e10s'], 06:03:06 INFO - 'tests': ['damp', 'tps']}, 06:03:06 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:03:06 INFO - 'tests': ['damp', 'tps']}, 06:03:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:03:06 INFO - 'tests': ['dromaeo_dom']}, 06:03:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:03:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:03:06 INFO - 'tests': ['basic_compositor_video']}, 06:03:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:03:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:03:06 INFO - 'tests': ['a11yr', 06:03:06 INFO - 'ts_paint', 06:03:06 INFO - 'tpaint', 06:03:06 INFO - 'sessionrestore', 06:03:06 INFO - 'sessionrestore_no_auto_restore', 06:03:06 INFO - 'tabpaint']}, 06:03:06 INFO - 'other-e10s': {'tests': ['a11yr', 06:03:06 INFO - 'ts_paint', 06:03:06 INFO - 'tpaint', 06:03:06 INFO - 'sessionrestore', 06:03:06 INFO - 'sessionrestore_no_auto_restore', 06:03:06 INFO - 'tabpaint']}, 06:03:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:03:06 INFO - 'ts_paint', 06:03:06 INFO - 'tpaint', 06:03:06 INFO - 'sessionrestore', 06:03:06 INFO - 'sessionrestore_no_auto_restore', 06:03:06 INFO - 'tabpaint']}, 06:03:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:03:06 INFO - 'ts_paint', 06:03:06 INFO - 'tpaint', 06:03:06 INFO - 'sessionrestore', 06:03:06 INFO - 'sessionrestore_no_auto_restore', 06:03:06 INFO - 'tabpaint']}, 06:03:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:03:06 INFO - 'tests': ['a11yr', 06:03:06 INFO - 'ts_paint', 06:03:06 INFO - 'tpaint', 06:03:06 INFO - 'sessionrestore', 06:03:06 INFO - 'sessionrestore_no_auto_restore', 06:03:06 INFO - 'tabpaint']}, 06:03:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:03:06 INFO - 'tests': ['a11yr', 06:03:06 INFO - 'ts_paint', 06:03:06 INFO - 'tpaint', 06:03:06 INFO - 'sessionrestore', 06:03:06 INFO - 'sessionrestore_no_auto_restore', 06:03:06 INFO - 'tabpaint']}, 06:03:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:03:06 INFO - 'tests': ['tsvgx', 06:03:06 INFO - 'tsvgr_opacity', 06:03:06 INFO - 'tart', 06:03:06 INFO - 'tscrollx', 06:03:06 INFO - 'cart', 06:03:06 INFO - 'tsvg_static']}, 06:03:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:03:06 INFO - 'tsvgr_opacity', 06:03:06 INFO - 'tart', 06:03:06 INFO - 'tscrollx', 06:03:06 INFO - 'cart', 06:03:06 INFO - 'tsvg_static']}, 06:03:06 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 06:03:06 INFO - 'talos_options': ['--disable-e10s'], 06:03:06 INFO - 'tests': ['tp5o']}, 06:03:06 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:03:06 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 06:03:06 INFO - 'talos_options': ['--disable-e10s', 06:03:06 INFO - '--xperf_path', 06:03:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:03:06 INFO - 'tests': ['tp5n']}, 06:03:06 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:03:06 INFO - 'talos_options': ['--xperf_path', 06:03:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:03:06 INFO - 'tests': ['tp5n']}}, 06:03:06 INFO - 'talos.zip': {'path': '', 06:03:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:03:06 INFO - Running post-action listener: _resource_record_post_action 06:03:06 INFO - [mozharness: 2017-02-16 14:03:06.439994Z] Finished populate-webroot step (success) 06:03:06 INFO - [mozharness: 2017-02-16 14:03:06.440106Z] Running create-virtualenv step. 06:03:06 INFO - Running pre-action listener: _resource_record_pre_action 06:03:06 INFO - Running main action method: create_virtualenv 06:03:06 INFO - Creating virtualenv /builds/slave/test/build/venv 06:03:06 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 06:03:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:03:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:03:06 INFO - Using real prefix '/tools/python27' 06:03:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:03:07 INFO - Installing distribute.............................................................................................................................................................................................done. 06:03:10 INFO - Installing pip.................done. 06:03:10 INFO - Return code: 0 06:03:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:03:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:03:10 INFO - Reading from file tmpfile_stdout 06:03:10 INFO - Output received: 06:03:10 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) 06:03:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:03:10 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')]} 06:03:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:03:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03:10 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')]} 06:03:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:03:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03:10 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 0x10f503b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f506768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feac84bd2d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2e1d30>, '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 0x10f208db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f2d6be8>, '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.27JzeeSoFZ/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.3TIXSF1mzG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 06:03:10 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 06:03:10 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 06:03:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.27JzeeSoFZ/Render', 06:03:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:03:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:03:10 INFO - 'HOME': '/Users/cltbld', 06:03:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:03:10 INFO - 'LOGNAME': 'cltbld', 06:03:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:03:10 INFO - 'MOZ_NO_REMOTE': '1', 06:03:10 INFO - 'NO_EM_RESTART': '1', 06:03:10 INFO - 'PAGER': '/bin/cat', 06:03:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:03:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:03:10 INFO - 'PWD': '/builds/slave/test', 06:03:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:03:10 INFO - 'SHELL': '/bin/bash', 06:03:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3TIXSF1mzG/Listeners', 06:03:10 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 06:03:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:03:10 INFO - 'USER': 'cltbld', 06:03:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:03:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:03:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:03:10 INFO - 'XPC_FLAGS': '0x0', 06:03:10 INFO - 'XPC_SERVICE_NAME': '0', 06:03:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:03:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:03:10 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 06:03:10 INFO - Cleaning up... 06:03:10 INFO - Return code: 0 06:03:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:03:10 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')]} 06:03:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:03:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03:10 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')]} 06:03:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:03:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03:10 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 0x10f503b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f506768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feac84bd2d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2e1d30>, '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 0x10f208db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f2d6be8>, '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.27JzeeSoFZ/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.3TIXSF1mzG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 06:03:10 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 06:03:10 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 06:03:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.27JzeeSoFZ/Render', 06:03:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:03:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:03:10 INFO - 'HOME': '/Users/cltbld', 06:03:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:03:10 INFO - 'LOGNAME': 'cltbld', 06:03:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:03:10 INFO - 'MOZ_NO_REMOTE': '1', 06:03:10 INFO - 'NO_EM_RESTART': '1', 06:03:10 INFO - 'PAGER': '/bin/cat', 06:03:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:03:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:03:10 INFO - 'PWD': '/builds/slave/test', 06:03:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:03:10 INFO - 'SHELL': '/bin/bash', 06:03:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3TIXSF1mzG/Listeners', 06:03:10 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 06:03:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:03:10 INFO - 'USER': 'cltbld', 06:03:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:03:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:03:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:03:10 INFO - 'XPC_FLAGS': '0x0', 06:03:10 INFO - 'XPC_SERVICE_NAME': '0', 06:03:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:03:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:03:10 INFO - Downloading/unpacking psutil>=3.1.1 06:03:10 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 06:03:10 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 06:03:10 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 06:03:10 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 06:03:10 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 06:03:10 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 06:03:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:03:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:03:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:03:14 INFO - Installing collected packages: psutil 06:03:14 INFO - Running setup.py install for psutil 06:03:14 INFO - building 'psutil._psutil_osx' extension 06:03:14 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 06:03:15 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 06:03:15 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 06:03:15 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 06:03:15 INFO - building 'psutil._psutil_posix' extension 06:03:15 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 06:03:15 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:03:15 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:03:15 INFO - ^ 06:03:15 INFO - 1 warning generated. 06:03:15 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 06:03:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:03:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:03:15 INFO - Successfully installed psutil 06:03:15 INFO - Cleaning up... 06:03:15 INFO - Return code: 0 06:03:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:03:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:03:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:03:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:03:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:03:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f503b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f506768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feac84bd2d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2e1d30>, '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 0x10f208db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f2d6be8>, '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.27JzeeSoFZ/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.3TIXSF1mzG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 06:03:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:03:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:03:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.27JzeeSoFZ/Render', 06:03:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:03:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:03:15 INFO - 'HOME': '/Users/cltbld', 06:03:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:03:15 INFO - 'LOGNAME': 'cltbld', 06:03:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:03:15 INFO - 'MOZ_NO_REMOTE': '1', 06:03:15 INFO - 'NO_EM_RESTART': '1', 06:03:15 INFO - 'PAGER': '/bin/cat', 06:03:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:03:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:03:15 INFO - 'PWD': '/builds/slave/test', 06:03:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:03:15 INFO - 'SHELL': '/bin/bash', 06:03:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3TIXSF1mzG/Listeners', 06:03:15 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 06:03:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:03:15 INFO - 'USER': 'cltbld', 06:03:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:03:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:03:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:03:15 INFO - 'XPC_FLAGS': '0x0', 06:03:15 INFO - 'XPC_SERVICE_NAME': '0', 06:03:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:03:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:03:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:03:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:03:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:03:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:03:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:03:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:03:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:03:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:03:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:03:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:03:18 INFO - Installing collected packages: mozsystemmonitor 06:03:18 INFO - Running setup.py install for mozsystemmonitor 06:03:18 INFO - Successfully installed mozsystemmonitor 06:03:18 INFO - Cleaning up... 06:03:18 INFO - Return code: 0 06:03:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:03:18 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')]} 06:03:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:03:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03:18 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')]} 06:03:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:03:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03:18 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 0x10f503b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f506768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feac84bd2d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2e1d30>, '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 0x10f208db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f2d6be8>, '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.27JzeeSoFZ/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.3TIXSF1mzG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 06:03:18 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 06:03:18 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 06:03:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.27JzeeSoFZ/Render', 06:03:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:03:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:03:18 INFO - 'HOME': '/Users/cltbld', 06:03:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:03:18 INFO - 'LOGNAME': 'cltbld', 06:03:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:03:18 INFO - 'MOZ_NO_REMOTE': '1', 06:03:18 INFO - 'NO_EM_RESTART': '1', 06:03:18 INFO - 'PAGER': '/bin/cat', 06:03:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:03:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:03:18 INFO - 'PWD': '/builds/slave/test', 06:03:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:03:18 INFO - 'SHELL': '/bin/bash', 06:03:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3TIXSF1mzG/Listeners', 06:03:18 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 06:03:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:03:18 INFO - 'USER': 'cltbld', 06:03:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:03:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:03:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:03:18 INFO - 'XPC_FLAGS': '0x0', 06:03:18 INFO - 'XPC_SERVICE_NAME': '0', 06:03:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:03:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:03:19 INFO - Downloading/unpacking jsonschema==2.5.1 06:03:19 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 06:03:19 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 06:03:19 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 06:03:19 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 06:03:19 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 06:03:19 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 06:03:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:03:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:03:21 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 06:03:21 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 06:03:21 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 06:03:21 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 06:03:21 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 06:03:21 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 06:03:22 INFO - Downloading functools32-3.2.3-2.tar.gz 06:03:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:03:22 INFO - warning: no files found matching '*.txt' 06:03:22 INFO - no previously-included directories found matching 'build' 06:03:22 INFO - no previously-included directories found matching 'dist' 06:03:22 INFO - no previously-included directories found matching '.git*' 06:03:22 INFO - Installing collected packages: jsonschema, functools32 06:03:22 INFO - Running setup.py install for functools32 06:03:22 INFO - warning: no files found matching '*.txt' 06:03:22 INFO - no previously-included directories found matching 'build' 06:03:22 INFO - no previously-included directories found matching 'dist' 06:03:22 INFO - no previously-included directories found matching '.git*' 06:03:22 INFO - Successfully installed jsonschema functools32 06:03:22 INFO - Cleaning up... 06:03:22 INFO - Return code: 0 06:03:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:03:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:03:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:03:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:03:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:03:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03:22 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 0x10f503b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f506768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feac84bd2d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2e1d30>, '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 0x10f208db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f2d6be8>, '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.27JzeeSoFZ/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.3TIXSF1mzG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 06:03:22 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 06:03:22 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 06:03:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.27JzeeSoFZ/Render', 06:03:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:03:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:03:22 INFO - 'HOME': '/Users/cltbld', 06:03:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:03:22 INFO - 'LOGNAME': 'cltbld', 06:03:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:03:22 INFO - 'MOZ_NO_REMOTE': '1', 06:03:22 INFO - 'NO_EM_RESTART': '1', 06:03:22 INFO - 'PAGER': '/bin/cat', 06:03:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:03:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:03:22 INFO - 'PWD': '/builds/slave/test', 06:03:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:03:22 INFO - 'SHELL': '/bin/bash', 06:03:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3TIXSF1mzG/Listeners', 06:03:22 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 06:03:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:03:22 INFO - 'USER': 'cltbld', 06:03:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:03:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:03:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:03:22 INFO - 'XPC_FLAGS': '0x0', 06:03:22 INFO - 'XPC_SERVICE_NAME': '0', 06:03:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:03:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:03:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:03:22 INFO - Cleaning up... 06:03:22 INFO - Return code: 0 06:03:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:03:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:03:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:03:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:03:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:03:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03:22 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 0x10f503b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f506768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feac84bd2d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2e1d30>, '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 0x10f208db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f2d6be8>, '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.27JzeeSoFZ/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.3TIXSF1mzG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 06:03:22 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 06:03:22 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 06:03:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.27JzeeSoFZ/Render', 06:03:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:03:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:03:22 INFO - 'HOME': '/Users/cltbld', 06:03:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:03:22 INFO - 'LOGNAME': 'cltbld', 06:03:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:03:22 INFO - 'MOZ_NO_REMOTE': '1', 06:03:22 INFO - 'NO_EM_RESTART': '1', 06:03:22 INFO - 'PAGER': '/bin/cat', 06:03:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:03:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:03:22 INFO - 'PWD': '/builds/slave/test', 06:03:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:03:22 INFO - 'SHELL': '/bin/bash', 06:03:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3TIXSF1mzG/Listeners', 06:03:22 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 06:03:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:03:22 INFO - 'USER': 'cltbld', 06:03:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:03:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:03:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:03:22 INFO - 'XPC_FLAGS': '0x0', 06:03:22 INFO - 'XPC_SERVICE_NAME': '0', 06:03:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:03:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:03:23 INFO - Downloading/unpacking blobuploader==1.2.4 06:03: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 06:03: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 06:03: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 06:03: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 06:03: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 06:03: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 06:03:25 INFO - Downloading blobuploader-1.2.4.tar.gz 06:03:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:03:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:03:25 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 06:03:25 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 06:03:25 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 06:03:25 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 06:03:25 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 06:03:25 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 06:03:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:03:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:03: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 06:03: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 06:03: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 06:03: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 06:03: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 06:03: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 06:03:27 INFO - Downloading docopt-0.6.1.tar.gz 06:03:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:03:27 INFO - Installing collected packages: blobuploader, requests, docopt 06:03:27 INFO - Running setup.py install for blobuploader 06:03:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:03:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:03:27 INFO - Running setup.py install for requests 06:03:27 INFO - Running setup.py install for docopt 06:03:27 INFO - Successfully installed blobuploader requests docopt 06:03:27 INFO - Cleaning up... 06:03:28 INFO - Return code: 0 06:03:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:03:28 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')]} 06:03:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:03:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03:28 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')]} 06:03:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:03:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03:28 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 0x10f503b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f506768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feac84bd2d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2e1d30>, '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 0x10f208db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f2d6be8>, '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.27JzeeSoFZ/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.3TIXSF1mzG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 06:03:28 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 06:03:28 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 06:03:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.27JzeeSoFZ/Render', 06:03:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:03:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:03:28 INFO - 'HOME': '/Users/cltbld', 06:03:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:03:28 INFO - 'LOGNAME': 'cltbld', 06:03:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:03:28 INFO - 'MOZ_NO_REMOTE': '1', 06:03:28 INFO - 'NO_EM_RESTART': '1', 06:03:28 INFO - 'PAGER': '/bin/cat', 06:03:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:03:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:03:28 INFO - 'PWD': '/builds/slave/test', 06:03:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:03:28 INFO - 'SHELL': '/bin/bash', 06:03:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3TIXSF1mzG/Listeners', 06:03:28 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 06:03:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:03:28 INFO - 'USER': 'cltbld', 06:03:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:03:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:03:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:03:28 INFO - 'XPC_FLAGS': '0x0', 06:03:28 INFO - 'XPC_SERVICE_NAME': '0', 06:03:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:03:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:03:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:03:28 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-_VSug2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:03:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:03:28 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-NK74WE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:03:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:03:28 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-R1y4Vl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:03:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:03:28 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-_4JqjD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:03:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:03:28 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-3N_qdj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:03:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:03:28 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-c95sm9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:03:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:03:28 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-WWDgDN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:03:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:03:29 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-5G77Pw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:03:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:03:29 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-fy04K9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:03:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:03:29 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-2VZ9Ht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:03:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:03:29 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-Xw3oqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:03:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:03:29 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-pUADaX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:03:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:03:29 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-9WtGsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:03:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:03:29 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-3EbMbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:03:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:03:29 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-EErDoU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:03:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:03:29 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-sL5XNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:03:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:03:29 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-F3Mh8d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:03:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:03:30 INFO - Running setup.py install for manifestparser 06:03:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:03:30 INFO - Running setup.py install for mozcrash 06:03:30 INFO - Running setup.py install for mozdebug 06:03:30 INFO - Running setup.py install for mozdevice 06:03:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:03:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:03:30 INFO - Running setup.py install for mozfile 06:03:30 INFO - Running setup.py install for mozhttpd 06:03:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:03:30 INFO - Running setup.py install for mozinfo 06:03:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:03:31 INFO - Running setup.py install for mozInstall 06:03:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:03:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:03:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:03:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:03:31 INFO - Running setup.py install for mozleak 06:03:31 INFO - Running setup.py install for mozlog 06:03:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:03:31 INFO - Running setup.py install for moznetwork 06:03:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:03:31 INFO - Running setup.py install for mozprocess 06:03:31 INFO - Running setup.py install for mozprofile 06:03:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:03:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:03:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:03:32 INFO - Running setup.py install for mozrunner 06:03:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:03:32 INFO - Running setup.py install for mozscreenshot 06:03:32 INFO - Running setup.py install for moztest 06:03:32 INFO - Running setup.py install for mozversion 06:03:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:03:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:03:32 INFO - Cleaning up... 06:03:32 INFO - Return code: 0 06:03:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:03: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')]} 06:03:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:03:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03: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')]} 06:03:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:03:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03:32 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 0x10f503b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f506768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feac84bd2d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2e1d30>, '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 0x10f208db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f2d6be8>, '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.27JzeeSoFZ/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.3TIXSF1mzG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 06:03:32 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 06:03:32 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 06:03:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.27JzeeSoFZ/Render', 06:03:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:03:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:03:32 INFO - 'HOME': '/Users/cltbld', 06:03:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:03:32 INFO - 'LOGNAME': 'cltbld', 06:03:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:03:32 INFO - 'MOZ_NO_REMOTE': '1', 06:03:32 INFO - 'NO_EM_RESTART': '1', 06:03:32 INFO - 'PAGER': '/bin/cat', 06:03:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:03:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:03:32 INFO - 'PWD': '/builds/slave/test', 06:03:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:03:32 INFO - 'SHELL': '/bin/bash', 06:03:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3TIXSF1mzG/Listeners', 06:03:32 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 06:03:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:03:32 INFO - 'USER': 'cltbld', 06:03:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:03:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:03:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:03:32 INFO - 'XPC_FLAGS': '0x0', 06:03:32 INFO - 'XPC_SERVICE_NAME': '0', 06:03:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:03:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:03:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:03:32 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-SKUolg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:03:33 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)) 06:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:03:33 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-q1XOeQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:03:33 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)) 06:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:03:33 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-sh9hoc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:03:33 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)) 06:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:03:33 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-VrSPue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:03:33 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)) 06:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:03:33 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-MEN8Wj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:03:33 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)) 06:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:03:33 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-6TLzEa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:03:33 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)) 06:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:03:33 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-8CMWFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:03:33 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)) 06:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:03:33 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-25SWQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:03:33 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)) 06:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:03:33 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-VpORSS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:03:33 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)) 06:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:03:33 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-pTVEYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:03:34 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)) 06:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:03:34 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-9anK5D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:03:34 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)) 06:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:03:34 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-n13X29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:03:34 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)) 06:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:03:34 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-Xx67nK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:03:34 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)) 06:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:03:34 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-UYGr_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:03:34 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)) 06:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:03:34 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-HWYkJ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:03:34 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)) 06:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:03:34 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-TdAYC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:03:34 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)) 06:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:03:34 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-3bZbm9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:03:34 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)) 06:03:34 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)) 06:03:34 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)) 06:03:34 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)) 06:03:34 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)) 06:03:34 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)) 06:03:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:03:34 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 06:03:34 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 06:03:34 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 06:03:34 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 06:03:34 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 06:03:34 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 06:03:37 INFO - Downloading blessings-1.6.tar.gz 06:03:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:03:37 INFO - Installing collected packages: blessings 06:03:37 INFO - Running setup.py install for blessings 06:03:37 INFO - Successfully installed blessings 06:03:37 INFO - Cleaning up... 06:03:37 INFO - Return code: 0 06:03:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:03:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:03:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:03:38 INFO - Reading from file tmpfile_stdout 06:03:38 INFO - Current package versions: 06:03:38 INFO - blessings == 1.6 06:03:38 INFO - blobuploader == 1.2.4 06:03:38 INFO - docopt == 0.6.1 06:03:38 INFO - functools32 == 3.2.3-2 06:03:38 INFO - jsonschema == 2.5.1 06:03:38 INFO - manifestparser == 1.1 06:03:38 INFO - mozInstall == 1.12 06:03:38 INFO - mozcrash == 1.0 06:03:38 INFO - mozdebug == 0.1 06:03:38 INFO - mozdevice == 0.49 06:03:38 INFO - mozfile == 1.2 06:03:38 INFO - mozhttpd == 0.7 06:03:38 INFO - mozinfo == 0.9 06:03:38 INFO - mozleak == 0.1 06:03:38 INFO - mozlog == 3.4 06:03:38 INFO - moznetwork == 0.27 06:03:38 INFO - mozprocess == 0.24 06:03:38 INFO - mozprofile == 0.28 06:03:38 INFO - mozrunner == 6.13 06:03:38 INFO - mozscreenshot == 0.1 06:03:38 INFO - mozsystemmonitor == 0.3 06:03:38 INFO - moztest == 0.8 06:03:38 INFO - mozversion == 1.4 06:03:38 INFO - psutil == 3.1.1 06:03:38 INFO - requests == 1.2.3 06:03:38 INFO - wsgiref == 0.1.2 06:03:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:03:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:03:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:03:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:03:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:03:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03:38 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 0x10f503b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f506768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feac84bd2d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2e1d30>, '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 0x10f208db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f2d6be8>, '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.27JzeeSoFZ/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.3TIXSF1mzG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 06:03:38 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 06:03:38 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 06:03:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.27JzeeSoFZ/Render', 06:03:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:03:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:03:38 INFO - 'HOME': '/Users/cltbld', 06:03:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:03:38 INFO - 'LOGNAME': 'cltbld', 06:03:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:03:38 INFO - 'MOZ_NO_REMOTE': '1', 06:03:38 INFO - 'NO_EM_RESTART': '1', 06:03:38 INFO - 'PAGER': '/bin/cat', 06:03:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:03:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:03:38 INFO - 'PWD': '/builds/slave/test', 06:03:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:03:38 INFO - 'SHELL': '/bin/bash', 06:03:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3TIXSF1mzG/Listeners', 06:03:38 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 06:03:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:03:38 INFO - 'USER': 'cltbld', 06:03:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:03:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:03:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:03:38 INFO - 'XPC_FLAGS': '0x0', 06:03:38 INFO - 'XPC_SERVICE_NAME': '0', 06:03:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:03:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:03:39 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)) 06:03:39 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)) 06:03:39 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)) 06:03:39 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)) 06:03:39 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)) 06:03:39 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)) 06:03:39 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)) 06:03:39 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)) 06:03:39 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)) 06:03:39 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)) 06:03:39 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)) 06:03:39 INFO - Cleaning up... 06:03:39 INFO - Return code: 0 06:03:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:03:39 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')]} 06:03:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:03:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03:39 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')]} 06:03:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:03:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:03:39 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 0x10f503b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f506768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feac84bd2d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2e1d30>, '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 0x10f208db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f2d6be8>, '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.27JzeeSoFZ/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.3TIXSF1mzG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 06:03:39 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 06:03:39 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 06:03:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.27JzeeSoFZ/Render', 06:03:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:03:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:03:39 INFO - 'HOME': '/Users/cltbld', 06:03:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:03:39 INFO - 'LOGNAME': 'cltbld', 06:03:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:03:39 INFO - 'MOZ_NO_REMOTE': '1', 06:03:39 INFO - 'NO_EM_RESTART': '1', 06:03:39 INFO - 'PAGER': '/bin/cat', 06:03:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:03:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:03:39 INFO - 'PWD': '/builds/slave/test', 06:03:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:03:39 INFO - 'SHELL': '/bin/bash', 06:03:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3TIXSF1mzG/Listeners', 06:03:39 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 06:03:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:03:39 INFO - 'USER': 'cltbld', 06:03:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:03:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:03:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:03:39 INFO - 'XPC_FLAGS': '0x0', 06:03:39 INFO - 'XPC_SERVICE_NAME': '0', 06:03:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:03:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:03:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:03:39 INFO - Cleaning up... 06:03:39 INFO - Return code: 0 06:03:39 INFO - Running post-action listener: _resource_record_post_action 06:03:39 INFO - Running post-action listener: _start_resource_monitoring 06:03:39 INFO - Starting resource monitoring. 06:03:39 INFO - [mozharness: 2017-02-16 14:03:39.728589Z] Finished create-virtualenv step (success) 06:03:39 INFO - [mozharness: 2017-02-16 14:03:39.729506Z] Running install step. 06:03:39 INFO - Running pre-action listener: _resource_record_pre_action 06:03:39 INFO - Running main action method: install 06:03:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:03:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:03:39 INFO - Reading from file tmpfile_stdout 06:03:39 INFO - Detecting whether we're running mozinstall >=1.0... 06:03:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:03:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:03:40 INFO - Reading from file tmpfile_stdout 06:03:40 INFO - Output received: 06:03:40 INFO - Usage: mozinstall [options] installer 06:03:40 INFO - Options: 06:03:40 INFO - -h, --help show this help message and exit 06:03:40 INFO - -d DEST, --destination=DEST 06:03:40 INFO - Directory to install application into. [default: 06:03:40 INFO - "/builds/slave/test"] 06:03:40 INFO - --app=APP Application being installed. [default: firefox] 06:03:40 INFO - mkdir: /builds/slave/test/build/application 06:03:40 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'] 06:03:40 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 06:03:59 INFO - Reading from file tmpfile_stdout 06:03:59 INFO - Output received: 06:03:59 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 06:03:59 INFO - Running post-action listener: _resource_record_post_action 06:03:59 INFO - [mozharness: 2017-02-16 14:03:59.936957Z] Finished install step (success) 06:03:59 INFO - [mozharness: 2017-02-16 14:03:59.937138Z] Running run-tests step. 06:03:59 INFO - Running pre-action listener: _resource_record_pre_action 06:03:59 INFO - Running main action method: run_tests 06:03:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:03:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:03:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:03:59 INFO - 2017-02-16 06:03:59.951 screenresolution[1625:7286] starting screenresolution argv=screenresolution get 06:03:59 INFO - 2017-02-16 06:03:59.954 screenresolution[1625:7286] Display 0: 1600x1200x32@60 06:03:59 INFO - 2017-02-16 06:03:59.959 screenresolution[1626:7289] starting screenresolution argv=screenresolution list 06:03:59 INFO - Available Modes on Display 0 06:03:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:03:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:03:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:03:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:04:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:04:00 INFO - Intel Iris: 06:04:00 INFO - Chipset Model: Intel Iris 06:04:00 INFO - Type: GPU 06:04:00 INFO - Bus: Built-In 06:04:00 INFO - VRAM (Dynamic, Max): 1536 MB 06:04:00 INFO - Vendor: Intel (0x8086) 06:04:00 INFO - Device ID: 0x0a2e 06:04:00 INFO - Revision ID: 0x0009 06:04:00 INFO - Displays: 06:04:00 INFO - Display: 06:04:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:04:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:04:00 INFO - Display Serial Number: 1600x1200 60 06:04:00 INFO - Main Display: Yes 06:04:00 INFO - Mirror: Off 06:04:00 INFO - Online: Yes 06:04:00 INFO - Rotation: Supported 06:04:00 INFO - Return code: 0 06:04:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:04:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:04:00 INFO - Python 2.7.3 06:04:00 INFO - Return code: 0 06:04:00 INFO - grabbing minidump binary from tooltool 06:04:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:04:00 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 0x10f2e1d30>, '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 0x10f208db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f2d6be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:04:00 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 06:04:00 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 06:04:00 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 06:04:00 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:04:00 INFO - Return code: 0 06:04:00 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:04:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:04:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:04:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:04:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:04:00 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/Wk66E6LdQw-MKUCgbORCeA/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0062', '--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 06:04:00 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/Wk66E6LdQw-MKUCgbORCeA/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0062 --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 06:04:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.27JzeeSoFZ/Render', 06:04:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:04:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:04:00 INFO - 'HOME': '/Users/cltbld', 06:04:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:04:00 INFO - 'LOGNAME': 'cltbld', 06:04:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:04:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:04:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:04:00 INFO - 'MOZ_NO_REMOTE': '1', 06:04:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:04:00 INFO - 'NO_EM_RESTART': '1', 06:04:00 INFO - 'PAGER': '/bin/cat', 06:04:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:04:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:04:00 INFO - 'PWD': '/builds/slave/test', 06:04:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:04:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:04:00 INFO - 'SHELL': '/bin/bash', 06:04:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3TIXSF1mzG/Listeners', 06:04:00 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 06:04:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:04:00 INFO - 'USER': 'cltbld', 06:04:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:04:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:04:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:04:00 INFO - 'XPC_FLAGS': '0x0', 06:04:00 INFO - 'XPC_SERVICE_NAME': '0', 06:04:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:04:00 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/Wk66E6LdQw-MKUCgbORCeA/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0062', '--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 06:04:00 INFO - mozversion application_buildid: 20170216043118 06:04:00 INFO - mozversion application_changeset: 28886b4c135760a6d8aedf7ab7ec8cae5a0c5821 06:04:00 INFO - mozversion application_display_name: FirefoxDeveloperEdition 06:04:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:04:00 INFO - mozversion application_name: Firefox 06:04:00 INFO - mozversion application_remotingname: firefox-dev 06:04:00 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:04:00 INFO - mozversion application_vendor: Mozilla 06:04:00 INFO - mozversion application_version: 53.0a2 06:04:00 INFO - mozversion platform_buildid: 20170216043118 06:04:00 INFO - mozversion platform_changeset: 28886b4c135760a6d8aedf7ab7ec8cae5a0c5821 06:04:00 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:04:00 INFO - mozversion platform_version: 53.0a2 06:04:00 INFO - using testdate: 1487253840 06:04:00 INFO - actual date: 1487253840 06:04:00 INFO - starting webserver on 'localhost:49236' 06:04:00 INFO - SUITE-START | Running 2 tests 06:04:00 INFO - TEST-START | dromaeo_css 06:04:00 INFO - operating with platform_type : mac_ 06:04:00 INFO - Initialising browser for dromaeo_css test... 06:04:00 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/tmpmuLoyg/profile http://localhost:49236/getInfo.html) 06:04:03 INFO - PROCESS | 1636 | 2017-02-16 06:04:03.539 plugin-container[1638:7463] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4953, name = 'com.apple.tsm.portname' 06:04:03 INFO - PROCESS | 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:04:03 INFO - PROCESS | 1636 | 2017-02-16 06:04:03.541 plugin-container[1638:7463] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x931b, name = 'com.apple.CFPasteboardClient' 06:04:03 INFO - PROCESS | 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:04:03 INFO - PROCESS | 1636 | 2017-02-16 06:04:03.541 plugin-container[1638:7463] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:04:03 INFO - PROCESS | 1636 | __metrics Screen width/height:1600/1200 06:04:03 INFO - PROCESS | 1636 | colorDepth:24 06:04:03 INFO - PROCESS | 1636 | Browser inner width/height: 1024/689 06:04:03 INFO - PROCESS | 1636 | __metrics 06:04:03 ERROR - PROCESS | 1636 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 06:04:04 INFO - TEST-INFO | 1636: exit 0 06:04:04 INFO - Browser initialized. 06:04:04 INFO - Running cycle 1/1 for dromaeo_css test... 06:04:04 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/tmpmuLoyg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:04:06 INFO - PROCESS | 1639 | 2017-02-16 06:04:06.813 plugin-container[1640:7586] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8733, name = 'com.apple.tsm.portname' 06:04:06 INFO - PROCESS | 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:04:06 INFO - PROCESS | 1639 | 2017-02-16 06:04:06.814 plugin-container[1640:7586] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c0b, name = 'com.apple.CFPasteboardClient' 06:04:06 INFO - PROCESS | 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:04:06 INFO - PROCESS | 1639 | 2017-02-16 06:04:06.814 plugin-container[1640:7586] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:04:16 INFO - PROCESS | 1639 | RSS: Main: 218738688 06:04:16 INFO - PROCESS | 1639 | 06:07:19 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 06:07:21 INFO - PROCESS | 1639 | RSS: Main: 239267840 06:07:21 INFO - PROCESS | 1639 | 06:09:04 INFO - PROCESS | 1639 | ************************* 06:09:04 INFO - PROCESS | 1639 | A coding exception was thrown and uncaught in a Task. 06:09:04 INFO - PROCESS | 1639 | 06:09:04 ERROR - PROCESS | 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 06:09:04 INFO - PROCESS | 1639 | Full stack: 06:09:04 INFO - PROCESS | 1639 | ************************* 06:10:23 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 06:10:24 INFO - PROCESS | 1639 | RSS: Main: 247713792 06:10:24 INFO - PROCESS | 1639 | 06:13:26 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 06:13:26 INFO - PROCESS | 1639 | RSS: Main: 254021632 06:13:26 INFO - PROCESS | 1639 | 06:16:28 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 06:16:29 INFO - PROCESS | 1639 | RSS: Main: 253448192 06:16:29 INFO - PROCESS | 1639 | 06:19:32 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 06:19:32 INFO - PROCESS | 1639 | RSS: Main: 257560576 06:19:32 INFO - PROCESS | 1639 | 06:22:35 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 06:22:36 INFO - PROCESS | 1639 | RSS: Main: 259792896 06:22:36 INFO - PROCESS | 1639 | 06:22:36 INFO - PROCESS | 1639 | __start_tp_report 06:22:36 INFO - PROCESS | 1639 | _x_x_mozilla_page_load 06:22:36 INFO - PROCESS | 1639 | _x_x_mozilla_page_load_details 06:22:36 INFO - PROCESS | 1639 | |i|pagename|runs| 06:22:36 INFO - PROCESS | 1639 | |0;dojo.html;3429.15985583532;3452.27502224533;3463.8960831175073;3472.496488009239;3473.253250551131;5911.083782013784;5925.733341999609;5937.109433584965;5951.732172052257;6006.4293892080295;5944.940550594492;5972.19375384323;5990.1913241712355;6016.278046634399;6038.758449662008;5112.693238405707;5320.467953204688;5363.329583802025;5418.322709661293;5439.075357189287;4555.794989225493;5148.3564554430695;5441.401445840955;5445.727713614323;5446.7276636168035;5314.867128321785;5344.278522399465;5436.401995780461;5446.863828404282;5517.751701173437;4451.755153466558;5394.244805727201;5423.620346575742;5452.563794896419;5483.396826349099;5295.602829787743;5406.567474602022;5410.729463526847;5415.0523658359625;5451.809186678487;4808.711477311373;5997.790077347272;6031.788887388921;6114.908276375858;6137.969310153465;5271.630985830993;6188.938110618881;6189.752409903598;6207.503399728011;6269.3730626937395;6332.525060620425;6344;6354.078658594524;6359.268684101341;6362.981922892362;6063.514918806485;6099.664518451527;6113.816585502442;6120.816375508742;6131.50947924165;5439.836804895859;6174.197354343906;6312.147860038836;6316.652584107918;6343.904841427382;5570.275864137636;5587.608867379326;6300.1494798202575;6311.621302721759;6327.177466929362;5403.054465468527;6312.652804095727;6331.715072821734;6332.841678958063;6339.96830015847;5188.7405629719115;6120.387961203844;6257.812265632038;6273.529485288622;6283.59156654816;6218.689065546704;6269.279032911182;6284.402981716821;6284.780032698834;6303.873922521524;5089.6691715038405;5094.796208151706;5097.719625420564;5117.206832940826;5121.8719532012;3812;4498.122866041156;4558.997020655451;4568.269076947672;4588.449386073626;6009.969950150221;6034.306054803666;6071.939280607137;6118.101457354478;6118.649636126507;6290.591111577733;6301.4328710416285;6368.10846481493;6379.64911929839;6394.136791533084;5947.988841896888;6016.639001659914;6022.5784195105925;6032.728527216286;6114.419130182626;5573;5587.552995760329;5602.95492145364;5603.971980140154;5621.241132447068;6479.8056058318325;6509.609423434609;6512.185976753;6522.086907833002;6527.445167160655;6177.351378105234;6214.471769899609;6275.623462592259;6293.654147299383;6333.493320534254;5207.921881171861;6268.091126786499;6416.48668106541;6508.902366464602;6552.803415897531;6241.375862413723;6254.8123556293385;6268.091126786681;6272.6236425814595;6274.403931626488;6254;6274.090256912631;6308.495320374267;6309.211348581427;6320.5259605528845;6165.753369865155;6193.4425901669065;6229.844253893689;6294;6294.339094395023;6230.626162430269;6276;6279;6306.306306306211;6308.463780578519;6061.787837425669;6117.235345581802;6152.261728592597;6186.1648677427975;6212.316645169119;5479.589030822624;5542.72286385671;6145.647957449354;6206.131141640084;6233.314335423009;6121.326654068138;6211.937880621136;6215;6218.440340369389;6233 06:22:36 INFO - PROCESS | 1639 | |1;ext.html;415.3375366290765;458.1890054603351;482.74655805702;503.29287351271455;518.377946464243;40930;42017.7899110504;42024.36963445547;42081.57918420811;42093.57906420943;35104.64895351052;36370.908872733795;42208.57791422093;44410.777946110225;44484.33273500892;8492.320614350838;9250.629974801;9430.434173949585;9440.716778496622;9478.857817132748;7929.286364227219;11200.991910728033;11434.656960291162;11469.942650286737;11654.766904661901;11439.313641181556;11464.369459679714;11486.138539609563;11496.482658280398;11525.884741152608;11475.770484590303;11538.884611153864;11542.942285288562;11543;11557.30656160633;11383.03244224242;11452.885471145266;11456.3698996556;11471.713207169887;11499.310041397543;41675.70783606901;41849.95375115616;42020.78989605063;42060;42083.57916420827;3919.7648141111627;3953.2093581283857;3991.341428664267;4004.6395824375654;4062.79686015701;28203.57694634582;29000.564991525145;29815.70184298151;30041.94853180128;30101.698983010327;3108.1763332716846;3151.416987857254;3219.565358676572;3321.5183798349103;3328.6671332866763;506489;509682.35476467514;511514;511808.9999999963;515897;58767.41232587705;59314.40685593175;59314.51713707192;59361.703191483764;59483.40516594865;63043.739125218155;63520.68239658864;63538.0469292961;63851;63866.36133638604;15686.9215653921;16264;16334.918325408296;16335.91832040856;16351.26419311134;10321.225908056926;11301.248306512503;11352.94323528377;11887.40562971848;12586.433610487367;18595.256189752257;19040.61918761617;19045.61908761845;19104.61790764177;19106.52233694169;7739.55773955773;7761.068671759425;7771.805704857424;7783.727569535039;7823.882641760378;852.8464876322197;866.3459088388227;875.8198426694702;876.8684697295457;907.5235501361838;30804.383912322075;30976.53535196974;31145.221369465944;31432.842835785676;31591;1048.2976405808126;1050.4590136079926;1054.9736256593494;1094.3816743539874;1180.4628893853276;14876;15944;16332.918335408247;16435.506934791974;16440.588985275463;237206;237752;238017;238300.80849595988;240621;63447;64274.71450571056;64345;64367;64411.67794160999;1404.6909679870412;1431.8639729225706;1445.3640398224748;1446.2262689461088;1455.097839339595;29938.8503057492;30584.694153058186;30680.539791902695;31079.689203108584;31279.530807037456;54421.91156176933;54739.45260547344;54874.62813429696;54969.45030549643;55061.62345941384;572508;573393;573743;575515;576546.117269411;24834.130805421722;25597.87201063983;25627.97488100455;26322.025848061854;27766.86116569404;42050.94872628209;42511;42668.78665606652;43296;43434.78282608567;34952.65047349494;35356.469652954715;35398.938031859085;35433.291334173686;36529.26941461103;29496.37769922675;30567.694323057374;35367.646323536435;36210.8189459051;36388.09029774277;34603.65396346004;34814.303713926085;34831.82584087063;34855.82572087123;35382.407791648926;28956.84172633071;30541.54187687231;33978.49032264567;33984.830075849466;34284.48573271353;24218.63672044956;24823;25095.24714258575;25379.74620253774;25475.57981991708 06:22:36 INFO - PROCESS | 1639 | |2;jquery.html;370.67010360778903;386.4107236464393;390.00512379180464;396.3638360431508;419.67684882640367;16440.260188291526;19847.702284465726;20353.89823050883;21155.365339039836;21168;20938.685919711217;21287.68068478974;21432.57134857302;21694.457638559044;21968;5342.385625653042;5809.6804675742815;6060.272767267934;6071.969640151815;6122.173506576622;5297.496737809902;5619.80330688426;5727.284089488814;5928.49607783339;5951.196588460567;5785.132230165466;5975.85060373492;5981.252343457068;5984.491318237955;5994.220751302347;5631.1271752878165;5862.618929769594;5947.434993675594;5962.493188079018;5963.344032156481;5212.192110222922;5215.6349055566125;5221;5223.320968274138;5236.738163091868;21149.15403383863;23697;25152.49695006108;25161.62257566138;25866.61200082;2744.245332533549;2805.3968396794585;2807.354308509034;2843.672977607581;2845.8434786086755;9544.141027307576;9882.456464894429;10295.794084118275;10475.057244847923;15621.453249136339;1821.826926441986;1860.9720854187199;1862.850971922243;1868.5235265007336;1892.233645373626;135936;136634;138516.30741846326;141564.29217853845;143974;11885.762284754257;11979.041676665845;12054.216475929037;12198.451069701885;12205.20666156697;14008.019438639198;14489.347979340955;15627.531174064796;15655.295511702001;15656.765148522782;8525.74422767318;8681.392302538889;8883.244924181388;8926.973398059306;8976;7590.203028682019;8362.916370836214;8467.237948584658;8662.480251184948;8740.694075707446;4190.114448498188;4751.83368582098;4775.2359622460235;4839.080574690797;4894.583960363338;1977.7626684797917;2028.097496614022;2033.6136134134467;2034.4100210938957;2045.795420457972;786.929176374129;1021.0096206679509;1023.6263763726187;1044.2846650044744;1062.4687656171914;19903.900480497505;20101.798982010285;20534.79465205329;20582.794172058388;20707.96460176985;1024.8155332040305;1033.9741506462249;1057.7302787789217;1064.2762921213648;1065.1957771882335;10370;10916.56333746657;10956.013958743752;10982;10983.121350291958;753227;767359;773738;775156;779815;141138.2943085278;142136;145071;145439;145625.27187364208;945.0832692288469;974.3520558828442;995.7062666513395;999.2555546118043;1007;15774.763378549102;18069.457916262534;18389.448316550526;18676.906615466836;18857.528561786065;53013.734931325096;57348.42651573431;57797;58828.70585647044;61513.077303839586;80857.59571202342;81786;82129.58935205286;82291;82739.58630207051;6620;7966.880496792669;8012.679492820455;8476.618552165291;8528.658853646033;9174.403663761834;11789.587364442546;12603.369831508204;12933.09468337245;13031.804522931974;10901.692756910468;10980.670579882617;11116.277441966246;11276.94361528187;11411.201215915138;8993.010768815557;10490.580376785148;10933.781324373627;10963.780724385308;11140.05309548665;9384.873815142226;10064.590957266135;10184.134348580454;10213.591456341961;11425.942870285928;7160.391366733886;7342.229065947999;7519.849603008019;7722.961385193263;8435.240828325235;9308.860367094634;9820.4107753535;11131.888681113085;11251.49368278413;11257.324560526395 06:22:36 INFO - PROCESS | 1639 | |3;mootools.html;1246.781813182693;1277.067740549399;1427.536050783495;1449.6593300574357;1452.3609611770826;6849.589024658524;7601.20187380324;7893.526388416684;8663.523506207164;8684.175003374685;7258.782236532912;8149.592520373973;8396.62215200316;8446.535440550768;8552.828943421144;2088.9868413819286;2225.2545397291847;2321;2340.578695834749;2355.5171189906027;2090.341542414135;2308.549832782608;2365.6333268343433;2372.8457650252676;2375.58427275227;2115.175081718131;2260.1750361118156;2338.918137865175;2343.8828058597087;2348.847324923883;2317.5480781247666;2329.301209637111;2337.91817286395;2340.5201933603657;2349.424391024193;2315.583195024895;2319.617263151578;2379.428937055094;2380.1788383007834;2390.0798192695765;8584.356173287028;8595.828083438359;8659.740207793777;8677.088905664878;8691.695790647296;5180.430152683201;5297.258383826267;5314.016906872241;5330.893382132335;5336.866578335534;3515.5078289039297;3552.1652411683235;3557.5197348358156;3587.712982961357;3610.3862343401424;1225.540422341622;1238.7150955280247;1266.949322027118;1268.6003908768707;1291.2639795316672;10998.560057597686;11054.502547385388;11119.166062545342;11161.162912781574;11184.776304473946;4442.844500442534;4748.691335063209;4789.473157952622;4806.759662016885;4819.397575303087;9684.854727179098;9737.610495580238;9749.220062395134;9782.75543111428;9783.804323913482;5325.8402247931845;5368.0605893968395;5373;5374.6506477078865;5376.435474275223;4723.527647235318;4820.638452116105;4825.276208568743;4873.926891096637;4940.802367905316;3363.814990175515;3891.2606604745006;3961.1087505311652;4002.079521709965;4022.2905265262148;1182.3024415594841;1231.58741821489;1272.8154417609394;1291.1930043722673;1302.1275745250705;760.1296515489734;778.1401551285861;802.1096582793095;824.8556502612018;858.9484630922165;5614.157876318585;5681.261436013375;5701.144828275792;5837.7157025454335;5875.441833025856;981.3866333541537;988.1579468493882;1010.9443980581138;1025.3540269630084;1037.190991027;3685.576158741779;3866.5940076292145;3932.2332145231976;3999.5800440953863;4007.599240075969;9738.513074346254;10275.434851083262;10276.743081422876;10277.7430564235;10288.948555257326;9893.653722119836;10127.493625318704;10183.643572474928;10194.133498652549;10346.965303469593;7857.371410287164;7928.365730741527;7963.522188668582;8017.639206235734;8025.197480251928;5409.486098820606;5433.375161856279;5569.749361278833;5595.356533998643;5696.601237913472;9370.484623345508;9375.906240937777;9437.009114042927;9464.006279340845;9469.905300947177;9201.815963680823;9640.276979226446;9724.367916085432;9739.41563506192;9747.512624368612;6124.510039196943;6994.475414343843;7079.575225486487;7082.0793296873135;7089.929100709133;7825.33484653788;7924.247196516321;7940.92059079425;7996.760097197093;8019.837123616926;6379.93620063812;7156.3917067047805;7186.496945213994;7267.127944646676;7293.598852063187;7151.892721609076;7166.928330716626;7194.640267986684;7212.7475538358;7344.522606030591;6377.688038353628;6424.710888010144;6451.903221451588;6454.774082907075;6455.709493072729;4910.312556242057;4914.803407863646;4952.133376659142;5097.413797413196;5198;5013.649044566845;5015.247712843103;5118.513741194581;5257.947420525746;5302.1781623848365 06:22:36 INFO - PROCESS | 1639 | |4;prototype.html;284.23257205545036;354.11471321695745;357.93378225028374;364.81394488810713;370.1782043862624;5008.197049062334;5171.818986335475;5448.264484294619;5462.770876552773;5481.972590137048;4420.557944205586;4476.932846007313;5196;5214.193638643792;5297.814576489824;3520.3839328117606;3790.7346485746007;4242.533321334666;4245.554216807237;4294.656427485794;3880.7865567393783;3899.2120633746867;3908.843646254161;4261.1450328280125;4273.0130489322455;4076.1657254235565;4141.730787498818;4174.70777045607;4214.388913607525;4261.403403523509;3768.811559422018;3968.6825053995613;4162.41726158338;4184.979075104605;4191.497020357546;3312.565264530568;3323.7839540429795;3606.855725770966;3705.7220708446976;3767.0017445377;4328.956710432918;4574.970631607862;4972.403311602595;5121.82073627425;5162.5095615916425;4716.95283047172;4897.755112244409;4905.8773530661665;4907.656464047518;4913.26301054841;5385.434529374398;5571.415001424833;5698.6580805151825;5714.914276285859;5741.856453588652;3355.4295769719206;3637.399829028207;3639.581448133472;3812.866549670748;3868.497095377583;5702.236523894251;5847.941520584783;5999.190109335227;6000.399960004008;6107.694615269219;3708.9072773180887;3844.5386553613744;3955.782431966212;3963.5334926077535;3993.4608827808456;4045.615666511677;4060.715749897479;4068.613481719232;4091.734037287567;4096.344584866407;3869.806509674505;3949.9802500987885;4363.716358436692;4583.052202813858;4695.906081878344;4696.060787842445;5762.74067666956;5795.362510123968;5803.6807975560905;5919.974417396126;1115.3865374044244;1136.6817291158488;1214.8276912779033;1243.8569564500199;1317.6639956811143;740.3632875726871;845.7166849105496;851.4082712514743;882.4572887674162;887.8135591525722;4857.587105096107;4885.6289160479155;5179.119549676564;5190.976992830587;5248.422673505911;5075.543201111917;5316.255724198615;5441.129419292974;5668.659880407189;5686.857828554236;4248.957510424918;4532.2979878633105;4838.443578988391;5140.920406714557;5146.279520867081;2565.5125526149973;2938.912602337149;2952.099609619087;2952.822830630169;2978.7914845960577;5056.797728090835;5290.206469029599;5454.4545545445135;5855.853603659943;5872.911906321408;5411.621186516984;5436.6194366393975;5776.696361210925;5796.246487956539;5796.594238403356;5186.662866913639;5848.415158484203;5903.409659034062;5903.852403689943;5910.527157827363;5290.910090514149;5540.556755459473;5541.362743284412;5649.71751412436;5656.717164141859;4630.398048253705;4779.569838714532;4786.95213047865;5148.459411761711;5517.0138750050755;4812.927806082982;5232.450592687713;5746.678263999387;5815.185873977562;5818.796342128006;3219.3400352927124;3461.72476990911;3681.8159092044757;3737.8133791732143;3760.8683696070507;4611.893145645088;5161.509656582619;5286.81496147633;5584.916226256528;5612.326520817528;5062.392512898476;5388.46115388458;5447.346318441812;5461.644993075437;5500.3949565548555;4033.515978082649;4739.786709598007;4945.23348880924;5245.580353571781;5384.21928820311;4926.595920162737;5173.301604283373;5259.687715407543;5356.491133342326;5445.945540544544;5584.944150558443;5656.236408084856;5697.262334987703;5716.571257155647;5788.363280039108;4991.675541089818;5411.594130440311;5606.215129881738;5633.549316054624;5634.718264086698 06:22:36 INFO - PROCESS | 1639 | |5;yui.html;695.5861262548788;696.8292768271774;759.9088109426868;783.3889566138411;837.9874301885471;13211.537596184135;14645.487407940724;15358.846411535882;15551.455699050535;15619.21903904806;13309.933450332735;14313.78529322061;14517.49188778393;14517.78223326651;14531.491397801079;879.4459490520978;889.6130183370223;898.0884402331639;901.9233365163936;902.3367824648877;888.9777755556098;889.977750556238;891.2647066170402;894.8702438146465;894.995525022374;894.3560636341856;923.0630909626734;923.3905622289291;926.5089502563618;927.211869910574;915.8671992561108;919.843626583479;920.2867777472445;920.7513971227764;921.2399770189587;684.165318311659;697.7313734212314;697.7767114523355;698.6436917172279;699.8635266123108;9552.808943821085;11317.717057073556;11474.368909709963;13618.591442256748;13699;11729.472173752201;12239.32683702396;12727.23636581808;12754;12823.294718790463;12470.561403334783;12503.937480312632;12562.623121306375;12971.740565188738;13135.474581016748;4289.378040184156;4393.934090988638;4406.471223453174;4475.9481521842345;4602.631789456836;111284;113416;114747.42626286815;117121;118022;9533;10324.638637647646;10574.735631609117;10693.411862347646;10749.40878251688;20965.79034209669;21177.470563236042;21181.78818211798;21199;21226.044827982776;7489.3634041106025;7587.203343648947;7595.3164215220895;7650.655720492591;7741.303282704584;4148.128892932457;4172.7913604319665;4241.660667146621;4286.87139385819;4301.978490107529;3461.9653803461642;3502.036939841564;3530.0998245447245;3537.451694987281;3537.7877327360443;640.4876099120685;672.5561129654404;673.845015646404;676.2257215488337;683.6205905722372;513.4223998002248;537.1388140094591;542.4087744358668;546.2980070609327;548.9835304940858;9201;9627.181689556466;9646.807063858683;9861.408315501092;10108.342957707726;622.6886556721639;640.3628389752133;652.4063102576632;653.3433898931544;665.2648823050556;4415.40392047076;4461.910761784746;4667.109265846924;4688.2733176357715;4774.090363854486;105840;106855;107230.46384768182;107539;107976.46011769891;63753;65237;65246;78975.8153627696;93431;63899.4025149375;65626.67186664132;74592.64333105023;75190.4961900759;78924;7675.808104797425;8488.854004709532;8897.955510222408;8930.687425940061;8936;52538.73730631475;52581.21128183004;53070.73464632652;54048;54182.729086355896;47186.056278874916;62335.688321558104;62900.68549657222;69822.65088674524;72068.27931720826;10684.358938463716;10760.3543787373;10879.129669626253;11083.501242443948;11338;11782.410879456163;11881.405929703307;12020;12178.269303841798;14039.50861719835;13183.934080329536;13383.330833458094;13737.725245494834;14023.298835058411;14073.655961894754;13181.340932953506;13238.867611323763;13418.93290533541;13744.518941836988;13755.931220343835;12964.416601252778;13611.327306471987;13613.52352667652;13729.588112356645;13997.300134993413;10613;11074.778504429705;11185.566238729847;11319.320840749582;11475.655730328104;9522.14300712939;10984.615538456115;11074.889251107386;11354.716132096433;11431.485583148944 06:22:36 INFO - PROCESS | 1639 | __end_tp_report 06:22:36 INFO - PROCESS | 1639 | __start_cc_report 06:22:36 INFO - PROCESS | 1639 | _x_x_mozilla_cycle_collect,392 06:22:36 INFO - PROCESS | 1639 | __end_cc_report 06:22:36 INFO - PROCESS | 1639 | __startTimestamp1487254956147__endTimestamp 06:22:36 INFO - PROCESS | 1639 | 06:22:36 INFO - PROCESS | 1639 | ------- Summary: start ------- 06:22:36 INFO - PROCESS | 1639 | Number of tests: 6 06:22:36 INFO - PROCESS | 1639 | 06:22:36 INFO - PROCESS | 1639 | [#0] dojo.html Cycles:165 Average:5839.77 Median:6118.65 stddev:661.38 (10.8%) stddev-sans-first:635.79 06:22:36 INFO - PROCESS | 1639 | Values: 3429.2 3452.3 3463.9 3472.5 3473.3 5911.1 5925.7 5937.1 5951.7 6006.4 5944.9 5972.2 5990.2 6016.3 6038.8 5112.7 5320.5 5363.3 5418.3 5439.1 4555.8 5148.4 5441.4 5445.7 5446.7 5314.9 5344.3 5436.4 5446.9 5517.8 4451.8 5394.2 5423.6 5452.6 5483.4 5295.6 5406.6 5410.7 5415.1 5451.8 4808.7 5997.8 6031.8 6114.9 6138.0 5271.6 6188.9 6189.8 6207.5 6269.4 6332.5 6344.0 6354.1 6359.3 6363.0 6063.5 6099.7 6113.8 6120.8 6131.5 5439.8 6174.2 6312.1 6316.7 6343.9 5570.3 5587.6 6300.1 6311.6 6327.2 5403.1 6312.7 6331.7 6332.8 6340.0 5188.7 6120.4 6257.8 6273.5 6283.6 6218.7 6269.3 6284.4 6284.8 6303.9 5089.7 5094.8 5097.7 5117.2 5121.9 3812.0 4498.1 4559.0 4568.3 4588.4 6010.0 6034.3 6071.9 6118.1 6118.6 6290.6 6301.4 6368.1 6379.6 6394.1 5948.0 6016.6 6022.6 6032.7 6114.4 5573.0 5587.6 5603.0 5604.0 5621.2 6479.8 6509.6 6512.2 6522.1 6527.4 6177.4 6214.5 6275.6 6293.7 6333.5 5207.9 6268.1 6416.5 6508.9 6552.8 6241.4 6254.8 6268.1 6272.6 6274.4 6254.0 6274.1 6308.5 6309.2 6320.5 6165.8 6193.4 6229.8 6294.0 6294.3 6230.6 6276.0 6279.0 6306.3 6308.5 6061.8 6117.2 6152.3 6186.2 6212.3 5479.6 5542.7 6145.6 6206.1 6233.3 6121.3 6211.9 6215.0 6218.4 6233.0 06:22:36 INFO - PROCESS | 1639 | 06:22:36 INFO - PROCESS | 1639 | [#1] ext.html Cycles:180 Average:59649.27 Median:34444.07 stddev:124167.19 (360.5%) stddev-sans-first:124435.86 06:22:36 INFO - PROCESS | 1639 | Values: 415.3 458.2 482.7 503.3 518.4 40930.0 42017.8 42024.4 42081.6 42093.6 35104.6 36370.9 42208.6 44410.8 44484.3 8492.3 9250.6 9430.4 9440.7 9478.9 7929.3 11201.0 11434.7 11469.9 11654.8 11439.3 11464.4 11486.1 11496.5 11525.9 11475.8 11538.9 11542.9 11543.0 11557.3 11383.0 11452.9 11456.4 11471.7 11499.3 41675.7 41850.0 42020.8 42060.0 42083.6 3919.8 3953.2 3991.3 4004.6 4062.8 28203.6 29000.6 29815.7 30041.9 30101.7 3108.2 3151.4 3219.6 3321.5 3328.7 506489.0 509682.4 511514.0 511809.0 515897.0 58767.4 59314.4 59314.5 59361.7 59483.4 63043.7 63520.7 63538.0 63851.0 63866.4 15686.9 16264.0 16334.9 16335.9 16351.3 10321.2 11301.2 11352.9 11887.4 12586.4 18595.3 19040.6 19045.6 19104.6 19106.5 7739.6 7761.1 7771.8 7783.7 7823.9 852.8 866.3 875.8 876.9 907.5 30804.4 30976.5 31145.2 31432.8 31591.0 1048.3 1050.5 1055.0 1094.4 1180.5 14876.0 15944.0 16332.9 16435.5 16440.6 237206.0 237752.0 238017.0 238300.8 240621.0 63447.0 64274.7 64345.0 64367.0 64411.7 1404.7 1431.9 1445.4 1446.2 1455.1 29938.9 30584.7 30680.5 31079.7 31279.5 54421.9 54739.5 54874.6 54969.5 55061.6 572508.0 573393.0 573743.0 575515.0 576546.1 24834.1 25597.9 25628.0 26322.0 27766.9 42050.9 42511.0 42668.8 43296.0 43434.8 34952.7 35356.5 35398.9 35433.3 36529.3 29496.4 30567.7 35367.6 36210.8 36388.1 34603.7 34814.3 34831.8 34855.8 35382.4 28956.8 30541.5 33978.5 33984.8 34284.5 24218.6 24823.0 25095.2 25379.7 25475.6 06:22:36 INFO - PROCESS | 1639 | 06:22:36 INFO - PROCESS | 1639 | [#2] jquery.html Cycles:180 Average:41004.66 Median:25157.06 stddev:127972.36 (508.7%) stddev-sans-first:128294.98 06:22:36 INFO - PROCESS | 1639 | Values: 370.7 386.4 390.0 396.4 419.7 16440.3 19847.7 20353.9 21155.4 21168.0 20938.7 21287.7 21432.6 21694.5 21968.0 5342.4 5809.7 6060.3 6072.0 6122.2 5297.5 5619.8 5727.3 5928.5 5951.2 5785.1 5975.9 5981.3 5984.5 5994.2 5631.1 5862.6 5947.4 5962.5 5963.3 5212.2 5215.6 5221.0 5223.3 5236.7 21149.2 23697.0 25152.5 25161.6 25866.6 2744.2 2805.4 2807.4 2843.7 2845.8 9544.1 9882.5 10295.8 10475.1 15621.5 1821.8 1861.0 1862.9 1868.5 1892.2 135936.0 136634.0 138516.3 141564.3 143974.0 11885.8 11979.0 12054.2 12198.5 12205.2 14008.0 14489.3 15627.5 15655.3 15656.8 8525.7 8681.4 8883.2 8927.0 8976.0 7590.2 8362.9 8467.2 8662.5 8740.7 4190.1 4751.8 4775.2 4839.1 4894.6 1977.8 2028.1 2033.6 2034.4 2045.8 786.9 1021.0 1023.6 1044.3 1062.5 19903.9 20101.8 20534.8 20582.8 20708.0 1024.8 1034.0 1057.7 1064.3 1065.2 10370.0 10916.6 10956.0 10982.0 10983.1 753227.0 767359.0 773738.0 775156.0 779815.0 141138.3 142136.0 145071.0 145439.0 145625.3 945.1 974.4 995.7 999.3 1007.0 15774.8 18069.5 18389.4 18676.9 18857.5 53013.7 57348.4 57797.0 58828.7 61513.1 80857.6 81786.0 82129.6 82291.0 82739.6 6620.0 7966.9 8012.7 8476.6 8528.7 9174.4 11789.6 12603.4 12933.1 13031.8 10901.7 10980.7 11116.3 11276.9 11411.2 8993.0 10490.6 10933.8 10963.8 11140.1 9384.9 10064.6 10184.1 10213.6 11425.9 7160.4 7342.2 7519.8 7723.0 8435.2 9308.9 9820.4 11131.9 11251.5 11257.3 06:22:36 INFO - PROCESS | 1639 | 06:22:36 INFO - PROCESS | 1639 | [#3] mootools.html Cycles:180 Average:5517.48 Median:5277.60 stddev:3018.80 (57.2%) stddev-sans-first:3010.20 06:22:36 INFO - PROCESS | 1639 | Values: 1246.8 1277.1 1427.5 1449.7 1452.4 6849.6 7601.2 7893.5 8663.5 8684.2 7258.8 8149.6 8396.6 8446.5 8552.8 2089.0 2225.3 2321.0 2340.6 2355.5 2090.3 2308.5 2365.6 2372.8 2375.6 2115.2 2260.2 2338.9 2343.9 2348.8 2317.5 2329.3 2337.9 2340.5 2349.4 2315.6 2319.6 2379.4 2380.2 2390.1 8584.4 8595.8 8659.7 8677.1 8691.7 5180.4 5297.3 5314.0 5330.9 5336.9 3515.5 3552.2 3557.5 3587.7 3610.4 1225.5 1238.7 1266.9 1268.6 1291.3 10998.6 11054.5 11119.2 11161.2 11184.8 4442.8 4748.7 4789.5 4806.8 4819.4 9684.9 9737.6 9749.2 9782.8 9783.8 5325.8 5368.1 5373.0 5374.7 5376.4 4723.5 4820.6 4825.3 4873.9 4940.8 3363.8 3891.3 3961.1 4002.1 4022.3 1182.3 1231.6 1272.8 1291.2 1302.1 760.1 778.1 802.1 824.9 858.9 5614.2 5681.3 5701.1 5837.7 5875.4 981.4 988.2 1010.9 1025.4 1037.2 3685.6 3866.6 3932.2 3999.6 4007.6 9738.5 10275.4 10276.7 10277.7 10288.9 9893.7 10127.5 10183.6 10194.1 10347.0 7857.4 7928.4 7963.5 8017.6 8025.2 5409.5 5433.4 5569.7 5595.4 5696.6 9370.5 9375.9 9437.0 9464.0 9469.9 9201.8 9640.3 9724.4 9739.4 9747.5 6124.5 6994.5 7079.6 7082.1 7089.9 7825.3 7924.2 7940.9 7996.8 8019.8 6379.9 7156.4 7186.5 7267.1 7293.6 7151.9 7166.9 7194.6 7212.7 7344.5 6377.7 6424.7 6451.9 6454.8 6455.7 4910.3 4914.8 4952.1 5097.4 5198.0 5013.6 5015.2 5118.5 5257.9 5302.2 06:22:36 INFO - PROCESS | 1639 | 06:22:36 INFO - PROCESS | 1639 | [#4] prototype.html Cycles:180 Average:4492.80 Median:4999.94 stddev:1372.48 (27.4%) stddev-sans-first:1339.48 06:22:36 INFO - PROCESS | 1639 | Values: 284.2 354.1 357.9 364.8 370.2 5008.2 5171.8 5448.3 5462.8 5482.0 4420.6 4476.9 5196.0 5214.2 5297.8 3520.4 3790.7 4242.5 4245.6 4294.7 3880.8 3899.2 3908.8 4261.1 4273.0 4076.2 4141.7 4174.7 4214.4 4261.4 3768.8 3968.7 4162.4 4185.0 4191.5 3312.6 3323.8 3606.9 3705.7 3767.0 4329.0 4575.0 4972.4 5121.8 5162.5 4717.0 4897.8 4905.9 4907.7 4913.3 5385.4 5571.4 5698.7 5714.9 5741.9 3355.4 3637.4 3639.6 3812.9 3868.5 5702.2 5847.9 5999.2 6000.4 6107.7 3708.9 3844.5 3955.8 3963.5 3993.5 4045.6 4060.7 4068.6 4091.7 4096.3 3869.8 3950.0 4363.7 4583.1 4695.9 4696.1 5762.7 5795.4 5803.7 5920.0 1115.4 1136.7 1214.8 1243.9 1317.7 740.4 845.7 851.4 882.5 887.8 4857.6 4885.6 5179.1 5191.0 5248.4 5075.5 5316.3 5441.1 5668.7 5686.9 4249.0 4532.3 4838.4 5140.9 5146.3 2565.5 2938.9 2952.1 2952.8 2978.8 5056.8 5290.2 5454.5 5855.9 5872.9 5411.6 5436.6 5776.7 5796.2 5796.6 5186.7 5848.4 5903.4 5903.9 5910.5 5290.9 5540.6 5541.4 5649.7 5656.7 4630.4 4779.6 4787.0 5148.5 5517.0 4812.9 5232.5 5746.7 5815.2 5818.8 3219.3 3461.7 3681.8 3737.8 3760.9 4611.9 5161.5 5286.8 5584.9 5612.3 5062.4 5388.5 5447.3 5461.6 5500.4 4033.5 4739.8 4945.2 5245.6 5384.2 4926.6 5173.3 5259.7 5356.5 5445.9 5584.9 5656.2 5697.3 5716.6 5788.4 4991.7 5411.6 5606.2 5633.5 5634.7 06:22:36 INFO - PROCESS | 1639 | 06:22:36 INFO - PROCESS | 1639 | [#5] yui.html Cycles:180 Average:19904.13 Median:4410.94 stddev:29320.35 (664.7%) stddev-sans-first:29367.13 06:22:36 INFO - PROCESS | 1639 | Values: 695.6 696.8 759.9 783.4 838.0 13211.5 14645.5 15358.8 15551.5 15619.2 13309.9 14313.8 14517.5 14517.8 14531.5 879.4 889.6 898.1 901.9 902.3 889.0 890.0 891.3 894.9 895.0 894.4 923.1 923.4 926.5 927.2 915.9 919.8 920.3 920.8 921.2 684.2 697.7 697.8 698.6 699.9 9552.8 11317.7 11474.4 13618.6 13699.0 11729.5 12239.3 12727.2 12754.0 12823.3 12470.6 12503.9 12562.6 12971.7 13135.5 4289.4 4393.9 4406.5 4475.9 4602.6 111284.0 113416.0 114747.4 117121.0 118022.0 9533.0 10324.6 10574.7 10693.4 10749.4 20965.8 21177.5 21181.8 21199.0 21226.0 7489.4 7587.2 7595.3 7650.7 7741.3 4148.1 4172.8 4241.7 4286.9 4302.0 3462.0 3502.0 3530.1 3537.5 3537.8 640.5 672.6 673.8 676.2 683.6 513.4 537.1 542.4 546.3 549.0 9201.0 9627.2 9646.8 9861.4 10108.3 622.7 640.4 652.4 653.3 665.3 4415.4 4461.9 4667.1 4688.3 4774.1 105840.0 106855.0 107230.5 107539.0 107976.5 63753.0 65237.0 65246.0 78975.8 93431.0 63899.4 65626.7 74592.6 75190.5 78924.0 7675.8 8488.9 8898.0 8930.7 8936.0 52538.7 52581.2 53070.7 54048.0 54182.7 47186.1 62335.7 62900.7 69822.7 72068.3 10684.4 10760.4 10879.1 11083.5 11338.0 11782.4 11881.4 12020.0 12178.3 14039.5 13183.9 13383.3 13737.7 14023.3 14073.7 13181.3 13238.9 13418.9 13744.5 13755.9 12964.4 13611.3 13613.5 13729.6 13997.3 10613.0 11074.8 11185.6 11319.3 11475.7 9522.1 10984.6 11074.9 11354.7 11431.5 06:22:36 INFO - PROCESS | 1639 | -------- Summary: end -------- 06:22:36 INFO - PROCESS | 1639 | 06:22:36 INFO - TEST-INFO | 1639: exit 0 06:22:36 INFO - TEST-OK | dromaeo_css | took 1116241ms 06:22:36 INFO - TEST-START | kraken 06:22:36 INFO - operating with platform_type : mac_ 06:22:36 INFO - Initialising browser for kraken test... 06:22:36 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/tmpozM1IL/profile http://localhost:49236/getInfo.html) 06:22:39 INFO - PROCESS | 1651 | 2017-02-16 06:22:39.504 plugin-container[1652:9875] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a43, name = 'com.apple.tsm.portname' 06:22:39 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:22:39 INFO - PROCESS | 1651 | 2017-02-16 06:22:39.507 plugin-container[1652:9875] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4807, name = 'com.apple.CFPasteboardClient' 06:22:39 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:22:39 INFO - PROCESS | 1651 | 2017-02-16 06:22:39.507 plugin-container[1652:9875] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:22:39 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 06:22:39 INFO - PROCESS | 1651 | colorDepth:24 06:22:39 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 06:22:39 INFO - PROCESS | 1651 | __metrics 06:22:39 ERROR - PROCESS | 1651 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 06:22:40 INFO - TEST-INFO | 1651: exit 0 06:22:40 INFO - Browser initialized. 06:22:40 INFO - Running cycle 1/1 for kraken test... 06:22:40 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/tmpozM1IL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:22:42 INFO - PROCESS | 1653 | 2017-02-16 06:22:42.589 plugin-container[1654:10003] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x454f, name = 'com.apple.tsm.portname' 06:22:42 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:22:42 INFO - PROCESS | 1653 | 2017-02-16 06:22:42.592 plugin-container[1654:10003] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4717, name = 'com.apple.CFPasteboardClient' 06:22:42 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:22:42 INFO - PROCESS | 1653 | 2017-02-16 06:22:42.592 plugin-container[1654:10003] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:22:52 INFO - PROCESS | 1653 | RSS: Main: 219070464 06:22:52 INFO - PROCESS | 1653 | 06:22:55 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 06:22:56 INFO - PROCESS | 1653 | RSS: Main: 232857600 06:22:56 INFO - PROCESS | 1653 | 06:22:58 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 06:22:59 INFO - PROCESS | 1653 | RSS: Main: 240889856 06:22:59 INFO - PROCESS | 1653 | 06:23:02 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 06:23:03 INFO - PROCESS | 1653 | RSS: Main: 244633600 06:23:03 INFO - PROCESS | 1653 | 06:23:05 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 06:23:06 INFO - PROCESS | 1653 | RSS: Main: 245645312 06:23:06 INFO - PROCESS | 1653 | 06:23:08 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:23:08 INFO - PROCESS | 1653 | RSS: Main: 246386688 06:23:08 INFO - PROCESS | 1653 | 06:23:11 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 06:23:12 INFO - PROCESS | 1653 | RSS: Main: 250507264 06:23:12 INFO - PROCESS | 1653 | 06:23:15 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 06:23:16 INFO - PROCESS | 1653 | RSS: Main: 249700352 06:23:16 INFO - PROCESS | 1653 | 06:23:19 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 06:23:20 INFO - PROCESS | 1653 | RSS: Main: 249708544 06:23:20 INFO - PROCESS | 1653 | 06:23:21 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:23:22 INFO - PROCESS | 1653 | RSS: Main: 248836096 06:23:22 INFO - PROCESS | 1653 | 06:23:24 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:23:24 INFO - PROCESS | 1653 | RSS: Main: 248889344 06:23:24 INFO - PROCESS | 1653 | 06:23:27 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:23:27 INFO - PROCESS | 1653 | RSS: Main: 248954880 06:23:27 INFO - PROCESS | 1653 | 06:23:30 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:23:31 INFO - PROCESS | 1653 | RSS: Main: 249249792 06:23:31 INFO - PROCESS | 1653 | 06:23:34 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:23:35 INFO - PROCESS | 1653 | RSS: Main: 249114624 06:23:35 INFO - PROCESS | 1653 | 06:23:36 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 06:23:37 INFO - PROCESS | 1653 | RSS: Main: 251031552 06:23:37 INFO - PROCESS | 1653 | 06:23:37 INFO - PROCESS | 1653 | __start_tp_report 06:23:37 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 06:23:37 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 06:23:37 INFO - PROCESS | 1653 | |i|pagename|runs| 06:23:37 INFO - PROCESS | 1653 | |0;ai-astar;106;119;119;121;119;119;121;114;120;120 06:23:37 INFO - PROCESS | 1653 | |1;audio-beat-detection;181;133;112;149;111;114;113;114;131;139 06:23:37 INFO - PROCESS | 1653 | |2;audio-dft;200;230;278;198;197;198;196;196;198;192 06:23:37 INFO - PROCESS | 1653 | |3;audio-fft;83;58;60;87;86;79;61;59;71;53 06:23:37 INFO - PROCESS | 1653 | |4;audio-oscillator;89;73;71;99;100;104;99;71;72;83 06:23:37 INFO - PROCESS | 1653 | |5;imaging-gaussian-blur;107;83;83;131;117;135;90;132;78;102 06:23:37 INFO - PROCESS | 1653 | |6;imaging-darkroom;100;100;101;113;101;115;175;113;177;120 06:23:37 INFO - PROCESS | 1653 | |7;imaging-desaturate;77;147;148;104;76;91;121;141;144;148 06:23:37 INFO - PROCESS | 1653 | |8;json-parse-financial;56;55;54;55;61;59;59;59;59;60 06:23:37 INFO - PROCESS | 1653 | |9;json-stringify-tinderbox;69;73;70;84;92;73;70;69;93;104 06:23:37 INFO - PROCESS | 1653 | |10;stanford-crypto-aes;82;76;99;104;103;105;76;73;105;104 06:23:37 INFO - PROCESS | 1653 | |11;stanford-crypto-ccm;140;140;138;137;138;139;142;146;193;141 06:23:37 INFO - PROCESS | 1653 | |12;stanford-crypto-pbkdf2;168;194;230;197;168;167;168;172;167;167 06:23:37 INFO - PROCESS | 1653 | |13;stanford-crypto-sha256-iterative;68;68;66;67;67;66;91;89;85;80 06:23:37 INFO - PROCESS | 1653 | __end_tp_report 06:23:37 INFO - PROCESS | 1653 | __start_cc_report 06:23:37 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,969 06:23:37 INFO - PROCESS | 1653 | __end_cc_report 06:23:37 INFO - PROCESS | 1653 | __startTimestamp1487255017100__endTimestamp 06:23:37 INFO - PROCESS | 1653 | 06:23:37 INFO - PROCESS | 1653 | ------- Summary: start ------- 06:23:37 INFO - PROCESS | 1653 | Number of tests: 14 06:23:37 INFO - PROCESS | 1653 | 06:23:37 INFO - PROCESS | 1653 | [#0] ai-astar Cycles:10 Average:117.80 Median:119.50 stddev:4.59 (3.8%) stddev-sans-first:2.09 06:23:37 INFO - PROCESS | 1653 | Values: 106.0 119.0 119.0 121.0 119.0 119.0 121.0 114.0 120.0 120.0 06:23:37 INFO - PROCESS | 1653 | 06:23:37 INFO - PROCESS | 1653 | [#1] audio-beat-detection Cycles:10 Average:129.70 Median:132.00 stddev:22.46 (17.0%) stddev-sans-first:14.20 06:23:37 INFO - PROCESS | 1653 | Values: 181.0 133.0 112.0 149.0 111.0 114.0 113.0 114.0 131.0 139.0 06:23:37 INFO - PROCESS | 1653 | 06:23:37 INFO - PROCESS | 1653 | [#2] audio-dft Cycles:10 Average:208.30 Median:198.00 stddev:26.69 (13.5%) stddev-sans-first:28.14 06:23:37 INFO - PROCESS | 1653 | Values: 200.0 230.0 278.0 198.0 197.0 198.0 196.0 196.0 198.0 192.0 06:23:37 INFO - PROCESS | 1653 | 06:23:37 INFO - PROCESS | 1653 | [#3] audio-fft Cycles:10 Average:69.70 Median:75.00 stddev:13.04 (17.4%) stddev-sans-first:12.91 06:23:37 INFO - PROCESS | 1653 | Values: 83.0 58.0 60.0 87.0 86.0 79.0 61.0 59.0 71.0 53.0 06:23:37 INFO - PROCESS | 1653 | 06:23:37 INFO - PROCESS | 1653 | [#4] audio-oscillator Cycles:10 Average:86.10 Median:78.00 stddev:13.71 (17.6%) stddev-sans-first:14.50 06:23:37 INFO - PROCESS | 1653 | Values: 89.0 73.0 71.0 99.0 100.0 104.0 99.0 71.0 72.0 83.0 06:23:37 INFO - PROCESS | 1653 | 06:23:37 INFO - PROCESS | 1653 | [#5] imaging-gaussian-blur Cycles:10 Average:105.80 Median:106.50 stddev:22.05 (20.7%) stddev-sans-first:23.39 06:23:37 INFO - PROCESS | 1653 | Values: 107.0 83.0 83.0 131.0 117.0 135.0 90.0 132.0 78.0 102.0 06:23:37 INFO - PROCESS | 1653 | 06:23:37 INFO - PROCESS | 1653 | [#6] imaging-darkroom Cycles:10 Average:121.50 Median:114.00 stddev:29.62 (26.0%) stddev-sans-first:30.38 06:23:37 INFO - PROCESS | 1653 | Values: 100.0 100.0 101.0 113.0 101.0 115.0 175.0 113.0 177.0 120.0 06:23:37 INFO - PROCESS | 1653 | 06:23:37 INFO - PROCESS | 1653 | [#7] imaging-desaturate Cycles:10 Average:119.70 Median:148.00 stddev:30.18 (20.4%) stddev-sans-first:27.77 06:23:37 INFO - PROCESS | 1653 | Values: 77.0 147.0 148.0 104.0 76.0 91.0 121.0 141.0 144.0 148.0 06:23:37 INFO - PROCESS | 1653 | 06:23:37 INFO - PROCESS | 1653 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:59.00 stddev:2.45 (4.2%) stddev-sans-first:2.52 06:23:37 INFO - PROCESS | 1653 | Values: 56.0 55.0 54.0 55.0 61.0 59.0 59.0 59.0 59.0 60.0 06:23:37 INFO - PROCESS | 1653 | 06:23:37 INFO - PROCESS | 1653 | [#9] json-stringify-tinderbox Cycles:10 Average:79.70 Median:73.00 stddev:12.67 (17.4%) stddev-sans-first:12.83 06:23:37 INFO - PROCESS | 1653 | Values: 69.0 73.0 70.0 84.0 92.0 73.0 70.0 69.0 93.0 104.0 06:23:37 INFO - PROCESS | 1653 | 06:23:37 INFO - PROCESS | 1653 | [#10] stanford-crypto-aes Cycles:10 Average:92.70 Median:74.50 stddev:14.00 (18.8%) stddev-sans-first:14.30 06:23:37 INFO - PROCESS | 1653 | Values: 82.0 76.0 99.0 104.0 103.0 105.0 76.0 73.0 105.0 104.0 06:23:37 INFO - PROCESS | 1653 | 06:23:37 INFO - PROCESS | 1653 | [#11] stanford-crypto-ccm Cycles:10 Average:145.40 Median:140.50 stddev:16.92 (12.0%) stddev-sans-first:17.83 06:23:37 INFO - PROCESS | 1653 | Values: 140.0 140.0 138.0 137.0 138.0 139.0 142.0 146.0 193.0 141.0 06:23:37 INFO - PROCESS | 1653 | 06:23:37 INFO - PROCESS | 1653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.80 Median:170.00 stddev:21.05 (12.4%) stddev-sans-first:21.89 06:23:37 INFO - PROCESS | 1653 | Values: 168.0 194.0 230.0 197.0 168.0 167.0 168.0 172.0 167.0 167.0 06:23:37 INFO - PROCESS | 1653 | 06:23:37 INFO - PROCESS | 1653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.70 Median:74.00 stddev:10.35 (14.0%) stddev-sans-first:10.69 06:23:37 INFO - PROCESS | 1653 | Values: 68.0 68.0 66.0 67.0 67.0 66.0 91.0 89.0 85.0 80.0 06:23:37 INFO - PROCESS | 1653 | -------- Summary: end -------- 06:23:37 INFO - PROCESS | 1653 | 06:23:37 INFO - TEST-INFO | 1653: exit 0 06:23:37 INFO - TEST-OK | kraken | took 61191ms 06:23:37 INFO - SUITE-END | took 1177s 06:23:38 INFO - Completed test suite (00:19:37) 06:23:38 INFO - javascript benchmark 06:23:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7277.812054947184, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3429.15985583532, 3452.27502224533, 3463.8960831175073, 3472.496488009239, 3473.253250551131, 5911.083782013784, 5925.733341999609, 5937.109433584965, 5951.732172052257, 6006.4293892080295, 5944.940550594492, 5972.19375384323, 5990.1913241712355, 6016.278046634399, 6038.758449662008, 5112.693238405707, 5320.467953204688, 5363.329583802025, 5418.322709661293, 5439.075357189287, 4555.794989225493, 5148.3564554430695, 5441.401445840955, 5445.727713614323, 5446.7276636168035, 5314.867128321785, 5344.278522399465, 5436.401995780461, 5446.863828404282, 5517.751701173437, 4451.755153466558, 5394.244805727201, 5423.620346575742, 5452.563794896419, 5483.396826349099, 5295.602829787743, 5406.567474602022, 5410.729463526847, 5415.0523658359625, 5451.809186678487, 4808.711477311373, 5997.790077347272, 6031.788887388921, 6114.908276375858, 6137.969310153465, 5271.630985830993, 6188.938110618881, 6189.752409903598, 6207.503399728011, 6269.3730626937395, 6332.525060620425, 6344.0, 6354.078658594524, 6359.268684101341, 6362.981922892362, 6063.514918806485, 6099.664518451527, 6113.816585502442, 6120.816375508742, 6131.50947924165, 5439.836804895859, 6174.197354343906, 6312.147860038836, 6316.652584107918, 6343.904841427382, 5570.275864137636, 5587.608867379326, 6300.1494798202575, 6311.621302721759, 6327.177466929362, 5403.054465468527, 6312.652804095727, 6331.715072821734, 6332.841678958063, 6339.96830015847, 5188.7405629719115, 6120.387961203844, 6257.812265632038, 6273.529485288622, 6283.59156654816, 6218.689065546704, 6269.279032911182, 6284.402981716821, 6284.780032698834, 6303.873922521524, 5089.6691715038405, 5094.796208151706, 5097.719625420564, 5117.206832940826, 5121.8719532012, 3812.0, 4498.122866041156, 4558.997020655451, 4568.269076947672, 4588.449386073626, 6009.969950150221, 6034.306054803666, 6071.939280607137, 6118.101457354478, 6118.649636126507, 6290.591111577733, 6301.4328710416285, 6368.10846481493, 6379.64911929839, 6394.136791533084, 5947.988841896888, 6016.639001659914, 6022.5784195105925, 6032.728527216286, 6114.419130182626, 5573.0, 5587.552995760329, 5602.95492145364, 5603.971980140154, 5621.241132447068, 6479.8056058318325, 6509.609423434609, 6512.185976753, 6522.086907833002, 6527.445167160655, 6177.351378105234, 6214.471769899609, 6275.623462592259, 6293.654147299383, 6333.493320534254, 5207.921881171861, 6268.091126786499, 6416.48668106541, 6508.902366464602, 6552.803415897531, 6241.375862413723, 6254.8123556293385, 6268.091126786681, 6272.6236425814595, 6274.403931626488, 6254.0, 6274.090256912631, 6308.495320374267, 6309.211348581427, 6320.5259605528845, 6165.753369865155, 6193.4425901669065, 6229.844253893689, 6294.0, 6294.339094395023, 6230.626162430269, 6276.0, 6279.0, 6306.306306306211, 6308.463780578519, 6061.787837425669, 6117.235345581802, 6152.261728592597, 6186.1648677427975, 6212.316645169119, 5479.589030822624, 5542.72286385671, 6145.647957449354, 6206.131141640084, 6233.314335423009, 6121.326654068138, 6211.937880621136, 6215.0, 6218.440340369389, 6233.0], "value": 5800.259739955747, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [415.3375366290765, 458.1890054603351, 482.74655805702, 503.29287351271455, 518.377946464243, 40930.0, 42017.7899110504, 42024.36963445547, 42081.57918420811, 42093.57906420943, 35104.64895351052, 36370.908872733795, 42208.57791422093, 44410.777946110225, 44484.33273500892, 8492.320614350838, 9250.629974801, 9430.434173949585, 9440.716778496622, 9478.857817132748, 7929.286364227219, 11200.991910728033, 11434.656960291162, 11469.942650286737, 11654.766904661901, 11439.313641181556, 11464.369459679714, 11486.138539609563, 11496.482658280398, 11525.884741152608, 11475.770484590303, 11538.884611153864, 11542.942285288562, 11543.0, 11557.30656160633, 11383.03244224242, 11452.885471145266, 11456.3698996556, 11471.713207169887, 11499.310041397543, 41675.70783606901, 41849.95375115616, 42020.78989605063, 42060.0, 42083.57916420827, 3919.7648141111627, 3953.2093581283857, 3991.341428664267, 4004.6395824375654, 4062.79686015701, 28203.57694634582, 29000.564991525145, 29815.70184298151, 30041.94853180128, 30101.698983010327, 3108.1763332716846, 3151.416987857254, 3219.565358676572, 3321.5183798349103, 3328.6671332866763, 506489.0, 509682.35476467514, 511514.0, 511808.9999999963, 515897.0, 58767.41232587705, 59314.40685593175, 59314.51713707192, 59361.703191483764, 59483.40516594865, 63043.739125218155, 63520.68239658864, 63538.0469292961, 63851.0, 63866.36133638604, 15686.9215653921, 16264.0, 16334.918325408296, 16335.91832040856, 16351.26419311134, 10321.225908056926, 11301.248306512503, 11352.94323528377, 11887.40562971848, 12586.433610487367, 18595.256189752257, 19040.61918761617, 19045.61908761845, 19104.61790764177, 19106.52233694169, 7739.55773955773, 7761.068671759425, 7771.805704857424, 7783.727569535039, 7823.882641760378, 852.8464876322197, 866.3459088388227, 875.8198426694702, 876.8684697295457, 907.5235501361838, 30804.383912322075, 30976.53535196974, 31145.221369465944, 31432.842835785676, 31591.0, 1048.2976405808126, 1050.4590136079926, 1054.9736256593494, 1094.3816743539874, 1180.4628893853276, 14876.0, 15944.0, 16332.918335408247, 16435.506934791974, 16440.588985275463, 237206.0, 237752.0, 238017.0, 238300.80849595988, 240621.0, 63447.0, 64274.71450571056, 64345.0, 64367.0, 64411.67794160999, 1404.6909679870412, 1431.8639729225706, 1445.3640398224748, 1446.2262689461088, 1455.097839339595, 29938.8503057492, 30584.694153058186, 30680.539791902695, 31079.689203108584, 31279.530807037456, 54421.91156176933, 54739.45260547344, 54874.62813429696, 54969.45030549643, 55061.62345941384, 572508.0, 573393.0, 573743.0, 575515.0, 576546.117269411, 24834.130805421722, 25597.87201063983, 25627.97488100455, 26322.025848061854, 27766.86116569404, 42050.94872628209, 42511.0, 42668.78665606652, 43296.0, 43434.78282608567, 34952.65047349494, 35356.469652954715, 35398.938031859085, 35433.291334173686, 36529.26941461103, 29496.37769922675, 30567.694323057374, 35367.646323536435, 36210.8189459051, 36388.09029774277, 34603.65396346004, 34814.303713926085, 34831.82584087063, 34855.82572087123, 35382.407791648926, 28956.84172633071, 30541.54187687231, 33978.49032264567, 33984.830075849466, 34284.48573271353, 24218.63672044956, 24823.0, 25095.24714258575, 25379.74620253774, 25475.57981991708], "value": 19682.47472823417, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.67010360778903, 386.4107236464393, 390.00512379180464, 396.3638360431508, 419.67684882640367, 16440.260188291526, 19847.702284465726, 20353.89823050883, 21155.365339039836, 21168.0, 20938.685919711217, 21287.68068478974, 21432.57134857302, 21694.457638559044, 21968.0, 5342.385625653042, 5809.6804675742815, 6060.272767267934, 6071.969640151815, 6122.173506576622, 5297.496737809902, 5619.80330688426, 5727.284089488814, 5928.49607783339, 5951.196588460567, 5785.132230165466, 5975.85060373492, 5981.252343457068, 5984.491318237955, 5994.220751302347, 5631.1271752878165, 5862.618929769594, 5947.434993675594, 5962.493188079018, 5963.344032156481, 5212.192110222922, 5215.6349055566125, 5221.0, 5223.320968274138, 5236.738163091868, 21149.15403383863, 23697.0, 25152.49695006108, 25161.62257566138, 25866.61200082, 2744.245332533549, 2805.3968396794585, 2807.354308509034, 2843.672977607581, 2845.8434786086755, 9544.141027307576, 9882.456464894429, 10295.794084118275, 10475.057244847923, 15621.453249136339, 1821.826926441986, 1860.9720854187199, 1862.850971922243, 1868.5235265007336, 1892.233645373626, 135936.0, 136634.0, 138516.30741846326, 141564.29217853845, 143974.0, 11885.762284754257, 11979.041676665845, 12054.216475929037, 12198.451069701885, 12205.20666156697, 14008.019438639198, 14489.347979340955, 15627.531174064796, 15655.295511702001, 15656.765148522782, 8525.74422767318, 8681.392302538889, 8883.244924181388, 8926.973398059306, 8976.0, 7590.203028682019, 8362.916370836214, 8467.237948584658, 8662.480251184948, 8740.694075707446, 4190.114448498188, 4751.83368582098, 4775.2359622460235, 4839.080574690797, 4894.583960363338, 1977.7626684797917, 2028.097496614022, 2033.6136134134467, 2034.4100210938957, 2045.795420457972, 786.929176374129, 1021.0096206679509, 1023.6263763726187, 1044.2846650044744, 1062.4687656171914, 19903.900480497505, 20101.798982010285, 20534.79465205329, 20582.794172058388, 20707.96460176985, 1024.8155332040305, 1033.9741506462249, 1057.7302787789217, 1064.2762921213648, 1065.1957771882335, 10370.0, 10916.56333746657, 10956.013958743752, 10982.0, 10983.121350291958, 753227.0, 767359.0, 773738.0, 775156.0, 779815.0, 141138.2943085278, 142136.0, 145071.0, 145439.0, 145625.27187364208, 945.0832692288469, 974.3520558828442, 995.7062666513395, 999.2555546118043, 1007.0, 15774.763378549102, 18069.457916262534, 18389.448316550526, 18676.906615466836, 18857.528561786065, 53013.734931325096, 57348.42651573431, 57797.0, 58828.70585647044, 61513.077303839586, 80857.59571202342, 81786.0, 82129.58935205286, 82291.0, 82739.58630207051, 6620.0, 7966.880496792669, 8012.679492820455, 8476.618552165291, 8528.658853646033, 9174.403663761834, 11789.587364442546, 12603.369831508204, 12933.09468337245, 13031.804522931974, 10901.692756910468, 10980.670579882617, 11116.277441966246, 11276.94361528187, 11411.201215915138, 8993.010768815557, 10490.580376785148, 10933.781324373627, 10963.780724385308, 11140.05309548665, 9384.873815142226, 10064.590957266135, 10184.134348580454, 10213.591456341961, 11425.942870285928, 7160.391366733886, 7342.229065947999, 7519.849603008019, 7722.961385193263, 8435.240828325235, 9308.860367094634, 9820.4107753535, 11131.888681113085, 11251.49368278413, 11257.324560526395], "value": 9807.240537672164, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1246.781813182693, 1277.067740549399, 1427.536050783495, 1449.6593300574357, 1452.3609611770826, 6849.589024658524, 7601.20187380324, 7893.526388416684, 8663.523506207164, 8684.175003374685, 7258.782236532912, 8149.592520373973, 8396.62215200316, 8446.535440550768, 8552.828943421144, 2088.9868413819286, 2225.2545397291847, 2321.0, 2340.578695834749, 2355.5171189906027, 2090.341542414135, 2308.549832782608, 2365.6333268343433, 2372.8457650252676, 2375.58427275227, 2115.175081718131, 2260.1750361118156, 2338.918137865175, 2343.8828058597087, 2348.847324923883, 2317.5480781247666, 2329.301209637111, 2337.91817286395, 2340.5201933603657, 2349.424391024193, 2315.583195024895, 2319.617263151578, 2379.428937055094, 2380.1788383007834, 2390.0798192695765, 8584.356173287028, 8595.828083438359, 8659.740207793777, 8677.088905664878, 8691.695790647296, 5180.430152683201, 5297.258383826267, 5314.016906872241, 5330.893382132335, 5336.866578335534, 3515.5078289039297, 3552.1652411683235, 3557.5197348358156, 3587.712982961357, 3610.3862343401424, 1225.540422341622, 1238.7150955280247, 1266.949322027118, 1268.6003908768707, 1291.2639795316672, 10998.560057597686, 11054.502547385388, 11119.166062545342, 11161.162912781574, 11184.776304473946, 4442.844500442534, 4748.691335063209, 4789.473157952622, 4806.759662016885, 4819.397575303087, 9684.854727179098, 9737.610495580238, 9749.220062395134, 9782.75543111428, 9783.804323913482, 5325.8402247931845, 5368.0605893968395, 5373.0, 5374.6506477078865, 5376.435474275223, 4723.527647235318, 4820.638452116105, 4825.276208568743, 4873.926891096637, 4940.802367905316, 3363.814990175515, 3891.2606604745006, 3961.1087505311652, 4002.079521709965, 4022.2905265262148, 1182.3024415594841, 1231.58741821489, 1272.8154417609394, 1291.1930043722673, 1302.1275745250705, 760.1296515489734, 778.1401551285861, 802.1096582793095, 824.8556502612018, 858.9484630922165, 5614.157876318585, 5681.261436013375, 5701.144828275792, 5837.7157025454335, 5875.441833025856, 981.3866333541537, 988.1579468493882, 1010.9443980581138, 1025.3540269630084, 1037.190991027, 3685.576158741779, 3866.5940076292145, 3932.2332145231976, 3999.5800440953863, 4007.599240075969, 9738.513074346254, 10275.434851083262, 10276.743081422876, 10277.7430564235, 10288.948555257326, 9893.653722119836, 10127.493625318704, 10183.643572474928, 10194.133498652549, 10346.965303469593, 7857.371410287164, 7928.365730741527, 7963.522188668582, 8017.639206235734, 8025.197480251928, 5409.486098820606, 5433.375161856279, 5569.749361278833, 5595.356533998643, 5696.601237913472, 9370.484623345508, 9375.906240937777, 9437.009114042927, 9464.006279340845, 9469.905300947177, 9201.815963680823, 9640.276979226446, 9724.367916085432, 9739.41563506192, 9747.512624368612, 6124.510039196943, 6994.475414343843, 7079.575225486487, 7082.0793296873135, 7089.929100709133, 7825.33484653788, 7924.247196516321, 7940.92059079425, 7996.760097197093, 8019.837123616926, 6379.93620063812, 7156.3917067047805, 7186.496945213994, 7267.127944646676, 7293.598852063187, 7151.892721609076, 7166.928330716626, 7194.640267986684, 7212.7475538358, 7344.522606030591, 6377.688038353628, 6424.710888010144, 6451.903221451588, 6454.774082907075, 6455.709493072729, 4910.312556242057, 4914.803407863646, 4952.133376659142, 5097.413797413196, 5198.0, 5013.649044566845, 5015.247712843103, 5118.513741194581, 5257.947420525746, 5302.1781623848365], "value": 4473.369936137568, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [284.23257205545036, 354.11471321695745, 357.93378225028374, 364.81394488810713, 370.1782043862624, 5008.197049062334, 5171.818986335475, 5448.264484294619, 5462.770876552773, 5481.972590137048, 4420.557944205586, 4476.932846007313, 5196.0, 5214.193638643792, 5297.814576489824, 3520.3839328117606, 3790.7346485746007, 4242.533321334666, 4245.554216807237, 4294.656427485794, 3880.7865567393783, 3899.2120633746867, 3908.843646254161, 4261.1450328280125, 4273.0130489322455, 4076.1657254235565, 4141.730787498818, 4174.70777045607, 4214.388913607525, 4261.403403523509, 3768.811559422018, 3968.6825053995613, 4162.41726158338, 4184.979075104605, 4191.497020357546, 3312.565264530568, 3323.7839540429795, 3606.855725770966, 3705.7220708446976, 3767.0017445377, 4328.956710432918, 4574.970631607862, 4972.403311602595, 5121.82073627425, 5162.5095615916425, 4716.95283047172, 4897.755112244409, 4905.8773530661665, 4907.656464047518, 4913.26301054841, 5385.434529374398, 5571.415001424833, 5698.6580805151825, 5714.914276285859, 5741.856453588652, 3355.4295769719206, 3637.399829028207, 3639.581448133472, 3812.866549670748, 3868.497095377583, 5702.236523894251, 5847.941520584783, 5999.190109335227, 6000.399960004008, 6107.694615269219, 3708.9072773180887, 3844.5386553613744, 3955.782431966212, 3963.5334926077535, 3993.4608827808456, 4045.615666511677, 4060.715749897479, 4068.613481719232, 4091.734037287567, 4096.344584866407, 3869.806509674505, 3949.9802500987885, 4363.716358436692, 4583.052202813858, 4695.906081878344, 4696.060787842445, 5762.74067666956, 5795.362510123968, 5803.6807975560905, 5919.974417396126, 1115.3865374044244, 1136.6817291158488, 1214.8276912779033, 1243.8569564500199, 1317.6639956811143, 740.3632875726871, 845.7166849105496, 851.4082712514743, 882.4572887674162, 887.8135591525722, 4857.587105096107, 4885.6289160479155, 5179.119549676564, 5190.976992830587, 5248.422673505911, 5075.543201111917, 5316.255724198615, 5441.129419292974, 5668.659880407189, 5686.857828554236, 4248.957510424918, 4532.2979878633105, 4838.443578988391, 5140.920406714557, 5146.279520867081, 2565.5125526149973, 2938.912602337149, 2952.099609619087, 2952.822830630169, 2978.7914845960577, 5056.797728090835, 5290.206469029599, 5454.4545545445135, 5855.853603659943, 5872.911906321408, 5411.621186516984, 5436.6194366393975, 5776.696361210925, 5796.246487956539, 5796.594238403356, 5186.662866913639, 5848.415158484203, 5903.409659034062, 5903.852403689943, 5910.527157827363, 5290.910090514149, 5540.556755459473, 5541.362743284412, 5649.71751412436, 5656.717164141859, 4630.398048253705, 4779.569838714532, 4786.95213047865, 5148.459411761711, 5517.0138750050755, 4812.927806082982, 5232.450592687713, 5746.678263999387, 5815.185873977562, 5818.796342128006, 3219.3400352927124, 3461.72476990911, 3681.8159092044757, 3737.8133791732143, 3760.8683696070507, 4611.893145645088, 5161.509656582619, 5286.81496147633, 5584.916226256528, 5612.326520817528, 5062.392512898476, 5388.46115388458, 5447.346318441812, 5461.644993075437, 5500.3949565548555, 4033.515978082649, 4739.786709598007, 4945.23348880924, 5245.580353571781, 5384.21928820311, 4926.595920162737, 5173.301604283373, 5259.687715407543, 5356.491133342326, 5445.945540544544, 5584.944150558443, 5656.236408084856, 5697.262334987703, 5716.571257155647, 5788.363280039108, 4991.675541089818, 5411.594130440311, 5606.215129881738, 5633.549316054624, 5634.718264086698], "value": 4059.3211028508895, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [695.5861262548788, 696.8292768271774, 759.9088109426868, 783.3889566138411, 837.9874301885471, 13211.537596184135, 14645.487407940724, 15358.846411535882, 15551.455699050535, 15619.21903904806, 13309.933450332735, 14313.78529322061, 14517.49188778393, 14517.78223326651, 14531.491397801079, 879.4459490520978, 889.6130183370223, 898.0884402331639, 901.9233365163936, 902.3367824648877, 888.9777755556098, 889.977750556238, 891.2647066170402, 894.8702438146465, 894.995525022374, 894.3560636341856, 923.0630909626734, 923.3905622289291, 926.5089502563618, 927.211869910574, 915.8671992561108, 919.843626583479, 920.2867777472445, 920.7513971227764, 921.2399770189587, 684.165318311659, 697.7313734212314, 697.7767114523355, 698.6436917172279, 699.8635266123108, 9552.808943821085, 11317.717057073556, 11474.368909709963, 13618.591442256748, 13699.0, 11729.472173752201, 12239.32683702396, 12727.23636581808, 12754.0, 12823.294718790463, 12470.561403334783, 12503.937480312632, 12562.623121306375, 12971.740565188738, 13135.474581016748, 4289.378040184156, 4393.934090988638, 4406.471223453174, 4475.9481521842345, 4602.631789456836, 111284.0, 113416.0, 114747.42626286815, 117121.0, 118022.0, 9533.0, 10324.638637647646, 10574.735631609117, 10693.411862347646, 10749.40878251688, 20965.79034209669, 21177.470563236042, 21181.78818211798, 21199.0, 21226.044827982776, 7489.3634041106025, 7587.203343648947, 7595.3164215220895, 7650.655720492591, 7741.303282704584, 4148.128892932457, 4172.7913604319665, 4241.660667146621, 4286.87139385819, 4301.978490107529, 3461.9653803461642, 3502.036939841564, 3530.0998245447245, 3537.451694987281, 3537.7877327360443, 640.4876099120685, 672.5561129654404, 673.845015646404, 676.2257215488337, 683.6205905722372, 513.4223998002248, 537.1388140094591, 542.4087744358668, 546.2980070609327, 548.9835304940858, 9201.0, 9627.181689556466, 9646.807063858683, 9861.408315501092, 10108.342957707726, 622.6886556721639, 640.3628389752133, 652.4063102576632, 653.3433898931544, 665.2648823050556, 4415.40392047076, 4461.910761784746, 4667.109265846924, 4688.2733176357715, 4774.090363854486, 105840.0, 106855.0, 107230.46384768182, 107539.0, 107976.46011769891, 63753.0, 65237.0, 65246.0, 78975.8153627696, 93431.0, 63899.4025149375, 65626.67186664132, 74592.64333105023, 75190.4961900759, 78924.0, 7675.808104797425, 8488.854004709532, 8897.955510222408, 8930.687425940061, 8936.0, 52538.73730631475, 52581.21128183004, 53070.73464632652, 54048.0, 54182.729086355896, 47186.056278874916, 62335.688321558104, 62900.68549657222, 69822.65088674524, 72068.27931720826, 10684.358938463716, 10760.3543787373, 10879.129669626253, 11083.501242443948, 11338.0, 11782.410879456163, 11881.405929703307, 12020.0, 12178.269303841798, 14039.50861719835, 13183.934080329536, 13383.330833458094, 13737.725245494834, 14023.298835058411, 14073.655961894754, 13181.340932953506, 13238.867611323763, 13418.93290533541, 13744.518941836988, 13755.931220343835, 12964.416601252778, 13611.327306471987, 13613.52352667652, 13729.588112356645, 13997.300134993413, 10613.0, 11074.778504429705, 11185.566238729847, 11319.320840749582, 11475.655730328104, 9522.14300712939, 10984.615538456115, 11074.889251107386, 11354.716132096433, 11431.485583148944], "value": 7307.959913983161, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1588.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 119.0, 119.0, 121.0, 119.0, 119.0, 121.0, 114.0, 120.0, 120.0], "value": 117.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 133.0, 112.0, 149.0, 111.0, 114.0, 113.0, 114.0, 131.0, 139.0], "value": 129.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 230.0, 278.0, 198.0, 197.0, 198.0, 196.0, 196.0, 198.0, 192.0], "value": 208.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 58.0, 60.0, 87.0, 86.0, 79.0, 61.0, 59.0, 71.0, 53.0], "value": 69.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 73.0, 71.0, 99.0, 100.0, 104.0, 99.0, 71.0, 72.0, 83.0], "value": 86.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 83.0, 83.0, 131.0, 117.0, 135.0, 90.0, 132.0, 78.0, 102.0], "value": 105.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 100.0, 101.0, 113.0, 101.0, 115.0, 175.0, 113.0, 177.0, 120.0], "value": 121.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 147.0, 148.0, 104.0, 76.0, 91.0, 121.0, 141.0, 144.0, 148.0], "value": 119.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 54.0, 55.0, 61.0, 59.0, 59.0, 59.0, 59.0, 60.0], "value": 57.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 73.0, 70.0, 84.0, 92.0, 73.0, 70.0, 69.0, 93.0, 104.0], "value": 79.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 76.0, 99.0, 104.0, 103.0, 105.0, 76.0, 73.0, 105.0, 104.0], "value": 92.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 140.0, 138.0, 137.0, 138.0, 139.0, 142.0, 146.0, 193.0, 141.0], "value": 145.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 194.0, 230.0, 197.0, 168.0, 167.0, 168.0, 172.0, 167.0, 167.0], "value": 179.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 66.0, 67.0, 67.0, 66.0, 91.0, 89.0, 85.0, 80.0], "value": 74.7, "unit": "score"}]}]} 06:23:38 INFO - Return code: 0 06:23:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:23:38 ERROR - # TBPL SUCCESS # 06:23:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:23:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:23:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:23:38 INFO - 2017-02-16 06:23:38.395 screenresolution[1658:10378] starting screenresolution argv=screenresolution get 06:23:38 INFO - 2017-02-16 06:23:38.398 screenresolution[1658:10378] Display 0: 1600x1200x32@60 06:23:38 INFO - 2017-02-16 06:23:38.404 screenresolution[1659:10381] starting screenresolution argv=screenresolution list 06:23:38 INFO - Available Modes on Display 0 06:23:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:23:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:23:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:23:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:23:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:23:38 INFO - Intel Iris: 06:23:38 INFO - Chipset Model: Intel Iris 06:23:38 INFO - Type: GPU 06:23:38 INFO - Bus: Built-In 06:23:38 INFO - VRAM (Dynamic, Max): 1536 MB 06:23:38 INFO - Vendor: Intel (0x8086) 06:23:38 INFO - Device ID: 0x0a2e 06:23:38 INFO - Revision ID: 0x0009 06:23:38 INFO - Displays: 06:23:38 INFO - Display: 06:23:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:23:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:23:38 INFO - Display Serial Number: 1600x1200 60 06:23:38 INFO - Main Display: Yes 06:23:38 INFO - Mirror: Off 06:23:38 INFO - Online: Yes 06:23:38 INFO - Rotation: Supported 06:23:38 INFO - Return code: 0 06:23:38 INFO - Running post-action listener: _resource_record_post_action 06:23:38 INFO - [mozharness: 2017-02-16 14:23:38.639681Z] Finished run-tests step (success) 06:23:38 INFO - Running post-run listener: _resource_record_post_run 06:23:38 INFO - Total resource usage - Wall time: 1198s; CPU: 55.0%; Read bytes: 39692800; Write bytes: 516173824; Read time: 389; Write time: 1791 06:23:38 INFO - TinderboxPrint: CPU usage
54.7% 06:23:38 INFO - TinderboxPrint: I/O read bytes / time
39,692,800 / 389 06:23:38 INFO - TinderboxPrint: I/O write bytes / time
516,173,824 / 1,791 06:23:38 INFO - TinderboxPrint: CPU idle
2,172.8 (45.3%) 06:23:38 INFO - TinderboxPrint: CPU system
969.1 (20.2%) 06:23:38 INFO - TinderboxPrint: CPU user
1,651.8 (34.5%) 06:23:38 INFO - TinderboxPrint: Swap in / out
248,152,064 / 0 06:23:38 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 207608320; Write bytes: 199974912; Read time: 15890; Write time: 402 06:23:38 INFO - run-tests - Wall time: 1179s; CPU: 55.0%; Read bytes: 35023360; Write bytes: 301721600; Read time: 350; Write time: 1244 06:23:39 INFO - Running post-run listener: _upload_blobber_files 06:23:39 INFO - Blob upload gear active. 06:23:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:23:39 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 06:23:39 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'] 06:23:39 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 06:23:39 INFO - (blobuploader) - INFO - Open directory for files ... 06:23:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:23:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:23:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:23:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:23:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:23:40 INFO - (blobuploader) - INFO - Done attempting. 06:23:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:23:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:23:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:23:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:23:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:23:41 INFO - (blobuploader) - INFO - Done attempting. 06:23:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:23:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:23:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:23:42 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:23:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:23:42 INFO - (blobuploader) - INFO - Done attempting. 06:23:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:23:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:23:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:23:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:23:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:23:44 INFO - (blobuploader) - INFO - Done attempting. 06:23:44 INFO - (blobuploader) - INFO - Iteration through files over. 06:23:44 INFO - Return code: 0 06:23:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:23:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:23:44 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7ec1b6f3e8f2ac40fdc63885636612fff3e58b62587e88061deffc8462bbddfe1157c6172901ac3b9376020e4a7c949a7440c2f932acf952b55e5bf341a3d3b5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d91b28b2983cab59e98cc6dccd95ee29e44810e2778fa141e6beaa01570a0a0d35b0fc06d1d8a459f1d568b2c5bfa2945c4a0391a6988cbcc0fe098add9b977b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f0c11248d45f1b76db63bbc67b2a8a98462ecd104d52610b1c18c7b905361fddc110b38ff3bd2e3590c8dbb6851c418dfa1b07822cba124b57054e24159b86d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/656146f8bd2df3b99449bbd39e9fd6aca096a60bdcaed36274af9f321f8a31c6614345673d7edc7448e29f954c57be62cf2a757668de7470b48ce1bd0ec79e56"} 06:23:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:23:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:23:44 INFO - Contents: 06:23:44 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7ec1b6f3e8f2ac40fdc63885636612fff3e58b62587e88061deffc8462bbddfe1157c6172901ac3b9376020e4a7c949a7440c2f932acf952b55e5bf341a3d3b5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d91b28b2983cab59e98cc6dccd95ee29e44810e2778fa141e6beaa01570a0a0d35b0fc06d1d8a459f1d568b2c5bfa2945c4a0391a6988cbcc0fe098add9b977b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f0c11248d45f1b76db63bbc67b2a8a98462ecd104d52610b1c18c7b905361fddc110b38ff3bd2e3590c8dbb6851c418dfa1b07822cba124b57054e24159b86d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/656146f8bd2df3b99449bbd39e9fd6aca096a60bdcaed36274af9f321f8a31c6614345673d7edc7448e29f954c57be62cf2a757668de7470b48ce1bd0ec79e56"} 06:23:44 INFO - Running post-run listener: copy_logs_to_upload_dir 06:23:44 INFO - Copying logs to upload dir... 06:23:44 INFO - mkdir: /builds/slave/test/build/upload/logs 06:23:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.031112 ========= master_lag: 0.56 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-02-16 06:23:44.873717) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-16 06:23:44.877115) ========= 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.27JzeeSoFZ/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.3TIXSF1mzG/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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/7ec1b6f3e8f2ac40fdc63885636612fff3e58b62587e88061deffc8462bbddfe1157c6172901ac3b9376020e4a7c949a7440c2f932acf952b55e5bf341a3d3b5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d91b28b2983cab59e98cc6dccd95ee29e44810e2778fa141e6beaa01570a0a0d35b0fc06d1d8a459f1d568b2c5bfa2945c4a0391a6988cbcc0fe098add9b977b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f0c11248d45f1b76db63bbc67b2a8a98462ecd104d52610b1c18c7b905361fddc110b38ff3bd2e3590c8dbb6851c418dfa1b07822cba124b57054e24159b86d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/656146f8bd2df3b99449bbd39e9fd6aca096a60bdcaed36274af9f321f8a31c6614345673d7edc7448e29f954c57be62cf2a757668de7470b48ce1bd0ec79e56"} build_url:https://queue.taskcluster.net/v1/task/Wk66E6LdQw-MKUCgbORCeA/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011023 build_url: 'https://queue.taskcluster.net/v1/task/Wk66E6LdQw-MKUCgbORCeA/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/7ec1b6f3e8f2ac40fdc63885636612fff3e58b62587e88061deffc8462bbddfe1157c6172901ac3b9376020e4a7c949a7440c2f932acf952b55e5bf341a3d3b5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d91b28b2983cab59e98cc6dccd95ee29e44810e2778fa141e6beaa01570a0a0d35b0fc06d1d8a459f1d568b2c5bfa2945c4a0391a6988cbcc0fe098add9b977b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f0c11248d45f1b76db63bbc67b2a8a98462ecd104d52610b1c18c7b905361fddc110b38ff3bd2e3590c8dbb6851c418dfa1b07822cba124b57054e24159b86d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/656146f8bd2df3b99449bbd39e9fd6aca096a60bdcaed36274af9f321f8a31c6614345673d7edc7448e29f954c57be62cf2a757668de7470b48ce1bd0ec79e56"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-16 06:23:44.917396) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 06:23:44.917733) ========= 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.27JzeeSoFZ/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.3TIXSF1mzG/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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.004996 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 06:23:44.966543) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-16 06:23:44.966857) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-16 06:23:44.967176) ========= ========= Total master_lag: 0.70 =========