builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0239 starttime: 1493994825.7 results: success (0) buildid: 20170505054525 builduid: e4c79c7dbfe74047b1476565fdcd92d4 revision: 3e76a9b4f4fd14595a4919b6b839549911efdc3d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-05 07:33:45.705025) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-05 07:33:45.709817) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-05 07:33:45.710265) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-05 07:33:45.745177) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 07:33:45.745594) ========= 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.BCpef8XTb0/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.KB1qiY2iNa/Listeners TMPDIR=/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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-05-05 07:33:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 121M=0s 2017-05-05 07:33:46 (121 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.096088 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 07:33:45.875945) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 07:33:45.876259) ========= 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.BCpef8XTb0/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.KB1qiY2iNa/Listeners TMPDIR=/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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.038268 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 07:33:45.949743) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-05-05 07:33:45.950192) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 3e76a9b4f4fd14595a4919b6b839549911efdc3d --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-beta --rev 3e76a9b4f4fd14595a4919b6b839549911efdc3d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.BCpef8XTb0/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.KB1qiY2iNa/Listeners TMPDIR=/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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-05-05 07:33:46,584 truncating revision to first 12 chars 2017-05-05 07:33:46,584 Setting DEBUG logging. 2017-05-05 07:33:46,584 attempt 1/10 2017-05-05 07:33:46,584 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/3e76a9b4f4fd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-05 07:33:47,584 unpacking tar archive at: mozilla-beta-3e76a9b4f4fd/testing/mozharness/ program finished with exit code 0 elapsedTime=2.243772 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-05-05 07:33:48.231827) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-05 07:33:48.232152) ========= script_repo_revision: 3e76a9b4f4fd14595a4919b6b839549911efdc3d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-05 07:33:48.233179) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-05 07:33:48.233459) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-05 07:33:48.263183) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 22 mins, 38 secs) (at 2017-05-05 07:33:48.263596) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.BCpef8XTb0/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.KB1qiY2iNa/Listeners TMPDIR=/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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:33:49 INFO - MultiFileLogger online at 20170505 07:33:49 in /builds/slave/test 07:33:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 07:33:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:33:49 INFO - {'append_to_log': False, 07:33:49 INFO - 'base_work_dir': '/builds/slave/test', 07:33:49 INFO - 'blob_upload_branch': 'Mozilla-Beta', 07:33:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:33:49 INFO - 'branch': 'Mozilla-Beta', 07:33:49 INFO - 'buildbot_json_path': 'buildprops.json', 07:33:49 INFO - 'config_files': ('talos/mac_config.py',), 07:33:49 INFO - 'default_actions': ('clobber', 07:33:49 INFO - 'read-buildbot-config', 07:33:49 INFO - 'download-and-extract', 07:33:49 INFO - 'populate-webroot', 07:33:49 INFO - 'create-virtualenv', 07:33:49 INFO - 'install', 07:33:49 INFO - 'run-tests'), 07:33:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:33:49 INFO - 'download_minidump_stackwalk': True, 07:33:49 INFO - 'download_symbols': 'ondemand', 07:33:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:33:49 INFO - 'tooltool.py': '/tools/tooltool.py', 07:33:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:33:49 INFO - '/tools/misc-python/virtualenv.py')}, 07:33:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:33:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:33:49 INFO - 'gecko_profile': False, 07:33:49 INFO - 'gecko_profile_interval': 0, 07:33:49 INFO - 'installer_path': 'installer.exe', 07:33:49 INFO - 'log_level': 'info', 07:33:49 INFO - 'log_name': 'talos', 07:33:49 INFO - 'log_to_console': True, 07:33:49 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:33:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:33:49 INFO - 'opt_config_files': (), 07:33:49 INFO - 'pip_index': False, 07:33:49 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:33:49 INFO - 'cmd': ('bash', 07:33:49 INFO - '-c', 07:33:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:33:49 INFO - 'enabled': True, 07:33:49 INFO - 'halt_on_failure': False, 07:33:49 INFO - 'name': 'check_screen_resolution'},), 07:33:49 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:33:49 INFO - 'cmd': ('bash', 07:33:49 INFO - '-c', 07:33:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:33:49 INFO - 'enabled': True, 07:33:49 INFO - 'halt_on_failure': False, 07:33:49 INFO - 'name': 'check_screen_resolution'},), 07:33:49 INFO - 'run_cmd_checks_enabled': True, 07:33:49 INFO - 'suite': 'dromaeojs-e10s', 07:33:49 INFO - 'system_bits': '32', 07:33:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:33:49 INFO - 'title': 't-yosemite-r7-0239', 07:33:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:33:49 INFO - 'use_talos_json': True, 07:33:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:33:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:33:49 INFO - 'work_dir': 'build'} 07:33:49 INFO - [mozharness: 2017-05-05 14:33:49.075184Z] Running clobber step. 07:33:49 INFO - Running pre-action listener: _resource_record_pre_action 07:33:49 INFO - Running main action method: clobber 07:33:49 INFO - rmtree: /builds/slave/test/build 07:33:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:33:53 INFO - Running post-action listener: _resource_record_post_action 07:33:53 INFO - [mozharness: 2017-05-05 14:33:53.103107Z] Finished clobber step (success) 07:33:53 INFO - [mozharness: 2017-05-05 14:33:53.103571Z] Running read-buildbot-config step. 07:33:53 INFO - Running pre-action listener: _resource_record_pre_action 07:33:53 INFO - Running main action method: read_buildbot_config 07:33:53 INFO - Using buildbot properties: 07:33:53 INFO - { 07:33:53 INFO - "project": "", 07:33:53 INFO - "product": "firefox", 07:33:53 INFO - "script_repo_revision": "production", 07:33:53 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 07:33:53 INFO - "repository": "", 07:33:53 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 07:33:53 INFO - "buildid": "20170505054525", 07:33:53 INFO - "pgo_build": "False", 07:33:53 INFO - "basedir": "/builds/slave/test", 07:33:53 INFO - "buildnumber": 1, 07:33:53 INFO - "slavename": "t-yosemite-r7-0239", 07:33:53 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 07:33:53 INFO - "platform": "yosemite_r7", 07:33:53 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 07:33:53 INFO - "branch": "mozilla-beta", 07:33:53 INFO - "repo_path": "releases/mozilla-beta", 07:33:53 INFO - "revision": "3e76a9b4f4fd14595a4919b6b839549911efdc3d", 07:33:53 INFO - "stage_platform": "macosx64", 07:33:53 INFO - "builduid": "e4c79c7dbfe74047b1476565fdcd92d4", 07:33:53 INFO - "slavebuilddir": "test" 07:33:53 INFO - } 07:33:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/d72vUU-VRIeapEWp6qrLlg/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 07:33:53 INFO - Running post-action listener: _resource_record_post_action 07:33:53 INFO - [mozharness: 2017-05-05 14:33:53.112287Z] Finished read-buildbot-config step (success) 07:33:53 INFO - [mozharness: 2017-05-05 14:33:53.112485Z] Running download-and-extract step. 07:33:53 INFO - Running pre-action listener: _resource_record_pre_action 07:33:53 INFO - Running main action method: download_and_extract 07:33:53 INFO - mkdir: /builds/slave/test/build/tests 07:33:53 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:33:53 INFO - trying https://queue.taskcluster.net/v1/task/d72vUU-VRIeapEWp6qrLlg/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 07:33:53 INFO - Downloading https://queue.taskcluster.net/v1/task/d72vUU-VRIeapEWp6qrLlg/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 07:33:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d72vUU-VRIeapEWp6qrLlg/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json'}, attempt #1 07:33:54 INFO - Downloaded 1287 bytes. 07:33:54 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 07:33:54 INFO - Using the following test package requirements: 07:33:54 INFO - {u'awsy': [u'firefox-54.0.en-US.mac.common.tests.zip', 07:33:54 INFO - u'firefox-54.0.en-US.mac.awsy.tests.zip'], 07:33:54 INFO - u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 07:33:54 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 07:33:54 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 07:33:54 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 07:33:54 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 07:33:54 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 07:33:54 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 07:33:54 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 07:33:54 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 07:33:54 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 07:33:54 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 07:33:54 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 07:33:54 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 07:33:54 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 07:33:54 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 07:33:54 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 07:33:54 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 07:33:54 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 07:33:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d72vUU-VRIeapEWp6qrLlg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 07:33:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d72vUU-VRIeapEWp6qrLlg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 07:33:54 INFO - Fetch https://queue.taskcluster.net/v1/task/d72vUU-VRIeapEWp6qrLlg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 07:33:56 INFO - Expected file size: 51223907 07:33:56 INFO - Obtained file size: 51223907 07:34:23 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip', u'firefox-54.0.en-US.mac.talos.tests.zip'] for test suite category: talos 07:34:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d72vUU-VRIeapEWp6qrLlg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 07:34:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d72vUU-VRIeapEWp6qrLlg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 07:34:23 INFO - Fetch https://queue.taskcluster.net/v1/task/d72vUU-VRIeapEWp6qrLlg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 07:34:26 INFO - Expected file size: 51223907 07:34:26 INFO - Obtained file size: 51223907 07:34:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d72vUU-VRIeapEWp6qrLlg/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 07:34:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d72vUU-VRIeapEWp6qrLlg/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 07:34:52 INFO - Fetch https://queue.taskcluster.net/v1/task/d72vUU-VRIeapEWp6qrLlg/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 07:34:54 INFO - Expected file size: 14404449 07:34:54 INFO - Obtained file size: 14404449 07:34:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:34:54 INFO - trying https://queue.taskcluster.net/v1/task/d72vUU-VRIeapEWp6qrLlg/artifacts/public/build/firefox-54.0.en-US.mac.dmg 07:34:54 INFO - Downloading https://queue.taskcluster.net/v1/task/d72vUU-VRIeapEWp6qrLlg/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 07:34:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d72vUU-VRIeapEWp6qrLlg/artifacts/public/build/firefox-54.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg'}, attempt #1 07:34:58 INFO - Downloaded 59558233 bytes. 07:34:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d72vUU-VRIeapEWp6qrLlg/artifacts/public/build/firefox-54.0.en-US.mac.dmg 07:34:58 INFO - mkdir: /builds/slave/test/properties 07:34:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:34:58 INFO - Writing to file /builds/slave/test/properties/build_url 07:34:58 INFO - Contents: 07:34:58 INFO - build_url:https://queue.taskcluster.net/v1/task/d72vUU-VRIeapEWp6qrLlg/artifacts/public/build/firefox-54.0.en-US.mac.dmg 07:34:59 INFO - Running post-action listener: _resource_record_post_action 07:34:59 INFO - Running post-action listener: set_extra_try_arguments 07:34:59 INFO - [mozharness: 2017-05-05 14:34:59.163471Z] Finished download-and-extract step (success) 07:34:59 INFO - [mozharness: 2017-05-05 14:34:59.163642Z] Running populate-webroot step. 07:34:59 INFO - Running pre-action listener: _resource_record_pre_action 07:34:59 INFO - Running main action method: populate_webroot 07:34:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:34:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:34:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:34:59 INFO - '--tppagecycles', 07:34:59 INFO - '7'], 07:34:59 INFO - 'tests': ['tsvgm']}}, 07:34:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:34:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:34:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:34:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:34:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:34:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:34:59 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:34:59 INFO - 'talos_options': ['--disable-e10s'], 07:34:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:34:59 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:34:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:34:59 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:34:59 INFO - 'talos_options': ['--disable-e10s'], 07:34:59 INFO - 'tests': ['damp', 'tps']}, 07:34:59 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:34:59 INFO - 'tests': ['damp', 'tps']}, 07:34:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:34:59 INFO - 'tests': ['dromaeo_dom']}, 07:34:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:34:59 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:34:59 INFO - 'tests': ['basic_compositor_video']}, 07:34:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:34:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:34:59 INFO - 'tests': ['a11yr', 07:34:59 INFO - 'ts_paint', 07:34:59 INFO - 'tpaint', 07:34:59 INFO - 'sessionrestore', 07:34:59 INFO - 'sessionrestore_no_auto_restore', 07:34:59 INFO - 'tabpaint']}, 07:34:59 INFO - 'other-e10s': {'tests': ['a11yr', 07:34:59 INFO - 'ts_paint', 07:34:59 INFO - 'tpaint', 07:34:59 INFO - 'sessionrestore', 07:34:59 INFO - 'sessionrestore_no_auto_restore', 07:34:59 INFO - 'tabpaint']}, 07:34:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:34:59 INFO - 'ts_paint', 07:34:59 INFO - 'tpaint', 07:34:59 INFO - 'sessionrestore', 07:34:59 INFO - 'sessionrestore_no_auto_restore', 07:34:59 INFO - 'tabpaint']}, 07:34:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:34:59 INFO - 'ts_paint', 07:34:59 INFO - 'tpaint', 07:34:59 INFO - 'sessionrestore', 07:34:59 INFO - 'sessionrestore_no_auto_restore', 07:34:59 INFO - 'tabpaint']}, 07:34:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:34:59 INFO - 'tests': ['a11yr', 07:34:59 INFO - 'ts_paint', 07:34:59 INFO - 'tpaint', 07:34:59 INFO - 'sessionrestore', 07:34:59 INFO - 'sessionrestore_no_auto_restore', 07:34:59 INFO - 'tabpaint']}, 07:34:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:34:59 INFO - 'tests': ['a11yr', 07:34:59 INFO - 'ts_paint', 07:34:59 INFO - 'tpaint', 07:34:59 INFO - 'sessionrestore', 07:34:59 INFO - 'sessionrestore_no_auto_restore', 07:34:59 INFO - 'tabpaint']}, 07:34:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:34:59 INFO - 'tests': ['tsvgx', 07:34:59 INFO - 'tsvgr_opacity', 07:34:59 INFO - 'tart', 07:34:59 INFO - 'tscrollx', 07:34:59 INFO - 'cart', 07:34:59 INFO - 'tsvg_static']}, 07:34:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:34:59 INFO - 'tsvgr_opacity', 07:34:59 INFO - 'tart', 07:34:59 INFO - 'tscrollx', 07:34:59 INFO - 'cart', 07:34:59 INFO - 'tsvg_static']}, 07:34:59 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:34:59 INFO - 'talos_options': ['--disable-e10s'], 07:34:59 INFO - 'tests': ['tp5o']}, 07:34:59 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:34:59 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:34:59 INFO - 'talos_options': ['--disable-e10s', 07:34:59 INFO - '--xperf_path', 07:34:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:34:59 INFO - 'tests': ['tp5n']}, 07:34:59 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:34:59 INFO - 'talos_options': ['--xperf_path', 07:34:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:34:59 INFO - 'tests': ['tp5n']}}, 07:34:59 INFO - 'talos.zip': {'path': '', 07:34:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:34:59 INFO - Running post-action listener: _resource_record_post_action 07:34:59 INFO - [mozharness: 2017-05-05 14:34:59.188164Z] Finished populate-webroot step (success) 07:34:59 INFO - [mozharness: 2017-05-05 14:34:59.188314Z] Running create-virtualenv step. 07:34:59 INFO - Running pre-action listener: _resource_record_pre_action 07:34:59 INFO - Running main action method: create_virtualenv 07:34:59 INFO - Creating virtualenv /builds/slave/test/build/venv 07:34:59 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:34:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:34:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:34:59 INFO - Using real prefix '/tools/python27' 07:34:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:35:00 INFO - Installing distribute.............................................................................................................................................................................................done. 07:35:05 INFO - Installing pip.................done. 07:35:05 INFO - Return code: 0 07:35:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:35:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:35:06 INFO - Reading from file tmpfile_stdout 07:35:06 INFO - Output received: 07:35:06 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:35:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:35:06 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:35:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:06 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:35:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:06 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 0x1070b9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070bc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f800ac734f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e97d30>, '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 0x106dbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e8cbe8>, '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.BCpef8XTb0/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.KB1qiY2iNa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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:35:06 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:35:06 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:35:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BCpef8XTb0/Render', 07:35:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:06 INFO - 'HOME': '/Users/cltbld', 07:35:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:06 INFO - 'LOGNAME': 'cltbld', 07:35:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:06 INFO - 'MOZ_NO_REMOTE': '1', 07:35:06 INFO - 'NO_EM_RESTART': '1', 07:35:06 INFO - 'PAGER': '/bin/cat', 07:35:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:06 INFO - 'PWD': '/builds/slave/test', 07:35:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:06 INFO - 'SHELL': '/bin/bash', 07:35:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KB1qiY2iNa/Listeners', 07:35:06 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 07:35:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:06 INFO - 'USER': 'cltbld', 07:35:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:06 INFO - 'XPC_FLAGS': '0x0', 07:35:06 INFO - 'XPC_SERVICE_NAME': '0', 07:35:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:06 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:35:06 INFO - Cleaning up... 07:35:06 INFO - Return code: 0 07:35:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:35:06 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:35:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:06 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:35:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:06 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 0x1070b9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070bc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f800ac734f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e97d30>, '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 0x106dbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e8cbe8>, '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.BCpef8XTb0/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.KB1qiY2iNa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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:35:06 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:35:06 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:35:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BCpef8XTb0/Render', 07:35:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:06 INFO - 'HOME': '/Users/cltbld', 07:35:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:06 INFO - 'LOGNAME': 'cltbld', 07:35:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:06 INFO - 'MOZ_NO_REMOTE': '1', 07:35:06 INFO - 'NO_EM_RESTART': '1', 07:35:06 INFO - 'PAGER': '/bin/cat', 07:35:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:06 INFO - 'PWD': '/builds/slave/test', 07:35:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:06 INFO - 'SHELL': '/bin/bash', 07:35:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KB1qiY2iNa/Listeners', 07:35:06 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 07:35:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:06 INFO - 'USER': 'cltbld', 07:35:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:06 INFO - 'XPC_FLAGS': '0x0', 07:35:06 INFO - 'XPC_SERVICE_NAME': '0', 07:35:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:06 INFO - Downloading/unpacking psutil>=3.1.1 07:35:06 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:35:06 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:35:06 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:35:06 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:35:06 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:35:06 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:35:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:35:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:35:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:35:10 INFO - Installing collected packages: psutil 07:35:10 INFO - Running setup.py install for psutil 07:35:10 INFO - building 'psutil._psutil_osx' extension 07:35:10 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:35: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:35: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:35: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:35:12 INFO - building 'psutil._psutil_posix' extension 07:35:12 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:35:12 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:35:12 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:35:12 INFO - ^ 07:35:12 INFO - 1 warning generated. 07:35:12 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:35:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:35:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:35:12 INFO - Successfully installed psutil 07:35:12 INFO - Cleaning up... 07:35:12 INFO - Return code: 0 07:35:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:35:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35: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 0x1070b9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070bc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f800ac734f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e97d30>, '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 0x106dbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e8cbe8>, '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.BCpef8XTb0/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.KB1qiY2iNa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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:35: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:35: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:35:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BCpef8XTb0/Render', 07:35:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:12 INFO - 'HOME': '/Users/cltbld', 07:35:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:12 INFO - 'LOGNAME': 'cltbld', 07:35:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:12 INFO - 'MOZ_NO_REMOTE': '1', 07:35:12 INFO - 'NO_EM_RESTART': '1', 07:35:12 INFO - 'PAGER': '/bin/cat', 07:35:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:12 INFO - 'PWD': '/builds/slave/test', 07:35:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:12 INFO - 'SHELL': '/bin/bash', 07:35:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KB1qiY2iNa/Listeners', 07:35:12 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 07:35:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:12 INFO - 'USER': 'cltbld', 07:35:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:12 INFO - 'XPC_FLAGS': '0x0', 07:35:12 INFO - 'XPC_SERVICE_NAME': '0', 07:35:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:35: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:35: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:35: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:35: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:35: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:35: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:35:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:35:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:35: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:35:15 INFO - Installing collected packages: mozsystemmonitor 07:35:15 INFO - Running setup.py install for mozsystemmonitor 07:35:15 INFO - Successfully installed mozsystemmonitor 07:35:15 INFO - Cleaning up... 07:35:15 INFO - Return code: 0 07:35:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:35: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:35:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35: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:35:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35: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 0x1070b9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070bc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f800ac734f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e97d30>, '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 0x106dbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e8cbe8>, '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.BCpef8XTb0/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.KB1qiY2iNa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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:35: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:35: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:35:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BCpef8XTb0/Render', 07:35:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:15 INFO - 'HOME': '/Users/cltbld', 07:35:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:15 INFO - 'LOGNAME': 'cltbld', 07:35:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:15 INFO - 'MOZ_NO_REMOTE': '1', 07:35:15 INFO - 'NO_EM_RESTART': '1', 07:35:15 INFO - 'PAGER': '/bin/cat', 07:35:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:15 INFO - 'PWD': '/builds/slave/test', 07:35:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:15 INFO - 'SHELL': '/bin/bash', 07:35:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KB1qiY2iNa/Listeners', 07:35:15 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 07:35:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:15 INFO - 'USER': 'cltbld', 07:35:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:15 INFO - 'XPC_FLAGS': '0x0', 07:35:15 INFO - 'XPC_SERVICE_NAME': '0', 07:35:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:16 INFO - Downloading/unpacking jsonschema==2.5.1 07:35:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:35:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:35:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:35:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:35:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:35:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:35:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:35:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:35: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:35: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:35: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:35: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:35: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:35: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:35:18 INFO - Downloading functools32-3.2.3-2.tar.gz 07:35:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:35:18 INFO - warning: no files found matching '*.txt' 07:35:18 INFO - no previously-included directories found matching 'build' 07:35:18 INFO - no previously-included directories found matching 'dist' 07:35:18 INFO - no previously-included directories found matching '.git*' 07:35:18 INFO - Installing collected packages: jsonschema, functools32 07:35:18 INFO - Running setup.py install for functools32 07:35:19 INFO - warning: no files found matching '*.txt' 07:35:19 INFO - no previously-included directories found matching 'build' 07:35:19 INFO - no previously-included directories found matching 'dist' 07:35:19 INFO - no previously-included directories found matching '.git*' 07:35:19 INFO - Successfully installed jsonschema functools32 07:35:19 INFO - Cleaning up... 07:35:19 INFO - Return code: 0 07:35:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:35: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:35:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35: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:35:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35: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 0x1070b9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070bc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f800ac734f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e97d30>, '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 0x106dbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e8cbe8>, '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.BCpef8XTb0/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.KB1qiY2iNa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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:35: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:35: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:35:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BCpef8XTb0/Render', 07:35:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:19 INFO - 'HOME': '/Users/cltbld', 07:35:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:19 INFO - 'LOGNAME': 'cltbld', 07:35:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:19 INFO - 'MOZ_NO_REMOTE': '1', 07:35:19 INFO - 'NO_EM_RESTART': '1', 07:35:19 INFO - 'PAGER': '/bin/cat', 07:35:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:19 INFO - 'PWD': '/builds/slave/test', 07:35:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:19 INFO - 'SHELL': '/bin/bash', 07:35:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KB1qiY2iNa/Listeners', 07:35:19 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 07:35:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:19 INFO - 'USER': 'cltbld', 07:35:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:19 INFO - 'XPC_FLAGS': '0x0', 07:35:19 INFO - 'XPC_SERVICE_NAME': '0', 07:35:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:35:19 INFO - Cleaning up... 07:35:19 INFO - Return code: 0 07:35:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:35: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:35:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35: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:35:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35: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 0x1070b9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070bc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f800ac734f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e97d30>, '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 0x106dbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e8cbe8>, '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.BCpef8XTb0/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.KB1qiY2iNa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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:35: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:35: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:35:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BCpef8XTb0/Render', 07:35:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:19 INFO - 'HOME': '/Users/cltbld', 07:35:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:19 INFO - 'LOGNAME': 'cltbld', 07:35:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:19 INFO - 'MOZ_NO_REMOTE': '1', 07:35:19 INFO - 'NO_EM_RESTART': '1', 07:35:19 INFO - 'PAGER': '/bin/cat', 07:35:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:19 INFO - 'PWD': '/builds/slave/test', 07:35:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:19 INFO - 'SHELL': '/bin/bash', 07:35:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KB1qiY2iNa/Listeners', 07:35:19 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 07:35:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:19 INFO - 'USER': 'cltbld', 07:35:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:19 INFO - 'XPC_FLAGS': '0x0', 07:35:19 INFO - 'XPC_SERVICE_NAME': '0', 07:35:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:20 INFO - Downloading/unpacking blobuploader==1.2.4 07:35:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:35:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:35:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:35:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:35:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:35:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:35:22 INFO - Downloading blobuploader-1.2.4.tar.gz 07:35:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:35:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:35: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:35: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:35: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:35: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:35: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:35: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:35:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:35:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:35: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:35: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:35: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:35: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:35: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:35: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:35:23 INFO - Downloading docopt-0.6.1.tar.gz 07:35:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:35:24 INFO - Installing collected packages: blobuploader, requests, docopt 07:35:24 INFO - Running setup.py install for blobuploader 07:35:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:35:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:35:24 INFO - Running setup.py install for requests 07:35:25 INFO - Running setup.py install for docopt 07:35:25 INFO - Successfully installed blobuploader requests docopt 07:35:25 INFO - Cleaning up... 07:35:25 INFO - Return code: 0 07:35:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:35:25 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:35:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:25 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:35:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:25 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 0x1070b9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070bc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f800ac734f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e97d30>, '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 0x106dbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e8cbe8>, '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.BCpef8XTb0/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.KB1qiY2iNa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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:35:25 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:35:25 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:35:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BCpef8XTb0/Render', 07:35:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:25 INFO - 'HOME': '/Users/cltbld', 07:35:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:25 INFO - 'LOGNAME': 'cltbld', 07:35:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:25 INFO - 'MOZ_NO_REMOTE': '1', 07:35:25 INFO - 'NO_EM_RESTART': '1', 07:35:25 INFO - 'PAGER': '/bin/cat', 07:35:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:25 INFO - 'PWD': '/builds/slave/test', 07:35:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:25 INFO - 'SHELL': '/bin/bash', 07:35:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KB1qiY2iNa/Listeners', 07:35:25 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 07:35:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:25 INFO - 'USER': 'cltbld', 07:35:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:25 INFO - 'XPC_FLAGS': '0x0', 07:35:25 INFO - 'XPC_SERVICE_NAME': '0', 07:35:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:35:26 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-K4fZlS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:35:26 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-zwNOnR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:35:26 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-8NNC0_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:35:26 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-U25QJr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:35:26 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-6bkbln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:35:27 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-gbV20O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:35:27 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-ATESNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:35:27 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-r7NLaM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:35:27 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-LfBgsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:35:27 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-6V2nGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:35:27 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-C9bwvM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:35:28 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-WnnvwU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:35:28 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-9FzVys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:35:28 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-1OL70u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:35:28 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-lOrHLc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:35:28 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-4zOxxt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:35:29 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-AWSArE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:35:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:35:29 INFO - Running setup.py install for manifestparser 07:35:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:35:29 INFO - Running setup.py install for mozcrash 07:35:29 INFO - Running setup.py install for mozdebug 07:35:29 INFO - Running setup.py install for mozdevice 07:35:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:35:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:35:30 INFO - Running setup.py install for mozfile 07:35:30 INFO - Running setup.py install for mozhttpd 07:35:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:35:30 INFO - Running setup.py install for mozinfo 07:35:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:35:30 INFO - Running setup.py install for mozInstall 07:35:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:35:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:35:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:35:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:35:31 INFO - Running setup.py install for mozleak 07:35:31 INFO - Running setup.py install for mozlog 07:35:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:35:31 INFO - Running setup.py install for moznetwork 07:35:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:35:32 INFO - Running setup.py install for mozprocess 07:35:32 INFO - Running setup.py install for mozprofile 07:35:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:35:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:35:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:35:32 INFO - Running setup.py install for mozrunner 07:35:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:35:32 INFO - Running setup.py install for mozscreenshot 07:35:33 INFO - Running setup.py install for moztest 07:35:33 INFO - Running setup.py install for mozversion 07:35:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:35:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:35:33 INFO - Cleaning up... 07:35:33 INFO - Return code: 0 07:35:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:35:33 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:35:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:33 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:35:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:33 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 0x1070b9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070bc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f800ac734f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e97d30>, '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 0x106dbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e8cbe8>, '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.BCpef8XTb0/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.KB1qiY2iNa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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:35:33 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:35:33 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:35:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BCpef8XTb0/Render', 07:35:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:33 INFO - 'HOME': '/Users/cltbld', 07:35:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:33 INFO - 'LOGNAME': 'cltbld', 07:35:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:33 INFO - 'MOZ_NO_REMOTE': '1', 07:35:33 INFO - 'NO_EM_RESTART': '1', 07:35:33 INFO - 'PAGER': '/bin/cat', 07:35:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:33 INFO - 'PWD': '/builds/slave/test', 07:35:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:33 INFO - 'SHELL': '/bin/bash', 07:35:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KB1qiY2iNa/Listeners', 07:35:33 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 07:35:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:33 INFO - 'USER': 'cltbld', 07:35:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:33 INFO - 'XPC_FLAGS': '0x0', 07:35:33 INFO - 'XPC_SERVICE_NAME': '0', 07:35:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:35:34 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-BWSLAl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:35:34 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:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:35:34 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-fvQ6_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:35:34 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:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:35:34 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-rKwhAP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:35:34 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:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:35:34 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-9ARFrr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:35:34 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:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:35:34 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-lpGwKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:35:35 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:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:35:35 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-myrmmx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:35:35 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:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:35:35 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-83Mjlz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:35:35 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:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:35:35 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-3yUDVd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:35:35 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:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:35:35 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-9mCfUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:35:35 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:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:35:35 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-jVasvO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:35:35 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:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:35:35 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-bZAnfO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:35:36 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:35:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:35:36 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-9oHEnj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:35:36 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:35:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:35:36 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-udlwkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:35:36 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:35:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:35:36 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-WjHEQG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:35:36 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:35:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:35:36 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-gWOj9e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:35:36 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:35:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:35:36 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-ig2wAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:35:37 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:35:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:35:37 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-Ex2eY6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:35:37 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:35:37 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:35:37 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:35:37 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:35:37 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:35:37 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:35:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:35:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:35:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:35:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:35:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:35:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:35:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:35:39 INFO - Downloading blessings-1.6.tar.gz 07:35:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:35:40 INFO - Installing collected packages: blessings 07:35:40 INFO - Running setup.py install for blessings 07:35:40 INFO - Successfully installed blessings 07:35:40 INFO - Cleaning up... 07:35:40 INFO - Return code: 0 07:35:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:35:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:35:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:35:40 INFO - Reading from file tmpfile_stdout 07:35:40 INFO - Current package versions: 07:35:40 INFO - blessings == 1.6 07:35:40 INFO - blobuploader == 1.2.4 07:35:40 INFO - docopt == 0.6.1 07:35:40 INFO - functools32 == 3.2.3-2 07:35:40 INFO - jsonschema == 2.5.1 07:35:40 INFO - manifestparser == 1.1 07:35:40 INFO - mozInstall == 1.12 07:35:40 INFO - mozcrash == 1.0 07:35:40 INFO - mozdebug == 0.1 07:35:40 INFO - mozdevice == 0.49 07:35:40 INFO - mozfile == 1.2 07:35:40 INFO - mozhttpd == 0.7 07:35:40 INFO - mozinfo == 0.9 07:35:40 INFO - mozleak == 0.1 07:35:40 INFO - mozlog == 3.4 07:35:40 INFO - moznetwork == 0.27 07:35:40 INFO - mozprocess == 0.25 07:35:40 INFO - mozprofile == 0.28 07:35:40 INFO - mozrunner == 6.13 07:35:40 INFO - mozscreenshot == 0.1 07:35:40 INFO - mozsystemmonitor == 0.3 07:35:40 INFO - moztest == 0.8 07:35:40 INFO - mozversion == 1.4 07:35:40 INFO - psutil == 3.1.1 07:35:40 INFO - requests == 1.2.3 07:35:40 INFO - wsgiref == 0.1.2 07:35:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:35:40 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:35:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:40 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:35:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:40 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 0x1070b9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070bc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f800ac734f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e97d30>, '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 0x106dbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e8cbe8>, '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.BCpef8XTb0/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.KB1qiY2iNa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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:35:40 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:35:40 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:35:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BCpef8XTb0/Render', 07:35:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:40 INFO - 'HOME': '/Users/cltbld', 07:35:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:40 INFO - 'LOGNAME': 'cltbld', 07:35:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:40 INFO - 'MOZ_NO_REMOTE': '1', 07:35:40 INFO - 'NO_EM_RESTART': '1', 07:35:40 INFO - 'PAGER': '/bin/cat', 07:35:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:40 INFO - 'PWD': '/builds/slave/test', 07:35:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:40 INFO - 'SHELL': '/bin/bash', 07:35:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KB1qiY2iNa/Listeners', 07:35:40 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 07:35:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:40 INFO - 'USER': 'cltbld', 07:35:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:40 INFO - 'XPC_FLAGS': '0x0', 07:35:40 INFO - 'XPC_SERVICE_NAME': '0', 07:35:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:41 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:35:41 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:35:41 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:35:41 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:35:41 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:35:41 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:35:41 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:35:41 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:35:41 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:35:41 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:35:41 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:35:41 INFO - Cleaning up... 07:35:41 INFO - Return code: 0 07:35:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:35:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1070b9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070bc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f800ac734f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e97d30>, '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 0x106dbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e8cbe8>, '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.BCpef8XTb0/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.KB1qiY2iNa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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:35:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:35:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:35:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BCpef8XTb0/Render', 07:35:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:41 INFO - 'HOME': '/Users/cltbld', 07:35:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:41 INFO - 'LOGNAME': 'cltbld', 07:35:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:41 INFO - 'MOZ_NO_REMOTE': '1', 07:35:41 INFO - 'NO_EM_RESTART': '1', 07:35:41 INFO - 'PAGER': '/bin/cat', 07:35:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:41 INFO - 'PWD': '/builds/slave/test', 07:35:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:41 INFO - 'SHELL': '/bin/bash', 07:35:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KB1qiY2iNa/Listeners', 07:35:41 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 07:35:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:41 INFO - 'USER': 'cltbld', 07:35:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:41 INFO - 'XPC_FLAGS': '0x0', 07:35:41 INFO - 'XPC_SERVICE_NAME': '0', 07:35:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:35:41 INFO - Cleaning up... 07:35:41 INFO - Return code: 0 07:35:41 INFO - Running post-action listener: _resource_record_post_action 07:35:41 INFO - Running post-action listener: _start_resource_monitoring 07:35:41 INFO - Starting resource monitoring. 07:35:41 INFO - [mozharness: 2017-05-05 14:35:41.996912Z] Finished create-virtualenv step (success) 07:35:41 INFO - [mozharness: 2017-05-05 14:35:41.998620Z] Running install step. 07:35:41 INFO - Running pre-action listener: _resource_record_pre_action 07:35:41 INFO - Running main action method: install 07:35:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:35:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:35:42 INFO - Reading from file tmpfile_stdout 07:35:42 INFO - Detecting whether we're running mozinstall >=1.0... 07:35:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:35:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:35:42 INFO - Reading from file tmpfile_stdout 07:35:42 INFO - Output received: 07:35:42 INFO - Usage: mozinstall [options] installer 07:35:42 INFO - Options: 07:35:42 INFO - -h, --help show this help message and exit 07:35:42 INFO - -d DEST, --destination=DEST 07:35:42 INFO - Directory to install application into. [default: 07:35:42 INFO - "/builds/slave/test"] 07:35:42 INFO - --app=APP Application being installed. [default: firefox] 07:35:42 INFO - mkdir: /builds/slave/test/build/application 07:35:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:35:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0.en-US.mac.dmg --destination /builds/slave/test/build/application 07:36:08 INFO - Reading from file tmpfile_stdout 07:36:08 INFO - Output received: 07:36:08 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 07:36:08 INFO - Running post-action listener: _resource_record_post_action 07:36:08 INFO - [mozharness: 2017-05-05 14:36:08.344046Z] Finished install step (success) 07:36:08 INFO - [mozharness: 2017-05-05 14:36:08.344346Z] Running run-tests step. 07:36:08 INFO - Running pre-action listener: _resource_record_pre_action 07:36:08 INFO - Running main action method: run_tests 07:36:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:36:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:36:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:36:08 INFO - 2017-05-05 07:36:08.370 screenresolution[1650:7555] starting screenresolution argv=screenresolution get 07:36:08 INFO - 2017-05-05 07:36:08.375 screenresolution[1650:7555] Display 0: 1600x1200x32@60 07:36:08 INFO - 2017-05-05 07:36:08.386 screenresolution[1651:7557] starting screenresolution argv=screenresolution list 07:36:08 INFO - Available Modes on Display 0 07:36:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:36:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:36:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:36:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:36:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:36:08 INFO - Intel Iris: 07:36:08 INFO - Chipset Model: Intel Iris 07:36:08 INFO - Type: GPU 07:36:08 INFO - Bus: Built-In 07:36:08 INFO - VRAM (Dynamic, Max): 1536 MB 07:36:08 INFO - Vendor: Intel (0x8086) 07:36:08 INFO - Device ID: 0x0a2e 07:36:08 INFO - Revision ID: 0x0009 07:36:08 INFO - Displays: 07:36:08 INFO - Display: 07:36:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:36:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:36:08 INFO - Display Serial Number: 1600x1200 60 07:36:08 INFO - Main Display: Yes 07:36:08 INFO - Mirror: Off 07:36:08 INFO - Online: Yes 07:36:08 INFO - Rotation: Supported 07:36:08 INFO - Return code: 0 07:36:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:36:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:36:08 INFO - Python 2.7.3 07:36:08 INFO - Return code: 0 07:36:08 INFO - grabbing minidump binary from tooltool 07:36:08 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:36:08 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 0x106e97d30>, '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 0x106dbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e8cbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:36:08 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:36:08 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:36:08 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:36:08 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:36:08 INFO - Return code: 0 07:36:08 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:36:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:36:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:36:08 INFO - ENV: RUST_BACKTRACE is now 1 07:36:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:36:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:36:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d72vUU-VRIeapEWp6qrLlg/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0239', '--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:36:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/d72vUU-VRIeapEWp6qrLlg/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0239 --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:36:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BCpef8XTb0/Render', 07:36:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:08 INFO - 'HOME': '/Users/cltbld', 07:36:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:08 INFO - 'LOGNAME': 'cltbld', 07:36:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:36:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:36:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:08 INFO - 'MOZ_NO_REMOTE': '1', 07:36:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:36:08 INFO - 'NO_EM_RESTART': '1', 07:36:08 INFO - 'PAGER': '/bin/cat', 07:36:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:08 INFO - 'PWD': '/builds/slave/test', 07:36:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:36:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:08 INFO - 'RUST_BACKTRACE': '1', 07:36:08 INFO - 'SHELL': '/bin/bash', 07:36:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KB1qiY2iNa/Listeners', 07:36:08 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 07:36:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:08 INFO - 'USER': 'cltbld', 07:36:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:08 INFO - 'XPC_FLAGS': '0x0', 07:36:08 INFO - 'XPC_SERVICE_NAME': '0', 07:36:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d72vUU-VRIeapEWp6qrLlg/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0239', '--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:36:09 INFO - mozversion application_buildid: 20170505054525 07:36:09 INFO - mozversion application_changeset: 3e76a9b4f4fd14595a4919b6b839549911efdc3d 07:36:09 INFO - mozversion application_display_name: Firefox 07:36:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:36:09 INFO - mozversion application_name: Firefox 07:36:09 INFO - mozversion application_remotingname: firefox 07:36:09 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 07:36:09 INFO - mozversion application_vendor: Mozilla 07:36:09 INFO - mozversion application_version: 54.0 07:36:09 INFO - mozversion platform_buildid: 20170505054525 07:36:09 INFO - mozversion platform_changeset: 3e76a9b4f4fd14595a4919b6b839549911efdc3d 07:36:09 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 07:36:09 INFO - mozversion platform_version: 54.0 07:36:09 INFO - using testdate: 1493994969 07:36:09 INFO - actual date: 1493994969 07:36:09 INFO - starting webserver on 'localhost:49237' 07:36:09 INFO - SUITE-START | Running 2 tests 07:36:09 INFO - TEST-START | dromaeo_css 07:36:09 INFO - operating with platform_type : mac_ 07:36:09 INFO - Initialising browser for dromaeo_css test... 07:36:09 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/tmpeQHcZu/profile http://localhost:49237/getInfo.html) 07:36:14 INFO - PROCESS | 1661 | 2017-05-05 07:36:14.487 plugin-container[1666:7770] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d43, name = 'com.apple.tsm.portname' 07:36:14 INFO - PROCESS | 1661 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:36:14 INFO - PROCESS | 1661 | 2017-05-05 07:36:14.488 plugin-container[1666:7770] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4d17, name = 'com.apple.CFPasteboardClient' 07:36:14 INFO - PROCESS | 1661 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:36:14 INFO - PROCESS | 1661 | 2017-05-05 07:36:14.488 plugin-container[1666:7770] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:36:14 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 07:36:14 INFO - PROCESS | 1661 | colorDepth:24 07:36:14 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 07:36:14 INFO - PROCESS | 1661 | __metrics 07:36:14 ERROR - PROCESS | 1661 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3371: TypeError: this.tabs is undefined 07:36:15 INFO - TEST-INFO | 1661: exit 0 07:36:15 INFO - Browser initialized. 07:36:15 INFO - Running cycle 1/1 for dromaeo_css test... 07:36:15 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/tmpeQHcZu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:36:19 INFO - PROCESS | 1667 | 2017-05-05 07:36:19.855 plugin-container[1668:7899] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4643, name = 'com.apple.tsm.portname' 07:36:19 INFO - PROCESS | 1667 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:36:19 INFO - PROCESS | 1667 | 2017-05-05 07:36:19.856 plugin-container[1668:7899] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8813, name = 'com.apple.CFPasteboardClient' 07:36:19 INFO - PROCESS | 1667 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:36:19 INFO - PROCESS | 1667 | 2017-05-05 07:36:19.856 plugin-container[1668:7899] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:36:29 INFO - PROCESS | 1667 | RSS: Main: 174333952 07:36:29 INFO - PROCESS | 1667 | 07:39:31 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49237/tests/dromaeo/cssquery-ext.html) 07:39:33 INFO - PROCESS | 1667 | RSS: Main: 192528384 07:39:33 INFO - PROCESS | 1667 | 07:42:36 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-ext.html (next: http://localhost:49237/tests/dromaeo/cssquery-jquery.html) 07:42:36 INFO - PROCESS | 1667 | RSS: Main: 201506816 07:42:36 INFO - PROCESS | 1667 | 07:45:39 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49237/tests/dromaeo/cssquery-mootools.html) 07:45:40 INFO - PROCESS | 1667 | RSS: Main: 203882496 07:45:40 INFO - PROCESS | 1667 | 07:48:42 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49237/tests/dromaeo/cssquery-prototype.html) 07:48:43 INFO - PROCESS | 1667 | RSS: Main: 207036416 07:48:43 INFO - PROCESS | 1667 | 07:51:47 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49237/tests/dromaeo/cssquery-yui.html) 07:51:47 INFO - PROCESS | 1667 | RSS: Main: 209518592 07:51:47 INFO - PROCESS | 1667 | 07:54:51 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-yui.html (next: http://localhost:49237/tests/dromaeo/cssquery-dojo.html) 07:54:51 INFO - PROCESS | 1667 | RSS: Main: 207937536 07:54:51 INFO - PROCESS | 1667 | 07:54:51 INFO - PROCESS | 1667 | __start_tp_report 07:54:51 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 07:54:51 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 07:54:51 INFO - PROCESS | 1667 | |i|pagename|runs| 07:54:51 INFO - PROCESS | 1667 | |0;dojo.html;1386.1267401537034;1913.880379977713;1930.9710354344695;1973.1712680674116;2010.7486564179478;3331.2504686445536;3395.2190996070917;3400.9489857652093;3527.2769082338123;3585.1754096557806;3351.4805205193234;3485.477178423238;3519.8240087995628;3572.428411454168;3604.7476676632646;3019.773516986224;3049.1919641295076;3113.1750086227166;3131.7024882636115;3150.5274208868736;2610.5823068309073;2980.8807647694066;3069.539569064636;3130.0766273949125;3164.193130751655;2661.2016395081496;2862.842543660098;3092.814431134128;3120.8595613197463;3140.544621029949;2469;2620.5938079597695;2917.854107294648;2981.9105426837014;3225.580674512322;2984.925376865574;3026.636803583562;3077.4460597092516;3098.938021239585;3190.457622204231;2995.400919816024;3365.96634033659;3426.9828650856584;3511.6488351164935;3574.9821250893838;3486.6861982421706;3501.3172431375892;3607.332643460968;3635.0367152704553;3722.9627703722886;3652.1052342176336;3698.389765688658;3716.758410703296;3739.906502337436;3805.809709514541;2728.795340349462;3332.5167850662;3360.311136217094;3500.054985153994;3562.590302115264;3505.158761897126;3598.208394153282;3617.692496137805;3658.048907284125;3755.3615885299564;3437.673421024999;3548.290341931624;3600.6039335673054;3617.6924961378577;3621.167131559703;3507.8421471033867;3525.541679581638;3610.819459027038;3614.295212433603;3640.21735326906;3533.964660353415;3554.7511674183074;3555.1289933965827;3584.4981702561663;3622.710183185339;3024.971509686673;3514.7363947704025;3560.1989552350515;3582.982085089558;3714.6285371462636;2778.5137600919757;2802.7337402946687;2813.887444502238;2899.9710002900124;2960.422717570053;2467.2721547143638;2569.614557816305;2599.3371690218873;2619.7642212200994;2643.339165208698;3519.331327047853;3561.234334618018;3603.1172362770762;3621.6016238213774;3621.63783621641;3656.9212082435747;3664.6518580734787;3700.6239076636616;3712.350338690718;3838.9059118151195;3374.5444365010408;3385.7291416686608;3425.4176789945273;3479.739019573542;3557.626449222846;3139.7331226845517;3164.240582260241;3167.3506931079073;3180.332130252673;3214.11611806755;3650.1239702471216;3674.33861904849;3848.826802793825;3855.8264878079995;3896.123372241223;3538.5046093546407;3574.4638304254568;3591.6408359163875;3644.526211592476;3699.482072509905;3546.2907418515883;3564.6435356464144;3716.0524066362905;3730.1047748540695;3816.3512202925012;3165.7467402608195;3401.608814986308;3414.965850341465;3465.9602119363585;3589.120665436985;3099.8450077496486;3540.0264927144212;3718.3492888744904;3747.8007037747657;3758.6993040556144;3446.827658617009;3477.217626034122;3604.7656902301264;3608.0438683748303;3658.9023293012524;3433.5021421893184;3443.517907492903;3526.047967048831;3557.3596752584785;3638.2541578976775;2910.5779661949323;3391.93216135671;3441.5698037745283;3453.620101788751;3477.217626034122;3347.581552305962;3413.095529684685;3527.1005893496995;3591.2637909228024;3609.7473176877365;3268.7875288106197;3328.8169150696945;3452.361313157074;3526.3123690880034;3536.2927414517712 07:54:51 INFO - PROCESS | 1667 | |1;ext.html;408.74453466583384;439.6043560795285;440.4780335302669;440.6342735529511;535.6973310079804;22525.436864078405;22607.434814129654;24568.8771556142;25096.623550646756;25154;22086.558268834615;22913;23061.76938230617;23805.452645578025;24465.63301550478;4577.4278215223185;5912.024515954884;6165.9075113873105;6569.310222426648;6604.768833090843;5687.687177205252;6140.508759299268;6244.000959846426;6281.811545653638;6399.8080057598345;6216.564840461169;6342.619442833445;6344.619322840621;6364.968175159118;6445;6180.320164781915;6273.278572964076;6405.743770249162;6538.673066346688;6701.832454188636;6017.458428741391;6077.1491991121275;6116.388361163892;6170.907436388457;6241.7191226394925;19905;19936.601267974704;20180.39458816238;20279.37764978798;20336.389908302775;2062.8143467087884;2199.186301068599;2203.7575866654656;2220.4781876259067;2221.5001624634488;13218.735625287536;14366;14883.627909302246;15168.165750883696;15454.536363909101;1745.8603311735158;1791.2834866053552;1796.8742188046842;1818.7180986946912;1902.2010755482731;192622;195705;197255;197439;200790;21795.782042179693;22095.226667066574;23271.06915723386;24084.759152408602;25703.48593028129;20667.79332206689;27062.5940610891;27175.86412067927;27535.760890759964;28500.28749281243;8052.872597836307;8073.6770529178175;8242.505449673039;8270.297024752843;8385.874211886827;6915.239323674392;6978.162620485473;7173.6413179340825;7241.674124664402;7417.851642967111;6811.659417029129;6832.940894161413;6868.862622747517;6890;7035.12060992376;2518.4585314157544;3173.4922412413903;3208.069659798632;3243.772935894465;3292.863961933177;510.9463506331856;511.215284538232;516.5557620446413;540.1088204462668;567.8608740858516;12287.69280767988;13701.492835788054;15044.699106017819;16067.116308602905;16646.50060498187;521.1193083688554;544.4065968094717;596.9134475501115;602.9638221706712;630.015154150003;6811.641026915604;7332.413406927433;8140.023197216372;8215.630296636666;8507.234348908503;275916;281841;285787;290401;293367;29298.560521592193;29866;30078.849605752268;30260.638271277847;30729.231769205948;782.718221440281;790.1979490816825;809.6478032056075;839.4637812802679;839.5969934431507;15005;15101.47144849925;15252.694946100793;15437.687796536971;16039.759403609189;22231.88840557933;22298.665520017537;23627.881860591275;24127.396815079763;24884.506929584284;258507;261360;262730.49078036664;265853;269165;14128.364223609757;14239.857601423853;16501.58746031359;16856.915715421343;17055.658886822443;22116.447088822908;22912.31263062111;23188.76811231866;23190.956406961388;23195.768042320036;14847.737942275027;15178;15912.52262432129;16834.326626934784;17170.22733976999;14797.92601036988;16027.519174424786;16224.107674078039;16909.492715218563;17270.395536156175;18560.628787424444;18613.720794188368;18775.624487510446;18943.526411839815;19449.51376215606;15610.375584976473;16534.503964881074;16799.82401231902;16940.915295423445;17096.401625943032;11702.239354441934;11744.882551174378;12815.974722022402;13807.447702091804;13869 07:54:51 INFO - PROCESS | 1667 | |2;jquery.html;224.65739746885995;242.9867452722149;243.68652960542676;245.55922119794965;256.20193098498174;9431.622735090597;10188.592456301758;11569.13231507636;12615.621531354063;12853.871461285384;9710;11730.41347932602;11851.696313405519;12044.81932771009;12346.62960111196;3301.712332190448;3505.5442792437075;3884.281407939526;3915;3952.4466574679423;3371.7976921384675;3753;3827.8468861245515;3945.881623551298;3946.3488524393442;3633.7274704397146;3835.846566137351;3863.014931192542;3919.960800391988;3947.151362457071;3738.9439158412647;3788.4506746521874;3839.8864329344456;3898.7718868556312;3909.6676782473523;3738.7943663098517;3750.79370634615;3806;3895.844166233347;3907;14619.415223391052;14838;15035.924820375938;15195.696086078216;15279.624833764903;1596.5529651697543;1639.8848782827672;1695.355764809377;1701.7617533545313;1821.952377382997;7539.434542409341;8888.155625215593;9392.671256506057;9637.37357071788;9661;991.4794732765356;1158.8874680306915;1159.321796748903;1222.4315693202705;1229.9938500307442;71139;72000.91998620024;72039.63980180066;74814.99999999946;80116;10803.891961080288;11180.832287515694;11408.771824563462;12027.518899244107;12583.67871373511;18353;18428.262869485337;18610.720839187423;18797.40222081111;19123;5981.175741398828;6105.175801266861;6108.297545782203;6166.383361663888;6381.266154392211;5119.283300337956;5160.277561141444;5194.6104042196985;5238.685678859204;5505.889882202334;5206.219067139959;5522.972385138129;5631.802886898939;5655.0386434306265;5733.942660573424;2369.779563524786;2417.8065754739932;2440.6095024795945;2455.484348286844;2475.4553998120386;433.8763452416109;509.49305441085613;518.3779464642444;528.1918664443408;543.804230477028;9986.600535978625;10272.794544109076;10368.189680380276;11498.770024599462;12480.438380272728;519.8310549071567;527.7282199667175;535.0129011972904;535.6545028456624;576.7779404929132;5750.712464376765;5928.347881733006;6212.81361559154;6414.64719440426;6569.868602627921;375947;405992;439208;450325;454859;90785;92753.07246927444;93764;94016;94408.52795735978;654.2933631677777;696.7422053840112;700.5411455496658;722.173111787001;746.1903834339802;10840.512176952214;10967.670969870916;11302.813204613398;11462.656120316404;11489.655310340702;24959.75040249574;32303.676963231006;33532.66467335393;35440.64559354373;37366;48788.2681759781;51854.22218666648;52800.20799688085;53593.73203133959;54127.72936135294;6159.876802464015;6488.188976377953;6699.631520266432;6843.863122737617;6950.860982780215;7477.626118694152;7763.767086987399;7766.301032907066;8279.875801863098;8334.6666133354;5909.084091965752;6195.938040619536;6397.3282805306635;6535.509836762357;6977.33715297046;5161.948380516147;5682.5453963681975;5965.373635768182;6016.8796624068145;6807.251202367636;5639.830805075854;6447.580907241015;6560.868782624416;6566.474682025331;6612;6013.338532761481;6886.621235832077;7305.379042781423;7339.302766237199;7926.405519585939;5468.589855760754;6642.368974947372;6805.93194068053;6973.686184121828;7162.176349719641 07:54:51 INFO - PROCESS | 1667 | |3;mootools.html;893.0266010049045;900.2392977933644;913.0686699566443;918.6049998500646;928.5635751196937;5990.341062483123;6315.747370105202;6489.967550162249;6620.337966203378;6684.699188536521;6089.147519347284;6138;6396.6801659917055;6416.615003099817;6605.6697165141795;1188.6434069779075;1331.5273078057296;1359.422245545639;1376.4012654495277;1385.7090011097682;1145.7651181507772;1303.354839354521;1341.2421981580424;1359.8776110150084;1364.1542243808854;1311.1674086954804;1341.7718987772103;1353.3977380065874;1389.5553422904675;1390.7149034447964;1153.4578747988432;1271.3389037700344;1347.8989075819304;1352.7226918481688;1360.9996652460434;1119.171812858487;1124.9818913882948;1212.8962643994012;1316.697159653285;1332.6934804994808;6253.562250642457;6292.056191571301;6351.4283714465455;6395.456386207178;6428.19647544057;2942.3820997590533;3269.2480729432127;3278.950815737766;3329.217633856042;3380.0197942596865;1829.2408650410064;1954.5309125809845;2034.6134234495398;2123.9575208495744;2162.383720639626;676.4182802789597;700.4151533469559;720.204174387305;724.6811402982671;735.6763024269304;6400.871982560323;7657.46397752152;8555.743327700178;8573.52845593492;8685.305175585938;2393.4734358441465;2553.553128202557;2721.8911243550037;2819.4783964966546;2864.269611249118;5293.867653308621;6695.631740254235;6723.495737819683;7002.509824312351;7067.505274630829;3187.7290430313683;3267.8856240031487;3332.0670212340583;3356.446186379269;3399.354122716725;3028.651705053947;3088.336007758298;3134.702203290684;3136.168915237464;3178.364327134536;2109.7679255281905;2196.615592271346;2218.38994276572;2235.944101397478;2269.500709843832;577.1717585265158;584.7427132061879;595.9076343166817;607.4897086447318;618.3661746709658;463.36981704881333;471.8207081309149;521.0022806325843;529.4021423933076;560.6159780550255;3025.5007923692783;3570.8214589270433;3695.371786796251;3747.3254814133716;3823.808809559511;578.5660754434174;581.6771691711057;603.8556934608979;609.8902197604385;618.9690515474208;2374.9168779092647;2376.2871138658334;2380.535795519857;2404.3748625357184;2428.4900170963942;5929.495992840571;6718.025886246467;7155.749548765768;7549.414622929136;7582.8246621773715;6729.49528785343;7189.784306470814;7580.0145981023215;7849.686012559434;7936.920630793734;5594.524465420403;5638.9286035653095;5793;5857.033589457692;5920.407959204045;3557.4485954676034;3728.8626968774784;3747.587765345755;3862.0537968197973;3874.4769456123063;5886.911696324644;6925.688344024632;6936.4797640176175;6965.895511567229;6970.407515361251;6563.212414510289;6901.412675084658;6916.1700595926795;7268.9823424721635;7444.776656700307;4113.341865301538;4450.777461126995;4755.643326750576;4762.714237145782;5093.71984540839;5876.707124432618;5890.705464726832;5929.762809487745;5963.2844058713235;6036.456718895321;4489.820407183676;4535.138323718483;4642.53574642533;4671.85984420468;4940.60475161979;4754.976225118852;4917.0903382874285;5036.194208926554;5124.538791508782;5137.255098010843;4484.1255955088445;4525.932111018403;4603.401557797465;4625.7918393673035;4657.93013104797;3299.5875515560556;3301.257217126127;3331.9167020824675;3375.780574262665;3433.1073920781278;3291.8683252670585;3391.3386889557287;3412.590489141319;3457.498662693946;3514.262004978983 07:54:51 INFO - PROCESS | 1667 | |4;prototype.html;195.52097361464416;205.08736124247096;215.71525586226178;219.71327417719877;223.7929914828783;2558.9508301596347;2837.3187337965633;2876.1084063940193;3014.1259034879886;3084.984575077124;2438.9878200546796;2667;3009.1574359179463;3077.3076057886965;3134.899617256438;2156.1698745982753;2445.902163913441;2544.6946366436055;2544.73280305568;2637.3406648337914;2203.327984964585;2224.1992882562263;2377.6552399902002;2419.854808711474;2639.0895141176265;2075.361566897982;2247.3482690019873;2431.817613678981;2469.5798117844524;2524.4853088147147;2513.5726926422462;2517.8363406378526;2536.7716905478505;2573.5882258838683;2587.611858221263;1878.7933327333983;1884.8869067855971;2109.641360968639;2141.6252155872817;2269.9558203226534;2909.418116376733;2935.354222071141;2998;3059.6175478065243;3097.938041239185;2789.9721002789915;2827.7313655202724;2844.7155284471596;2912.286489809989;2918.6059881916094;3151.558781770554;3222.822744749038;3279.770416070876;3296.9449776071665;3339.682730140633;2131.1155870313955;2138.6474877634478;2418.8548687078833;2600.3499125218696;2613.1768492924666;3053.6258683592473;3062.647795503501;3200.999999999977;3261.445554255735;3525.2244506208594;2350.518143780521;2385.081743528719;2552.5788244939376;2608.856512891809;2625;2490.9750902491105;2529.4941011797714;2769.418422131335;2829.3209629689136;2841.9857900710363;2890.4363649088227;2900.825950442938;2933.8557962394684;2987.5668028135797;3044.558539011831;2938.2654336415894;3018.2795806390145;3248.6101667800017;3265.8856940006985;3324.750643701732;801.5951944268107;825.3479750996765;861.5519929636554;897.2149369301861;931.6971984105193;631.3907079668143;673.0678010954863;682.0315152483486;708.7632082016811;734.7575300150937;3021.6827233140643;3031.317953460498;3111.315510587667;3158.867764259116;3165.382750363657;3078.8601921664676;3371.0727003041184;3382.8139452330356;3388.661133886641;3431.588209414886;2689.7041325454184;3060.877564897379;3133.498640217554;3180;3305.603327600655;1519.5365413548973;1592.7849740284914;1641.663458990928;1743.747156662277;1753.65803668286;3253.9511907321407;3449.842031972966;3498.6676265754713;3581.5881173664843;3613.8193090345903;2949.056301983345;3064.004198635452;3397.2695870387984;3427.520147179397;3552.9644703552635;3233.3533293341425;3358.5465962094804;3406.982965085159;3593.4969104325937;3597.1906321078072;2977.925551861221;3271.869125235059;3310;3347.113015051062;3354.3731290323685;2776.8889244429997;2805.793508791239;3121.4392803598203;3133.3000499251125;3150.480170771889;3060.403221371811;3095.860686269168;3401.234722187488;3410.522526846194;3691.686206672463;2152.806247437738;2303.96544051836;2625.750553697396;2638.8812503437007;2668.613051107617;2942.189864126005;2996.3557835065567;3265.770826779279;3285.7207137392634;3515.384807658598;2723.7470763449037;2867;2987.2830520675316;3056.3276079262528;3264.8857289994735;2765.893642542999;3094.520349345855;3140.1473130852905;3207.9198020049685;3221.3557288541915;2921.4887394706266;2928.985355073211;2967.703229677015;3132.3108916038436;3159.7472202224226;3069.4935335669365;3222.468292731673;3238.7732858699665;3287.375398674244;3365.192353835111;2999.565063065887;3014.6533148687304;3086.5430717596437;3117.4856148735203;3146.4267866066966 07:54:51 INFO - PROCESS | 1667 | |5;yui.html;441.20582950688754;471.38955053206075;484.5735752537767;490.35763150273146;491.5625093666636;8205.548694821782;9123.908760912389;9144.579328531707;9330.86003709944;9745.51272436377;8623.91376086239;8695.260902823251;8695.304375649948;8848.955755221215;8953.328500362466;472.36231088031053;505.93675790526186;558.7429782300147;561.2339157050617;563.821612829187;429.99140017199636;439.229152836771;502.65316931317454;533.6131304804024;593.4658807073625;573.1946615005924;578.1558923970987;579.7622974580423;589.1104432307226;598.9580729348947;558.2435799491711;572.6764378126345;573.8450618333047;582.4175824175824;589.6373730155966;414.3784323514728;435.6427729262006;438.2680922858833;438.49135003396225;442.03636073360065;9273.304502162366;9438.858417123749;9750.561224744904;9782.657606983721;9818.45998470084;7710.113336966265;7983.361331093499;8410.621522031523;8573.099824518398;8741.825163496758;6431.774887878902;6753.358430949101;6807.2512023677355;6859.485538584626;7209.711611535532;2537.9492410151693;2546.1724939394585;2574.871256437171;2623.8950441982297;2675.598660200966;58341.7912014839;60131;60506.697466512385;61194.999999999556;61471;5125.948740512622;5961.897049045941;6131.478824299985;6325.58883672569;6339.714712837934;12125.151239413333;12146.696332591757;12515.874841251652;12697.111202215941;12761.61715148547;4246.617804397619;4330.610245077958;4361.433013708198;4487.935549647199;4590.219662657356;2486;2491.3522484153887;2514.3085651446;2546.427053912892;2578.600316950876;1977.7725561560605;1990.0945069993118;2003.0986056274735;2016.9092390842447;2022.5044864008412;339.4772051041418;360.1428599932197;370.75900664567706;373.43424711562005;375.6844250829316;304.30921807496856;323.559958456499;354.68255910959545;416.6895662731224;421.26699542795313;5722;6059.545534084873;6114.724837382329;6570.342965703391;6710.396064354231;317.4349657609459;327.190204244493;327.44171188124193;420.3820384035463;443.90456051948985;2727.6044973478733;2741.369485018457;2958.423107494018;3065.065155127663;3088.3977624363483;58117.70941145267;59937.201883943555;61529;61921.69039154775;63416.04875926865;40916.79541602273;42160.57839421628;44382.55895925691;52201;52809.73595132;43619.4733184337;43924;45361.09277814425;45387.54612453899;46564.53435465738;4590.793414296431;5202.687838729688;5561.915426491957;5609.719514024364;5881.7647294107755;28541.857290714244;28731.5690264642;29278.7072129276;29814.85092574523;31663.20841978969;36096.09759756027;36677.63322366849;37354.8132259337;38291;38486.965105669784;6153.876922461615;6522.60505875335;6525.771597994238;6582.3746744059235;7090.751823686146;7483.027206463125;7667.961660191663;7985.361171106414;8132.430729848854;8201.507909525448;5897.823065308047;7134.678939447841;7341.375983041287;7426.517276377018;7628.694852206072;7076.504644675029;7205.855882882418;7301.488895777245;7357.816054598464;7381.446391520765;6852.903535434307;6969.30306969299;7105.609191494311;7354.8896766549615;7405.333519983227;5201.271821945006;5296.364436267672;5488.670679759227;5529.640573362719;5643.858903527444;5535.892821435648;5575.2473416088305;5647.548196144381;5922.703864806656;6360.268569114611 07:54:51 INFO - PROCESS | 1667 | __end_tp_report 07:54:51 INFO - PROCESS | 1667 | __start_cc_report 07:54:51 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,586 07:54:51 INFO - PROCESS | 1667 | __end_cc_report 07:54:51 INFO - PROCESS | 1667 | __startTimestamp1493996091409__endTimestamp 07:54:51 INFO - PROCESS | 1667 | 07:54:51 INFO - PROCESS | 1667 | ------- Summary: start ------- 07:54:51 INFO - PROCESS | 1667 | Number of tests: 6 07:54:51 INFO - PROCESS | 1667 | 07:54:51 INFO - PROCESS | 1667 | [#0] dojo.html Cycles:165 Average:3342.89 Median:3500.05 stddev:414.58 (11.8%) stddev-sans-first:386.39 07:54:51 INFO - PROCESS | 1667 | Values: 1386.1 1913.9 1931.0 1973.2 2010.7 3331.3 3395.2 3400.9 3527.3 3585.2 3351.5 3485.5 3519.8 3572.4 3604.7 3019.8 3049.2 3113.2 3131.7 3150.5 2610.6 2980.9 3069.5 3130.1 3164.2 2661.2 2862.8 3092.8 3120.9 3140.5 2469.0 2620.6 2917.9 2981.9 3225.6 2984.9 3026.6 3077.4 3098.9 3190.5 2995.4 3366.0 3427.0 3511.6 3575.0 3486.7 3501.3 3607.3 3635.0 3723.0 3652.1 3698.4 3716.8 3739.9 3805.8 2728.8 3332.5 3360.3 3500.1 3562.6 3505.2 3598.2 3617.7 3658.0 3755.4 3437.7 3548.3 3600.6 3617.7 3621.2 3507.8 3525.5 3610.8 3614.3 3640.2 3534.0 3554.8 3555.1 3584.5 3622.7 3025.0 3514.7 3560.2 3583.0 3714.6 2778.5 2802.7 2813.9 2900.0 2960.4 2467.3 2569.6 2599.3 2619.8 2643.3 3519.3 3561.2 3603.1 3621.6 3621.6 3656.9 3664.7 3700.6 3712.4 3838.9 3374.5 3385.7 3425.4 3479.7 3557.6 3139.7 3164.2 3167.4 3180.3 3214.1 3650.1 3674.3 3848.8 3855.8 3896.1 3538.5 3574.5 3591.6 3644.5 3699.5 3546.3 3564.6 3716.1 3730.1 3816.4 3165.7 3401.6 3415.0 3466.0 3589.1 3099.8 3540.0 3718.3 3747.8 3758.7 3446.8 3477.2 3604.8 3608.0 3658.9 3433.5 3443.5 3526.0 3557.4 3638.3 2910.6 3391.9 3441.6 3453.6 3477.2 3347.6 3413.1 3527.1 3591.3 3609.7 3268.8 3328.8 3452.4 3526.3 3536.3 07:54:51 INFO - PROCESS | 1667 | 07:54:51 INFO - PROCESS | 1667 | [#1] ext.html Cycles:180 Average:31960.79 Median:14110.97 stddev:66927.10 (474.3%) stddev-sans-first:67072.92 07:54:51 INFO - PROCESS | 1667 | Values: 408.7 439.6 440.5 440.6 535.7 22525.4 22607.4 24568.9 25096.6 25154.0 22086.6 22913.0 23061.8 23805.5 24465.6 4577.4 5912.0 6165.9 6569.3 6604.8 5687.7 6140.5 6244.0 6281.8 6399.8 6216.6 6342.6 6344.6 6365.0 6445.0 6180.3 6273.3 6405.7 6538.7 6701.8 6017.5 6077.1 6116.4 6170.9 6241.7 19905.0 19936.6 20180.4 20279.4 20336.4 2062.8 2199.2 2203.8 2220.5 2221.5 13218.7 14366.0 14883.6 15168.2 15454.5 1745.9 1791.3 1796.9 1818.7 1902.2 192622.0 195705.0 197255.0 197439.0 200790.0 21795.8 22095.2 23271.1 24084.8 25703.5 20667.8 27062.6 27175.9 27535.8 28500.3 8052.9 8073.7 8242.5 8270.3 8385.9 6915.2 6978.2 7173.6 7241.7 7417.9 6811.7 6832.9 6868.9 6890.0 7035.1 2518.5 3173.5 3208.1 3243.8 3292.9 510.9 511.2 516.6 540.1 567.9 12287.7 13701.5 15044.7 16067.1 16646.5 521.1 544.4 596.9 603.0 630.0 6811.6 7332.4 8140.0 8215.6 8507.2 275916.0 281841.0 285787.0 290401.0 293367.0 29298.6 29866.0 30078.8 30260.6 30729.2 782.7 790.2 809.6 839.5 839.6 15005.0 15101.5 15252.7 15437.7 16039.8 22231.9 22298.7 23627.9 24127.4 24884.5 258507.0 261360.0 262730.5 265853.0 269165.0 14128.4 14239.9 16501.6 16856.9 17055.7 22116.4 22912.3 23188.8 23191.0 23195.8 14847.7 15178.0 15912.5 16834.3 17170.2 14797.9 16027.5 16224.1 16909.5 17270.4 18560.6 18613.7 18775.6 18943.5 19449.5 15610.4 16534.5 16799.8 16940.9 17096.4 11702.2 11744.9 12816.0 13807.4 13869.0 07:54:51 INFO - PROCESS | 1667 | 07:54:51 INFO - PROCESS | 1667 | [#2] jquery.html Cycles:180 Average:24249.56 Median:5161.11 stddev:70988.16 (1375.4%) stddev-sans-first:71164.38 07:54:51 INFO - PROCESS | 1667 | Values: 224.7 243.0 243.7 245.6 256.2 9431.6 10188.6 11569.1 12615.6 12853.9 9710.0 11730.4 11851.7 12044.8 12346.6 3301.7 3505.5 3884.3 3915.0 3952.4 3371.8 3753.0 3827.8 3945.9 3946.3 3633.7 3835.8 3863.0 3920.0 3947.2 3738.9 3788.5 3839.9 3898.8 3909.7 3738.8 3750.8 3806.0 3895.8 3907.0 14619.4 14838.0 15035.9 15195.7 15279.6 1596.6 1639.9 1695.4 1701.8 1822.0 7539.4 8888.2 9392.7 9637.4 9661.0 991.5 1158.9 1159.3 1222.4 1230.0 71139.0 72000.9 72039.6 74815.0 80116.0 10803.9 11180.8 11408.8 12027.5 12583.7 18353.0 18428.3 18610.7 18797.4 19123.0 5981.2 6105.2 6108.3 6166.4 6381.3 5119.3 5160.3 5194.6 5238.7 5505.9 5206.2 5523.0 5631.8 5655.0 5733.9 2369.8 2417.8 2440.6 2455.5 2475.5 433.9 509.5 518.4 528.2 543.8 9986.6 10272.8 10368.2 11498.8 12480.4 519.8 527.7 535.0 535.7 576.8 5750.7 5928.3 6212.8 6414.6 6569.9 375947.0 405992.0 439208.0 450325.0 454859.0 90785.0 92753.1 93764.0 94016.0 94408.5 654.3 696.7 700.5 722.2 746.2 10840.5 10967.7 11302.8 11462.7 11489.7 24959.8 32303.7 33532.7 35440.6 37366.0 48788.3 51854.2 52800.2 53593.7 54127.7 6159.9 6488.2 6699.6 6843.9 6950.9 7477.6 7763.8 7766.3 8279.9 8334.7 5909.1 6195.9 6397.3 6535.5 6977.3 5161.9 5682.5 5965.4 6016.9 6807.3 5639.8 6447.6 6560.9 6566.5 6612.0 6013.3 6886.6 7305.4 7339.3 7926.4 5468.6 6642.4 6805.9 6973.7 7162.2 07:54:51 INFO - PROCESS | 1667 | 07:54:51 INFO - PROCESS | 1667 | [#3] mootools.html Cycles:180 Average:3757.35 Median:4664.89 stddev:2318.68 (49.7%) stddev-sans-first:2315.19 07:54:51 INFO - PROCESS | 1667 | Values: 893.0 900.2 913.1 918.6 928.6 5990.3 6315.7 6490.0 6620.3 6684.7 6089.1 6138.0 6396.7 6416.6 6605.7 1188.6 1331.5 1359.4 1376.4 1385.7 1145.8 1303.4 1341.2 1359.9 1364.2 1311.2 1341.8 1353.4 1389.6 1390.7 1153.5 1271.3 1347.9 1352.7 1361.0 1119.2 1125.0 1212.9 1316.7 1332.7 6253.6 6292.1 6351.4 6395.5 6428.2 2942.4 3269.2 3279.0 3329.2 3380.0 1829.2 1954.5 2034.6 2124.0 2162.4 676.4 700.4 720.2 724.7 735.7 6400.9 7657.5 8555.7 8573.5 8685.3 2393.5 2553.6 2721.9 2819.5 2864.3 5293.9 6695.6 6723.5 7002.5 7067.5 3187.7 3267.9 3332.1 3356.4 3399.4 3028.7 3088.3 3134.7 3136.2 3178.4 2109.8 2196.6 2218.4 2235.9 2269.5 577.2 584.7 595.9 607.5 618.4 463.4 471.8 521.0 529.4 560.6 3025.5 3570.8 3695.4 3747.3 3823.8 578.6 581.7 603.9 609.9 619.0 2374.9 2376.3 2380.5 2404.4 2428.5 5929.5 6718.0 7155.7 7549.4 7582.8 6729.5 7189.8 7580.0 7849.7 7936.9 5594.5 5638.9 5793.0 5857.0 5920.4 3557.4 3728.9 3747.6 3862.1 3874.5 5886.9 6925.7 6936.5 6965.9 6970.4 6563.2 6901.4 6916.2 7269.0 7444.8 4113.3 4450.8 4755.6 4762.7 5093.7 5876.7 5890.7 5929.8 5963.3 6036.5 4489.8 4535.1 4642.5 4671.9 4940.6 4755.0 4917.1 5036.2 5124.5 5137.3 4484.1 4525.9 4603.4 4625.8 4657.9 3299.6 3301.3 3331.9 3375.8 3433.1 3291.9 3391.3 3412.6 3457.5 3514.3 07:54:51 INFO - PROCESS | 1667 | 07:54:51 INFO - PROCESS | 1667 | [#4] prototype.html Cycles:180 Average:2703.45 Median:3016.47 stddev:773.91 (25.7%) stddev-sans-first:752.84 07:54:51 INFO - PROCESS | 1667 | Values: 195.5 205.1 215.7 219.7 223.8 2559.0 2837.3 2876.1 3014.1 3085.0 2439.0 2667.0 3009.2 3077.3 3134.9 2156.2 2445.9 2544.7 2544.7 2637.3 2203.3 2224.2 2377.7 2419.9 2639.1 2075.4 2247.3 2431.8 2469.6 2524.5 2513.6 2517.8 2536.8 2573.6 2587.6 1878.8 1884.9 2109.6 2141.6 2270.0 2909.4 2935.4 2998.0 3059.6 3097.9 2790.0 2827.7 2844.7 2912.3 2918.6 3151.6 3222.8 3279.8 3296.9 3339.7 2131.1 2138.6 2418.9 2600.3 2613.2 3053.6 3062.6 3201.0 3261.4 3525.2 2350.5 2385.1 2552.6 2608.9 2625.0 2491.0 2529.5 2769.4 2829.3 2842.0 2890.4 2900.8 2933.9 2987.6 3044.6 2938.3 3018.3 3248.6 3265.9 3324.8 801.6 825.3 861.6 897.2 931.7 631.4 673.1 682.0 708.8 734.8 3021.7 3031.3 3111.3 3158.9 3165.4 3078.9 3371.1 3382.8 3388.7 3431.6 2689.7 3060.9 3133.5 3180.0 3305.6 1519.5 1592.8 1641.7 1743.7 1753.7 3254.0 3449.8 3498.7 3581.6 3613.8 2949.1 3064.0 3397.3 3427.5 3553.0 3233.4 3358.5 3407.0 3593.5 3597.2 2977.9 3271.9 3310.0 3347.1 3354.4 2776.9 2805.8 3121.4 3133.3 3150.5 3060.4 3095.9 3401.2 3410.5 3691.7 2152.8 2304.0 2625.8 2638.9 2668.6 2942.2 2996.4 3265.8 3285.7 3515.4 2723.7 2867.0 2987.3 3056.3 3264.9 2765.9 3094.5 3140.1 3207.9 3221.4 2921.5 2929.0 2967.7 3132.3 3159.7 3069.5 3222.5 3238.8 3287.4 3365.2 2999.6 3014.7 3086.5 3117.5 3146.4 07:54:51 INFO - PROCESS | 1667 | 07:54:51 INFO - PROCESS | 1667 | [#5] yui.html Cycles:180 Average:11616.94 Median:3066.75 stddev:16703.75 (544.7%) stddev-sans-first:16729.53 07:54:51 INFO - PROCESS | 1667 | Values: 441.2 471.4 484.6 490.4 491.6 8205.5 9123.9 9144.6 9330.9 9745.5 8623.9 8695.3 8695.3 8849.0 8953.3 472.4 505.9 558.7 561.2 563.8 430.0 439.2 502.7 533.6 593.5 573.2 578.2 579.8 589.1 599.0 558.2 572.7 573.8 582.4 589.6 414.4 435.6 438.3 438.5 442.0 9273.3 9438.9 9750.6 9782.7 9818.5 7710.1 7983.4 8410.6 8573.1 8741.8 6431.8 6753.4 6807.3 6859.5 7209.7 2537.9 2546.2 2574.9 2623.9 2675.6 58341.8 60131.0 60506.7 61195.0 61471.0 5125.9 5961.9 6131.5 6325.6 6339.7 12125.2 12146.7 12515.9 12697.1 12761.6 4246.6 4330.6 4361.4 4487.9 4590.2 2486.0 2491.4 2514.3 2546.4 2578.6 1977.8 1990.1 2003.1 2016.9 2022.5 339.5 360.1 370.8 373.4 375.7 304.3 323.6 354.7 416.7 421.3 5722.0 6059.5 6114.7 6570.3 6710.4 317.4 327.2 327.4 420.4 443.9 2727.6 2741.4 2958.4 3065.1 3088.4 58117.7 59937.2 61529.0 61921.7 63416.0 40916.8 42160.6 44382.6 52201.0 52809.7 43619.5 43924.0 45361.1 45387.5 46564.5 4590.8 5202.7 5561.9 5609.7 5881.8 28541.9 28731.6 29278.7 29814.9 31663.2 36096.1 36677.6 37354.8 38291.0 38487.0 6153.9 6522.6 6525.8 6582.4 7090.8 7483.0 7668.0 7985.4 8132.4 8201.5 5897.8 7134.7 7341.4 7426.5 7628.7 7076.5 7205.9 7301.5 7357.8 7381.4 6852.9 6969.3 7105.6 7354.9 7405.3 5201.3 5296.4 5488.7 5529.6 5643.9 5535.9 5575.2 5647.5 5922.7 6360.3 07:54:51 INFO - PROCESS | 1667 | -------- Summary: end -------- 07:54:51 INFO - PROCESS | 1667 | 07:54:52 INFO - TEST-INFO | 1667: exit 0 07:54:52 INFO - TEST-OK | dromaeo_css | took 1123024ms 07:54:52 INFO - TEST-START | kraken 07:54:52 INFO - operating with platform_type : mac_ 07:54:52 INFO - Initialising browser for kraken test... 07:54:52 INFO - TEST-INFO | started process 1786 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/tmpBYsb3J/profile http://localhost:49237/getInfo.html) 07:54:56 INFO - PROCESS | 1786 | 2017-05-05 07:54:56.537 plugin-container[1789:10470] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x843f, name = 'com.apple.tsm.portname' 07:54:56 INFO - PROCESS | 1786 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:54:56 INFO - PROCESS | 1786 | 2017-05-05 07:54:56.539 plugin-container[1789:10470] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4343, name = 'com.apple.CFPasteboardClient' 07:54:56 INFO - PROCESS | 1786 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:54:56 INFO - PROCESS | 1786 | 2017-05-05 07:54:56.539 plugin-container[1789:10470] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:54:56 INFO - PROCESS | 1786 | __metrics Screen width/height:1600/1200 07:54:56 INFO - PROCESS | 1786 | colorDepth:24 07:54:56 INFO - PROCESS | 1786 | Browser inner width/height: 1024/689 07:54:56 INFO - PROCESS | 1786 | __metrics 07:54:56 ERROR - PROCESS | 1786 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3371: TypeError: this.tabs is undefined 07:54:58 INFO - TEST-INFO | 1786: exit 0 07:54:58 INFO - Browser initialized. 07:54:58 INFO - Running cycle 1/1 for kraken test... 07:54:58 INFO - TEST-INFO | started process 1790 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/tmpBYsb3J/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:55:01 INFO - PROCESS | 1790 | 2017-05-05 07:55:01.890 plugin-container[1791:10596] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 07:55:01 INFO - PROCESS | 1790 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:55:01 INFO - PROCESS | 1790 | 2017-05-05 07:55:01.892 plugin-container[1791:10596] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a17, name = 'com.apple.CFPasteboardClient' 07:55:01 INFO - PROCESS | 1790 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:55:01 INFO - PROCESS | 1790 | 2017-05-05 07:55:01.892 plugin-container[1791:10596] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:55:11 INFO - PROCESS | 1790 | RSS: Main: 174440448 07:55:11 INFO - PROCESS | 1790 | 07:55:15 INFO - PROCESS | 1790 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-beat-detection) 07:55:17 INFO - PROCESS | 1790 | RSS: Main: 187088896 07:55:17 INFO - PROCESS | 1790 | 07:55:21 INFO - PROCESS | 1790 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-dft) 07:55:22 INFO - PROCESS | 1790 | RSS: Main: 195039232 07:55:22 INFO - PROCESS | 1790 | 07:55:26 INFO - PROCESS | 1790 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-fft) 07:55:27 INFO - PROCESS | 1790 | RSS: Main: 194846720 07:55:27 INFO - PROCESS | 1790 | 07:55:30 INFO - PROCESS | 1790 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-oscillator) 07:55:31 INFO - PROCESS | 1790 | RSS: Main: 203046912 07:55:31 INFO - PROCESS | 1790 | 07:55:34 INFO - PROCESS | 1790 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:55:35 INFO - PROCESS | 1790 | RSS: Main: 212631552 07:55:35 INFO - PROCESS | 1790 | 07:55:40 INFO - PROCESS | 1790 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-darkroom) 07:55:40 INFO - PROCESS | 1790 | RSS: Main: 204582912 07:55:40 INFO - PROCESS | 1790 | 07:55:46 INFO - PROCESS | 1790 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-desaturate) 07:55:47 INFO - PROCESS | 1790 | RSS: Main: 204836864 07:55:47 INFO - PROCESS | 1790 | 07:55:52 INFO - PROCESS | 1790 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49237/tests/kraken/driver.html?testName=json-parse-financial) 07:55:53 INFO - PROCESS | 1790 | RSS: Main: 206094336 07:55:53 INFO - PROCESS | 1790 | 07:55:55 INFO - PROCESS | 1790 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49237/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:55:56 INFO - PROCESS | 1790 | RSS: Main: 211914752 07:55:56 INFO - PROCESS | 1790 | 07:55:59 INFO - PROCESS | 1790 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:56:00 INFO - PROCESS | 1790 | RSS: Main: 217538560 07:56:00 INFO - PROCESS | 1790 | 07:56:03 INFO - PROCESS | 1790 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:56:04 INFO - PROCESS | 1790 | RSS: Main: 206491648 07:56:04 INFO - PROCESS | 1790 | 07:56:09 INFO - PROCESS | 1790 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:56:10 INFO - PROCESS | 1790 | RSS: Main: 207142912 07:56:10 INFO - PROCESS | 1790 | 07:56:15 INFO - PROCESS | 1790 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:56:15 INFO - PROCESS | 1790 | RSS: Main: 206696448 07:56:15 INFO - PROCESS | 1790 | 07:56:18 INFO - PROCESS | 1790 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49237/tests/kraken/driver.html?testName=ai-astar) 07:56:18 INFO - PROCESS | 1790 | RSS: Main: 212541440 07:56:18 INFO - PROCESS | 1790 | 07:56:18 INFO - PROCESS | 1790 | __start_tp_report 07:56:18 INFO - PROCESS | 1790 | _x_x_mozilla_page_load 07:56:18 INFO - PROCESS | 1790 | _x_x_mozilla_page_load_details 07:56:18 INFO - PROCESS | 1790 | |i|pagename|runs| 07:56:18 INFO - PROCESS | 1790 | |0;ai-astar;279;308;218;224;220;223;302;229;229;220 07:56:18 INFO - PROCESS | 1790 | |1;audio-beat-detection;220;242;205;287;277;221;203;227;265;238 07:56:18 INFO - PROCESS | 1790 | |2;audio-dft;298;280;421;305;284;293;372;296;285;289 07:56:18 INFO - PROCESS | 1790 | |3;audio-fft;186;144;152;168;116;149;123;96;117;150 07:56:18 INFO - PROCESS | 1790 | |4;audio-oscillator;165;121;132;141;168;119;166;151;136;151 07:56:18 INFO - PROCESS | 1790 | |5;imaging-gaussian-blur;175;157;159;230;219;212;219;181;172;167 07:56:18 INFO - PROCESS | 1790 | |6;imaging-darkroom;189;288;199;243;172;217;199;228;240;227 07:56:18 INFO - PROCESS | 1790 | |7;imaging-desaturate;212;154;191;218;157;146;232;200;166;145 07:56:18 INFO - PROCESS | 1790 | |8;json-parse-financial;116;151;150;175;178;128;129;133;124;138 07:56:18 INFO - PROCESS | 1790 | |9;json-stringify-tinderbox;91;164;143;119;125;120;110;142;132;128 07:56:18 INFO - PROCESS | 1790 | |10;stanford-crypto-aes;182;148;187;169;166;197;238;158;159;161 07:56:18 INFO - PROCESS | 1790 | |11;stanford-crypto-ccm;266;279;237;242;254;275;271;312;405;269 07:56:18 INFO - PROCESS | 1790 | |12;stanford-crypto-pbkdf2;301;315;330;363;365;401;325;319;312;315 07:56:18 INFO - PROCESS | 1790 | |13;stanford-crypto-sha256-iterative;114;109;121;123;119;113;110;120;102;118 07:56:18 INFO - PROCESS | 1790 | __end_tp_report 07:56:18 INFO - PROCESS | 1790 | __start_cc_report 07:56:18 INFO - PROCESS | 1790 | _x_x_mozilla_cycle_collect,1502 07:56:18 INFO - PROCESS | 1790 | __end_cc_report 07:56:18 INFO - PROCESS | 1790 | __startTimestamp1493996178616__endTimestamp 07:56:18 INFO - PROCESS | 1790 | 07:56:18 INFO - PROCESS | 1790 | ------- Summary: start ------- 07:56:18 INFO - PROCESS | 1790 | Number of tests: 14 07:56:18 INFO - PROCESS | 1790 | 07:56:18 INFO - PROCESS | 1790 | [#0] ai-astar Cycles:10 Average:245.20 Median:229.00 stddev:36.19 (15.8%) stddev-sans-first:36.26 07:56:18 INFO - PROCESS | 1790 | Values: 279.0 308.0 218.0 224.0 220.0 223.0 302.0 229.0 229.0 220.0 07:56:18 INFO - PROCESS | 1790 | 07:56:18 INFO - PROCESS | 1790 | [#1] audio-beat-detection Cycles:10 Average:238.50 Median:240.00 stddev:29.27 (12.2%) stddev-sans-first:30.27 07:56:18 INFO - PROCESS | 1790 | Values: 220.0 242.0 205.0 287.0 277.0 221.0 203.0 227.0 265.0 238.0 07:56:18 INFO - PROCESS | 1790 | 07:56:18 INFO - PROCESS | 1790 | [#2] audio-dft Cycles:10 Average:312.30 Median:297.00 stddev:46.44 (15.6%) stddev-sans-first:48.97 07:56:18 INFO - PROCESS | 1790 | Values: 298.0 280.0 421.0 305.0 284.0 293.0 372.0 296.0 285.0 289.0 07:56:18 INFO - PROCESS | 1790 | 07:56:18 INFO - PROCESS | 1790 | [#3] audio-fft Cycles:10 Average:140.10 Median:151.00 stddev:27.02 (17.9%) stddev-sans-first:22.99 07:56:18 INFO - PROCESS | 1790 | Values: 186.0 144.0 152.0 168.0 116.0 149.0 123.0 96.0 117.0 150.0 07:56:18 INFO - PROCESS | 1790 | 07:56:18 INFO - PROCESS | 1790 | [#4] audio-oscillator Cycles:10 Average:145.00 Median:151.00 stddev:18.14 (12.0%) stddev-sans-first:17.73 07:56:18 INFO - PROCESS | 1790 | Values: 165.0 121.0 132.0 141.0 168.0 119.0 166.0 151.0 136.0 151.0 07:56:18 INFO - PROCESS | 1790 | 07:56:18 INFO - PROCESS | 1790 | [#5] imaging-gaussian-blur Cycles:10 Average:189.10 Median:196.50 stddev:27.82 (14.2%) stddev-sans-first:29.04 07:56:18 INFO - PROCESS | 1790 | Values: 175.0 157.0 159.0 230.0 219.0 212.0 219.0 181.0 172.0 167.0 07:56:18 INFO - PROCESS | 1790 | 07:56:18 INFO - PROCESS | 1790 | [#6] imaging-darkroom Cycles:10 Average:220.20 Median:227.50 stddev:33.03 (14.5%) stddev-sans-first:33.05 07:56:18 INFO - PROCESS | 1790 | Values: 189.0 288.0 199.0 243.0 172.0 217.0 199.0 228.0 240.0 227.0 07:56:18 INFO - PROCESS | 1790 | 07:56:18 INFO - PROCESS | 1790 | [#7] imaging-desaturate Cycles:10 Average:182.10 Median:195.50 stddev:32.37 (16.6%) stddev-sans-first:32.48 07:56:18 INFO - PROCESS | 1790 | Values: 212.0 154.0 191.0 218.0 157.0 146.0 232.0 200.0 166.0 145.0 07:56:18 INFO - PROCESS | 1790 | 07:56:18 INFO - PROCESS | 1790 | [#8] json-parse-financial Cycles:10 Average:142.20 Median:144.00 stddev:21.06 (14.6%) stddev-sans-first:20.09 07:56:18 INFO - PROCESS | 1790 | Values: 116.0 151.0 150.0 175.0 178.0 128.0 129.0 133.0 124.0 138.0 07:56:18 INFO - PROCESS | 1790 | 07:56:18 INFO - PROCESS | 1790 | [#9] json-stringify-tinderbox Cycles:10 Average:127.40 Median:137.00 stddev:19.93 (14.6%) stddev-sans-first:16.22 07:56:18 INFO - PROCESS | 1790 | Values: 91.0 164.0 143.0 119.0 125.0 120.0 110.0 142.0 132.0 128.0 07:56:18 INFO - PROCESS | 1790 | 07:56:18 INFO - PROCESS | 1790 | [#10] stanford-crypto-aes Cycles:10 Average:176.50 Median:175.50 stddev:26.27 (15.0%) stddev-sans-first:27.79 07:56:18 INFO - PROCESS | 1790 | Values: 182.0 148.0 187.0 169.0 166.0 197.0 238.0 158.0 159.0 161.0 07:56:18 INFO - PROCESS | 1790 | 07:56:18 INFO - PROCESS | 1790 | [#11] stanford-crypto-ccm Cycles:10 Average:281.00 Median:273.00 stddev:48.34 (17.7%) stddev-sans-first:50.97 07:56:18 INFO - PROCESS | 1790 | Values: 266.0 279.0 237.0 242.0 254.0 275.0 271.0 312.0 405.0 269.0 07:56:18 INFO - PROCESS | 1790 | 07:56:18 INFO - PROCESS | 1790 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:334.60 Median:327.50 stddev:31.45 (9.6%) stddev-sans-first:30.92 07:56:18 INFO - PROCESS | 1790 | Values: 301.0 315.0 330.0 363.0 365.0 401.0 325.0 319.0 312.0 315.0 07:56:18 INFO - PROCESS | 1790 | 07:56:18 INFO - PROCESS | 1790 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:114.90 Median:118.50 stddev:6.54 (5.5%) stddev-sans-first:6.93 07:56:18 INFO - PROCESS | 1790 | Values: 114.0 109.0 121.0 123.0 119.0 113.0 110.0 120.0 102.0 118.0 07:56:18 INFO - PROCESS | 1790 | -------- Summary: end -------- 07:56:18 INFO - PROCESS | 1790 | 07:56:19 INFO - TEST-INFO | 1790: exit 0 07:56:19 INFO - TEST-OK | kraken | took 87295ms 07:56:19 INFO - SUITE-END | took 1210s 07:56:19 INFO - Completed test suite (00:20:10) 07:56:19 INFO - javascript benchmark 07:56:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 4371.660650605157, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1386.1267401537034, 1913.880379977713, 1930.9710354344695, 1973.1712680674116, 2010.7486564179478, 3331.2504686445536, 3395.2190996070917, 3400.9489857652093, 3527.2769082338123, 3585.1754096557806, 3351.4805205193234, 3485.477178423238, 3519.8240087995628, 3572.428411454168, 3604.7476676632646, 3019.773516986224, 3049.1919641295076, 3113.1750086227166, 3131.7024882636115, 3150.5274208868736, 2610.5823068309073, 2980.8807647694066, 3069.539569064636, 3130.0766273949125, 3164.193130751655, 2661.2016395081496, 2862.842543660098, 3092.814431134128, 3120.8595613197463, 3140.544621029949, 2469.0, 2620.5938079597695, 2917.854107294648, 2981.9105426837014, 3225.580674512322, 2984.925376865574, 3026.636803583562, 3077.4460597092516, 3098.938021239585, 3190.457622204231, 2995.400919816024, 3365.96634033659, 3426.9828650856584, 3511.6488351164935, 3574.9821250893838, 3486.6861982421706, 3501.3172431375892, 3607.332643460968, 3635.0367152704553, 3722.9627703722886, 3652.1052342176336, 3698.389765688658, 3716.758410703296, 3739.906502337436, 3805.809709514541, 2728.795340349462, 3332.5167850662, 3360.311136217094, 3500.054985153994, 3562.590302115264, 3505.158761897126, 3598.208394153282, 3617.692496137805, 3658.048907284125, 3755.3615885299564, 3437.673421024999, 3548.290341931624, 3600.6039335673054, 3617.6924961378577, 3621.167131559703, 3507.8421471033867, 3525.541679581638, 3610.819459027038, 3614.295212433603, 3640.21735326906, 3533.964660353415, 3554.7511674183074, 3555.1289933965827, 3584.4981702561663, 3622.710183185339, 3024.971509686673, 3514.7363947704025, 3560.1989552350515, 3582.982085089558, 3714.6285371462636, 2778.5137600919757, 2802.7337402946687, 2813.887444502238, 2899.9710002900124, 2960.422717570053, 2467.2721547143638, 2569.614557816305, 2599.3371690218873, 2619.7642212200994, 2643.339165208698, 3519.331327047853, 3561.234334618018, 3603.1172362770762, 3621.6016238213774, 3621.63783621641, 3656.9212082435747, 3664.6518580734787, 3700.6239076636616, 3712.350338690718, 3838.9059118151195, 3374.5444365010408, 3385.7291416686608, 3425.4176789945273, 3479.739019573542, 3557.626449222846, 3139.7331226845517, 3164.240582260241, 3167.3506931079073, 3180.332130252673, 3214.11611806755, 3650.1239702471216, 3674.33861904849, 3848.826802793825, 3855.8264878079995, 3896.123372241223, 3538.5046093546407, 3574.4638304254568, 3591.6408359163875, 3644.526211592476, 3699.482072509905, 3546.2907418515883, 3564.6435356464144, 3716.0524066362905, 3730.1047748540695, 3816.3512202925012, 3165.7467402608195, 3401.608814986308, 3414.965850341465, 3465.9602119363585, 3589.120665436985, 3099.8450077496486, 3540.0264927144212, 3718.3492888744904, 3747.8007037747657, 3758.6993040556144, 3446.827658617009, 3477.217626034122, 3604.7656902301264, 3608.0438683748303, 3658.9023293012524, 3433.5021421893184, 3443.517907492903, 3526.047967048831, 3557.3596752584785, 3638.2541578976775, 2910.5779661949323, 3391.93216135671, 3441.5698037745283, 3453.620101788751, 3477.217626034122, 3347.581552305962, 3413.095529684685, 3527.1005893496995, 3591.2637909228024, 3609.7473176877365, 3268.7875288106197, 3328.8169150696945, 3452.361313157074, 3526.3123690880034, 3536.2927414517712], "value": 3315.148330375257, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [408.74453466583384, 439.6043560795285, 440.4780335302669, 440.6342735529511, 535.6973310079804, 22525.436864078405, 22607.434814129654, 24568.8771556142, 25096.623550646756, 25154.0, 22086.558268834615, 22913.0, 23061.76938230617, 23805.452645578025, 24465.63301550478, 4577.4278215223185, 5912.024515954884, 6165.9075113873105, 6569.310222426648, 6604.768833090843, 5687.687177205252, 6140.508759299268, 6244.000959846426, 6281.811545653638, 6399.8080057598345, 6216.564840461169, 6342.619442833445, 6344.619322840621, 6364.968175159118, 6445.0, 6180.320164781915, 6273.278572964076, 6405.743770249162, 6538.673066346688, 6701.832454188636, 6017.458428741391, 6077.1491991121275, 6116.388361163892, 6170.907436388457, 6241.7191226394925, 19905.0, 19936.601267974704, 20180.39458816238, 20279.37764978798, 20336.389908302775, 2062.8143467087884, 2199.186301068599, 2203.7575866654656, 2220.4781876259067, 2221.5001624634488, 13218.735625287536, 14366.0, 14883.627909302246, 15168.165750883696, 15454.536363909101, 1745.8603311735158, 1791.2834866053552, 1796.8742188046842, 1818.7180986946912, 1902.2010755482731, 192622.0, 195705.0, 197255.0, 197439.0, 200790.0, 21795.782042179693, 22095.226667066574, 23271.06915723386, 24084.759152408602, 25703.48593028129, 20667.79332206689, 27062.5940610891, 27175.86412067927, 27535.760890759964, 28500.28749281243, 8052.872597836307, 8073.6770529178175, 8242.505449673039, 8270.297024752843, 8385.874211886827, 6915.239323674392, 6978.162620485473, 7173.6413179340825, 7241.674124664402, 7417.851642967111, 6811.659417029129, 6832.940894161413, 6868.862622747517, 6890.0, 7035.12060992376, 2518.4585314157544, 3173.4922412413903, 3208.069659798632, 3243.772935894465, 3292.863961933177, 510.9463506331856, 511.215284538232, 516.5557620446413, 540.1088204462668, 567.8608740858516, 12287.69280767988, 13701.492835788054, 15044.699106017819, 16067.116308602905, 16646.50060498187, 521.1193083688554, 544.4065968094717, 596.9134475501115, 602.9638221706712, 630.015154150003, 6811.641026915604, 7332.413406927433, 8140.023197216372, 8215.630296636666, 8507.234348908503, 275916.0, 281841.0, 285787.0, 290401.0, 293367.0, 29298.560521592193, 29866.0, 30078.849605752268, 30260.638271277847, 30729.231769205948, 782.718221440281, 790.1979490816825, 809.6478032056075, 839.4637812802679, 839.5969934431507, 15005.0, 15101.47144849925, 15252.694946100793, 15437.687796536971, 16039.759403609189, 22231.88840557933, 22298.665520017537, 23627.881860591275, 24127.396815079763, 24884.506929584284, 258507.0, 261360.0, 262730.49078036664, 265853.0, 269165.0, 14128.364223609757, 14239.857601423853, 16501.58746031359, 16856.915715421343, 17055.658886822443, 22116.447088822908, 22912.31263062111, 23188.76811231866, 23190.956406961388, 23195.768042320036, 14847.737942275027, 15178.0, 15912.52262432129, 16834.326626934784, 17170.22733976999, 14797.92601036988, 16027.519174424786, 16224.107674078039, 16909.492715218563, 17270.395536156175, 18560.628787424444, 18613.720794188368, 18775.624487510446, 18943.526411839815, 19449.51376215606, 15610.375584976473, 16534.503964881074, 16799.82401231902, 16940.915295423445, 17096.401625943032, 11702.239354441934, 11744.882551174378, 12815.974722022402, 13807.447702091804, 13869.0], "value": 10359.558089943059, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [224.65739746885995, 242.9867452722149, 243.68652960542676, 245.55922119794965, 256.20193098498174, 9431.622735090597, 10188.592456301758, 11569.13231507636, 12615.621531354063, 12853.871461285384, 9710.0, 11730.41347932602, 11851.696313405519, 12044.81932771009, 12346.62960111196, 3301.712332190448, 3505.5442792437075, 3884.281407939526, 3915.0, 3952.4466574679423, 3371.7976921384675, 3753.0, 3827.8468861245515, 3945.881623551298, 3946.3488524393442, 3633.7274704397146, 3835.846566137351, 3863.014931192542, 3919.960800391988, 3947.151362457071, 3738.9439158412647, 3788.4506746521874, 3839.8864329344456, 3898.7718868556312, 3909.6676782473523, 3738.7943663098517, 3750.79370634615, 3806.0, 3895.844166233347, 3907.0, 14619.415223391052, 14838.0, 15035.924820375938, 15195.696086078216, 15279.624833764903, 1596.5529651697543, 1639.8848782827672, 1695.355764809377, 1701.7617533545313, 1821.952377382997, 7539.434542409341, 8888.155625215593, 9392.671256506057, 9637.37357071788, 9661.0, 991.4794732765356, 1158.8874680306915, 1159.321796748903, 1222.4315693202705, 1229.9938500307442, 71139.0, 72000.91998620024, 72039.63980180066, 74814.99999999946, 80116.0, 10803.891961080288, 11180.832287515694, 11408.771824563462, 12027.518899244107, 12583.67871373511, 18353.0, 18428.262869485337, 18610.720839187423, 18797.40222081111, 19123.0, 5981.175741398828, 6105.175801266861, 6108.297545782203, 6166.383361663888, 6381.266154392211, 5119.283300337956, 5160.277561141444, 5194.6104042196985, 5238.685678859204, 5505.889882202334, 5206.219067139959, 5522.972385138129, 5631.802886898939, 5655.0386434306265, 5733.942660573424, 2369.779563524786, 2417.8065754739932, 2440.6095024795945, 2455.484348286844, 2475.4553998120386, 433.8763452416109, 509.49305441085613, 518.3779464642444, 528.1918664443408, 543.804230477028, 9986.600535978625, 10272.794544109076, 10368.189680380276, 11498.770024599462, 12480.438380272728, 519.8310549071567, 527.7282199667175, 535.0129011972904, 535.6545028456624, 576.7779404929132, 5750.712464376765, 5928.347881733006, 6212.81361559154, 6414.64719440426, 6569.868602627921, 375947.0, 405992.0, 439208.0, 450325.0, 454859.0, 90785.0, 92753.07246927444, 93764.0, 94016.0, 94408.52795735978, 654.2933631677777, 696.7422053840112, 700.5411455496658, 722.173111787001, 746.1903834339802, 10840.512176952214, 10967.670969870916, 11302.813204613398, 11462.656120316404, 11489.655310340702, 24959.75040249574, 32303.676963231006, 33532.66467335393, 35440.64559354373, 37366.0, 48788.2681759781, 51854.22218666648, 52800.20799688085, 53593.73203133959, 54127.72936135294, 6159.876802464015, 6488.188976377953, 6699.631520266432, 6843.863122737617, 6950.860982780215, 7477.626118694152, 7763.767086987399, 7766.301032907066, 8279.875801863098, 8334.6666133354, 5909.084091965752, 6195.938040619536, 6397.3282805306635, 6535.509836762357, 6977.33715297046, 5161.948380516147, 5682.5453963681975, 5965.373635768182, 6016.8796624068145, 6807.251202367636, 5639.830805075854, 6447.580907241015, 6560.868782624416, 6566.474682025331, 6612.0, 6013.338532761481, 6886.621235832077, 7305.379042781423, 7339.302766237199, 7926.405519585939, 5468.589855760754, 6642.368974947372, 6805.93194068053, 6973.686184121828, 7162.176349719641], "value": 6570.549627013479, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [893.0266010049045, 900.2392977933644, 913.0686699566443, 918.6049998500646, 928.5635751196937, 5990.341062483123, 6315.747370105202, 6489.967550162249, 6620.337966203378, 6684.699188536521, 6089.147519347284, 6138.0, 6396.6801659917055, 6416.615003099817, 6605.6697165141795, 1188.6434069779075, 1331.5273078057296, 1359.422245545639, 1376.4012654495277, 1385.7090011097682, 1145.7651181507772, 1303.354839354521, 1341.2421981580424, 1359.8776110150084, 1364.1542243808854, 1311.1674086954804, 1341.7718987772103, 1353.3977380065874, 1389.5553422904675, 1390.7149034447964, 1153.4578747988432, 1271.3389037700344, 1347.8989075819304, 1352.7226918481688, 1360.9996652460434, 1119.171812858487, 1124.9818913882948, 1212.8962643994012, 1316.697159653285, 1332.6934804994808, 6253.562250642457, 6292.056191571301, 6351.4283714465455, 6395.456386207178, 6428.19647544057, 2942.3820997590533, 3269.2480729432127, 3278.950815737766, 3329.217633856042, 3380.0197942596865, 1829.2408650410064, 1954.5309125809845, 2034.6134234495398, 2123.9575208495744, 2162.383720639626, 676.4182802789597, 700.4151533469559, 720.204174387305, 724.6811402982671, 735.6763024269304, 6400.871982560323, 7657.46397752152, 8555.743327700178, 8573.52845593492, 8685.305175585938, 2393.4734358441465, 2553.553128202557, 2721.8911243550037, 2819.4783964966546, 2864.269611249118, 5293.867653308621, 6695.631740254235, 6723.495737819683, 7002.509824312351, 7067.505274630829, 3187.7290430313683, 3267.8856240031487, 3332.0670212340583, 3356.446186379269, 3399.354122716725, 3028.651705053947, 3088.336007758298, 3134.702203290684, 3136.168915237464, 3178.364327134536, 2109.7679255281905, 2196.615592271346, 2218.38994276572, 2235.944101397478, 2269.500709843832, 577.1717585265158, 584.7427132061879, 595.9076343166817, 607.4897086447318, 618.3661746709658, 463.36981704881333, 471.8207081309149, 521.0022806325843, 529.4021423933076, 560.6159780550255, 3025.5007923692783, 3570.8214589270433, 3695.371786796251, 3747.3254814133716, 3823.808809559511, 578.5660754434174, 581.6771691711057, 603.8556934608979, 609.8902197604385, 618.9690515474208, 2374.9168779092647, 2376.2871138658334, 2380.535795519857, 2404.3748625357184, 2428.4900170963942, 5929.495992840571, 6718.025886246467, 7155.749548765768, 7549.414622929136, 7582.8246621773715, 6729.49528785343, 7189.784306470814, 7580.0145981023215, 7849.686012559434, 7936.920630793734, 5594.524465420403, 5638.9286035653095, 5793.0, 5857.033589457692, 5920.407959204045, 3557.4485954676034, 3728.8626968774784, 3747.587765345755, 3862.0537968197973, 3874.4769456123063, 5886.911696324644, 6925.688344024632, 6936.4797640176175, 6965.895511567229, 6970.407515361251, 6563.212414510289, 6901.412675084658, 6916.1700595926795, 7268.9823424721635, 7444.776656700307, 4113.341865301538, 4450.777461126995, 4755.643326750576, 4762.714237145782, 5093.71984540839, 5876.707124432618, 5890.705464726832, 5929.762809487745, 5963.2844058713235, 6036.456718895321, 4489.820407183676, 4535.138323718483, 4642.53574642533, 4671.85984420468, 4940.60475161979, 4754.976225118852, 4917.0903382874285, 5036.194208926554, 5124.538791508782, 5137.255098010843, 4484.1255955088445, 4525.932111018403, 4603.401557797465, 4625.7918393673035, 4657.93013104797, 3299.5875515560556, 3301.257217126127, 3331.9167020824675, 3375.780574262665, 3433.1073920781278, 3291.8683252670585, 3391.3386889557287, 3412.590489141319, 3457.498662693946, 3514.262004978983], "value": 2883.472214573811, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [195.52097361464416, 205.08736124247096, 215.71525586226178, 219.71327417719877, 223.7929914828783, 2558.9508301596347, 2837.3187337965633, 2876.1084063940193, 3014.1259034879886, 3084.984575077124, 2438.9878200546796, 2667.0, 3009.1574359179463, 3077.3076057886965, 3134.899617256438, 2156.1698745982753, 2445.902163913441, 2544.6946366436055, 2544.73280305568, 2637.3406648337914, 2203.327984964585, 2224.1992882562263, 2377.6552399902002, 2419.854808711474, 2639.0895141176265, 2075.361566897982, 2247.3482690019873, 2431.817613678981, 2469.5798117844524, 2524.4853088147147, 2513.5726926422462, 2517.8363406378526, 2536.7716905478505, 2573.5882258838683, 2587.611858221263, 1878.7933327333983, 1884.8869067855971, 2109.641360968639, 2141.6252155872817, 2269.9558203226534, 2909.418116376733, 2935.354222071141, 2998.0, 3059.6175478065243, 3097.938041239185, 2789.9721002789915, 2827.7313655202724, 2844.7155284471596, 2912.286489809989, 2918.6059881916094, 3151.558781770554, 3222.822744749038, 3279.770416070876, 3296.9449776071665, 3339.682730140633, 2131.1155870313955, 2138.6474877634478, 2418.8548687078833, 2600.3499125218696, 2613.1768492924666, 3053.6258683592473, 3062.647795503501, 3200.999999999977, 3261.445554255735, 3525.2244506208594, 2350.518143780521, 2385.081743528719, 2552.5788244939376, 2608.856512891809, 2625.0, 2490.9750902491105, 2529.4941011797714, 2769.418422131335, 2829.3209629689136, 2841.9857900710363, 2890.4363649088227, 2900.825950442938, 2933.8557962394684, 2987.5668028135797, 3044.558539011831, 2938.2654336415894, 3018.2795806390145, 3248.6101667800017, 3265.8856940006985, 3324.750643701732, 801.5951944268107, 825.3479750996765, 861.5519929636554, 897.2149369301861, 931.6971984105193, 631.3907079668143, 673.0678010954863, 682.0315152483486, 708.7632082016811, 734.7575300150937, 3021.6827233140643, 3031.317953460498, 3111.315510587667, 3158.867764259116, 3165.382750363657, 3078.8601921664676, 3371.0727003041184, 3382.8139452330356, 3388.661133886641, 3431.588209414886, 2689.7041325454184, 3060.877564897379, 3133.498640217554, 3180.0, 3305.603327600655, 1519.5365413548973, 1592.7849740284914, 1641.663458990928, 1743.747156662277, 1753.65803668286, 3253.9511907321407, 3449.842031972966, 3498.6676265754713, 3581.5881173664843, 3613.8193090345903, 2949.056301983345, 3064.004198635452, 3397.2695870387984, 3427.520147179397, 3552.9644703552635, 3233.3533293341425, 3358.5465962094804, 3406.982965085159, 3593.4969104325937, 3597.1906321078072, 2977.925551861221, 3271.869125235059, 3310.0, 3347.113015051062, 3354.3731290323685, 2776.8889244429997, 2805.793508791239, 3121.4392803598203, 3133.3000499251125, 3150.480170771889, 3060.403221371811, 3095.860686269168, 3401.234722187488, 3410.522526846194, 3691.686206672463, 2152.806247437738, 2303.96544051836, 2625.750553697396, 2638.8812503437007, 2668.613051107617, 2942.189864126005, 2996.3557835065567, 3265.770826779279, 3285.7207137392634, 3515.384807658598, 2723.7470763449037, 2867.0, 2987.2830520675316, 3056.3276079262528, 3264.8857289994735, 2765.893642542999, 3094.520349345855, 3140.1473130852905, 3207.9198020049685, 3221.3557288541915, 2921.4887394706266, 2928.985355073211, 2967.703229677015, 3132.3108916038436, 3159.7472202224226, 3069.4935335669365, 3222.468292731673, 3238.7732858699665, 3287.375398674244, 3365.192353835111, 2999.565063065887, 3014.6533148687304, 3086.5430717596437, 3117.4856148735203, 3146.4267866066966], "value": 2474.8847948943294, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [441.20582950688754, 471.38955053206075, 484.5735752537767, 490.35763150273146, 491.5625093666636, 8205.548694821782, 9123.908760912389, 9144.579328531707, 9330.86003709944, 9745.51272436377, 8623.91376086239, 8695.260902823251, 8695.304375649948, 8848.955755221215, 8953.328500362466, 472.36231088031053, 505.93675790526186, 558.7429782300147, 561.2339157050617, 563.821612829187, 429.99140017199636, 439.229152836771, 502.65316931317454, 533.6131304804024, 593.4658807073625, 573.1946615005924, 578.1558923970987, 579.7622974580423, 589.1104432307226, 598.9580729348947, 558.2435799491711, 572.6764378126345, 573.8450618333047, 582.4175824175824, 589.6373730155966, 414.3784323514728, 435.6427729262006, 438.2680922858833, 438.49135003396225, 442.03636073360065, 9273.304502162366, 9438.858417123749, 9750.561224744904, 9782.657606983721, 9818.45998470084, 7710.113336966265, 7983.361331093499, 8410.621522031523, 8573.099824518398, 8741.825163496758, 6431.774887878902, 6753.358430949101, 6807.2512023677355, 6859.485538584626, 7209.711611535532, 2537.9492410151693, 2546.1724939394585, 2574.871256437171, 2623.8950441982297, 2675.598660200966, 58341.7912014839, 60131.0, 60506.697466512385, 61194.999999999556, 61471.0, 5125.948740512622, 5961.897049045941, 6131.478824299985, 6325.58883672569, 6339.714712837934, 12125.151239413333, 12146.696332591757, 12515.874841251652, 12697.111202215941, 12761.61715148547, 4246.617804397619, 4330.610245077958, 4361.433013708198, 4487.935549647199, 4590.219662657356, 2486.0, 2491.3522484153887, 2514.3085651446, 2546.427053912892, 2578.600316950876, 1977.7725561560605, 1990.0945069993118, 2003.0986056274735, 2016.9092390842447, 2022.5044864008412, 339.4772051041418, 360.1428599932197, 370.75900664567706, 373.43424711562005, 375.6844250829316, 304.30921807496856, 323.559958456499, 354.68255910959545, 416.6895662731224, 421.26699542795313, 5722.0, 6059.545534084873, 6114.724837382329, 6570.342965703391, 6710.396064354231, 317.4349657609459, 327.190204244493, 327.44171188124193, 420.3820384035463, 443.90456051948985, 2727.6044973478733, 2741.369485018457, 2958.423107494018, 3065.065155127663, 3088.3977624363483, 58117.70941145267, 59937.201883943555, 61529.0, 61921.69039154775, 63416.04875926865, 40916.79541602273, 42160.57839421628, 44382.55895925691, 52201.0, 52809.73595132, 43619.4733184337, 43924.0, 45361.09277814425, 45387.54612453899, 46564.53435465738, 4590.793414296431, 5202.687838729688, 5561.915426491957, 5609.719514024364, 5881.7647294107755, 28541.857290714244, 28731.5690264642, 29278.7072129276, 29814.85092574523, 31663.20841978969, 36096.09759756027, 36677.63322366849, 37354.8132259337, 38291.0, 38486.965105669784, 6153.876922461615, 6522.60505875335, 6525.771597994238, 6582.3746744059235, 7090.751823686146, 7483.027206463125, 7667.961660191663, 7985.361171106414, 8132.430729848854, 8201.507909525448, 5897.823065308047, 7134.678939447841, 7341.375983041287, 7426.517276377018, 7628.694852206072, 7076.504644675029, 7205.855882882418, 7301.488895777245, 7357.816054598464, 7381.446391520765, 6852.903535434307, 6969.30306969299, 7105.609191494311, 7354.8896766549615, 7405.333519983227, 5201.271821945006, 5296.364436267672, 5488.670679759227, 5529.640573362719, 5643.858903527444, 5535.892821435648, 5575.2473416088305, 5647.548196144381, 5922.703864806656, 6360.268569114611], "value": 4334.038543240949, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 2849.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [279.0, 308.0, 218.0, 224.0, 220.0, 223.0, 302.0, 229.0, 229.0, 220.0], "value": 245.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [220.0, 242.0, 205.0, 287.0, 277.0, 221.0, 203.0, 227.0, 265.0, 238.0], "value": 238.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [298.0, 280.0, 421.0, 305.0, 284.0, 293.0, 372.0, 296.0, 285.0, 289.0], "value": 312.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 144.0, 152.0, 168.0, 116.0, 149.0, 123.0, 96.0, 117.0, 150.0], "value": 140.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 121.0, 132.0, 141.0, 168.0, 119.0, 166.0, 151.0, 136.0, 151.0], "value": 145.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 157.0, 159.0, 230.0, 219.0, 212.0, 219.0, 181.0, 172.0, 167.0], "value": 189.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 288.0, 199.0, 243.0, 172.0, 217.0, 199.0, 228.0, 240.0, 227.0], "value": 220.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [212.0, 154.0, 191.0, 218.0, 157.0, 146.0, 232.0, 200.0, 166.0, 145.0], "value": 182.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 151.0, 150.0, 175.0, 178.0, 128.0, 129.0, 133.0, 124.0, 138.0], "value": 142.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 164.0, 143.0, 119.0, 125.0, 120.0, 110.0, 142.0, 132.0, 128.0], "value": 127.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 148.0, 187.0, 169.0, 166.0, 197.0, 238.0, 158.0, 159.0, 161.0], "value": 176.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [266.0, 279.0, 237.0, 242.0, 254.0, 275.0, 271.0, 312.0, 405.0, 269.0], "value": 281.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [301.0, 315.0, 330.0, 363.0, 365.0, 401.0, 325.0, 319.0, 312.0, 315.0], "value": 334.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 109.0, 121.0, 123.0, 119.0, 113.0, 110.0, 120.0, 102.0, 118.0], "value": 114.9, "unit": "score"}]}]} 07:56:19 INFO - Return code: 0 07:56:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:56:19 ERROR - # TBPL SUCCESS # 07:56:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:56:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:56:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:56:19 INFO - 2017-05-05 07:56:19.989 screenresolution[1803:11017] starting screenresolution argv=screenresolution get 07:56:19 INFO - 2017-05-05 07:56:19.994 screenresolution[1803:11017] Display 0: 1600x1200x32@60 07:56:20 INFO - 2017-05-05 07:56:20.004 screenresolution[1804:11020] starting screenresolution argv=screenresolution list 07:56:20 INFO - Available Modes on Display 0 07:56:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:56:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:56:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:56:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:56:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:56:20 INFO - Intel Iris: 07:56:20 INFO - Chipset Model: Intel Iris 07:56:20 INFO - Type: GPU 07:56:20 INFO - Bus: Built-In 07:56:20 INFO - VRAM (Dynamic, Max): 1536 MB 07:56:20 INFO - Vendor: Intel (0x8086) 07:56:20 INFO - Device ID: 0x0a2e 07:56:20 INFO - Revision ID: 0x0009 07:56:20 INFO - Displays: 07:56:20 INFO - Display: 07:56:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:56:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:56:20 INFO - Display Serial Number: 1600x1200 60 07:56:20 INFO - Main Display: Yes 07:56:20 INFO - Mirror: Off 07:56:20 INFO - Online: Yes 07:56:20 INFO - Rotation: Supported 07:56:20 INFO - Return code: 0 07:56:20 INFO - Running post-action listener: _resource_record_post_action 07:56:20 INFO - [mozharness: 2017-05-05 14:56:20.349127Z] Finished run-tests step (success) 07:56:20 INFO - Running post-run listener: _resource_record_post_run 07:56:20 INFO - Total resource usage - Wall time: 1238s; CPU: 56.0%; Read bytes: 34856960; Write bytes: 431071744; Read time: 239; Write time: 1586 07:56:20 INFO - TinderboxPrint: CPU usage
55.6% 07:56:20 INFO - TinderboxPrint: I/O read bytes / time
34,856,960 / 239 07:56:20 INFO - TinderboxPrint: I/O write bytes / time
431,071,744 / 1,586 07:56:20 INFO - TinderboxPrint: CPU idle
2,198.7 (44.4%) 07:56:20 INFO - TinderboxPrint: CPU system
1,020.2 (20.6%) 07:56:20 INFO - TinderboxPrint: CPU user
1,731.7 (35.0%) 07:56:20 INFO - TinderboxPrint: Swap in / out
152,281,088 / 0 07:56:20 INFO - install - Wall time: 26s; CPU: 55.0%; Read bytes: 121702912; Write bytes: 117557248; Read time: 20010; Write time: 262 07:56:20 INFO - run-tests - Wall time: 1212s; CPU: 56.0%; Read bytes: 32862208; Write bytes: 303778304; Read time: 217; Write time: 1291 07:56:21 INFO - Running post-run listener: _upload_blobber_files 07:56:21 INFO - Blob upload gear active. 07:56:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:56:21 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:56:21 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:56:21 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:56:21 INFO - (blobuploader) - INFO - Open directory for files ... 07:56:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:56:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:56:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:56:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:56:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:56:22 INFO - (blobuploader) - INFO - Done attempting. 07:56:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:56:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:56:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:56:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:56:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:56:23 INFO - (blobuploader) - INFO - Done attempting. 07:56:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:56:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:56:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:56:24 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:56:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:56:24 INFO - (blobuploader) - INFO - Done attempting. 07:56:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:56:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:56:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:56:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:56:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:56:27 INFO - (blobuploader) - INFO - Done attempting. 07:56:27 INFO - (blobuploader) - INFO - Iteration through files over. 07:56:27 INFO - Return code: 0 07:56:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:56:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:56:27 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b3a16e21db53b59916b4092e3ad75cc823e974e051391639f186676c0bf5d91b2cbf514f6aa21972ef9f8e919f83350292fb30839e506e6a2c53bdbeaf9b2574", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/493f5c6d4bef5d930f8aff3a336119e3ce93d93024931d78d7d5f05e3b65850969dfb52b461f8d04855d4a1676c22a082d23df3c9ca918e2d6719ccabad2586d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/35426f685019e59646c6cb6af959459f23361337cb21d896669d8c46e05f549c6760cbe366bb13f0a6f05099a4a8a2a7176d4b2c49e8e0d812f32bad1719feb3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6769ceffc3faf5f5080ceda01fc82869d2b7c6c2cb57d100056b7ce9a433455e9ae1843f45dda949539792078fbb1123b0666e9dc992c59b0da7f160eb15e40b"} 07:56:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:56:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:56:27 INFO - Contents: 07:56:27 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b3a16e21db53b59916b4092e3ad75cc823e974e051391639f186676c0bf5d91b2cbf514f6aa21972ef9f8e919f83350292fb30839e506e6a2c53bdbeaf9b2574", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/493f5c6d4bef5d930f8aff3a336119e3ce93d93024931d78d7d5f05e3b65850969dfb52b461f8d04855d4a1676c22a082d23df3c9ca918e2d6719ccabad2586d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/35426f685019e59646c6cb6af959459f23361337cb21d896669d8c46e05f549c6760cbe366bb13f0a6f05099a4a8a2a7176d4b2c49e8e0d812f32bad1719feb3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6769ceffc3faf5f5080ceda01fc82869d2b7c6c2cb57d100056b7ce9a433455e9ae1843f45dda949539792078fbb1123b0666e9dc992c59b0da7f160eb15e40b"} 07:56:27 INFO - Running post-run listener: copy_logs_to_upload_dir 07:56:27 INFO - Copying logs to upload dir... 07:56:27 INFO - mkdir: /builds/slave/test/build/upload/logs 07:56:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1358.448340 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 22 mins, 38 secs) (at 2017-05-05 07:56:26.736194) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-05 07:56:26.740027) ========= 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.BCpef8XTb0/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.KB1qiY2iNa/Listeners TMPDIR=/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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-Beta/sha512/b3a16e21db53b59916b4092e3ad75cc823e974e051391639f186676c0bf5d91b2cbf514f6aa21972ef9f8e919f83350292fb30839e506e6a2c53bdbeaf9b2574", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/493f5c6d4bef5d930f8aff3a336119e3ce93d93024931d78d7d5f05e3b65850969dfb52b461f8d04855d4a1676c22a082d23df3c9ca918e2d6719ccabad2586d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/35426f685019e59646c6cb6af959459f23361337cb21d896669d8c46e05f549c6760cbe366bb13f0a6f05099a4a8a2a7176d4b2c49e8e0d812f32bad1719feb3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6769ceffc3faf5f5080ceda01fc82869d2b7c6c2cb57d100056b7ce9a433455e9ae1843f45dda949539792078fbb1123b0666e9dc992c59b0da7f160eb15e40b"} build_url:https://queue.taskcluster.net/v1/task/d72vUU-VRIeapEWp6qrLlg/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.017035 build_url: 'https://queue.taskcluster.net/v1/task/d72vUU-VRIeapEWp6qrLlg/artifacts/public/build/firefox-54.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b3a16e21db53b59916b4092e3ad75cc823e974e051391639f186676c0bf5d91b2cbf514f6aa21972ef9f8e919f83350292fb30839e506e6a2c53bdbeaf9b2574", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/493f5c6d4bef5d930f8aff3a336119e3ce93d93024931d78d7d5f05e3b65850969dfb52b461f8d04855d4a1676c22a082d23df3c9ca918e2d6719ccabad2586d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/35426f685019e59646c6cb6af959459f23361337cb21d896669d8c46e05f549c6760cbe366bb13f0a6f05099a4a8a2a7176d4b2c49e8e0d812f32bad1719feb3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6769ceffc3faf5f5080ceda01fc82869d2b7c6c2cb57d100056b7ce9a433455e9ae1843f45dda949539792078fbb1123b0666e9dc992c59b0da7f160eb15e40b"}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-05 07:56:26.794979) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 07:56:26.795328) ========= 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.BCpef8XTb0/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.KB1qiY2iNa/Listeners TMPDIR=/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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.007676 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 07:56:26.846984) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-05 07:56:26.847379) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-05 07:56:26.847752) ========= ========= Total master_lag: 0.21 =========