builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0391 starttime: 1485799688.69 results: success (0) buildid: 20170130081443 builduid: a93dd99ac7204122b57a6e65bf26ff48 revision: 40425a7cb3569597c1277203c8c2d0109bb78468 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-30 10:08:08.695260) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-30 10:08:08.695949) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-30 10:08:08.696444) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-30 10:08:08.723619) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 10:08:08.724290) ========= 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.jibMWWHc1B/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.rpeNHQ5YnU/Listeners TMPDIR=/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-30 10:08:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.17M=0.001s 2017-01-30 10:08:08 (8.17 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.156304 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 10:08:08.905572) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 10:08:08.905893) ========= 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.jibMWWHc1B/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.rpeNHQ5YnU/Listeners TMPDIR=/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/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.019697 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 10:08:08.955068) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-30 10:08:08.955453) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 40425a7cb3569597c1277203c8c2d0109bb78468 --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 40425a7cb3569597c1277203c8c2d0109bb78468 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.jibMWWHc1B/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.rpeNHQ5YnU/Listeners TMPDIR=/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-30 10:08:09,045 truncating revision to first 12 chars 2017-01-30 10:08:09,045 Setting DEBUG logging. 2017-01-30 10:08:09,045 attempt 1/10 2017-01-30 10:08:09,045 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/40425a7cb356?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-30 10:08:10,556 unpacking tar archive at: mozilla-aurora-40425a7cb356/testing/mozharness/ program finished with exit code 0 elapsedTime=1.769083 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-30 10:08:10.747722) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-30 10:08:10.748062) ========= script_repo_revision: 40425a7cb3569597c1277203c8c2d0109bb78468 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-30 10:08:10.748440) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-30 10:08:10.748706) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-30 10:08:10.768457) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-01-30 10:08:10.768849) ========= /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.jibMWWHc1B/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.rpeNHQ5YnU/Listeners TMPDIR=/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/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 10:08:10 INFO - MultiFileLogger online at 20170130 10:08:10 in /builds/slave/test 10:08:10 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 10:08:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:08:10 INFO - {'append_to_log': False, 10:08:10 INFO - 'base_work_dir': '/builds/slave/test', 10:08:10 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 10:08:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:08:10 INFO - 'branch': 'Mozilla-Aurora', 10:08:10 INFO - 'buildbot_json_path': 'buildprops.json', 10:08:10 INFO - 'config_files': ('talos/mac_config.py',), 10:08:10 INFO - 'default_actions': ('clobber', 10:08:10 INFO - 'read-buildbot-config', 10:08:10 INFO - 'download-and-extract', 10:08:10 INFO - 'populate-webroot', 10:08:10 INFO - 'create-virtualenv', 10:08:10 INFO - 'install', 10:08:10 INFO - 'run-tests'), 10:08:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:08:10 INFO - 'download_minidump_stackwalk': True, 10:08:10 INFO - 'download_symbols': 'ondemand', 10:08:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:08:10 INFO - 'tooltool.py': '/tools/tooltool.py', 10:08:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:08:10 INFO - '/tools/misc-python/virtualenv.py')}, 10:08:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:08:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:08:10 INFO - 'installer_path': 'installer.exe', 10:08:10 INFO - 'log_level': 'info', 10:08:10 INFO - 'log_name': 'talos', 10:08:10 INFO - 'log_to_console': True, 10:08:10 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:08:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:08:10 INFO - 'opt_config_files': (), 10:08:10 INFO - 'pip_index': False, 10:08:10 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:08:10 INFO - 'cmd': ('bash', 10:08:10 INFO - '-c', 10:08:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:08:10 INFO - 'enabled': True, 10:08:10 INFO - 'halt_on_failure': False, 10:08:10 INFO - 'name': 'check_screen_resolution'},), 10:08:10 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:08:10 INFO - 'cmd': ('bash', 10:08:10 INFO - '-c', 10:08:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:08:10 INFO - 'enabled': True, 10:08:10 INFO - 'halt_on_failure': False, 10:08:10 INFO - 'name': 'check_screen_resolution'},), 10:08:10 INFO - 'run_cmd_checks_enabled': True, 10:08:10 INFO - 'sps_profile': False, 10:08:10 INFO - 'sps_profile_interval': 0, 10:08:10 INFO - 'suite': 'dromaeojs-e10s', 10:08:10 INFO - 'system_bits': '32', 10:08:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:08:10 INFO - 'title': 't-yosemite-r7-0391', 10:08:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:08:10 INFO - 'use_talos_json': True, 10:08:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:08:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:08:10 INFO - 'work_dir': 'build'} 10:08:10 INFO - [mozharness: 2017-01-30 18:08:10.979071Z] Running clobber step. 10:08:10 INFO - Running pre-action listener: _resource_record_pre_action 10:08:10 INFO - Running main action method: clobber 10:08:10 INFO - rmtree: /builds/slave/test/build 10:08:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:08:12 INFO - Running post-action listener: _resource_record_post_action 10:08:12 INFO - [mozharness: 2017-01-30 18:08:12.523027Z] Finished clobber step (success) 10:08:12 INFO - [mozharness: 2017-01-30 18:08:12.523270Z] Running read-buildbot-config step. 10:08:12 INFO - Running pre-action listener: _resource_record_pre_action 10:08:12 INFO - Running main action method: read_buildbot_config 10:08:12 INFO - Using buildbot properties: 10:08:12 INFO - { 10:08:12 INFO - "project": "", 10:08:12 INFO - "product": "firefox", 10:08:12 INFO - "script_repo_revision": "production", 10:08:12 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 10:08:12 INFO - "repository": "", 10:08:12 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 10:08:12 INFO - "buildid": "20170130081443", 10:08:12 INFO - "pgo_build": "False", 10:08:12 INFO - "basedir": "/builds/slave/test", 10:08:12 INFO - "buildnumber": 0, 10:08:12 INFO - "slavename": "t-yosemite-r7-0391", 10:08:12 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 10:08:12 INFO - "platform": "yosemite_r7", 10:08:12 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 10:08:12 INFO - "branch": "mozilla-aurora", 10:08:12 INFO - "repo_path": "releases/mozilla-aurora", 10:08:12 INFO - "revision": "40425a7cb3569597c1277203c8c2d0109bb78468", 10:08:12 INFO - "stage_platform": "macosx64", 10:08:12 INFO - "builduid": "a93dd99ac7204122b57a6e65bf26ff48", 10:08:12 INFO - "slavebuilddir": "test" 10:08:12 INFO - } 10:08:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/DlQ_hmv0QiK9z8f7Zz4-lw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 10:08:12 INFO - Running post-action listener: _resource_record_post_action 10:08:12 INFO - [mozharness: 2017-01-30 18:08:12.529287Z] Finished read-buildbot-config step (success) 10:08:12 INFO - [mozharness: 2017-01-30 18:08:12.529499Z] Running download-and-extract step. 10:08:12 INFO - Running pre-action listener: _resource_record_pre_action 10:08:12 INFO - Running main action method: download_and_extract 10:08:12 INFO - mkdir: /builds/slave/test/build/tests 10:08:12 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')]} 10:08:12 INFO - trying https://queue.taskcluster.net/v1/task/DlQ_hmv0QiK9z8f7Zz4-lw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 10:08:12 INFO - Downloading https://queue.taskcluster.net/v1/task/DlQ_hmv0QiK9z8f7Zz4-lw/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 10:08:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DlQ_hmv0QiK9z8f7Zz4-lw/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 10:08:13 INFO - Downloaded 1199 bytes. 10:08:13 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 10:08:13 INFO - Using the following test package requirements: 10:08:13 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 10:08:13 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 10:08:13 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 10:08:13 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 10:08:13 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 10:08:13 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 10:08:13 INFO - u'jsshell-mac.zip'], 10:08:13 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 10:08:13 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 10:08:13 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 10:08:13 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 10:08:13 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 10:08:13 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 10:08:13 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 10:08:13 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 10:08:13 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 10:08:13 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 10:08:13 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 10:08:13 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 10:08:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DlQ_hmv0QiK9z8f7Zz4-lw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 10:08:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DlQ_hmv0QiK9z8f7Zz4-lw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 10:08:13 INFO - Fetch https://queue.taskcluster.net/v1/task/DlQ_hmv0QiK9z8f7Zz4-lw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 10:08:14 INFO - Expected file size: 16351797 10:08:14 INFO - Obtained file size: 16351797 10:08:21 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 10:08:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DlQ_hmv0QiK9z8f7Zz4-lw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 10:08:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DlQ_hmv0QiK9z8f7Zz4-lw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 10:08:21 INFO - Fetch https://queue.taskcluster.net/v1/task/DlQ_hmv0QiK9z8f7Zz4-lw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 10:08:22 INFO - Expected file size: 16351797 10:08:22 INFO - Obtained file size: 16351797 10:08:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DlQ_hmv0QiK9z8f7Zz4-lw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 10:08:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DlQ_hmv0QiK9z8f7Zz4-lw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 10:08:28 INFO - Fetch https://queue.taskcluster.net/v1/task/DlQ_hmv0QiK9z8f7Zz4-lw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 10:08:29 INFO - Expected file size: 14403485 10:08:29 INFO - Obtained file size: 14403485 10:08:30 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')]} 10:08:30 INFO - trying https://queue.taskcluster.net/v1/task/DlQ_hmv0QiK9z8f7Zz4-lw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 10:08:30 INFO - Downloading https://queue.taskcluster.net/v1/task/DlQ_hmv0QiK9z8f7Zz4-lw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 10:08:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DlQ_hmv0QiK9z8f7Zz4-lw/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 10:08:32 INFO - Downloaded 73868060 bytes. 10:08:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DlQ_hmv0QiK9z8f7Zz4-lw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 10:08:32 INFO - mkdir: /builds/slave/test/properties 10:08:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:08:32 INFO - Writing to file /builds/slave/test/properties/build_url 10:08:32 INFO - Contents: 10:08:32 INFO - build_url:https://queue.taskcluster.net/v1/task/DlQ_hmv0QiK9z8f7Zz4-lw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 10:08:32 INFO - Running post-action listener: _resource_record_post_action 10:08:32 INFO - Running post-action listener: set_extra_try_arguments 10:08:32 INFO - [mozharness: 2017-01-30 18:08:32.945427Z] Finished download-and-extract step (success) 10:08:32 INFO - [mozharness: 2017-01-30 18:08:32.945580Z] Running populate-webroot step. 10:08:32 INFO - Running pre-action listener: _resource_record_pre_action 10:08:32 INFO - Running main action method: populate_webroot 10:08:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:08:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:08:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:08:32 INFO - '--tppagecycles', 10:08:32 INFO - '7'], 10:08:32 INFO - 'tests': ['tsvgm']}}, 10:08:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:08:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:08:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:08:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:08:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:08:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:08:32 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:08:32 INFO - 'talos_options': ['--disable-e10s'], 10:08:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:08:32 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:08:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:08:32 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:08:32 INFO - 'talos_options': ['--disable-e10s'], 10:08:32 INFO - 'tests': ['damp', 'tps']}, 10:08:32 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:08:32 INFO - 'tests': ['damp', 'tps']}, 10:08:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:08:32 INFO - 'tests': ['dromaeo_dom']}, 10:08:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:08:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:08:32 INFO - 'tests': ['basic_compositor_video']}, 10:08:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:08:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:08:32 INFO - 'tests': ['a11yr', 10:08:32 INFO - 'ts_paint', 10:08:32 INFO - 'tpaint', 10:08:32 INFO - 'sessionrestore', 10:08:32 INFO - 'sessionrestore_no_auto_restore', 10:08:32 INFO - 'tabpaint']}, 10:08:32 INFO - 'other-e10s': {'tests': ['a11yr', 10:08:32 INFO - 'ts_paint', 10:08:32 INFO - 'tpaint', 10:08:32 INFO - 'sessionrestore', 10:08:32 INFO - 'sessionrestore_no_auto_restore', 10:08:32 INFO - 'tabpaint']}, 10:08:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:08:32 INFO - 'ts_paint', 10:08:32 INFO - 'tpaint', 10:08:32 INFO - 'sessionrestore', 10:08:32 INFO - 'sessionrestore_no_auto_restore', 10:08:32 INFO - 'tabpaint']}, 10:08:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:08:32 INFO - 'ts_paint', 10:08:32 INFO - 'tpaint', 10:08:32 INFO - 'sessionrestore', 10:08:32 INFO - 'sessionrestore_no_auto_restore', 10:08:32 INFO - 'tabpaint']}, 10:08:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:08:32 INFO - 'tests': ['a11yr', 10:08:32 INFO - 'ts_paint', 10:08:32 INFO - 'tpaint', 10:08:32 INFO - 'sessionrestore', 10:08:32 INFO - 'sessionrestore_no_auto_restore', 10:08:32 INFO - 'tabpaint']}, 10:08:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:08:32 INFO - 'tests': ['a11yr', 10:08:32 INFO - 'ts_paint', 10:08:32 INFO - 'tpaint', 10:08:32 INFO - 'sessionrestore', 10:08:32 INFO - 'sessionrestore_no_auto_restore', 10:08:32 INFO - 'tabpaint']}, 10:08:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:08:32 INFO - 'tests': ['tsvgx', 10:08:32 INFO - 'tsvgr_opacity', 10:08:32 INFO - 'tart', 10:08:32 INFO - 'tscrollx', 10:08:32 INFO - 'cart', 10:08:32 INFO - 'tsvg_static']}, 10:08:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:08:32 INFO - 'tsvgr_opacity', 10:08:32 INFO - 'tart', 10:08:32 INFO - 'tscrollx', 10:08:32 INFO - 'cart', 10:08:32 INFO - 'tsvg_static']}, 10:08:32 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:08:32 INFO - 'talos_options': ['--disable-e10s'], 10:08:32 INFO - 'tests': ['tp5o']}, 10:08:32 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:08:32 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:08:32 INFO - 'talos_options': ['--disable-e10s', 10:08:32 INFO - '--xperf_path', 10:08:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:08:32 INFO - 'tests': ['tp5n']}, 10:08:32 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:08:32 INFO - 'talos_options': ['--xperf_path', 10:08:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:08:32 INFO - 'tests': ['tp5n']}}, 10:08:32 INFO - 'talos.zip': {'path': '', 10:08:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:08:32 INFO - Running post-action listener: _resource_record_post_action 10:08:32 INFO - [mozharness: 2017-01-30 18:08:32.965082Z] Finished populate-webroot step (success) 10:08:32 INFO - [mozharness: 2017-01-30 18:08:32.965197Z] Running create-virtualenv step. 10:08:32 INFO - Running pre-action listener: _resource_record_pre_action 10:08:32 INFO - Running main action method: create_virtualenv 10:08:32 INFO - Creating virtualenv /builds/slave/test/build/venv 10:08:32 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 10:08:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:08:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:08:33 INFO - Using real prefix '/tools/python27' 10:08:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:08:33 INFO - Installing distribute.............................................................................................................................................................................................done. 10:08:36 INFO - Installing pip.................done. 10:08:36 INFO - Return code: 0 10:08:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:08:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:08:36 INFO - Reading from file tmpfile_stdout 10:08:36 INFO - Output received: 10:08:36 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) 10:08:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:08:36 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')]} 10:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:36 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')]} 10:08:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:36 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 0x104666b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104669768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3dbde0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104444d30>, '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 0x10436bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104439be8>, '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.jibMWWHc1B/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.rpeNHQ5YnU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/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 10:08:36 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 10:08:36 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 10:08:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jibMWWHc1B/Render', 10:08:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:08:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:08:36 INFO - 'HOME': '/Users/cltbld', 10:08:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:08:36 INFO - 'LOGNAME': 'cltbld', 10:08:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:36 INFO - 'MOZ_NO_REMOTE': '1', 10:08:36 INFO - 'NO_EM_RESTART': '1', 10:08:36 INFO - 'PAGER': '/bin/cat', 10:08:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:08:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:36 INFO - 'PWD': '/builds/slave/test', 10:08:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:08:36 INFO - 'SHELL': '/bin/bash', 10:08:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rpeNHQ5YnU/Listeners', 10:08:36 INFO - 'TMPDIR': '/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/', 10:08:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:08:36 INFO - 'USER': 'cltbld', 10:08:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:08:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:08:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:36 INFO - 'XPC_FLAGS': '0x0', 10:08:36 INFO - 'XPC_SERVICE_NAME': '0', 10:08:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:08:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:37 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 10:08:37 INFO - Cleaning up... 10:08:37 INFO - Return code: 0 10:08:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:08:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:08:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:08:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104666b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104669768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3dbde0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104444d30>, '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 0x10436bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104439be8>, '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.jibMWWHc1B/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.rpeNHQ5YnU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/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 10:08:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:08:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:08:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jibMWWHc1B/Render', 10:08:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:08:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:08:37 INFO - 'HOME': '/Users/cltbld', 10:08:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:08:37 INFO - 'LOGNAME': 'cltbld', 10:08:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:37 INFO - 'MOZ_NO_REMOTE': '1', 10:08:37 INFO - 'NO_EM_RESTART': '1', 10:08:37 INFO - 'PAGER': '/bin/cat', 10:08:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:08:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:37 INFO - 'PWD': '/builds/slave/test', 10:08:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:08:37 INFO - 'SHELL': '/bin/bash', 10:08:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rpeNHQ5YnU/Listeners', 10:08:37 INFO - 'TMPDIR': '/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/', 10:08:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:08:37 INFO - 'USER': 'cltbld', 10:08:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:08:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:08:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:37 INFO - 'XPC_FLAGS': '0x0', 10:08:37 INFO - 'XPC_SERVICE_NAME': '0', 10:08:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:08:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:37 INFO - Downloading/unpacking psutil>=3.1.1 10:08:37 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 10:08:37 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 10:08:37 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 10:08:37 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 10:08:37 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 10:08:37 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 10:08:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:08:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:08:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:08:41 INFO - Installing collected packages: psutil 10:08:41 INFO - Running setup.py install for psutil 10:08:41 INFO - building 'psutil._psutil_osx' extension 10:08:41 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 10:08:41 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 10:08:41 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 10:08:41 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 10:08:41 INFO - building 'psutil._psutil_posix' extension 10:08:41 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 10:08:41 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:08:41 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:08:41 INFO - ^ 10:08:41 INFO - 1 warning generated. 10:08:41 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 10:08:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:08:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:08:41 INFO - Successfully installed psutil 10:08:41 INFO - Cleaning up... 10:08:42 INFO - Return code: 0 10:08:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:08:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:08:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:08:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104666b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104669768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3dbde0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104444d30>, '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 0x10436bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104439be8>, '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.jibMWWHc1B/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.rpeNHQ5YnU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/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 10:08:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:08:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:08:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jibMWWHc1B/Render', 10:08:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:08:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:08:42 INFO - 'HOME': '/Users/cltbld', 10:08:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:08:42 INFO - 'LOGNAME': 'cltbld', 10:08:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:42 INFO - 'MOZ_NO_REMOTE': '1', 10:08:42 INFO - 'NO_EM_RESTART': '1', 10:08:42 INFO - 'PAGER': '/bin/cat', 10:08:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:08:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:42 INFO - 'PWD': '/builds/slave/test', 10:08:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:08:42 INFO - 'SHELL': '/bin/bash', 10:08:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rpeNHQ5YnU/Listeners', 10:08:42 INFO - 'TMPDIR': '/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/', 10:08:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:08:42 INFO - 'USER': 'cltbld', 10:08:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:08:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:08:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:42 INFO - 'XPC_FLAGS': '0x0', 10:08:42 INFO - 'XPC_SERVICE_NAME': '0', 10:08:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:08:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:08:42 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 10:08:42 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 10:08:42 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 10:08:42 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 10:08:42 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 10:08:42 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 10:08:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:08:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:08:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:08:44 INFO - Installing collected packages: mozsystemmonitor 10:08:44 INFO - Running setup.py install for mozsystemmonitor 10:08:45 INFO - Successfully installed mozsystemmonitor 10:08:45 INFO - Cleaning up... 10:08:45 INFO - Return code: 0 10:08:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:08:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:08:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:08:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104666b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104669768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3dbde0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104444d30>, '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 0x10436bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104439be8>, '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.jibMWWHc1B/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.rpeNHQ5YnU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/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 10:08:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:08:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:08:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jibMWWHc1B/Render', 10:08:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:08:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:08:45 INFO - 'HOME': '/Users/cltbld', 10:08:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:08:45 INFO - 'LOGNAME': 'cltbld', 10:08:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:45 INFO - 'MOZ_NO_REMOTE': '1', 10:08:45 INFO - 'NO_EM_RESTART': '1', 10:08:45 INFO - 'PAGER': '/bin/cat', 10:08:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:08:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:45 INFO - 'PWD': '/builds/slave/test', 10:08:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:08:45 INFO - 'SHELL': '/bin/bash', 10:08:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rpeNHQ5YnU/Listeners', 10:08:45 INFO - 'TMPDIR': '/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/', 10:08:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:08:45 INFO - 'USER': 'cltbld', 10:08:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:08:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:08:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:45 INFO - 'XPC_FLAGS': '0x0', 10:08:45 INFO - 'XPC_SERVICE_NAME': '0', 10:08:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:08:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:45 INFO - Downloading/unpacking jsonschema==2.5.1 10:08:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:08:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:08:47 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 10:08:47 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 10:08:47 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 10:08:47 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 10:08:47 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 10:08:47 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 10:08:48 INFO - Downloading functools32-3.2.3-2.tar.gz 10:08:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:08:48 INFO - warning: no files found matching '*.txt' 10:08:48 INFO - no previously-included directories found matching 'build' 10:08:48 INFO - no previously-included directories found matching 'dist' 10:08:48 INFO - no previously-included directories found matching '.git*' 10:08:48 INFO - Installing collected packages: jsonschema, functools32 10:08:48 INFO - Running setup.py install for functools32 10:08:48 INFO - warning: no files found matching '*.txt' 10:08:48 INFO - no previously-included directories found matching 'build' 10:08:48 INFO - no previously-included directories found matching 'dist' 10:08:48 INFO - no previously-included directories found matching '.git*' 10:08:48 INFO - Successfully installed jsonschema functools32 10:08:48 INFO - Cleaning up... 10:08:48 INFO - Return code: 0 10:08:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:08:48 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')]} 10:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:48 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')]} 10:08:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:48 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 0x104666b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104669768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3dbde0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104444d30>, '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 0x10436bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104439be8>, '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.jibMWWHc1B/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.rpeNHQ5YnU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/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 10:08:48 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 10:08:48 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 10:08:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jibMWWHc1B/Render', 10:08:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:08:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:08:48 INFO - 'HOME': '/Users/cltbld', 10:08:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:08:48 INFO - 'LOGNAME': 'cltbld', 10:08:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:48 INFO - 'MOZ_NO_REMOTE': '1', 10:08:48 INFO - 'NO_EM_RESTART': '1', 10:08:48 INFO - 'PAGER': '/bin/cat', 10:08:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:08:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:48 INFO - 'PWD': '/builds/slave/test', 10:08:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:08:48 INFO - 'SHELL': '/bin/bash', 10:08:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rpeNHQ5YnU/Listeners', 10:08:48 INFO - 'TMPDIR': '/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/', 10:08:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:08:48 INFO - 'USER': 'cltbld', 10:08:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:08:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:08:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:48 INFO - 'XPC_FLAGS': '0x0', 10:08:48 INFO - 'XPC_SERVICE_NAME': '0', 10:08:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:08:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:08:49 INFO - Cleaning up... 10:08:49 INFO - Return code: 0 10:08:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:08:49 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')]} 10:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:49 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')]} 10:08:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:49 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 0x104666b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104669768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3dbde0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104444d30>, '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 0x10436bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104439be8>, '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.jibMWWHc1B/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.rpeNHQ5YnU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/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 10:08:49 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 10:08:49 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 10:08:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jibMWWHc1B/Render', 10:08:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:08:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:08:49 INFO - 'HOME': '/Users/cltbld', 10:08:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:08:49 INFO - 'LOGNAME': 'cltbld', 10:08:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:49 INFO - 'MOZ_NO_REMOTE': '1', 10:08:49 INFO - 'NO_EM_RESTART': '1', 10:08:49 INFO - 'PAGER': '/bin/cat', 10:08:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:08:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:49 INFO - 'PWD': '/builds/slave/test', 10:08:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:08:49 INFO - 'SHELL': '/bin/bash', 10:08:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rpeNHQ5YnU/Listeners', 10:08:49 INFO - 'TMPDIR': '/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/', 10:08:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:08:49 INFO - 'USER': 'cltbld', 10:08:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:08:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:08:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:49 INFO - 'XPC_FLAGS': '0x0', 10:08:49 INFO - 'XPC_SERVICE_NAME': '0', 10:08:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:08:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:49 INFO - Downloading/unpacking blobuploader==1.2.4 10:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:51 INFO - Downloading blobuploader-1.2.4.tar.gz 10:08:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:08:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:08:52 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 10:08:52 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 10:08:52 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 10:08:52 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 10:08:52 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 10:08:52 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 10:08:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:08:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:08:52 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 10:08:52 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 10:08:52 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 10:08:52 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 10:08:52 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 10:08:52 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 10:08:53 INFO - Downloading docopt-0.6.1.tar.gz 10:08:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:08:53 INFO - Installing collected packages: blobuploader, requests, docopt 10:08:53 INFO - Running setup.py install for blobuploader 10:08:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:08:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:08:53 INFO - Running setup.py install for requests 10:08:53 INFO - Running setup.py install for docopt 10:08:54 INFO - Successfully installed blobuploader requests docopt 10:08:54 INFO - Cleaning up... 10:08:54 INFO - Return code: 0 10:08:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:08:54 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')]} 10:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:54 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')]} 10:08:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:54 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 0x104666b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104669768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3dbde0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104444d30>, '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 0x10436bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104439be8>, '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.jibMWWHc1B/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.rpeNHQ5YnU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/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 10:08:54 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 10:08:54 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 10:08:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jibMWWHc1B/Render', 10:08:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:08:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:08:54 INFO - 'HOME': '/Users/cltbld', 10:08:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:08:54 INFO - 'LOGNAME': 'cltbld', 10:08:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:54 INFO - 'MOZ_NO_REMOTE': '1', 10:08:54 INFO - 'NO_EM_RESTART': '1', 10:08:54 INFO - 'PAGER': '/bin/cat', 10:08:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:08:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:54 INFO - 'PWD': '/builds/slave/test', 10:08:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:08:54 INFO - 'SHELL': '/bin/bash', 10:08:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rpeNHQ5YnU/Listeners', 10:08:54 INFO - 'TMPDIR': '/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/', 10:08:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:08:54 INFO - 'USER': 'cltbld', 10:08:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:08:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:08:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:54 INFO - 'XPC_FLAGS': '0x0', 10:08:54 INFO - 'XPC_SERVICE_NAME': '0', 10:08:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:08:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:08:54 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-_ksJam-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:08:54 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-ksZWHy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:08:54 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-kw9b3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:08:54 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-mkXaGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:08:54 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-GK_hlL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:08:55 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-vE7zaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:08:55 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-MVyO3f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:08:55 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-JxjAy7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:08:55 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-3aVqrb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:08:55 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-2sAfp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:08:55 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-16SMJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:08:55 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-6pKhnK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:08:55 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-D8SO2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:08:55 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-mWux2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:08:55 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-jOWXfi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:08:56 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-l4bN8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:08:56 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-EevQgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:08:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:08:56 INFO - Running setup.py install for manifestparser 10:08:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:08:56 INFO - Running setup.py install for mozcrash 10:08:56 INFO - Running setup.py install for mozdebug 10:08:56 INFO - Running setup.py install for mozdevice 10:08:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:08:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:08:56 INFO - Running setup.py install for mozfile 10:08:57 INFO - Running setup.py install for mozhttpd 10:08:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:08:57 INFO - Running setup.py install for mozinfo 10:08:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:08:57 INFO - Running setup.py install for mozInstall 10:08:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:08:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:08:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:08:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:08:57 INFO - Running setup.py install for mozleak 10:08:57 INFO - Running setup.py install for mozlog 10:08:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:08:57 INFO - Running setup.py install for moznetwork 10:08:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:08:57 INFO - Running setup.py install for mozprocess 10:08:58 INFO - Running setup.py install for mozprofile 10:08:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:08:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:08:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:08:58 INFO - Running setup.py install for mozrunner 10:08:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:08:58 INFO - Running setup.py install for mozscreenshot 10:08:58 INFO - Running setup.py install for moztest 10:08:58 INFO - Running setup.py install for mozversion 10:08:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:08:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:08:58 INFO - Cleaning up... 10:08:58 INFO - Return code: 0 10:08:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:08:58 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')]} 10:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:58 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')]} 10:08:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:58 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 0x104666b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104669768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3dbde0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104444d30>, '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 0x10436bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104439be8>, '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.jibMWWHc1B/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.rpeNHQ5YnU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/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 10:08:58 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 10:08:58 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 10:08:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jibMWWHc1B/Render', 10:08:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:08:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:08:58 INFO - 'HOME': '/Users/cltbld', 10:08:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:08:58 INFO - 'LOGNAME': 'cltbld', 10:08:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:58 INFO - 'MOZ_NO_REMOTE': '1', 10:08:58 INFO - 'NO_EM_RESTART': '1', 10:08:58 INFO - 'PAGER': '/bin/cat', 10:08:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:08:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:58 INFO - 'PWD': '/builds/slave/test', 10:08:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:08:58 INFO - 'SHELL': '/bin/bash', 10:08:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rpeNHQ5YnU/Listeners', 10:08:58 INFO - 'TMPDIR': '/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/', 10:08:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:08:58 INFO - 'USER': 'cltbld', 10:08:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:08:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:08:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:58 INFO - 'XPC_FLAGS': '0x0', 10:08:58 INFO - 'XPC_SERVICE_NAME': '0', 10:08:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:08:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:08:59 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-BGGltN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:08:59 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)) 10:08:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:08:59 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-OF1TRG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:08:59 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)) 10:08:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:08:59 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-cBpzEV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:08:59 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)) 10:08:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:08:59 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-iK78x5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:08:59 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)) 10:08:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:08:59 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-ckJ6oS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:08:59 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)) 10:08:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:08:59 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-HStyAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:08:59 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)) 10:08:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:08:59 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-MsBjtZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:08:59 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)) 10:08:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:08:59 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-nH81O5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:08:59 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)) 10:08:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:08:59 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-pr7g_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:09:00 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)) 10:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:09:00 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-GwFUcs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:09:00 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)) 10:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:09:00 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-zwetDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:09:00 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)) 10:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:09:00 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-qov4uh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:09:00 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)) 10:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:09:00 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-4OiuWQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:09:00 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)) 10:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:09:00 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-m__at9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:09:00 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)) 10:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:09:00 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-EvZoFs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:09:00 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)) 10:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:09:00 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-NQcOAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:09:00 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)) 10:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:09:00 INFO - Running setup.py (path:/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/pip-erH5en-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:09:00 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)) 10:09:00 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)) 10:09:00 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)) 10:09:00 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)) 10:09:00 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)) 10:09:00 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)) 10:09:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:03 INFO - Downloading blessings-1.6.tar.gz 10:09:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:09:03 INFO - Installing collected packages: blessings 10:09:03 INFO - Running setup.py install for blessings 10:09:03 INFO - Successfully installed blessings 10:09:03 INFO - Cleaning up... 10:09:03 INFO - Return code: 0 10:09:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:09:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:09:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:09:04 INFO - Reading from file tmpfile_stdout 10:09:04 INFO - Current package versions: 10:09:04 INFO - blessings == 1.6 10:09:04 INFO - blobuploader == 1.2.4 10:09:04 INFO - docopt == 0.6.1 10:09:04 INFO - functools32 == 3.2.3-2 10:09:04 INFO - jsonschema == 2.5.1 10:09:04 INFO - manifestparser == 1.1 10:09:04 INFO - mozInstall == 1.12 10:09:04 INFO - mozcrash == 1.0 10:09:04 INFO - mozdebug == 0.1 10:09:04 INFO - mozdevice == 0.49 10:09:04 INFO - mozfile == 1.2 10:09:04 INFO - mozhttpd == 0.7 10:09:04 INFO - mozinfo == 0.9 10:09:04 INFO - mozleak == 0.1 10:09:04 INFO - mozlog == 3.4 10:09:04 INFO - moznetwork == 0.27 10:09:04 INFO - mozprocess == 0.24 10:09:04 INFO - mozprofile == 0.28 10:09:04 INFO - mozrunner == 6.13 10:09:04 INFO - mozscreenshot == 0.1 10:09:04 INFO - mozsystemmonitor == 0.3 10:09:04 INFO - moztest == 0.8 10:09:04 INFO - mozversion == 1.4 10:09:04 INFO - psutil == 3.1.1 10:09:04 INFO - requests == 1.2.3 10:09:04 INFO - wsgiref == 0.1.2 10:09:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:09:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:09:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:04 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 0x104666b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104669768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3dbde0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104444d30>, '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 0x10436bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104439be8>, '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.jibMWWHc1B/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.rpeNHQ5YnU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/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 10:09:04 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 10:09:04 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 10:09:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jibMWWHc1B/Render', 10:09:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:09:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:09:04 INFO - 'HOME': '/Users/cltbld', 10:09:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:09:04 INFO - 'LOGNAME': 'cltbld', 10:09:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:04 INFO - 'MOZ_NO_REMOTE': '1', 10:09:04 INFO - 'NO_EM_RESTART': '1', 10:09:04 INFO - 'PAGER': '/bin/cat', 10:09:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:09:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:04 INFO - 'PWD': '/builds/slave/test', 10:09:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:09:04 INFO - 'SHELL': '/bin/bash', 10:09:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rpeNHQ5YnU/Listeners', 10:09:04 INFO - 'TMPDIR': '/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/', 10:09:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:09:04 INFO - 'USER': 'cltbld', 10:09:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:09:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:09:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:04 INFO - 'XPC_FLAGS': '0x0', 10:09:04 INFO - 'XPC_SERVICE_NAME': '0', 10:09:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:09:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:04 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)) 10:09:04 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)) 10:09:04 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)) 10:09:04 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)) 10:09:04 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)) 10:09:04 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)) 10:09:04 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)) 10:09:04 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)) 10:09:04 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)) 10:09:04 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)) 10:09:04 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)) 10:09:04 INFO - Cleaning up... 10:09:04 INFO - Return code: 0 10:09:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:09:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:09:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:05 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 0x104666b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104669768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3dbde0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104444d30>, '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 0x10436bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104439be8>, '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.jibMWWHc1B/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.rpeNHQ5YnU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/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 10:09:05 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 10:09:05 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 10:09:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jibMWWHc1B/Render', 10:09:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:09:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:09:05 INFO - 'HOME': '/Users/cltbld', 10:09:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:09:05 INFO - 'LOGNAME': 'cltbld', 10:09:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:05 INFO - 'MOZ_NO_REMOTE': '1', 10:09:05 INFO - 'NO_EM_RESTART': '1', 10:09:05 INFO - 'PAGER': '/bin/cat', 10:09:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:09:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:05 INFO - 'PWD': '/builds/slave/test', 10:09:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:09:05 INFO - 'SHELL': '/bin/bash', 10:09:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rpeNHQ5YnU/Listeners', 10:09:05 INFO - 'TMPDIR': '/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/', 10:09:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:09:05 INFO - 'USER': 'cltbld', 10:09:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:09:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:09:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:05 INFO - 'XPC_FLAGS': '0x0', 10:09:05 INFO - 'XPC_SERVICE_NAME': '0', 10:09:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:09:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:09:05 INFO - Cleaning up... 10:09:05 INFO - Return code: 0 10:09:05 INFO - Running post-action listener: _resource_record_post_action 10:09:05 INFO - Running post-action listener: _start_resource_monitoring 10:09:05 INFO - Starting resource monitoring. 10:09:05 INFO - [mozharness: 2017-01-30 18:09:05.631566Z] Finished create-virtualenv step (success) 10:09:05 INFO - [mozharness: 2017-01-30 18:09:05.632483Z] Running install step. 10:09:05 INFO - Running pre-action listener: _resource_record_pre_action 10:09:05 INFO - Running main action method: install 10:09:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:09:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:09:05 INFO - Reading from file tmpfile_stdout 10:09:05 INFO - Detecting whether we're running mozinstall >=1.0... 10:09:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:09:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:09:05 INFO - Reading from file tmpfile_stdout 10:09:05 INFO - Output received: 10:09:05 INFO - Usage: mozinstall [options] installer 10:09:05 INFO - Options: 10:09:05 INFO - -h, --help show this help message and exit 10:09:05 INFO - -d DEST, --destination=DEST 10:09:05 INFO - Directory to install application into. [default: 10:09:05 INFO - "/builds/slave/test"] 10:09:05 INFO - --app=APP Application being installed. [default: firefox] 10:09:05 INFO - mkdir: /builds/slave/test/build/application 10:09:05 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'] 10:09:05 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 10:09:26 INFO - Reading from file tmpfile_stdout 10:09:26 INFO - Output received: 10:09:26 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 10:09:26 INFO - Running post-action listener: _resource_record_post_action 10:09:26 INFO - [mozharness: 2017-01-30 18:09:26.156447Z] Finished install step (success) 10:09:26 INFO - [mozharness: 2017-01-30 18:09:26.156593Z] Running run-tests step. 10:09:26 INFO - Running pre-action listener: _resource_record_pre_action 10:09:26 INFO - Running main action method: run_tests 10:09:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:09:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:09:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:09:26 INFO - 2017-01-30 10:09:26.171 screenresolution[1894:14814] starting screenresolution argv=screenresolution get 10:09:26 INFO - 2017-01-30 10:09:26.173 screenresolution[1894:14814] Display 0: 1600x1200x32@60 10:09:26 INFO - 2017-01-30 10:09:26.179 screenresolution[1895:14816] starting screenresolution argv=screenresolution list 10:09:26 INFO - Available Modes on Display 0 10:09:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:09:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:09:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:09:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:09:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:09:26 INFO - Intel Iris: 10:09:26 INFO - Chipset Model: Intel Iris 10:09:26 INFO - Type: GPU 10:09:26 INFO - Bus: Built-In 10:09:26 INFO - VRAM (Dynamic, Max): 1536 MB 10:09:26 INFO - Vendor: Intel (0x8086) 10:09:26 INFO - Device ID: 0x0a2e 10:09:26 INFO - Revision ID: 0x0009 10:09:26 INFO - Displays: 10:09:26 INFO - Display: 10:09:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:09:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:09:26 INFO - Display Serial Number: 1600x1200 60 10:09:26 INFO - Main Display: Yes 10:09:26 INFO - Mirror: Off 10:09:26 INFO - Online: Yes 10:09:26 INFO - Rotation: Supported 10:09:26 INFO - Return code: 0 10:09:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:09:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:09:26 INFO - Python 2.7.3 10:09:26 INFO - Return code: 0 10:09:26 INFO - grabbing minidump binary from tooltool 10:09:26 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')]} 10:09:26 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 0x104444d30>, '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 0x10436bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104439be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:09:26 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 10:09:26 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 10:09:26 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 10:09:26 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:09:26 INFO - Return code: 0 10:09:26 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:09:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:09:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:09:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:09:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:09:26 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/DlQ_hmv0QiK9z8f7Zz4-lw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0391', '--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 10:09:26 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/DlQ_hmv0QiK9z8f7Zz4-lw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0391 --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 10:09:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jibMWWHc1B/Render', 10:09:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:09:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:09:26 INFO - 'HOME': '/Users/cltbld', 10:09:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:09:26 INFO - 'LOGNAME': 'cltbld', 10:09:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:09:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:09:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:26 INFO - 'MOZ_NO_REMOTE': '1', 10:09:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:09:26 INFO - 'NO_EM_RESTART': '1', 10:09:26 INFO - 'PAGER': '/bin/cat', 10:09:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:09:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:26 INFO - 'PWD': '/builds/slave/test', 10:09:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:09:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:09:26 INFO - 'SHELL': '/bin/bash', 10:09:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rpeNHQ5YnU/Listeners', 10:09:26 INFO - 'TMPDIR': '/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/', 10:09:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:09:26 INFO - 'USER': 'cltbld', 10:09:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:09:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:09:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:26 INFO - 'XPC_FLAGS': '0x0', 10:09:26 INFO - 'XPC_SERVICE_NAME': '0', 10:09:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:09:26 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/DlQ_hmv0QiK9z8f7Zz4-lw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0391', '--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 10:09:26 INFO - mozversion application_buildid: 20170130081443 10:09:26 INFO - mozversion application_changeset: 40425a7cb3569597c1277203c8c2d0109bb78468 10:09:26 INFO - mozversion application_display_name: FirefoxDeveloperEdition 10:09:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:09:26 INFO - mozversion application_name: Firefox 10:09:26 INFO - mozversion application_remotingname: firefox-dev 10:09:26 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:09:26 INFO - mozversion application_vendor: Mozilla 10:09:26 INFO - mozversion application_version: 53.0a2 10:09:26 INFO - mozversion platform_buildid: 20170130081443 10:09:26 INFO - mozversion platform_changeset: 40425a7cb3569597c1277203c8c2d0109bb78468 10:09:26 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:09:26 INFO - mozversion platform_version: 53.0a2 10:09:26 INFO - using testdate: 1485799766 10:09:26 INFO - actual date: 1485799766 10:09:26 INFO - starting webserver on 'localhost:53460' 10:09:26 INFO - SUITE-START | Running 2 tests 10:09:26 INFO - TEST-START | dromaeo_css 10:09:26 INFO - operating with platform_type : mac_ 10:09:26 INFO - Initialising browser for dromaeo_css test... 10:09:26 INFO - TEST-INFO | started process 1905 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/tmpD5G_1i/profile http://localhost:53460/getInfo.html) 10:09:29 INFO - PROCESS | 1905 | 2017-01-30 10:09:29.656 plugin-container[1907:14993] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c3f, name = 'com.apple.tsm.portname' 10:09:29 INFO - PROCESS | 1905 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:09:29 INFO - PROCESS | 1905 | 2017-01-30 10:09:29.660 plugin-container[1907:14993] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x960b, name = 'com.apple.CFPasteboardClient' 10:09:29 INFO - PROCESS | 1905 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:09:29 INFO - PROCESS | 1905 | 2017-01-30 10:09:29.660 plugin-container[1907:14993] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:09:29 INFO - PROCESS | 1905 | __metrics Screen width/height:1600/1200 10:09:29 INFO - PROCESS | 1905 | colorDepth:24 10:09:29 INFO - PROCESS | 1905 | Browser inner width/height: 1024/689 10:09:29 INFO - PROCESS | 1905 | __metrics 10:09:29 ERROR - PROCESS | 1905 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 10:09:30 INFO - TEST-INFO | 1905: exit 0 10:09:30 INFO - Browser initialized. 10:09:30 INFO - Running cycle 1/1 for dromaeo_css test... 10:09:30 INFO - TEST-INFO | started process 1908 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/tmpD5G_1i/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:09:32 INFO - PROCESS | 1908 | 2017-01-30 10:09:32.984 plugin-container[1909:15123] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8943, name = 'com.apple.tsm.portname' 10:09:32 INFO - PROCESS | 1908 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:09:32 INFO - PROCESS | 1908 | 2017-01-30 10:09:32.984 plugin-container[1909:15123] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4823, name = 'com.apple.CFPasteboardClient' 10:09:32 INFO - PROCESS | 1908 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:09:32 INFO - PROCESS | 1908 | 2017-01-30 10:09:32.985 plugin-container[1909:15123] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:09:42 INFO - PROCESS | 1908 | RSS: Main: 218517504 10:09:42 INFO - PROCESS | 1908 | 10:12:45 INFO - PROCESS | 1908 | Cycle 1(1): loaded http://localhost:53460/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53460/tests/dromaeo/cssquery-ext.html) 10:12:46 INFO - PROCESS | 1908 | RSS: Main: 237363200 10:12:46 INFO - PROCESS | 1908 | 10:14:30 INFO - PROCESS | 1908 | ************************* 10:14:30 INFO - PROCESS | 1908 | A coding exception was thrown and uncaught in a Task. 10:14:30 INFO - PROCESS | 1908 | 10:14:30 ERROR - PROCESS | 1908 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:14:30 INFO - PROCESS | 1908 | Full stack: 10:14:30 INFO - PROCESS | 1908 | ************************* 10:15:49 INFO - PROCESS | 1908 | Cycle 1(1): loaded http://localhost:53460/tests/dromaeo/cssquery-ext.html (next: http://localhost:53460/tests/dromaeo/cssquery-jquery.html) 10:15:49 INFO - PROCESS | 1908 | RSS: Main: 246882304 10:15:49 INFO - PROCESS | 1908 | 10:18:51 INFO - PROCESS | 1908 | Cycle 1(1): loaded http://localhost:53460/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53460/tests/dromaeo/cssquery-mootools.html) 10:18:52 INFO - PROCESS | 1908 | RSS: Main: 254173184 10:18:52 INFO - PROCESS | 1908 | 10:21:54 INFO - PROCESS | 1908 | Cycle 1(1): loaded http://localhost:53460/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53460/tests/dromaeo/cssquery-prototype.html) 10:21:54 INFO - PROCESS | 1908 | RSS: Main: 251101184 10:21:54 INFO - PROCESS | 1908 | 10:24:57 INFO - PROCESS | 1908 | Cycle 1(1): loaded http://localhost:53460/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53460/tests/dromaeo/cssquery-yui.html) 10:24:58 INFO - PROCESS | 1908 | RSS: Main: 254660608 10:24:58 INFO - PROCESS | 1908 | 10:28:01 INFO - PROCESS | 1908 | Cycle 1(1): loaded http://localhost:53460/tests/dromaeo/cssquery-yui.html (next: http://localhost:53460/tests/dromaeo/cssquery-dojo.html) 10:28:01 INFO - PROCESS | 1908 | RSS: Main: 255975424 10:28:01 INFO - PROCESS | 1908 | 10:28:01 INFO - PROCESS | 1908 | __start_tp_report 10:28:01 INFO - PROCESS | 1908 | _x_x_mozilla_page_load 10:28:01 INFO - PROCESS | 1908 | _x_x_mozilla_page_load_details 10:28:01 INFO - PROCESS | 1908 | |i|pagename|runs| 10:28:01 INFO - PROCESS | 1908 | |0;dojo.html;2975.390045040767;3391.576052993376;3417.606975197853;3420.640832712567;3440.0195944155903;5815.709214539272;5877.853053673661;5901.49837263832;5920.526357891369;5934.851628709284;5913.881722365551;5925.46670799629;5966.731497082631;5983.341832398432;5985.521158307336;5336.493033161843;5351.170568561879;5377.892442151155;5411.134218525037;5417.566594672437;5432.293801805759;5433.891322173554;5437.755301011464;5452.509274165324;5455.890882182354;5289.8942021159555;5294.444083371249;5436.91844622331;5444.564434845222;5462.808801691942;5354.785808567653;5358.437364076774;5375.11310633745;5436.21174929637;5463.125899856043;5286.577073834084;5346.946530534723;5347.0909945309395;5365.302510673627;5408.513233808937;5729.455701708331;5795.739191736382;5962;5982.940170598282;5999.460048595647;6245.656488893109;6250.593711408789;6259.561830671855;6260.686965651745;6294.181756371642;6307.653079080649;6313.747450101991;6329.968350158219;6332.145160403379;6374.968125159391;5995.46040856325;6032.215811944419;6036.607620504653;6042.395760423922;6073.392660733891;6192.442680158807;6205.131281620576;6288.748450062038;6305.8108256752375;6307.873842523216;4768.928466073012;4785.377900872933;6161.507079433634;6226.5641405102115;6245.0632405139595;5663.867226554706;6274.968625156845;6293.96853015732;6302.464290535264;6308.526860485482;5018.5985121190215;6210.161628180228;6215.036669316263;6224.128621992924;6302.338254483305;5080.618953578496;5479.808206712746;6230.065490176419;6231.501479881598;6255.40573645503;5084.44071152173;5087.64386492942;5098.107831129538;5108.386993560796;5126.820561280338;4427.5572442755465;4452.354408610733;4508.887277818081;4563.361129441881;4581.152486789888;5899.616524925866;5912.793052243151;5968.731407086691;5980.85047873798;5981.611195272293;6288.213973253343;6302.527310451643;6316.115743795872;6326.9683651581445;6331.176946996953;5806.2451881255165;5838.357780644125;5923.4668879800165;5941.58408911372;5954.523638108941;5580.776768929198;5588.1059030555725;5591.720413979285;5599.888002239933;5627.718614069362;6495.1556297681;6506.34936506355;6508.381703738042;6512.511561632991;6517.576357536745;6147.72335244924;6183.288921774054;6207.441330280297;6225.595336303126;6312.842178945563;5220.451852555427;6481.4166724994975;6501.902471462838;6530.7387704493185;6541.6075035498025;6219.533534984804;6232.376762323732;6240.594361366497;6288.9685551573775;6290.685465726787;6208.4722798562625;6231.626102433868;6267.435930766071;6321.273053598711;6328.493720502441;6155.2613686356135;6250.968745156245;6254.530910181846;6261;6266;6077.027675571887;6162.784302549389;6230.7507699691505;6240.313565507699;6245.781397651061;4172.3532852407925;4967.3045773591;5885.705714714333;6000.309964354155;6163.907541386793;6115.757578772925;6141.271221159771;6165.84585385369;6242.968785156227;6272.9022421075215;6083.300420451527;6126.6017708848785;6132.63204207749;6157.0456579230295;6175.3824617539685 10:28:01 INFO - PROCESS | 1908 | |1;ext.html;432.24141631436845;433.71374892570907;493.9404976325781;515.1037195280212;516.788116872082;29819.850900745492;40780.38829417557;40792.796036019856;40966.59033409665;40978.79510602443;42258;42526.574734252725;42527;42680.57319426805;42681.35977960333;8490.575471226444;8715.302775777922;9238.168564829164;9493.288003399774;9504.762380940463;11225.989660930514;11544;11576.652700419001;11674.35791031493;11890.108241881893;9775.804483910317;11389.772204555904;11429.657110286706;11440.828387574193;11474.885251147507;9531.80936381272;11365.374904380256;11429.828552571718;11464.19750617457;11469.426528673617;11219.270747401393;11346.432678366049;11432.37121958292;11434.542618295258;11441.713957151054;40469.19061618751;40803.1839363214;40827.59172408297;40900.59099409027;40990.180196396206;4002.4396584478195;4044.838206471767;4046;4072.3687828386646;4125.1131006833375;28609;29445.41109177826;29852.55221171684;30945.535816962765;31014.534781978287;3236.8543415546123;3249.5775549178456;3292.456744637132;3302.702756751904;3379.5268662387284;419255;445699;448206;449877;450954.99999999674;57494;57789.4221057784;57935;57949;57984.71007645019;59729.701351492964;60196;60461.69769151126;60481.092783608285;60906;15668.451604193799;16234.918825405797;16274.023558586523;16323.591910202102;16335.754963675554;11326.32042077478;11658.358790266617;12236.082293827998;12576.308303043237;12646.367681615882;15071.321790519452;17542.122893855256;17732;17953.102344882704;17994.64010719778;7249.673764680602;7252.129744430702;7811.648475818602;7873.330766884879;7965.322947549524;882.4440602420434;894.6108442827391;898.9370744047985;912.6760000199833;932.0958670090001;26163.73836261613;29159.271018224288;30474;30507.2373190672;31215;1059.8463222832645;1084.8969347911936;1089.4389389464432;1129.8474705914762;1205.180477275461;15964.840351596567;16216;16235.188240587924;16235.431759888583;16256.67486650284;255774;256278;257724.71137644566;258538;258565;59543.404565954654;60039;60807.39192608017;60906;60923.69538152281;1447.4210315873734;1452;1474.4765608209145;1489.1958342494931;1491.5450787509697;23575.056997719897;30099.247518811328;30257.848710756305;30374.84812575923;30381.696183037886;51150.48849511457;51797;52055.95888082293;52104.47895520996;52140.739296303276;503421;504652;505229;505250;506100;23630.054797807894;24431.26706198817;26230.737692623592;26462.603060954487;26850;47767.76116119397;47767.76116119536;47906.04187916292;47942;48364.03271934612;38979.805100974314;39471.407928880515;39593.60406396014;39925.655744239724;40829.59170408377;38771.61228387793;38989.61010389973;39202.41196381999;39573.60426395699;40052;37659.43510847285;38286;38540.80729596334;38551.42172867353;38683.03292417712;30410;33052.83473582617;33976.490352645225;34417.31165376728;34752.304953901286;24392.146274880295;24953.786516126256;25618.487630247662;25870.87064564665;26029 10:28:01 INFO - PROCESS | 1908 | |2;jquery.html;357.34605671620926;389.9863504777333;393.25537391373064;399.7581463214755;420.4492115328919;15968.281427335769;20180.69728954067;20192.889391083503;20936;20962.16151353946;20901.895490522566;21195.57608847822;21497.355079347606;21614.20661445606;21771.782282177173;5805.825825225239;5985.042393217086;6014.969925150368;6015.6992150392525;6028.125921741344;5773.3937936516695;5826.563007774413;5939.55453340999;5984.790532331369;6011.338752737217;5938.020226662596;5942.257217847769;5942.286925568917;5943.3462319144855;5948.672822994734;5655.604107712441;5778.624389414675;5842.065269556851;5914.053751399777;5947.316058653245;5070.08738427083;5171.37943446785;5173.663711858717;5180.430152683201;5183.714895680736;24248.54508729482;25564.36089097769;25958.09146679876;26093;26179.738202617922;2514.208024472304;2748.628935093757;3167.524871269305;3171.952420713691;3191.457452233126;9853.90146098537;10160.94919525405;10257.794844103151;10403.271770976035;10473.319234249826;1848.2276585122318;1907.4849790556611;1909.5417099895924;1911.9330823421114;1920.3470819921154;102993;110315.89684103137;117022;117483.825161749;121034;12055.758884822255;12068.758624827455;12158.270503769802;12178.451969661386;12241.245719713172;13959.720805584035;14599.927000365142;15717.764233536505;15753.975991560741;15758.212089395485;8487.660493580312;8738.475691458532;8814.206721395105;8855.158759917798;8984.146506081912;8602.483850968962;8642;8699.304055675531;8791.340649451316;8804.163604457566;4784.234522476387;4814.759262036884;4826.975865120652;4894.2169252920075;4896.436909755353;2030.6547886859269;2079.3553998260586;2083.7082808406835;2085.7392825896763;2088.404804630673;1001.399160503692;1022.3967858963099;1027.8766548014287;1033.540074666766;1038.4236748604446;18856.434306970812;19752.70370944437;21907.67138492924;22007.899605019684;22144.778552214593;925.8750068740768;1039.5062345385882;1055.9419231942318;1074.4466599701161;1090.569225156059;10927.398993055458;11523.596674116367;11535.653930382103;11588.362640054878;11601.361925094201;742493;756917;787873;798512;810507;151578;152908;156333.2183339076;156637;158447;1036.5801850250662;1045.3362115056993;1081.210716177195;1088.2926098036182;1089.5641743302742;19794.703079454106;20147;20364.490887727927;20453.59092818165;20468;59780;60177.69911150416;61295.69352153211;62252.68873655784;62855.74288514296;75737.62131189309;89642.55178724065;89784;90413;91291;8119.269265766109;8192.221738934792;8201.71294004707;8218.547979860927;8384.245417912418;10726.946365268124;12107.51569937228;12308.138430309793;13226;13556.525521606696;9311.860322095039;11153.888461115284;11225.418153824829;11275.154363422613;11460;11202.943985280348;11221.326720396803;11229.71925701864;11486;11507.539698412305;11540.403409232855;11560.47977841016;11596.188266821579;11689.415529223676;11876;8118.985126859143;8177.713780017671;8286.58567071632;8291.751247462586;8481.024682161631;9085.727428177166;9095.454272743656;11210.103191744804;11306.265092768943;11332.206745527734 10:28:01 INFO - PROCESS | 1908 | |3;mootools.html;1436.3321055709093;1437.4968760933675;1464.6817863922467;1466.7873158392033;1480.8593183647554;7298.306660867209;7703.268189521993;7860.213978602152;8164.673413063478;8593.398462107654;8088.797780055502;8365.28895043922;8389.244967952884;8480.067192608809;8510.617022233999;2277.851939623919;2326.9185578504757;2330.3009097270838;2331.8484298520543;2333.0784340185614;2282.4522114692436;2312.2947501012186;2318.478342372961;2318.6869772580653;2326.9883650581723;2299.4366380236866;2311.3066080175963;2324.31432727345;2332.6384410416413;2335.8832058397097;1922.961600735601;1978.9412664224571;2244.236959433784;2290.438842483594;2310.341552657493;1937.4962509747427;2248.718910136233;2309.86140831549;2314.745378008418;2317.2700599311165;8375.49747015175;8402.747917562483;8453.57732113398;8458.407911446202;8467.51818431772;4988.351514303154;5080.187170052811;5088.0587091388215;5138.3577052868395;5139.871503212412;2966.510525763268;3193.2495863472063;3327.2513684421056;3466.722662187019;3480.1473638958364;1220.0727447140148;1242.8943539799127;1260.9495620175182;1265.9620211393674;1275.3049587974576;10813.513391897304;10937.398443085627;10984.560617575287;11006.834897476625;11024.062954648865;4381.189479946156;4581.541845815392;4670.813167473331;4705.858824235278;4746.976265118652;9442.90557094434;9626.711198663912;9651;9655.662051828152;9685.17675997534;4412.404325416028;5206.947930520722;5219.086659834514;5225.817096401608;5229.947700523022;3730.869419570302;4252.978735106305;4597.264437689953;4656;4721.457032441244;3880.2045580656463;3918.3730603103368;3979.46277252573;3993.4209539616595;4030.3148464760475;1298.9545365912147;1311.4295281552554;1312.6324629103867;1321.253491777143;1324.3907802411;768.9231076892378;789.3763926498002;796.6494742313364;800.9559474228856;805.8589746794405;5008.098542262428;5600.243967064475;5608.439156084441;5710.229119068956;5797.768089276382;567.1577707104946;576.4667682393768;578.7019684862299;940.8917974432891;1029.6550655530482;3561.931420573869;3570.1788588624763;3881.4954055973108;3883.3592457244804;3894.3963685628773;10021.699349019542;10056.798864022678;10185.490725463696;10252.077313041862;10267.58929642806;9482.525873706425;9700.5149742514;10071.295009349275;10107.98920107998;10130.848037279447;7757.534547927143;7905.288524032865;8026.357891368676;8038.196180382032;8052.919470805334;5419.458054194549;5580.525655319343;5588.580856435865;5636.4927156556105;5660.20757093999;9015.954920225357;9386.624535018524;9388.014258502759;9413.341066125306;9498.00270971538;8106.270435660819;9271.86092208604;9607.759806004906;9639.855402169112;9695.563699633674;5983.401659833982;6418.679066046586;7122.465815063994;7234.529755565872;7420.740274090381;8130.63412146443;8210.055843577826;8217.424780265324;8224.83550329002;8233.79415514617;6207.844803879939;6362.204724409449;7050.400715939202;7245.347918687344;7320.414366850746;6972.825679358057;7075.5047146699235;7081.787546373617;7209.170945341353;7230.096237970254;6407.519436042408;6426.4216220540375;6487.091807147098;6490.383413575702;6490.480761538971;4478.552144785495;4940.2342636891335;4993.300937868774;5037.722925239001;5098.46466121052;4929.359183306147;5030.195168772979;5084.6440749147205;5099.2860999460845;5140.357455318085 10:28:01 INFO - PROCESS | 1908 | |4;prototype.html;285.96854346021945;354.13944115798597;356.2767581808928;363.28795560701025;370.42029224264024;5184.9222261666055;5310.36275646922;5460.918086228699;5489.725513724317;5665.745041473138;4862.683925544837;5301.840944771653;5482.272055002597;5487.478689524489;5573.219749235111;3964.949288438566;4203.369494575808;4371.453568303962;4391.516933137353;4396.824127034914;3890.961090389088;4090.509138903321;4126.442930204429;4326.675499337546;4366.345048242757;3602.675759181673;3771.5474143102865;4120.134771697947;4253.085586598881;4344.78276086196;3310.751693622964;4334.813911774843;4352.825886964533;4383.684894531628;4404.8458303959205;3226.725728313096;3695.5011073505;3883.825227864753;3884.7280690351686;3888.3972984187494;4505.842295519674;4930.260460930853;4941.1470698488065;4971.130052240879;5320.6275560710765;4428.535003824584;4556.567126123013;4605.723656580616;5018.2974383586325;5077.086124497589;4565.739958720422;5241.0828105081455;5939.613925094898;5944.405559444064;5991.8016396720395;3962.326404511211;4199.307114326163;4234.322508398673;4235.618794308496;4287.6141147296585;5606.24315717377;5623.156526521014;6124.693765311717;6223.630801223769;6229.470495007885;3809.2571948470336;4123.257813593582;4355.73865568067;4375.059362237071;4395.318725597537;3954.022988505747;4125.339945608688;4171.0781278092145;4379.934300985487;4430.756308403069;4391.934120988188;4858.02839432115;4961.751912404366;5004.573696496481;5005.899882002413;4864.73243971585;5301.920471192935;5581.609287349846;5951.880962380728;5973.313068997034;1346.3133801761173;1353.722486890185;1383.4742797736797;1383.5434306678771;1423.8647328503775;924.0205382294789;949.8765160529088;977.9438206736708;994.3791619659908;1010.0404615615195;4599.609033232213;4832.589229915427;4967.726775027336;5070.898582028412;5225.712585807741;5756.798512052058;5765.711714414262;5774.711264436845;5802.6808525531505;5847.210626565445;4310.577509421946;4329.523752387235;4862.78117484714;5051.494850514919;5171.663841850268;2748.6531599516493;2944.336449905796;2969.302213979713;2981.8807247710283;2990.3720218754306;5098;5357.705326207096;5935.554833387513;5962.25471816023;5991.700414979234;4893.730844803499;5048.368953880765;5230.424653288135;5550.86122846924;5886.584342404998;5484.533814625722;5894.322152952465;5923.111533270044;5923.496502797224;5923.637563360451;5638;5680.971595141998;5759.481646651821;5769.009691656372;5779.653220806765;5456.836294911159;5480.725963701879;5677.517411019944;6013.609115407485;6045.78839740607;5294.100002999422;5701.743421545957;5836.854078647898;6310.211223597051;6369.0764839099;3475.9478607821407;3940.763554186758;4009.6591789698205;4021.9597804021587;4079.8385646640854;5268.710220937885;5855.628470469466;6059.424354686298;6097.451229389376;6101.84745381369;5682.886342273214;5817.94182058174;5894.410558944071;5930.584859059824;5940.762369505344;5222.597605101696;5440.619156658996;5852.502537284208;5864.618799778001;5924.6149000314845;5068.67788821743;5122.74386280677;5558.583106266965;5725.484706376279;5795.594308398372;5000.424951130521;5411.918821217606;5802.50678692299;5835.9708201458725;5876.823695289148;5534.236719031098;5776.7400466979925;5782.797602083907;5805.76776928935;5807.274090738658 10:28:01 INFO - PROCESS | 1908 | |5;yui.html;656.9866673262918;669.2938949408373;715.116830714068;793.2503783924191;848.3298194426403;14748.6312842179;15465.38138474461;16015.519534413957;16173.919130404362;16178.35286588538;14367;14574.562763117123;14623.195724235164;14801.629959251024;14805.11169329841;705.2700455029046;867.9696210632613;879.7184900831736;880.0847118996268;881.7222574888922;721.6103304215717;850.9618265715817;870.5168631409565;878.6353663229752;880.1946219209416;907.8093600343935;930.1396208507103;933.4725879877881;936.0545848692835;937;871.3203701113142;930.7207837648679;930.9674161404319;932.9160375566231;933.1648174883475;692.972281108755;693.670506509409;695.0720787748312;695.1762161838187;696.2132789947377;15286.77069843942;15666.608334791608;15674.921625391915;15895.205239737967;16311.59221019484;14381.352839122264;14728.926355368154;14736.263186840615;14753.926230368887;14861.108333500024;11478.770424591461;11917.880821191764;11976.401179941055;12063.155579109465;12335.876641233563;3715.5541335039698;3758.361078616642;3788.034051316924;3806.2958352704563;3854.903627409309;95242.52378738062;98503.50748246284;99468.50265748697;100439;101165.4941725294;8871.379003469696;10183.82885968123;10365.393364028587;10525.578976840994;10887.23789334739;20444.897775511326;20601.175952961712;20641.587168256552;20701.58596828085;20710.68933965992;6802.387785099266;6822.727090916308;7455.254474552501;7965.721199757981;7968.60156992148;4252.085801552681;4261.893452663646;4282.400463935051;4334.566543345703;4455.5989960903025;3545.94681079784;3635.0003748968716;3636.5272514572935;3645.7812531247678;3648.635136486383;563.1271529129914;592.1887014789766;595.2826843653387;616.8149555133442;621.4065567383138;578.9392113828071;590.4685782795518;590.5511811023567;596.4214711729616;627.0813258576208;10394.792104157874;10426.218033647507;10560.207984401048;10615.89384106149;10697.83953240702;596.9644358437308;600.8112928806847;617.8331850400367;658.2232965101131;733.0909672006674;4492;5114.641975061784;5137.332146820964;5144.254083157921;5163.535281824654;71981;72226;79735;88885;89889;68556.97164542536;73869.2613073873;76607.23392766113;87354.56322718473;89414.55292723495;55214.72392638011;68747;70458.64770676114;71740.56518869594;71871;10742.462876855969;11007.669769906915;11247.66257012291;11344.773104537699;11383.260088094248;44879.775601121786;45581.77209113933;45908.54091459043;46783.76608116938;47583.04833903372;58940.70529647324;59119.40880591139;59666.40333596608;60325;61625.76748464916;12760;12802.039847011325;12953;13082.738345233232;13254.138480998705;13844.238566878515;14379.424823006962;14483.855161448671;14564.635884102558;14729.55811325662;13371.598852034454;13761.243131627456;13835.723285534032;14388.712225755635;14428.711425771216;13626.863731362559;13720.313984300945;13765.931170344084;14370.640733981734;14394.28028598545;13496;13496.32518374097;13889.791653125414;14072.085314454527;14107.647308817363;9528.904710953078;9565.378250413702;9611.615535378507;9657.5856035991;9851.867035291034;8555.914440855511;8730.432521886058;8994.370394072352;9103.180713735796;9179.908200917906 10:28:01 INFO - PROCESS | 1908 | __end_tp_report 10:28:01 INFO - PROCESS | 1908 | __start_cc_report 10:28:01 INFO - PROCESS | 1908 | _x_x_mozilla_cycle_collect,378 10:28:01 INFO - PROCESS | 1908 | __end_cc_report 10:28:01 INFO - PROCESS | 1908 | __startTimestamp1485800881347__endTimestamp 10:28:01 INFO - PROCESS | 1908 | 10:28:01 INFO - PROCESS | 1908 | ------- Summary: start ------- 10:28:01 INFO - PROCESS | 1908 | Number of tests: 6 10:28:01 INFO - PROCESS | 1908 | 10:28:01 INFO - PROCESS | 1908 | [#0] dojo.html Cycles:165 Average:5806.76 Median:6032.22 stddev:663.93 (11.0%) stddev-sans-first:627.71 10:28:01 INFO - PROCESS | 1908 | Values: 2975.4 3391.6 3417.6 3420.6 3440.0 5815.7 5877.9 5901.5 5920.5 5934.9 5913.9 5925.5 5966.7 5983.3 5985.5 5336.5 5351.2 5377.9 5411.1 5417.6 5432.3 5433.9 5437.8 5452.5 5455.9 5289.9 5294.4 5436.9 5444.6 5462.8 5354.8 5358.4 5375.1 5436.2 5463.1 5286.6 5346.9 5347.1 5365.3 5408.5 5729.5 5795.7 5962.0 5982.9 5999.5 6245.7 6250.6 6259.6 6260.7 6294.2 6307.7 6313.7 6330.0 6332.1 6375.0 5995.5 6032.2 6036.6 6042.4 6073.4 6192.4 6205.1 6288.7 6305.8 6307.9 4768.9 4785.4 6161.5 6226.6 6245.1 5663.9 6275.0 6294.0 6302.5 6308.5 5018.6 6210.2 6215.0 6224.1 6302.3 5080.6 5479.8 6230.1 6231.5 6255.4 5084.4 5087.6 5098.1 5108.4 5126.8 4427.6 4452.4 4508.9 4563.4 4581.2 5899.6 5912.8 5968.7 5980.9 5981.6 6288.2 6302.5 6316.1 6327.0 6331.2 5806.2 5838.4 5923.5 5941.6 5954.5 5580.8 5588.1 5591.7 5599.9 5627.7 6495.2 6506.3 6508.4 6512.5 6517.6 6147.7 6183.3 6207.4 6225.6 6312.8 5220.5 6481.4 6501.9 6530.7 6541.6 6219.5 6232.4 6240.6 6289.0 6290.7 6208.5 6231.6 6267.4 6321.3 6328.5 6155.3 6251.0 6254.5 6261.0 6266.0 6077.0 6162.8 6230.8 6240.3 6245.8 4172.4 4967.3 5885.7 6000.3 6163.9 6115.8 6141.3 6165.8 6243.0 6272.9 6083.3 6126.6 6132.6 6157.0 6175.4 10:28:01 INFO - PROCESS | 1908 | 10:28:01 INFO - PROCESS | 1908 | [#1] ext.html Cycles:180 Average:56400.85 Median:38413.40 stddev:110203.90 (286.9%) stddev-sans-first:110432.93 10:28:01 INFO - PROCESS | 1908 | Values: 432.2 433.7 493.9 515.1 516.8 29819.9 40780.4 40792.8 40966.6 40978.8 42258.0 42526.6 42527.0 42680.6 42681.4 8490.6 8715.3 9238.2 9493.3 9504.8 11226.0 11544.0 11576.7 11674.4 11890.1 9775.8 11389.8 11429.7 11440.8 11474.9 9531.8 11365.4 11429.8 11464.2 11469.4 11219.3 11346.4 11432.4 11434.5 11441.7 40469.2 40803.2 40827.6 40900.6 40990.2 4002.4 4044.8 4046.0 4072.4 4125.1 28609.0 29445.4 29852.6 30945.5 31014.5 3236.9 3249.6 3292.5 3302.7 3379.5 419255.0 445699.0 448206.0 449877.0 450955.0 57494.0 57789.4 57935.0 57949.0 57984.7 59729.7 60196.0 60461.7 60481.1 60906.0 15668.5 16234.9 16274.0 16323.6 16335.8 11326.3 11658.4 12236.1 12576.3 12646.4 15071.3 17542.1 17732.0 17953.1 17994.6 7249.7 7252.1 7811.6 7873.3 7965.3 882.4 894.6 898.9 912.7 932.1 26163.7 29159.3 30474.0 30507.2 31215.0 1059.8 1084.9 1089.4 1129.8 1205.2 15964.8 16216.0 16235.2 16235.4 16256.7 255774.0 256278.0 257724.7 258538.0 258565.0 59543.4 60039.0 60807.4 60906.0 60923.7 1447.4 1452.0 1474.5 1489.2 1491.5 23575.1 30099.2 30257.8 30374.8 30381.7 51150.5 51797.0 52056.0 52104.5 52140.7 503421.0 504652.0 505229.0 505250.0 506100.0 23630.1 24431.3 26230.7 26462.6 26850.0 47767.8 47767.8 47906.0 47942.0 48364.0 38979.8 39471.4 39593.6 39925.7 40829.6 38771.6 38989.6 39202.4 39573.6 40052.0 37659.4 38286.0 38540.8 38551.4 38683.0 30410.0 33052.8 33976.5 34417.3 34752.3 24392.1 24953.8 25618.5 25870.9 26029.0 10:28:01 INFO - PROCESS | 1908 | 10:28:01 INFO - PROCESS | 1908 | [#2] jquery.html Cycles:180 Average:41344.17 Median:21692.99 stddev:129348.84 (596.3%) stddev-sans-first:129675.08 10:28:01 INFO - PROCESS | 1908 | Values: 357.3 390.0 393.3 399.8 420.4 15968.3 20180.7 20192.9 20936.0 20962.2 20901.9 21195.6 21497.4 21614.2 21771.8 5805.8 5985.0 6015.0 6015.7 6028.1 5773.4 5826.6 5939.6 5984.8 6011.3 5938.0 5942.3 5942.3 5943.3 5948.7 5655.6 5778.6 5842.1 5914.1 5947.3 5070.1 5171.4 5173.7 5180.4 5183.7 24248.5 25564.4 25958.1 26093.0 26179.7 2514.2 2748.6 3167.5 3172.0 3191.5 9853.9 10160.9 10257.8 10403.3 10473.3 1848.2 1907.5 1909.5 1911.9 1920.3 102993.0 110315.9 117022.0 117483.8 121034.0 12055.8 12068.8 12158.3 12178.5 12241.2 13959.7 14599.9 15717.8 15754.0 15758.2 8487.7 8738.5 8814.2 8855.2 8984.1 8602.5 8642.0 8699.3 8791.3 8804.2 4784.2 4814.8 4827.0 4894.2 4896.4 2030.7 2079.4 2083.7 2085.7 2088.4 1001.4 1022.4 1027.9 1033.5 1038.4 18856.4 19752.7 21907.7 22007.9 22144.8 925.9 1039.5 1055.9 1074.4 1090.6 10927.4 11523.6 11535.7 11588.4 11601.4 742493.0 756917.0 787873.0 798512.0 810507.0 151578.0 152908.0 156333.2 156637.0 158447.0 1036.6 1045.3 1081.2 1088.3 1089.6 19794.7 20147.0 20364.5 20453.6 20468.0 59780.0 60177.7 61295.7 62252.7 62855.7 75737.6 89642.6 89784.0 90413.0 91291.0 8119.3 8192.2 8201.7 8218.5 8384.2 10726.9 12107.5 12308.1 13226.0 13556.5 9311.9 11153.9 11225.4 11275.2 11460.0 11202.9 11221.3 11229.7 11486.0 11507.5 11540.4 11560.5 11596.2 11689.4 11876.0 8119.0 8177.7 8286.6 8291.8 8481.0 9085.7 9095.5 11210.1 11306.3 11332.2 10:28:01 INFO - PROCESS | 1908 | 10:28:01 INFO - PROCESS | 1908 | [#3] mootools.html Cycles:180 Average:5430.16 Median:5093.26 stddev:3006.66 (59.0%) stddev-sans-first:3000.11 10:28:01 INFO - PROCESS | 1908 | Values: 1436.3 1437.5 1464.7 1466.8 1480.9 7298.3 7703.3 7860.2 8164.7 8593.4 8088.8 8365.3 8389.2 8480.1 8510.6 2277.9 2326.9 2330.3 2331.8 2333.1 2282.5 2312.3 2318.5 2318.7 2327.0 2299.4 2311.3 2324.3 2332.6 2335.9 1923.0 1978.9 2244.2 2290.4 2310.3 1937.5 2248.7 2309.9 2314.7 2317.3 8375.5 8402.7 8453.6 8458.4 8467.5 4988.4 5080.2 5088.1 5138.4 5139.9 2966.5 3193.2 3327.3 3466.7 3480.1 1220.1 1242.9 1260.9 1266.0 1275.3 10813.5 10937.4 10984.6 11006.8 11024.1 4381.2 4581.5 4670.8 4705.9 4747.0 9442.9 9626.7 9651.0 9655.7 9685.2 4412.4 5206.9 5219.1 5225.8 5229.9 3730.9 4253.0 4597.3 4656.0 4721.5 3880.2 3918.4 3979.5 3993.4 4030.3 1299.0 1311.4 1312.6 1321.3 1324.4 768.9 789.4 796.6 801.0 805.9 5008.1 5600.2 5608.4 5710.2 5797.8 567.2 576.5 578.7 940.9 1029.7 3561.9 3570.2 3881.5 3883.4 3894.4 10021.7 10056.8 10185.5 10252.1 10267.6 9482.5 9700.5 10071.3 10108.0 10130.8 7757.5 7905.3 8026.4 8038.2 8052.9 5419.5 5580.5 5588.6 5636.5 5660.2 9016.0 9386.6 9388.0 9413.3 9498.0 8106.3 9271.9 9607.8 9639.9 9695.6 5983.4 6418.7 7122.5 7234.5 7420.7 8130.6 8210.1 8217.4 8224.8 8233.8 6207.8 6362.2 7050.4 7245.3 7320.4 6972.8 7075.5 7081.8 7209.2 7230.1 6407.5 6426.4 6487.1 6490.4 6490.5 4478.6 4940.2 4993.3 5037.7 5098.5 4929.4 5030.2 5084.6 5099.3 5140.4 10:28:01 INFO - PROCESS | 1908 | 10:28:01 INFO - PROCESS | 1908 | [#4] prototype.html Cycles:180 Average:4683.19 Median:5110.37 stddev:1404.18 (27.5%) stddev-sans-first:1368.79 10:28:01 INFO - PROCESS | 1908 | Values: 286.0 354.1 356.3 363.3 370.4 5184.9 5310.4 5460.9 5489.7 5665.7 4862.7 5301.8 5482.3 5487.5 5573.2 3964.9 4203.4 4371.5 4391.5 4396.8 3891.0 4090.5 4126.4 4326.7 4366.3 3602.7 3771.5 4120.1 4253.1 4344.8 3310.8 4334.8 4352.8 4383.7 4404.8 3226.7 3695.5 3883.8 3884.7 3888.4 4505.8 4930.3 4941.1 4971.1 5320.6 4428.5 4556.6 4605.7 5018.3 5077.1 4565.7 5241.1 5939.6 5944.4 5991.8 3962.3 4199.3 4234.3 4235.6 4287.6 5606.2 5623.2 6124.7 6223.6 6229.5 3809.3 4123.3 4355.7 4375.1 4395.3 3954.0 4125.3 4171.1 4379.9 4430.8 4391.9 4858.0 4961.8 5004.6 5005.9 4864.7 5301.9 5581.6 5951.9 5973.3 1346.3 1353.7 1383.5 1383.5 1423.9 924.0 949.9 977.9 994.4 1010.0 4599.6 4832.6 4967.7 5070.9 5225.7 5756.8 5765.7 5774.7 5802.7 5847.2 4310.6 4329.5 4862.8 5051.5 5171.7 2748.7 2944.3 2969.3 2981.9 2990.4 5098.0 5357.7 5935.6 5962.3 5991.7 4893.7 5048.4 5230.4 5550.9 5886.6 5484.5 5894.3 5923.1 5923.5 5923.6 5638.0 5681.0 5759.5 5769.0 5779.7 5456.8 5480.7 5677.5 6013.6 6045.8 5294.1 5701.7 5836.9 6310.2 6369.1 3475.9 3940.8 4009.7 4022.0 4079.8 5268.7 5855.6 6059.4 6097.5 6101.8 5682.9 5817.9 5894.4 5930.6 5940.8 5222.6 5440.6 5852.5 5864.6 5924.6 5068.7 5122.7 5558.6 5725.5 5795.6 5000.4 5411.9 5802.5 5836.0 5876.8 5534.2 5776.7 5782.8 5805.8 5807.3 10:28:01 INFO - PROCESS | 1908 | 10:28:01 INFO - PROCESS | 1908 | [#5] yui.html Cycles:180 Average:18783.35 Median:47183.41 stddev:25567.73 (54.2%) stddev-sans-first:25603.22 10:28:01 INFO - PROCESS | 1908 | Values: 657.0 669.3 715.1 793.3 848.3 14748.6 15465.4 16015.5 16173.9 16178.4 14367.0 14574.6 14623.2 14801.6 14805.1 705.3 868.0 879.7 880.1 881.7 721.6 851.0 870.5 878.6 880.2 907.8 930.1 933.5 936.1 937.0 871.3 930.7 931.0 932.9 933.2 693.0 693.7 695.1 695.2 696.2 15286.8 15666.6 15674.9 15895.2 16311.6 14381.4 14728.9 14736.3 14753.9 14861.1 11478.8 11917.9 11976.4 12063.2 12335.9 3715.6 3758.4 3788.0 3806.3 3854.9 95242.5 98503.5 99468.5 100439.0 101165.5 8871.4 10183.8 10365.4 10525.6 10887.2 20444.9 20601.2 20641.6 20701.6 20710.7 6802.4 6822.7 7455.3 7965.7 7968.6 4252.1 4261.9 4282.4 4334.6 4455.6 3545.9 3635.0 3636.5 3645.8 3648.6 563.1 592.2 595.3 616.8 621.4 578.9 590.5 590.6 596.4 627.1 10394.8 10426.2 10560.2 10615.9 10697.8 597.0 600.8 617.8 658.2 733.1 4492.0 5114.6 5137.3 5144.3 5163.5 71981.0 72226.0 79735.0 88885.0 89889.0 68557.0 73869.3 76607.2 87354.6 89414.6 55214.7 68747.0 70458.6 71740.6 71871.0 10742.5 11007.7 11247.7 11344.8 11383.3 44879.8 45581.8 45908.5 46783.8 47583.0 58940.7 59119.4 59666.4 60325.0 61625.8 12760.0 12802.0 12953.0 13082.7 13254.1 13844.2 14379.4 14483.9 14564.6 14729.6 13371.6 13761.2 13835.7 14388.7 14428.7 13626.9 13720.3 13765.9 14370.6 14394.3 13496.0 13496.3 13889.8 14072.1 14107.6 9528.9 9565.4 9611.6 9657.6 9851.9 8555.9 8730.4 8994.4 9103.2 9179.9 10:28:01 INFO - PROCESS | 1908 | -------- Summary: end -------- 10:28:01 INFO - PROCESS | 1908 | 10:28:01 INFO - TEST-INFO | 1908: exit 0 10:28:01 INFO - TEST-OK | dromaeo_css | took 1115216ms 10:28:01 INFO - TEST-START | kraken 10:28:01 INFO - operating with platform_type : mac_ 10:28:01 INFO - Initialising browser for kraken test... 10:28:01 INFO - TEST-INFO | started process 1913 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/tmpx9uQDt/profile http://localhost:53460/getInfo.html) 10:28:05 INFO - PROCESS | 1913 | 2017-01-30 10:28:04.999 plugin-container[1914:17061] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d4b, name = 'com.apple.tsm.portname' 10:28:05 INFO - PROCESS | 1913 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:28:05 INFO - PROCESS | 1913 | 2017-01-30 10:28:05.002 plugin-container[1914:17061] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x460b, name = 'com.apple.CFPasteboardClient' 10:28:05 INFO - PROCESS | 1913 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:28:05 INFO - PROCESS | 1913 | 2017-01-30 10:28:05.002 plugin-container[1914:17061] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:28:05 INFO - PROCESS | 1913 | __metrics Screen width/height:1600/1200 10:28:05 INFO - PROCESS | 1913 | colorDepth:24 10:28:05 INFO - PROCESS | 1913 | Browser inner width/height: 1024/689 10:28:05 INFO - PROCESS | 1913 | __metrics 10:28:05 ERROR - PROCESS | 1913 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 10:28:05 INFO - TEST-INFO | 1913: exit 0 10:28:05 INFO - Browser initialized. 10:28:05 INFO - Running cycle 1/1 for kraken test... 10:28:05 INFO - TEST-INFO | started process 1915 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/T/tmpx9uQDt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:28:08 INFO - PROCESS | 1915 | 2017-01-30 10:28:08.510 plugin-container[1916:17187] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x444b, name = 'com.apple.tsm.portname' 10:28:08 INFO - PROCESS | 1915 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:28:08 INFO - PROCESS | 1915 | 2017-01-30 10:28:08.510 plugin-container[1916:17187] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 10:28:08 INFO - PROCESS | 1915 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:28:08 INFO - PROCESS | 1915 | 2017-01-30 10:28:08.510 plugin-container[1916:17187] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:28:18 INFO - PROCESS | 1915 | RSS: Main: 219074560 10:28:18 INFO - PROCESS | 1915 | 10:28:21 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:53460/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53460/tests/kraken/driver.html?testName=audio-beat-detection) 10:28:22 INFO - PROCESS | 1915 | RSS: Main: 233246720 10:28:22 INFO - PROCESS | 1915 | 10:28:24 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:53460/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53460/tests/kraken/driver.html?testName=audio-dft) 10:28:25 INFO - PROCESS | 1915 | RSS: Main: 240824320 10:28:25 INFO - PROCESS | 1915 | 10:28:28 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:53460/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53460/tests/kraken/driver.html?testName=audio-fft) 10:28:29 INFO - PROCESS | 1915 | RSS: Main: 244711424 10:28:29 INFO - PROCESS | 1915 | 10:28:31 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:53460/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53460/tests/kraken/driver.html?testName=audio-oscillator) 10:28:32 INFO - PROCESS | 1915 | RSS: Main: 244985856 10:28:32 INFO - PROCESS | 1915 | 10:28:34 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:53460/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53460/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:28:34 INFO - PROCESS | 1915 | RSS: Main: 246407168 10:28:34 INFO - PROCESS | 1915 | 10:28:37 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:53460/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53460/tests/kraken/driver.html?testName=imaging-darkroom) 10:28:38 INFO - PROCESS | 1915 | RSS: Main: 250093568 10:28:38 INFO - PROCESS | 1915 | 10:28:41 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:53460/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53460/tests/kraken/driver.html?testName=imaging-desaturate) 10:28:42 INFO - PROCESS | 1915 | RSS: Main: 250060800 10:28:42 INFO - PROCESS | 1915 | 10:28:45 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:53460/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53460/tests/kraken/driver.html?testName=json-parse-financial) 10:28:45 INFO - PROCESS | 1915 | RSS: Main: 249663488 10:28:45 INFO - PROCESS | 1915 | 10:28:47 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:53460/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53460/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:28:48 INFO - PROCESS | 1915 | RSS: Main: 249335808 10:28:48 INFO - PROCESS | 1915 | 10:28:50 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:53460/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53460/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:28:50 INFO - PROCESS | 1915 | RSS: Main: 249339904 10:28:50 INFO - PROCESS | 1915 | 10:28:53 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:53460/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53460/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:28:53 INFO - PROCESS | 1915 | RSS: Main: 249397248 10:28:53 INFO - PROCESS | 1915 | 10:28:56 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:53460/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53460/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:28:57 INFO - PROCESS | 1915 | RSS: Main: 249970688 10:28:57 INFO - PROCESS | 1915 | 10:29:00 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:53460/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53460/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:29:01 INFO - PROCESS | 1915 | RSS: Main: 249532416 10:29:01 INFO - PROCESS | 1915 | 10:29:02 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:53460/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53460/tests/kraken/driver.html?testName=ai-astar) 10:29:03 INFO - PROCESS | 1915 | RSS: Main: 251527168 10:29:03 INFO - PROCESS | 1915 | 10:29:03 INFO - PROCESS | 1915 | __start_tp_report 10:29:03 INFO - PROCESS | 1915 | _x_x_mozilla_page_load 10:29:03 INFO - PROCESS | 1915 | _x_x_mozilla_page_load_details 10:29:03 INFO - PROCESS | 1915 | |i|pagename|runs| 10:29:03 INFO - PROCESS | 1915 | |0;ai-astar;107;117;119;99;180;174;128;99;118;126 10:29:03 INFO - PROCESS | 1915 | |1;audio-beat-detection;144;111;130;152;113;115;113;115;142;133 10:29:03 INFO - PROCESS | 1915 | |2;audio-dft;199;227;282;244;200;202;198;198;196;198 10:29:03 INFO - PROCESS | 1915 | |3;audio-fft;80;58;59;86;60;66;86;86;67;88 10:29:03 INFO - PROCESS | 1915 | |4;audio-oscillator;85;70;84;73;68;72;81;69;72;80 10:29:03 INFO - PROCESS | 1915 | |5;imaging-gaussian-blur;90;87;81;96;135;74;91;100;95;131 10:29:03 INFO - PROCESS | 1915 | |6;imaging-darkroom;154;96;97;96;97;135;142;96;96;95 10:29:03 INFO - PROCESS | 1915 | |7;imaging-desaturate;140;146;126;95;112;145;91;146;92;144 10:29:03 INFO - PROCESS | 1915 | |8;json-parse-financial;59;59;61;70;91;98;90;64;64;63 10:29:03 INFO - PROCESS | 1915 | |9;json-stringify-tinderbox;72;77;75;74;71;73;73;65;88;102 10:29:03 INFO - PROCESS | 1915 | |10;stanford-crypto-aes;87;104;79;98;105;105;82;87;86;95 10:29:03 INFO - PROCESS | 1915 | |11;stanford-crypto-ccm;141;153;149;146;146;160;159;164;214;173 10:29:03 INFO - PROCESS | 1915 | |12;stanford-crypto-pbkdf2;169;172;172;173;170;170;169;175;170;170 10:29:03 INFO - PROCESS | 1915 | |13;stanford-crypto-sha256-iterative;68;66;68;65;73;83;95;88;90;80 10:29:03 INFO - PROCESS | 1915 | __end_tp_report 10:29:03 INFO - PROCESS | 1915 | __start_cc_report 10:29:03 INFO - PROCESS | 1915 | _x_x_mozilla_cycle_collect,924 10:29:03 INFO - PROCESS | 1915 | __end_cc_report 10:29:03 INFO - PROCESS | 1915 | __startTimestamp1485800943146__endTimestamp 10:29:03 INFO - PROCESS | 1915 | 10:29:03 INFO - PROCESS | 1915 | ------- Summary: start ------- 10:29:03 INFO - PROCESS | 1915 | Number of tests: 14 10:29:03 INFO - PROCESS | 1915 | 10:29:03 INFO - PROCESS | 1915 | [#0] ai-astar Cycles:10 Average:126.70 Median:151.00 stddev:28.35 (18.8%) stddev-sans-first:29.16 10:29:03 INFO - PROCESS | 1915 | Values: 107.0 117.0 119.0 99.0 180.0 174.0 128.0 99.0 118.0 126.0 10:29:03 INFO - PROCESS | 1915 | 10:29:03 INFO - PROCESS | 1915 | [#1] audio-beat-detection Cycles:10 Average:126.80 Median:131.50 stddev:15.35 (11.7%) stddev-sans-first:14.96 10:29:03 INFO - PROCESS | 1915 | Values: 144.0 111.0 130.0 152.0 113.0 115.0 113.0 115.0 142.0 133.0 10:29:03 INFO - PROCESS | 1915 | 10:29:03 INFO - PROCESS | 1915 | [#2] audio-dft Cycles:10 Average:214.40 Median:201.00 stddev:28.57 (14.2%) stddev-sans-first:29.76 10:29:03 INFO - PROCESS | 1915 | Values: 199.0 227.0 282.0 244.0 200.0 202.0 198.0 198.0 196.0 198.0 10:29:03 INFO - PROCESS | 1915 | 10:29:03 INFO - PROCESS | 1915 | [#3] audio-fft Cycles:10 Average:73.60 Median:83.00 stddev:12.70 (15.3%) stddev-sans-first:13.26 10:29:03 INFO - PROCESS | 1915 | Values: 80.0 58.0 59.0 86.0 60.0 66.0 86.0 86.0 67.0 88.0 10:29:03 INFO - PROCESS | 1915 | 10:29:03 INFO - PROCESS | 1915 | [#4] audio-oscillator Cycles:10 Average:75.40 Median:76.50 stddev:6.43 (8.4%) stddev-sans-first:5.81 10:29:03 INFO - PROCESS | 1915 | Values: 85.0 70.0 84.0 73.0 68.0 72.0 81.0 69.0 72.0 80.0 10:29:03 INFO - PROCESS | 1915 | 10:29:03 INFO - PROCESS | 1915 | [#5] imaging-gaussian-blur Cycles:10 Average:98.00 Median:88.50 stddev:19.93 (22.5%) stddev-sans-first:20.93 10:29:03 INFO - PROCESS | 1915 | Values: 90.0 87.0 81.0 96.0 135.0 74.0 91.0 100.0 95.0 131.0 10:29:03 INFO - PROCESS | 1915 | 10:29:03 INFO - PROCESS | 1915 | [#6] imaging-darkroom Cycles:10 Average:110.40 Median:96.00 stddev:23.41 (24.4%) stddev-sans-first:18.77 10:29:03 INFO - PROCESS | 1915 | Values: 154.0 96.0 97.0 96.0 97.0 135.0 142.0 96.0 96.0 95.0 10:29:03 INFO - PROCESS | 1915 | 10:29:03 INFO - PROCESS | 1915 | [#7] imaging-desaturate Cycles:10 Average:123.70 Median:146.00 stddev:23.96 (16.4%) stddev-sans-first:24.68 10:29:03 INFO - PROCESS | 1915 | Values: 140.0 146.0 126.0 95.0 112.0 145.0 91.0 146.0 92.0 144.0 10:29:03 INFO - PROCESS | 1915 | 10:29:03 INFO - PROCESS | 1915 | [#8] json-parse-financial Cycles:10 Average:71.90 Median:67.00 stddev:15.03 (22.4%) stddev-sans-first:15.20 10:29:03 INFO - PROCESS | 1915 | Values: 59.0 59.0 61.0 70.0 91.0 98.0 90.0 64.0 64.0 63.0 10:29:03 INFO - PROCESS | 1915 | 10:29:03 INFO - PROCESS | 1915 | [#9] json-stringify-tinderbox Cycles:10 Average:77.00 Median:73.50 stddev:10.52 (14.3%) stddev-sans-first:11.00 10:29:03 INFO - PROCESS | 1915 | Values: 72.0 77.0 75.0 74.0 71.0 73.0 73.0 65.0 88.0 102.0 10:29:03 INFO - PROCESS | 1915 | 10:29:03 INFO - PROCESS | 1915 | [#10] stanford-crypto-aes Cycles:10 Average:92.80 Median:86.50 stddev:9.86 (11.4%) stddev-sans-first:10.24 10:29:03 INFO - PROCESS | 1915 | Values: 87.0 104.0 79.0 98.0 105.0 105.0 82.0 87.0 86.0 95.0 10:29:03 INFO - PROCESS | 1915 | 10:29:03 INFO - PROCESS | 1915 | [#11] stanford-crypto-ccm Cycles:10 Average:160.50 Median:159.50 stddev:21.14 (13.3%) stddev-sans-first:21.21 10:29:03 INFO - PROCESS | 1915 | Values: 141.0 153.0 149.0 146.0 146.0 160.0 159.0 164.0 214.0 173.0 10:29:03 INFO - PROCESS | 1915 | 10:29:03 INFO - PROCESS | 1915 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.00 Median:171.00 stddev:1.94 (1.1%) stddev-sans-first:1.92 10:29:03 INFO - PROCESS | 1915 | Values: 169.0 172.0 172.0 173.0 170.0 170.0 169.0 175.0 170.0 170.0 10:29:03 INFO - PROCESS | 1915 | 10:29:03 INFO - PROCESS | 1915 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.60 Median:81.50 stddev:11.05 (13.6%) stddev-sans-first:11.16 10:29:03 INFO - PROCESS | 1915 | Values: 68.0 66.0 68.0 65.0 73.0 83.0 95.0 88.0 90.0 80.0 10:29:03 INFO - PROCESS | 1915 | -------- Summary: end -------- 10:29:03 INFO - PROCESS | 1915 | 10:29:03 INFO - TEST-INFO | 1915: exit 0 10:29:04 INFO - TEST-OK | kraken | took 62043ms 10:29:04 INFO - SUITE-END | took 1177s 10:29:04 INFO - Completed test suite (00:19:37) 10:29:04 INFO - javascript benchmark 10:29:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7326.3053532647145, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2975.390045040767, 3391.576052993376, 3417.606975197853, 3420.640832712567, 3440.0195944155903, 5815.709214539272, 5877.853053673661, 5901.49837263832, 5920.526357891369, 5934.851628709284, 5913.881722365551, 5925.46670799629, 5966.731497082631, 5983.341832398432, 5985.521158307336, 5336.493033161843, 5351.170568561879, 5377.892442151155, 5411.134218525037, 5417.566594672437, 5432.293801805759, 5433.891322173554, 5437.755301011464, 5452.509274165324, 5455.890882182354, 5289.8942021159555, 5294.444083371249, 5436.91844622331, 5444.564434845222, 5462.808801691942, 5354.785808567653, 5358.437364076774, 5375.11310633745, 5436.21174929637, 5463.125899856043, 5286.577073834084, 5346.946530534723, 5347.0909945309395, 5365.302510673627, 5408.513233808937, 5729.455701708331, 5795.739191736382, 5962.0, 5982.940170598282, 5999.460048595647, 6245.656488893109, 6250.593711408789, 6259.561830671855, 6260.686965651745, 6294.181756371642, 6307.653079080649, 6313.747450101991, 6329.968350158219, 6332.145160403379, 6374.968125159391, 5995.46040856325, 6032.215811944419, 6036.607620504653, 6042.395760423922, 6073.392660733891, 6192.442680158807, 6205.131281620576, 6288.748450062038, 6305.8108256752375, 6307.873842523216, 4768.928466073012, 4785.377900872933, 6161.507079433634, 6226.5641405102115, 6245.0632405139595, 5663.867226554706, 6274.968625156845, 6293.96853015732, 6302.464290535264, 6308.526860485482, 5018.5985121190215, 6210.161628180228, 6215.036669316263, 6224.128621992924, 6302.338254483305, 5080.618953578496, 5479.808206712746, 6230.065490176419, 6231.501479881598, 6255.40573645503, 5084.44071152173, 5087.64386492942, 5098.107831129538, 5108.386993560796, 5126.820561280338, 4427.5572442755465, 4452.354408610733, 4508.887277818081, 4563.361129441881, 4581.152486789888, 5899.616524925866, 5912.793052243151, 5968.731407086691, 5980.85047873798, 5981.611195272293, 6288.213973253343, 6302.527310451643, 6316.115743795872, 6326.9683651581445, 6331.176946996953, 5806.2451881255165, 5838.357780644125, 5923.4668879800165, 5941.58408911372, 5954.523638108941, 5580.776768929198, 5588.1059030555725, 5591.720413979285, 5599.888002239933, 5627.718614069362, 6495.1556297681, 6506.34936506355, 6508.381703738042, 6512.511561632991, 6517.576357536745, 6147.72335244924, 6183.288921774054, 6207.441330280297, 6225.595336303126, 6312.842178945563, 5220.451852555427, 6481.4166724994975, 6501.902471462838, 6530.7387704493185, 6541.6075035498025, 6219.533534984804, 6232.376762323732, 6240.594361366497, 6288.9685551573775, 6290.685465726787, 6208.4722798562625, 6231.626102433868, 6267.435930766071, 6321.273053598711, 6328.493720502441, 6155.2613686356135, 6250.968745156245, 6254.530910181846, 6261.0, 6266.0, 6077.027675571887, 6162.784302549389, 6230.7507699691505, 6240.313565507699, 6245.781397651061, 4172.3532852407925, 4967.3045773591, 5885.705714714333, 6000.309964354155, 6163.907541386793, 6115.757578772925, 6141.271221159771, 6165.84585385369, 6242.968785156227, 6272.9022421075215, 6083.300420451527, 6126.6017708848785, 6132.63204207749, 6157.0456579230295, 6175.3824617539685], "value": 5766.872157196416, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [432.24141631436845, 433.71374892570907, 493.9404976325781, 515.1037195280212, 516.788116872082, 29819.850900745492, 40780.38829417557, 40792.796036019856, 40966.59033409665, 40978.79510602443, 42258.0, 42526.574734252725, 42527.0, 42680.57319426805, 42681.35977960333, 8490.575471226444, 8715.302775777922, 9238.168564829164, 9493.288003399774, 9504.762380940463, 11225.989660930514, 11544.0, 11576.652700419001, 11674.35791031493, 11890.108241881893, 9775.804483910317, 11389.772204555904, 11429.657110286706, 11440.828387574193, 11474.885251147507, 9531.80936381272, 11365.374904380256, 11429.828552571718, 11464.19750617457, 11469.426528673617, 11219.270747401393, 11346.432678366049, 11432.37121958292, 11434.542618295258, 11441.713957151054, 40469.19061618751, 40803.1839363214, 40827.59172408297, 40900.59099409027, 40990.180196396206, 4002.4396584478195, 4044.838206471767, 4046.0, 4072.3687828386646, 4125.1131006833375, 28609.0, 29445.41109177826, 29852.55221171684, 30945.535816962765, 31014.534781978287, 3236.8543415546123, 3249.5775549178456, 3292.456744637132, 3302.702756751904, 3379.5268662387284, 419255.0, 445699.0, 448206.0, 449877.0, 450954.99999999674, 57494.0, 57789.4221057784, 57935.0, 57949.0, 57984.71007645019, 59729.701351492964, 60196.0, 60461.69769151126, 60481.092783608285, 60906.0, 15668.451604193799, 16234.918825405797, 16274.023558586523, 16323.591910202102, 16335.754963675554, 11326.32042077478, 11658.358790266617, 12236.082293827998, 12576.308303043237, 12646.367681615882, 15071.321790519452, 17542.122893855256, 17732.0, 17953.102344882704, 17994.64010719778, 7249.673764680602, 7252.129744430702, 7811.648475818602, 7873.330766884879, 7965.322947549524, 882.4440602420434, 894.6108442827391, 898.9370744047985, 912.6760000199833, 932.0958670090001, 26163.73836261613, 29159.271018224288, 30474.0, 30507.2373190672, 31215.0, 1059.8463222832645, 1084.8969347911936, 1089.4389389464432, 1129.8474705914762, 1205.180477275461, 15964.840351596567, 16216.0, 16235.188240587924, 16235.431759888583, 16256.67486650284, 255774.0, 256278.0, 257724.71137644566, 258538.0, 258565.0, 59543.404565954654, 60039.0, 60807.39192608017, 60906.0, 60923.69538152281, 1447.4210315873734, 1452.0, 1474.4765608209145, 1489.1958342494931, 1491.5450787509697, 23575.056997719897, 30099.247518811328, 30257.848710756305, 30374.84812575923, 30381.696183037886, 51150.48849511457, 51797.0, 52055.95888082293, 52104.47895520996, 52140.739296303276, 503421.0, 504652.0, 505229.0, 505250.0, 506100.0, 23630.054797807894, 24431.26706198817, 26230.737692623592, 26462.603060954487, 26850.0, 47767.76116119397, 47767.76116119536, 47906.04187916292, 47942.0, 48364.03271934612, 38979.805100974314, 39471.407928880515, 39593.60406396014, 39925.655744239724, 40829.59170408377, 38771.61228387793, 38989.61010389973, 39202.41196381999, 39573.60426395699, 40052.0, 37659.43510847285, 38286.0, 38540.80729596334, 38551.42172867353, 38683.03292417712, 30410.0, 33052.83473582617, 33976.490352645225, 34417.31165376728, 34752.304953901286, 24392.146274880295, 24953.786516126256, 25618.487630247662, 25870.87064564665, 26029.0], "value": 19688.0427632564, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.34605671620926, 389.9863504777333, 393.25537391373064, 399.7581463214755, 420.4492115328919, 15968.281427335769, 20180.69728954067, 20192.889391083503, 20936.0, 20962.16151353946, 20901.895490522566, 21195.57608847822, 21497.355079347606, 21614.20661445606, 21771.782282177173, 5805.825825225239, 5985.042393217086, 6014.969925150368, 6015.6992150392525, 6028.125921741344, 5773.3937936516695, 5826.563007774413, 5939.55453340999, 5984.790532331369, 6011.338752737217, 5938.020226662596, 5942.257217847769, 5942.286925568917, 5943.3462319144855, 5948.672822994734, 5655.604107712441, 5778.624389414675, 5842.065269556851, 5914.053751399777, 5947.316058653245, 5070.08738427083, 5171.37943446785, 5173.663711858717, 5180.430152683201, 5183.714895680736, 24248.54508729482, 25564.36089097769, 25958.09146679876, 26093.0, 26179.738202617922, 2514.208024472304, 2748.628935093757, 3167.524871269305, 3171.952420713691, 3191.457452233126, 9853.90146098537, 10160.94919525405, 10257.794844103151, 10403.271770976035, 10473.319234249826, 1848.2276585122318, 1907.4849790556611, 1909.5417099895924, 1911.9330823421114, 1920.3470819921154, 102993.0, 110315.89684103137, 117022.0, 117483.825161749, 121034.0, 12055.758884822255, 12068.758624827455, 12158.270503769802, 12178.451969661386, 12241.245719713172, 13959.720805584035, 14599.927000365142, 15717.764233536505, 15753.975991560741, 15758.212089395485, 8487.660493580312, 8738.475691458532, 8814.206721395105, 8855.158759917798, 8984.146506081912, 8602.483850968962, 8642.0, 8699.304055675531, 8791.340649451316, 8804.163604457566, 4784.234522476387, 4814.759262036884, 4826.975865120652, 4894.2169252920075, 4896.436909755353, 2030.6547886859269, 2079.3553998260586, 2083.7082808406835, 2085.7392825896763, 2088.404804630673, 1001.399160503692, 1022.3967858963099, 1027.8766548014287, 1033.540074666766, 1038.4236748604446, 18856.434306970812, 19752.70370944437, 21907.67138492924, 22007.899605019684, 22144.778552214593, 925.8750068740768, 1039.5062345385882, 1055.9419231942318, 1074.4466599701161, 1090.569225156059, 10927.398993055458, 11523.596674116367, 11535.653930382103, 11588.362640054878, 11601.361925094201, 742493.0, 756917.0, 787873.0, 798512.0, 810507.0, 151578.0, 152908.0, 156333.2183339076, 156637.0, 158447.0, 1036.5801850250662, 1045.3362115056993, 1081.210716177195, 1088.2926098036182, 1089.5641743302742, 19794.703079454106, 20147.0, 20364.490887727927, 20453.59092818165, 20468.0, 59780.0, 60177.69911150416, 61295.69352153211, 62252.68873655784, 62855.74288514296, 75737.62131189309, 89642.55178724065, 89784.0, 90413.0, 91291.0, 8119.269265766109, 8192.221738934792, 8201.71294004707, 8218.547979860927, 8384.245417912418, 10726.946365268124, 12107.51569937228, 12308.138430309793, 13226.0, 13556.525521606696, 9311.860322095039, 11153.888461115284, 11225.418153824829, 11275.154363422613, 11460.0, 11202.943985280348, 11221.326720396803, 11229.71925701864, 11486.0, 11507.539698412305, 11540.403409232855, 11560.47977841016, 11596.188266821579, 11689.415529223676, 11876.0, 8118.985126859143, 8177.713780017671, 8286.58567071632, 8291.751247462586, 8481.024682161631, 9085.727428177166, 9095.454272743656, 11210.103191744804, 11306.265092768943, 11332.206745527734], "value": 10028.653978859455, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1436.3321055709093, 1437.4968760933675, 1464.6817863922467, 1466.7873158392033, 1480.8593183647554, 7298.306660867209, 7703.268189521993, 7860.213978602152, 8164.673413063478, 8593.398462107654, 8088.797780055502, 8365.28895043922, 8389.244967952884, 8480.067192608809, 8510.617022233999, 2277.851939623919, 2326.9185578504757, 2330.3009097270838, 2331.8484298520543, 2333.0784340185614, 2282.4522114692436, 2312.2947501012186, 2318.478342372961, 2318.6869772580653, 2326.9883650581723, 2299.4366380236866, 2311.3066080175963, 2324.31432727345, 2332.6384410416413, 2335.8832058397097, 1922.961600735601, 1978.9412664224571, 2244.236959433784, 2290.438842483594, 2310.341552657493, 1937.4962509747427, 2248.718910136233, 2309.86140831549, 2314.745378008418, 2317.2700599311165, 8375.49747015175, 8402.747917562483, 8453.57732113398, 8458.407911446202, 8467.51818431772, 4988.351514303154, 5080.187170052811, 5088.0587091388215, 5138.3577052868395, 5139.871503212412, 2966.510525763268, 3193.2495863472063, 3327.2513684421056, 3466.722662187019, 3480.1473638958364, 1220.0727447140148, 1242.8943539799127, 1260.9495620175182, 1265.9620211393674, 1275.3049587974576, 10813.513391897304, 10937.398443085627, 10984.560617575287, 11006.834897476625, 11024.062954648865, 4381.189479946156, 4581.541845815392, 4670.813167473331, 4705.858824235278, 4746.976265118652, 9442.90557094434, 9626.711198663912, 9651.0, 9655.662051828152, 9685.17675997534, 4412.404325416028, 5206.947930520722, 5219.086659834514, 5225.817096401608, 5229.947700523022, 3730.869419570302, 4252.978735106305, 4597.264437689953, 4656.0, 4721.457032441244, 3880.2045580656463, 3918.3730603103368, 3979.46277252573, 3993.4209539616595, 4030.3148464760475, 1298.9545365912147, 1311.4295281552554, 1312.6324629103867, 1321.253491777143, 1324.3907802411, 768.9231076892378, 789.3763926498002, 796.6494742313364, 800.9559474228856, 805.8589746794405, 5008.098542262428, 5600.243967064475, 5608.439156084441, 5710.229119068956, 5797.768089276382, 567.1577707104946, 576.4667682393768, 578.7019684862299, 940.8917974432891, 1029.6550655530482, 3561.931420573869, 3570.1788588624763, 3881.4954055973108, 3883.3592457244804, 3894.3963685628773, 10021.699349019542, 10056.798864022678, 10185.490725463696, 10252.077313041862, 10267.58929642806, 9482.525873706425, 9700.5149742514, 10071.295009349275, 10107.98920107998, 10130.848037279447, 7757.534547927143, 7905.288524032865, 8026.357891368676, 8038.196180382032, 8052.919470805334, 5419.458054194549, 5580.525655319343, 5588.580856435865, 5636.4927156556105, 5660.20757093999, 9015.954920225357, 9386.624535018524, 9388.014258502759, 9413.341066125306, 9498.00270971538, 8106.270435660819, 9271.86092208604, 9607.759806004906, 9639.855402169112, 9695.563699633674, 5983.401659833982, 6418.679066046586, 7122.465815063994, 7234.529755565872, 7420.740274090381, 8130.63412146443, 8210.055843577826, 8217.424780265324, 8224.83550329002, 8233.79415514617, 6207.844803879939, 6362.204724409449, 7050.400715939202, 7245.347918687344, 7320.414366850746, 6972.825679358057, 7075.5047146699235, 7081.787546373617, 7209.170945341353, 7230.096237970254, 6407.519436042408, 6426.4216220540375, 6487.091807147098, 6490.383413575702, 6490.480761538971, 4478.552144785495, 4940.2342636891335, 4993.300937868774, 5037.722925239001, 5098.46466121052, 4929.359183306147, 5030.195168772979, 5084.6440749147205, 5099.2860999460845, 5140.357455318085], "value": 4374.027853964188, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [285.96854346021945, 354.13944115798597, 356.2767581808928, 363.28795560701025, 370.42029224264024, 5184.9222261666055, 5310.36275646922, 5460.918086228699, 5489.725513724317, 5665.745041473138, 4862.683925544837, 5301.840944771653, 5482.272055002597, 5487.478689524489, 5573.219749235111, 3964.949288438566, 4203.369494575808, 4371.453568303962, 4391.516933137353, 4396.824127034914, 3890.961090389088, 4090.509138903321, 4126.442930204429, 4326.675499337546, 4366.345048242757, 3602.675759181673, 3771.5474143102865, 4120.134771697947, 4253.085586598881, 4344.78276086196, 3310.751693622964, 4334.813911774843, 4352.825886964533, 4383.684894531628, 4404.8458303959205, 3226.725728313096, 3695.5011073505, 3883.825227864753, 3884.7280690351686, 3888.3972984187494, 4505.842295519674, 4930.260460930853, 4941.1470698488065, 4971.130052240879, 5320.6275560710765, 4428.535003824584, 4556.567126123013, 4605.723656580616, 5018.2974383586325, 5077.086124497589, 4565.739958720422, 5241.0828105081455, 5939.613925094898, 5944.405559444064, 5991.8016396720395, 3962.326404511211, 4199.307114326163, 4234.322508398673, 4235.618794308496, 4287.6141147296585, 5606.24315717377, 5623.156526521014, 6124.693765311717, 6223.630801223769, 6229.470495007885, 3809.2571948470336, 4123.257813593582, 4355.73865568067, 4375.059362237071, 4395.318725597537, 3954.022988505747, 4125.339945608688, 4171.0781278092145, 4379.934300985487, 4430.756308403069, 4391.934120988188, 4858.02839432115, 4961.751912404366, 5004.573696496481, 5005.899882002413, 4864.73243971585, 5301.920471192935, 5581.609287349846, 5951.880962380728, 5973.313068997034, 1346.3133801761173, 1353.722486890185, 1383.4742797736797, 1383.5434306678771, 1423.8647328503775, 924.0205382294789, 949.8765160529088, 977.9438206736708, 994.3791619659908, 1010.0404615615195, 4599.609033232213, 4832.589229915427, 4967.726775027336, 5070.898582028412, 5225.712585807741, 5756.798512052058, 5765.711714414262, 5774.711264436845, 5802.6808525531505, 5847.210626565445, 4310.577509421946, 4329.523752387235, 4862.78117484714, 5051.494850514919, 5171.663841850268, 2748.6531599516493, 2944.336449905796, 2969.302213979713, 2981.8807247710283, 2990.3720218754306, 5098.0, 5357.705326207096, 5935.554833387513, 5962.25471816023, 5991.700414979234, 4893.730844803499, 5048.368953880765, 5230.424653288135, 5550.86122846924, 5886.584342404998, 5484.533814625722, 5894.322152952465, 5923.111533270044, 5923.496502797224, 5923.637563360451, 5638.0, 5680.971595141998, 5759.481646651821, 5769.009691656372, 5779.653220806765, 5456.836294911159, 5480.725963701879, 5677.517411019944, 6013.609115407485, 6045.78839740607, 5294.100002999422, 5701.743421545957, 5836.854078647898, 6310.211223597051, 6369.0764839099, 3475.9478607821407, 3940.763554186758, 4009.6591789698205, 4021.9597804021587, 4079.8385646640854, 5268.710220937885, 5855.628470469466, 6059.424354686298, 6097.451229389376, 6101.84745381369, 5682.886342273214, 5817.94182058174, 5894.410558944071, 5930.584859059824, 5940.762369505344, 5222.597605101696, 5440.619156658996, 5852.502537284208, 5864.618799778001, 5924.6149000314845, 5068.67788821743, 5122.74386280677, 5558.583106266965, 5725.484706376279, 5795.594308398372, 5000.424951130521, 5411.918821217606, 5802.50678692299, 5835.9708201458725, 5876.823695289148, 5534.236719031098, 5776.7400466979925, 5782.797602083907, 5805.76776928935, 5807.274090738658], "value": 4247.433998674076, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [656.9866673262918, 669.2938949408373, 715.116830714068, 793.2503783924191, 848.3298194426403, 14748.6312842179, 15465.38138474461, 16015.519534413957, 16173.919130404362, 16178.35286588538, 14367.0, 14574.562763117123, 14623.195724235164, 14801.629959251024, 14805.11169329841, 705.2700455029046, 867.9696210632613, 879.7184900831736, 880.0847118996268, 881.7222574888922, 721.6103304215717, 850.9618265715817, 870.5168631409565, 878.6353663229752, 880.1946219209416, 907.8093600343935, 930.1396208507103, 933.4725879877881, 936.0545848692835, 937.0, 871.3203701113142, 930.7207837648679, 930.9674161404319, 932.9160375566231, 933.1648174883475, 692.972281108755, 693.670506509409, 695.0720787748312, 695.1762161838187, 696.2132789947377, 15286.77069843942, 15666.608334791608, 15674.921625391915, 15895.205239737967, 16311.59221019484, 14381.352839122264, 14728.926355368154, 14736.263186840615, 14753.926230368887, 14861.108333500024, 11478.770424591461, 11917.880821191764, 11976.401179941055, 12063.155579109465, 12335.876641233563, 3715.5541335039698, 3758.361078616642, 3788.034051316924, 3806.2958352704563, 3854.903627409309, 95242.52378738062, 98503.50748246284, 99468.50265748697, 100439.0, 101165.4941725294, 8871.379003469696, 10183.82885968123, 10365.393364028587, 10525.578976840994, 10887.23789334739, 20444.897775511326, 20601.175952961712, 20641.587168256552, 20701.58596828085, 20710.68933965992, 6802.387785099266, 6822.727090916308, 7455.254474552501, 7965.721199757981, 7968.60156992148, 4252.085801552681, 4261.893452663646, 4282.400463935051, 4334.566543345703, 4455.5989960903025, 3545.94681079784, 3635.0003748968716, 3636.5272514572935, 3645.7812531247678, 3648.635136486383, 563.1271529129914, 592.1887014789766, 595.2826843653387, 616.8149555133442, 621.4065567383138, 578.9392113828071, 590.4685782795518, 590.5511811023567, 596.4214711729616, 627.0813258576208, 10394.792104157874, 10426.218033647507, 10560.207984401048, 10615.89384106149, 10697.83953240702, 596.9644358437308, 600.8112928806847, 617.8331850400367, 658.2232965101131, 733.0909672006674, 4492.0, 5114.641975061784, 5137.332146820964, 5144.254083157921, 5163.535281824654, 71981.0, 72226.0, 79735.0, 88885.0, 89889.0, 68556.97164542536, 73869.2613073873, 76607.23392766113, 87354.56322718473, 89414.55292723495, 55214.72392638011, 68747.0, 70458.64770676114, 71740.56518869594, 71871.0, 10742.462876855969, 11007.669769906915, 11247.66257012291, 11344.773104537699, 11383.260088094248, 44879.775601121786, 45581.77209113933, 45908.54091459043, 46783.76608116938, 47583.04833903372, 58940.70529647324, 59119.40880591139, 59666.40333596608, 60325.0, 61625.76748464916, 12760.0, 12802.039847011325, 12953.0, 13082.738345233232, 13254.138480998705, 13844.238566878515, 14379.424823006962, 14483.855161448671, 14564.635884102558, 14729.55811325662, 13371.598852034454, 13761.243131627456, 13835.723285534032, 14388.712225755635, 14428.711425771216, 13626.863731362559, 13720.313984300945, 13765.931170344084, 14370.640733981734, 14394.28028598545, 13496.0, 13496.32518374097, 13889.791653125414, 14072.085314454527, 14107.647308817363, 9528.904710953078, 9565.378250413702, 9611.615535378507, 9657.5856035991, 9851.867035291034, 8555.914440855511, 8730.432521886058, 8994.370394072352, 9103.180713735796, 9179.908200917906], "value": 7309.210220709733, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1599.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 117.0, 119.0, 99.0, 180.0, 174.0, 128.0, 99.0, 118.0, 126.0], "value": 126.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 111.0, 130.0, 152.0, 113.0, 115.0, 113.0, 115.0, 142.0, 133.0], "value": 126.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 227.0, 282.0, 244.0, 200.0, 202.0, 198.0, 198.0, 196.0, 198.0], "value": 214.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 58.0, 59.0, 86.0, 60.0, 66.0, 86.0, 86.0, 67.0, 88.0], "value": 73.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 70.0, 84.0, 73.0, 68.0, 72.0, 81.0, 69.0, 72.0, 80.0], "value": 75.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 81.0, 96.0, 135.0, 74.0, 91.0, 100.0, 95.0, 131.0], "value": 98.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 96.0, 97.0, 96.0, 97.0, 135.0, 142.0, 96.0, 96.0, 95.0], "value": 110.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 146.0, 126.0, 95.0, 112.0, 145.0, 91.0, 146.0, 92.0, 144.0], "value": 123.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 61.0, 70.0, 91.0, 98.0, 90.0, 64.0, 64.0, 63.0], "value": 71.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 77.0, 75.0, 74.0, 71.0, 73.0, 73.0, 65.0, 88.0, 102.0], "value": 77.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 104.0, 79.0, 98.0, 105.0, 105.0, 82.0, 87.0, 86.0, 95.0], "value": 92.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 153.0, 149.0, 146.0, 146.0, 160.0, 159.0, 164.0, 214.0, 173.0], "value": 160.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 172.0, 172.0, 173.0, 170.0, 170.0, 169.0, 175.0, 170.0, 170.0], "value": 171.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 68.0, 65.0, 73.0, 83.0, 95.0, 88.0, 90.0, 80.0], "value": 77.6, "unit": "score"}]}]} 10:29:04 INFO - Return code: 0 10:29:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:29:04 ERROR - # TBPL SUCCESS # 10:29:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:29:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:29:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:29:04 INFO - 2017-01-30 10:29:04.452 screenresolution[1920:17581] starting screenresolution argv=screenresolution get 10:29:04 INFO - 2017-01-30 10:29:04.454 screenresolution[1920:17581] Display 0: 1600x1200x32@60 10:29:04 INFO - 2017-01-30 10:29:04.460 screenresolution[1921:17584] starting screenresolution argv=screenresolution list 10:29:04 INFO - Available Modes on Display 0 10:29:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:29:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:29:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:29:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:29:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:29:04 INFO - Intel Iris: 10:29:04 INFO - Chipset Model: Intel Iris 10:29:04 INFO - Type: GPU 10:29:04 INFO - Bus: Built-In 10:29:04 INFO - VRAM (Dynamic, Max): 1536 MB 10:29:04 INFO - Vendor: Intel (0x8086) 10:29:04 INFO - Device ID: 0x0a2e 10:29:04 INFO - Revision ID: 0x0009 10:29:04 INFO - Displays: 10:29:04 INFO - Display: 10:29:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:29:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:29:04 INFO - Display Serial Number: 1600x1200 60 10:29:04 INFO - Main Display: Yes 10:29:04 INFO - Mirror: Off 10:29:04 INFO - Online: Yes 10:29:04 INFO - Rotation: Supported 10:29:04 INFO - Return code: 0 10:29:04 INFO - Running post-action listener: _resource_record_post_action 10:29:04 INFO - [mozharness: 2017-01-30 18:29:04.696254Z] Finished run-tests step (success) 10:29:04 INFO - Running post-run listener: _resource_record_post_run 10:29:04 INFO - Total resource usage - Wall time: 1198s; CPU: 55.0%; Read bytes: 1684992; Write bytes: 509721088; Read time: 14; Write time: 1606 10:29:04 INFO - TinderboxPrint: CPU usage
54.6% 10:29:04 INFO - TinderboxPrint: I/O read bytes / time
1,684,992 / 14 10:29:04 INFO - TinderboxPrint: I/O write bytes / time
509,721,088 / 1,606 10:29:04 INFO - TinderboxPrint: CPU idle
2,177.5 (45.4%) 10:29:04 INFO - TinderboxPrint: CPU system
971.4 (20.3%) 10:29:04 INFO - TinderboxPrint: CPU user
1,644.8 (34.3%) 10:29:04 INFO - TinderboxPrint: Swap in / out
209,833,984 / 0 10:29:04 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 202998272; Write bytes: 198758400; Read time: 15619; Write time: 420 10:29:04 INFO - run-tests - Wall time: 1179s; CPU: 55.0%; Read bytes: 1684992; Write bytes: 300276224; Read time: 14; Write time: 1148 10:29:05 INFO - Running post-run listener: _upload_blobber_files 10:29:05 INFO - Blob upload gear active. 10:29:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:29:05 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 10:29:05 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'] 10:29:05 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 10:29:05 INFO - (blobuploader) - INFO - Open directory for files ... 10:29:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:29:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:29:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:29:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:29:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:29:06 INFO - (blobuploader) - INFO - Done attempting. 10:29:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:29:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:29:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:29:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:29:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:29:07 INFO - (blobuploader) - INFO - Done attempting. 10:29:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:29:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:29:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:29:08 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:29:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:29:08 INFO - (blobuploader) - INFO - Done attempting. 10:29:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:29:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:29:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:29:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:29:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:29:10 INFO - (blobuploader) - INFO - Done attempting. 10:29:10 INFO - (blobuploader) - INFO - Iteration through files over. 10:29:10 INFO - Return code: 0 10:29:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:29:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:29:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/422f618528b4fc8d859effb25ac05d3ef1b490282d21b0a77ae092c088e57451794eb25ae429a9f1244a913150840d706b1de114b9b284753b0cfa4ab1548f7d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/de2e6cd235cda5765695a2d4ee0cb8256e1354068b6577c9b91ff87477245228829383f9ed14bc02bd7267a72da0e561e3b237a2bfa673b0bb401b56ce82b41a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3dbbf42775f9332c0b6ba0c7883dbb900468f90fcae7dfae99875afe3db97e1b25ee8d9417743d44580c10f2b3214c0e6f616377db6b17fcae1e4b748189d27f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fe8bff93ccf8b32d5eb6a57d0f7391aebcaa94573cd652c8e8704fe38378afb8590637a59497e53e647bb68518f0969c715afc556857c072035055ea724c67fe"} 10:29:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:29:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:29:10 INFO - Contents: 10:29:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/422f618528b4fc8d859effb25ac05d3ef1b490282d21b0a77ae092c088e57451794eb25ae429a9f1244a913150840d706b1de114b9b284753b0cfa4ab1548f7d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/de2e6cd235cda5765695a2d4ee0cb8256e1354068b6577c9b91ff87477245228829383f9ed14bc02bd7267a72da0e561e3b237a2bfa673b0bb401b56ce82b41a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3dbbf42775f9332c0b6ba0c7883dbb900468f90fcae7dfae99875afe3db97e1b25ee8d9417743d44580c10f2b3214c0e6f616377db6b17fcae1e4b748189d27f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fe8bff93ccf8b32d5eb6a57d0f7391aebcaa94573cd652c8e8704fe38378afb8590637a59497e53e647bb68518f0969c715afc556857c072035055ea724c67fe"} 10:29:10 INFO - Running post-run listener: copy_logs_to_upload_dir 10:29:10 INFO - Copying logs to upload dir... 10:29:10 INFO - mkdir: /builds/slave/test/build/upload/logs 10:29:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.486197 ========= master_lag: 0.96 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-01-30 10:29:11.216795) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-30 10:29:11.221606) ========= 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.jibMWWHc1B/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.rpeNHQ5YnU/Listeners TMPDIR=/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/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/422f618528b4fc8d859effb25ac05d3ef1b490282d21b0a77ae092c088e57451794eb25ae429a9f1244a913150840d706b1de114b9b284753b0cfa4ab1548f7d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/de2e6cd235cda5765695a2d4ee0cb8256e1354068b6577c9b91ff87477245228829383f9ed14bc02bd7267a72da0e561e3b237a2bfa673b0bb401b56ce82b41a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3dbbf42775f9332c0b6ba0c7883dbb900468f90fcae7dfae99875afe3db97e1b25ee8d9417743d44580c10f2b3214c0e6f616377db6b17fcae1e4b748189d27f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fe8bff93ccf8b32d5eb6a57d0f7391aebcaa94573cd652c8e8704fe38378afb8590637a59497e53e647bb68518f0969c715afc556857c072035055ea724c67fe"} build_url:https://queue.taskcluster.net/v1/task/DlQ_hmv0QiK9z8f7Zz4-lw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011117 build_url: 'https://queue.taskcluster.net/v1/task/DlQ_hmv0QiK9z8f7Zz4-lw/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/422f618528b4fc8d859effb25ac05d3ef1b490282d21b0a77ae092c088e57451794eb25ae429a9f1244a913150840d706b1de114b9b284753b0cfa4ab1548f7d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/de2e6cd235cda5765695a2d4ee0cb8256e1354068b6577c9b91ff87477245228829383f9ed14bc02bd7267a72da0e561e3b237a2bfa673b0bb401b56ce82b41a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3dbbf42775f9332c0b6ba0c7883dbb900468f90fcae7dfae99875afe3db97e1b25ee8d9417743d44580c10f2b3214c0e6f616377db6b17fcae1e4b748189d27f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fe8bff93ccf8b32d5eb6a57d0f7391aebcaa94573cd652c8e8704fe38378afb8590637a59497e53e647bb68518f0969c715afc556857c072035055ea724c67fe"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-30 10:29:11.264217) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 10:29:11.264647) ========= 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.jibMWWHc1B/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.rpeNHQ5YnU/Listeners TMPDIR=/var/folders/bb/ktj0_qbn2d57sqn3vz5wnz8000000w/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.005159 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 10:29:11.313917) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-30 10:29:11.317405) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-30 10:29:11.317869) ========= ========= Total master_lag: 1.11 =========