builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0241 starttime: 1490260224.13 results: success (0) buildid: 20170323004002 builduid: 0d386e2a9e554889a232dd48e591b7a4 revision: cd04c51ec1d7080ea856ef28f73456cf427d4758 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-23 02:10:24.127132) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-23 02:10:24.127581) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-23 02:10:24.127864) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-23 02:10:24.153969) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 02:10:24.154288) ========= 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.zCJcj5fX54/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.ihyEqUkPZ5/Listeners TMPDIR=/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-23 02:10:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 29.5M=0s 2017-03-23 02:10:24 (29.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.168272 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 02:10:24.346457) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 02:10:24.346764) ========= 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.zCJcj5fX54/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.ihyEqUkPZ5/Listeners TMPDIR=/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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.032536 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 02:10:24.402381) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-23 02:10:24.402860) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev cd04c51ec1d7080ea856ef28f73456cf427d4758 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev cd04c51ec1d7080ea856ef28f73456cf427d4758 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.zCJcj5fX54/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.ihyEqUkPZ5/Listeners TMPDIR=/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-23 02:10:24,662 truncating revision to first 12 chars 2017-03-23 02:10:24,662 Setting DEBUG logging. 2017-03-23 02:10:24,662 attempt 1/10 2017-03-23 02:10:24,662 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/cd04c51ec1d7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-23 02:10:25,980 unpacking tar archive at: mozilla-aurora-cd04c51ec1d7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.680701 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-23 02:10:26.109856) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-23 02:10:26.110446) ========= script_repo_revision: cd04c51ec1d7080ea856ef28f73456cf427d4758 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-23 02:10:26.111074) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-23 02:10:26.111551) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-23 02:10:26.132563) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-03-23 02:10:26.132958) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.zCJcj5fX54/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.ihyEqUkPZ5/Listeners TMPDIR=/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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 02:10:26 INFO - MultiFileLogger online at 20170323 02:10:26 in /builds/slave/test 02:10:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:10:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:10:26 INFO - {'append_to_log': False, 02:10:26 INFO - 'base_work_dir': '/builds/slave/test', 02:10:26 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:10:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:10:26 INFO - 'branch': 'Mozilla-Aurora', 02:10:26 INFO - 'buildbot_json_path': 'buildprops.json', 02:10:26 INFO - 'config_files': ('talos/mac_config.py',), 02:10:26 INFO - 'default_actions': ('clobber', 02:10:26 INFO - 'read-buildbot-config', 02:10:26 INFO - 'download-and-extract', 02:10:26 INFO - 'populate-webroot', 02:10:26 INFO - 'create-virtualenv', 02:10:26 INFO - 'install', 02:10:26 INFO - 'run-tests'), 02:10:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:10:26 INFO - 'download_minidump_stackwalk': True, 02:10:26 INFO - 'download_symbols': 'ondemand', 02:10:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:10:26 INFO - 'tooltool.py': '/tools/tooltool.py', 02:10:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:10:26 INFO - '/tools/misc-python/virtualenv.py')}, 02:10:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:10:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:10:26 INFO - 'gecko_profile': False, 02:10:26 INFO - 'gecko_profile_interval': 0, 02:10:26 INFO - 'installer_path': 'installer.exe', 02:10:26 INFO - 'log_level': 'info', 02:10:26 INFO - 'log_name': 'talos', 02:10:26 INFO - 'log_to_console': True, 02:10:26 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:10:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:10:26 INFO - 'opt_config_files': (), 02:10:26 INFO - 'pip_index': False, 02:10:26 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:10:26 INFO - 'cmd': ('bash', 02:10:26 INFO - '-c', 02:10:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:10:26 INFO - 'enabled': True, 02:10:26 INFO - 'halt_on_failure': False, 02:10:26 INFO - 'name': 'check_screen_resolution'},), 02:10:26 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:10:26 INFO - 'cmd': ('bash', 02:10:26 INFO - '-c', 02:10:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:10:26 INFO - 'enabled': True, 02:10:26 INFO - 'halt_on_failure': False, 02:10:26 INFO - 'name': 'check_screen_resolution'},), 02:10:26 INFO - 'run_cmd_checks_enabled': True, 02:10:26 INFO - 'suite': 'dromaeojs-e10s', 02:10:26 INFO - 'system_bits': '32', 02:10:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:10:26 INFO - 'title': 't-yosemite-r7-0241', 02:10:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:10:26 INFO - 'use_talos_json': True, 02:10:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:10:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:10:26 INFO - 'work_dir': 'build'} 02:10:26 INFO - [mozharness: 2017-03-23 09:10:26.497504Z] Running clobber step. 02:10:26 INFO - Running pre-action listener: _resource_record_pre_action 02:10:26 INFO - Running main action method: clobber 02:10:26 INFO - rmtree: /builds/slave/test/build 02:10:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:10:28 INFO - Running post-action listener: _resource_record_post_action 02:10:28 INFO - [mozharness: 2017-03-23 09:10:28.976815Z] Finished clobber step (success) 02:10:28 INFO - [mozharness: 2017-03-23 09:10:28.977414Z] Running read-buildbot-config step. 02:10:28 INFO - Running pre-action listener: _resource_record_pre_action 02:10:28 INFO - Running main action method: read_buildbot_config 02:10:28 INFO - Using buildbot properties: 02:10:28 INFO - { 02:10:28 INFO - "project": "", 02:10:28 INFO - "product": "firefox", 02:10:28 INFO - "script_repo_revision": "production", 02:10:28 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 02:10:28 INFO - "repository": "", 02:10:28 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 02:10:28 INFO - "buildid": "20170323004002", 02:10:28 INFO - "stage_platform": "macosx64", 02:10:28 INFO - "basedir": "/builds/slave/test", 02:10:28 INFO - "nightly_build": "True", 02:10:28 INFO - "buildnumber": 3, 02:10:28 INFO - "slavename": "t-yosemite-r7-0241", 02:10:28 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 02:10:28 INFO - "platform": "yosemite_r7", 02:10:28 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:10:28 INFO - "branch": "mozilla-aurora", 02:10:28 INFO - "repo_path": "releases/mozilla-aurora", 02:10:28 INFO - "revision": "cd04c51ec1d7080ea856ef28f73456cf427d4758", 02:10:28 INFO - "pgo_build": "False", 02:10:28 INFO - "builduid": "0d386e2a9e554889a232dd48e591b7a4", 02:10:28 INFO - "slavebuilddir": "test" 02:10:28 INFO - } 02:10:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/V9QZeFUpQFG9jrSQWTOApg/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 02:10:28 INFO - Running post-action listener: _resource_record_post_action 02:10:28 INFO - [mozharness: 2017-03-23 09:10:28.985278Z] Finished read-buildbot-config step (success) 02:10:28 INFO - [mozharness: 2017-03-23 09:10:28.985441Z] Running download-and-extract step. 02:10:28 INFO - Running pre-action listener: _resource_record_pre_action 02:10:28 INFO - Running main action method: download_and_extract 02:10:28 INFO - mkdir: /builds/slave/test/build/tests 02:10:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:10:28 INFO - trying https://queue.taskcluster.net/v1/task/V9QZeFUpQFG9jrSQWTOApg/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 02:10:28 INFO - Downloading https://queue.taskcluster.net/v1/task/V9QZeFUpQFG9jrSQWTOApg/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 02:10:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/V9QZeFUpQFG9jrSQWTOApg/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json'}, attempt #1 02:10:30 INFO - Downloaded 1199 bytes. 02:10:30 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 02:10:30 INFO - Using the following test package requirements: 02:10:30 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 02:10:30 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:10:30 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 02:10:30 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:10:30 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 02:10:30 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:10:30 INFO - u'jsshell-mac.zip'], 02:10:30 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:10:30 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 02:10:30 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 02:10:30 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:10:30 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 02:10:30 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:10:30 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 02:10:30 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:10:30 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 02:10:30 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:10:30 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 02:10:30 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:10:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/V9QZeFUpQFG9jrSQWTOApg/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 02:10:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/V9QZeFUpQFG9jrSQWTOApg/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:10:30 INFO - Fetch https://queue.taskcluster.net/v1/task/V9QZeFUpQFG9jrSQWTOApg/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 02:10:32 INFO - Expected file size: 51782384 02:10:32 INFO - Obtained file size: 51782384 02:10:47 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip', u'firefox-54.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:10:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/V9QZeFUpQFG9jrSQWTOApg/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 02:10:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/V9QZeFUpQFG9jrSQWTOApg/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:10:47 INFO - Fetch https://queue.taskcluster.net/v1/task/V9QZeFUpQFG9jrSQWTOApg/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 02:10:49 INFO - Expected file size: 51782384 02:10:49 INFO - Obtained file size: 51782384 02:11:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/V9QZeFUpQFG9jrSQWTOApg/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 02:11:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/V9QZeFUpQFG9jrSQWTOApg/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:11:04 INFO - Fetch https://queue.taskcluster.net/v1/task/V9QZeFUpQFG9jrSQWTOApg/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 02:11:05 INFO - Expected file size: 14404438 02:11:05 INFO - Obtained file size: 14404438 02:11:05 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')]} 02:11:05 INFO - trying https://queue.taskcluster.net/v1/task/V9QZeFUpQFG9jrSQWTOApg/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 02:11:05 INFO - Downloading https://queue.taskcluster.net/v1/task/V9QZeFUpQFG9jrSQWTOApg/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 02:11:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/V9QZeFUpQFG9jrSQWTOApg/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg'}, attempt #1 02:11:08 INFO - Downloaded 74817182 bytes. 02:11:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/V9QZeFUpQFG9jrSQWTOApg/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 02:11:08 INFO - mkdir: /builds/slave/test/properties 02:11:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:11:08 INFO - Writing to file /builds/slave/test/properties/build_url 02:11:08 INFO - Contents: 02:11:08 INFO - build_url:https://queue.taskcluster.net/v1/task/V9QZeFUpQFG9jrSQWTOApg/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 02:11:09 INFO - Running post-action listener: _resource_record_post_action 02:11:09 INFO - Running post-action listener: set_extra_try_arguments 02:11:09 INFO - [mozharness: 2017-03-23 09:11:09.321421Z] Finished download-and-extract step (success) 02:11:09 INFO - [mozharness: 2017-03-23 09:11:09.321544Z] Running populate-webroot step. 02:11:09 INFO - Running pre-action listener: _resource_record_pre_action 02:11:09 INFO - Running main action method: populate_webroot 02:11:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:11:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:11:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:11:09 INFO - '--tppagecycles', 02:11:09 INFO - '7'], 02:11:09 INFO - 'tests': ['tsvgm']}}, 02:11:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:11:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:11:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:11:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:11:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:11:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:11:09 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:11:09 INFO - 'talos_options': ['--disable-e10s'], 02:11:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:11:09 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:11:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:11:09 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:11:09 INFO - 'talos_options': ['--disable-e10s'], 02:11:09 INFO - 'tests': ['damp', 'tps']}, 02:11:09 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:11:09 INFO - 'tests': ['damp', 'tps']}, 02:11:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:11:09 INFO - 'tests': ['dromaeo_dom']}, 02:11:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:11:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:11:09 INFO - 'tests': ['basic_compositor_video']}, 02:11:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:11:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:11:09 INFO - 'tests': ['a11yr', 02:11:09 INFO - 'ts_paint', 02:11:09 INFO - 'tpaint', 02:11:09 INFO - 'sessionrestore', 02:11:09 INFO - 'sessionrestore_no_auto_restore', 02:11:09 INFO - 'tabpaint']}, 02:11:09 INFO - 'other-e10s': {'tests': ['a11yr', 02:11:09 INFO - 'ts_paint', 02:11:09 INFO - 'tpaint', 02:11:09 INFO - 'sessionrestore', 02:11:09 INFO - 'sessionrestore_no_auto_restore', 02:11:09 INFO - 'tabpaint']}, 02:11:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:11:09 INFO - 'ts_paint', 02:11:09 INFO - 'tpaint', 02:11:09 INFO - 'sessionrestore', 02:11:09 INFO - 'sessionrestore_no_auto_restore', 02:11:09 INFO - 'tabpaint']}, 02:11:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:11:09 INFO - 'ts_paint', 02:11:09 INFO - 'tpaint', 02:11:09 INFO - 'sessionrestore', 02:11:09 INFO - 'sessionrestore_no_auto_restore', 02:11:09 INFO - 'tabpaint']}, 02:11:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:11:09 INFO - 'tests': ['a11yr', 02:11:09 INFO - 'ts_paint', 02:11:09 INFO - 'tpaint', 02:11:09 INFO - 'sessionrestore', 02:11:09 INFO - 'sessionrestore_no_auto_restore', 02:11:09 INFO - 'tabpaint']}, 02:11:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:11:09 INFO - 'tests': ['a11yr', 02:11:09 INFO - 'ts_paint', 02:11:09 INFO - 'tpaint', 02:11:09 INFO - 'sessionrestore', 02:11:09 INFO - 'sessionrestore_no_auto_restore', 02:11:09 INFO - 'tabpaint']}, 02:11:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:11:09 INFO - 'tests': ['tsvgx', 02:11:09 INFO - 'tsvgr_opacity', 02:11:09 INFO - 'tart', 02:11:09 INFO - 'tscrollx', 02:11:09 INFO - 'cart', 02:11:09 INFO - 'tsvg_static']}, 02:11:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:11:09 INFO - 'tsvgr_opacity', 02:11:09 INFO - 'tart', 02:11:09 INFO - 'tscrollx', 02:11:09 INFO - 'cart', 02:11:09 INFO - 'tsvg_static']}, 02:11:09 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:11:09 INFO - 'talos_options': ['--disable-e10s'], 02:11:09 INFO - 'tests': ['tp5o']}, 02:11:09 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:11:09 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:11:09 INFO - 'talos_options': ['--disable-e10s', 02:11:09 INFO - '--xperf_path', 02:11:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:11:09 INFO - 'tests': ['tp5n']}, 02:11:09 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:11:09 INFO - 'talos_options': ['--xperf_path', 02:11:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:11:09 INFO - 'tests': ['tp5n']}}, 02:11:09 INFO - 'talos.zip': {'path': '', 02:11:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:11:09 INFO - Running post-action listener: _resource_record_post_action 02:11:09 INFO - [mozharness: 2017-03-23 09:11:09.339780Z] Finished populate-webroot step (success) 02:11:09 INFO - [mozharness: 2017-03-23 09:11:09.339895Z] Running create-virtualenv step. 02:11:09 INFO - Running pre-action listener: _resource_record_pre_action 02:11:09 INFO - Running main action method: create_virtualenv 02:11:09 INFO - Creating virtualenv /builds/slave/test/build/venv 02:11:09 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 02:11:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:11:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:11:09 INFO - Using real prefix '/tools/python27' 02:11:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:11:10 INFO - Installing distribute.............................................................................................................................................................................................done. 02:11:13 INFO - Installing pip.................done. 02:11:13 INFO - Return code: 0 02:11:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:11:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:11:13 INFO - Reading from file tmpfile_stdout 02:11:13 INFO - Output received: 02:11:13 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) 02:11:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:11:13 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')]} 02:11:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:11:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:13 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')]} 02:11:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:11:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:13 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 0x10308eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103091768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5cb4949a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e6cd30>, '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 0x102d93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102e61be8>, '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.zCJcj5fX54/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.ihyEqUkPZ5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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 02:11:13 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 02:11:13 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 02:11:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zCJcj5fX54/Render', 02:11:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:11:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:11:13 INFO - 'HOME': '/Users/cltbld', 02:11:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:11:13 INFO - 'LOGNAME': 'cltbld', 02:11:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:11:13 INFO - 'MOZ_NO_REMOTE': '1', 02:11:13 INFO - 'NO_EM_RESTART': '1', 02:11:13 INFO - 'PAGER': '/bin/cat', 02:11:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:11:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:11:13 INFO - 'PWD': '/builds/slave/test', 02:11:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:11:13 INFO - 'SHELL': '/bin/bash', 02:11:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ihyEqUkPZ5/Listeners', 02:11:13 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 02:11:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:11:13 INFO - 'USER': 'cltbld', 02:11:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:11:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:11:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:11:13 INFO - 'XPC_FLAGS': '0x0', 02:11:13 INFO - 'XPC_SERVICE_NAME': '0', 02:11:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:11:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:11:13 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 02:11:13 INFO - Cleaning up... 02:11:13 INFO - Return code: 0 02:11:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:11:13 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')]} 02:11:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:11:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:13 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')]} 02:11:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:11:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:13 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 0x10308eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103091768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5cb4949a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e6cd30>, '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 0x102d93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102e61be8>, '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.zCJcj5fX54/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.ihyEqUkPZ5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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 02:11:13 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 02:11:13 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 02:11:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zCJcj5fX54/Render', 02:11:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:11:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:11:13 INFO - 'HOME': '/Users/cltbld', 02:11:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:11:13 INFO - 'LOGNAME': 'cltbld', 02:11:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:11:13 INFO - 'MOZ_NO_REMOTE': '1', 02:11:13 INFO - 'NO_EM_RESTART': '1', 02:11:13 INFO - 'PAGER': '/bin/cat', 02:11:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:11:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:11:13 INFO - 'PWD': '/builds/slave/test', 02:11:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:11:13 INFO - 'SHELL': '/bin/bash', 02:11:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ihyEqUkPZ5/Listeners', 02:11:13 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 02:11:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:11:13 INFO - 'USER': 'cltbld', 02:11:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:11:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:11:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:11:13 INFO - 'XPC_FLAGS': '0x0', 02:11:13 INFO - 'XPC_SERVICE_NAME': '0', 02:11:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:11:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:11:13 INFO - Downloading/unpacking psutil>=3.1.1 02:11:13 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 02:11:13 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 02:11:13 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 02:11:13 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 02:11:13 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 02:11:13 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 02:11:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:11:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:11:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:11:17 INFO - Installing collected packages: psutil 02:11:17 INFO - Running setup.py install for psutil 02:11:17 INFO - building 'psutil._psutil_osx' extension 02:11:17 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 02:11:18 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 02:11:18 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 02:11:18 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 02:11:18 INFO - building 'psutil._psutil_posix' extension 02:11:18 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 02:11:18 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:11:18 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:11:18 INFO - ^ 02:11:18 INFO - 1 warning generated. 02:11:18 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 02:11:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:11:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:11:18 INFO - Successfully installed psutil 02:11:18 INFO - Cleaning up... 02:11:18 INFO - Return code: 0 02:11:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:11:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:11:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:11:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:11:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10308eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103091768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5cb4949a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e6cd30>, '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 0x102d93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102e61be8>, '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.zCJcj5fX54/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.ihyEqUkPZ5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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 02:11:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:11:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:11:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zCJcj5fX54/Render', 02:11:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:11:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:11:18 INFO - 'HOME': '/Users/cltbld', 02:11:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:11:18 INFO - 'LOGNAME': 'cltbld', 02:11:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:11:18 INFO - 'MOZ_NO_REMOTE': '1', 02:11:18 INFO - 'NO_EM_RESTART': '1', 02:11:18 INFO - 'PAGER': '/bin/cat', 02:11:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:11:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:11:18 INFO - 'PWD': '/builds/slave/test', 02:11:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:11:18 INFO - 'SHELL': '/bin/bash', 02:11:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ihyEqUkPZ5/Listeners', 02:11:18 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 02:11:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:11:18 INFO - 'USER': 'cltbld', 02:11:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:11:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:11:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:11:18 INFO - 'XPC_FLAGS': '0x0', 02:11:18 INFO - 'XPC_SERVICE_NAME': '0', 02:11:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:11:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:11:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:11: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 02:11: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 02:11: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 02:11: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 02:11: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 02:11: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 02:11:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:11:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:11:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:11:22 INFO - Installing collected packages: mozsystemmonitor 02:11:22 INFO - Running setup.py install for mozsystemmonitor 02:11:22 INFO - Successfully installed mozsystemmonitor 02:11:22 INFO - Cleaning up... 02:11:22 INFO - Return code: 0 02:11:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:11:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:11:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:11:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:11:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:11:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10308eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103091768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5cb4949a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e6cd30>, '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 0x102d93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102e61be8>, '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.zCJcj5fX54/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.ihyEqUkPZ5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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 02:11:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:11:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:11:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zCJcj5fX54/Render', 02:11:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:11:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:11:23 INFO - 'HOME': '/Users/cltbld', 02:11:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:11:23 INFO - 'LOGNAME': 'cltbld', 02:11:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:11:23 INFO - 'MOZ_NO_REMOTE': '1', 02:11:23 INFO - 'NO_EM_RESTART': '1', 02:11:23 INFO - 'PAGER': '/bin/cat', 02:11:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:11:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:11:23 INFO - 'PWD': '/builds/slave/test', 02:11:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:11:23 INFO - 'SHELL': '/bin/bash', 02:11:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ihyEqUkPZ5/Listeners', 02:11:23 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 02:11:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:11:23 INFO - 'USER': 'cltbld', 02:11:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:11:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:11:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:11:23 INFO - 'XPC_FLAGS': '0x0', 02:11:23 INFO - 'XPC_SERVICE_NAME': '0', 02:11:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:11:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:11:23 INFO - Downloading/unpacking jsonschema==2.5.1 02:11: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 02:11: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 02:11: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 02:11: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 02:11: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 02:11: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 02:11:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:11:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:11:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:11:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:11:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:11:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:11:27 INFO - Downloading functools32-3.2.3-2.tar.gz 02:11:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:11:27 INFO - warning: no files found matching '*.txt' 02:11:27 INFO - no previously-included directories found matching 'build' 02:11:27 INFO - no previously-included directories found matching 'dist' 02:11:27 INFO - no previously-included directories found matching '.git*' 02:11:27 INFO - Installing collected packages: jsonschema, functools32 02:11:27 INFO - Running setup.py install for functools32 02:11:27 INFO - warning: no files found matching '*.txt' 02:11:27 INFO - no previously-included directories found matching 'build' 02:11:27 INFO - no previously-included directories found matching 'dist' 02:11:27 INFO - no previously-included directories found matching '.git*' 02:11:27 INFO - Successfully installed jsonschema functools32 02:11:27 INFO - Cleaning up... 02:11:27 INFO - Return code: 0 02:11:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:11:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:11:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:11:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:11:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:11:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10308eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103091768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5cb4949a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e6cd30>, '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 0x102d93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102e61be8>, '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.zCJcj5fX54/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.ihyEqUkPZ5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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 02:11:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:11:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:11:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zCJcj5fX54/Render', 02:11:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:11:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:11:27 INFO - 'HOME': '/Users/cltbld', 02:11:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:11:27 INFO - 'LOGNAME': 'cltbld', 02:11:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:11:27 INFO - 'MOZ_NO_REMOTE': '1', 02:11:27 INFO - 'NO_EM_RESTART': '1', 02:11:27 INFO - 'PAGER': '/bin/cat', 02:11:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:11:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:11:27 INFO - 'PWD': '/builds/slave/test', 02:11:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:11:27 INFO - 'SHELL': '/bin/bash', 02:11:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ihyEqUkPZ5/Listeners', 02:11:27 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 02:11:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:11:27 INFO - 'USER': 'cltbld', 02:11:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:11:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:11:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:11:27 INFO - 'XPC_FLAGS': '0x0', 02:11:27 INFO - 'XPC_SERVICE_NAME': '0', 02:11:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:11:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:11:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:11:27 INFO - Cleaning up... 02:11:27 INFO - Return code: 0 02:11:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:11:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:11:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:11:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:11:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:11:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10308eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103091768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5cb4949a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e6cd30>, '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 0x102d93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102e61be8>, '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.zCJcj5fX54/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.ihyEqUkPZ5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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 02:11:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:11:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:11:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zCJcj5fX54/Render', 02:11:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:11:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:11:27 INFO - 'HOME': '/Users/cltbld', 02:11:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:11:27 INFO - 'LOGNAME': 'cltbld', 02:11:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:11:27 INFO - 'MOZ_NO_REMOTE': '1', 02:11:27 INFO - 'NO_EM_RESTART': '1', 02:11:27 INFO - 'PAGER': '/bin/cat', 02:11:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:11:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:11:27 INFO - 'PWD': '/builds/slave/test', 02:11:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:11:27 INFO - 'SHELL': '/bin/bash', 02:11:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ihyEqUkPZ5/Listeners', 02:11:27 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 02:11:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:11:27 INFO - 'USER': 'cltbld', 02:11:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:11:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:11:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:11:27 INFO - 'XPC_FLAGS': '0x0', 02:11:27 INFO - 'XPC_SERVICE_NAME': '0', 02:11:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:11:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:11:28 INFO - Downloading/unpacking blobuploader==1.2.4 02:11:28 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 02:11:28 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 02:11:28 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 02:11:28 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 02:11:28 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 02:11:28 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 02:11:31 INFO - Downloading blobuploader-1.2.4.tar.gz 02:11:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:11:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:11:32 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 02:11:32 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 02:11:32 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 02:11:32 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 02:11:32 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 02:11:32 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 02:11:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:11:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:11:32 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 02:11:32 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 02:11:32 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 02:11:32 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 02:11:32 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 02:11:32 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 02:11:33 INFO - Downloading docopt-0.6.1.tar.gz 02:11:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:11:33 INFO - Installing collected packages: blobuploader, requests, docopt 02:11:33 INFO - Running setup.py install for blobuploader 02:11:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:11:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:11:33 INFO - Running setup.py install for requests 02:11:33 INFO - Running setup.py install for docopt 02:11:34 INFO - Successfully installed blobuploader requests docopt 02:11:34 INFO - Cleaning up... 02:11:34 INFO - Return code: 0 02:11:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:11:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:11:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:11:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:11:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:11:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:34 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 0x10308eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103091768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5cb4949a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e6cd30>, '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 0x102d93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102e61be8>, '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.zCJcj5fX54/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.ihyEqUkPZ5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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 02:11:34 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 02:11:34 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 02:11:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zCJcj5fX54/Render', 02:11:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:11:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:11:34 INFO - 'HOME': '/Users/cltbld', 02:11:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:11:34 INFO - 'LOGNAME': 'cltbld', 02:11:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:11:34 INFO - 'MOZ_NO_REMOTE': '1', 02:11:34 INFO - 'NO_EM_RESTART': '1', 02:11:34 INFO - 'PAGER': '/bin/cat', 02:11:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:11:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:11:34 INFO - 'PWD': '/builds/slave/test', 02:11:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:11:34 INFO - 'SHELL': '/bin/bash', 02:11:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ihyEqUkPZ5/Listeners', 02:11:34 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 02:11:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:11:34 INFO - 'USER': 'cltbld', 02:11:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:11:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:11:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:11:34 INFO - 'XPC_FLAGS': '0x0', 02:11:34 INFO - 'XPC_SERVICE_NAME': '0', 02:11:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:11:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:11:34 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-Qk4mrD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:11:34 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-QdGkTF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:11:34 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-EN1yfg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:11:34 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-HBtCKx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:11:34 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-N_lBjw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:11:34 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-9oRxua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:11:35 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-ErKRwE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:11:35 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-l8xRvc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:11:35 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-REca2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:11:35 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-E2D3st-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:11:35 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-RnFoVS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:11:35 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-ZctE5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:11:35 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-gxZV4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:11:35 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-W1dz0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:11:35 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-g3vx15-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:11:36 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-_3s7vw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:11:36 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-3NV2A2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:11:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:11:36 INFO - Running setup.py install for manifestparser 02:11:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:11:36 INFO - Running setup.py install for mozcrash 02:11:36 INFO - Running setup.py install for mozdebug 02:11:36 INFO - Running setup.py install for mozdevice 02:11:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:11:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:11:36 INFO - Running setup.py install for mozfile 02:11:36 INFO - Running setup.py install for mozhttpd 02:11:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:11:37 INFO - Running setup.py install for mozinfo 02:11:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:11:37 INFO - Running setup.py install for mozInstall 02:11:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:11:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:11:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:11:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:11:37 INFO - Running setup.py install for mozleak 02:11:37 INFO - Running setup.py install for mozlog 02:11:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:11:37 INFO - Running setup.py install for moznetwork 02:11:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:11:37 INFO - Running setup.py install for mozprocess 02:11:38 INFO - Running setup.py install for mozprofile 02:11:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:11:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:11:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:11:38 INFO - Running setup.py install for mozrunner 02:11:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:11:38 INFO - Running setup.py install for mozscreenshot 02:11:38 INFO - Running setup.py install for moztest 02:11:38 INFO - Running setup.py install for mozversion 02:11:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:11:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:11:38 INFO - Cleaning up... 02:11:38 INFO - Return code: 0 02:11:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:11:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:11:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:11:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:11:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:11:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:38 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 0x10308eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103091768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5cb4949a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e6cd30>, '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 0x102d93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102e61be8>, '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.zCJcj5fX54/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.ihyEqUkPZ5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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 02:11:38 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 02:11:38 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 02:11:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zCJcj5fX54/Render', 02:11:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:11:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:11:38 INFO - 'HOME': '/Users/cltbld', 02:11:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:11:38 INFO - 'LOGNAME': 'cltbld', 02:11:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:11:38 INFO - 'MOZ_NO_REMOTE': '1', 02:11:38 INFO - 'NO_EM_RESTART': '1', 02:11:38 INFO - 'PAGER': '/bin/cat', 02:11:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:11:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:11:38 INFO - 'PWD': '/builds/slave/test', 02:11:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:11:38 INFO - 'SHELL': '/bin/bash', 02:11:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ihyEqUkPZ5/Listeners', 02:11:38 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 02:11:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:11:38 INFO - 'USER': 'cltbld', 02:11:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:11:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:11:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:11:38 INFO - 'XPC_FLAGS': '0x0', 02:11:38 INFO - 'XPC_SERVICE_NAME': '0', 02:11:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:11:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:11:39 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-dGNWPm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:11:39 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)) 02:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:11:39 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-wZtYTV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:11:39 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)) 02:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:11:39 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-b_4LX3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:11:39 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)) 02:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:11:39 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-WYHAVc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:11:39 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)) 02:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:11:39 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-x90cKu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:11:39 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)) 02:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:11:39 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-qbbiQM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:11:39 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)) 02:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:11:39 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-K4ziKc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:11:39 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)) 02:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:11:39 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-h5ZzYp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:11:39 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)) 02:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:11:39 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-NxpITr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:11:40 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)) 02:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:11:40 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-Dpxy1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:11:40 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)) 02:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:11:40 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-eLQnxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:11:40 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)) 02:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:11:40 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-PViqre-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:11:40 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)) 02:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:11:40 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-jbzmMP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:11:40 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)) 02:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:11:40 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-udYMCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:11:40 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)) 02:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:11:40 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-4hKGf8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:11:40 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)) 02:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:11:40 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-sWay32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:11:40 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)) 02:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:11:40 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-M3QD6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:11:40 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)) 02:11:40 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)) 02:11:40 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)) 02:11:40 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)) 02:11:40 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)) 02:11:40 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)) 02:11:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:11:40 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 02:11:40 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 02:11:40 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 02:11:40 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 02:11:40 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 02:11:40 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 02:11:43 INFO - Downloading blessings-1.6.tar.gz 02:11:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:11:43 INFO - Installing collected packages: blessings 02:11:43 INFO - Running setup.py install for blessings 02:11:43 INFO - Successfully installed blessings 02:11:43 INFO - Cleaning up... 02:11:43 INFO - Return code: 0 02:11:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:11:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:11:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:11:44 INFO - Reading from file tmpfile_stdout 02:11:44 INFO - Current package versions: 02:11:44 INFO - blessings == 1.6 02:11:44 INFO - blobuploader == 1.2.4 02:11:44 INFO - docopt == 0.6.1 02:11:44 INFO - functools32 == 3.2.3-2 02:11:44 INFO - jsonschema == 2.5.1 02:11:44 INFO - manifestparser == 1.1 02:11:44 INFO - mozInstall == 1.12 02:11:44 INFO - mozcrash == 1.0 02:11:44 INFO - mozdebug == 0.1 02:11:44 INFO - mozdevice == 0.49 02:11:44 INFO - mozfile == 1.2 02:11:44 INFO - mozhttpd == 0.7 02:11:44 INFO - mozinfo == 0.9 02:11:44 INFO - mozleak == 0.1 02:11:44 INFO - mozlog == 3.4 02:11:44 INFO - moznetwork == 0.27 02:11:44 INFO - mozprocess == 0.25 02:11:44 INFO - mozprofile == 0.28 02:11:44 INFO - mozrunner == 6.13 02:11:44 INFO - mozscreenshot == 0.1 02:11:44 INFO - mozsystemmonitor == 0.3 02:11:44 INFO - moztest == 0.8 02:11:44 INFO - mozversion == 1.4 02:11:44 INFO - psutil == 3.1.1 02:11:44 INFO - requests == 1.2.3 02:11:44 INFO - wsgiref == 0.1.2 02:11:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:11:44 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')]} 02:11:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:11:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:44 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')]} 02:11:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:11:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:44 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 0x10308eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103091768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5cb4949a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e6cd30>, '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 0x102d93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102e61be8>, '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.zCJcj5fX54/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.ihyEqUkPZ5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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 02:11:44 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 02:11:44 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 02:11:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zCJcj5fX54/Render', 02:11:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:11:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:11:44 INFO - 'HOME': '/Users/cltbld', 02:11:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:11:44 INFO - 'LOGNAME': 'cltbld', 02:11:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:11:44 INFO - 'MOZ_NO_REMOTE': '1', 02:11:44 INFO - 'NO_EM_RESTART': '1', 02:11:44 INFO - 'PAGER': '/bin/cat', 02:11:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:11:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:11:44 INFO - 'PWD': '/builds/slave/test', 02:11:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:11:44 INFO - 'SHELL': '/bin/bash', 02:11:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ihyEqUkPZ5/Listeners', 02:11:44 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 02:11:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:11:44 INFO - 'USER': 'cltbld', 02:11:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:11:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:11:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:11:44 INFO - 'XPC_FLAGS': '0x0', 02:11:44 INFO - 'XPC_SERVICE_NAME': '0', 02:11:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:11:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:11:44 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)) 02:11:44 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)) 02:11:44 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)) 02:11:44 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)) 02:11:44 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)) 02:11:44 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)) 02:11:44 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)) 02:11:44 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)) 02:11:44 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)) 02:11:44 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)) 02:11:44 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)) 02:11:44 INFO - Cleaning up... 02:11:44 INFO - Return code: 0 02:11:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:11:44 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')]} 02:11:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:11:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:44 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')]} 02:11:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:11:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:44 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 0x10308eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103091768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5cb4949a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e6cd30>, '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 0x102d93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102e61be8>, '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.zCJcj5fX54/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.ihyEqUkPZ5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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 02:11:44 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 02:11:44 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 02:11:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zCJcj5fX54/Render', 02:11:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:11:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:11:44 INFO - 'HOME': '/Users/cltbld', 02:11:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:11:44 INFO - 'LOGNAME': 'cltbld', 02:11:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:11:44 INFO - 'MOZ_NO_REMOTE': '1', 02:11:44 INFO - 'NO_EM_RESTART': '1', 02:11:44 INFO - 'PAGER': '/bin/cat', 02:11:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:11:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:11:44 INFO - 'PWD': '/builds/slave/test', 02:11:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:11:44 INFO - 'SHELL': '/bin/bash', 02:11:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ihyEqUkPZ5/Listeners', 02:11:44 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 02:11:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:11:44 INFO - 'USER': 'cltbld', 02:11:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:11:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:11:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:11:44 INFO - 'XPC_FLAGS': '0x0', 02:11:44 INFO - 'XPC_SERVICE_NAME': '0', 02:11:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:11:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:11:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:11:44 INFO - Cleaning up... 02:11:44 INFO - Return code: 0 02:11:44 INFO - Running post-action listener: _resource_record_post_action 02:11:44 INFO - Running post-action listener: _start_resource_monitoring 02:11:44 INFO - Starting resource monitoring. 02:11:44 INFO - [mozharness: 2017-03-23 09:11:44.644677Z] Finished create-virtualenv step (success) 02:11:44 INFO - [mozharness: 2017-03-23 09:11:44.645587Z] Running install step. 02:11:44 INFO - Running pre-action listener: _resource_record_pre_action 02:11:44 INFO - Running main action method: install 02:11:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:11:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:11:44 INFO - Reading from file tmpfile_stdout 02:11:44 INFO - Detecting whether we're running mozinstall >=1.0... 02:11:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:11:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:11:45 INFO - Reading from file tmpfile_stdout 02:11:45 INFO - Output received: 02:11:45 INFO - Usage: mozinstall [options] installer 02:11:45 INFO - Options: 02:11:45 INFO - -h, --help show this help message and exit 02:11:45 INFO - -d DEST, --destination=DEST 02:11:45 INFO - Directory to install application into. [default: 02:11:45 INFO - "/builds/slave/test"] 02:11:45 INFO - --app=APP Application being installed. [default: firefox] 02:11:45 INFO - mkdir: /builds/slave/test/build/application 02:11:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:11:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:12:05 INFO - Reading from file tmpfile_stdout 02:12:05 INFO - Output received: 02:12:05 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:12:05 INFO - Running post-action listener: _resource_record_post_action 02:12:05 INFO - [mozharness: 2017-03-23 09:12:05.621544Z] Finished install step (success) 02:12:05 INFO - [mozharness: 2017-03-23 09:12:05.621708Z] Running run-tests step. 02:12:05 INFO - Running pre-action listener: _resource_record_pre_action 02:12:05 INFO - Running main action method: run_tests 02:12:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:12:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:12:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:12:05 INFO - 2017-03-23 02:12:05.636 screenresolution[1629:7563] starting screenresolution argv=screenresolution get 02:12:05 INFO - 2017-03-23 02:12:05.638 screenresolution[1629:7563] Display 0: 1600x1200x32@60 02:12:05 INFO - 2017-03-23 02:12:05.644 screenresolution[1630:7565] starting screenresolution argv=screenresolution list 02:12:05 INFO - Available Modes on Display 0 02:12:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:12:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:12:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:12:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:12:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:12:05 INFO - Intel Iris: 02:12:05 INFO - Chipset Model: Intel Iris 02:12:05 INFO - Type: GPU 02:12:05 INFO - Bus: Built-In 02:12:05 INFO - VRAM (Dynamic, Max): 1536 MB 02:12:05 INFO - Vendor: Intel (0x8086) 02:12:05 INFO - Device ID: 0x0a2e 02:12:05 INFO - Revision ID: 0x0009 02:12:05 INFO - Displays: 02:12:05 INFO - Display: 02:12:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:12:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:12:05 INFO - Display Serial Number: 1600x1200 60 02:12:05 INFO - Main Display: Yes 02:12:05 INFO - Mirror: Off 02:12:05 INFO - Online: Yes 02:12:05 INFO - Rotation: Supported 02:12:05 INFO - Return code: 0 02:12:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:12:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:12:05 INFO - Python 2.7.3 02:12:05 INFO - Return code: 0 02:12:05 INFO - grabbing minidump binary from tooltool 02:12:05 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')]} 02:12:05 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 0x102e6cd30>, '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 0x102d93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102e61be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:12:05 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 02:12:05 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 02:12:05 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 02:12:05 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:12:06 INFO - Return code: 0 02:12:06 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:12:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:12:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:12:06 INFO - ENV: RUST_BACKTRACE is now 1 02:12:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:12:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:12:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/V9QZeFUpQFG9jrSQWTOApg/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0241', '--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 02:12:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/V9QZeFUpQFG9jrSQWTOApg/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0241 --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 02:12:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zCJcj5fX54/Render', 02:12:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:12:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:12:06 INFO - 'HOME': '/Users/cltbld', 02:12:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:12:06 INFO - 'LOGNAME': 'cltbld', 02:12:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:12:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:12:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:06 INFO - 'MOZ_NO_REMOTE': '1', 02:12:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:12:06 INFO - 'NO_EM_RESTART': '1', 02:12:06 INFO - 'PAGER': '/bin/cat', 02:12:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:12:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:06 INFO - 'PWD': '/builds/slave/test', 02:12:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:12:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:12:06 INFO - 'RUST_BACKTRACE': '1', 02:12:06 INFO - 'SHELL': '/bin/bash', 02:12:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ihyEqUkPZ5/Listeners', 02:12:06 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 02:12:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:12:06 INFO - 'USER': 'cltbld', 02:12:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:12:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:12:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:06 INFO - 'XPC_FLAGS': '0x0', 02:12:06 INFO - 'XPC_SERVICE_NAME': '0', 02:12:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:12:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/V9QZeFUpQFG9jrSQWTOApg/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0241', '--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 02:12:06 INFO - mozversion application_buildid: 20170323004002 02:12:06 INFO - mozversion application_changeset: cd04c51ec1d7080ea856ef28f73456cf427d4758 02:12:06 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:12:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:12:06 INFO - mozversion application_name: Firefox 02:12:06 INFO - mozversion application_remotingname: firefox-dev 02:12:06 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:12:06 INFO - mozversion application_vendor: Mozilla 02:12:06 INFO - mozversion application_version: 54.0a2 02:12:06 INFO - mozversion platform_buildid: 20170323004002 02:12:06 INFO - mozversion platform_changeset: cd04c51ec1d7080ea856ef28f73456cf427d4758 02:12:06 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:12:06 INFO - mozversion platform_version: 54.0a2 02:12:06 INFO - using testdate: 1490260326 02:12:06 INFO - actual date: 1490260326 02:12:06 INFO - starting webserver on 'localhost:49248' 02:12:06 INFO - SUITE-START | Running 2 tests 02:12:06 INFO - TEST-START | dromaeo_css 02:12:06 INFO - operating with platform_type : mac_ 02:12:06 INFO - Initialising browser for dromaeo_css test... 02:12:06 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/tmpPmGecE/profile http://localhost:49248/getInfo.html) 02:12:09 INFO - PROCESS | 1640 | 2017-03-23 02:12:09.583 plugin-container[1643:7752] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x903f, name = 'com.apple.tsm.portname' 02:12:09 INFO - PROCESS | 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:12:09 INFO - PROCESS | 1640 | 2017-03-23 02:12:09.584 plugin-container[1643:7752] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x960b, name = 'com.apple.CFPasteboardClient' 02:12:09 INFO - PROCESS | 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:12:09 INFO - PROCESS | 1640 | 2017-03-23 02:12:09.584 plugin-container[1643:7752] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:12:09 INFO - PROCESS | 1640 | __metrics Screen width/height:1600/1200 02:12:09 INFO - PROCESS | 1640 | colorDepth:24 02:12:09 INFO - PROCESS | 1640 | Browser inner width/height: 1024/689 02:12:09 INFO - PROCESS | 1640 | __metrics 02:12:09 ERROR - PROCESS | 1640 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 02:12:10 INFO - TEST-INFO | 1640: exit 0 02:12:10 INFO - Browser initialized. 02:12:10 INFO - Running cycle 1/1 for dromaeo_css test... 02:12:10 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/tmpPmGecE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:12:12 INFO - PROCESS | 1644 | 2017-03-23 02:12:12.974 plugin-container[1645:7890] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 02:12:12 INFO - PROCESS | 1644 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:12:12 INFO - PROCESS | 1644 | 2017-03-23 02:12:12.977 plugin-container[1645:7890] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0f, name = 'com.apple.CFPasteboardClient' 02:12:12 INFO - PROCESS | 1644 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:12:12 INFO - PROCESS | 1644 | 2017-03-23 02:12:12.977 plugin-container[1645:7890] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:12:22 INFO - PROCESS | 1644 | RSS: Main: 221073408 02:12:22 INFO - PROCESS | 1644 | 02:15:26 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49248/tests/dromaeo/cssquery-ext.html) 02:15:27 INFO - PROCESS | 1644 | RSS: Main: 241958912 02:15:27 INFO - PROCESS | 1644 | 02:17:10 INFO - PROCESS | 1644 | ************************* 02:17:10 INFO - PROCESS | 1644 | A coding exception was thrown and uncaught in a Task. 02:17:10 INFO - PROCESS | 1644 | 02:17:10 ERROR - PROCESS | 1644 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:17:10 INFO - PROCESS | 1644 | Full stack: 02:17:10 INFO - PROCESS | 1644 | ************************* 02:18:29 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-ext.html (next: http://localhost:49248/tests/dromaeo/cssquery-jquery.html) 02:18:30 INFO - PROCESS | 1644 | RSS: Main: 250806272 02:18:30 INFO - PROCESS | 1644 | 02:21:32 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49248/tests/dromaeo/cssquery-mootools.html) 02:21:33 INFO - PROCESS | 1644 | RSS: Main: 257245184 02:21:33 INFO - PROCESS | 1644 | 02:24:35 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49248/tests/dromaeo/cssquery-prototype.html) 02:24:35 INFO - PROCESS | 1644 | RSS: Main: 254668800 02:24:35 INFO - PROCESS | 1644 | 02:27:38 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49248/tests/dromaeo/cssquery-yui.html) 02:27:39 INFO - PROCESS | 1644 | RSS: Main: 260497408 02:27:39 INFO - PROCESS | 1644 | 02:30:42 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-yui.html (next: http://localhost:49248/tests/dromaeo/cssquery-dojo.html) 02:30:42 INFO - PROCESS | 1644 | RSS: Main: 256622592 02:30:42 INFO - PROCESS | 1644 | 02:30:42 INFO - PROCESS | 1644 | __start_tp_report 02:30:42 INFO - PROCESS | 1644 | _x_x_mozilla_page_load 02:30:42 INFO - PROCESS | 1644 | _x_x_mozilla_page_load_details 02:30:42 INFO - PROCESS | 1644 | |i|pagename|runs| 02:30:42 INFO - PROCESS | 1644 | |0;dojo.html;3503.7372197085224;3507.281007393484;3527.171114788024;3533.540639716837;3541.8760343387953;5905.202797622314;5971.37300583439;6030.909536356959;6091.634501929876;6114.663693496856;6073.089036644495;6106.755729770804;6140.508759299257;6148.784792532262;6167.7532898684;5215.243789650498;5446.863828404292;5491.368492623339;5509.752061157257;5570.442955704438;4781.832635857746;5465.9180112298145;5537.750801213955;5580.330360356763;5632.183333416652;5338.813141540047;5339.519443250107;5535;5570.885822835429;5578.191162281467;5477.75350109244;5487;5558.666480011212;5608.887822243573;5625.071863142576;4441.75570343631;5458.235846981426;5504.91742623861;5508.4491550845;5545.944540554583;5753.8561535961935;6117.847053823645;6141.078838174265;6197.225346831646;6205.8138255851945;5343.946560534423;6281.528885333572;6301.779437719703;6312.274088479791;6359.523035772289;6575.112359831457;6602.075709400688;6609.438197753197;6612.272650008544;6617.636030018347;6217.6891155442045;6237;6262.624242545417;6279.686015699197;6284.402981716729;6395.936040639627;6402.263739669997;6584.275729669733;6673.733050677918;6756.527043107034;6345.936540634627;6391.265004524446;6398.168238129107;6408.967955160288;6418.358164183638;6424.582402143846;6482.643454609947;6532.934670653328;6549.541532092803;6571.737130514822;6196.504279657616;6249.375062493714;6463.644499552475;6484.902726459107;6490.643014634241;6193.256809182927;6370.331115232926;6380.330065343165;6380.489560835122;6428.292887782341;5158.509941555546;5201.011807756514;5202.557782588447;5224.738763061831;5243.2659427680155;4589.701669391479;4601;4611.677182597186;4642.744649044335;4672.182368085571;6065.3934606539;6122.908156377658;6141.508679305734;6247.9062814057825;6273.027680709497;6461.838454038687;6468.094466774655;6530.738770449224;6548.1814773153355;6555.3772391622715;6233.750649974041;6255.718492667841;6256.655883926428;6267.9373206268265;6280.403361680633;5574.442555744393;5807.303123625107;5809.448102430262;5817.912731309034;5826.854328641733;5566.693831839126;6607.339266073451;6669.166354205724;6742.393184613408;6743.9325606743305;5454.4272851351625;6482.54622176462;6581.605103693793;6592.571482853599;6600.702968366339;6786.796396108125;6799.184097908283;6828.351306625863;6849.075374824335;6860.108185935996;6226.750929962751;6259.217597800275;6271.498280137669;6320.620762754065;6423.42189202974;5120.692758434506;5458.6724796512335;6530.379613936669;6530.67346632657;6552.6723663817575;6315.115883776183;6332.240131184288;6340.302566717565;6351.587146835441;6368.4586810121655;6129.264488261437;6134.436587033385;6187.597806142587;6263.749450021948;6330.778422755181;5800.39095894925;6118.010103775157;6141.148492690724;6239.875202496016;6256.249250090018;6210.720517576629;6301.936980630135;6350.079238510482;6366.045093235866;6384.45732112757;6184.907226391698;6194.535409844189;6199.907001395073;6242;6266.498680105672 02:30:42 INFO - PROCESS | 1644 | |1;ext.html;736.7163641997832;801.0987638906231;820.3683163963747;958.3004406783052;962.5331714118647;38215.808920955395;39031;39090.60909390905;39106;39141.60858391419;37790.8110459448;38037;38080.23839523215;38087;38165.42751858725;7790.143084260741;7948.9602551987155;10462.424566648831;10735.570577176943;10911.83632245517;10547.63083292085;10625.84061239082;10655.946720266427;10659.84010239847;10669.946650266776;10655.946720266427;10666.466676666136;10687.946560267188;10696.304740191863;10707.678769636923;10634.734131646732;10643.733906652356;10647.09499692527;10664.840027399596;10666.14670826332;10333.844992325121;10341.224408169417;10346.327488713285;10379.584816607327;10397.376157430503;32495.512567311274;32660;32734.508982365285;32786.672133278604;33168.3366332672;3668.669819716238;3749.1189570450924;3751.4747935289083;3756.1736417988272;3806.352920003606;24865.378365540826;25044.749552504425;25222.369440763945;25992.8700356497;26086.086986955364;3035.878564857403;3059.143439836849;3149.889753858627;3238.25520130369;3264.853081611333;364928;367209;367490;368403;368419;43353.34969975453;43401.565984340385;43465.56534434678;43532.56467435285;43560.56439435565;44885;44947.87630309203;45112;45115;45247.32129018068;13438.529651462151;13744.518941836988;13761.036727428984;13777.380017899219;13825;11784.705382365339;11963.64109076729;11975.161738678209;11983.46074426653;12054.095942804324;10989.890101099047;11531;11544.480498377594;11585.76828463426;11637.767244655059;4717.481077081518;5492.368377636623;5500.972495137578;5544.22380866679;5551.3893471718075;1080.864891888514;1105.2760441910561;1113.4154568851256;1129.5538262386312;1166.7141550320057;21039.579208416053;26919.057832976145;27068.323291917466;27186.184414467596;27768.861155694092;1003.8092762375126;1184.1474138620351;1196.9222000569935;1216.3735676126803;1254.4668515880714;13678.247696376795;13757.646301295346;13839.54684758086;13912.956528260422;13978.44086236539;397087.0145649311;478337;478411;479348;479565;46083;47273.527264726916;54891.45108548943;54905.72547137239;55054.44945550493;1195.5038658956435;1350.4058214385639;1373.6291201375773;1384.7715127004133;1385.25888649572;25162.748372516042;25506.489870202862;25515.48969020572;25932;26098.60852087182;39125;39240.803795980835;39320.80339598398;39331.80334098311;39368.80315598518;448232;452710;453935;454404;454915;27820.86089569539;27936.022239222344;27991.580126297715;28075.29811754641;28080.29799255035;35378.64621353857;35829.82085089558;36356.81821590875;36438.72464463731;36728;30075.548866766578;30141;30513.93201237946;31053;31123.688763112987;29343.559846601893;29392.55911161377;29616.703832962256;29704.70295297106;30133.794648213825;30314.545281821232;30362.84818575893;30899.382012360078;30918.536221956238;31002;23867.52264954726;25945.740542594333;27721.306967325978;28283.292917677223;28410.590729111813;16299.348026078824;18982.810171898105;20735;21176.669551635536;21349.46626334354 02:30:42 INFO - PROCESS | 1644 | |2;jquery.html;368.38847513128206;386.05609285297453;404.215821306665;408.16530195749726;449.3260109835247;19503.41489755306;20768.68846967297;20770.85760283184;20962.895185524052;21277.57444851102;21292.680609790867;21527.892360538215;21583.892080539576;22161.889190554066;22296.8885155574;6180.84547886302;6453.838654033663;6479.287278399373;6490.707918143671;6521.152250207467;6084.391560843902;6306.558540902139;6338.429541341278;6388.680565971683;6396.200474940632;6346.460550853183;6350.920343541609;6362.172917520716;6364.809055728336;6376.872462550747;6196.4423201911595;6273.968630156843;6309.621422714652;6406.327335629739;6412.166418365629;6200.844978875519;6231.4391704746795;6260.718267677966;6279;6303.684815759194;22591.661125083137;26043.479130417287;26060;26222.86888565564;26372.60441093385;2971.628546431696;3308.768386212966;3319.0374791310733;3352.6312105668358;3374.3588718143474;15514.298547686802;15682.451114211062;16132;16613.00321980685;16828.07445590492;1748.4754573627988;1790.2123065851115;1986.970195447055;1987.7316562264054;2009.5880344529337;98771;116763;121750.78249217483;121838.56322873493;125107.37446312801;19908.800911990984;20697.758134511976;21914.671279930815;22448.551028979327;22521.973022427734;33485;33811.4928276076;33976;34070;34082.82958585191;8772.429792063496;10589.523471443803;10606.15150787935;10808.135349172047;10914.945425272823;7708;8497.150284971576;8766.868496972551;8813.69152079687;8998.01021887592;8567.614457349435;10018.499075046218;10206.36698128296;10357.792844143074;10544.103751181236;3775.962240377616;4415.602595766396;4421.9336709949375;4448.911021779546;4478.552144785495;977.0913050862766;1013.5337744637402;1015.7562185075528;1016.6390931219458;1063.6117816996896;11853.99241064502;13169.67075823093;13514.189148651112;13824.239666818421;13992.23042732639;1030.5002073994108;1038.9116925061303;1052.7947050325267;1065.1478816946412;1070.384528895888;6833.180018397824;7012.439004879598;7026.824329391704;7194.424446044304;7227.89158162628;702217;716127.258091129;762367;765091;781372;123460;129912;131296.3435182837;133784;137949.62050379568;1235.234154823997;1256.8931640810451;1291.3019379515906;1292.5394304435927;1299.064673435125;12212.267263964191;12291;12440.19138755978;12472.625821225378;12595.496180152692;54235.72882135564;55060;55740.72129639326;55848.72075639596;56998.57503562444;77833;79162.57282083227;80969;80987.59506202431;81317.18682813096;9526.9044059934;10436.217283703905;10687.786244274916;10995.560177592806;11482.081433485135;12245.448954796877;12265.141440099107;12541.811872822098;12597.181183223061;12626.810597841224;9743.13639794977;10847.457627118454;10906;10981.945090274497;11226.719332016439;10635.627753028606;10757.085647719718;10826.56693732242;10944.507497162806;11093.778124437305;10879.456027198767;11070.501827417624;11119.11047116245;11167.609133680608;11203.60787372438;10844.132469402586;10854.837177442187;11057.391843448688;11221.382823944436;11257.324560526395;9142.542872856198;9775.826900771954;10425.530851111567;10783.24517283814;11009.229353945468 02:30:42 INFO - PROCESS | 1644 | |3;mootools.html;1420.7087547052852;1523.3906437425028;1526.9847301526981;1549.938002479901;1576.6925449537341;9342.159205671489;9603.567839447223;10684.78630427391;11352.43237838108;11401.885981140196;10560.26078174528;10928.836067458995;10936.453177341122;10947.781044379108;10959.671209863696;2382.463945612241;2409.4337830609793;2411.131992482705;2421.5641184586766;2423.3456966619;2350.764923507653;2367.1359953616893;2385.189035727852;2392.820538459614;2398.5083057973075;2164.6428339323993;2184.3337781976493;2186;2187.726534183227;2187.8359123065834;2200.3948914048765;2253.684484172209;2260.208926875605;2277.3851060213815;2277.601419751537;2354.458474550846;2356.045801450415;2356.4580146566213;2364.113457453455;2367.9052837886466;11014.50434730439;11099.55601775928;11120.332780033224;11123.777524449546;11141.888581114166;5752.913706294409;5901.557383196235;5913.172155898178;5918.526517878602;5927.555433342516;3336.7831090979007;3479.8434070466637;3655.1227705350525;3661.908452288714;3668.266346730638;1088.9509972051276;1131.162939424828;1156.0751398880946;1157.7279339355246;1161.349644199251;15180.240987950669;15319.846801531954;15333.923330383388;15378;15389.615259618598;4138.958610413857;4725.605946245866;4867.537583929521;4922.360093187863;4939.5554400104165;12726;12810.231386116862;12825;12857.549985750455;12859.42132604035;5769.365369809318;5859.970700146472;5862.03276459388;5890.705464726747;5935.7625694972585;4417.491988421309;4929.260610908393;5170.457102004236;5182.896342073137;5272.340957380327;3959.920801583952;4028.4762980812307;4062.7968601569805;4112.403701463331;4159.334506478949;1095.0856035210688;1096.4791723931069;1102.7298311913632;1110.4614262082882;1114.9832752508719;755.61463653536;829.4111181061514;833.6498670558381;936.8594710793299;941.9670311539063;6399.488040956712;6409.743610255631;6458.451031662267;6530.575512591667;6654.966725166343;952.4666186935339;991.7768502086973;995.2137811129127;1003.8845532763679;1022.9310370662675;4059.9594004060173;4231.365295205744;4234.470691163605;4259.87220383389;4347.739135651871;10986.670399888017;13452;13619.250941198132;13627.523036693668;13745.725085498234;10118.392896426238;13270.601881943365;13565.796513052312;13575.932120339336;13576.864231357758;8701.521416322037;10077.143442807297;10123.392596444237;10221.386716797017;10233;5991.700414979321;6645.401913827779;6684.866302674017;6754.155730533684;6854.622995735083;11788.115891308358;11857.34784586856;11905.761884762083;12060.216085954386;12093.334866582423;10763.46182690878;12286.508539658313;12343.629691109281;12363.32001739913;12424.37878106073;8064.274215320649;8262.669493220204;9012.41419307743;9053;9336.97293297723;10183.898161018591;10327.225458090823;10415.84376234342;10415.94792026035;10433.9478302608;9001.639934402812;9031.50326732036;9060.90939090627;9101.544922753968;9241.306901982512;8721.956390218262;8844.95577522134;8868.467891926248;8950.015498295312;9040.186383225542;6847.828804279734;7903.209679032051;7908.485948413335;8014.83970320602;8028.879566806386;5893.351731309467;5937;5997.460228579449;6004.279486461653;6155.384461553809;5132.97433512845;5798.971005144947;5933.703314834327;6054.757809687563;6190.81427557174 02:30:42 INFO - PROCESS | 1644 | |4;prototype.html;362.6427968451077;369.84466524059894;379.60331453630954;380.288859832114;387.5775404808759;5093.191916869514;5328.786848526059;5331.706756128421;5343.572514198864;5412.323459567554;4985.227289770091;5167.4574169712105;5213.296205012322;5219.556337711289;5228.189630607262;4177.289860723669;4352.934705979397;4355.782210889451;4360.847370342039;4362.716423432483;3739.420389839566;3810.7141964352645;4137.441445404877;4292;4306.8277268909205;3830.042489377656;4246.554111818261;4246.6218917406195;4253.617973934591;4308.956910430903;4271.231178387889;4285.45723539524;4312.741235525863;4320.848770293056;4356.324769660708;3562.786232826039;3739.0278527582755;3835.4438606401914;3934.272159650474;4016.4176194451934;4219.156168766259;4985.675931064506;5052.8231511897275;5085.694858308513;5145.485451454824;4128.823285363687;4303.827846886121;4856.902861942776;4874.683145595525;4919.237518184687;5100.617453690988;5165.302684137669;5255.738622730555;5471.699056551888;5596.524295434893;3996.160806230695;4367.737935723867;4412.514623391425;4499.302608095751;4510.661700372485;4786.922942337981;4935.7532123393685;5159.458256883048;5593.664380137164;5640.435956404327;4006.856331862498;4069.2878746219294;4284.614384705329;4338.544452832471;4505.639548836085;4226.873193804191;4370.950971766753;4617.12274667812;4624.583787459078;4680.485146633868;4267.610138322487;4392.9121417572105;4460.598546130799;4608.055348653518;4695.906081878344;5512.4211957744665;5515.862103447446;5551.805686800943;5554.583406244547;5560.972195139079;1404.9297535123203;1512.7141929360175;1555.502239283441;1571.8349573294868;1577.4084718230663;959.7696552827272;1099.428297285407;1170.449888552379;1186.7982442984714;1190.7618476304774;4811.975940120277;5277.366715994105;5277.894442111136;5296.788128474895;5353.170258609922;4960.330355401975;5289.365276166807;5838.94161058384;5844.620099693507;5879.794207202727;4373.703805502073;4847.776228807803;5206.271122042917;5309;5315.654482458628;2680.2227354067104;2737.3704048069058;2775.125835361895;2821.9858900705367;3021.9546706799415;5795.594308398372;5873.442023007808;5992.520598352208;5994.730237139339;6037.245344331958;4718.88202794926;5052.797888084436;5809.8547536311935;5871.647701137946;5968.910466343008;5135.948640513547;5489.560835133179;5572.749226284827;5627.986962346817;6114.471382154461;4714.717116972993;5294.444083371191;5560.888782224414;5796.217510636179;5817.156512305776;5522.337319521683;5635.830925072254;5678.517326027334;5703.771849126155;5706.771729130955;5567.387587365306;5678.290213723285;5813.970930145322;6121.3572574879;6178.37419096891;3745.419459983707;3762.830672619684;3929.823157957956;4497;4573.634109271184;4887.97352555953;4960.090365209348;5101.464346243591;5689.358810361289;5716.399778023414;4830.589399901048;5338.306020217502;5535.6991107089;5638.0266906582365;5677.870798450581;4573.908521829611;4923.926141107958;5591.608587398843;5602.943970560405;5620.409856965123;4863.659543831898;4978.187324161837;5195.363460509927;5415.23641069453;5541.667499950016;4402.405675233803;4967.484917100319;5365.853658536616;5554.861128471821;5708.829689913641;4966.1941003333;5121.950000250014;5507.476789704971;5542.2795036644975;5603.523700485504 02:30:42 INFO - PROCESS | 1644 | |5;yui.html;712.6009434716556;749.2994050562728;772.9111152217495;778.6885245901639;839.6347588798872;15278.847211527882;15807.288672009745;16077;17522.299108035662;18412;15324.6935061299;17596.20817063232;17618;17642.82357176428;17651.470455886312;916.2624087609472;942.5098948546786;945.3477100800426;945.3902233059672;947.4315410753561;908.9864800747152;943.6319835264252;965.0831709875611;965.7537327981355;966.0291407135819;861.5519929636616;978.5498670611491;999.5302207962246;1004.5429329655026;1004.6433516101788;843.1863251961855;972.7081875437411;972.9173020293283;982.6069572171117;987.5111819649247;730.3244498838607;733.2337707096098;733.8789099798527;733.8789099798527;734.5923012727934;14081.859181408157;16104.033757974441;16318.347266109342;16496.587585310343;17092;14628.561143165722;14769;14859.925700371537;14877.702445951129;15338.156401397919;10548.419836908966;11542.711432214262;11617.593384231512;11687.649370518813;11915.106367022508;4220.6412454941365;4580.175568397687;4585.747783871886;4621.2200299265505;4832.444268909086;92088;96351.51824240905;105406.47296763543;105513.47243263734;105880;10165.745856353651;10366.533505992098;10496.107830834311;10709.357438553556;11068.723281918017;21519.924003799748;21638.02628881704;21744;21804.45488862791;21816;7775.222477752292;7890.64492097857;7913.129555748863;7924.881126783102;8018.037835459782;4080.6123418275215;4183.523718863989;4270.679699022524;4277.7647229402055;4314.525402205755;3179.6979286968162;3269.7547683923326;3270.9509357359657;3271.9345613087603;3291.4733642617543;627.9372062793684;629.4523764325066;631.9747210111544;633.9904901426482;650.0379438431148;502.88685045865117;530.3053000569266;532.9493698098674;537.1378936806448;547.4005963469994;8951.776205594782;9971.40171589707;9984.35101718386;10022.16719255506;10058.390657494765;616.9383061693794;643.4935924573759;644.6518879804853;650.3561474140662;652.8988006858945;4579.839705610288;4743.407074115736;4748.738819364899;4755.262934245197;4812.181929072066;102846.48576757219;104127.4793626027;104231.4788426053;104759;106936;77779.44441111146;89858;90698.54650726705;90961.54519227361;92886.53556732308;77875.61062194766;79325.60337198277;79766;79872.20127798764;80610;8732.781680457785;9313.720588382359;9340.159385655325;9342.439453632804;9344;45297.54702452933;47356.052878942915;48198;50355.99288014293;52054.73972630112;55892.44107559035;59007.40992590019;62773.686131570874;64319;72112;13816.378262978391;13985.510507132201;14036.157830530201;14245.274132537286;14490;14955;14966.941490421015;15170.24148792578;15217.315220815311;15272.389104435699;13790.724185516034;13855.515056972958;13995.650108747363;14019.29903504841;14138.575842724735;12387.566435174725;14030.158190508602;14459.060161089496;14767.630809229855;15146.318415671101;13649.931750341184;13688.589342319747;13703.246321452416;13805.930970345486;14624.561263162122;10083;11024.283421577571;11194.888051119711;11751.588694395656;11847.348395838311;8898.555072246232;10895.96488333607;10997.002997002997;11525.538978440769;11735.882641173479 02:30:42 INFO - PROCESS | 1644 | __end_tp_report 02:30:42 INFO - PROCESS | 1644 | __start_cc_report 02:30:42 INFO - PROCESS | 1644 | _x_x_mozilla_cycle_collect,421 02:30:42 INFO - PROCESS | 1644 | __end_cc_report 02:30:42 INFO - PROCESS | 1644 | __startTimestamp1490261442558__endTimestamp 02:30:42 INFO - PROCESS | 1644 | 02:30:42 INFO - PROCESS | 1644 | ------- Summary: start ------- 02:30:42 INFO - PROCESS | 1644 | Number of tests: 6 02:30:42 INFO - PROCESS | 1644 | 02:30:42 INFO - PROCESS | 1644 | [#0] dojo.html Cycles:165 Average:5994.09 Median:6233.75 stddev:676.58 (10.9%) stddev-sans-first:649.84 02:30:42 INFO - PROCESS | 1644 | Values: 3503.7 3507.3 3527.2 3533.5 3541.9 5905.2 5971.4 6030.9 6091.6 6114.7 6073.1 6106.8 6140.5 6148.8 6167.8 5215.2 5446.9 5491.4 5509.8 5570.4 4781.8 5465.9 5537.8 5580.3 5632.2 5338.8 5339.5 5535.0 5570.9 5578.2 5477.8 5487.0 5558.7 5608.9 5625.1 4441.8 5458.2 5504.9 5508.4 5545.9 5753.9 6117.8 6141.1 6197.2 6205.8 5343.9 6281.5 6301.8 6312.3 6359.5 6575.1 6602.1 6609.4 6612.3 6617.6 6217.7 6237.0 6262.6 6279.7 6284.4 6395.9 6402.3 6584.3 6673.7 6756.5 6345.9 6391.3 6398.2 6409.0 6418.4 6424.6 6482.6 6532.9 6549.5 6571.7 6196.5 6249.4 6463.6 6484.9 6490.6 6193.3 6370.3 6380.3 6380.5 6428.3 5158.5 5201.0 5202.6 5224.7 5243.3 4589.7 4601.0 4611.7 4642.7 4672.2 6065.4 6122.9 6141.5 6247.9 6273.0 6461.8 6468.1 6530.7 6548.2 6555.4 6233.8 6255.7 6256.7 6267.9 6280.4 5574.4 5807.3 5809.4 5817.9 5826.9 5566.7 6607.3 6669.2 6742.4 6743.9 5454.4 6482.5 6581.6 6592.6 6600.7 6786.8 6799.2 6828.4 6849.1 6860.1 6226.8 6259.2 6271.5 6320.6 6423.4 5120.7 5458.7 6530.4 6530.7 6552.7 6315.1 6332.2 6340.3 6351.6 6368.5 6129.3 6134.4 6187.6 6263.7 6330.8 5800.4 6118.0 6141.1 6239.9 6256.2 6210.7 6301.9 6350.1 6366.0 6384.5 6184.9 6194.5 6199.9 6242.0 6266.5 02:30:42 INFO - PROCESS | 1644 | 02:30:42 INFO - PROCESS | 1644 | [#1] ext.html Cycles:180 Average:54725.33 Median:29660.70 stddev:114404.48 (385.7%) stddev-sans-first:114653.60 02:30:42 INFO - PROCESS | 1644 | Values: 736.7 801.1 820.4 958.3 962.5 38215.8 39031.0 39090.6 39106.0 39141.6 37790.8 38037.0 38080.2 38087.0 38165.4 7790.1 7949.0 10462.4 10735.6 10911.8 10547.6 10625.8 10655.9 10659.8 10669.9 10655.9 10666.5 10687.9 10696.3 10707.7 10634.7 10643.7 10647.1 10664.8 10666.1 10333.8 10341.2 10346.3 10379.6 10397.4 32495.5 32660.0 32734.5 32786.7 33168.3 3668.7 3749.1 3751.5 3756.2 3806.4 24865.4 25044.7 25222.4 25992.9 26086.1 3035.9 3059.1 3149.9 3238.3 3264.9 364928.0 367209.0 367490.0 368403.0 368419.0 43353.3 43401.6 43465.6 43532.6 43560.6 44885.0 44947.9 45112.0 45115.0 45247.3 13438.5 13744.5 13761.0 13777.4 13825.0 11784.7 11963.6 11975.2 11983.5 12054.1 10989.9 11531.0 11544.5 11585.8 11637.8 4717.5 5492.4 5501.0 5544.2 5551.4 1080.9 1105.3 1113.4 1129.6 1166.7 21039.6 26919.1 27068.3 27186.2 27768.9 1003.8 1184.1 1196.9 1216.4 1254.5 13678.2 13757.6 13839.5 13913.0 13978.4 397087.0 478337.0 478411.0 479348.0 479565.0 46083.0 47273.5 54891.5 54905.7 55054.4 1195.5 1350.4 1373.6 1384.8 1385.3 25162.7 25506.5 25515.5 25932.0 26098.6 39125.0 39240.8 39320.8 39331.8 39368.8 448232.0 452710.0 453935.0 454404.0 454915.0 27820.9 27936.0 27991.6 28075.3 28080.3 35378.6 35829.8 36356.8 36438.7 36728.0 30075.5 30141.0 30513.9 31053.0 31123.7 29343.6 29392.6 29616.7 29704.7 30133.8 30314.5 30362.8 30899.4 30918.5 31002.0 23867.5 25945.7 27721.3 28283.3 28410.6 16299.3 18982.8 20735.0 21176.7 21349.5 02:30:42 INFO - PROCESS | 1644 | 02:30:42 INFO - PROCESS | 1644 | [#2] jquery.html Cycles:180 Average:40336.31 Median:21555.89 stddev:123237.53 (571.7%) stddev-sans-first:123546.70 02:30:42 INFO - PROCESS | 1644 | Values: 368.4 386.1 404.2 408.2 449.3 19503.4 20768.7 20770.9 20962.9 21277.6 21292.7 21527.9 21583.9 22161.9 22296.9 6180.8 6453.8 6479.3 6490.7 6521.2 6084.4 6306.6 6338.4 6388.7 6396.2 6346.5 6350.9 6362.2 6364.8 6376.9 6196.4 6274.0 6309.6 6406.3 6412.2 6200.8 6231.4 6260.7 6279.0 6303.7 22591.7 26043.5 26060.0 26222.9 26372.6 2971.6 3308.8 3319.0 3352.6 3374.4 15514.3 15682.5 16132.0 16613.0 16828.1 1748.5 1790.2 1987.0 1987.7 2009.6 98771.0 116763.0 121750.8 121838.6 125107.4 19908.8 20697.8 21914.7 22448.6 22522.0 33485.0 33811.5 33976.0 34070.0 34082.8 8772.4 10589.5 10606.2 10808.1 10914.9 7708.0 8497.2 8766.9 8813.7 8998.0 8567.6 10018.5 10206.4 10357.8 10544.1 3776.0 4415.6 4421.9 4448.9 4478.6 977.1 1013.5 1015.8 1016.6 1063.6 11854.0 13169.7 13514.2 13824.2 13992.2 1030.5 1038.9 1052.8 1065.1 1070.4 6833.2 7012.4 7026.8 7194.4 7227.9 702217.0 716127.3 762367.0 765091.0 781372.0 123460.0 129912.0 131296.3 133784.0 137949.6 1235.2 1256.9 1291.3 1292.5 1299.1 12212.3 12291.0 12440.2 12472.6 12595.5 54235.7 55060.0 55740.7 55848.7 56998.6 77833.0 79162.6 80969.0 80987.6 81317.2 9526.9 10436.2 10687.8 10995.6 11482.1 12245.4 12265.1 12541.8 12597.2 12626.8 9743.1 10847.5 10906.0 10981.9 11226.7 10635.6 10757.1 10826.6 10944.5 11093.8 10879.5 11070.5 11119.1 11167.6 11203.6 10844.1 10854.8 11057.4 11221.4 11257.3 9142.5 9775.8 10425.5 10783.2 11009.2 02:30:42 INFO - PROCESS | 1644 | 02:30:42 INFO - PROCESS | 1644 | [#3] mootools.html Cycles:180 Average:6682.15 Median:2410.28 stddev:4180.92 (173.5%) stddev-sans-first:4173.96 02:30:42 INFO - PROCESS | 1644 | Values: 1420.7 1523.4 1527.0 1549.9 1576.7 9342.2 9603.6 10684.8 11352.4 11401.9 10560.3 10928.8 10936.5 10947.8 10959.7 2382.5 2409.4 2411.1 2421.6 2423.3 2350.8 2367.1 2385.2 2392.8 2398.5 2164.6 2184.3 2186.0 2187.7 2187.8 2200.4 2253.7 2260.2 2277.4 2277.6 2354.5 2356.0 2356.5 2364.1 2367.9 11014.5 11099.6 11120.3 11123.8 11141.9 5752.9 5901.6 5913.2 5918.5 5927.6 3336.8 3479.8 3655.1 3661.9 3668.3 1089.0 1131.2 1156.1 1157.7 1161.3 15180.2 15319.8 15333.9 15378.0 15389.6 4139.0 4725.6 4867.5 4922.4 4939.6 12726.0 12810.2 12825.0 12857.5 12859.4 5769.4 5860.0 5862.0 5890.7 5935.8 4417.5 4929.3 5170.5 5182.9 5272.3 3959.9 4028.5 4062.8 4112.4 4159.3 1095.1 1096.5 1102.7 1110.5 1115.0 755.6 829.4 833.6 936.9 942.0 6399.5 6409.7 6458.5 6530.6 6655.0 952.5 991.8 995.2 1003.9 1022.9 4060.0 4231.4 4234.5 4259.9 4347.7 10986.7 13452.0 13619.3 13627.5 13745.7 10118.4 13270.6 13565.8 13575.9 13576.9 8701.5 10077.1 10123.4 10221.4 10233.0 5991.7 6645.4 6684.9 6754.2 6854.6 11788.1 11857.3 11905.8 12060.2 12093.3 10763.5 12286.5 12343.6 12363.3 12424.4 8064.3 8262.7 9012.4 9053.0 9337.0 10183.9 10327.2 10415.8 10415.9 10433.9 9001.6 9031.5 9060.9 9101.5 9241.3 8722.0 8845.0 8868.5 8950.0 9040.2 6847.8 7903.2 7908.5 8014.8 8028.9 5893.4 5937.0 5997.5 6004.3 6155.4 5133.0 5799.0 5933.7 6054.8 6190.8 02:30:42 INFO - PROCESS | 1644 | 02:30:42 INFO - PROCESS | 1644 | [#4] prototype.html Cycles:180 Average:4602.54 Median:4966.84 stddev:1302.20 (26.2%) stddev-sans-first:1266.37 02:30:42 INFO - PROCESS | 1644 | Values: 362.6 369.8 379.6 380.3 387.6 5093.2 5328.8 5331.7 5343.6 5412.3 4985.2 5167.5 5213.3 5219.6 5228.2 4177.3 4352.9 4355.8 4360.8 4362.7 3739.4 3810.7 4137.4 4292.0 4306.8 3830.0 4246.6 4246.6 4253.6 4309.0 4271.2 4285.5 4312.7 4320.8 4356.3 3562.8 3739.0 3835.4 3934.3 4016.4 4219.2 4985.7 5052.8 5085.7 5145.5 4128.8 4303.8 4856.9 4874.7 4919.2 5100.6 5165.3 5255.7 5471.7 5596.5 3996.2 4367.7 4412.5 4499.3 4510.7 4786.9 4935.8 5159.5 5593.7 5640.4 4006.9 4069.3 4284.6 4338.5 4505.6 4226.9 4371.0 4617.1 4624.6 4680.5 4267.6 4392.9 4460.6 4608.1 4695.9 5512.4 5515.9 5551.8 5554.6 5561.0 1404.9 1512.7 1555.5 1571.8 1577.4 959.8 1099.4 1170.4 1186.8 1190.8 4812.0 5277.4 5277.9 5296.8 5353.2 4960.3 5289.4 5838.9 5844.6 5879.8 4373.7 4847.8 5206.3 5309.0 5315.7 2680.2 2737.4 2775.1 2822.0 3022.0 5795.6 5873.4 5992.5 5994.7 6037.2 4718.9 5052.8 5809.9 5871.6 5968.9 5135.9 5489.6 5572.7 5628.0 6114.5 4714.7 5294.4 5560.9 5796.2 5817.2 5522.3 5635.8 5678.5 5703.8 5706.8 5567.4 5678.3 5814.0 6121.4 6178.4 3745.4 3762.8 3929.8 4497.0 4573.6 4888.0 4960.1 5101.5 5689.4 5716.4 4830.6 5338.3 5535.7 5638.0 5677.9 4573.9 4923.9 5591.6 5602.9 5620.4 4863.7 4978.2 5195.4 5415.2 5541.7 4402.4 4967.5 5365.9 5554.9 5708.8 4966.2 5122.0 5507.5 5542.3 5603.5 02:30:42 INFO - PROCESS | 1644 | 02:30:42 INFO - PROCESS | 1644 | [#5] yui.html Cycles:180 Average:20486.27 Median:4296.15 stddev:28919.84 (673.2%) stddev-sans-first:28962.85 02:30:42 INFO - PROCESS | 1644 | Values: 712.6 749.3 772.9 778.7 839.6 15278.8 15807.3 16077.0 17522.3 18412.0 15324.7 17596.2 17618.0 17642.8 17651.5 916.3 942.5 945.3 945.4 947.4 909.0 943.6 965.1 965.8 966.0 861.6 978.5 999.5 1004.5 1004.6 843.2 972.7 972.9 982.6 987.5 730.3 733.2 733.9 733.9 734.6 14081.9 16104.0 16318.3 16496.6 17092.0 14628.6 14769.0 14859.9 14877.7 15338.2 10548.4 11542.7 11617.6 11687.6 11915.1 4220.6 4580.2 4585.7 4621.2 4832.4 92088.0 96351.5 105406.5 105513.5 105880.0 10165.7 10366.5 10496.1 10709.4 11068.7 21519.9 21638.0 21744.0 21804.5 21816.0 7775.2 7890.6 7913.1 7924.9 8018.0 4080.6 4183.5 4270.7 4277.8 4314.5 3179.7 3269.8 3271.0 3271.9 3291.5 627.9 629.5 632.0 634.0 650.0 502.9 530.3 532.9 537.1 547.4 8951.8 9971.4 9984.4 10022.2 10058.4 616.9 643.5 644.7 650.4 652.9 4579.8 4743.4 4748.7 4755.3 4812.2 102846.5 104127.5 104231.5 104759.0 106936.0 77779.4 89858.0 90698.5 90961.5 92886.5 77875.6 79325.6 79766.0 79872.2 80610.0 8732.8 9313.7 9340.2 9342.4 9344.0 45297.5 47356.1 48198.0 50356.0 52054.7 55892.4 59007.4 62773.7 64319.0 72112.0 13816.4 13985.5 14036.2 14245.3 14490.0 14955.0 14966.9 15170.2 15217.3 15272.4 13790.7 13855.5 13995.7 14019.3 14138.6 12387.6 14030.2 14459.1 14767.6 15146.3 13649.9 13688.6 13703.2 13805.9 14624.6 10083.0 11024.3 11194.9 11751.6 11847.3 8898.6 10896.0 10997.0 11525.5 11735.9 02:30:42 INFO - PROCESS | 1644 | -------- Summary: end -------- 02:30:42 INFO - PROCESS | 1644 | 02:30:43 INFO - TEST-INFO | 1644: exit 0 02:30:43 INFO - TEST-OK | dromaeo_css | took 1116979ms 02:30:43 INFO - TEST-START | kraken 02:30:43 INFO - operating with platform_type : mac_ 02:30:43 INFO - Initialising browser for kraken test... 02:30:43 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/tmpETJinT/profile http://localhost:49248/getInfo.html) 02:30:45 INFO - PROCESS | 1657 | 2017-03-23 02:30:45.920 plugin-container[1659:10712] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x893f, name = 'com.apple.tsm.portname' 02:30:45 INFO - PROCESS | 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:30:45 INFO - PROCESS | 1657 | 2017-03-23 02:30:45.921 plugin-container[1659:10712] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0f, name = 'com.apple.CFPasteboardClient' 02:30:45 INFO - PROCESS | 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:30:45 INFO - PROCESS | 1657 | 2017-03-23 02:30:45.921 plugin-container[1659:10712] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:30:45 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 02:30:45 INFO - PROCESS | 1657 | colorDepth:24 02:30:45 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 02:30:45 INFO - PROCESS | 1657 | __metrics 02:30:46 ERROR - PROCESS | 1657 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 02:30:46 INFO - TEST-INFO | 1657: exit 0 02:30:46 INFO - Browser initialized. 02:30:46 INFO - Running cycle 1/1 for kraken test... 02:30:46 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/tmpETJinT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:30:49 INFO - PROCESS | 1660 | 2017-03-23 02:30:49.395 plugin-container[1661:10842] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4643, name = 'com.apple.tsm.portname' 02:30:49 INFO - PROCESS | 1660 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:30:49 INFO - PROCESS | 1660 | 2017-03-23 02:30:49.396 plugin-container[1661:10842] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c1b, name = 'com.apple.CFPasteboardClient' 02:30:49 INFO - PROCESS | 1660 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:30:49 INFO - PROCESS | 1660 | 2017-03-23 02:30:49.396 plugin-container[1661:10842] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:30:59 INFO - PROCESS | 1660 | RSS: Main: 221151232 02:30:59 INFO - PROCESS | 1660 | 02:31:01 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection) 02:31:02 INFO - PROCESS | 1660 | RSS: Main: 235347968 02:31:02 INFO - PROCESS | 1660 | 02:31:05 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-dft) 02:31:05 INFO - PROCESS | 1660 | RSS: Main: 243593216 02:31:05 INFO - PROCESS | 1660 | 02:31:09 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-fft) 02:31:09 INFO - PROCESS | 1660 | RSS: Main: 247394304 02:31:09 INFO - PROCESS | 1660 | 02:31:11 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator) 02:31:12 INFO - PROCESS | 1660 | RSS: Main: 248967168 02:31:12 INFO - PROCESS | 1660 | 02:31:14 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:31:15 INFO - PROCESS | 1660 | RSS: Main: 248803328 02:31:15 INFO - PROCESS | 1660 | 02:31:18 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom) 02:31:19 INFO - PROCESS | 1660 | RSS: Main: 250388480 02:31:19 INFO - PROCESS | 1660 | 02:31:22 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate) 02:31:22 INFO - PROCESS | 1660 | RSS: Main: 250912768 02:31:22 INFO - PROCESS | 1660 | 02:31:26 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial) 02:31:26 INFO - PROCESS | 1660 | RSS: Main: 251092992 02:31:26 INFO - PROCESS | 1660 | 02:31:28 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:31:29 INFO - PROCESS | 1660 | RSS: Main: 251056128 02:31:29 INFO - PROCESS | 1660 | 02:31:30 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:31:31 INFO - PROCESS | 1660 | RSS: Main: 251289600 02:31:31 INFO - PROCESS | 1660 | 02:31:33 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:31:34 INFO - PROCESS | 1660 | RSS: Main: 251129856 02:31:34 INFO - PROCESS | 1660 | 02:31:37 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:31:38 INFO - PROCESS | 1660 | RSS: Main: 251531264 02:31:38 INFO - PROCESS | 1660 | 02:31:41 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:31:41 INFO - PROCESS | 1660 | RSS: Main: 251224064 02:31:41 INFO - PROCESS | 1660 | 02:31:43 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49248/tests/kraken/driver.html?testName=ai-astar) 02:31:43 INFO - PROCESS | 1660 | RSS: Main: 253214720 02:31:43 INFO - PROCESS | 1660 | 02:31:43 INFO - PROCESS | 1660 | __start_tp_report 02:31:43 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 02:31:43 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 02:31:43 INFO - PROCESS | 1660 | |i|pagename|runs| 02:31:43 INFO - PROCESS | 1660 | |0;ai-astar;117;118;117;117;120;117;121;119;119;118 02:31:43 INFO - PROCESS | 1660 | |1;audio-beat-detection;145;124;109;138;136;101;141;138;148;112 02:31:43 INFO - PROCESS | 1660 | |2;audio-dft;195;205;199;203;200;194;198;183;200;197 02:31:43 INFO - PROCESS | 1660 | |3;audio-fft;107;86;77;88;63;63;65;83;96;77 02:31:43 INFO - PROCESS | 1660 | |4;audio-oscillator;88;69;83;74;71;69;96;71;70;69 02:31:43 INFO - PROCESS | 1660 | |5;imaging-gaussian-blur;107;132;110;113;83;126;136;135;133;114 02:31:43 INFO - PROCESS | 1660 | |6;imaging-darkroom;98;99;99;122;98;98;100;97;97;98 02:31:43 INFO - PROCESS | 1660 | |7;imaging-desaturate;85;143;74;144;76;148;76;93;114;130 02:31:43 INFO - PROCESS | 1660 | |8;json-parse-financial;64;64;63;66;74;95;98;88;67;67 02:31:43 INFO - PROCESS | 1660 | |9;json-stringify-tinderbox;60;71;84;100;89;66;61;61;64;62 02:31:43 INFO - PROCESS | 1660 | |10;stanford-crypto-aes;83;87;86;84;87;81;87;91;83;89 02:31:43 INFO - PROCESS | 1660 | |11;stanford-crypto-ccm;145;158;145;150;135;142;148;140;220;150 02:31:43 INFO - PROCESS | 1660 | |12;stanford-crypto-pbkdf2;168;170;167;184;169;171;167;166;177;165 02:31:43 INFO - PROCESS | 1660 | |13;stanford-crypto-sha256-iterative;68;64;65;65;68;67;67;65;78;68 02:31:43 INFO - PROCESS | 1660 | __end_tp_report 02:31:43 INFO - PROCESS | 1660 | __start_cc_report 02:31:43 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,1028 02:31:43 INFO - PROCESS | 1660 | __end_cc_report 02:31:43 INFO - PROCESS | 1660 | __startTimestamp1490261503720__endTimestamp 02:31:43 INFO - PROCESS | 1660 | 02:31:43 INFO - PROCESS | 1660 | ------- Summary: start ------- 02:31:43 INFO - PROCESS | 1660 | Number of tests: 14 02:31:43 INFO - PROCESS | 1660 | 02:31:43 INFO - PROCESS | 1660 | [#0] ai-astar Cycles:10 Average:118.30 Median:118.50 stddev:1.42 (1.2%) stddev-sans-first:1.42 02:31:43 INFO - PROCESS | 1660 | Values: 117.0 118.0 117.0 117.0 120.0 117.0 121.0 119.0 119.0 118.0 02:31:43 INFO - PROCESS | 1660 | 02:31:43 INFO - PROCESS | 1660 | [#1] audio-beat-detection Cycles:10 Average:129.20 Median:138.00 stddev:16.57 (12.0%) stddev-sans-first:16.55 02:31:43 INFO - PROCESS | 1660 | Values: 145.0 124.0 109.0 138.0 136.0 101.0 141.0 138.0 148.0 112.0 02:31:43 INFO - PROCESS | 1660 | 02:31:43 INFO - PROCESS | 1660 | [#2] audio-dft Cycles:10 Average:197.40 Median:199.50 stddev:6.06 (3.0%) stddev-sans-first:6.36 02:31:43 INFO - PROCESS | 1660 | Values: 195.0 205.0 199.0 203.0 200.0 194.0 198.0 183.0 200.0 197.0 02:31:43 INFO - PROCESS | 1660 | 02:31:43 INFO - PROCESS | 1660 | [#3] audio-fft Cycles:10 Average:80.50 Median:80.00 stddev:14.58 (18.2%) stddev-sans-first:11.90 02:31:43 INFO - PROCESS | 1660 | Values: 107.0 86.0 77.0 88.0 63.0 63.0 65.0 83.0 96.0 77.0 02:31:43 INFO - PROCESS | 1660 | 02:31:43 INFO - PROCESS | 1660 | [#4] audio-oscillator Cycles:10 Average:76.00 Median:72.50 stddev:9.60 (13.2%) stddev-sans-first:9.15 02:31:43 INFO - PROCESS | 1660 | Values: 88.0 69.0 83.0 74.0 71.0 69.0 96.0 71.0 70.0 69.0 02:31:43 INFO - PROCESS | 1660 | 02:31:43 INFO - PROCESS | 1660 | [#5] imaging-gaussian-blur Cycles:10 Average:118.90 Median:132.50 stddev:16.80 (12.7%) stddev-sans-first:17.26 02:31:43 INFO - PROCESS | 1660 | Values: 107.0 132.0 110.0 113.0 83.0 126.0 136.0 135.0 133.0 114.0 02:31:43 INFO - PROCESS | 1660 | 02:31:43 INFO - PROCESS | 1660 | [#6] imaging-darkroom Cycles:10 Average:100.60 Median:98.00 stddev:7.57 (7.7%) stddev-sans-first:7.98 02:31:43 INFO - PROCESS | 1660 | Values: 98.0 99.0 99.0 122.0 98.0 98.0 100.0 97.0 97.0 98.0 02:31:43 INFO - PROCESS | 1660 | 02:31:43 INFO - PROCESS | 1660 | [#7] imaging-desaturate Cycles:10 Average:108.30 Median:75.00 stddev:30.91 (41.2%) stddev-sans-first:31.61 02:31:43 INFO - PROCESS | 1660 | Values: 85.0 143.0 74.0 144.0 76.0 148.0 76.0 93.0 114.0 130.0 02:31:43 INFO - PROCESS | 1660 | 02:31:43 INFO - PROCESS | 1660 | [#8] json-parse-financial Cycles:10 Average:74.60 Median:70.50 stddev:13.71 (19.5%) stddev-sans-first:14.00 02:31:43 INFO - PROCESS | 1660 | Values: 64.0 64.0 63.0 66.0 74.0 95.0 98.0 88.0 67.0 67.0 02:31:43 INFO - PROCESS | 1660 | 02:31:43 INFO - PROCESS | 1660 | [#9] json-stringify-tinderbox Cycles:10 Average:71.80 Median:65.00 stddev:14.16 (21.8%) stddev-sans-first:14.36 02:31:43 INFO - PROCESS | 1660 | Values: 60.0 71.0 84.0 100.0 89.0 66.0 61.0 61.0 64.0 62.0 02:31:43 INFO - PROCESS | 1660 | 02:31:43 INFO - PROCESS | 1660 | [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:87.00 stddev:3.05 (3.5%) stddev-sans-first:3.06 02:31:43 INFO - PROCESS | 1660 | Values: 83.0 87.0 86.0 84.0 87.0 81.0 87.0 91.0 83.0 89.0 02:31:43 INFO - PROCESS | 1660 | 02:31:43 INFO - PROCESS | 1660 | [#11] stanford-crypto-ccm Cycles:10 Average:153.30 Median:149.00 stddev:24.26 (16.3%) stddev-sans-first:25.55 02:31:43 INFO - PROCESS | 1660 | Values: 145.0 158.0 145.0 150.0 135.0 142.0 148.0 140.0 220.0 150.0 02:31:43 INFO - PROCESS | 1660 | 02:31:43 INFO - PROCESS | 1660 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.40 Median:169.50 stddev:5.85 (3.5%) stddev-sans-first:6.14 02:31:43 INFO - PROCESS | 1660 | Values: 168.0 170.0 167.0 184.0 169.0 171.0 167.0 166.0 177.0 165.0 02:31:43 INFO - PROCESS | 1660 | 02:31:43 INFO - PROCESS | 1660 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:67.50 stddev:3.98 (5.9%) stddev-sans-first:4.22 02:31:43 INFO - PROCESS | 1660 | Values: 68.0 64.0 65.0 65.0 68.0 67.0 67.0 65.0 78.0 68.0 02:31:43 INFO - PROCESS | 1660 | -------- Summary: end -------- 02:31:43 INFO - PROCESS | 1660 | 02:31:44 INFO - TEST-INFO | 1660: exit 0 02:31:44 INFO - TEST-OK | kraken | took 61455ms 02:31:44 INFO - SUITE-END | took 1178s 02:31:44 INFO - Completed test suite (00:19:38) 02:31:44 INFO - javascript benchmark 02:31:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7578.159532799714, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3503.7372197085224, 3507.281007393484, 3527.171114788024, 3533.540639716837, 3541.8760343387953, 5905.202797622314, 5971.37300583439, 6030.909536356959, 6091.634501929876, 6114.663693496856, 6073.089036644495, 6106.755729770804, 6140.508759299257, 6148.784792532262, 6167.7532898684, 5215.243789650498, 5446.863828404292, 5491.368492623339, 5509.752061157257, 5570.442955704438, 4781.832635857746, 5465.9180112298145, 5537.750801213955, 5580.330360356763, 5632.183333416652, 5338.813141540047, 5339.519443250107, 5535.0, 5570.885822835429, 5578.191162281467, 5477.75350109244, 5487.0, 5558.666480011212, 5608.887822243573, 5625.071863142576, 4441.75570343631, 5458.235846981426, 5504.91742623861, 5508.4491550845, 5545.944540554583, 5753.8561535961935, 6117.847053823645, 6141.078838174265, 6197.225346831646, 6205.8138255851945, 5343.946560534423, 6281.528885333572, 6301.779437719703, 6312.274088479791, 6359.523035772289, 6575.112359831457, 6602.075709400688, 6609.438197753197, 6612.272650008544, 6617.636030018347, 6217.6891155442045, 6237.0, 6262.624242545417, 6279.686015699197, 6284.402981716729, 6395.936040639627, 6402.263739669997, 6584.275729669733, 6673.733050677918, 6756.527043107034, 6345.936540634627, 6391.265004524446, 6398.168238129107, 6408.967955160288, 6418.358164183638, 6424.582402143846, 6482.643454609947, 6532.934670653328, 6549.541532092803, 6571.737130514822, 6196.504279657616, 6249.375062493714, 6463.644499552475, 6484.902726459107, 6490.643014634241, 6193.256809182927, 6370.331115232926, 6380.330065343165, 6380.489560835122, 6428.292887782341, 5158.509941555546, 5201.011807756514, 5202.557782588447, 5224.738763061831, 5243.2659427680155, 4589.701669391479, 4601.0, 4611.677182597186, 4642.744649044335, 4672.182368085571, 6065.3934606539, 6122.908156377658, 6141.508679305734, 6247.9062814057825, 6273.027680709497, 6461.838454038687, 6468.094466774655, 6530.738770449224, 6548.1814773153355, 6555.3772391622715, 6233.750649974041, 6255.718492667841, 6256.655883926428, 6267.9373206268265, 6280.403361680633, 5574.442555744393, 5807.303123625107, 5809.448102430262, 5817.912731309034, 5826.854328641733, 5566.693831839126, 6607.339266073451, 6669.166354205724, 6742.393184613408, 6743.9325606743305, 5454.4272851351625, 6482.54622176462, 6581.605103693793, 6592.571482853599, 6600.702968366339, 6786.796396108125, 6799.184097908283, 6828.351306625863, 6849.075374824335, 6860.108185935996, 6226.750929962751, 6259.217597800275, 6271.498280137669, 6320.620762754065, 6423.42189202974, 5120.692758434506, 5458.6724796512335, 6530.379613936669, 6530.67346632657, 6552.6723663817575, 6315.115883776183, 6332.240131184288, 6340.302566717565, 6351.587146835441, 6368.4586810121655, 6129.264488261437, 6134.436587033385, 6187.597806142587, 6263.749450021948, 6330.778422755181, 5800.39095894925, 6118.010103775157, 6141.148492690724, 6239.875202496016, 6256.249250090018, 6210.720517576629, 6301.936980630135, 6350.079238510482, 6366.045093235866, 6384.45732112757, 6184.907226391698, 6194.535409844189, 6199.907001395073, 6242.0, 6266.498680105672], "value": 5952.738739556894, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [736.7163641997832, 801.0987638906231, 820.3683163963747, 958.3004406783052, 962.5331714118647, 38215.808920955395, 39031.0, 39090.60909390905, 39106.0, 39141.60858391419, 37790.8110459448, 38037.0, 38080.23839523215, 38087.0, 38165.42751858725, 7790.143084260741, 7948.9602551987155, 10462.424566648831, 10735.570577176943, 10911.83632245517, 10547.63083292085, 10625.84061239082, 10655.946720266427, 10659.84010239847, 10669.946650266776, 10655.946720266427, 10666.466676666136, 10687.946560267188, 10696.304740191863, 10707.678769636923, 10634.734131646732, 10643.733906652356, 10647.09499692527, 10664.840027399596, 10666.14670826332, 10333.844992325121, 10341.224408169417, 10346.327488713285, 10379.584816607327, 10397.376157430503, 32495.512567311274, 32660.0, 32734.508982365285, 32786.672133278604, 33168.3366332672, 3668.669819716238, 3749.1189570450924, 3751.4747935289083, 3756.1736417988272, 3806.352920003606, 24865.378365540826, 25044.749552504425, 25222.369440763945, 25992.8700356497, 26086.086986955364, 3035.878564857403, 3059.143439836849, 3149.889753858627, 3238.25520130369, 3264.853081611333, 364928.0, 367209.0, 367490.0, 368403.0, 368419.0, 43353.34969975453, 43401.565984340385, 43465.56534434678, 43532.56467435285, 43560.56439435565, 44885.0, 44947.87630309203, 45112.0, 45115.0, 45247.32129018068, 13438.529651462151, 13744.518941836988, 13761.036727428984, 13777.380017899219, 13825.0, 11784.705382365339, 11963.64109076729, 11975.161738678209, 11983.46074426653, 12054.095942804324, 10989.890101099047, 11531.0, 11544.480498377594, 11585.76828463426, 11637.767244655059, 4717.481077081518, 5492.368377636623, 5500.972495137578, 5544.22380866679, 5551.3893471718075, 1080.864891888514, 1105.2760441910561, 1113.4154568851256, 1129.5538262386312, 1166.7141550320057, 21039.579208416053, 26919.057832976145, 27068.323291917466, 27186.184414467596, 27768.861155694092, 1003.8092762375126, 1184.1474138620351, 1196.9222000569935, 1216.3735676126803, 1254.4668515880714, 13678.247696376795, 13757.646301295346, 13839.54684758086, 13912.956528260422, 13978.44086236539, 397087.0145649311, 478337.0, 478411.0, 479348.0, 479565.0, 46083.0, 47273.527264726916, 54891.45108548943, 54905.72547137239, 55054.44945550493, 1195.5038658956435, 1350.4058214385639, 1373.6291201375773, 1384.7715127004133, 1385.25888649572, 25162.748372516042, 25506.489870202862, 25515.48969020572, 25932.0, 26098.60852087182, 39125.0, 39240.803795980835, 39320.80339598398, 39331.80334098311, 39368.80315598518, 448232.0, 452710.0, 453935.0, 454404.0, 454915.0, 27820.86089569539, 27936.022239222344, 27991.580126297715, 28075.29811754641, 28080.29799255035, 35378.64621353857, 35829.82085089558, 36356.81821590875, 36438.72464463731, 36728.0, 30075.548866766578, 30141.0, 30513.93201237946, 31053.0, 31123.688763112987, 29343.559846601893, 29392.55911161377, 29616.703832962256, 29704.70295297106, 30133.794648213825, 30314.545281821232, 30362.84818575893, 30899.382012360078, 30918.536221956238, 31002.0, 23867.52264954726, 25945.740542594333, 27721.306967325978, 28283.292917677223, 28410.590729111813, 16299.348026078824, 18982.810171898105, 20735.0, 21176.669551635536, 21349.46626334354], "value": 17834.940649560212, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.38847513128206, 386.05609285297453, 404.215821306665, 408.16530195749726, 449.3260109835247, 19503.41489755306, 20768.68846967297, 20770.85760283184, 20962.895185524052, 21277.57444851102, 21292.680609790867, 21527.892360538215, 21583.892080539576, 22161.889190554066, 22296.8885155574, 6180.84547886302, 6453.838654033663, 6479.287278399373, 6490.707918143671, 6521.152250207467, 6084.391560843902, 6306.558540902139, 6338.429541341278, 6388.680565971683, 6396.200474940632, 6346.460550853183, 6350.920343541609, 6362.172917520716, 6364.809055728336, 6376.872462550747, 6196.4423201911595, 6273.968630156843, 6309.621422714652, 6406.327335629739, 6412.166418365629, 6200.844978875519, 6231.4391704746795, 6260.718267677966, 6279.0, 6303.684815759194, 22591.661125083137, 26043.479130417287, 26060.0, 26222.86888565564, 26372.60441093385, 2971.628546431696, 3308.768386212966, 3319.0374791310733, 3352.6312105668358, 3374.3588718143474, 15514.298547686802, 15682.451114211062, 16132.0, 16613.00321980685, 16828.07445590492, 1748.4754573627988, 1790.2123065851115, 1986.970195447055, 1987.7316562264054, 2009.5880344529337, 98771.0, 116763.0, 121750.78249217483, 121838.56322873493, 125107.37446312801, 19908.800911990984, 20697.758134511976, 21914.671279930815, 22448.551028979327, 22521.973022427734, 33485.0, 33811.4928276076, 33976.0, 34070.0, 34082.82958585191, 8772.429792063496, 10589.523471443803, 10606.15150787935, 10808.135349172047, 10914.945425272823, 7708.0, 8497.150284971576, 8766.868496972551, 8813.69152079687, 8998.01021887592, 8567.614457349435, 10018.499075046218, 10206.36698128296, 10357.792844143074, 10544.103751181236, 3775.962240377616, 4415.602595766396, 4421.9336709949375, 4448.911021779546, 4478.552144785495, 977.0913050862766, 1013.5337744637402, 1015.7562185075528, 1016.6390931219458, 1063.6117816996896, 11853.99241064502, 13169.67075823093, 13514.189148651112, 13824.239666818421, 13992.23042732639, 1030.5002073994108, 1038.9116925061303, 1052.7947050325267, 1065.1478816946412, 1070.384528895888, 6833.180018397824, 7012.439004879598, 7026.824329391704, 7194.424446044304, 7227.89158162628, 702217.0, 716127.258091129, 762367.0, 765091.0, 781372.0, 123460.0, 129912.0, 131296.3435182837, 133784.0, 137949.62050379568, 1235.234154823997, 1256.8931640810451, 1291.3019379515906, 1292.5394304435927, 1299.064673435125, 12212.267263964191, 12291.0, 12440.19138755978, 12472.625821225378, 12595.496180152692, 54235.72882135564, 55060.0, 55740.72129639326, 55848.72075639596, 56998.57503562444, 77833.0, 79162.57282083227, 80969.0, 80987.59506202431, 81317.18682813096, 9526.9044059934, 10436.217283703905, 10687.786244274916, 10995.560177592806, 11482.081433485135, 12245.448954796877, 12265.141440099107, 12541.811872822098, 12597.181183223061, 12626.810597841224, 9743.13639794977, 10847.457627118454, 10906.0, 10981.945090274497, 11226.719332016439, 10635.627753028606, 10757.085647719718, 10826.56693732242, 10944.507497162806, 11093.778124437305, 10879.456027198767, 11070.501827417624, 11119.11047116245, 11167.609133680608, 11203.60787372438, 10844.132469402586, 10854.837177442187, 11057.391843448688, 11221.382823944436, 11257.324560526395, 9142.542872856198, 9775.826900771954, 10425.530851111567, 10783.24517283814, 11009.229353945468], "value": 10873.878359260554, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1420.7087547052852, 1523.3906437425028, 1526.9847301526981, 1549.938002479901, 1576.6925449537341, 9342.159205671489, 9603.567839447223, 10684.78630427391, 11352.43237838108, 11401.885981140196, 10560.26078174528, 10928.836067458995, 10936.453177341122, 10947.781044379108, 10959.671209863696, 2382.463945612241, 2409.4337830609793, 2411.131992482705, 2421.5641184586766, 2423.3456966619, 2350.764923507653, 2367.1359953616893, 2385.189035727852, 2392.820538459614, 2398.5083057973075, 2164.6428339323993, 2184.3337781976493, 2186.0, 2187.726534183227, 2187.8359123065834, 2200.3948914048765, 2253.684484172209, 2260.208926875605, 2277.3851060213815, 2277.601419751537, 2354.458474550846, 2356.045801450415, 2356.4580146566213, 2364.113457453455, 2367.9052837886466, 11014.50434730439, 11099.55601775928, 11120.332780033224, 11123.777524449546, 11141.888581114166, 5752.913706294409, 5901.557383196235, 5913.172155898178, 5918.526517878602, 5927.555433342516, 3336.7831090979007, 3479.8434070466637, 3655.1227705350525, 3661.908452288714, 3668.266346730638, 1088.9509972051276, 1131.162939424828, 1156.0751398880946, 1157.7279339355246, 1161.349644199251, 15180.240987950669, 15319.846801531954, 15333.923330383388, 15378.0, 15389.615259618598, 4138.958610413857, 4725.605946245866, 4867.537583929521, 4922.360093187863, 4939.5554400104165, 12726.0, 12810.231386116862, 12825.0, 12857.549985750455, 12859.42132604035, 5769.365369809318, 5859.970700146472, 5862.03276459388, 5890.705464726747, 5935.7625694972585, 4417.491988421309, 4929.260610908393, 5170.457102004236, 5182.896342073137, 5272.340957380327, 3959.920801583952, 4028.4762980812307, 4062.7968601569805, 4112.403701463331, 4159.334506478949, 1095.0856035210688, 1096.4791723931069, 1102.7298311913632, 1110.4614262082882, 1114.9832752508719, 755.61463653536, 829.4111181061514, 833.6498670558381, 936.8594710793299, 941.9670311539063, 6399.488040956712, 6409.743610255631, 6458.451031662267, 6530.575512591667, 6654.966725166343, 952.4666186935339, 991.7768502086973, 995.2137811129127, 1003.8845532763679, 1022.9310370662675, 4059.9594004060173, 4231.365295205744, 4234.470691163605, 4259.87220383389, 4347.739135651871, 10986.670399888017, 13452.0, 13619.250941198132, 13627.523036693668, 13745.725085498234, 10118.392896426238, 13270.601881943365, 13565.796513052312, 13575.932120339336, 13576.864231357758, 8701.521416322037, 10077.143442807297, 10123.392596444237, 10221.386716797017, 10233.0, 5991.700414979321, 6645.401913827779, 6684.866302674017, 6754.155730533684, 6854.622995735083, 11788.115891308358, 11857.34784586856, 11905.761884762083, 12060.216085954386, 12093.334866582423, 10763.46182690878, 12286.508539658313, 12343.629691109281, 12363.32001739913, 12424.37878106073, 8064.274215320649, 8262.669493220204, 9012.41419307743, 9053.0, 9336.97293297723, 10183.898161018591, 10327.225458090823, 10415.84376234342, 10415.94792026035, 10433.9478302608, 9001.639934402812, 9031.50326732036, 9060.90939090627, 9101.544922753968, 9241.306901982512, 8721.956390218262, 8844.95577522134, 8868.467891926248, 8950.015498295312, 9040.186383225542, 6847.828804279734, 7903.209679032051, 7908.485948413335, 8014.83970320602, 8028.879566806386, 5893.351731309467, 5937.0, 5997.460228579449, 6004.279486461653, 6155.384461553809, 5132.97433512845, 5798.971005144947, 5933.703314834327, 6054.757809687563, 6190.81427557174], "value": 5086.682179958994, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.6427968451077, 369.84466524059894, 379.60331453630954, 380.288859832114, 387.5775404808759, 5093.191916869514, 5328.786848526059, 5331.706756128421, 5343.572514198864, 5412.323459567554, 4985.227289770091, 5167.4574169712105, 5213.296205012322, 5219.556337711289, 5228.189630607262, 4177.289860723669, 4352.934705979397, 4355.782210889451, 4360.847370342039, 4362.716423432483, 3739.420389839566, 3810.7141964352645, 4137.441445404877, 4292.0, 4306.8277268909205, 3830.042489377656, 4246.554111818261, 4246.6218917406195, 4253.617973934591, 4308.956910430903, 4271.231178387889, 4285.45723539524, 4312.741235525863, 4320.848770293056, 4356.324769660708, 3562.786232826039, 3739.0278527582755, 3835.4438606401914, 3934.272159650474, 4016.4176194451934, 4219.156168766259, 4985.675931064506, 5052.8231511897275, 5085.694858308513, 5145.485451454824, 4128.823285363687, 4303.827846886121, 4856.902861942776, 4874.683145595525, 4919.237518184687, 5100.617453690988, 5165.302684137669, 5255.738622730555, 5471.699056551888, 5596.524295434893, 3996.160806230695, 4367.737935723867, 4412.514623391425, 4499.302608095751, 4510.661700372485, 4786.922942337981, 4935.7532123393685, 5159.458256883048, 5593.664380137164, 5640.435956404327, 4006.856331862498, 4069.2878746219294, 4284.614384705329, 4338.544452832471, 4505.639548836085, 4226.873193804191, 4370.950971766753, 4617.12274667812, 4624.583787459078, 4680.485146633868, 4267.610138322487, 4392.9121417572105, 4460.598546130799, 4608.055348653518, 4695.906081878344, 5512.4211957744665, 5515.862103447446, 5551.805686800943, 5554.583406244547, 5560.972195139079, 1404.9297535123203, 1512.7141929360175, 1555.502239283441, 1571.8349573294868, 1577.4084718230663, 959.7696552827272, 1099.428297285407, 1170.449888552379, 1186.7982442984714, 1190.7618476304774, 4811.975940120277, 5277.366715994105, 5277.894442111136, 5296.788128474895, 5353.170258609922, 4960.330355401975, 5289.365276166807, 5838.94161058384, 5844.620099693507, 5879.794207202727, 4373.703805502073, 4847.776228807803, 5206.271122042917, 5309.0, 5315.654482458628, 2680.2227354067104, 2737.3704048069058, 2775.125835361895, 2821.9858900705367, 3021.9546706799415, 5795.594308398372, 5873.442023007808, 5992.520598352208, 5994.730237139339, 6037.245344331958, 4718.88202794926, 5052.797888084436, 5809.8547536311935, 5871.647701137946, 5968.910466343008, 5135.948640513547, 5489.560835133179, 5572.749226284827, 5627.986962346817, 6114.471382154461, 4714.717116972993, 5294.444083371191, 5560.888782224414, 5796.217510636179, 5817.156512305776, 5522.337319521683, 5635.830925072254, 5678.517326027334, 5703.771849126155, 5706.771729130955, 5567.387587365306, 5678.290213723285, 5813.970930145322, 6121.3572574879, 6178.37419096891, 3745.419459983707, 3762.830672619684, 3929.823157957956, 4497.0, 4573.634109271184, 4887.97352555953, 4960.090365209348, 5101.464346243591, 5689.358810361289, 5716.399778023414, 4830.589399901048, 5338.306020217502, 5535.6991107089, 5638.0266906582365, 5677.870798450581, 4573.908521829611, 4923.926141107958, 5591.608587398843, 5602.943970560405, 5620.409856965123, 4863.659543831898, 4978.187324161837, 5195.363460509927, 5415.23641069453, 5541.667499950016, 4402.405675233803, 4967.484917100319, 5365.853658536616, 5554.861128471821, 5708.829689913641, 4966.1941003333, 5121.950000250014, 5507.476789704971, 5542.2795036644975, 5603.523700485504], "value": 4221.236658348062, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [712.6009434716556, 749.2994050562728, 772.9111152217495, 778.6885245901639, 839.6347588798872, 15278.847211527882, 15807.288672009745, 16077.0, 17522.299108035662, 18412.0, 15324.6935061299, 17596.20817063232, 17618.0, 17642.82357176428, 17651.470455886312, 916.2624087609472, 942.5098948546786, 945.3477100800426, 945.3902233059672, 947.4315410753561, 908.9864800747152, 943.6319835264252, 965.0831709875611, 965.7537327981355, 966.0291407135819, 861.5519929636616, 978.5498670611491, 999.5302207962246, 1004.5429329655026, 1004.6433516101788, 843.1863251961855, 972.7081875437411, 972.9173020293283, 982.6069572171117, 987.5111819649247, 730.3244498838607, 733.2337707096098, 733.8789099798527, 733.8789099798527, 734.5923012727934, 14081.859181408157, 16104.033757974441, 16318.347266109342, 16496.587585310343, 17092.0, 14628.561143165722, 14769.0, 14859.925700371537, 14877.702445951129, 15338.156401397919, 10548.419836908966, 11542.711432214262, 11617.593384231512, 11687.649370518813, 11915.106367022508, 4220.6412454941365, 4580.175568397687, 4585.747783871886, 4621.2200299265505, 4832.444268909086, 92088.0, 96351.51824240905, 105406.47296763543, 105513.47243263734, 105880.0, 10165.745856353651, 10366.533505992098, 10496.107830834311, 10709.357438553556, 11068.723281918017, 21519.924003799748, 21638.02628881704, 21744.0, 21804.45488862791, 21816.0, 7775.222477752292, 7890.64492097857, 7913.129555748863, 7924.881126783102, 8018.037835459782, 4080.6123418275215, 4183.523718863989, 4270.679699022524, 4277.7647229402055, 4314.525402205755, 3179.6979286968162, 3269.7547683923326, 3270.9509357359657, 3271.9345613087603, 3291.4733642617543, 627.9372062793684, 629.4523764325066, 631.9747210111544, 633.9904901426482, 650.0379438431148, 502.88685045865117, 530.3053000569266, 532.9493698098674, 537.1378936806448, 547.4005963469994, 8951.776205594782, 9971.40171589707, 9984.35101718386, 10022.16719255506, 10058.390657494765, 616.9383061693794, 643.4935924573759, 644.6518879804853, 650.3561474140662, 652.8988006858945, 4579.839705610288, 4743.407074115736, 4748.738819364899, 4755.262934245197, 4812.181929072066, 102846.48576757219, 104127.4793626027, 104231.4788426053, 104759.0, 106936.0, 77779.44441111146, 89858.0, 90698.54650726705, 90961.54519227361, 92886.53556732308, 77875.61062194766, 79325.60337198277, 79766.0, 79872.20127798764, 80610.0, 8732.781680457785, 9313.720588382359, 9340.159385655325, 9342.439453632804, 9344.0, 45297.54702452933, 47356.052878942915, 48198.0, 50355.99288014293, 52054.73972630112, 55892.44107559035, 59007.40992590019, 62773.686131570874, 64319.0, 72112.0, 13816.378262978391, 13985.510507132201, 14036.157830530201, 14245.274132537286, 14490.0, 14955.0, 14966.941490421015, 15170.24148792578, 15217.315220815311, 15272.389104435699, 13790.724185516034, 13855.515056972958, 13995.650108747363, 14019.29903504841, 14138.575842724735, 12387.566435174725, 14030.158190508602, 14459.060161089496, 14767.630809229855, 15146.318415671101, 13649.931750341184, 13688.589342319747, 13703.246321452416, 13805.930970345486, 14624.561263162122, 10083.0, 11024.283421577571, 11194.888051119711, 11751.588694395656, 11847.348395838311, 8898.555072246232, 10895.96488333607, 10997.002997002997, 11525.538978440769, 11735.882641173479], "value": 7640.058877347002, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1552.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 120.0, 117.0, 121.0, 119.0, 119.0, 118.0], "value": 118.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 124.0, 109.0, 138.0, 136.0, 101.0, 141.0, 138.0, 148.0, 112.0], "value": 129.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 205.0, 199.0, 203.0, 200.0, 194.0, 198.0, 183.0, 200.0, 197.0], "value": 197.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 86.0, 77.0, 88.0, 63.0, 63.0, 65.0, 83.0, 96.0, 77.0], "value": 80.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 69.0, 83.0, 74.0, 71.0, 69.0, 96.0, 71.0, 70.0, 69.0], "value": 76.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 132.0, 110.0, 113.0, 83.0, 126.0, 136.0, 135.0, 133.0, 114.0], "value": 118.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 99.0, 99.0, 122.0, 98.0, 98.0, 100.0, 97.0, 97.0, 98.0], "value": 100.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 143.0, 74.0, 144.0, 76.0, 148.0, 76.0, 93.0, 114.0, 130.0], "value": 108.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 66.0, 74.0, 95.0, 98.0, 88.0, 67.0, 67.0], "value": 74.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 71.0, 84.0, 100.0, 89.0, 66.0, 61.0, 61.0, 64.0, 62.0], "value": 71.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 87.0, 86.0, 84.0, 87.0, 81.0, 87.0, 91.0, 83.0, 89.0], "value": 85.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 158.0, 145.0, 150.0, 135.0, 142.0, 148.0, 140.0, 220.0, 150.0], "value": 153.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 170.0, 167.0, 184.0, 169.0, 171.0, 167.0, 166.0, 177.0, 165.0], "value": 170.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 64.0, 65.0, 65.0, 68.0, 67.0, 67.0, 65.0, 78.0, 68.0], "value": 67.5, "unit": "score"}]}]} 02:31:44 INFO - Return code: 0 02:31:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:31:45 ERROR - # TBPL SUCCESS # 02:31:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:31:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:31:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:31:45 INFO - 2017-03-23 02:31:45.044 screenresolution[1665:11227] starting screenresolution argv=screenresolution get 02:31:45 INFO - 2017-03-23 02:31:45.047 screenresolution[1665:11227] Display 0: 1600x1200x32@60 02:31:45 INFO - 2017-03-23 02:31:45.054 screenresolution[1666:11230] starting screenresolution argv=screenresolution list 02:31:45 INFO - Available Modes on Display 0 02:31:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:31:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:31:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:31:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:31:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:31:45 INFO - Intel Iris: 02:31:45 INFO - Chipset Model: Intel Iris 02:31:45 INFO - Type: GPU 02:31:45 INFO - Bus: Built-In 02:31:45 INFO - VRAM (Dynamic, Max): 1536 MB 02:31:45 INFO - Vendor: Intel (0x8086) 02:31:45 INFO - Device ID: 0x0a2e 02:31:45 INFO - Revision ID: 0x0009 02:31:45 INFO - Displays: 02:31:45 INFO - Display: 02:31:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:31:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:31:45 INFO - Display Serial Number: 1600x1200 60 02:31:45 INFO - Main Display: Yes 02:31:45 INFO - Mirror: Off 02:31:45 INFO - Online: Yes 02:31:45 INFO - Rotation: Supported 02:31:45 INFO - Return code: 0 02:31:45 INFO - Running post-action listener: _resource_record_post_action 02:31:45 INFO - [mozharness: 2017-03-23 09:31:45.292927Z] Finished run-tests step (success) 02:31:45 INFO - Running post-run listener: _resource_record_post_run 02:31:45 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 39536640; Write bytes: 515253248; Read time: 255; Write time: 1897 02:31:45 INFO - TinderboxPrint: CPU usage
54.4% 02:31:45 INFO - TinderboxPrint: I/O read bytes / time
39,536,640 / 255 02:31:45 INFO - TinderboxPrint: I/O write bytes / time
515,253,248 / 1,897 02:31:45 INFO - TinderboxPrint: CPU idle
2,188.1 (45.6%) 02:31:45 INFO - TinderboxPrint: CPU system
962.1 (20.0%) 02:31:45 INFO - TinderboxPrint: CPU user
1,651.4 (34.4%) 02:31:45 INFO - TinderboxPrint: Swap in / out
248,532,992 / 0 02:31:45 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 197734912; Write bytes: 190050304; Read time: 15896; Write time: 420 02:31:45 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 38574080; Write bytes: 305435648; Read time: 241; Write time: 1419 02:31:45 INFO - Running post-run listener: _upload_blobber_files 02:31:45 INFO - Blob upload gear active. 02:31:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:31:45 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 02:31:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:31:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:31:46 INFO - (blobuploader) - INFO - Open directory for files ... 02:31:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:31:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:31:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:31:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:31:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:31:46 INFO - (blobuploader) - INFO - Done attempting. 02:31:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:31:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:31:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:31:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:31:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:31:47 INFO - (blobuploader) - INFO - Done attempting. 02:31:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:31:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:31:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:31:49 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:31:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:31:49 INFO - (blobuploader) - INFO - Done attempting. 02:31:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:31:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:31:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:31:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:31:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:31:52 INFO - (blobuploader) - INFO - Done attempting. 02:31:52 INFO - (blobuploader) - INFO - Iteration through files over. 02:31:52 INFO - Return code: 0 02:31:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:31:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:31:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/59dc99e668e715bb39a6ccda21e03ab8483e398edcfc99b42f00e955b551edde3453c5ccf7102db7fc7bef168bacde7262d1edd2fc3c0b4d71db86a28895e99b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/abc0a6fe0a63ea37b799cf2e8ecb0c20a9469241fe7ceda9f3af5a6436bbbd25290f6ad75448e673569d813659880638e6871358b955ab94768562b16a2dfab1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/10876dd4820e61befd89079df740a447862d2efe5a55b19038bf718b69758ffefe67febb421f22b8b0add95fc5bbf9e273dde3e1d11f5446ab5970b4cd47313e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/797dcd0b9282dc36960e4c0039e1f52f2ca1b0b3faf56648bd5dee2f23720ee75672db274faa74a26d8c71520c0e7a733b6c85e8fb2cd3bb4b31ed7913da2a68"} 02:31:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:31:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:31:52 INFO - Contents: 02:31:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/59dc99e668e715bb39a6ccda21e03ab8483e398edcfc99b42f00e955b551edde3453c5ccf7102db7fc7bef168bacde7262d1edd2fc3c0b4d71db86a28895e99b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/abc0a6fe0a63ea37b799cf2e8ecb0c20a9469241fe7ceda9f3af5a6436bbbd25290f6ad75448e673569d813659880638e6871358b955ab94768562b16a2dfab1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/10876dd4820e61befd89079df740a447862d2efe5a55b19038bf718b69758ffefe67febb421f22b8b0add95fc5bbf9e273dde3e1d11f5446ab5970b4cd47313e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/797dcd0b9282dc36960e4c0039e1f52f2ca1b0b3faf56648bd5dee2f23720ee75672db274faa74a26d8c71520c0e7a733b6c85e8fb2cd3bb4b31ed7913da2a68"} 02:31:52 INFO - Running post-run listener: copy_logs_to_upload_dir 02:31:52 INFO - Copying logs to upload dir... 02:31:52 INFO - mkdir: /builds/slave/test/build/upload/logs 02:31:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1285.861249 ========= master_lag: 0.21 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-03-23 02:31:52.207365) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-23 02:31:52.212774) ========= 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.zCJcj5fX54/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.ihyEqUkPZ5/Listeners TMPDIR=/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/59dc99e668e715bb39a6ccda21e03ab8483e398edcfc99b42f00e955b551edde3453c5ccf7102db7fc7bef168bacde7262d1edd2fc3c0b4d71db86a28895e99b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/abc0a6fe0a63ea37b799cf2e8ecb0c20a9469241fe7ceda9f3af5a6436bbbd25290f6ad75448e673569d813659880638e6871358b955ab94768562b16a2dfab1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/10876dd4820e61befd89079df740a447862d2efe5a55b19038bf718b69758ffefe67febb421f22b8b0add95fc5bbf9e273dde3e1d11f5446ab5970b4cd47313e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/797dcd0b9282dc36960e4c0039e1f52f2ca1b0b3faf56648bd5dee2f23720ee75672db274faa74a26d8c71520c0e7a733b6c85e8fb2cd3bb4b31ed7913da2a68"} build_url:https://queue.taskcluster.net/v1/task/V9QZeFUpQFG9jrSQWTOApg/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011083 build_url: 'https://queue.taskcluster.net/v1/task/V9QZeFUpQFG9jrSQWTOApg/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/59dc99e668e715bb39a6ccda21e03ab8483e398edcfc99b42f00e955b551edde3453c5ccf7102db7fc7bef168bacde7262d1edd2fc3c0b4d71db86a28895e99b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/abc0a6fe0a63ea37b799cf2e8ecb0c20a9469241fe7ceda9f3af5a6436bbbd25290f6ad75448e673569d813659880638e6871358b955ab94768562b16a2dfab1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/10876dd4820e61befd89079df740a447862d2efe5a55b19038bf718b69758ffefe67febb421f22b8b0add95fc5bbf9e273dde3e1d11f5446ab5970b4cd47313e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/797dcd0b9282dc36960e4c0039e1f52f2ca1b0b3faf56648bd5dee2f23720ee75672db274faa74a26d8c71520c0e7a733b6c85e8fb2cd3bb4b31ed7913da2a68"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-23 02:31:52.247582) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 02:31:52.247900) ========= 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.zCJcj5fX54/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.ihyEqUkPZ5/Listeners TMPDIR=/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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.005106 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 02:31:52.296293) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-23 02:31:52.296621) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-23 02:31:52.296949) ========= ========= Total master_lag: 0.35 =========