builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0338 starttime: 1490970259.82 results: success (0) buildid: 20170331063801 builduid: 2f7668d0933e474785785f7a1bf7d7c8 revision: 1105ff76f42a96c1af3a54c043aa2a338ca45081 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-31 07:24:19.821084) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-31 07:24:19.821553) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-31 07:24:19.821862) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-31 07:24:19.852620) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 07:24:19.853029) ========= 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.bWtNnGumta/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.bsyzc7rrLI/Listeners TMPDIR=/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-31 07:24:19-- 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% 7.92M=0.001s 2017-03-31 07:24:19 (7.92 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.105174 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 07:24:19.981938) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 07:24:19.982260) ========= 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.bWtNnGumta/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.bsyzc7rrLI/Listeners TMPDIR=/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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.022407 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 07:24:20.033599) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-31 07:24:20.037007) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1105ff76f42a96c1af3a54c043aa2a338ca45081 --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 1105ff76f42a96c1af3a54c043aa2a338ca45081 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bWtNnGumta/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.bsyzc7rrLI/Listeners TMPDIR=/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-31 07:24:20,129 truncating revision to first 12 chars 2017-03-31 07:24:20,129 Setting DEBUG logging. 2017-03-31 07:24:20,129 attempt 1/10 2017-03-31 07:24:20,129 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1105ff76f42a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-31 07:24:21,437 unpacking tar archive at: mozilla-aurora-1105ff76f42a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.572280 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-31 07:24:21.632740) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-31 07:24:21.633070) ========= script_repo_revision: 1105ff76f42a96c1af3a54c043aa2a338ca45081 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-31 07:24:21.633479) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-31 07:24:21.633893) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-31 07:24:21.653944) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2017-03-31 07:24:21.654314) ========= /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.bWtNnGumta/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.bsyzc7rrLI/Listeners TMPDIR=/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 07:24:21 INFO - MultiFileLogger online at 20170331 07:24:21 in /builds/slave/test 07:24:21 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 07:24:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:24:21 INFO - {'append_to_log': False, 07:24:21 INFO - 'base_work_dir': '/builds/slave/test', 07:24:21 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:24:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:24:21 INFO - 'branch': 'Mozilla-Aurora', 07:24:21 INFO - 'buildbot_json_path': 'buildprops.json', 07:24:21 INFO - 'config_files': ('talos/mac_config.py',), 07:24:21 INFO - 'default_actions': ('clobber', 07:24:21 INFO - 'read-buildbot-config', 07:24:21 INFO - 'download-and-extract', 07:24:21 INFO - 'populate-webroot', 07:24:21 INFO - 'create-virtualenv', 07:24:21 INFO - 'install', 07:24:21 INFO - 'run-tests'), 07:24:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:24:21 INFO - 'download_minidump_stackwalk': True, 07:24:21 INFO - 'download_symbols': 'ondemand', 07:24:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:24:21 INFO - 'tooltool.py': '/tools/tooltool.py', 07:24:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:24:21 INFO - '/tools/misc-python/virtualenv.py')}, 07:24:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:24:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:24:21 INFO - 'gecko_profile': False, 07:24:21 INFO - 'gecko_profile_interval': 0, 07:24:21 INFO - 'installer_path': 'installer.exe', 07:24:21 INFO - 'log_level': 'info', 07:24:21 INFO - 'log_name': 'talos', 07:24:21 INFO - 'log_to_console': True, 07:24:21 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:24:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:24:21 INFO - 'opt_config_files': (), 07:24:21 INFO - 'pip_index': False, 07:24:21 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:24:21 INFO - 'cmd': ('bash', 07:24:21 INFO - '-c', 07:24:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:24:21 INFO - 'enabled': True, 07:24:21 INFO - 'halt_on_failure': False, 07:24:21 INFO - 'name': 'check_screen_resolution'},), 07:24:21 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:24:21 INFO - 'cmd': ('bash', 07:24:21 INFO - '-c', 07:24:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:24:21 INFO - 'enabled': True, 07:24:21 INFO - 'halt_on_failure': False, 07:24:21 INFO - 'name': 'check_screen_resolution'},), 07:24:21 INFO - 'run_cmd_checks_enabled': True, 07:24:21 INFO - 'suite': 'dromaeojs-e10s', 07:24:21 INFO - 'system_bits': '32', 07:24:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:24:21 INFO - 'title': 't-yosemite-r7-0338', 07:24:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:24:21 INFO - 'use_talos_json': True, 07:24:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:24:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:24:21 INFO - 'work_dir': 'build'} 07:24:21 INFO - [mozharness: 2017-03-31 14:24:21.861072Z] Running clobber step. 07:24:21 INFO - Running pre-action listener: _resource_record_pre_action 07:24:21 INFO - Running main action method: clobber 07:24:21 INFO - rmtree: /builds/slave/test/build 07:24:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:24:23 INFO - Running post-action listener: _resource_record_post_action 07:24:23 INFO - [mozharness: 2017-03-31 14:24:23.618062Z] Finished clobber step (success) 07:24:23 INFO - [mozharness: 2017-03-31 14:24:23.618217Z] Running read-buildbot-config step. 07:24:23 INFO - Running pre-action listener: _resource_record_pre_action 07:24:23 INFO - Running main action method: read_buildbot_config 07:24:23 INFO - Using buildbot properties: 07:24:23 INFO - { 07:24:23 INFO - "project": "", 07:24:23 INFO - "product": "firefox", 07:24:23 INFO - "script_repo_revision": "production", 07:24:23 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 07:24:23 INFO - "repository": "", 07:24:23 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 07:24:23 INFO - "buildid": "20170331063801", 07:24:23 INFO - "pgo_build": "False", 07:24:23 INFO - "basedir": "/builds/slave/test", 07:24:23 INFO - "buildnumber": 17, 07:24:23 INFO - "slavename": "t-yosemite-r7-0338", 07:24:23 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 07:24:23 INFO - "platform": "yosemite_r7", 07:24:23 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 07:24:23 INFO - "branch": "mozilla-aurora", 07:24:23 INFO - "repo_path": "releases/mozilla-aurora", 07:24:23 INFO - "revision": "1105ff76f42a96c1af3a54c043aa2a338ca45081", 07:24:23 INFO - "stage_platform": "macosx64", 07:24:23 INFO - "builduid": "2f7668d0933e474785785f7a1bf7d7c8", 07:24:23 INFO - "slavebuilddir": "test" 07:24:23 INFO - } 07:24:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/c2Nx2sB7TAqKeuwRcVZQiw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 07:24:23 INFO - Running post-action listener: _resource_record_post_action 07:24:23 INFO - [mozharness: 2017-03-31 14:24:23.621640Z] Finished read-buildbot-config step (success) 07:24:23 INFO - [mozharness: 2017-03-31 14:24:23.621751Z] Running download-and-extract step. 07:24:23 INFO - Running pre-action listener: _resource_record_pre_action 07:24:23 INFO - Running main action method: download_and_extract 07:24:23 INFO - mkdir: /builds/slave/test/build/tests 07:24:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:24:23 INFO - trying https://queue.taskcluster.net/v1/task/c2Nx2sB7TAqKeuwRcVZQiw/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 07:24:23 INFO - Downloading https://queue.taskcluster.net/v1/task/c2Nx2sB7TAqKeuwRcVZQiw/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 07:24:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c2Nx2sB7TAqKeuwRcVZQiw/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json'}, attempt #1 07:24:24 INFO - Downloaded 1199 bytes. 07:24:24 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 07:24:24 INFO - Using the following test package requirements: 07:24:24 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 07:24:24 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 07:24:24 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 07:24:24 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 07:24:24 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 07:24:24 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 07:24:24 INFO - u'jsshell-mac.zip'], 07:24:24 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 07:24:24 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 07:24:24 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 07:24:24 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 07:24:24 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 07:24:24 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 07:24:24 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 07:24:24 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 07:24:24 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 07:24:24 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 07:24:24 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 07:24:24 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 07:24:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/c2Nx2sB7TAqKeuwRcVZQiw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 07:24:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/c2Nx2sB7TAqKeuwRcVZQiw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:24:24 INFO - Fetch https://queue.taskcluster.net/v1/task/c2Nx2sB7TAqKeuwRcVZQiw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 07:24:26 INFO - Expected file size: 51791407 07:24:26 INFO - Obtained file size: 51791407 07:24:42 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip', u'firefox-54.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 07:24:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/c2Nx2sB7TAqKeuwRcVZQiw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 07:24:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/c2Nx2sB7TAqKeuwRcVZQiw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:24:42 INFO - Fetch https://queue.taskcluster.net/v1/task/c2Nx2sB7TAqKeuwRcVZQiw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 07:24:43 INFO - Expected file size: 51791407 07:24:43 INFO - Obtained file size: 51791407 07:24:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/c2Nx2sB7TAqKeuwRcVZQiw/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 07:24:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/c2Nx2sB7TAqKeuwRcVZQiw/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 07:24:59 INFO - Fetch https://queue.taskcluster.net/v1/task/c2Nx2sB7TAqKeuwRcVZQiw/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 07:24:59 INFO - Expected file size: 14404438 07:24:59 INFO - Obtained file size: 14404438 07:25:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:25:00 INFO - trying https://queue.taskcluster.net/v1/task/c2Nx2sB7TAqKeuwRcVZQiw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 07:25:00 INFO - Downloading https://queue.taskcluster.net/v1/task/c2Nx2sB7TAqKeuwRcVZQiw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 07:25:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c2Nx2sB7TAqKeuwRcVZQiw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg'}, attempt #1 07:25:02 INFO - Downloaded 74696202 bytes. 07:25:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/c2Nx2sB7TAqKeuwRcVZQiw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 07:25:02 INFO - mkdir: /builds/slave/test/properties 07:25:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:25:02 INFO - Writing to file /builds/slave/test/properties/build_url 07:25:02 INFO - Contents: 07:25:02 INFO - build_url:https://queue.taskcluster.net/v1/task/c2Nx2sB7TAqKeuwRcVZQiw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 07:25:03 INFO - Running post-action listener: _resource_record_post_action 07:25:03 INFO - Running post-action listener: set_extra_try_arguments 07:25:03 INFO - [mozharness: 2017-03-31 14:25:03.047139Z] Finished download-and-extract step (success) 07:25:03 INFO - [mozharness: 2017-03-31 14:25:03.047267Z] Running populate-webroot step. 07:25:03 INFO - Running pre-action listener: _resource_record_pre_action 07:25:03 INFO - Running main action method: populate_webroot 07:25:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:25:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:25:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:25:03 INFO - '--tppagecycles', 07:25:03 INFO - '7'], 07:25:03 INFO - 'tests': ['tsvgm']}}, 07:25:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:25:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:25:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:25:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:25:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:25:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:25:03 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:25:03 INFO - 'talos_options': ['--disable-e10s'], 07:25:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:25:03 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:25:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:25:03 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:25:03 INFO - 'talos_options': ['--disable-e10s'], 07:25:03 INFO - 'tests': ['damp', 'tps']}, 07:25:03 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:25:03 INFO - 'tests': ['damp', 'tps']}, 07:25:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:25:03 INFO - 'tests': ['dromaeo_dom']}, 07:25:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:25:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:25:03 INFO - 'tests': ['basic_compositor_video']}, 07:25:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:25:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:25:03 INFO - 'tests': ['a11yr', 07:25:03 INFO - 'ts_paint', 07:25:03 INFO - 'tpaint', 07:25:03 INFO - 'sessionrestore', 07:25:03 INFO - 'sessionrestore_no_auto_restore', 07:25:03 INFO - 'tabpaint']}, 07:25:03 INFO - 'other-e10s': {'tests': ['a11yr', 07:25:03 INFO - 'ts_paint', 07:25:03 INFO - 'tpaint', 07:25:03 INFO - 'sessionrestore', 07:25:03 INFO - 'sessionrestore_no_auto_restore', 07:25:03 INFO - 'tabpaint']}, 07:25:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:25:03 INFO - 'ts_paint', 07:25:03 INFO - 'tpaint', 07:25:03 INFO - 'sessionrestore', 07:25:03 INFO - 'sessionrestore_no_auto_restore', 07:25:03 INFO - 'tabpaint']}, 07:25:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:25:03 INFO - 'ts_paint', 07:25:03 INFO - 'tpaint', 07:25:03 INFO - 'sessionrestore', 07:25:03 INFO - 'sessionrestore_no_auto_restore', 07:25:03 INFO - 'tabpaint']}, 07:25:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:25:03 INFO - 'tests': ['a11yr', 07:25:03 INFO - 'ts_paint', 07:25:03 INFO - 'tpaint', 07:25:03 INFO - 'sessionrestore', 07:25:03 INFO - 'sessionrestore_no_auto_restore', 07:25:03 INFO - 'tabpaint']}, 07:25:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:25:03 INFO - 'tests': ['a11yr', 07:25:03 INFO - 'ts_paint', 07:25:03 INFO - 'tpaint', 07:25:03 INFO - 'sessionrestore', 07:25:03 INFO - 'sessionrestore_no_auto_restore', 07:25:03 INFO - 'tabpaint']}, 07:25:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:25:03 INFO - 'tests': ['tsvgx', 07:25:03 INFO - 'tsvgr_opacity', 07:25:03 INFO - 'tart', 07:25:03 INFO - 'tscrollx', 07:25:03 INFO - 'cart', 07:25:03 INFO - 'tsvg_static']}, 07:25:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:25:03 INFO - 'tsvgr_opacity', 07:25:03 INFO - 'tart', 07:25:03 INFO - 'tscrollx', 07:25:03 INFO - 'cart', 07:25:03 INFO - 'tsvg_static']}, 07:25:03 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:25:03 INFO - 'talos_options': ['--disable-e10s'], 07:25:03 INFO - 'tests': ['tp5o']}, 07:25:03 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:25:03 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:25:03 INFO - 'talos_options': ['--disable-e10s', 07:25:03 INFO - '--xperf_path', 07:25:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:25:03 INFO - 'tests': ['tp5n']}, 07:25:03 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:25:03 INFO - 'talos_options': ['--xperf_path', 07:25:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:25:03 INFO - 'tests': ['tp5n']}}, 07:25:03 INFO - 'talos.zip': {'path': '', 07:25:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:25:03 INFO - Running post-action listener: _resource_record_post_action 07:25:03 INFO - [mozharness: 2017-03-31 14:25:03.065983Z] Finished populate-webroot step (success) 07:25:03 INFO - [mozharness: 2017-03-31 14:25:03.066125Z] Running create-virtualenv step. 07:25:03 INFO - Running pre-action listener: _resource_record_pre_action 07:25:03 INFO - Running main action method: create_virtualenv 07:25:03 INFO - Creating virtualenv /builds/slave/test/build/venv 07:25:03 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 07:25:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:25:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:25:03 INFO - Using real prefix '/tools/python27' 07:25:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:25:03 INFO - Installing distribute.............................................................................................................................................................................................done. 07:25:06 INFO - Installing pip.................done. 07:25:06 INFO - Return code: 0 07:25:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:25:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:25:07 INFO - Reading from file tmpfile_stdout 07:25:07 INFO - Output received: 07:25:07 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) 07:25:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:25:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:25:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:25:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:07 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 0x1069eab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1069ed768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd02cbaa00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067c8d30>, '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 0x1066efdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1067bdbe8>, '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.bWtNnGumta/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.bsyzc7rrLI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 07:25:07 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 07:25:07 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 07:25:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bWtNnGumta/Render', 07:25:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:25:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:25:07 INFO - 'HOME': '/Users/cltbld', 07:25:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:25:07 INFO - 'LOGNAME': 'cltbld', 07:25:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:07 INFO - 'MOZ_NO_REMOTE': '1', 07:25:07 INFO - 'NO_EM_RESTART': '1', 07:25:07 INFO - 'PAGER': '/bin/cat', 07:25:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:25:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:07 INFO - 'PWD': '/builds/slave/test', 07:25:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:25:07 INFO - 'SHELL': '/bin/bash', 07:25:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bsyzc7rrLI/Listeners', 07:25:07 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 07:25:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:25:07 INFO - 'USER': 'cltbld', 07:25:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:25:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:25:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:07 INFO - 'XPC_FLAGS': '0x0', 07:25:07 INFO - 'XPC_SERVICE_NAME': '0', 07:25:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:25:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:07 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 07:25:07 INFO - Cleaning up... 07:25:07 INFO - Return code: 0 07:25:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:25:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:25:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:25:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:07 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 0x1069eab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1069ed768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd02cbaa00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067c8d30>, '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 0x1066efdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1067bdbe8>, '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.bWtNnGumta/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.bsyzc7rrLI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 07:25:07 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 07:25:07 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 07:25:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bWtNnGumta/Render', 07:25:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:25:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:25:07 INFO - 'HOME': '/Users/cltbld', 07:25:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:25:07 INFO - 'LOGNAME': 'cltbld', 07:25:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:07 INFO - 'MOZ_NO_REMOTE': '1', 07:25:07 INFO - 'NO_EM_RESTART': '1', 07:25:07 INFO - 'PAGER': '/bin/cat', 07:25:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:25:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:07 INFO - 'PWD': '/builds/slave/test', 07:25:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:25:07 INFO - 'SHELL': '/bin/bash', 07:25:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bsyzc7rrLI/Listeners', 07:25:07 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 07:25:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:25:07 INFO - 'USER': 'cltbld', 07:25:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:25:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:25:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:07 INFO - 'XPC_FLAGS': '0x0', 07:25:07 INFO - 'XPC_SERVICE_NAME': '0', 07:25:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:25:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:07 INFO - Downloading/unpacking psutil>=3.1.1 07:25:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:25:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:25:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:25:10 INFO - Installing collected packages: psutil 07:25:10 INFO - Running setup.py install for psutil 07:25:11 INFO - building 'psutil._psutil_osx' extension 07:25:11 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 07:25:11 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 07:25:11 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 07:25:11 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 07:25:11 INFO - building 'psutil._psutil_posix' extension 07:25:11 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 07:25:11 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:25:11 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:25:11 INFO - ^ 07:25:11 INFO - 1 warning generated. 07:25:11 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 07:25:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:25:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:25:11 INFO - Successfully installed psutil 07:25:11 INFO - Cleaning up... 07:25:11 INFO - Return code: 0 07:25:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:25:11 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')]} 07:25:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:11 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')]} 07:25:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:12 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 0x1069eab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1069ed768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd02cbaa00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067c8d30>, '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 0x1066efdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1067bdbe8>, '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.bWtNnGumta/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.bsyzc7rrLI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 07:25:12 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 07:25:12 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 07:25:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bWtNnGumta/Render', 07:25:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:25:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:25:12 INFO - 'HOME': '/Users/cltbld', 07:25:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:25:12 INFO - 'LOGNAME': 'cltbld', 07:25:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:12 INFO - 'MOZ_NO_REMOTE': '1', 07:25:12 INFO - 'NO_EM_RESTART': '1', 07:25:12 INFO - 'PAGER': '/bin/cat', 07:25:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:25:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:12 INFO - 'PWD': '/builds/slave/test', 07:25:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:25:12 INFO - 'SHELL': '/bin/bash', 07:25:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bsyzc7rrLI/Listeners', 07:25:12 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 07:25:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:25:12 INFO - 'USER': 'cltbld', 07:25:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:25:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:25:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:12 INFO - 'XPC_FLAGS': '0x0', 07:25:12 INFO - 'XPC_SERVICE_NAME': '0', 07:25:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:25:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:25:12 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 07:25:12 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 07:25:12 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 07:25:12 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 07:25:12 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 07:25:12 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 07:25:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:25:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:25:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:25:15 INFO - Installing collected packages: mozsystemmonitor 07:25:15 INFO - Running setup.py install for mozsystemmonitor 07:25:15 INFO - Successfully installed mozsystemmonitor 07:25:15 INFO - Cleaning up... 07:25:15 INFO - Return code: 0 07:25:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:25:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:25:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1069eab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1069ed768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd02cbaa00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067c8d30>, '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 0x1066efdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1067bdbe8>, '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.bWtNnGumta/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.bsyzc7rrLI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 07:25:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:25:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:25:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bWtNnGumta/Render', 07:25:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:25:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:25:15 INFO - 'HOME': '/Users/cltbld', 07:25:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:25:15 INFO - 'LOGNAME': 'cltbld', 07:25:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:15 INFO - 'MOZ_NO_REMOTE': '1', 07:25:15 INFO - 'NO_EM_RESTART': '1', 07:25:15 INFO - 'PAGER': '/bin/cat', 07:25:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:25:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:15 INFO - 'PWD': '/builds/slave/test', 07:25:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:25:15 INFO - 'SHELL': '/bin/bash', 07:25:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bsyzc7rrLI/Listeners', 07:25:15 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 07:25:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:25:15 INFO - 'USER': 'cltbld', 07:25:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:25:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:25:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:15 INFO - 'XPC_FLAGS': '0x0', 07:25:15 INFO - 'XPC_SERVICE_NAME': '0', 07:25:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:25:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:15 INFO - Downloading/unpacking jsonschema==2.5.1 07:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:25:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:25:18 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 07:25:18 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 07:25:18 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 07:25:18 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 07:25:18 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 07:25:18 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 07:25:18 INFO - Downloading functools32-3.2.3-2.tar.gz 07:25:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:25:18 INFO - warning: no files found matching '*.txt' 07:25:18 INFO - no previously-included directories found matching 'build' 07:25:18 INFO - no previously-included directories found matching 'dist' 07:25:18 INFO - no previously-included directories found matching '.git*' 07:25:18 INFO - Installing collected packages: jsonschema, functools32 07:25:18 INFO - Running setup.py install for functools32 07:25:19 INFO - warning: no files found matching '*.txt' 07:25:19 INFO - no previously-included directories found matching 'build' 07:25:19 INFO - no previously-included directories found matching 'dist' 07:25:19 INFO - no previously-included directories found matching '.git*' 07:25:19 INFO - Successfully installed jsonschema functools32 07:25:19 INFO - Cleaning up... 07:25:19 INFO - Return code: 0 07:25:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:25:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:25:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:25:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1069eab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1069ed768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd02cbaa00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067c8d30>, '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 0x1066efdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1067bdbe8>, '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.bWtNnGumta/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.bsyzc7rrLI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 07:25:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:25:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:25:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bWtNnGumta/Render', 07:25:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:25:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:25:19 INFO - 'HOME': '/Users/cltbld', 07:25:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:25:19 INFO - 'LOGNAME': 'cltbld', 07:25:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:19 INFO - 'MOZ_NO_REMOTE': '1', 07:25:19 INFO - 'NO_EM_RESTART': '1', 07:25:19 INFO - 'PAGER': '/bin/cat', 07:25:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:25:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:19 INFO - 'PWD': '/builds/slave/test', 07:25:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:25:19 INFO - 'SHELL': '/bin/bash', 07:25:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bsyzc7rrLI/Listeners', 07:25:19 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 07:25:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:25:19 INFO - 'USER': 'cltbld', 07:25:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:25:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:25:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:19 INFO - 'XPC_FLAGS': '0x0', 07:25:19 INFO - 'XPC_SERVICE_NAME': '0', 07:25:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:25:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:25:19 INFO - Cleaning up... 07:25:19 INFO - Return code: 0 07:25:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:25:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:25:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:25:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1069eab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1069ed768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd02cbaa00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067c8d30>, '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 0x1066efdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1067bdbe8>, '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.bWtNnGumta/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.bsyzc7rrLI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 07:25:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:25:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:25:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bWtNnGumta/Render', 07:25:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:25:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:25:19 INFO - 'HOME': '/Users/cltbld', 07:25:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:25:19 INFO - 'LOGNAME': 'cltbld', 07:25:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:19 INFO - 'MOZ_NO_REMOTE': '1', 07:25:19 INFO - 'NO_EM_RESTART': '1', 07:25:19 INFO - 'PAGER': '/bin/cat', 07:25:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:25:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:19 INFO - 'PWD': '/builds/slave/test', 07:25:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:25:19 INFO - 'SHELL': '/bin/bash', 07:25:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bsyzc7rrLI/Listeners', 07:25:19 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 07:25:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:25:19 INFO - 'USER': 'cltbld', 07:25:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:25:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:25:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:19 INFO - 'XPC_FLAGS': '0x0', 07:25:19 INFO - 'XPC_SERVICE_NAME': '0', 07:25:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:25:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:19 INFO - Downloading/unpacking blobuploader==1.2.4 07:25:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:22 INFO - Downloading blobuploader-1.2.4.tar.gz 07:25:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:25:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:25:22 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 07:25:22 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 07:25:22 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 07:25:22 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 07:25:22 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 07:25:22 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 07:25:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:25:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:25:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:23 INFO - Downloading docopt-0.6.1.tar.gz 07:25:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:25:23 INFO - Installing collected packages: blobuploader, requests, docopt 07:25:23 INFO - Running setup.py install for blobuploader 07:25:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:25:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:25:23 INFO - Running setup.py install for requests 07:25:24 INFO - Running setup.py install for docopt 07:25:24 INFO - Successfully installed blobuploader requests docopt 07:25:24 INFO - Cleaning up... 07:25:24 INFO - Return code: 0 07:25:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:25:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:25:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:25:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:24 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 0x1069eab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1069ed768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd02cbaa00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067c8d30>, '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 0x1066efdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1067bdbe8>, '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.bWtNnGumta/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.bsyzc7rrLI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 07:25:24 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 07:25:24 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 07:25:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bWtNnGumta/Render', 07:25:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:25:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:25:24 INFO - 'HOME': '/Users/cltbld', 07:25:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:25:24 INFO - 'LOGNAME': 'cltbld', 07:25:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:24 INFO - 'MOZ_NO_REMOTE': '1', 07:25:24 INFO - 'NO_EM_RESTART': '1', 07:25:24 INFO - 'PAGER': '/bin/cat', 07:25:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:25:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:24 INFO - 'PWD': '/builds/slave/test', 07:25:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:25:24 INFO - 'SHELL': '/bin/bash', 07:25:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bsyzc7rrLI/Listeners', 07:25:24 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 07:25:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:25:24 INFO - 'USER': 'cltbld', 07:25:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:25:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:25:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:24 INFO - 'XPC_FLAGS': '0x0', 07:25:24 INFO - 'XPC_SERVICE_NAME': '0', 07:25:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:25:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:25:24 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-0TZc93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:25:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:25:24 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-Pa6abY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:25:25 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-VI6Rry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:25:25 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-hiIkSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:25:25 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-vZQCAl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:25:25 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-udtcdb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:25:25 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-AMQ4vi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:25:25 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-fO6m2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:25:25 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-mSptEN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:25:25 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-7TF30u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:25:25 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-ITUWhG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:25:26 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-f8T01s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:25:26 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-a3TLQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:25:26 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-M6Zgnt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:25:26 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-3w5xuf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:25:26 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-Gcs0sA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:25:26 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-XoOtT1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:25:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:25:26 INFO - Running setup.py install for manifestparser 07:25:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:25:26 INFO - Running setup.py install for mozcrash 07:25:26 INFO - Running setup.py install for mozdebug 07:25:27 INFO - Running setup.py install for mozdevice 07:25:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:25:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:25:27 INFO - Running setup.py install for mozfile 07:25:27 INFO - Running setup.py install for mozhttpd 07:25:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:25:27 INFO - Running setup.py install for mozinfo 07:25:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:25:27 INFO - Running setup.py install for mozInstall 07:25:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:25:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:25:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:25:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:25:27 INFO - Running setup.py install for mozleak 07:25:27 INFO - Running setup.py install for mozlog 07:25:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:25:28 INFO - Running setup.py install for moznetwork 07:25:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:25:28 INFO - Running setup.py install for mozprocess 07:25:28 INFO - Running setup.py install for mozprofile 07:25:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:25:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:25:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:25:28 INFO - Running setup.py install for mozrunner 07:25:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:25:28 INFO - Running setup.py install for mozscreenshot 07:25:28 INFO - Running setup.py install for moztest 07:25:29 INFO - Running setup.py install for mozversion 07:25:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:25:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:25:29 INFO - Cleaning up... 07:25:29 INFO - Return code: 0 07:25:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:25:29 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')]} 07:25:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:29 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')]} 07:25:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:29 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 0x1069eab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1069ed768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd02cbaa00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067c8d30>, '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 0x1066efdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1067bdbe8>, '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.bWtNnGumta/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.bsyzc7rrLI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 07:25:29 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 07:25:29 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 07:25:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bWtNnGumta/Render', 07:25:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:25:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:25:29 INFO - 'HOME': '/Users/cltbld', 07:25:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:25:29 INFO - 'LOGNAME': 'cltbld', 07:25:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:29 INFO - 'MOZ_NO_REMOTE': '1', 07:25:29 INFO - 'NO_EM_RESTART': '1', 07:25:29 INFO - 'PAGER': '/bin/cat', 07:25:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:25:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:29 INFO - 'PWD': '/builds/slave/test', 07:25:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:25:29 INFO - 'SHELL': '/bin/bash', 07:25:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bsyzc7rrLI/Listeners', 07:25:29 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 07:25:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:25:29 INFO - 'USER': 'cltbld', 07:25:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:25:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:25:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:29 INFO - 'XPC_FLAGS': '0x0', 07:25:29 INFO - 'XPC_SERVICE_NAME': '0', 07:25:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:25:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:25:29 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-1oNPF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:25:29 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)) 07:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:25:29 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-tBdsWw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:25:29 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)) 07:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:25:29 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-UJo_ZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:25:29 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)) 07:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:25:29 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-a1sflV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:25:29 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)) 07:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:25:30 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-KdUKcQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:25:30 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)) 07:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:25:30 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-WIHaMD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:25:30 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)) 07:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:25:30 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-ibOqpj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:25:30 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)) 07:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:25:30 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-6eXOAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:25:30 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)) 07:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:25:30 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-cFCNcJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:25:30 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)) 07:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:25:30 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-CVn6AV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:25:30 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)) 07:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:25:30 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-swuVlU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:25:30 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)) 07:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:25:30 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-ZsWtat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:25:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:25:30 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-jUlYUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:25:30 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)) 07:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:25:30 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-2V97Nf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:25:31 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)) 07:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:25:31 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-yIWpSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:25:31 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)) 07:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:25:31 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-HhWWmd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:25:31 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)) 07:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:25:31 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-kOk3ZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:25:31 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)) 07:25:31 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)) 07:25:31 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)) 07:25:31 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)) 07:25:31 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)) 07:25:31 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)) 07:25:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:25:31 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 07:25:31 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 07:25:31 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 07:25:31 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 07:25:31 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 07:25:31 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 07:25:34 INFO - Downloading blessings-1.6.tar.gz 07:25:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:25:34 INFO - Installing collected packages: blessings 07:25:34 INFO - Running setup.py install for blessings 07:25:34 INFO - Successfully installed blessings 07:25:34 INFO - Cleaning up... 07:25:34 INFO - Return code: 0 07:25:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:25:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:25:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:25:34 INFO - Reading from file tmpfile_stdout 07:25:34 INFO - Current package versions: 07:25:34 INFO - blessings == 1.6 07:25:34 INFO - blobuploader == 1.2.4 07:25:34 INFO - docopt == 0.6.1 07:25:34 INFO - functools32 == 3.2.3-2 07:25:34 INFO - jsonschema == 2.5.1 07:25:34 INFO - manifestparser == 1.1 07:25:34 INFO - mozInstall == 1.12 07:25:34 INFO - mozcrash == 1.0 07:25:34 INFO - mozdebug == 0.1 07:25:34 INFO - mozdevice == 0.49 07:25:34 INFO - mozfile == 1.2 07:25:34 INFO - mozhttpd == 0.7 07:25:34 INFO - mozinfo == 0.9 07:25:34 INFO - mozleak == 0.1 07:25:34 INFO - mozlog == 3.4 07:25:34 INFO - moznetwork == 0.27 07:25:34 INFO - mozprocess == 0.25 07:25:34 INFO - mozprofile == 0.28 07:25:34 INFO - mozrunner == 6.13 07:25:34 INFO - mozscreenshot == 0.1 07:25:34 INFO - mozsystemmonitor == 0.3 07:25:34 INFO - moztest == 0.8 07:25:34 INFO - mozversion == 1.4 07:25:34 INFO - psutil == 3.1.1 07:25:34 INFO - requests == 1.2.3 07:25:34 INFO - wsgiref == 0.1.2 07:25:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:25:34 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')]} 07:25:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:34 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')]} 07:25:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:34 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 0x1069eab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1069ed768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd02cbaa00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067c8d30>, '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 0x1066efdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1067bdbe8>, '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.bWtNnGumta/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.bsyzc7rrLI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 07:25:34 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 07:25:34 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 07:25:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bWtNnGumta/Render', 07:25:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:25:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:25:34 INFO - 'HOME': '/Users/cltbld', 07:25:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:25:34 INFO - 'LOGNAME': 'cltbld', 07:25:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:34 INFO - 'MOZ_NO_REMOTE': '1', 07:25:34 INFO - 'NO_EM_RESTART': '1', 07:25:34 INFO - 'PAGER': '/bin/cat', 07:25:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:25:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:34 INFO - 'PWD': '/builds/slave/test', 07:25:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:25:34 INFO - 'SHELL': '/bin/bash', 07:25:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bsyzc7rrLI/Listeners', 07:25:34 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 07:25:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:25:34 INFO - 'USER': 'cltbld', 07:25:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:25:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:25:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:34 INFO - 'XPC_FLAGS': '0x0', 07:25:34 INFO - 'XPC_SERVICE_NAME': '0', 07:25:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:25:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:34 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)) 07:25:34 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)) 07:25:34 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)) 07:25:34 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)) 07:25:34 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)) 07:25:34 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)) 07:25:34 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)) 07:25:34 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)) 07:25:34 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)) 07:25:34 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)) 07:25:34 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)) 07:25:34 INFO - Cleaning up... 07:25:34 INFO - Return code: 0 07:25:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:25:34 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')]} 07:25:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:34 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')]} 07:25:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:34 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 0x1069eab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1069ed768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd02cbaa00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067c8d30>, '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 0x1066efdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1067bdbe8>, '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.bWtNnGumta/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.bsyzc7rrLI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 07:25:34 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 07:25:34 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 07:25:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bWtNnGumta/Render', 07:25:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:25:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:25:34 INFO - 'HOME': '/Users/cltbld', 07:25:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:25:34 INFO - 'LOGNAME': 'cltbld', 07:25:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:34 INFO - 'MOZ_NO_REMOTE': '1', 07:25:34 INFO - 'NO_EM_RESTART': '1', 07:25:34 INFO - 'PAGER': '/bin/cat', 07:25:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:25:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:34 INFO - 'PWD': '/builds/slave/test', 07:25:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:25:34 INFO - 'SHELL': '/bin/bash', 07:25:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bsyzc7rrLI/Listeners', 07:25:34 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 07:25:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:25:34 INFO - 'USER': 'cltbld', 07:25:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:25:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:25:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:34 INFO - 'XPC_FLAGS': '0x0', 07:25:34 INFO - 'XPC_SERVICE_NAME': '0', 07:25:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:25:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:25:35 INFO - Cleaning up... 07:25:35 INFO - Return code: 0 07:25:35 INFO - Running post-action listener: _resource_record_post_action 07:25:35 INFO - Running post-action listener: _start_resource_monitoring 07:25:35 INFO - Starting resource monitoring. 07:25:35 INFO - [mozharness: 2017-03-31 14:25:35.248899Z] Finished create-virtualenv step (success) 07:25:35 INFO - [mozharness: 2017-03-31 14:25:35.249917Z] Running install step. 07:25:35 INFO - Running pre-action listener: _resource_record_pre_action 07:25:35 INFO - Running main action method: install 07:25:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:25:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:25:35 INFO - Reading from file tmpfile_stdout 07:25:35 INFO - Detecting whether we're running mozinstall >=1.0... 07:25:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:25:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:25:35 INFO - Reading from file tmpfile_stdout 07:25:35 INFO - Output received: 07:25:35 INFO - Usage: mozinstall [options] installer 07:25:35 INFO - Options: 07:25:35 INFO - -h, --help show this help message and exit 07:25:35 INFO - -d DEST, --destination=DEST 07:25:35 INFO - Directory to install application into. [default: 07:25:35 INFO - "/builds/slave/test"] 07:25:35 INFO - --app=APP Application being installed. [default: firefox] 07:25:35 INFO - mkdir: /builds/slave/test/build/application 07:25:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:25:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 07:25:56 INFO - Reading from file tmpfile_stdout 07:25:56 INFO - Output received: 07:25:56 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 07:25:56 INFO - Running post-action listener: _resource_record_post_action 07:25:56 INFO - [mozharness: 2017-03-31 14:25:56.125546Z] Finished install step (success) 07:25:56 INFO - [mozharness: 2017-03-31 14:25:56.125694Z] Running run-tests step. 07:25:56 INFO - Running pre-action listener: _resource_record_pre_action 07:25:56 INFO - Running main action method: run_tests 07:25:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:25:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:25:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:25:56 INFO - 2017-03-31 07:25:56.140 screenresolution[2166:16810] starting screenresolution argv=screenresolution get 07:25:56 INFO - 2017-03-31 07:25:56.143 screenresolution[2166:16810] Display 0: 1600x1200x32@60 07:25:56 INFO - 2017-03-31 07:25:56.149 screenresolution[2167:16812] starting screenresolution argv=screenresolution list 07:25:56 INFO - Available Modes on Display 0 07:25:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:25:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:25:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:25:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:25:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:25:56 INFO - Intel Iris: 07:25:56 INFO - Chipset Model: Intel Iris 07:25:56 INFO - Type: GPU 07:25:56 INFO - Bus: Built-In 07:25:56 INFO - VRAM (Dynamic, Max): 1536 MB 07:25:56 INFO - Vendor: Intel (0x8086) 07:25:56 INFO - Device ID: 0x0a2e 07:25:56 INFO - Revision ID: 0x0009 07:25:56 INFO - Displays: 07:25:56 INFO - Display: 07:25:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:25:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:25:56 INFO - Display Serial Number: 1600x1200 60 07:25:56 INFO - Main Display: Yes 07:25:56 INFO - Mirror: Off 07:25:56 INFO - Online: Yes 07:25:56 INFO - Rotation: Supported 07:25:56 INFO - Return code: 0 07:25:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:25:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:25:56 INFO - Python 2.7.3 07:25:56 INFO - Return code: 0 07:25:56 INFO - grabbing minidump binary from tooltool 07:25:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:25:56 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 0x1067c8d30>, '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 0x1066efdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1067bdbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:25:56 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 07:25:56 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 07:25:56 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 07:25:56 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:25:56 INFO - Return code: 0 07:25:56 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:25:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:25:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:25:56 INFO - ENV: RUST_BACKTRACE is now 1 07:25:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:25:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:25:56 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/c2Nx2sB7TAqKeuwRcVZQiw/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0338', '--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 07:25:56 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/c2Nx2sB7TAqKeuwRcVZQiw/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0338 --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 07:25:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bWtNnGumta/Render', 07:25:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:25:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:25:56 INFO - 'HOME': '/Users/cltbld', 07:25:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:25:56 INFO - 'LOGNAME': 'cltbld', 07:25:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:25:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:25:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:56 INFO - 'MOZ_NO_REMOTE': '1', 07:25:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:25:56 INFO - 'NO_EM_RESTART': '1', 07:25:56 INFO - 'PAGER': '/bin/cat', 07:25:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:25:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:56 INFO - 'PWD': '/builds/slave/test', 07:25:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:25:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:25:56 INFO - 'RUST_BACKTRACE': '1', 07:25:56 INFO - 'SHELL': '/bin/bash', 07:25:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bsyzc7rrLI/Listeners', 07:25:56 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 07:25:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:25:56 INFO - 'USER': 'cltbld', 07:25:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:25:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:25:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:56 INFO - 'XPC_FLAGS': '0x0', 07:25:56 INFO - 'XPC_SERVICE_NAME': '0', 07:25:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:25:56 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/c2Nx2sB7TAqKeuwRcVZQiw/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0338', '--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 07:25:56 INFO - mozversion application_buildid: 20170331063801 07:25:56 INFO - mozversion application_changeset: 1105ff76f42a96c1af3a54c043aa2a338ca45081 07:25:56 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:25:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:25:56 INFO - mozversion application_name: Firefox 07:25:56 INFO - mozversion application_remotingname: firefox-dev 07:25:56 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:25:56 INFO - mozversion application_vendor: Mozilla 07:25:56 INFO - mozversion application_version: 54.0a2 07:25:56 INFO - mozversion platform_buildid: 20170331063801 07:25:56 INFO - mozversion platform_changeset: 1105ff76f42a96c1af3a54c043aa2a338ca45081 07:25:56 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:25:56 INFO - mozversion platform_version: 54.0a2 07:25:56 INFO - using testdate: 1490970356 07:25:56 INFO - actual date: 1490970356 07:25:56 INFO - starting webserver on 'localhost:52532' 07:25:56 INFO - SUITE-START | Running 2 tests 07:25:56 INFO - TEST-START | dromaeo_css 07:25:56 INFO - operating with platform_type : mac_ 07:25:56 INFO - Initialising browser for dromaeo_css test... 07:25:56 INFO - TEST-INFO | started process 2177 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/tmpb0heMA/profile http://localhost:52532/getInfo.html) 07:25:59 INFO - PROCESS | 2177 | 2017-03-31 07:25:59.379 plugin-container[2179:16975] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b4b, name = 'com.apple.tsm.portname' 07:25:59 INFO - PROCESS | 2177 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:25:59 INFO - PROCESS | 2177 | 2017-03-31 07:25:59.382 plugin-container[2179:16975] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x492f, name = 'com.apple.CFPasteboardClient' 07:25:59 INFO - PROCESS | 2177 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:25:59 INFO - PROCESS | 2177 | 2017-03-31 07:25:59.382 plugin-container[2179:16975] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:25:59 INFO - PROCESS | 2177 | __metrics Screen width/height:1600/1200 07:25:59 INFO - PROCESS | 2177 | colorDepth:24 07:25:59 INFO - PROCESS | 2177 | Browser inner width/height: 1024/689 07:25:59 INFO - PROCESS | 2177 | __metrics 07:25:59 ERROR - PROCESS | 2177 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 07:26:00 INFO - TEST-INFO | 2177: exit 0 07:26:00 INFO - Browser initialized. 07:26:00 INFO - Running cycle 1/1 for dromaeo_css test... 07:26:00 INFO - TEST-INFO | started process 2180 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/tmpb0heMA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:26:02 INFO - PROCESS | 2180 | 2017-03-31 07:26:02.616 plugin-container[2181:17112] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4847, name = 'com.apple.tsm.portname' 07:26:02 INFO - PROCESS | 2180 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:26:02 INFO - PROCESS | 2180 | 2017-03-31 07:26:02.616 plugin-container[2181:17112] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x451b, name = 'com.apple.CFPasteboardClient' 07:26:02 INFO - PROCESS | 2180 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:26:02 INFO - PROCESS | 2180 | 2017-03-31 07:26:02.616 plugin-container[2181:17112] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:26:12 INFO - PROCESS | 2180 | RSS: Main: 221057024 07:26:12 INFO - PROCESS | 2180 | 07:29:16 INFO - PROCESS | 2180 | Cycle 1(1): loaded http://localhost:52532/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52532/tests/dromaeo/cssquery-ext.html) 07:29:17 INFO - PROCESS | 2180 | RSS: Main: 242368512 07:29:17 INFO - PROCESS | 2180 | 07:31:00 INFO - PROCESS | 2180 | ************************* 07:31:00 INFO - PROCESS | 2180 | A coding exception was thrown and uncaught in a Task. 07:31:00 INFO - PROCESS | 2180 | 07:31:00 ERROR - PROCESS | 2180 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:31:00 INFO - PROCESS | 2180 | Full stack: 07:31:00 INFO - PROCESS | 2180 | ************************* 07:32:20 INFO - PROCESS | 2180 | Cycle 1(1): loaded http://localhost:52532/tests/dromaeo/cssquery-ext.html (next: http://localhost:52532/tests/dromaeo/cssquery-jquery.html) 07:32:20 INFO - PROCESS | 2180 | RSS: Main: 250458112 07:32:20 INFO - PROCESS | 2180 | 07:35:22 INFO - PROCESS | 2180 | Cycle 1(1): loaded http://localhost:52532/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52532/tests/dromaeo/cssquery-mootools.html) 07:35:23 INFO - PROCESS | 2180 | RSS: Main: 256868352 07:35:23 INFO - PROCESS | 2180 | 07:38:25 INFO - PROCESS | 2180 | Cycle 1(1): loaded http://localhost:52532/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52532/tests/dromaeo/cssquery-prototype.html) 07:38:26 INFO - PROCESS | 2180 | RSS: Main: 253050880 07:38:26 INFO - PROCESS | 2180 | 07:41:29 INFO - PROCESS | 2180 | Cycle 1(1): loaded http://localhost:52532/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52532/tests/dromaeo/cssquery-yui.html) 07:41:29 INFO - PROCESS | 2180 | RSS: Main: 258273280 07:41:29 INFO - PROCESS | 2180 | 07:44:32 INFO - PROCESS | 2180 | Cycle 1(1): loaded http://localhost:52532/tests/dromaeo/cssquery-yui.html (next: http://localhost:52532/tests/dromaeo/cssquery-dojo.html) 07:44:33 INFO - PROCESS | 2180 | RSS: Main: 254361600 07:44:33 INFO - PROCESS | 2180 | 07:44:33 INFO - PROCESS | 2180 | __start_tp_report 07:44:33 INFO - PROCESS | 2180 | _x_x_mozilla_page_load 07:44:33 INFO - PROCESS | 2180 | _x_x_mozilla_page_load_details 07:44:33 INFO - PROCESS | 2180 | |i|pagename|runs| 07:44:33 INFO - PROCESS | 2180 | |0;dojo.html;3463.7229021678268;3471.9305613887736;3472.861085556578;3481.129717570607;3522.348365552373;6076.6961651917445;6090.817275481737;6148.047052706826;6177.135201071842;6177.505799536038;6092.725827337769;6157.938420615804;6166.722497487613;6170.475509581691;6179.505639548836;5486.61593688441;5536.086545719952;5543.25166102575;5569.888602227953;5638.379778224392;5603.411641777596;5606;5615.971920140393;5656.095024796034;5663.745131469073;3934.9803250983705;5360.490753378443;5587;5597.692126933017;5755;5446.291982042309;5447.782088716466;5454.59090568209;5463.508284254416;5473.17902314656;4494.213512635276;5285.524302812765;5404.5946554008215;5405.783768649249;5408.269883565747;6123;6129;6131.87736245277;6192.566520343577;6243.687815609247;6251;6368.936310636881;6426.1003459515705;6426.550141490097;6435.517336199757;6555.672216389162;6559.901601475982;6581.670916454158;6590.011498275249;6590.8352291193105;5030.647854650139;6007.789727359522;6084.78304339134;6118.010103775246;6177.351378105324;6627.536072474881;6683.699233534406;6701.262861085277;6707.3628005339415;6721.764738234138;6364;6367.777127800505;6377.7448902044325;6380.936190638127;6403.58376705522;6280.403361680633;6319.115323854664;6384.042393640991;6523.478121750249;6525.3800888915475;4767.380240568773;5698.629589076697;6329;6421.74313027483;6638;6395.712192951329;6424.775132870327;6454.064160696673;6461.095446637474;6467.126937863422;5070.163423035232;5131.358580177478;5238.266642670029;5238.68567885928;5267.815626453055;4537.455505339314;4589.632829373642;4623;4680.204365257914;4694.1550520905885;5991.310999235056;6104.786332478342;6138.664296166128;6150.323464418911;6165.568410211242;6485.286618471964;6511.0558968949235;6520.021996700533;6539.50953678476;6549.377809108127;5916.792912248136;6105.419985101408;6194.039923811816;6196.318404975449;6204.7828326008375;5654.208410822488;5659.943400565941;5660.15097735343;5666.858328541737;5684.857878552986;6693;6694.698738556874;6708.228553716385;6708.329167083252;6738.090357801634;6412.230532335963;6472.449841763503;6483.222013358427;6490.156279683611;6493.902591461227;6347.841303967253;6399.328070552711;6585.5719378240265;6594.703238354382;6734.22556406;6358.872822543431;6439.484841212786;6448.967755161194;6455.419012288917;6462.935370646422;6390.968045159744;6496.70764815575;6502.512311576556;6524.412802847766;6529.51028672861;4872.9512704872495;6182.690865456799;6235.75056997715;6247.219097612799;6298.968505157445;5104.642675012714;6226.346233645402;6291.496680265659;6313.684315784284;6380.9042864358;5223.112070948024;6128.264608247039;6244.1570387997035;6337;6355.205599300088;5353;6162.890679677701;6314.810555683337;6361.2048493938255;6372.139761132188;5910.468057874812;6168.013117901114;6252.343503932204;6262.311145774052;6310.1796766420075 07:44:33 INFO - PROCESS | 2180 | |1;ext.html;730.817295676081;735.283098978496;830.5349004557448;947.8578213268013;949.4398305000049;33406.832965835136;38620;39640;41276.96807579808;41336.79331603345;32081.5187772183;39588.60411395885;39911.201775964466;39955;39975.60024399755;7857.6856925722905;10683.358998460079;10889.183311251649;11045.944770276137;11107.72230694231;10804.621838235664;10857.185711071661;10919.563217471292;10922.945385273102;10926.344419334866;10925.016748492633;10936;10936.671899843017;10938.070264027567;10948.178886583499;10899.1280697544;10912.890871091346;10919.945400272987;10929.234953553254;10975.06711929487;10519.684409467729;10577.995090466393;10600.363978161335;10603.257771955967;10605.575776968912;28842.567361489593;35115.473267901005;35532.46701299483;35690.64309356899;35702.75040373574;3653.4702468141973;3677.5035370224946;3697.9445308320396;3707.443883417482;3760.567534733513;25178.874105629355;25188.748112519006;25581.872090639612;25964.610530842052;26687.86497080229;3009.819410835357;3047.771417143701;3124.390743804959;3202.3755367703307;3233.207864073317;286083;373860;374176;375073;376958;46227.53772462232;46766.76616616895;46804.5319546807;46872.82817929579;46926;47882.521174787806;48084;48283.275750863766;48365.790855228195;48412.27381589279;13986;14063.2968351582;14305.642358940902;14331.78502322466;14341.282935853165;12105.576304829288;12161.391930403444;12318.014558835272;12318.692032699075;12322.445489952974;11167.888321116847;11241.887581124083;11741.236819606698;12322.383880806103;12488.438020289108;4698.8120475181295;5585.385607583163;5619.072852979294;5647.717614119278;5648.209250704905;1037.190991027;1067.40758878823;1098.2367254757867;1141.57191053355;1181.9349935753444;23968;26449.867750661124;26788.866055669598;27767.8892844284;28030;961.6393852305386;1013.341328136717;1201.5133870782347;1237.189640785287;1288.6778305423645;11124.49939752713;12370.050517319132;14584.124952502883;14628.414863405558;14841.851581484263;513884;515322;515728;515826;518274.4086279544;40623.59376406257;49698.006039879;50163.74590635263;51155.232671509955;52514.474855250955;1373.4849431463201;1419.8509156538414;1425.1306702911215;1430.9785353219918;1433.089987857718;22356.105755769586;24702.752972470764;25764.871175644003;27857.44285114327;28364.716352836207;43592.56407435885;43620.34569481397;43770.56229437665;43801.56198437975;43846.561534385524;469656.65171673923;486361;501208.49395752785;505655;506511;30616.08151755451;30871.536926945664;30940.69059309378;31151;31165.065048048597;39045.6095439042;39693.20613587654;39918.80040599778;40665.98335041648;40837.38743918784;26694.332641684112;28508.57237141403;28625.713742862306;28689.713102868704;28863;24966.875165624057;28148.71851281461;29017.854910726157;29027.419451610425;29080.06235510429;24117.276481705576;33988.32023359469;33997.8100766472;34020.829895850366;34133.146671333416;27768;28598.285042873264;28626.713732863238;29274.853625731736;29447;22807;23060.34375975443;23243;23476.178333758235;23857.832575213222 07:44:33 INFO - PROCESS | 2180 | |2;jquery.html;414.2440046914382;429.5597013061612;431.88376952930656;434.6631360695463;444.3445917272024;19895.701564476527;21184.2585509507;21322.46693832655;21453.141874325047;21815.127394904226;18159.364422245224;21522.89238553809;21913.561728765417;22593.887030564823;22751.862406879674;6595.274519802818;6885.173779146509;6899.48253880961;6957.130358705162;6957.8956315655305;6371.235451745773;6794.728210871559;6838.589684618914;6838.829029274259;6853.520253582251;6525.510586706016;6762.2223444304045;6819.590824550518;6833.248342682301;6853.520253582251;6723.09238252837;6772.255051944282;6774.45804335652;6780.474393261501;6788.72845086196;6505.121808555832;6586.110875031857;6596.472282217411;6641.601503909781;6643.202815662152;26430.86784566084;26435.603465948025;26542.07102751414;26668;26734.46531069387;3009.172477568686;3009.458297506448;3075.8462076896067;3078.3073808393156;3087.228192951762;13176.53882114131;15509.239726605363;16083.199648170628;16272.023678579322;16561.4203502878;2082.5938941906334;2138.6898899659463;2141.3468891987936;2144.088762276042;2148.1622167354744;124232;128842;131878;133668.33165834207;136340;18728.719069213974;23174.53650926972;23257;23625.63743625658;24653.38366540851;36923.630763692556;37332.81333593315;38053.04867378338;38193.61806381956;38307;11198.776024479464;11254.381009044417;11323.490442930088;11477.36874471912;11655;7548.66031028605;9176.31177661678;9204.493752843659;9213.355065145375;9402.576884040234;8958.462492250486;8992.370534062684;10919.563217471212;11040.779184416268;11172.162087843444;3710.5361829771277;4278.379634952915;4405.9559404405545;4420.535843736361;4421.646268298528;865.9307255419551;891.888513935758;921.9677311294073;935.9064093590587;962.5957098018849;21492;21614;22752.886235568716;22857.057150142424;22885.656715149285;952.2096659772373;958.5878072428783;982.1602529837029;982.9066238707311;994.8607194992707;8176.836463270702;9195.770105747277;12013.819792703116;12459.252444853339;12473.625791226277;671614;766965;784506;787688;794915;140144;163723;164232;164708;169159;1200.8018676918211;1242.1739543203669;1273.382409531395;1284.6852521132382;1302.1145620977636;19957.84257899503;21126.47183820417;21177.894110529964;21291.36125916225;21327.7867221332;65227;65430.67284663737;65602.01596975954;65732;65755.34244657683;90603;92023.53988230016;93266.53366733123;93771;94094;9813.509324533601;11429;11638.41807909618;11850.348230847387;12199.51201951912;12968.675783105498;13052.869471305165;13078.607641770763;13196.14225075367;13410.32948352559;8461.78845528842;11294.652382535633;11441;11486.540538378706;11504.654860354203;10293.639722609672;10311.381317120997;10373.325733827278;10600.310979786289;10640.521176547229;10904.34573925567;10929.726756831144;11104.5558177672;11242.775144497227;11258.38078905668;11736.968024381094;11801.704957376134;11879;12016.579419720618;12017.09871759604;8037.638306276114;8893.021767605429;9476.67326574294;10650.147988161083;10843.1867609928 07:44:33 INFO - PROCESS | 2180 | |3;mootools.html;1350.4463170100257;1434.985650143499;1512.7277090123773;1543.5678010157153;1573.8898277120602;9467.337286389955;9615.807683846318;10613.893861061388;11127.554897804088;11232.999999999989;9115.68095116671;10744.871788462217;11054.060404865597;11092.55629774808;11104.333739975607;1949.4444083436188;2000.6798912174056;2424.369663887393;2434.3670645632087;2436.768506991833;2400.6759087523224;2413.9155129570468;2426.235735743235;2446.2416650838295;2470.962935555959;2365.7989070928993;2394.964075538868;2400.651905473714;2429.259075981825;2467.2351571012955;1977.3474753331366;2390.8804559772116;2392.509535545209;2394.724606670238;2410.313060777679;2369.680093187415;2375.655529948148;2384.9046038158453;2390.5935990881594;2391.2228525729033;11088.112950963985;11102.777944441146;11119.666410007712;11256.887431125666;11271.549138034468;5805.303363596353;5884.146798714162;5984.640921544721;5992.161097446361;5997.040473524259;3599.7120230381506;3694.2980833641523;3704.1850792825535;3714.1271801126713;3730.6082861299715;1198.8189852571038;1209.6129238643637;1222.7004383925996;1245.1284101129245;1264.3614974437942;15775.92112039444;15908.840911590853;15975.281112349972;16002.119883406407;16040.759388609296;4887.218045112765;4933.4819843915875;5022.773975171126;5043.773030213649;5107.514786095315;11720.589779357852;11789.941050294694;11814.173007889538;11850.051995840313;11855.99224065964;5825.563082768725;5931.139984702194;5933.851653708605;5933.881322373529;5944.940550594525;5207.583393328525;5315.787368505294;5324.973375133177;5336.706481143575;5418.512333889968;3866.6133386661672;3967.424723415146;3967.504061992251;4062.30940740069;4074.5925407459017;1064.1593141418348;1072.1904961753983;1073.0503504398664;1085.03973983024;1086.3319058778793;803.4205031321491;857.8670306102564;911.4166933162782;917.5366439947917;925.4817302310728;5481.808136715196;6664.966675166593;6695.163104611924;6839.897401538981;6903.482238832108;1014.5079636376352;1044.4934206909643;1052.6421016854306;1058.1851973979992;1092.3118435385816;4234.407182994383;4285.635720963691;4322.438083049184;4420.403245561873;4493.573110554492;13920.58238252854;14385.85614143866;14488.782668259984;14496.782548261785;14524.419023238952;9045.547722613843;12577.874221257853;14362.425502979764;14369.06601070927;14380.640483987983;10072.59709611622;10362.948185259025;10370.481475926174;10371.27401081917;10374.325668831501;5217.607560308381;5909.55678324136;6106.023036314168;6551.6110763360975;6846.554973926679;11154.386508742096;11254.21220514556;11261.605843795427;11263.549458021587;11396.259243149168;11043.503042362952;11073.224874258725;11479.36863472517;11573;12526.311052892179;9432.764180895532;9436.716898493056;9547.713568592953;9581.616735330508;9633.229341652792;10417.583296668352;10446.216533759847;10474.842877356998;10504.842427363748;10619.787604248026;9004.549772511216;9017.594208260512;9056.230220431336;9106.453612783254;9239.168474837297;7987;8205.876911846208;8700.825983480168;8798.780030499032;8852.203301702877;7732.226777322223;8005.319547838499;8092.271695547429;8121.3908956829655;8137.959310203411;5801.361850196559;5945.494632956247;6036.758529658764;6038.154658347747;6110.7861224856915;5972.790952316822;6012.939870601238;6142.9078563820685;6145.784897528565;6265.154204182377 07:44:33 INFO - PROCESS | 2180 | |4;prototype.html;304.1908523327948;373.33918963434724;384.12036436560277;388.2409888667655;393.0703885311238;4597.919488920101;5275;5291.698111321578;5369;5515.503604675579;4385.912281754371;4477.955220447794;5189.636725429212;5234.6335756496965;5257.421683614799;3583.7670551414203;3598.4962105305276;3968.8214030368704;4082.530508991474;4376.155498925692;3910.882673519785;4194.224068547313;4465.397171381871;4472.597466228039;4487.596116349528;3925.2934471795065;4243.681723870706;4293.613574778269;4456.59890609845;4542.38677778499;3929.7249192556533;4021.819018144176;4185.874423767292;4348.978255108705;4514.774261286922;4017.738846974937;4031.3348297530874;4037.899052523681;4043.1509383029306;4060.939085913714;5163.63854530183;5193;5201.817936372209;5230.678519140335;5269.947300527022;4261.934516370908;4692;4729.290606409066;5097.923531147036;5192.3249977503065;4939.209726443752;5683.318001839806;5787.479126878601;5805.970970145122;5807.30312362515;4326.9567304326865;4385.386045953569;4415.873952142215;4443.311286750559;4596.770161491912;5355.384130824966;5682.397258220854;6045.939540604626;6082.756689732405;6088.299845517778;3898.5516665583823;4554.908901822011;4569.611583015414;4600.7929643166135;4625.7687115644085;3795.6014618465215;4054.594540545922;4701.811927522929;4748.240281554935;4758.5241475852135;4358.866694659411;4721.822021354325;4859.684120532154;5031.84904452867;5103.719295438712;5668.263125793703;5668.886622267614;5699.316082070178;5708.689939095956;5711.343195532484;1531.6400645848216;1594.792676952012;1597.5382524989504;1608.4772448953902;1618.158557550091;999.7900440907491;1121.147927575049;1141.0871302957767;1203.7050922524038;1228.441059318026;4676.329081670872;4741.905161896742;4992.650514463952;5302.045631786315;5327.600429967768;5020.673656212334;5124.104880742369;5308.469153084738;5435.945640543623;5454.61817672767;4525.909481810345;4644.489106198315;4989.276554899592;5175.508326708957;5271.6309858310315;2739.3425577861567;2978.3298757779326;3083.6762139975426;3096.427160975227;3100.023492599824;4701.529847015271;4882.902341953141;5428.946724402263;5640.943590564042;6074.7266373012435;4872.615759585678;5371.597130215249;5477.972610136924;5796.971015144982;5945.851353716192;5392.91910621341;5482.91775623358;5729.1119876419225;5827.504662103769;6147.924113280158;5165.992631436984;5243.23973023917;5312.759216877625;5323.364934357518;5328.307320048369;4871.368091689324;5130.896857175576;5714.79998200061;5757.740901659352;5815.621984570989;5424.457554244544;5569.10894256917;5991.610545314541;6002.549808764273;6167.506599471942;4511.571400716926;4596.172688915894;4641.67508274431;4657.740995617055;4717.905641887074;4550.6359491239955;5143.6399452037995;5914.704264786829;5932.733027013708;5954;4913.9017219656125;4983.476734942778;5162.432132465501;5257.239949026639;5363.2759577456545;4992.925106123338;5063.772130254074;5624.6625202487985;5705.942940570541;5715.742791574306;5132.692038477703;5428.538574221077;5562.972185139049;5599.832005039855;5605.766731319103;4953.925691114709;5186.766595503136;5215.608829337739;5657.745401457027;5690.37405885344;5523.502884740232;5525.944740552543;5540.005597984803;5573.693446860299;5633.718314084362 07:44:33 INFO - PROCESS | 2180 | |5;yui.html;668.4351722794237;686.7870960002397;713.6645776485052;771.2441807029111;802.1617409806752;15334.463293784705;16008.759868601981;16542.255598498068;16759.994400335974;16774.161291935416;12628.494860205603;15016.474423395157;15310.157941313224;15577.065376077444;15595.766063509056;913.7806926337681;938.648006997376;940.5908429833045;942.7454587261435;943.1323182671958;888.9333300002494;943.3113826906329;945.5508633399115;958.0754571838174;958.3531116496372;985.344745744083;987.8370068938652;988.4810474500873;991.182274623435;993.2600212841443;978.3493976505687;985.3545927417553;986.5511192407438;987.4272921705466;991.6182269826132;722.6061796320965;723.9457040721967;729.5622626424156;734.0494060192065;734.6620554544916;13601.591952241448;15824.683506329924;16295.022298662117;16361.936474129143;16687.83312166875;14024.719505609934;14372.425102995867;14457.204853733041;14462.638434039129;14477.42090316386;11707.76584468306;11915.582954596548;11952.103592230531;11958.820617690742;11989.280643161352;3617.927641447183;3662.670359667616;3700.7594506357;3739.5138631977943;3843.615638436162;110447.9999999992;110719.44640276827;114889;116883;116908;10401.791964160826;10919.344839309666;11100.38898118777;11129.554817807197;11473.71315717097;22071.779282207295;22801.429964251027;23243;23287.88356058209;23319.183828565918;6636.668166591651;7028.332308430691;7699.499532530368;7700.229977002255;7830.6084695764985;3848.230353929225;4356.847510337123;4411.867643970686;4454.977725111418;4471.485779135376;3488.1977145256733;3559.18138828071;3569.3575156471566;3576.660217279354;3597.6941959933697;623.607127509666;628.9591176573508;641.8202903187115;644.3073695777058;651.5829868883918;621.8134559632092;668.8160755792098;691.2948792231896;693.7537174303151;714.9034880291094;10073.546690398804;10105.747356316151;10121.089101980857;10122.949385253027;10407.50162102851;655.4625207330039;685.6194811879454;687.8280429892527;687.9312068793081;691.6057847027146;5034.672746271481;5057.721825299644;5064.53128592704;5068.923966140511;5120.641555091182;101977;102470.97529024763;103576.92846143035;106682;107981;79254.60372698099;90632.09367906237;91672.0832791677;92879;93289.5335523318;77754.6112269435;80544;81421.59289203516;81654.18345816585;82231.5888420566;9295.2175476447;11172.832407513732;11183.32900026001;11297.43512824339;11323.377214253294;42233.36649950314;44997.55002449934;46515.76742116268;46938.061238775714;50666.24000640067;60531;61260.38739612725;62756.68621657045;62841.68579157075;62845.05732413926;10542.314749541256;12690.936545317214;12695.93652031734;13010.609681709564;13031.869681303066;14583;14746.557603271918;14803.18582477974;14904.888392746145;15394.07635541871;13303.866961330263;13565.864341356855;13922.303884805517;14114.929425352808;14426;13072.607821765363;13630.863691363356;13683.452661893412;13790.586282411543;14254.714905702036;13005.479780808662;13502.459901603826;13690.86309136896;13823.447062117804;14134.575962721136;10027;10176.643817466353;10310.43292618913;10387.37675739458;10506.369617822955;11210.551577937118;11354.205205635857;11368.374739389414;11409.60066397672;11476.4261786912 07:44:33 INFO - PROCESS | 2180 | __end_tp_report 07:44:33 INFO - PROCESS | 2180 | __start_cc_report 07:44:33 INFO - PROCESS | 2180 | _x_x_mozilla_cycle_collect,411 07:44:33 INFO - PROCESS | 2180 | __end_cc_report 07:44:33 INFO - PROCESS | 2180 | __startTimestamp1490971473151__endTimestamp 07:44:33 INFO - PROCESS | 2180 | 07:44:33 INFO - PROCESS | 2180 | ------- Summary: start ------- 07:44:33 INFO - PROCESS | 2180 | Number of tests: 6 07:44:33 INFO - PROCESS | 2180 | 07:44:33 INFO - PROCESS | 2180 | [#0] dojo.html Cycles:165 Average:5969.60 Median:6194.04 stddev:705.09 (11.4%) stddev-sans-first:679.29 07:44:33 INFO - PROCESS | 2180 | Values: 3463.7 3471.9 3472.9 3481.1 3522.3 6076.7 6090.8 6148.0 6177.1 6177.5 6092.7 6157.9 6166.7 6170.5 6179.5 5486.6 5536.1 5543.3 5569.9 5638.4 5603.4 5606.0 5616.0 5656.1 5663.7 3935.0 5360.5 5587.0 5597.7 5755.0 5446.3 5447.8 5454.6 5463.5 5473.2 4494.2 5285.5 5404.6 5405.8 5408.3 6123.0 6129.0 6131.9 6192.6 6243.7 6251.0 6368.9 6426.1 6426.6 6435.5 6555.7 6559.9 6581.7 6590.0 6590.8 5030.6 6007.8 6084.8 6118.0 6177.4 6627.5 6683.7 6701.3 6707.4 6721.8 6364.0 6367.8 6377.7 6380.9 6403.6 6280.4 6319.1 6384.0 6523.5 6525.4 4767.4 5698.6 6329.0 6421.7 6638.0 6395.7 6424.8 6454.1 6461.1 6467.1 5070.2 5131.4 5238.3 5238.7 5267.8 4537.5 4589.6 4623.0 4680.2 4694.2 5991.3 6104.8 6138.7 6150.3 6165.6 6485.3 6511.1 6520.0 6539.5 6549.4 5916.8 6105.4 6194.0 6196.3 6204.8 5654.2 5659.9 5660.2 5666.9 5684.9 6693.0 6694.7 6708.2 6708.3 6738.1 6412.2 6472.4 6483.2 6490.2 6493.9 6347.8 6399.3 6585.6 6594.7 6734.2 6358.9 6439.5 6449.0 6455.4 6462.9 6391.0 6496.7 6502.5 6524.4 6529.5 4873.0 6182.7 6235.8 6247.2 6299.0 5104.6 6226.3 6291.5 6313.7 6380.9 5223.1 6128.3 6244.2 6337.0 6355.2 5353.0 6162.9 6314.8 6361.2 6372.1 5910.5 6168.0 6252.3 6262.3 6310.2 07:44:33 INFO - PROCESS | 2180 | 07:44:33 INFO - PROCESS | 2180 | [#1] ext.html Cycles:180 Average:57706.04 Median:28940.43 stddev:123052.62 (425.2%) stddev-sans-first:123323.46 07:44:33 INFO - PROCESS | 2180 | Values: 730.8 735.3 830.5 947.9 949.4 33406.8 38620.0 39640.0 41277.0 41336.8 32081.5 39588.6 39911.2 39955.0 39975.6 7857.7 10683.4 10889.2 11045.9 11107.7 10804.6 10857.2 10919.6 10922.9 10926.3 10925.0 10936.0 10936.7 10938.1 10948.2 10899.1 10912.9 10919.9 10929.2 10975.1 10519.7 10578.0 10600.4 10603.3 10605.6 28842.6 35115.5 35532.5 35690.6 35702.8 3653.5 3677.5 3697.9 3707.4 3760.6 25178.9 25188.7 25581.9 25964.6 26687.9 3009.8 3047.8 3124.4 3202.4 3233.2 286083.0 373860.0 374176.0 375073.0 376958.0 46227.5 46766.8 46804.5 46872.8 46926.0 47882.5 48084.0 48283.3 48365.8 48412.3 13986.0 14063.3 14305.6 14331.8 14341.3 12105.6 12161.4 12318.0 12318.7 12322.4 11167.9 11241.9 11741.2 12322.4 12488.4 4698.8 5585.4 5619.1 5647.7 5648.2 1037.2 1067.4 1098.2 1141.6 1181.9 23968.0 26449.9 26788.9 27767.9 28030.0 961.6 1013.3 1201.5 1237.2 1288.7 11124.5 12370.1 14584.1 14628.4 14841.9 513884.0 515322.0 515728.0 515826.0 518274.4 40623.6 49698.0 50163.7 51155.2 52514.5 1373.5 1419.9 1425.1 1431.0 1433.1 22356.1 24702.8 25764.9 27857.4 28364.7 43592.6 43620.3 43770.6 43801.6 43846.6 469656.7 486361.0 501208.5 505655.0 506511.0 30616.1 30871.5 30940.7 31151.0 31165.1 39045.6 39693.2 39918.8 40666.0 40837.4 26694.3 28508.6 28625.7 28689.7 28863.0 24966.9 28148.7 29017.9 29027.4 29080.1 24117.3 33988.3 33997.8 34020.8 34133.1 27768.0 28598.3 28626.7 29274.9 29447.0 22807.0 23060.3 23243.0 23476.2 23857.8 07:44:33 INFO - PROCESS | 2180 | 07:44:33 INFO - PROCESS | 2180 | [#2] jquery.html Cycles:180 Average:43490.15 Median:25542.13 stddev:126796.03 (496.4%) stddev-sans-first:127110.47 07:44:33 INFO - PROCESS | 2180 | Values: 414.2 429.6 431.9 434.7 444.3 19895.7 21184.3 21322.5 21453.1 21815.1 18159.4 21522.9 21913.6 22593.9 22751.9 6595.3 6885.2 6899.5 6957.1 6957.9 6371.2 6794.7 6838.6 6838.8 6853.5 6525.5 6762.2 6819.6 6833.2 6853.5 6723.1 6772.3 6774.5 6780.5 6788.7 6505.1 6586.1 6596.5 6641.6 6643.2 26430.9 26435.6 26542.1 26668.0 26734.5 3009.2 3009.5 3075.8 3078.3 3087.2 13176.5 15509.2 16083.2 16272.0 16561.4 2082.6 2138.7 2141.3 2144.1 2148.2 124232.0 128842.0 131878.0 133668.3 136340.0 18728.7 23174.5 23257.0 23625.6 24653.4 36923.6 37332.8 38053.0 38193.6 38307.0 11198.8 11254.4 11323.5 11477.4 11655.0 7548.7 9176.3 9204.5 9213.4 9402.6 8958.5 8992.4 10919.6 11040.8 11172.2 3710.5 4278.4 4406.0 4420.5 4421.6 865.9 891.9 922.0 935.9 962.6 21492.0 21614.0 22752.9 22857.1 22885.7 952.2 958.6 982.2 982.9 994.9 8176.8 9195.8 12013.8 12459.3 12473.6 671614.0 766965.0 784506.0 787688.0 794915.0 140144.0 163723.0 164232.0 164708.0 169159.0 1200.8 1242.2 1273.4 1284.7 1302.1 19957.8 21126.5 21177.9 21291.4 21327.8 65227.0 65430.7 65602.0 65732.0 65755.3 90603.0 92023.5 93266.5 93771.0 94094.0 9813.5 11429.0 11638.4 11850.3 12199.5 12968.7 13052.9 13078.6 13196.1 13410.3 8461.8 11294.7 11441.0 11486.5 11504.7 10293.6 10311.4 10373.3 10600.3 10640.5 10904.3 10929.7 11104.6 11242.8 11258.4 11737.0 11801.7 11879.0 12016.6 12017.1 8037.6 8893.0 9476.7 10650.1 10843.2 07:44:33 INFO - PROCESS | 2180 | 07:44:33 INFO - PROCESS | 2180 | [#3] mootools.html Cycles:180 Average:6734.64 Median:2431.81 stddev:4206.10 (173.0%) stddev-sans-first:4198.44 07:44:33 INFO - PROCESS | 2180 | Values: 1350.4 1435.0 1512.7 1543.6 1573.9 9467.3 9615.8 10613.9 11127.6 11233.0 9115.7 10744.9 11054.1 11092.6 11104.3 1949.4 2000.7 2424.4 2434.4 2436.8 2400.7 2413.9 2426.2 2446.2 2471.0 2365.8 2395.0 2400.7 2429.3 2467.2 1977.3 2390.9 2392.5 2394.7 2410.3 2369.7 2375.7 2384.9 2390.6 2391.2 11088.1 11102.8 11119.7 11256.9 11271.5 5805.3 5884.1 5984.6 5992.2 5997.0 3599.7 3694.3 3704.2 3714.1 3730.6 1198.8 1209.6 1222.7 1245.1 1264.4 15775.9 15908.8 15975.3 16002.1 16040.8 4887.2 4933.5 5022.8 5043.8 5107.5 11720.6 11789.9 11814.2 11850.1 11856.0 5825.6 5931.1 5933.9 5933.9 5944.9 5207.6 5315.8 5325.0 5336.7 5418.5 3866.6 3967.4 3967.5 4062.3 4074.6 1064.2 1072.2 1073.1 1085.0 1086.3 803.4 857.9 911.4 917.5 925.5 5481.8 6665.0 6695.2 6839.9 6903.5 1014.5 1044.5 1052.6 1058.2 1092.3 4234.4 4285.6 4322.4 4420.4 4493.6 13920.6 14385.9 14488.8 14496.8 14524.4 9045.5 12577.9 14362.4 14369.1 14380.6 10072.6 10362.9 10370.5 10371.3 10374.3 5217.6 5909.6 6106.0 6551.6 6846.6 11154.4 11254.2 11261.6 11263.5 11396.3 11043.5 11073.2 11479.4 11573.0 12526.3 9432.8 9436.7 9547.7 9581.6 9633.2 10417.6 10446.2 10474.8 10504.8 10619.8 9004.5 9017.6 9056.2 9106.5 9239.2 7987.0 8205.9 8700.8 8798.8 8852.2 7732.2 8005.3 8092.3 8121.4 8138.0 5801.4 5945.5 6036.8 6038.2 6110.8 5972.8 6012.9 6142.9 6145.8 6265.2 07:44:33 INFO - PROCESS | 2180 | 07:44:33 INFO - PROCESS | 2180 | [#4] prototype.html Cycles:180 Average:4655.64 Median:5047.81 stddev:1293.45 (25.6%) stddev-sans-first:1255.17 07:44:33 INFO - PROCESS | 2180 | Values: 304.2 373.3 384.1 388.2 393.1 4597.9 5275.0 5291.7 5369.0 5515.5 4385.9 4478.0 5189.6 5234.6 5257.4 3583.8 3598.5 3968.8 4082.5 4376.2 3910.9 4194.2 4465.4 4472.6 4487.6 3925.3 4243.7 4293.6 4456.6 4542.4 3929.7 4021.8 4185.9 4349.0 4514.8 4017.7 4031.3 4037.9 4043.2 4060.9 5163.6 5193.0 5201.8 5230.7 5269.9 4261.9 4692.0 4729.3 5097.9 5192.3 4939.2 5683.3 5787.5 5806.0 5807.3 4327.0 4385.4 4415.9 4443.3 4596.8 5355.4 5682.4 6045.9 6082.8 6088.3 3898.6 4554.9 4569.6 4600.8 4625.8 3795.6 4054.6 4701.8 4748.2 4758.5 4358.9 4721.8 4859.7 5031.8 5103.7 5668.3 5668.9 5699.3 5708.7 5711.3 1531.6 1594.8 1597.5 1608.5 1618.2 999.8 1121.1 1141.1 1203.7 1228.4 4676.3 4741.9 4992.7 5302.0 5327.6 5020.7 5124.1 5308.5 5435.9 5454.6 4525.9 4644.5 4989.3 5175.5 5271.6 2739.3 2978.3 3083.7 3096.4 3100.0 4701.5 4882.9 5428.9 5640.9 6074.7 4872.6 5371.6 5478.0 5797.0 5945.9 5392.9 5482.9 5729.1 5827.5 6147.9 5166.0 5243.2 5312.8 5323.4 5328.3 4871.4 5130.9 5714.8 5757.7 5815.6 5424.5 5569.1 5991.6 6002.5 6167.5 4511.6 4596.2 4641.7 4657.7 4717.9 4550.6 5143.6 5914.7 5932.7 5954.0 4913.9 4983.5 5162.4 5257.2 5363.3 4992.9 5063.8 5624.7 5705.9 5715.7 5132.7 5428.5 5563.0 5599.8 5605.8 4953.9 5186.8 5215.6 5657.7 5690.4 5523.5 5525.9 5540.0 5573.7 5633.7 07:44:33 INFO - PROCESS | 2180 | 07:44:33 INFO - PROCESS | 2180 | [#5] yui.html Cycles:180 Average:20739.78 Median:3564.27 stddev:30023.94 (842.4%) stddev-sans-first:30070.34 07:44:33 INFO - PROCESS | 2180 | Values: 668.4 686.8 713.7 771.2 802.2 15334.5 16008.8 16542.3 16760.0 16774.2 12628.5 15016.5 15310.2 15577.1 15595.8 913.8 938.6 940.6 942.7 943.1 888.9 943.3 945.6 958.1 958.4 985.3 987.8 988.5 991.2 993.3 978.3 985.4 986.6 987.4 991.6 722.6 723.9 729.6 734.0 734.7 13601.6 15824.7 16295.0 16361.9 16687.8 14024.7 14372.4 14457.2 14462.6 14477.4 11707.8 11915.6 11952.1 11958.8 11989.3 3617.9 3662.7 3700.8 3739.5 3843.6 110448.0 110719.4 114889.0 116883.0 116908.0 10401.8 10919.3 11100.4 11129.6 11473.7 22071.8 22801.4 23243.0 23287.9 23319.2 6636.7 7028.3 7699.5 7700.2 7830.6 3848.2 4356.8 4411.9 4455.0 4471.5 3488.2 3559.2 3569.4 3576.7 3597.7 623.6 629.0 641.8 644.3 651.6 621.8 668.8 691.3 693.8 714.9 10073.5 10105.7 10121.1 10122.9 10407.5 655.5 685.6 687.8 687.9 691.6 5034.7 5057.7 5064.5 5068.9 5120.6 101977.0 102471.0 103576.9 106682.0 107981.0 79254.6 90632.1 91672.1 92879.0 93289.5 77754.6 80544.0 81421.6 81654.2 82231.6 9295.2 11172.8 11183.3 11297.4 11323.4 42233.4 44997.6 46515.8 46938.1 50666.2 60531.0 61260.4 62756.7 62841.7 62845.1 10542.3 12690.9 12695.9 13010.6 13031.9 14583.0 14746.6 14803.2 14904.9 15394.1 13303.9 13565.9 13922.3 14114.9 14426.0 13072.6 13630.9 13683.5 13790.6 14254.7 13005.5 13502.5 13690.9 13823.4 14134.6 10027.0 10176.6 10310.4 10387.4 10506.4 11210.6 11354.2 11368.4 11409.6 11476.4 07:44:33 INFO - PROCESS | 2180 | -------- Summary: end -------- 07:44:33 INFO - PROCESS | 2180 | 07:44:33 INFO - TEST-INFO | 2180: exit 0 07:44:33 INFO - TEST-OK | dromaeo_css | took 1117081ms 07:44:33 INFO - TEST-START | kraken 07:44:33 INFO - operating with platform_type : mac_ 07:44:33 INFO - Initialising browser for kraken test... 07:44:33 INFO - TEST-INFO | started process 2185 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/tmpVg1POs/profile http://localhost:52532/getInfo.html) 07:44:36 INFO - PROCESS | 2185 | 2017-03-31 07:44:36.576 plugin-container[2186:19227] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8837, name = 'com.apple.tsm.portname' 07:44:36 INFO - PROCESS | 2185 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:44:36 INFO - PROCESS | 2185 | 2017-03-31 07:44:36.579 plugin-container[2186:19227] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b23, name = 'com.apple.CFPasteboardClient' 07:44:36 INFO - PROCESS | 2185 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:44:36 INFO - PROCESS | 2185 | 2017-03-31 07:44:36.579 plugin-container[2186:19227] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:44:36 INFO - PROCESS | 2185 | __metrics Screen width/height:1600/1200 07:44:36 INFO - PROCESS | 2185 | colorDepth:24 07:44:36 INFO - PROCESS | 2185 | Browser inner width/height: 1024/689 07:44:36 INFO - PROCESS | 2185 | __metrics 07:44:36 ERROR - PROCESS | 2185 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 07:44:37 INFO - TEST-INFO | 2185: exit 0 07:44:37 INFO - Browser initialized. 07:44:37 INFO - Running cycle 1/1 for kraken test... 07:44:37 INFO - TEST-INFO | started process 2187 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/tmpVg1POs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:44:39 INFO - PROCESS | 2187 | 2017-03-31 07:44:39.949 plugin-container[2188:19352] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x444b, name = 'com.apple.tsm.portname' 07:44:39 INFO - PROCESS | 2187 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:44:39 INFO - PROCESS | 2187 | 2017-03-31 07:44:39.950 plugin-container[2188:19352] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x910b, name = 'com.apple.CFPasteboardClient' 07:44:39 INFO - PROCESS | 2187 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:44:39 INFO - PROCESS | 2187 | 2017-03-31 07:44:39.950 plugin-container[2188:19352] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:44:49 INFO - PROCESS | 2187 | RSS: Main: 221278208 07:44:49 INFO - PROCESS | 2187 | 07:44:52 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:52532/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52532/tests/kraken/driver.html?testName=audio-beat-detection) 07:44:53 INFO - PROCESS | 2187 | RSS: Main: 235692032 07:44:53 INFO - PROCESS | 2187 | 07:44:56 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:52532/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52532/tests/kraken/driver.html?testName=audio-dft) 07:44:56 INFO - PROCESS | 2187 | RSS: Main: 243625984 07:44:56 INFO - PROCESS | 2187 | 07:45:00 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:52532/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52532/tests/kraken/driver.html?testName=audio-fft) 07:45:01 INFO - PROCESS | 2187 | RSS: Main: 245329920 07:45:01 INFO - PROCESS | 2187 | 07:45:03 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:52532/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52532/tests/kraken/driver.html?testName=audio-oscillator) 07:45:03 INFO - PROCESS | 2187 | RSS: Main: 247963648 07:45:03 INFO - PROCESS | 2187 | 07:45:05 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:52532/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52532/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:45:06 INFO - PROCESS | 2187 | RSS: Main: 248905728 07:45:06 INFO - PROCESS | 2187 | 07:45:09 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:52532/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52532/tests/kraken/driver.html?testName=imaging-darkroom) 07:45:10 INFO - PROCESS | 2187 | RSS: Main: 252530688 07:45:10 INFO - PROCESS | 2187 | 07:45:13 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:52532/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52532/tests/kraken/driver.html?testName=imaging-desaturate) 07:45:14 INFO - PROCESS | 2187 | RSS: Main: 252592128 07:45:14 INFO - PROCESS | 2187 | 07:45:16 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:52532/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52532/tests/kraken/driver.html?testName=json-parse-financial) 07:45:17 INFO - PROCESS | 2187 | RSS: Main: 252940288 07:45:17 INFO - PROCESS | 2187 | 07:45:19 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:52532/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52532/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:45:19 INFO - PROCESS | 2187 | RSS: Main: 251600896 07:45:19 INFO - PROCESS | 2187 | 07:45:21 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:52532/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52532/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:45:22 INFO - PROCESS | 2187 | RSS: Main: 251604992 07:45:22 INFO - PROCESS | 2187 | 07:45:24 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:52532/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52532/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:45:25 INFO - PROCESS | 2187 | RSS: Main: 251576320 07:45:25 INFO - PROCESS | 2187 | 07:45:28 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:52532/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52532/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:45:29 INFO - PROCESS | 2187 | RSS: Main: 252092416 07:45:29 INFO - PROCESS | 2187 | 07:45:31 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:52532/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52532/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:45:32 INFO - PROCESS | 2187 | RSS: Main: 251744256 07:45:32 INFO - PROCESS | 2187 | 07:45:34 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:52532/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52532/tests/kraken/driver.html?testName=ai-astar) 07:45:34 INFO - PROCESS | 2187 | RSS: Main: 253693952 07:45:34 INFO - PROCESS | 2187 | 07:45:34 INFO - PROCESS | 2187 | __start_tp_report 07:45:34 INFO - PROCESS | 2187 | _x_x_mozilla_page_load 07:45:34 INFO - PROCESS | 2187 | _x_x_mozilla_page_load_details 07:45:34 INFO - PROCESS | 2187 | |i|pagename|runs| 07:45:34 INFO - PROCESS | 2187 | |0;ai-astar;107;118;111;121;121;116;121;127;177;171 07:45:34 INFO - PROCESS | 2187 | |1;audio-beat-detection;140;111;112;144;111;111;110;120;118;149 07:45:34 INFO - PROCESS | 2187 | |2;audio-dft;271;275;225;196;197;233;280;203;200;197 07:45:34 INFO - PROCESS | 2187 | |3;audio-fft;89;70;77;103;85;88;86;70;73;60 07:45:34 INFO - PROCESS | 2187 | |4;audio-oscillator;86;70;87;73;72;72;83;74;94;116 07:45:34 INFO - PROCESS | 2187 | |5;imaging-gaussian-blur;91;93;93;106;107;78;137;136;81;138 07:45:34 INFO - PROCESS | 2187 | |6;imaging-darkroom;106;118;99;98;99;98;100;130;153;139 07:45:34 INFO - PROCESS | 2187 | |7;imaging-desaturate;92;94;96;93;91;90;93;107;90;91 07:45:34 INFO - PROCESS | 2187 | |8;json-parse-financial;66;65;64;67;70;68;68;70;75;107 07:45:34 INFO - PROCESS | 2187 | |9;json-stringify-tinderbox;58;65;71;69;63;58;58;58;66;86 07:45:34 INFO - PROCESS | 2187 | |10;stanford-crypto-aes;88;90;109;92;85;86;85;82;83;90 07:45:34 INFO - PROCESS | 2187 | |11;stanford-crypto-ccm;144;133;181;149;149;149;148;151;220;178 07:45:34 INFO - PROCESS | 2187 | |12;stanford-crypto-pbkdf2;165;172;167;166;166;167;167;165;169;168 07:45:34 INFO - PROCESS | 2187 | |13;stanford-crypto-sha256-iterative;68;66;76;87;89;85;83;89;66;66 07:45:34 INFO - PROCESS | 2187 | __end_tp_report 07:45:34 INFO - PROCESS | 2187 | __start_cc_report 07:45:34 INFO - PROCESS | 2187 | _x_x_mozilla_cycle_collect,1015 07:45:34 INFO - PROCESS | 2187 | __end_cc_report 07:45:34 INFO - PROCESS | 2187 | __startTimestamp1490971534695__endTimestamp 07:45:34 INFO - PROCESS | 2187 | 07:45:34 INFO - PROCESS | 2187 | ------- Summary: start ------- 07:45:34 INFO - PROCESS | 2187 | Number of tests: 14 07:45:34 INFO - PROCESS | 2187 | 07:45:34 INFO - PROCESS | 2187 | [#0] ai-astar Cycles:10 Average:129.00 Median:121.00 stddev:24.41 (20.2%) stddev-sans-first:24.56 07:45:34 INFO - PROCESS | 2187 | Values: 107.0 118.0 111.0 121.0 121.0 116.0 121.0 127.0 177.0 171.0 07:45:34 INFO - PROCESS | 2187 | 07:45:34 INFO - PROCESS | 2187 | [#1] audio-beat-detection Cycles:10 Average:122.60 Median:119.00 stddev:15.49 (13.0%) stddev-sans-first:15.10 07:45:34 INFO - PROCESS | 2187 | Values: 140.0 111.0 112.0 144.0 111.0 111.0 110.0 120.0 118.0 149.0 07:45:34 INFO - PROCESS | 2187 | 07:45:34 INFO - PROCESS | 2187 | [#2] audio-dft Cycles:10 Average:227.70 Median:229.00 stddev:35.20 (15.4%) stddev-sans-first:33.67 07:45:34 INFO - PROCESS | 2187 | Values: 271.0 275.0 225.0 196.0 197.0 233.0 280.0 203.0 200.0 197.0 07:45:34 INFO - PROCESS | 2187 | 07:45:34 INFO - PROCESS | 2187 | [#3] audio-fft Cycles:10 Average:80.10 Median:81.00 stddev:12.44 (15.4%) stddev-sans-first:12.77 07:45:34 INFO - PROCESS | 2187 | Values: 89.0 70.0 77.0 103.0 85.0 88.0 86.0 70.0 73.0 60.0 07:45:34 INFO - PROCESS | 2187 | 07:45:34 INFO - PROCESS | 2187 | [#4] audio-oscillator Cycles:10 Average:82.70 Median:78.50 stddev:14.24 (18.1%) stddev-sans-first:15.06 07:45:34 INFO - PROCESS | 2187 | Values: 86.0 70.0 87.0 73.0 72.0 72.0 83.0 74.0 94.0 116.0 07:45:34 INFO - PROCESS | 2187 | 07:45:34 INFO - PROCESS | 2187 | [#5] imaging-gaussian-blur Cycles:10 Average:106.00 Median:79.50 stddev:23.23 (29.2%) stddev-sans-first:24.00 07:45:34 INFO - PROCESS | 2187 | Values: 91.0 93.0 93.0 106.0 107.0 78.0 137.0 136.0 81.0 138.0 07:45:34 INFO - PROCESS | 2187 | 07:45:34 INFO - PROCESS | 2187 | [#6] imaging-darkroom Cycles:10 Average:114.00 Median:125.50 stddev:20.11 (16.0%) stddev-sans-first:21.12 07:45:34 INFO - PROCESS | 2187 | Values: 106.0 118.0 99.0 98.0 99.0 98.0 100.0 130.0 153.0 139.0 07:45:34 INFO - PROCESS | 2187 | 07:45:34 INFO - PROCESS | 2187 | [#7] imaging-desaturate Cycles:10 Average:93.70 Median:92.50 stddev:5.03 (5.4%) stddev-sans-first:5.30 07:45:34 INFO - PROCESS | 2187 | Values: 92.0 94.0 96.0 93.0 91.0 90.0 93.0 107.0 90.0 91.0 07:45:34 INFO - PROCESS | 2187 | 07:45:34 INFO - PROCESS | 2187 | [#8] json-parse-financial Cycles:10 Average:72.00 Median:68.00 stddev:12.68 (18.7%) stddev-sans-first:13.27 07:45:34 INFO - PROCESS | 2187 | Values: 66.0 65.0 64.0 67.0 70.0 68.0 68.0 70.0 75.0 107.0 07:45:34 INFO - PROCESS | 2187 | 07:45:34 INFO - PROCESS | 2187 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.50 stddev:8.78 (13.4%) stddev-sans-first:8.92 07:45:34 INFO - PROCESS | 2187 | Values: 58.0 65.0 71.0 69.0 63.0 58.0 58.0 58.0 66.0 86.0 07:45:34 INFO - PROCESS | 2187 | 07:45:34 INFO - PROCESS | 2187 | [#10] stanford-crypto-aes Cycles:10 Average:89.00 Median:87.00 stddev:7.73 (8.9%) stddev-sans-first:8.19 07:45:34 INFO - PROCESS | 2187 | Values: 88.0 90.0 109.0 92.0 85.0 86.0 85.0 82.0 83.0 90.0 07:45:34 INFO - PROCESS | 2187 | 07:45:34 INFO - PROCESS | 2187 | [#11] stanford-crypto-ccm Cycles:10 Average:160.20 Median:150.00 stddev:25.69 (17.1%) stddev-sans-first:26.57 07:45:34 INFO - PROCESS | 2187 | Values: 144.0 133.0 181.0 149.0 149.0 149.0 148.0 151.0 220.0 178.0 07:45:34 INFO - PROCESS | 2187 | 07:45:34 INFO - PROCESS | 2187 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.20 Median:167.00 stddev:2.10 (1.3%) stddev-sans-first:2.07 07:45:34 INFO - PROCESS | 2187 | Values: 165.0 172.0 167.0 166.0 166.0 167.0 167.0 165.0 169.0 168.0 07:45:34 INFO - PROCESS | 2187 | 07:45:34 INFO - PROCESS | 2187 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.50 Median:84.00 stddev:10.17 (12.1%) stddev-sans-first:10.19 07:45:34 INFO - PROCESS | 2187 | Values: 68.0 66.0 76.0 87.0 89.0 85.0 83.0 89.0 66.0 66.0 07:45:34 INFO - PROCESS | 2187 | -------- Summary: end -------- 07:45:34 INFO - PROCESS | 2187 | 07:45:35 INFO - TEST-INFO | 2187: exit 0 07:45:35 INFO - TEST-OK | kraken | took 61778ms 07:45:35 INFO - SUITE-END | took 1178s 07:45:35 INFO - Completed test suite (00:19:39) 07:45:35 INFO - javascript benchmark 07:45:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7744.220352575248, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3463.7229021678268, 3471.9305613887736, 3472.861085556578, 3481.129717570607, 3522.348365552373, 6076.6961651917445, 6090.817275481737, 6148.047052706826, 6177.135201071842, 6177.505799536038, 6092.725827337769, 6157.938420615804, 6166.722497487613, 6170.475509581691, 6179.505639548836, 5486.61593688441, 5536.086545719952, 5543.25166102575, 5569.888602227953, 5638.379778224392, 5603.411641777596, 5606.0, 5615.971920140393, 5656.095024796034, 5663.745131469073, 3934.9803250983705, 5360.490753378443, 5587.0, 5597.692126933017, 5755.0, 5446.291982042309, 5447.782088716466, 5454.59090568209, 5463.508284254416, 5473.17902314656, 4494.213512635276, 5285.524302812765, 5404.5946554008215, 5405.783768649249, 5408.269883565747, 6123.0, 6129.0, 6131.87736245277, 6192.566520343577, 6243.687815609247, 6251.0, 6368.936310636881, 6426.1003459515705, 6426.550141490097, 6435.517336199757, 6555.672216389162, 6559.901601475982, 6581.670916454158, 6590.011498275249, 6590.8352291193105, 5030.647854650139, 6007.789727359522, 6084.78304339134, 6118.010103775246, 6177.351378105324, 6627.536072474881, 6683.699233534406, 6701.262861085277, 6707.3628005339415, 6721.764738234138, 6364.0, 6367.777127800505, 6377.7448902044325, 6380.936190638127, 6403.58376705522, 6280.403361680633, 6319.115323854664, 6384.042393640991, 6523.478121750249, 6525.3800888915475, 4767.380240568773, 5698.629589076697, 6329.0, 6421.74313027483, 6638.0, 6395.712192951329, 6424.775132870327, 6454.064160696673, 6461.095446637474, 6467.126937863422, 5070.163423035232, 5131.358580177478, 5238.266642670029, 5238.68567885928, 5267.815626453055, 4537.455505339314, 4589.632829373642, 4623.0, 4680.204365257914, 4694.1550520905885, 5991.310999235056, 6104.786332478342, 6138.664296166128, 6150.323464418911, 6165.568410211242, 6485.286618471964, 6511.0558968949235, 6520.021996700533, 6539.50953678476, 6549.377809108127, 5916.792912248136, 6105.419985101408, 6194.039923811816, 6196.318404975449, 6204.7828326008375, 5654.208410822488, 5659.943400565941, 5660.15097735343, 5666.858328541737, 5684.857878552986, 6693.0, 6694.698738556874, 6708.228553716385, 6708.329167083252, 6738.090357801634, 6412.230532335963, 6472.449841763503, 6483.222013358427, 6490.156279683611, 6493.902591461227, 6347.841303967253, 6399.328070552711, 6585.5719378240265, 6594.703238354382, 6734.22556406, 6358.872822543431, 6439.484841212786, 6448.967755161194, 6455.419012288917, 6462.935370646422, 6390.968045159744, 6496.70764815575, 6502.512311576556, 6524.412802847766, 6529.51028672861, 4872.9512704872495, 6182.690865456799, 6235.75056997715, 6247.219097612799, 6298.968505157445, 5104.642675012714, 6226.346233645402, 6291.496680265659, 6313.684315784284, 6380.9042864358, 5223.112070948024, 6128.264608247039, 6244.1570387997035, 6337.0, 6355.205599300088, 5353.0, 6162.890679677701, 6314.810555683337, 6361.2048493938255, 6372.139761132188, 5910.468057874812, 6168.013117901114, 6252.343503932204, 6262.311145774052, 6310.1796766420075], "value": 5926.70243885797, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [730.817295676081, 735.283098978496, 830.5349004557448, 947.8578213268013, 949.4398305000049, 33406.832965835136, 38620.0, 39640.0, 41276.96807579808, 41336.79331603345, 32081.5187772183, 39588.60411395885, 39911.201775964466, 39955.0, 39975.60024399755, 7857.6856925722905, 10683.358998460079, 10889.183311251649, 11045.944770276137, 11107.72230694231, 10804.621838235664, 10857.185711071661, 10919.563217471292, 10922.945385273102, 10926.344419334866, 10925.016748492633, 10936.0, 10936.671899843017, 10938.070264027567, 10948.178886583499, 10899.1280697544, 10912.890871091346, 10919.945400272987, 10929.234953553254, 10975.06711929487, 10519.684409467729, 10577.995090466393, 10600.363978161335, 10603.257771955967, 10605.575776968912, 28842.567361489593, 35115.473267901005, 35532.46701299483, 35690.64309356899, 35702.75040373574, 3653.4702468141973, 3677.5035370224946, 3697.9445308320396, 3707.443883417482, 3760.567534733513, 25178.874105629355, 25188.748112519006, 25581.872090639612, 25964.610530842052, 26687.86497080229, 3009.819410835357, 3047.771417143701, 3124.390743804959, 3202.3755367703307, 3233.207864073317, 286083.0, 373860.0, 374176.0, 375073.0, 376958.0, 46227.53772462232, 46766.76616616895, 46804.5319546807, 46872.82817929579, 46926.0, 47882.521174787806, 48084.0, 48283.275750863766, 48365.790855228195, 48412.27381589279, 13986.0, 14063.2968351582, 14305.642358940902, 14331.78502322466, 14341.282935853165, 12105.576304829288, 12161.391930403444, 12318.014558835272, 12318.692032699075, 12322.445489952974, 11167.888321116847, 11241.887581124083, 11741.236819606698, 12322.383880806103, 12488.438020289108, 4698.8120475181295, 5585.385607583163, 5619.072852979294, 5647.717614119278, 5648.209250704905, 1037.190991027, 1067.40758878823, 1098.2367254757867, 1141.57191053355, 1181.9349935753444, 23968.0, 26449.867750661124, 26788.866055669598, 27767.8892844284, 28030.0, 961.6393852305386, 1013.341328136717, 1201.5133870782347, 1237.189640785287, 1288.6778305423645, 11124.49939752713, 12370.050517319132, 14584.124952502883, 14628.414863405558, 14841.851581484263, 513884.0, 515322.0, 515728.0, 515826.0, 518274.4086279544, 40623.59376406257, 49698.006039879, 50163.74590635263, 51155.232671509955, 52514.474855250955, 1373.4849431463201, 1419.8509156538414, 1425.1306702911215, 1430.9785353219918, 1433.089987857718, 22356.105755769586, 24702.752972470764, 25764.871175644003, 27857.44285114327, 28364.716352836207, 43592.56407435885, 43620.34569481397, 43770.56229437665, 43801.56198437975, 43846.561534385524, 469656.65171673923, 486361.0, 501208.49395752785, 505655.0, 506511.0, 30616.08151755451, 30871.536926945664, 30940.69059309378, 31151.0, 31165.065048048597, 39045.6095439042, 39693.20613587654, 39918.80040599778, 40665.98335041648, 40837.38743918784, 26694.332641684112, 28508.57237141403, 28625.713742862306, 28689.713102868704, 28863.0, 24966.875165624057, 28148.71851281461, 29017.854910726157, 29027.419451610425, 29080.06235510429, 24117.276481705576, 33988.32023359469, 33997.8100766472, 34020.829895850366, 34133.146671333416, 27768.0, 28598.285042873264, 28626.713732863238, 29274.853625731736, 29447.0, 22807.0, 23060.34375975443, 23243.0, 23476.178333758235, 23857.832575213222], "value": 18347.571539394397, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [414.2440046914382, 429.5597013061612, 431.88376952930656, 434.6631360695463, 444.3445917272024, 19895.701564476527, 21184.2585509507, 21322.46693832655, 21453.141874325047, 21815.127394904226, 18159.364422245224, 21522.89238553809, 21913.561728765417, 22593.887030564823, 22751.862406879674, 6595.274519802818, 6885.173779146509, 6899.48253880961, 6957.130358705162, 6957.8956315655305, 6371.235451745773, 6794.728210871559, 6838.589684618914, 6838.829029274259, 6853.520253582251, 6525.510586706016, 6762.2223444304045, 6819.590824550518, 6833.248342682301, 6853.520253582251, 6723.09238252837, 6772.255051944282, 6774.45804335652, 6780.474393261501, 6788.72845086196, 6505.121808555832, 6586.110875031857, 6596.472282217411, 6641.601503909781, 6643.202815662152, 26430.86784566084, 26435.603465948025, 26542.07102751414, 26668.0, 26734.46531069387, 3009.172477568686, 3009.458297506448, 3075.8462076896067, 3078.3073808393156, 3087.228192951762, 13176.53882114131, 15509.239726605363, 16083.199648170628, 16272.023678579322, 16561.4203502878, 2082.5938941906334, 2138.6898899659463, 2141.3468891987936, 2144.088762276042, 2148.1622167354744, 124232.0, 128842.0, 131878.0, 133668.33165834207, 136340.0, 18728.719069213974, 23174.53650926972, 23257.0, 23625.63743625658, 24653.38366540851, 36923.630763692556, 37332.81333593315, 38053.04867378338, 38193.61806381956, 38307.0, 11198.776024479464, 11254.381009044417, 11323.490442930088, 11477.36874471912, 11655.0, 7548.66031028605, 9176.31177661678, 9204.493752843659, 9213.355065145375, 9402.576884040234, 8958.462492250486, 8992.370534062684, 10919.563217471212, 11040.779184416268, 11172.162087843444, 3710.5361829771277, 4278.379634952915, 4405.9559404405545, 4420.535843736361, 4421.646268298528, 865.9307255419551, 891.888513935758, 921.9677311294073, 935.9064093590587, 962.5957098018849, 21492.0, 21614.0, 22752.886235568716, 22857.057150142424, 22885.656715149285, 952.2096659772373, 958.5878072428783, 982.1602529837029, 982.9066238707311, 994.8607194992707, 8176.836463270702, 9195.770105747277, 12013.819792703116, 12459.252444853339, 12473.625791226277, 671614.0, 766965.0, 784506.0, 787688.0, 794915.0, 140144.0, 163723.0, 164232.0, 164708.0, 169159.0, 1200.8018676918211, 1242.1739543203669, 1273.382409531395, 1284.6852521132382, 1302.1145620977636, 19957.84257899503, 21126.47183820417, 21177.894110529964, 21291.36125916225, 21327.7867221332, 65227.0, 65430.67284663737, 65602.01596975954, 65732.0, 65755.34244657683, 90603.0, 92023.53988230016, 93266.53366733123, 93771.0, 94094.0, 9813.509324533601, 11429.0, 11638.41807909618, 11850.348230847387, 12199.51201951912, 12968.675783105498, 13052.869471305165, 13078.607641770763, 13196.14225075367, 13410.32948352559, 8461.78845528842, 11294.652382535633, 11441.0, 11486.540538378706, 11504.654860354203, 10293.639722609672, 10311.381317120997, 10373.325733827278, 10600.310979786289, 10640.521176547229, 10904.34573925567, 10929.726756831144, 11104.5558177672, 11242.775144497227, 11258.38078905668, 11736.968024381094, 11801.704957376134, 11879.0, 12016.579419720618, 12017.09871759604, 8037.638306276114, 8893.021767605429, 9476.67326574294, 10650.147988161083, 10843.1867609928], "value": 11746.206928454256, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1350.4463170100257, 1434.985650143499, 1512.7277090123773, 1543.5678010157153, 1573.8898277120602, 9467.337286389955, 9615.807683846318, 10613.893861061388, 11127.554897804088, 11232.999999999989, 9115.68095116671, 10744.871788462217, 11054.060404865597, 11092.55629774808, 11104.333739975607, 1949.4444083436188, 2000.6798912174056, 2424.369663887393, 2434.3670645632087, 2436.768506991833, 2400.6759087523224, 2413.9155129570468, 2426.235735743235, 2446.2416650838295, 2470.962935555959, 2365.7989070928993, 2394.964075538868, 2400.651905473714, 2429.259075981825, 2467.2351571012955, 1977.3474753331366, 2390.8804559772116, 2392.509535545209, 2394.724606670238, 2410.313060777679, 2369.680093187415, 2375.655529948148, 2384.9046038158453, 2390.5935990881594, 2391.2228525729033, 11088.112950963985, 11102.777944441146, 11119.666410007712, 11256.887431125666, 11271.549138034468, 5805.303363596353, 5884.146798714162, 5984.640921544721, 5992.161097446361, 5997.040473524259, 3599.7120230381506, 3694.2980833641523, 3704.1850792825535, 3714.1271801126713, 3730.6082861299715, 1198.8189852571038, 1209.6129238643637, 1222.7004383925996, 1245.1284101129245, 1264.3614974437942, 15775.92112039444, 15908.840911590853, 15975.281112349972, 16002.119883406407, 16040.759388609296, 4887.218045112765, 4933.4819843915875, 5022.773975171126, 5043.773030213649, 5107.514786095315, 11720.589779357852, 11789.941050294694, 11814.173007889538, 11850.051995840313, 11855.99224065964, 5825.563082768725, 5931.139984702194, 5933.851653708605, 5933.881322373529, 5944.940550594525, 5207.583393328525, 5315.787368505294, 5324.973375133177, 5336.706481143575, 5418.512333889968, 3866.6133386661672, 3967.424723415146, 3967.504061992251, 4062.30940740069, 4074.5925407459017, 1064.1593141418348, 1072.1904961753983, 1073.0503504398664, 1085.03973983024, 1086.3319058778793, 803.4205031321491, 857.8670306102564, 911.4166933162782, 917.5366439947917, 925.4817302310728, 5481.808136715196, 6664.966675166593, 6695.163104611924, 6839.897401538981, 6903.482238832108, 1014.5079636376352, 1044.4934206909643, 1052.6421016854306, 1058.1851973979992, 1092.3118435385816, 4234.407182994383, 4285.635720963691, 4322.438083049184, 4420.403245561873, 4493.573110554492, 13920.58238252854, 14385.85614143866, 14488.782668259984, 14496.782548261785, 14524.419023238952, 9045.547722613843, 12577.874221257853, 14362.425502979764, 14369.06601070927, 14380.640483987983, 10072.59709611622, 10362.948185259025, 10370.481475926174, 10371.27401081917, 10374.325668831501, 5217.607560308381, 5909.55678324136, 6106.023036314168, 6551.6110763360975, 6846.554973926679, 11154.386508742096, 11254.21220514556, 11261.605843795427, 11263.549458021587, 11396.259243149168, 11043.503042362952, 11073.224874258725, 11479.36863472517, 11573.0, 12526.311052892179, 9432.764180895532, 9436.716898493056, 9547.713568592953, 9581.616735330508, 9633.229341652792, 10417.583296668352, 10446.216533759847, 10474.842877356998, 10504.842427363748, 10619.787604248026, 9004.549772511216, 9017.594208260512, 9056.230220431336, 9106.453612783254, 9239.168474837297, 7987.0, 8205.876911846208, 8700.825983480168, 8798.780030499032, 8852.203301702877, 7732.226777322223, 8005.319547838499, 8092.271695547429, 8121.3908956829655, 8137.959310203411, 5801.361850196559, 5945.494632956247, 6036.758529658764, 6038.154658347747, 6110.7861224856915, 5972.790952316822, 6012.939870601238, 6142.9078563820685, 6145.784897528565, 6265.154204182377], "value": 5147.944030409897, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.1908523327948, 373.33918963434724, 384.12036436560277, 388.2409888667655, 393.0703885311238, 4597.919488920101, 5275.0, 5291.698111321578, 5369.0, 5515.503604675579, 4385.912281754371, 4477.955220447794, 5189.636725429212, 5234.6335756496965, 5257.421683614799, 3583.7670551414203, 3598.4962105305276, 3968.8214030368704, 4082.530508991474, 4376.155498925692, 3910.882673519785, 4194.224068547313, 4465.397171381871, 4472.597466228039, 4487.596116349528, 3925.2934471795065, 4243.681723870706, 4293.613574778269, 4456.59890609845, 4542.38677778499, 3929.7249192556533, 4021.819018144176, 4185.874423767292, 4348.978255108705, 4514.774261286922, 4017.738846974937, 4031.3348297530874, 4037.899052523681, 4043.1509383029306, 4060.939085913714, 5163.63854530183, 5193.0, 5201.817936372209, 5230.678519140335, 5269.947300527022, 4261.934516370908, 4692.0, 4729.290606409066, 5097.923531147036, 5192.3249977503065, 4939.209726443752, 5683.318001839806, 5787.479126878601, 5805.970970145122, 5807.30312362515, 4326.9567304326865, 4385.386045953569, 4415.873952142215, 4443.311286750559, 4596.770161491912, 5355.384130824966, 5682.397258220854, 6045.939540604626, 6082.756689732405, 6088.299845517778, 3898.5516665583823, 4554.908901822011, 4569.611583015414, 4600.7929643166135, 4625.7687115644085, 3795.6014618465215, 4054.594540545922, 4701.811927522929, 4748.240281554935, 4758.5241475852135, 4358.866694659411, 4721.822021354325, 4859.684120532154, 5031.84904452867, 5103.719295438712, 5668.263125793703, 5668.886622267614, 5699.316082070178, 5708.689939095956, 5711.343195532484, 1531.6400645848216, 1594.792676952012, 1597.5382524989504, 1608.4772448953902, 1618.158557550091, 999.7900440907491, 1121.147927575049, 1141.0871302957767, 1203.7050922524038, 1228.441059318026, 4676.329081670872, 4741.905161896742, 4992.650514463952, 5302.045631786315, 5327.600429967768, 5020.673656212334, 5124.104880742369, 5308.469153084738, 5435.945640543623, 5454.61817672767, 4525.909481810345, 4644.489106198315, 4989.276554899592, 5175.508326708957, 5271.6309858310315, 2739.3425577861567, 2978.3298757779326, 3083.6762139975426, 3096.427160975227, 3100.023492599824, 4701.529847015271, 4882.902341953141, 5428.946724402263, 5640.943590564042, 6074.7266373012435, 4872.615759585678, 5371.597130215249, 5477.972610136924, 5796.971015144982, 5945.851353716192, 5392.91910621341, 5482.91775623358, 5729.1119876419225, 5827.504662103769, 6147.924113280158, 5165.992631436984, 5243.23973023917, 5312.759216877625, 5323.364934357518, 5328.307320048369, 4871.368091689324, 5130.896857175576, 5714.79998200061, 5757.740901659352, 5815.621984570989, 5424.457554244544, 5569.10894256917, 5991.610545314541, 6002.549808764273, 6167.506599471942, 4511.571400716926, 4596.172688915894, 4641.67508274431, 4657.740995617055, 4717.905641887074, 4550.6359491239955, 5143.6399452037995, 5914.704264786829, 5932.733027013708, 5954.0, 4913.9017219656125, 4983.476734942778, 5162.432132465501, 5257.239949026639, 5363.2759577456545, 4992.925106123338, 5063.772130254074, 5624.6625202487985, 5705.942940570541, 5715.742791574306, 5132.692038477703, 5428.538574221077, 5562.972185139049, 5599.832005039855, 5605.766731319103, 4953.925691114709, 5186.766595503136, 5215.608829337739, 5657.745401457027, 5690.37405885344, 5523.502884740232, 5525.944740552543, 5540.005597984803, 5573.693446860299, 5633.718314084362], "value": 4275.360243015164, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [668.4351722794237, 686.7870960002397, 713.6645776485052, 771.2441807029111, 802.1617409806752, 15334.463293784705, 16008.759868601981, 16542.255598498068, 16759.994400335974, 16774.161291935416, 12628.494860205603, 15016.474423395157, 15310.157941313224, 15577.065376077444, 15595.766063509056, 913.7806926337681, 938.648006997376, 940.5908429833045, 942.7454587261435, 943.1323182671958, 888.9333300002494, 943.3113826906329, 945.5508633399115, 958.0754571838174, 958.3531116496372, 985.344745744083, 987.8370068938652, 988.4810474500873, 991.182274623435, 993.2600212841443, 978.3493976505687, 985.3545927417553, 986.5511192407438, 987.4272921705466, 991.6182269826132, 722.6061796320965, 723.9457040721967, 729.5622626424156, 734.0494060192065, 734.6620554544916, 13601.591952241448, 15824.683506329924, 16295.022298662117, 16361.936474129143, 16687.83312166875, 14024.719505609934, 14372.425102995867, 14457.204853733041, 14462.638434039129, 14477.42090316386, 11707.76584468306, 11915.582954596548, 11952.103592230531, 11958.820617690742, 11989.280643161352, 3617.927641447183, 3662.670359667616, 3700.7594506357, 3739.5138631977943, 3843.615638436162, 110447.9999999992, 110719.44640276827, 114889.0, 116883.0, 116908.0, 10401.791964160826, 10919.344839309666, 11100.38898118777, 11129.554817807197, 11473.71315717097, 22071.779282207295, 22801.429964251027, 23243.0, 23287.88356058209, 23319.183828565918, 6636.668166591651, 7028.332308430691, 7699.499532530368, 7700.229977002255, 7830.6084695764985, 3848.230353929225, 4356.847510337123, 4411.867643970686, 4454.977725111418, 4471.485779135376, 3488.1977145256733, 3559.18138828071, 3569.3575156471566, 3576.660217279354, 3597.6941959933697, 623.607127509666, 628.9591176573508, 641.8202903187115, 644.3073695777058, 651.5829868883918, 621.8134559632092, 668.8160755792098, 691.2948792231896, 693.7537174303151, 714.9034880291094, 10073.546690398804, 10105.747356316151, 10121.089101980857, 10122.949385253027, 10407.50162102851, 655.4625207330039, 685.6194811879454, 687.8280429892527, 687.9312068793081, 691.6057847027146, 5034.672746271481, 5057.721825299644, 5064.53128592704, 5068.923966140511, 5120.641555091182, 101977.0, 102470.97529024763, 103576.92846143035, 106682.0, 107981.0, 79254.60372698099, 90632.09367906237, 91672.0832791677, 92879.0, 93289.5335523318, 77754.6112269435, 80544.0, 81421.59289203516, 81654.18345816585, 82231.5888420566, 9295.2175476447, 11172.832407513732, 11183.32900026001, 11297.43512824339, 11323.377214253294, 42233.36649950314, 44997.55002449934, 46515.76742116268, 46938.061238775714, 50666.24000640067, 60531.0, 61260.38739612725, 62756.68621657045, 62841.68579157075, 62845.05732413926, 10542.314749541256, 12690.936545317214, 12695.93652031734, 13010.609681709564, 13031.869681303066, 14583.0, 14746.557603271918, 14803.18582477974, 14904.888392746145, 15394.07635541871, 13303.866961330263, 13565.864341356855, 13922.303884805517, 14114.929425352808, 14426.0, 13072.607821765363, 13630.863691363356, 13683.452661893412, 13790.586282411543, 14254.714905702036, 13005.479780808662, 13502.459901603826, 13690.86309136896, 13823.447062117804, 14134.575962721136, 10027.0, 10176.643817466353, 10310.43292618913, 10387.37675739458, 10506.369617822955, 11210.551577937118, 11354.205205635857, 11368.374739389414, 11409.60066397672, 11476.4261786912], "value": 7672.384149077641, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1586.9000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 118.0, 111.0, 121.0, 121.0, 116.0, 121.0, 127.0, 177.0, 171.0], "value": 129.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 111.0, 112.0, 144.0, 111.0, 111.0, 110.0, 120.0, 118.0, 149.0], "value": 122.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [271.0, 275.0, 225.0, 196.0, 197.0, 233.0, 280.0, 203.0, 200.0, 197.0], "value": 227.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 70.0, 77.0, 103.0, 85.0, 88.0, 86.0, 70.0, 73.0, 60.0], "value": 80.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 70.0, 87.0, 73.0, 72.0, 72.0, 83.0, 74.0, 94.0, 116.0], "value": 82.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 93.0, 93.0, 106.0, 107.0, 78.0, 137.0, 136.0, 81.0, 138.0], "value": 106.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 118.0, 99.0, 98.0, 99.0, 98.0, 100.0, 130.0, 153.0, 139.0], "value": 114.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 94.0, 96.0, 93.0, 91.0, 90.0, 93.0, 107.0, 90.0, 91.0], "value": 93.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 64.0, 67.0, 70.0, 68.0, 68.0, 70.0, 75.0, 107.0], "value": 72.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 65.0, 71.0, 69.0, 63.0, 58.0, 58.0, 58.0, 66.0, 86.0], "value": 65.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 90.0, 109.0, 92.0, 85.0, 86.0, 85.0, 82.0, 83.0, 90.0], "value": 89.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 133.0, 181.0, 149.0, 149.0, 149.0, 148.0, 151.0, 220.0, 178.0], "value": 160.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 172.0, 167.0, 166.0, 166.0, 167.0, 167.0, 165.0, 169.0, 168.0], "value": 167.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 76.0, 87.0, 89.0, 85.0, 83.0, 89.0, 66.0, 66.0], "value": 77.5, "unit": "score"}]}]} 07:45:35 INFO - Return code: 0 07:45:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:45:36 ERROR - # TBPL SUCCESS # 07:45:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:45:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:45:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:45:36 INFO - 2017-03-31 07:45:36.060 screenresolution[2192:19751] starting screenresolution argv=screenresolution get 07:45:36 INFO - 2017-03-31 07:45:36.063 screenresolution[2192:19751] Display 0: 1600x1200x32@60 07:45:36 INFO - 2017-03-31 07:45:36.069 screenresolution[2193:19754] starting screenresolution argv=screenresolution list 07:45:36 INFO - Available Modes on Display 0 07:45:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:45:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:45:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:45:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:45:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:45:36 INFO - Intel Iris: 07:45:36 INFO - Chipset Model: Intel Iris 07:45:36 INFO - Type: GPU 07:45:36 INFO - Bus: Built-In 07:45:36 INFO - VRAM (Dynamic, Max): 1536 MB 07:45:36 INFO - Vendor: Intel (0x8086) 07:45:36 INFO - Device ID: 0x0a2e 07:45:36 INFO - Revision ID: 0x0009 07:45:36 INFO - Displays: 07:45:36 INFO - Display: 07:45:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:45:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:45:36 INFO - Display Serial Number: 1600x1200 60 07:45:36 INFO - Main Display: Yes 07:45:36 INFO - Mirror: Off 07:45:36 INFO - Online: Yes 07:45:36 INFO - Rotation: Supported 07:45:36 INFO - Return code: 0 07:45:36 INFO - Running post-action listener: _resource_record_post_action 07:45:36 INFO - [mozharness: 2017-03-31 14:45:36.303926Z] Finished run-tests step (success) 07:45:36 INFO - Running post-run listener: _resource_record_post_run 07:45:36 INFO - Total resource usage - Wall time: 1200s; CPU: 55.0%; Read bytes: 90112; Write bytes: 513350656; Read time: 4; Write time: 1620 07:45:36 INFO - TinderboxPrint: CPU usage
54.6% 07:45:36 INFO - TinderboxPrint: I/O read bytes / time
90,112 / 4 07:45:36 INFO - TinderboxPrint: I/O write bytes / time
513,350,656 / 1,620 07:45:36 INFO - TinderboxPrint: CPU idle
2,179.8 (45.4%) 07:45:36 INFO - TinderboxPrint: CPU system
967.3 (20.1%) 07:45:36 INFO - TinderboxPrint: CPU user
1,654.5 (34.5%) 07:45:36 INFO - TinderboxPrint: Swap in / out
207,560,704 / 0 07:45:36 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 199827968; Write bytes: 199151616; Read time: 15484; Write time: 412 07:45:36 INFO - run-tests - Wall time: 1180s; CPU: 55.0%; Read bytes: 90112; Write bytes: 304286720; Read time: 4; Write time: 1172 07:45:36 INFO - Running post-run listener: _upload_blobber_files 07:45:36 INFO - Blob upload gear active. 07:45:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:45:36 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 07:45:36 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'] 07:45:36 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 07:45:37 INFO - (blobuploader) - INFO - Open directory for files ... 07:45:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:45:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:45:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:45:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:45:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:45:37 INFO - (blobuploader) - INFO - Done attempting. 07:45:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:45:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:45:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:45:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:45:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:45:39 INFO - (blobuploader) - INFO - Done attempting. 07:45:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:45:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:45:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:45:40 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:45:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:45:40 INFO - (blobuploader) - INFO - Done attempting. 07:45:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:45:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:45:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:45:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:45:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:45:42 INFO - (blobuploader) - INFO - Done attempting. 07:45:42 INFO - (blobuploader) - INFO - Iteration through files over. 07:45:42 INFO - Return code: 0 07:45:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:45:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:45:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/72860b69fe92f0846d99120e58a399e58140e184c8290eb4563d24a1166e387367f8ebc09f54aa3c307bf97c49e0b7a7d9e478fcb09b3ddbe5cefb0f3f07cf5c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/91ffe4e746b492da948a5463622f83eb8e86944ca29d47bc5bfab7cf1387d82e3a862126dc4ff412ba90d3b52a7e3b9ecb991499e63a2075a4e9dc4d1eaaeb52", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/005473574172cdd988965aca1c8a6d8906ce066cae3e4fd658a6ca28968a81b2dab2e47ac3868bdab71e76c707d398002a11572de37ef101e6b9a87a5d23d3f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/825a75e7f7b416c69ac52fdd44866c910a2b983d53246bf1e3847f2efc3e654172d41b47fcde45d242f032c6e254b26cd223f8e0d74c035f223ef5244c576190"} 07:45:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:45:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:45:42 INFO - Contents: 07:45:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/72860b69fe92f0846d99120e58a399e58140e184c8290eb4563d24a1166e387367f8ebc09f54aa3c307bf97c49e0b7a7d9e478fcb09b3ddbe5cefb0f3f07cf5c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/91ffe4e746b492da948a5463622f83eb8e86944ca29d47bc5bfab7cf1387d82e3a862126dc4ff412ba90d3b52a7e3b9ecb991499e63a2075a4e9dc4d1eaaeb52", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/005473574172cdd988965aca1c8a6d8906ce066cae3e4fd658a6ca28968a81b2dab2e47ac3868bdab71e76c707d398002a11572de37ef101e6b9a87a5d23d3f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/825a75e7f7b416c69ac52fdd44866c910a2b983d53246bf1e3847f2efc3e654172d41b47fcde45d242f032c6e254b26cd223f8e0d74c035f223ef5244c576190"} 07:45:42 INFO - Running post-run listener: copy_logs_to_upload_dir 07:45:42 INFO - Copying logs to upload dir... 07:45:42 INFO - mkdir: /builds/slave/test/build/upload/logs 07:45:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1281.026016 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2017-03-31 07:45:42.721716) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-31 07:45:42.725111) ========= 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.bWtNnGumta/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.bsyzc7rrLI/Listeners TMPDIR=/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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/72860b69fe92f0846d99120e58a399e58140e184c8290eb4563d24a1166e387367f8ebc09f54aa3c307bf97c49e0b7a7d9e478fcb09b3ddbe5cefb0f3f07cf5c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/91ffe4e746b492da948a5463622f83eb8e86944ca29d47bc5bfab7cf1387d82e3a862126dc4ff412ba90d3b52a7e3b9ecb991499e63a2075a4e9dc4d1eaaeb52", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/005473574172cdd988965aca1c8a6d8906ce066cae3e4fd658a6ca28968a81b2dab2e47ac3868bdab71e76c707d398002a11572de37ef101e6b9a87a5d23d3f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/825a75e7f7b416c69ac52fdd44866c910a2b983d53246bf1e3847f2efc3e654172d41b47fcde45d242f032c6e254b26cd223f8e0d74c035f223ef5244c576190"} build_url:https://queue.taskcluster.net/v1/task/c2Nx2sB7TAqKeuwRcVZQiw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011204 build_url: 'https://queue.taskcluster.net/v1/task/c2Nx2sB7TAqKeuwRcVZQiw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/72860b69fe92f0846d99120e58a399e58140e184c8290eb4563d24a1166e387367f8ebc09f54aa3c307bf97c49e0b7a7d9e478fcb09b3ddbe5cefb0f3f07cf5c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/91ffe4e746b492da948a5463622f83eb8e86944ca29d47bc5bfab7cf1387d82e3a862126dc4ff412ba90d3b52a7e3b9ecb991499e63a2075a4e9dc4d1eaaeb52", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/005473574172cdd988965aca1c8a6d8906ce066cae3e4fd658a6ca28968a81b2dab2e47ac3868bdab71e76c707d398002a11572de37ef101e6b9a87a5d23d3f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/825a75e7f7b416c69ac52fdd44866c910a2b983d53246bf1e3847f2efc3e654172d41b47fcde45d242f032c6e254b26cd223f8e0d74c035f223ef5244c576190"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-31 07:45:42.759619) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 07:45:42.759974) ========= 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.bWtNnGumta/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.bsyzc7rrLI/Listeners TMPDIR=/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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.005438 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 07:45:42.808911) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-31 07:45:42.809356) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-31 07:45:42.809793) ========= ========= Total master_lag: 0.18 =========