builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0077 starttime: 1460812991.38 results: success (0) buildid: 20160416045017 builduid: 92fced6d8bb54c7495284b27fc272d37 revision: 1da1937a9e03154ae7c60089f2dcf5ad9ee20fa3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-16 06:23:11.383490) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-16 06:23:11.384128) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-16 06:23:11.384406) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-16 06:23:11.447248) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 06:23:11.447517) ========= 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.UWBjIpLiqX/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.NZC2IUAKHW/Listeners TMPDIR=/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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 --2016-04-16 06:23:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 47.3M=0s 2016-04-16 06:23:12 (47.3 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.642691 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 06:23:12.108143) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 06:23:12.108462) ========= 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.UWBjIpLiqX/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.NZC2IUAKHW/Listeners TMPDIR=/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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.019723 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 06:23:12.160269) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-16 06:23:12.160616) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1da1937a9e03154ae7c60089f2dcf5ad9ee20fa3 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 1da1937a9e03154ae7c60089f2dcf5ad9ee20fa3 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.UWBjIpLiqX/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.NZC2IUAKHW/Listeners TMPDIR=/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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 2016-04-16 06:23:12,236 truncating revision to first 12 chars 2016-04-16 06:23:12,236 Setting DEBUG logging. 2016-04-16 06:23:12,236 attempt 1/10 2016-04-16 06:23:12,236 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1da1937a9e03?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-16 06:23:13,351 unpacking tar archive at: mozilla-central-1da1937a9e03/testing/mozharness/ program finished with exit code 0 elapsedTime=1.364644 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-16 06:23:13.544789) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-16 06:23:13.545110) ========= script_repo_revision: 1da1937a9e03154ae7c60089f2dcf5ad9ee20fa3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-16 06:23:13.545505) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-16 06:23:13.545800) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-16 06:23:13.559764) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 10 secs) (at 2016-04-16 06:23:13.560230) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.UWBjIpLiqX/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.NZC2IUAKHW/Listeners TMPDIR=/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 06:23:13 INFO - MultiFileLogger online at 20160416 06:23:13 in /builds/slave/test 06:23:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:23:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:23:13 INFO - {'append_to_log': False, 06:23:13 INFO - 'base_work_dir': '/builds/slave/test', 06:23:13 INFO - 'blob_upload_branch': 'Firefox', 06:23:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:23:13 INFO - 'branch': 'Firefox', 06:23:13 INFO - 'buildbot_json_path': 'buildprops.json', 06:23:13 INFO - 'config_files': ('talos/mac_config.py',), 06:23:13 INFO - 'default_actions': ('clobber', 06:23:13 INFO - 'read-buildbot-config', 06:23:13 INFO - 'download-and-extract', 06:23:13 INFO - 'populate-webroot', 06:23:13 INFO - 'create-virtualenv', 06:23:13 INFO - 'install', 06:23:13 INFO - 'run-tests'), 06:23:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:23:13 INFO - 'download_minidump_stackwalk': True, 06:23:13 INFO - 'download_symbols': 'ondemand', 06:23:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:23:13 INFO - 'tooltool.py': '/tools/tooltool.py', 06:23:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:23:13 INFO - '/tools/misc-python/virtualenv.py')}, 06:23:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:23:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:23:13 INFO - 'installer_path': 'installer.exe', 06:23:13 INFO - 'log_level': 'info', 06:23:13 INFO - 'log_name': 'talos', 06:23:13 INFO - 'log_to_console': True, 06:23:13 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:23:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:23:13 INFO - 'opt_config_files': (), 06:23:13 INFO - 'pip_index': False, 06:23:13 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:23:13 INFO - 'cmd': ('bash', 06:23:13 INFO - '-c', 06:23:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:23:13 INFO - 'enabled': True, 06:23:13 INFO - 'halt_on_failure': False, 06:23:13 INFO - 'name': 'check_screen_resolution'},), 06:23:13 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:23:13 INFO - 'cmd': ('bash', 06:23:13 INFO - '-c', 06:23:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:23:13 INFO - 'enabled': True, 06:23:13 INFO - 'halt_on_failure': False, 06:23:13 INFO - 'name': 'check_screen_resolution'},), 06:23:13 INFO - 'run_cmd_checks_enabled': True, 06:23:13 INFO - 'sps_profile': False, 06:23:13 INFO - 'sps_profile_interval': 0, 06:23:13 INFO - 'suite': 'dromaeojs-e10s', 06:23:13 INFO - 'system_bits': '32', 06:23:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:23:13 INFO - 'title': 't-yosemite-r7-0077', 06:23:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:23:13 INFO - 'use_talos_json': True, 06:23:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:23:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:23:13 INFO - 'work_dir': 'build'} 06:23:13 INFO - ##### 06:23:13 INFO - ##### Running clobber step. 06:23:13 INFO - ##### 06:23:13 INFO - Running pre-action listener: _resource_record_pre_action 06:23:13 INFO - Running main action method: clobber 06:23:13 INFO - rmtree: /builds/slave/test/build 06:23:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:23:15 INFO - Running post-action listener: _resource_record_post_action 06:23:15 INFO - ##### 06:23:15 INFO - ##### Running read-buildbot-config step. 06:23:15 INFO - ##### 06:23:15 INFO - Running pre-action listener: _resource_record_pre_action 06:23:15 INFO - Running main action method: read_buildbot_config 06:23:15 INFO - Using buildbot properties: 06:23:15 INFO - { 06:23:15 INFO - "project": "", 06:23:15 INFO - "product": "firefox", 06:23:15 INFO - "script_repo_revision": "production", 06:23:15 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 06:23:15 INFO - "repository": "", 06:23:15 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 06:23:15 INFO - "buildid": "20160416045017", 06:23:15 INFO - "pgo_build": "False", 06:23:15 INFO - "basedir": "/builds/slave/test", 06:23:15 INFO - "buildnumber": 193, 06:23:15 INFO - "slavename": "t-yosemite-r7-0077", 06:23:15 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 06:23:15 INFO - "platform": "yosemite_r7", 06:23:15 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 06:23:15 INFO - "branch": "mozilla-central", 06:23:15 INFO - "repo_path": "mozilla-central", 06:23:15 INFO - "revision": "1da1937a9e03154ae7c60089f2dcf5ad9ee20fa3", 06:23:15 INFO - "stage_platform": "macosx64", 06:23:15 INFO - "builduid": "92fced6d8bb54c7495284b27fc272d37", 06:23:15 INFO - "slavebuilddir": "test" 06:23:15 INFO - } 06:23:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/HrFnlNu-TPqUvGxGGwnpSQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 06:23:15 INFO - Running post-action listener: _resource_record_post_action 06:23:15 INFO - ##### 06:23:15 INFO - ##### Running download-and-extract step. 06:23:15 INFO - ##### 06:23:15 INFO - Running pre-action listener: _resource_record_pre_action 06:23:15 INFO - Running main action method: download_and_extract 06:23:15 INFO - mkdir: /builds/slave/test/build/tests 06:23:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:23:15 INFO - https://queue.taskcluster.net/v1/task/HrFnlNu-TPqUvGxGGwnpSQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 06:23:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HrFnlNu-TPqUvGxGGwnpSQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 06:23:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HrFnlNu-TPqUvGxGGwnpSQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 06:23:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HrFnlNu-TPqUvGxGGwnpSQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 06:23:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HrFnlNu-TPqUvGxGGwnpSQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 06:23:45 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HrFnlNu-TPqUvGxGGwnpSQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json: timed out 06:23:45 INFO - retry: attempt #1 caught exception: timed out 06:23:45 INFO - retry: Failed, sleeping 30 seconds before retrying 06:24:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HrFnlNu-TPqUvGxGGwnpSQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #2 06:24:16 INFO - Downloaded 1199 bytes. 06:24:16 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 06:24:16 INFO - Using the following test package requirements: 06:24:16 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 06:24:16 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:24:16 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 06:24:16 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:24:16 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 06:24:16 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:24:16 INFO - u'jsshell-mac.zip'], 06:24:16 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:24:16 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 06:24:16 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 06:24:16 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:24:16 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 06:24:16 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:24:16 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 06:24:16 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:24:16 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 06:24:16 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:24:16 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 06:24:16 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:24:16 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:16 INFO - https://queue.taskcluster.net/v1/task/HrFnlNu-TPqUvGxGGwnpSQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:24:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HrFnlNu-TPqUvGxGGwnpSQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 06:24:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HrFnlNu-TPqUvGxGGwnpSQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 06:24:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HrFnlNu-TPqUvGxGGwnpSQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 06:24:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HrFnlNu-TPqUvGxGGwnpSQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:24:18 INFO - Downloaded 18031932 bytes. 06:24:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:24:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 06:24:21 INFO - Return code: 0 06:24:21 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 06:24:21 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:21 INFO - https://queue.taskcluster.net/v1/task/HrFnlNu-TPqUvGxGGwnpSQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:24:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HrFnlNu-TPqUvGxGGwnpSQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 06:24:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HrFnlNu-TPqUvGxGGwnpSQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 06:24:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HrFnlNu-TPqUvGxGGwnpSQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 06:24:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HrFnlNu-TPqUvGxGGwnpSQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:24:22 INFO - Downloaded 18031932 bytes. 06:24:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:24:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 06:24:26 INFO - Return code: 0 06:24:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:26 INFO - https://queue.taskcluster.net/v1/task/HrFnlNu-TPqUvGxGGwnpSQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 06:24:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HrFnlNu-TPqUvGxGGwnpSQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 06:24:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HrFnlNu-TPqUvGxGGwnpSQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 06:24:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HrFnlNu-TPqUvGxGGwnpSQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 06:24:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HrFnlNu-TPqUvGxGGwnpSQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 06:24:29 INFO - Downloaded 10841076 bytes. 06:24:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:24:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 06:24:30 INFO - Return code: 0 06:24:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:30 INFO - https://queue.taskcluster.net/v1/task/HrFnlNu-TPqUvGxGGwnpSQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 06:24:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HrFnlNu-TPqUvGxGGwnpSQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 06:24:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HrFnlNu-TPqUvGxGGwnpSQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 06:24:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HrFnlNu-TPqUvGxGGwnpSQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 06:24:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HrFnlNu-TPqUvGxGGwnpSQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 06:24:35 INFO - Downloaded 109862483 bytes. 06:24:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HrFnlNu-TPqUvGxGGwnpSQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 06:24:35 INFO - mkdir: /builds/slave/test/properties 06:24:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:24:35 INFO - Writing to file /builds/slave/test/properties/build_url 06:24:35 INFO - Contents: 06:24:35 INFO - build_url:https://queue.taskcluster.net/v1/task/HrFnlNu-TPqUvGxGGwnpSQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 06:24:36 INFO - Running post-action listener: _resource_record_post_action 06:24:36 INFO - Running post-action listener: set_extra_try_arguments 06:24:36 INFO - ##### 06:24:36 INFO - ##### Running populate-webroot step. 06:24:36 INFO - ##### 06:24:36 INFO - Running pre-action listener: _resource_record_pre_action 06:24:36 INFO - Running main action method: populate_webroot 06:24:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:24:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:24:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:24:36 INFO - '--tppagecycles', 06:24:36 INFO - '7'], 06:24:36 INFO - 'tests': ['tsvgm']}}, 06:24:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:24:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:24:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:24:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:24:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:24:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:24:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:24:36 INFO - 'talos_options': ['--disable-e10s'], 06:24:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:24:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:24:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:24:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:24:36 INFO - 'talos_options': ['--disable-e10s'], 06:24:36 INFO - 'tests': ['damp', 'tps']}, 06:24:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:24:36 INFO - 'tests': ['damp', 'tps']}, 06:24:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:24:36 INFO - 'tests': ['dromaeo_dom']}, 06:24:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:24:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:24:36 INFO - 'tests': ['a11yr', 06:24:36 INFO - 'ts_paint', 06:24:36 INFO - 'tpaint', 06:24:36 INFO - 'sessionrestore', 06:24:36 INFO - 'sessionrestore_no_auto_restore', 06:24:36 INFO - 'tabpaint']}, 06:24:36 INFO - 'other-e10s': {'tests': ['a11yr', 06:24:36 INFO - 'ts_paint', 06:24:36 INFO - 'tpaint', 06:24:36 INFO - 'sessionrestore', 06:24:36 INFO - 'sessionrestore_no_auto_restore', 06:24:36 INFO - 'tabpaint']}, 06:24:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:24:36 INFO - 'ts_paint', 06:24:36 INFO - 'tpaint', 06:24:36 INFO - 'sessionrestore', 06:24:36 INFO - 'sessionrestore_no_auto_restore', 06:24:36 INFO - 'tabpaint']}, 06:24:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:24:36 INFO - 'ts_paint', 06:24:36 INFO - 'tpaint', 06:24:36 INFO - 'sessionrestore', 06:24:36 INFO - 'sessionrestore_no_auto_restore', 06:24:36 INFO - 'tabpaint']}, 06:24:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:24:36 INFO - 'tests': ['a11yr', 06:24:36 INFO - 'ts_paint', 06:24:36 INFO - 'tpaint', 06:24:36 INFO - 'sessionrestore', 06:24:36 INFO - 'sessionrestore_no_auto_restore', 06:24:36 INFO - 'tabpaint']}, 06:24:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:24:36 INFO - 'tests': ['a11yr', 06:24:36 INFO - 'ts_paint', 06:24:36 INFO - 'tpaint', 06:24:36 INFO - 'sessionrestore', 06:24:36 INFO - 'sessionrestore_no_auto_restore', 06:24:36 INFO - 'tabpaint']}, 06:24:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:24:36 INFO - 'tests': ['tsvgx', 06:24:36 INFO - 'tsvgr_opacity', 06:24:36 INFO - 'tart', 06:24:36 INFO - 'tscrollx', 06:24:36 INFO - 'cart']}, 06:24:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:24:36 INFO - 'tsvgr_opacity', 06:24:36 INFO - 'tart', 06:24:36 INFO - 'tscrollx', 06:24:36 INFO - 'cart']}, 06:24:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:24:36 INFO - 'talos_options': ['--disable-e10s'], 06:24:36 INFO - 'tests': ['tp5o']}, 06:24:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:24:36 INFO - 'tests': ['tp5o']}, 06:24:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:24:36 INFO - 'talos_options': ['--disable-e10s', 06:24:36 INFO - '--xperf_path', 06:24:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:24:36 INFO - 'tests': ['tp5n']}, 06:24:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:24:36 INFO - 'talos_options': ['--xperf_path', 06:24:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:24:36 INFO - 'tests': ['tp5n']}}, 06:24:36 INFO - 'talos.zip': {'path': '', 06:24:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:24:36 INFO - Running post-action listener: _resource_record_post_action 06:24:36 INFO - ##### 06:24:36 INFO - ##### Running create-virtualenv step. 06:24:36 INFO - ##### 06:24:36 INFO - Running pre-action listener: _resource_record_pre_action 06:24:36 INFO - Running main action method: create_virtualenv 06:24:36 INFO - Creating virtualenv /builds/slave/test/build/venv 06:24:36 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:24:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:24:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:24:36 INFO - Using real prefix '/tools/python27' 06:24:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:24:37 INFO - Installing distribute.............................................................................................................................................................................................done. 06:24:40 INFO - Installing pip.................done. 06:24:40 INFO - Return code: 0 06:24:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:24:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:24:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:24:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:40 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 0x10d555a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d565420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd08ad94e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3f4e00>, '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 0x10d25ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d3efb20>, '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.UWBjIpLiqX/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.NZC2IUAKHW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:24:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:24:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:24:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UWBjIpLiqX/Render', 06:24:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:24:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:24:40 INFO - 'HOME': '/Users/cltbld', 06:24:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:24:40 INFO - 'LOGNAME': 'cltbld', 06:24:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:40 INFO - 'MOZ_NO_REMOTE': '1', 06:24:40 INFO - 'NO_EM_RESTART': '1', 06:24:40 INFO - 'PAGER': '/bin/cat', 06:24:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:24:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:24:40 INFO - 'PWD': '/builds/slave/test', 06:24:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:24:40 INFO - 'SHELL': '/bin/bash', 06:24:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NZC2IUAKHW/Listeners', 06:24:40 INFO - 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', 06:24:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:24:40 INFO - 'USER': 'cltbld', 06:24:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:24:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:24:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:24:40 INFO - 'XPC_FLAGS': '0x0', 06:24:40 INFO - 'XPC_SERVICE_NAME': '0', 06:24:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:24:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:24:40 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:24:40 INFO - Cleaning up... 06:24:40 INFO - Return code: 0 06:24:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:24:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:24:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:24:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:40 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d555a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d565420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd08ad94e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3f4e00>, '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 0x10d25ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d3efb20>, '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.UWBjIpLiqX/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.NZC2IUAKHW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:24:40 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>=0.7.1'] in /builds/slave/test/build 06:24:40 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>=0.7.1 06:24:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UWBjIpLiqX/Render', 06:24:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:24:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:24:40 INFO - 'HOME': '/Users/cltbld', 06:24:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:24:40 INFO - 'LOGNAME': 'cltbld', 06:24:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:40 INFO - 'MOZ_NO_REMOTE': '1', 06:24:40 INFO - 'NO_EM_RESTART': '1', 06:24:40 INFO - 'PAGER': '/bin/cat', 06:24:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:24:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:24:40 INFO - 'PWD': '/builds/slave/test', 06:24:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:24:40 INFO - 'SHELL': '/bin/bash', 06:24:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NZC2IUAKHW/Listeners', 06:24:40 INFO - 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', 06:24:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:24:40 INFO - 'USER': 'cltbld', 06:24:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:24:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:24:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:24:40 INFO - 'XPC_FLAGS': '0x0', 06:24:40 INFO - 'XPC_SERVICE_NAME': '0', 06:24:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:24:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:24:41 INFO - Downloading/unpacking psutil>=0.7.1 06:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:24:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:24:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:24:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:24:44 INFO - Installing collected packages: psutil 06:24:44 INFO - Running setup.py install for psutil 06:24:44 INFO - building 'psutil._psutil_osx' extension 06:24:44 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 06:24:44 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 06:24:44 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 06:24:44 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 06:24:45 INFO - building 'psutil._psutil_posix' extension 06:24:45 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 06:24:45 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:24:45 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:24:45 INFO - ^ 06:24:45 INFO - 1 warning generated. 06:24:45 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 06:24:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:24:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:24:45 INFO - Successfully installed psutil 06:24:45 INFO - Cleaning up... 06:24:45 INFO - Return code: 0 06:24:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:24:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:24:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:24:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d555a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d565420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd08ad94e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3f4e00>, '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 0x10d25ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d3efb20>, '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.UWBjIpLiqX/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.NZC2IUAKHW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:24:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 06:24:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 06:24:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UWBjIpLiqX/Render', 06:24:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:24:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:24:45 INFO - 'HOME': '/Users/cltbld', 06:24:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:24:45 INFO - 'LOGNAME': 'cltbld', 06:24:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:45 INFO - 'MOZ_NO_REMOTE': '1', 06:24:45 INFO - 'NO_EM_RESTART': '1', 06:24:45 INFO - 'PAGER': '/bin/cat', 06:24:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:24:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:24:45 INFO - 'PWD': '/builds/slave/test', 06:24:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:24:45 INFO - 'SHELL': '/bin/bash', 06:24:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NZC2IUAKHW/Listeners', 06:24:45 INFO - 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', 06:24:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:24:45 INFO - 'USER': 'cltbld', 06:24:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:24:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:24:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:24:45 INFO - 'XPC_FLAGS': '0x0', 06:24:45 INFO - 'XPC_SERVICE_NAME': '0', 06:24:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:24:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:24:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:24:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:24:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:24:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:24:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:24:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:24:48 INFO - Installing collected packages: mozsystemmonitor 06:24:48 INFO - Running setup.py install for mozsystemmonitor 06:24:48 INFO - Successfully installed mozsystemmonitor 06:24:48 INFO - Cleaning up... 06:24:48 INFO - Return code: 0 06:24:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:24:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:24:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:24:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d555a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d565420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd08ad94e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3f4e00>, '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 0x10d25ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d3efb20>, '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.UWBjIpLiqX/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.NZC2IUAKHW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:24:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:24:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:24:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UWBjIpLiqX/Render', 06:24:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:24:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:24:48 INFO - 'HOME': '/Users/cltbld', 06:24:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:24:48 INFO - 'LOGNAME': 'cltbld', 06:24:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:48 INFO - 'MOZ_NO_REMOTE': '1', 06:24:48 INFO - 'NO_EM_RESTART': '1', 06:24:48 INFO - 'PAGER': '/bin/cat', 06:24:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:24:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:24:48 INFO - 'PWD': '/builds/slave/test', 06:24:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:24:48 INFO - 'SHELL': '/bin/bash', 06:24:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NZC2IUAKHW/Listeners', 06:24:48 INFO - 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', 06:24:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:24:48 INFO - 'USER': 'cltbld', 06:24:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:24:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:24:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:24:48 INFO - 'XPC_FLAGS': '0x0', 06:24:48 INFO - 'XPC_SERVICE_NAME': '0', 06:24:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:24:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:24:48 INFO - Downloading/unpacking blobuploader==1.2.4 06:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:24:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:50 INFO - Downloading blobuploader-1.2.4.tar.gz 06:24:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:24:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:24:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:24:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:24:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:52 INFO - Downloading docopt-0.6.1.tar.gz 06:24:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:24:52 INFO - Installing collected packages: blobuploader, requests, docopt 06:24:52 INFO - Running setup.py install for blobuploader 06:24:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:24:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:24:52 INFO - Running setup.py install for requests 06:24:52 INFO - Running setup.py install for docopt 06:24:53 INFO - Successfully installed blobuploader requests docopt 06:24:53 INFO - Cleaning up... 06:24:53 INFO - Return code: 0 06:24:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:24:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:24:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:24:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:53 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 0x10d555a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d565420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd08ad94e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3f4e00>, '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 0x10d25ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d3efb20>, '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.UWBjIpLiqX/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.NZC2IUAKHW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:24:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:24:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:24:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UWBjIpLiqX/Render', 06:24:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:24:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:24:53 INFO - 'HOME': '/Users/cltbld', 06:24:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:24:53 INFO - 'LOGNAME': 'cltbld', 06:24:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:53 INFO - 'MOZ_NO_REMOTE': '1', 06:24:53 INFO - 'NO_EM_RESTART': '1', 06:24:53 INFO - 'PAGER': '/bin/cat', 06:24:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:24:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:24:53 INFO - 'PWD': '/builds/slave/test', 06:24:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:24:53 INFO - 'SHELL': '/bin/bash', 06:24:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NZC2IUAKHW/Listeners', 06:24:53 INFO - 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', 06:24:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:24:53 INFO - 'USER': 'cltbld', 06:24:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:24:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:24:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:24:53 INFO - 'XPC_FLAGS': '0x0', 06:24:53 INFO - 'XPC_SERVICE_NAME': '0', 06:24:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:24:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:24:53 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-sH4TMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:24:53 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-lraG2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:24:53 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-PMAc3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:24:53 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-vbmIAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:24:53 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-TMOCc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:24:53 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-O4TxOj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:24:54 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-L2oVdi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:24:54 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-5bUYYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:24:54 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-9IJixL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:24:54 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-PX5X_n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:24:54 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-WhaWKP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:24:54 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-ars_fm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:24:54 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-ORbZCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:24:54 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-AZ0N8g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:24:54 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-MmrFt1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:24:54 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-JwJkDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:24:55 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-a5otXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:24:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:24:55 INFO - Running setup.py install for manifestparser 06:24:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:24:55 INFO - Running setup.py install for mozcrash 06:24:55 INFO - Running setup.py install for mozdebug 06:24:55 INFO - Running setup.py install for mozdevice 06:24:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:24:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:24:55 INFO - Running setup.py install for mozfile 06:24:55 INFO - Running setup.py install for mozhttpd 06:24:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:24:56 INFO - Running setup.py install for mozinfo 06:24:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:24:56 INFO - Running setup.py install for mozInstall 06:24:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:24:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:24:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:24:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:24:56 INFO - Running setup.py install for mozleak 06:24:56 INFO - Running setup.py install for mozlog 06:24:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:24:56 INFO - Running setup.py install for moznetwork 06:24:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:24:56 INFO - Running setup.py install for mozprocess 06:24:56 INFO - Running setup.py install for mozprofile 06:24:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:24:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:24:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:24:57 INFO - Running setup.py install for mozrunner 06:24:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:24:57 INFO - Running setup.py install for mozscreenshot 06:24:57 INFO - Running setup.py install for moztest 06:24:57 INFO - Running setup.py install for mozversion 06:24:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:24:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:24:57 INFO - Cleaning up... 06:24:57 INFO - Return code: 0 06:24:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:24:57 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:24:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:57 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:24:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:57 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 0x10d555a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d565420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd08ad94e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3f4e00>, '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 0x10d25ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d3efb20>, '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.UWBjIpLiqX/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.NZC2IUAKHW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:24:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:24:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:24:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UWBjIpLiqX/Render', 06:24:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:24:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:24:57 INFO - 'HOME': '/Users/cltbld', 06:24:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:24:57 INFO - 'LOGNAME': 'cltbld', 06:24:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:57 INFO - 'MOZ_NO_REMOTE': '1', 06:24:57 INFO - 'NO_EM_RESTART': '1', 06:24:57 INFO - 'PAGER': '/bin/cat', 06:24:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:24:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:24:57 INFO - 'PWD': '/builds/slave/test', 06:24:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:24:57 INFO - 'SHELL': '/bin/bash', 06:24:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NZC2IUAKHW/Listeners', 06:24:57 INFO - 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', 06:24:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:24:57 INFO - 'USER': 'cltbld', 06:24:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:24:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:24:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:24:57 INFO - 'XPC_FLAGS': '0x0', 06:24:57 INFO - 'XPC_SERVICE_NAME': '0', 06:24:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:24:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:24:58 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-CnItWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:24:58 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:24:58 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-zoOvW2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:24:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:24:58 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-20p372-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:24:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:24:58 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-Dp0hD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:24:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:24:58 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-hpzE_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:24:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:24:58 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-YElTmu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:24:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:24:58 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-waCxv6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:24:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:24:58 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-5oum6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:24:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:24:58 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-Ku7Bnv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:24:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:24:58 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-jlKMhy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:24:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:24:59 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-LRh3ro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:24:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:24:59 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-lK6WVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:24:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:24:59 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-axL3A4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:24:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:24:59 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-c65siB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:24:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:24:59 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-iGPpNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:24:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:24:59 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-Glda9_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:24:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:24:59 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-_GSqfx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:24:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:24:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:24:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:24:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:24:59 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:24:59 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:24:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:24:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:02 INFO - Downloading blessings-1.6.tar.gz 06:25:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:25:02 INFO - Installing collected packages: blessings 06:25:02 INFO - Running setup.py install for blessings 06:25:02 INFO - Successfully installed blessings 06:25:02 INFO - Cleaning up... 06:25:02 INFO - Return code: 0 06:25:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:25:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:25:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:25:02 INFO - Reading from file tmpfile_stdout 06:25:02 INFO - Current package versions: 06:25:02 INFO - blessings == 1.6 06:25:02 INFO - blobuploader == 1.2.4 06:25:02 INFO - docopt == 0.6.1 06:25:02 INFO - manifestparser == 1.1 06:25:02 INFO - mozInstall == 1.12 06:25:02 INFO - mozcrash == 0.17 06:25:02 INFO - mozdebug == 0.1 06:25:02 INFO - mozdevice == 0.48 06:25:02 INFO - mozfile == 1.2 06:25:02 INFO - mozhttpd == 0.7 06:25:02 INFO - mozinfo == 0.9 06:25:02 INFO - mozleak == 0.1 06:25:02 INFO - mozlog == 3.1 06:25:02 INFO - moznetwork == 0.27 06:25:02 INFO - mozprocess == 0.22 06:25:02 INFO - mozprofile == 0.28 06:25:02 INFO - mozrunner == 6.11 06:25:02 INFO - mozscreenshot == 0.1 06:25:02 INFO - mozsystemmonitor == 0.0 06:25:02 INFO - moztest == 0.7 06:25:02 INFO - mozversion == 1.4 06:25:02 INFO - psutil == 3.1.1 06:25:02 INFO - requests == 1.2.3 06:25:02 INFO - wsgiref == 0.1.2 06:25:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:25:02 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:02 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:02 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 0x10d555a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d565420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd08ad94e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3f4e00>, '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 0x10d25ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d3efb20>, '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.UWBjIpLiqX/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.NZC2IUAKHW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:25:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:25:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:25:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UWBjIpLiqX/Render', 06:25:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:25:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:25:02 INFO - 'HOME': '/Users/cltbld', 06:25:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:25:02 INFO - 'LOGNAME': 'cltbld', 06:25:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:02 INFO - 'MOZ_NO_REMOTE': '1', 06:25:02 INFO - 'NO_EM_RESTART': '1', 06:25:02 INFO - 'PAGER': '/bin/cat', 06:25:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:25:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:02 INFO - 'PWD': '/builds/slave/test', 06:25:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:25:02 INFO - 'SHELL': '/bin/bash', 06:25:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NZC2IUAKHW/Listeners', 06:25:02 INFO - 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', 06:25:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:25:02 INFO - 'USER': 'cltbld', 06:25:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:25:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:25:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:02 INFO - 'XPC_FLAGS': '0x0', 06:25:02 INFO - 'XPC_SERVICE_NAME': '0', 06:25:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:25:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:25:03 INFO - Cleaning up... 06:25:03 INFO - Return code: 0 06:25:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:25:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:03 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 0x10d555a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d565420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd08ad94e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3f4e00>, '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 0x10d25ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d3efb20>, '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.UWBjIpLiqX/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.NZC2IUAKHW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:25:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:25:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:25:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UWBjIpLiqX/Render', 06:25:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:25:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:25:03 INFO - 'HOME': '/Users/cltbld', 06:25:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:25:03 INFO - 'LOGNAME': 'cltbld', 06:25:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:03 INFO - 'MOZ_NO_REMOTE': '1', 06:25:03 INFO - 'NO_EM_RESTART': '1', 06:25:03 INFO - 'PAGER': '/bin/cat', 06:25:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:25:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:03 INFO - 'PWD': '/builds/slave/test', 06:25:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:25:03 INFO - 'SHELL': '/bin/bash', 06:25:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NZC2IUAKHW/Listeners', 06:25:03 INFO - 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', 06:25:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:25:03 INFO - 'USER': 'cltbld', 06:25:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:25:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:25:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:03 INFO - 'XPC_FLAGS': '0x0', 06:25:03 INFO - 'XPC_SERVICE_NAME': '0', 06:25:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:25:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:03 INFO - Downloading/unpacking jsonschema 06:25:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:25:05 INFO - Downloading/unpacking functools32 (from jsonschema) 06:25:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:06 INFO - Downloading functools32-3.2.3-2.tar.gz 06:25:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:25:06 INFO - warning: no files found matching '*.txt' 06:25:06 INFO - no previously-included directories found matching 'build' 06:25:06 INFO - no previously-included directories found matching 'dist' 06:25:06 INFO - no previously-included directories found matching '.git*' 06:25:06 INFO - Installing collected packages: jsonschema, functools32 06:25:06 INFO - Running setup.py install for functools32 06:25:06 INFO - warning: no files found matching '*.txt' 06:25:06 INFO - no previously-included directories found matching 'build' 06:25:06 INFO - no previously-included directories found matching 'dist' 06:25:06 INFO - no previously-included directories found matching '.git*' 06:25:06 INFO - Successfully installed jsonschema functools32 06:25:06 INFO - Cleaning up... 06:25:06 INFO - Return code: 0 06:25:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:25:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d555a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d565420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd08ad94e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3f4e00>, '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 0x10d25ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d3efb20>, '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.UWBjIpLiqX/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.NZC2IUAKHW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:25:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 06:25:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 06:25:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UWBjIpLiqX/Render', 06:25:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:25:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:25:06 INFO - 'HOME': '/Users/cltbld', 06:25:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:25:06 INFO - 'LOGNAME': 'cltbld', 06:25:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:06 INFO - 'MOZ_NO_REMOTE': '1', 06:25:06 INFO - 'NO_EM_RESTART': '1', 06:25:06 INFO - 'PAGER': '/bin/cat', 06:25:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:25:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:06 INFO - 'PWD': '/builds/slave/test', 06:25:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:25:06 INFO - 'SHELL': '/bin/bash', 06:25:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NZC2IUAKHW/Listeners', 06:25:06 INFO - 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', 06:25:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:25:06 INFO - 'USER': 'cltbld', 06:25:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:25:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:25:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:06 INFO - 'XPC_FLAGS': '0x0', 06:25:06 INFO - 'XPC_SERVICE_NAME': '0', 06:25:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:25:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:06 INFO - Downloading/unpacking flake8 06:25:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:25:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:25:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:25:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:25:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:25:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:25:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:25:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:25:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:25:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:25:10 INFO - no previously-included directories found matching 'docs/_build' 06:25:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:25:10 INFO - Running setup.py install for pep8 06:25:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:25:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:25:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:25:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:25:10 INFO - no previously-included directories found matching 'docs/_build' 06:25:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:25:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:25:10 INFO - Cleaning up... 06:25:10 INFO - Return code: 0 06:25:10 INFO - Running post-action listener: _resource_record_post_action 06:25:10 INFO - Running post-action listener: _start_resource_monitoring 06:25:10 INFO - Starting resource monitoring. 06:25:10 INFO - ##### 06:25:10 INFO - ##### Running install step. 06:25:10 INFO - ##### 06:25:10 INFO - Running pre-action listener: _resource_record_pre_action 06:25:10 INFO - Running main action method: install 06:25:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:25:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:25:11 INFO - Reading from file tmpfile_stdout 06:25:11 INFO - Detecting whether we're running mozinstall >=1.0... 06:25:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:25:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:25:11 INFO - Reading from file tmpfile_stdout 06:25:11 INFO - Output received: 06:25:11 INFO - Usage: mozinstall [options] installer 06:25:11 INFO - Options: 06:25:11 INFO - -h, --help show this help message and exit 06:25:11 INFO - -d DEST, --destination=DEST 06:25:11 INFO - Directory to install application into. [default: 06:25:11 INFO - "/builds/slave/test"] 06:25:11 INFO - --app=APP Application being installed. [default: firefox] 06:25:11 INFO - mkdir: /builds/slave/test/build/application 06:25:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:25:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 06:25:44 INFO - Reading from file tmpfile_stdout 06:25:44 INFO - Output received: 06:25:44 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:25:44 INFO - Running post-action listener: _resource_record_post_action 06:25:44 INFO - ##### 06:25:44 INFO - ##### Running run-tests step. 06:25:44 INFO - ##### 06:25:44 INFO - Running pre-action listener: _resource_record_pre_action 06:25:44 INFO - Running main action method: run_tests 06:25:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:25:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:25:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:25:44 INFO - 2016-04-16 06:25:44.886 screenresolution[2760:30353] starting screenresolution argv=screenresolution get 06:25:44 INFO - 2016-04-16 06:25:44.889 screenresolution[2760:30353] Display 0: 1600x1200x32@60 06:25:44 INFO - 2016-04-16 06:25:44.894 screenresolution[2761:30356] starting screenresolution argv=screenresolution list 06:25:44 INFO - Available Modes on Display 0 06:25:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:25:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:25:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:25:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:25:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:25:45 INFO - Intel Iris: 06:25:45 INFO - Chipset Model: Intel Iris 06:25:45 INFO - Type: GPU 06:25:45 INFO - Bus: Built-In 06:25:45 INFO - VRAM (Dynamic, Max): 1536 MB 06:25:45 INFO - Vendor: Intel (0x8086) 06:25:45 INFO - Device ID: 0x0a2e 06:25:45 INFO - Revision ID: 0x0009 06:25:45 INFO - Displays: 06:25:45 INFO - Display: 06:25:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:25:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:25:45 INFO - Display Serial Number: 1600x1200 60 06:25:45 INFO - Main Display: Yes 06:25:45 INFO - Mirror: Off 06:25:45 INFO - Online: Yes 06:25:45 INFO - Rotation: Supported 06:25:45 INFO - Return code: 0 06:25:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:25:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:25:45 INFO - Python 2.7.3 06:25:45 INFO - Return code: 0 06:25:45 INFO - grabbing minidump binary from tooltool 06:25:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:45 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3f4e00>, '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 0x10d25ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d3efb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:25:45 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:25:45 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 06:25:45 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:25:45 INFO - Return code: 0 06:25:45 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:25:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:25:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:25:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:25:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:25:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:25:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:25:46 INFO - Return code: 0 06:25:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HrFnlNu-TPqUvGxGGwnpSQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0077', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 06:25:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HrFnlNu-TPqUvGxGGwnpSQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0077 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 06:25:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UWBjIpLiqX/Render', 06:25:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:25:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:25:46 INFO - 'HOME': '/Users/cltbld', 06:25:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:25:46 INFO - 'LOGNAME': 'cltbld', 06:25:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:25:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:25:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:46 INFO - 'MOZ_NO_REMOTE': '1', 06:25:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:25:46 INFO - 'NO_EM_RESTART': '1', 06:25:46 INFO - 'PAGER': '/bin/cat', 06:25:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:25:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:46 INFO - 'PWD': '/builds/slave/test', 06:25:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:25:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:25:46 INFO - 'SHELL': '/bin/bash', 06:25:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NZC2IUAKHW/Listeners', 06:25:46 INFO - 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', 06:25:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:25:46 INFO - 'USER': 'cltbld', 06:25:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:25:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:25:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:46 INFO - 'XPC_FLAGS': '0x0', 06:25:46 INFO - 'XPC_SERVICE_NAME': '0', 06:25:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:25:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HrFnlNu-TPqUvGxGGwnpSQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0077', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 06:25:46 INFO - mozversion application_buildid: 20160416045017 06:25:46 INFO - mozversion application_changeset: 1da1937a9e03154ae7c60089f2dcf5ad9ee20fa3 06:25:46 INFO - mozversion application_display_name: Nightly 06:25:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:25:46 INFO - mozversion application_name: Firefox 06:25:46 INFO - mozversion application_remotingname: firefox 06:25:46 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:25:46 INFO - mozversion application_vendor: Mozilla 06:25:46 INFO - mozversion application_version: 48.0a1 06:25:46 INFO - mozversion platform_buildid: 20160416045017 06:25:46 INFO - mozversion platform_changeset: 1da1937a9e03154ae7c60089f2dcf5ad9ee20fa3 06:25:46 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:25:46 INFO - mozversion platform_version: 48.0a1 06:25:46 INFO - using testdate: 1460813146 06:25:46 INFO - actual date: 1460813146 06:25:46 INFO - starting webserver on 'localhost:56371' 06:25:46 INFO - SUITE-START | Running 2 tests 06:25:46 INFO - TEST-START | dromaeo_css 06:25:46 INFO - operating with platform_type : mac_ 06:25:46 INFO - Initialising browser for dromaeo_css test... 06:25:46 INFO - TEST-INFO | started process 2779 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/tmpQRfNVc/profile http://localhost:56371/getInfo.html) 06:25:48 INFO - PROCESS | 2779 | JavaScript error: jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 06:25:49 INFO - PROCESS | 2779 | __metrics Screen width/height:1600/1200 06:25:49 INFO - PROCESS | 2779 | colorDepth:24 06:25:49 INFO - PROCESS | 2779 | Browser inner width/height: 1024/689 06:25:49 INFO - PROCESS | 2779 | __metrics 06:25:49 ERROR - PROCESS | 2779 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 06:25:50 INFO - TEST-INFO | 2779: exit 0 06:25:50 INFO - Browser initialized. 06:25:50 INFO - Running cycle 1/1 for dromaeo_css test... 06:25:50 INFO - TEST-INFO | started process 2782 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/tmpQRfNVc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:26:01 INFO - PROCESS | 2782 | RSS: Main: 247914496 06:26:01 INFO - PROCESS | 2782 | 06:26:51 INFO - PROCESS | 2782 | 1460813211596 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 06:29:03 INFO - PROCESS | 2782 | Cycle 1(1): loaded http://localhost:56371/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56371/tests/dromaeo/cssquery-ext.html) 06:29:04 INFO - PROCESS | 2782 | RSS: Main: 260169728 06:29:04 INFO - PROCESS | 2782 | 06:32:06 INFO - PROCESS | 2782 | Cycle 1(1): loaded http://localhost:56371/tests/dromaeo/cssquery-ext.html (next: http://localhost:56371/tests/dromaeo/cssquery-jquery.html) 06:32:07 INFO - PROCESS | 2782 | RSS: Main: 272039936 06:32:07 INFO - PROCESS | 2782 | 06:35:09 INFO - PROCESS | 2782 | Cycle 1(1): loaded http://localhost:56371/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56371/tests/dromaeo/cssquery-mootools.html) 06:35:09 INFO - PROCESS | 2782 | RSS: Main: 274419712 06:35:09 INFO - PROCESS | 2782 | 06:38:11 INFO - PROCESS | 2782 | Cycle 1(1): loaded http://localhost:56371/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56371/tests/dromaeo/cssquery-prototype.html) 06:38:12 INFO - PROCESS | 2782 | RSS: Main: 275509248 06:38:12 INFO - PROCESS | 2782 | 06:41:14 INFO - PROCESS | 2782 | Cycle 1(1): loaded http://localhost:56371/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56371/tests/dromaeo/cssquery-yui.html) 06:41:15 INFO - PROCESS | 2782 | RSS: Main: 278417408 06:41:15 INFO - PROCESS | 2782 | 06:44:17 INFO - PROCESS | 2782 | Cycle 1(1): loaded http://localhost:56371/tests/dromaeo/cssquery-yui.html (next: http://localhost:56371/tests/dromaeo/cssquery-dojo.html) 06:44:18 INFO - PROCESS | 2782 | RSS: Main: 279465984 06:44:18 INFO - PROCESS | 2782 | 06:44:18 INFO - PROCESS | 2782 | __start_tp_report 06:44:18 INFO - PROCESS | 2782 | _x_x_mozilla_page_load 06:44:18 INFO - PROCESS | 2782 | _x_x_mozilla_page_load_details 06:44:18 INFO - PROCESS | 2782 | |i|pagename|runs| 06:44:18 INFO - PROCESS | 2782 | |0;dojo.html;3453.050411136937;3477.8956631301057;3495.475678648204;3497.3005398920222;3528.558930133733;5763.07790753479;5812.215350927623;5818.621789583674;5833.795817146395;5840.620359676618;5681.914771278423;5836.066229403296;5851.7074146292625;5853.268341457318;5922.822315330547;5203.375594928614;5277.868053298669;5300.231466437364;5335.359756829186;5389.434109418514;5412.9458705412835;5424.321959755031;5430.15832545956;5438.972805135989;5441.156620723794;5232.895342093175;5248.868778280574;5328.6269961102735;5350.30446042016;5370.489803468664;5257.237700533439;5273.129933560957;5277.47225277473;5290.920636190422;5293.602979776494;5239.711815850127;5259.368875734936;5275.261463395128;5300.628955973083;5301.019311427398;5609.270794796691;5651.208830763697;5750.597458177929;5750.88498230033;5799.536037117021;6224.719887605069;6233.937660623381;6241.095041219043;6255.499560035186;6262.780802671885;6185.072239164161;6220.758021542951;6251.812445626639;6256.436920677115;6267.6866156691985;5909.645421274738;5922.940770592325;5923.08192230205;5935.436133567261;5987.191729116601;6260.248770147611;6317.241930968313;6318.336574659686;6339.144215530844;6368.5860419072615;6027.668478233739;6150.04674275488;6202.627842329474;6239.469645080128;6252.5935814171935;5687.658740475585;6159.5072394208355;6189.412005859436;6240.594361366497;6272.3100458949475;6192.195014648157;6202;6217.720202590895;6231.22109736283;6250.15622890913;6142.508599312045;6231.937680623227;6234.3453937336835;6235.469985051231;6252.6873656317;4963.305137280783;4967.776450059756;4972.850814475499;4977.825776097891;5027.245913112989;4187.769672668032;4445.622122119591;4455.68810183284;4459.821607135743;4482.574155455227;5691.516221121168;5735.9388513125205;5751.166080918327;5797.594168408171;5849.88300233993;6200.658963756947;6203.410675985774;6206.565540412128;6221.657808820468;6251.4061164189325;5867.765289388377;5889.0283103287475;5907.438793314628;5922.052471604523;5925.170476133345;5281.15501519755;5442.727863606804;5453.509184173444;5482.958237934779;5542.8337149885565;6383.999999999907;6408.166938297992;6412.551121421549;6414.134091897534;6417.454516366161;6238.594491358047;6248.68756562161;6258.061290806416;6258.749650013949;6262.248530176408;5334.813281535127;6337.334579869232;6366.64983425916;6382.808515744535;6400;6237.594556353823;6238.937610623836;6247.68761561911;6263.3736626337;6277.71750271248;5782.306123265067;6260.092286618324;6274.1843560336865;6282.780102696383;6289.308176100717;5068.847934561969;6121.693915304306;6169.413905678954;6220.098085777447;6244.344343844013;6173.166622505904;6188.195534580475;6204.317525072329;6215.595986260879;6217.4715149212825;5937.762489500372;5946.464818166386;6010.639361638316;6060;6097.176881120992;6124.29896301299;6130.092410195535;6179.16581261524;6229.408206220402;6236.314005459305;6099.054646529795;6105.145279660762;6110.1445797587485;6120.8775824484155;6127.84680382994 06:44:18 INFO - PROCESS | 2782 | |1;ext.html;533.1522878622989;543.904816657085;559.3735016781205;559.5635404384578;606.7300051477089;35847.46228806567;36190.457143142805;36232.637673623256;36320.455193172056;36337;36480.452793208126;36795.89612311628;37002.25995480095;37124.81437592815;37206.88379348624;9302.906970930271;9439.575219115157;9531.475768832712;9534.237261019136;9564.90435095647;9489.00365461627;9549.236061115094;9552;9613.327067105305;9635.566399512003;9533.809323813519;9593.328467007312;9609.231261499064;9634.421934683942;9648.75878103046;9587.280953928448;9607.519624018842;9610.135087842093;9630.3258771886;9670.468124253199;9425.010373910778;9501.90498095017;9502.334836561444;9509.144177024033;9573.473458959754;32185.35629287401;36747;36764.26471470582;37101;37272;2677.611746296776;3200.883551319097;3210.646828848825;3232.272738633812;3425.794452332868;25299.747002530108;25911.740882591308;26125.143770445233;26136.085237016614;26400.471990560272;2627.395698989243;2628.342914271432;2661.653984981959;2737.438825040862;2765.908706088579;365630;366001;366970.1651491752;370372;370405;34976.475352869726;35070.47394289088;35217;35265.823670882;35291.823540882135;55040;67688.98466523006;67756.98364524536;68712;68849.31150688429;16622.25199866009;16644.167791610373;16838.158092095346;16851.41020064292;16906.830931690525;12545.059120565995;12920.41858116387;12954.222746635232;13028.934855325851;13041.739165216643;18998.335058272893;19062.61874762497;19265.51836204078;19270.61458770845;19669.704954425695;6719.798406047827;7757.612119394008;8041.9947506561675;8338.477468687111;8458.703945361884;909.3589019741066;933.7572231219796;975.190591808797;999.8450240212633;1014.5586669798661;26834.5974810378;28212.8589357056;28986.855065724536;29166.416671666448;29573.260668483028;1097.4471123360356;1103.773726386089;1114.1031469666996;1136.4488223211736;1251.942108917963;14135.505257315945;14186.71626567463;14388.928055359656;14509.92745036268;14554.927225364017;630165.8491707604;642409;643270;644720;646672;48465;58348.416515834295;58604.7069764657;58822;58991;1343.8845758020818;1497.2064805653022;1499.9100053996794;1537;1546.072356586062;28819.711802881702;28972.84108635631;29145.56281655819;29199.416011680074;29809.701902980694;46366;47272;47630.761846190544;47770.76114619405;47917.80205494891;385102;396379;398860;399286.00713992486;400067;26736.598951016138;27107.322316942234;27281.59077613798;27495.862520687268;27570.448591028467;44314.55685443233;44316.55683443124;44524.777376112914;45412.8646783833;45502.77248613868;37162.628373717;37239.88280351594;37253.62746372502;37675.246495070496;37908.43137352887;31372.215694607818;36498.8175059123;36637.762210026;37620.811895940344;37694;36135.45796813103;36239.81880090583;36712.449313259785;36866.8156659215;37004.44493332548;31841.363172736877;32544.186395340304;32638.673613263563;32707.672923270464;32820;22165.445863853533;24081.759182408652;24429.877850610632;24471.632925505775;24893.875530622954 06:44:18 INFO - PROCESS | 2782 | |2;jquery.html;332.47137052087186;344.5710090936784;391.8119302734687;404.27029212271856;413.243763912041;19351.322703705373;20390.796092039094;20418.89790551049;21018;21123.68314475282;20341.982900854935;20757.688634670456;20772.792272077273;21162.25932092377;21415.464613384633;5323.760430780605;5890.823275301748;6112.205413296265;6118.908216376758;6133.570650054476;6009.369016253296;6026.8794624107495;6042.697865106749;6049.727762250687;6071.817845464643;5685;5707.914381284284;5785.074388097905;5817.912731309034;5832.825015249528;5665.603407761459;5728.198052272685;5758.596898217126;5772.624779389326;5791.536677065825;5168.069747445458;5187.870303242411;5235.136202526579;5267.736613169364;5278.762455689503;21622.783772162235;25137.49725005508;25416.74583254181;25742.48515029689;26300.473990520273;2110.018841238831;2119.470132466883;2121.978780212209;2147.4953385954286;2397.940051498709;9992.800143997152;10189.133923616502;10266.332688375232;10292.228082893813;10310.7422314442;1741.4688520001393;1811.194018661696;1844.483544607512;1882.397632757518;1955.8728682635726;87945;117099.41450292694;121185.39407302906;122665;124587.37706311501;9664.613415463444;11788.23376480526;11832;11879.703007424883;12071.456784444721;11564.479598418091;12438.626841194779;13222.140560863512;15112.546623601309;15441.382344706086;8717.692346148002;8834.86747698785;8849.557522123869;8905.465672059698;8942.955285223663;7172.964135179395;8196;8625.78435539104;8688.478691278544;8803.383763136519;4672.369230153954;4706.388169537938;4770.236762118045;4790.616750659939;4794.472608013116;1708.3422882190446;1982.8909409982589;2011.3161525081543;2031.086011294923;2052.0868213644785;396.3539430727895;408.80173116038696;410.8787907567275;1005.4570531912685;1068.8610480637467;11499.3675347855;11638.76722465546;11790.587329443428;11835.230710003994;11924;437.5318409302016;454.50458999690494;455.84956964201734;462.1219682603014;475.379629583397;6005.939940600625;6071.726772295257;6109.262574320224;6137.294211165684;6141.692915354304;547143;578470.2152978501;646907;650353.2376366805;657371;93252.06747932434;122264;124897;137379.31310343384;138379;450.30427988756793;457.179363043338;462.61140641861;463.55498721227326;464.6190124098207;10974.725631858948;11071.280366776135;11114.44427778624;11150.721231969266;11278.041366483942;50124;50241;50256;50721.49278507168;50922.23616645827;69868.6506567464;72753.6362318185;74483;74717.62641186977;75025.62487187529;7983.1617680142745;8002.599870006593;8010.359171266401;8273.917260827315;8282.088970213392;11061.557537698402;12435.378231088229;12542.12205145631;12737.108402411743;12751.744965100832;7460.850782984418;9450.102240287162;10511.474426278808;11068.667939961813;11092.778144437227;8535.91464085376;8603.65585376603;9695.418274903528;10693.89306106929;10808.081313088162;9468.573914173741;10361.481925903523;11257.943710281725;11352.432378380883;11379.715507112389;6357.841053973688;7621.847563048819;7651.770446886602;7985.321247694011;8344;9922.702318930444;10580.576776928836;10626.628068017582;11148.163887708617;11396.544138234378 06:44:18 INFO - PROCESS | 2782 | |3;mootools.html;1611.2668735725242;1640.302871279706;1902.429271218634;1953.6385768632813;1968.625961067398;7427.702891884318;8459.4078414511;8509.234168924811;8632.309415246773;8923.375363724543;8594.91405085949;8651;8693.434926729758;8744.169303916135;8754.249150169959;2475.6781618389628;2487.1046423287603;2487.179230853814;2493.1897133431617;2499.175272160192;2415.1184817541557;2477.4549599088173;2486.105002199207;2492.8005759539283;2505.235903049569;2469.0247352295833;2474.7030356357172;2493.2021753039035;2510.8619025953567;2515.0945659562544;2456.115798312606;2465.432950421395;2478.615814548748;2480.7519248075228;2491.9003239870385;2465.5561998840203;2479.293401380598;2480.082369523288;2486.7761901428776;2495.7504249575077;8813.515256660881;8815.735527934108;8846.60190291432;8872.290216782641;8898.777530561723;5308.840734777963;5488.643238189505;5490.203920431515;5513.61404701671;5528.530074943635;3587.4260118380935;3631.8365673544754;3642.4900513928073;3670.467782171597;3674.3386190485703;920.1304766995192;984.3552473130111;1046.0533217438156;1051.3166441812807;1061.0609610494691;11410.828837567444;11566.016888564482;11707.47316370757;11719.12106592009;11726.35505047222;3963.3064213762477;4738.8341408050555;4943.233798761198;4949.406071271471;4965.280034394992;10009.499525023719;10021.749456263506;10024.248181386425;10065.345752526062;10107.140893024176;5426.972865135728;5446.128619420873;5462.098753705594;5473.890522189534;5497.615166938356;4450.577195166454;4783.1868582341085;4971.90056198874;4985.750712464363;4986.650934434628;4070.9592904071174;4090.476119970223;4101.487314085739;4110.609492098246;4114.814833332447;1204.3436327201696;1325.5956933135294;1357.6537982814318;1363.7477066742683;1369.1237607930932;815.6288888555692;898.9616992373818;912.6167009855876;923.9260859131253;937.2455173585194;5924.6149000314845;6007.579469437185;6008.519318454513;6087.360827113178;6159.5688301818445;457.65904401221303;460.8594378714524;481.2997089235154;482.93721816163674;487.5738464989961;3652.2878038782715;3999.980000100039;4047.8785636430953;4066.1664358806374;4076.980754811297;10444.947775261227;10768.084712799344;10817.675469735921;10947.959943805326;10949.671509854717;10706.839397409045;10746.247762656696;10839.945800270949;10879.945600271947;10881.945590271998;7669.884951725729;8111.310538604284;8278.710245141512;8282.50304981703;8367.95816020916;5807.186993820784;5895.734691938959;5958;5990.730417131327;5996.220491336098;10015.949920250352;10056.798864022825;10059.39643621385;10068.345557538736;10144.188464922936;9716.708498745049;9941.353812002197;10222.693319200436;10228.948855255676;10360;6945.444364450933;7318.890216646861;7588.823732321499;7657.119431265476;7662.73180438682;8217.342612591097;8337.207965243293;8380.622871970654;8438.915610843813;8440.788980275542;6103.3591472894705;7401.851962960818;7409.777706668809;7439.51643143194;7649.388048956182;7307.159676637042;7307.744228951961;7313.305236002571;7323.86480095586;7362.852742945218;6947.062146610345;7007.264237255014;7015.333543313377;7044.260352663102;7048.471364647569;4822.156122678587;4875.219964805614;4892.730899800403;5042.218456139304;5115.693058416507;4797.592204662503;4879.487653796442;4959.231319145538;5076.847694569169;5238.816641417532 06:44:18 INFO - PROCESS | 2782 | |4;prototype.html;310.17338792119006;319.48562813869665;328.66968696460054;330.0543941607296;332.47966931751824;6101.847453813657;6146.231721034871;6208.86452341568;6213.316535181132;6229.221347331583;5041.395032596084;6129.87740245196;6159.938400615993;6162.445379915818;6163.784267550636;4645.396098507189;4658.86023419298;4675.672702910798;4693.7653117344;4701.318308845215;4288.635465985395;4573.702709323883;4587.151376995266;4634.864458207727;4688.578027977482;4050.8177132029127;4290.678199135062;4517.051419201972;4558.72647641141;4573.501271527284;3926.9607303927023;4447.688661793676;4599.126166028461;4608.723476591382;4629.120467111272;3197.912709678697;3395.2021275000357;3570.821458927069;3651.379265524867;3919.000654833028;5111.348672707855;5331.653442526223;5435.619506634537;5851.3270973838125;5891.939450898836;5271.894562108775;5287.947120528784;5302.761375738101;5307.203919412081;5324.520793128599;4771.734577873517;5375.354957405098;6519.663468988846;6519.771807986745;6521.08704781331;3623.836927338276;3816.656500914931;4260.680448966309;4288.24955632763;4298.78506074695;6339.8415039623915;6614.437772789319;6834.9064149735805;6909.447244220451;6911.965440172818;3668.9633103669157;3836.3094642963974;4284.250256205151;4317.222899878052;4336.111097225062;3725.9068523287133;3737.112758057164;4402.691811573223;4428.601425871687;4431.8448854289945;5066.442691303953;5232.476752324737;5256.448072952361;5268.15709486488;5278.5249327560705;6537.215534135934;6557;6591.045372776296;6592.24189218246;6622.966885165543;1507.6984603079427;1527.3050761903307;1531.3461461621423;1531.7089752947127;1532.3947040918997;846.5259454705262;945.5981207986579;992.3995982430525;994.164901482758;1004.0762498501397;5545.223668686387;5995.820125396245;6050.455459008623;6088.908666370008;6104.4200800923845;5611.7474713637985;6444.742210311629;6751.324867513307;6802.591844489347;6819.7272109116075;5805.303363596396;5868.67722275279;6076.787312444043;6087.512998960073;6093.329733729286;3495.8601655933476;3553.6446355364255;3574.749767516301;3579.874704385334;3584.713222942158;6844.760433384908;6987.196472405637;7021.824454388681;7039.648017599099;7087.220405755363;6926.722931082701;6967.8606427871155;6969.0940177776565;6981.720731170696;7021.087258656342;6691.464682825363;7022.754203602952;7065.788026359218;7070.6313385015565;7106.299606149527;5497.505224529811;6451.870962580816;6655.334466553306;6779.93220067793;6814.522983391115;6390.680465976776;6678.365555272241;6716.3955244028275;6739.663016849236;6746.460283177236;6135.662538560422;6180.252365300314;6763.86472270542;7155.785326440215;7181.389581885389;4106.979465102655;4327.242732521859;4398.582134697199;4412.9117417652105;4429.80065897029;6454.644994525346;6532.856750068624;6769.830754231184;6808.62552559614;6874.450043996569;6009.969950150221;6325.778597749057;6516.446102081187;6552.312007239362;6645.933540664531;5140.897182056413;6074.78738244177;6230.691554773548;6287.868183726973;6576.572522786004;6366.840828979312;6405.7117429714845;6411.089235566394;6478.740850366121;6484;5357.705326207096;6511.869762604627;6572.211334639874;6596.80209593713;6609.239937407067;5190.429052804113;6186.783462578788;6416.935830641633;6443.710033048618;6482.643454610042 06:44:18 INFO - PROCESS | 2782 | |5;yui.html;686.3273991488342;742.7660287009595;756.0889128600036;775.5036776463064;798.508917016035;12581.937090314546;14976.625584360369;15007.549773506786;15204.555567221096;15455.536333909973;13508.864911350884;13574.660633484167;13618;13623.386947587358;13644.249566273851;728.8068661804599;904.8506996345595;905.3255324783046;927.9628814847398;947.393668052447;896.0501868019887;922.8338898998178;923.3029063057382;925.2505470568827;926.3376685669745;972.9027097290285;982.4989255479685;985.069109691342;987.377951890308;992.1566668331932;960.1550635440802;979.2166266986418;982.6855406269997;985.4973963278708;987.6740675577079;725.6081715873422;729.2452311857255;731.9707211711525;734.3904559215838;734.5042096584838;14828.3327250274;15084.321205545668;15129.621759455991;15165.393384264617;15171.544853654297;12878.356082195853;12895.355232238444;12925.67685807853;13002.219866808022;13009.089363744542;10156.695299141038;10305.84541231882;10306.742331441774;10328.948355258251;10600.787984240273;3476.7392445566684;3491.8952431427097;3544.3088597723195;3578.928421431583;3636.472711456824;59167.112493312634;83282.33435331259;83795.58102209511;85602.14397856004;94605.16184514476;7849.960750196213;8366.498010119412;9701.951490242503;9719.465429401309;9837.685180103064;21968.45078873041;22457.88771056167;22459.663105053438;22571.661425078637;22668.773312266996;6232.875342493216;6654.534182607268;7097.9290207097265;7555.848883022309;7740.303372696484;3291.6050073990796;4047.615476529725;4143.233501802176;4148.522919864194;4198.517170525429;3480.5823301203513;3585.659362360572;3595.2449985503335;3606.4229723244157;3614.945775813365;600.5105838741412;642.9935700643027;646.6443456099126;655.8260713323098;661.6228749612675;444.1538868455597;470.82795491525565;499.5578912662247;582.7144699097412;620.8944479438507;6481.546291759531;6590.472762179014;7780.105287891852;8069.757907262791;8267;584.3017593975159;588.2206076948061;590.4892268187987;608.3946473259135;611.6910959965189;3390.677885600864;3774.6791522720328;3812.14226798968;3910.198409326081;3929.960700393017;79013.60493197612;83914;87108;87583;89915;74096.25903740893;76907.61546192234;77417;77582.61208694034;78208.60895695598;52957.676058098856;63566;66691.33308666949;68033.63932721318;68556.97164542536;8064.274215320649;8209.096999330188;8251.133630968901;8290.917090829256;8395.034571024411;30217.244568885075;42496.362554561085;42912;43384.69845904628;43649.56350436455;49479.010419792125;52141;63673;63930;64610.35389646043;10559.841602375816;10739.731506712395;10771.084457821173;11149.99650031501;11509.769804603693;9468.769060022152;9996.3002589818;10860.619878304222;11196.216264861381;11476.311421314747;11166.776664466828;11416.771664566497;11426.371549564854;11622.94188529052;11630.6510804676;10168.847467288144;10990.450477475933;11311.717207069889;11571.305721656727;11687.707807304885;11230.438478075901;11345.675002706428;11419.429028548373;11454.82817757751;11479.655610331703;9711.805763884542;9762.609495620096;9976.700698979042;10043.296969212377;10256.282060255711;9665.130138287306;9737.561809718722;9747.902520974983;9764.462954537568;10015.499225038864 06:44:18 INFO - PROCESS | 2782 | __end_tp_report 06:44:18 INFO - PROCESS | 2782 | __start_cc_report 06:44:18 INFO - PROCESS | 2782 | _x_x_mozilla_cycle_collect,409 06:44:18 INFO - PROCESS | 2782 | __end_cc_report 06:44:18 INFO - PROCESS | 2782 | __startTimestamp1460814258194__endTimestamp 06:44:18 INFO - PROCESS | 2782 | 06:44:18 INFO - PROCESS | 2782 | ------- Summary: start ------- 06:44:18 INFO - PROCESS | 2782 | Number of tests: 6 06:44:18 INFO - PROCESS | 2782 | 06:44:18 INFO - PROCESS | 2782 | [#0] dojo.html Cycles:165 Average:5797.91 Median:6027.67 stddev:623.76 (10.3%) stddev-sans-first:597.93 06:44:18 INFO - PROCESS | 2782 | Values: 3453.1 3477.9 3495.5 3497.3 3528.6 5763.1 5812.2 5818.6 5833.8 5840.6 5681.9 5836.1 5851.7 5853.3 5922.8 5203.4 5277.9 5300.2 5335.4 5389.4 5412.9 5424.3 5430.2 5439.0 5441.2 5232.9 5248.9 5328.6 5350.3 5370.5 5257.2 5273.1 5277.5 5290.9 5293.6 5239.7 5259.4 5275.3 5300.6 5301.0 5609.3 5651.2 5750.6 5750.9 5799.5 6224.7 6233.9 6241.1 6255.5 6262.8 6185.1 6220.8 6251.8 6256.4 6267.7 5909.6 5922.9 5923.1 5935.4 5987.2 6260.2 6317.2 6318.3 6339.1 6368.6 6027.7 6150.0 6202.6 6239.5 6252.6 5687.7 6159.5 6189.4 6240.6 6272.3 6192.2 6202.0 6217.7 6231.2 6250.2 6142.5 6231.9 6234.3 6235.5 6252.7 4963.3 4967.8 4972.9 4977.8 5027.2 4187.8 4445.6 4455.7 4459.8 4482.6 5691.5 5735.9 5751.2 5797.6 5849.9 6200.7 6203.4 6206.6 6221.7 6251.4 5867.8 5889.0 5907.4 5922.1 5925.2 5281.2 5442.7 5453.5 5483.0 5542.8 6384.0 6408.2 6412.6 6414.1 6417.5 6238.6 6248.7 6258.1 6258.7 6262.2 5334.8 6337.3 6366.6 6382.8 6400.0 6237.6 6238.9 6247.7 6263.4 6277.7 5782.3 6260.1 6274.2 6282.8 6289.3 5068.8 6121.7 6169.4 6220.1 6244.3 6173.2 6188.2 6204.3 6215.6 6217.5 5937.8 5946.5 6010.6 6060.0 6097.2 6124.3 6130.1 6179.2 6229.4 6236.3 6099.1 6105.1 6110.1 6120.9 6127.8 06:44:18 INFO - PROCESS | 2782 | 06:44:18 INFO - PROCESS | 2782 | [#1] ext.html Cycles:180 Average:60288.57 Median:201841.31 stddev:129472.81 (64.1%) stddev-sans-first:129758.28 06:44:18 INFO - PROCESS | 2782 | Values: 533.2 543.9 559.4 559.6 606.7 35847.5 36190.5 36232.6 36320.5 36337.0 36480.5 36795.9 37002.3 37124.8 37206.9 9302.9 9439.6 9531.5 9534.2 9564.9 9489.0 9549.2 9552.0 9613.3 9635.6 9533.8 9593.3 9609.2 9634.4 9648.8 9587.3 9607.5 9610.1 9630.3 9670.5 9425.0 9501.9 9502.3 9509.1 9573.5 32185.4 36747.0 36764.3 37101.0 37272.0 2677.6 3200.9 3210.6 3232.3 3425.8 25299.7 25911.7 26125.1 26136.1 26400.5 2627.4 2628.3 2661.7 2737.4 2765.9 365630.0 366001.0 366970.2 370372.0 370405.0 34976.5 35070.5 35217.0 35265.8 35291.8 55040.0 67689.0 67757.0 68712.0 68849.3 16622.3 16644.2 16838.2 16851.4 16906.8 12545.1 12920.4 12954.2 13028.9 13041.7 18998.3 19062.6 19265.5 19270.6 19669.7 6719.8 7757.6 8042.0 8338.5 8458.7 909.4 933.8 975.2 999.8 1014.6 26834.6 28212.9 28986.9 29166.4 29573.3 1097.4 1103.8 1114.1 1136.4 1251.9 14135.5 14186.7 14388.9 14509.9 14554.9 630165.8 642409.0 643270.0 644720.0 646672.0 48465.0 58348.4 58604.7 58822.0 58991.0 1343.9 1497.2 1499.9 1537.0 1546.1 28819.7 28972.8 29145.6 29199.4 29809.7 46366.0 47272.0 47630.8 47770.8 47917.8 385102.0 396379.0 398860.0 399286.0 400067.0 26736.6 27107.3 27281.6 27495.9 27570.4 44314.6 44316.6 44524.8 45412.9 45502.8 37162.6 37239.9 37253.6 37675.2 37908.4 31372.2 36498.8 36637.8 37620.8 37694.0 36135.5 36239.8 36712.4 36866.8 37004.4 31841.4 32544.2 32638.7 32707.7 32820.0 22165.4 24081.8 24429.9 24471.6 24893.9 06:44:18 INFO - PROCESS | 2782 | 06:44:18 INFO - PROCESS | 2782 | [#2] jquery.html Cycles:180 Average:34327.01 Median:452.40 stddev:102900.36 (22745.2%) stddev-sans-first:103157.36 06:44:18 INFO - PROCESS | 2782 | Values: 332.5 344.6 391.8 404.3 413.2 19351.3 20390.8 20418.9 21018.0 21123.7 20342.0 20757.7 20772.8 21162.3 21415.5 5323.8 5890.8 6112.2 6118.9 6133.6 6009.4 6026.9 6042.7 6049.7 6071.8 5685.0 5707.9 5785.1 5817.9 5832.8 5665.6 5728.2 5758.6 5772.6 5791.5 5168.1 5187.9 5235.1 5267.7 5278.8 21622.8 25137.5 25416.7 25742.5 26300.5 2110.0 2119.5 2122.0 2147.5 2397.9 9992.8 10189.1 10266.3 10292.2 10310.7 1741.5 1811.2 1844.5 1882.4 1955.9 87945.0 117099.4 121185.4 122665.0 124587.4 9664.6 11788.2 11832.0 11879.7 12071.5 11564.5 12438.6 13222.1 15112.5 15441.4 8717.7 8834.9 8849.6 8905.5 8943.0 7173.0 8196.0 8625.8 8688.5 8803.4 4672.4 4706.4 4770.2 4790.6 4794.5 1708.3 1982.9 2011.3 2031.1 2052.1 396.4 408.8 410.9 1005.5 1068.9 11499.4 11638.8 11790.6 11835.2 11924.0 437.5 454.5 455.8 462.1 475.4 6005.9 6071.7 6109.3 6137.3 6141.7 547143.0 578470.2 646907.0 650353.2 657371.0 93252.1 122264.0 124897.0 137379.3 138379.0 450.3 457.2 462.6 463.6 464.6 10974.7 11071.3 11114.4 11150.7 11278.0 50124.0 50241.0 50256.0 50721.5 50922.2 69868.7 72753.6 74483.0 74717.6 75025.6 7983.2 8002.6 8010.4 8273.9 8282.1 11061.6 12435.4 12542.1 12737.1 12751.7 7460.9 9450.1 10511.5 11068.7 11092.8 8535.9 8603.7 9695.4 10693.9 10808.1 9468.6 10361.5 11257.9 11352.4 11379.7 6357.8 7621.8 7651.8 7985.3 8344.0 9922.7 10580.6 10626.6 11148.2 11396.5 06:44:18 INFO - PROCESS | 2782 | 06:44:18 INFO - PROCESS | 2782 | [#3] mootools.html Cycles:180 Average:5746.11 Median:2654.86 stddev:3194.86 (120.3%) stddev-sans-first:3188.71 06:44:18 INFO - PROCESS | 2782 | Values: 1611.3 1640.3 1902.4 1953.6 1968.6 7427.7 8459.4 8509.2 8632.3 8923.4 8594.9 8651.0 8693.4 8744.2 8754.2 2475.7 2487.1 2487.2 2493.2 2499.2 2415.1 2477.5 2486.1 2492.8 2505.2 2469.0 2474.7 2493.2 2510.9 2515.1 2456.1 2465.4 2478.6 2480.8 2491.9 2465.6 2479.3 2480.1 2486.8 2495.8 8813.5 8815.7 8846.6 8872.3 8898.8 5308.8 5488.6 5490.2 5513.6 5528.5 3587.4 3631.8 3642.5 3670.5 3674.3 920.1 984.4 1046.1 1051.3 1061.1 11410.8 11566.0 11707.5 11719.1 11726.4 3963.3 4738.8 4943.2 4949.4 4965.3 10009.5 10021.7 10024.2 10065.3 10107.1 5427.0 5446.1 5462.1 5473.9 5497.6 4450.6 4783.2 4971.9 4985.8 4986.7 4071.0 4090.5 4101.5 4110.6 4114.8 1204.3 1325.6 1357.7 1363.7 1369.1 815.6 899.0 912.6 923.9 937.2 5924.6 6007.6 6008.5 6087.4 6159.6 457.7 460.9 481.3 482.9 487.6 3652.3 4000.0 4047.9 4066.2 4077.0 10444.9 10768.1 10817.7 10948.0 10949.7 10706.8 10746.2 10839.9 10879.9 10881.9 7669.9 8111.3 8278.7 8282.5 8368.0 5807.2 5895.7 5958.0 5990.7 5996.2 10015.9 10056.8 10059.4 10068.3 10144.2 9716.7 9941.4 10222.7 10228.9 10360.0 6945.4 7318.9 7588.8 7657.1 7662.7 8217.3 8337.2 8380.6 8438.9 8440.8 6103.4 7401.9 7409.8 7439.5 7649.4 7307.2 7307.7 7313.3 7323.9 7362.9 6947.1 7007.3 7015.3 7044.3 7048.5 4822.2 4875.2 4892.7 5042.2 5115.7 4797.6 4879.5 4959.2 5076.8 5238.8 06:44:18 INFO - PROCESS | 2782 | 06:44:18 INFO - PROCESS | 2782 | [#4] prototype.html Cycles:180 Average:5256.60 Median:6075.79 stddev:1692.78 (27.9%) stddev-sans-first:1656.32 06:44:18 INFO - PROCESS | 2782 | Values: 310.2 319.5 328.7 330.1 332.5 6101.8 6146.2 6208.9 6213.3 6229.2 5041.4 6129.9 6159.9 6162.4 6163.8 4645.4 4658.9 4675.7 4693.8 4701.3 4288.6 4573.7 4587.2 4634.9 4688.6 4050.8 4290.7 4517.1 4558.7 4573.5 3927.0 4447.7 4599.1 4608.7 4629.1 3197.9 3395.2 3570.8 3651.4 3919.0 5111.3 5331.7 5435.6 5851.3 5891.9 5271.9 5287.9 5302.8 5307.2 5324.5 4771.7 5375.4 6519.7 6519.8 6521.1 3623.8 3816.7 4260.7 4288.2 4298.8 6339.8 6614.4 6834.9 6909.4 6912.0 3669.0 3836.3 4284.3 4317.2 4336.1 3725.9 3737.1 4402.7 4428.6 4431.8 5066.4 5232.5 5256.4 5268.2 5278.5 6537.2 6557.0 6591.0 6592.2 6623.0 1507.7 1527.3 1531.3 1531.7 1532.4 846.5 945.6 992.4 994.2 1004.1 5545.2 5995.8 6050.5 6088.9 6104.4 5611.7 6444.7 6751.3 6802.6 6819.7 5805.3 5868.7 6076.8 6087.5 6093.3 3495.9 3553.6 3574.7 3579.9 3584.7 6844.8 6987.2 7021.8 7039.6 7087.2 6926.7 6967.9 6969.1 6981.7 7021.1 6691.5 7022.8 7065.8 7070.6 7106.3 5497.5 6451.9 6655.3 6779.9 6814.5 6390.7 6678.4 6716.4 6739.7 6746.5 6135.7 6180.3 6763.9 7155.8 7181.4 4107.0 4327.2 4398.6 4412.9 4429.8 6454.6 6532.9 6769.8 6808.6 6874.5 6010.0 6325.8 6516.4 6552.3 6645.9 5140.9 6074.8 6230.7 6287.9 6576.6 6366.8 6405.7 6411.1 6478.7 6484.0 5357.7 6511.9 6572.2 6596.8 6609.2 5190.4 6186.8 6416.9 6443.7 6482.6 06:44:18 INFO - PROCESS | 2782 | 06:44:18 INFO - PROCESS | 2782 | [#5] yui.html Cycles:180 Average:17357.79 Median:29878.80 stddev:24196.65 (81.0%) stddev-sans-first:24232.15 06:44:18 INFO - PROCESS | 2782 | Values: 686.3 742.8 756.1 775.5 798.5 12581.9 14976.6 15007.5 15204.6 15455.5 13508.9 13574.7 13618.0 13623.4 13644.2 728.8 904.9 905.3 928.0 947.4 896.1 922.8 923.3 925.3 926.3 972.9 982.5 985.1 987.4 992.2 960.2 979.2 982.7 985.5 987.7 725.6 729.2 732.0 734.4 734.5 14828.3 15084.3 15129.6 15165.4 15171.5 12878.4 12895.4 12925.7 13002.2 13009.1 10156.7 10305.8 10306.7 10328.9 10600.8 3476.7 3491.9 3544.3 3578.9 3636.5 59167.1 83282.3 83795.6 85602.1 94605.2 7850.0 8366.5 9702.0 9719.5 9837.7 21968.5 22457.9 22459.7 22571.7 22668.8 6232.9 6654.5 7097.9 7555.8 7740.3 3291.6 4047.6 4143.2 4148.5 4198.5 3480.6 3585.7 3595.2 3606.4 3614.9 600.5 643.0 646.6 655.8 661.6 444.2 470.8 499.6 582.7 620.9 6481.5 6590.5 7780.1 8069.8 8267.0 584.3 588.2 590.5 608.4 611.7 3390.7 3774.7 3812.1 3910.2 3930.0 79013.6 83914.0 87108.0 87583.0 89915.0 74096.3 76907.6 77417.0 77582.6 78208.6 52957.7 63566.0 66691.3 68033.6 68557.0 8064.3 8209.1 8251.1 8290.9 8395.0 30217.2 42496.4 42912.0 43384.7 43649.6 49479.0 52141.0 63673.0 63930.0 64610.4 10559.8 10739.7 10771.1 11150.0 11509.8 9468.8 9996.3 10860.6 11196.2 11476.3 11166.8 11416.8 11426.4 11622.9 11630.7 10168.8 10990.5 11311.7 11571.3 11687.7 11230.4 11345.7 11419.4 11454.8 11479.7 9711.8 9762.6 9976.7 10043.3 10256.3 9665.1 9737.6 9747.9 9764.5 10015.5 06:44:18 INFO - PROCESS | 2782 | -------- Summary: end -------- 06:44:18 INFO - PROCESS | 2782 | 06:44:18 INFO - TEST-INFO | 2782: exit 0 06:44:18 INFO - TEST-OK | dromaeo_css | took 1112107ms 06:44:18 INFO - TEST-START | kraken 06:44:18 INFO - operating with platform_type : mac_ 06:44:18 INFO - Initialising browser for kraken test... 06:44:18 INFO - TEST-INFO | started process 2787 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/tmpooH6tA/profile http://localhost:56371/getInfo.html) 06:44:21 INFO - PROCESS | 2787 | JavaScript error: jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 06:44:21 INFO - PROCESS | 2787 | __metrics Screen width/height:1600/1200 06:44:21 INFO - PROCESS | 2787 | colorDepth:24 06:44:21 INFO - PROCESS | 2787 | Browser inner width/height: 1024/689 06:44:21 INFO - PROCESS | 2787 | __metrics 06:44:21 ERROR - PROCESS | 2787 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 06:44:22 INFO - TEST-INFO | 2787: exit 0 06:44:22 INFO - Browser initialized. 06:44:22 INFO - Running cycle 1/1 for kraken test... 06:44:22 INFO - TEST-INFO | started process 2790 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/tmpooH6tA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:44:34 INFO - PROCESS | 2790 | RSS: Main: 247648256 06:44:34 INFO - PROCESS | 2790 | 06:44:37 INFO - PROCESS | 2790 | Cycle 1(1): loaded http://localhost:56371/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56371/tests/kraken/driver.html?testName=audio-beat-detection) 06:44:38 INFO - PROCESS | 2790 | RSS: Main: 259776512 06:44:38 INFO - PROCESS | 2790 | 06:44:40 INFO - PROCESS | 2790 | Cycle 1(1): loaded http://localhost:56371/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56371/tests/kraken/driver.html?testName=audio-dft) 06:44:41 INFO - PROCESS | 2790 | RSS: Main: 269131776 06:44:41 INFO - PROCESS | 2790 | 06:44:44 INFO - PROCESS | 2790 | Cycle 1(1): loaded http://localhost:56371/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56371/tests/kraken/driver.html?testName=audio-fft) 06:44:45 INFO - PROCESS | 2790 | RSS: Main: 272130048 06:44:45 INFO - PROCESS | 2790 | 06:44:47 INFO - PROCESS | 2790 | Cycle 1(1): loaded http://localhost:56371/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56371/tests/kraken/driver.html?testName=audio-oscillator) 06:44:48 INFO - PROCESS | 2790 | RSS: Main: 273596416 06:44:48 INFO - PROCESS | 2790 | 06:44:50 INFO - PROCESS | 2790 | Cycle 1(1): loaded http://localhost:56371/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56371/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:44:50 INFO - PROCESS | 2790 | RSS: Main: 274051072 06:44:50 INFO - PROCESS | 2790 | 06:44:53 INFO - PROCESS | 2790 | Cycle 1(1): loaded http://localhost:56371/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56371/tests/kraken/driver.html?testName=imaging-darkroom) 06:44:54 INFO - PROCESS | 2790 | RSS: Main: 275255296 06:44:54 INFO - PROCESS | 2790 | 06:44:57 INFO - PROCESS | 2790 | Cycle 1(1): loaded http://localhost:56371/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56371/tests/kraken/driver.html?testName=imaging-desaturate) 06:44:57 INFO - PROCESS | 2790 | RSS: Main: 275382272 06:44:57 INFO - PROCESS | 2790 | 06:45:01 INFO - PROCESS | 2790 | Cycle 1(1): loaded http://localhost:56371/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56371/tests/kraken/driver.html?testName=json-parse-financial) 06:45:01 INFO - PROCESS | 2790 | RSS: Main: 275517440 06:45:01 INFO - PROCESS | 2790 | 06:45:03 INFO - PROCESS | 2790 | Cycle 1(1): loaded http://localhost:56371/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56371/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:45:04 INFO - PROCESS | 2790 | RSS: Main: 274927616 06:45:04 INFO - PROCESS | 2790 | 06:45:06 INFO - PROCESS | 2790 | Cycle 1(1): loaded http://localhost:56371/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56371/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:45:06 INFO - PROCESS | 2790 | RSS: Main: 274939904 06:45:06 INFO - PROCESS | 2790 | 06:45:08 INFO - PROCESS | 2790 | Cycle 1(1): loaded http://localhost:56371/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56371/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:45:09 INFO - PROCESS | 2790 | RSS: Main: 275030016 06:45:09 INFO - PROCESS | 2790 | 06:45:12 INFO - PROCESS | 2790 | Cycle 1(1): loaded http://localhost:56371/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56371/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:45:13 INFO - PROCESS | 2790 | RSS: Main: 275132416 06:45:13 INFO - PROCESS | 2790 | 06:45:16 INFO - PROCESS | 2790 | Cycle 1(1): loaded http://localhost:56371/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56371/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:45:16 INFO - PROCESS | 2790 | RSS: Main: 275189760 06:45:16 INFO - PROCESS | 2790 | 06:45:18 INFO - PROCESS | 2790 | Cycle 1(1): loaded http://localhost:56371/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56371/tests/kraken/driver.html?testName=ai-astar) 06:45:19 INFO - PROCESS | 2790 | RSS: Main: 276905984 06:45:19 INFO - PROCESS | 2790 | 06:45:19 INFO - PROCESS | 2790 | __start_tp_report 06:45:19 INFO - PROCESS | 2790 | _x_x_mozilla_page_load 06:45:19 INFO - PROCESS | 2790 | _x_x_mozilla_page_load_details 06:45:19 INFO - PROCESS | 2790 | |i|pagename|runs| 06:45:19 INFO - PROCESS | 2790 | |0;ai-astar;115;108;168;173;102;116;142;151;101;157 06:45:19 INFO - PROCESS | 2790 | |1;audio-beat-detection;164;154;139;195;118;138;105;178;152;150 06:45:19 INFO - PROCESS | 2790 | |2;audio-dft;197;214;232;198;197;197;201;201;199;199 06:45:19 INFO - PROCESS | 2790 | |3;audio-fft;64;76;82;145;49;49;58;59;164;87 06:45:19 INFO - PROCESS | 2790 | |4;audio-oscillator;79;85;133;72;77;82;119;80;97;123 06:45:19 INFO - PROCESS | 2790 | |5;imaging-gaussian-blur;91;125;88;86;89;87;95;88;95;77 06:45:19 INFO - PROCESS | 2790 | |6;imaging-darkroom;95;97;94;124;111;145;106;154;112;95 06:45:19 INFO - PROCESS | 2790 | |7;imaging-desaturate;100;149;89;122;144;128;130;138;137;149 06:45:19 INFO - PROCESS | 2790 | |8;json-parse-financial;62;79;91;57;55;62;82;97;98;70 06:45:19 INFO - PROCESS | 2790 | |9;json-stringify-tinderbox;63;66;71;94;60;69;64;79;92;101 06:45:19 INFO - PROCESS | 2790 | |10;stanford-crypto-aes;84;79;102;82;85;84;84;83;84;82 06:45:19 INFO - PROCESS | 2790 | |11;stanford-crypto-ccm;140;142;144;140;157;152;151;153;196;153 06:45:19 INFO - PROCESS | 2790 | |12;stanford-crypto-pbkdf2;168;168;233;225;217;175;205;169;182;227 06:45:19 INFO - PROCESS | 2790 | |13;stanford-crypto-sha256-iterative;98;94;59;92;100;97;97;96;67;68 06:45:19 INFO - PROCESS | 2790 | __end_tp_report 06:45:19 INFO - PROCESS | 2790 | __start_cc_report 06:45:19 INFO - PROCESS | 2790 | _x_x_mozilla_cycle_collect,1032 06:45:19 INFO - PROCESS | 2790 | __end_cc_report 06:45:19 INFO - PROCESS | 2790 | __startTimestamp1460814319087__endTimestamp 06:45:19 INFO - PROCESS | 2790 | 06:45:19 INFO - PROCESS | 2790 | ------- Summary: start ------- 06:45:19 INFO - PROCESS | 2790 | Number of tests: 14 06:45:19 INFO - PROCESS | 2790 | 06:45:19 INFO - PROCESS | 2790 | [#0] ai-astar Cycles:10 Average:133.30 Median:146.50 stddev:27.94 (19.1%) stddev-sans-first:28.84 06:45:19 INFO - PROCESS | 2790 | Values: 115.0 108.0 168.0 173.0 102.0 116.0 142.0 151.0 101.0 157.0 06:45:19 INFO - PROCESS | 2790 | 06:45:19 INFO - PROCESS | 2790 | [#1] audio-beat-detection Cycles:10 Average:149.30 Median:153.00 stddev:26.53 (17.3%) stddev-sans-first:27.60 06:45:19 INFO - PROCESS | 2790 | Values: 164.0 154.0 139.0 195.0 118.0 138.0 105.0 178.0 152.0 150.0 06:45:19 INFO - PROCESS | 2790 | 06:45:19 INFO - PROCESS | 2790 | [#2] audio-dft Cycles:10 Average:203.50 Median:200.00 stddev:11.22 (5.6%) stddev-sans-first:11.65 06:45:19 INFO - PROCESS | 2790 | Values: 197.0 214.0 232.0 198.0 197.0 197.0 201.0 201.0 199.0 199.0 06:45:19 INFO - PROCESS | 2790 | 06:45:19 INFO - PROCESS | 2790 | [#3] audio-fft Cycles:10 Average:83.30 Median:61.50 stddev:39.92 (64.9%) stddev-sans-first:41.73 06:45:19 INFO - PROCESS | 2790 | Values: 64.0 76.0 82.0 145.0 49.0 49.0 58.0 59.0 164.0 87.0 06:45:19 INFO - PROCESS | 2790 | 06:45:19 INFO - PROCESS | 2790 | [#4] audio-oscillator Cycles:10 Average:94.70 Median:79.50 stddev:22.14 (27.8%) stddev-sans-first:22.74 06:45:19 INFO - PROCESS | 2790 | Values: 79.0 85.0 133.0 72.0 77.0 82.0 119.0 80.0 97.0 123.0 06:45:19 INFO - PROCESS | 2790 | 06:45:19 INFO - PROCESS | 2790 | [#5] imaging-gaussian-blur Cycles:10 Average:92.10 Median:88.50 stddev:12.63 (14.3%) stddev-sans-first:13.39 06:45:19 INFO - PROCESS | 2790 | Values: 91.0 125.0 88.0 86.0 89.0 87.0 95.0 88.0 95.0 77.0 06:45:19 INFO - PROCESS | 2790 | 06:45:19 INFO - PROCESS | 2790 | [#6] imaging-darkroom Cycles:10 Average:113.30 Median:124.00 stddev:21.46 (17.3%) stddev-sans-first:21.71 06:45:19 INFO - PROCESS | 2790 | Values: 95.0 97.0 94.0 124.0 111.0 145.0 106.0 154.0 112.0 95.0 06:45:19 INFO - PROCESS | 2790 | 06:45:19 INFO - PROCESS | 2790 | [#7] imaging-desaturate Cycles:10 Average:128.60 Median:141.00 stddev:20.17 (14.3%) stddev-sans-first:18.55 06:45:19 INFO - PROCESS | 2790 | Values: 100.0 149.0 89.0 122.0 144.0 128.0 130.0 138.0 137.0 149.0 06:45:19 INFO - PROCESS | 2790 | 06:45:19 INFO - PROCESS | 2790 | [#8] json-parse-financial Cycles:10 Average:75.30 Median:80.50 stddev:16.40 (20.4%) stddev-sans-first:16.67 06:45:19 INFO - PROCESS | 2790 | Values: 62.0 79.0 91.0 57.0 55.0 62.0 82.0 97.0 98.0 70.0 06:45:19 INFO - PROCESS | 2790 | 06:45:19 INFO - PROCESS | 2790 | [#9] json-stringify-tinderbox Cycles:10 Average:75.90 Median:70.00 stddev:14.75 (21.1%) stddev-sans-first:14.88 06:45:19 INFO - PROCESS | 2790 | Values: 63.0 66.0 71.0 94.0 60.0 69.0 64.0 79.0 92.0 101.0 06:45:19 INFO - PROCESS | 2790 | 06:45:19 INFO - PROCESS | 2790 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:84.00 stddev:6.24 (7.4%) stddev-sans-first:6.61 06:45:19 INFO - PROCESS | 2790 | Values: 84.0 79.0 102.0 82.0 85.0 84.0 84.0 83.0 84.0 82.0 06:45:19 INFO - PROCESS | 2790 | 06:45:19 INFO - PROCESS | 2790 | [#11] stanford-crypto-ccm Cycles:10 Average:152.80 Median:152.50 stddev:16.36 (10.7%) stddev-sans-first:16.69 06:45:19 INFO - PROCESS | 2790 | Values: 140.0 142.0 144.0 140.0 157.0 152.0 151.0 153.0 196.0 153.0 06:45:19 INFO - PROCESS | 2790 | 06:45:19 INFO - PROCESS | 2790 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:196.90 Median:211.00 stddev:27.12 (12.9%) stddev-sans-first:26.67 06:45:19 INFO - PROCESS | 2790 | Values: 168.0 168.0 233.0 225.0 217.0 175.0 205.0 169.0 182.0 227.0 06:45:19 INFO - PROCESS | 2790 | 06:45:19 INFO - PROCESS | 2790 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:86.80 Median:95.00 stddev:15.60 (16.4%) stddev-sans-first:16.01 06:45:19 INFO - PROCESS | 2790 | Values: 98.0 94.0 59.0 92.0 100.0 97.0 97.0 96.0 67.0 68.0 06:45:19 INFO - PROCESS | 2790 | -------- Summary: end -------- 06:45:19 INFO - PROCESS | 2790 | 06:45:19 INFO - TEST-INFO | 2790: exit 0 06:45:19 INFO - TEST-OK | kraken | took 61142ms 06:45:19 INFO - SUITE-END | took 1173s 06:45:20 INFO - Completed test suite (00:19:33) 06:45:20 INFO - javascript benchmark 06:45:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3453.050411136937, 3477.8956631301057, 3495.475678648204, 3497.3005398920222, 3528.558930133733, 5763.07790753479, 5812.215350927623, 5818.621789583674, 5833.795817146395, 5840.620359676618, 5681.914771278423, 5836.066229403296, 5851.7074146292625, 5853.268341457318, 5922.822315330547, 5203.375594928614, 5277.868053298669, 5300.231466437364, 5335.359756829186, 5389.434109418514, 5412.9458705412835, 5424.321959755031, 5430.15832545956, 5438.972805135989, 5441.156620723794, 5232.895342093175, 5248.868778280574, 5328.6269961102735, 5350.30446042016, 5370.489803468664, 5257.237700533439, 5273.129933560957, 5277.47225277473, 5290.920636190422, 5293.602979776494, 5239.711815850127, 5259.368875734936, 5275.261463395128, 5300.628955973083, 5301.019311427398, 5609.270794796691, 5651.208830763697, 5750.597458177929, 5750.88498230033, 5799.536037117021, 6224.719887605069, 6233.937660623381, 6241.095041219043, 6255.499560035186, 6262.780802671885, 6185.072239164161, 6220.758021542951, 6251.812445626639, 6256.436920677115, 6267.6866156691985, 5909.645421274738, 5922.940770592325, 5923.08192230205, 5935.436133567261, 5987.191729116601, 6260.248770147611, 6317.241930968313, 6318.336574659686, 6339.144215530844, 6368.5860419072615, 6027.668478233739, 6150.04674275488, 6202.627842329474, 6239.469645080128, 6252.5935814171935, 5687.658740475585, 6159.5072394208355, 6189.412005859436, 6240.594361366497, 6272.3100458949475, 6192.195014648157, 6202.0, 6217.720202590895, 6231.22109736283, 6250.15622890913, 6142.508599312045, 6231.937680623227, 6234.3453937336835, 6235.469985051231, 6252.6873656317, 4963.305137280783, 4967.776450059756, 4972.850814475499, 4977.825776097891, 5027.245913112989, 4187.769672668032, 4445.622122119591, 4455.68810183284, 4459.821607135743, 4482.574155455227, 5691.516221121168, 5735.9388513125205, 5751.166080918327, 5797.594168408171, 5849.88300233993, 6200.658963756947, 6203.410675985774, 6206.565540412128, 6221.657808820468, 6251.4061164189325, 5867.765289388377, 5889.0283103287475, 5907.438793314628, 5922.052471604523, 5925.170476133345, 5281.15501519755, 5442.727863606804, 5453.509184173444, 5482.958237934779, 5542.8337149885565, 6383.999999999907, 6408.166938297992, 6412.551121421549, 6414.134091897534, 6417.454516366161, 6238.594491358047, 6248.68756562161, 6258.061290806416, 6258.749650013949, 6262.248530176408, 5334.813281535127, 6337.334579869232, 6366.64983425916, 6382.808515744535, 6400.0, 6237.594556353823, 6238.937610623836, 6247.68761561911, 6263.3736626337, 6277.71750271248, 5782.306123265067, 6260.092286618324, 6274.1843560336865, 6282.780102696383, 6289.308176100717, 5068.847934561969, 6121.693915304306, 6169.413905678954, 6220.098085777447, 6244.344343844013, 6173.166622505904, 6188.195534580475, 6204.317525072329, 6215.595986260879, 6217.4715149212825, 5937.762489500372, 5946.464818166386, 6010.639361638316, 6060.0, 6097.176881120992, 6124.29896301299, 6130.092410195535, 6179.16581261524, 6229.408206220402, 6236.314005459305, 6099.054646529795, 6105.145279660762, 6110.1445797587485, 6120.8775824484155, 6127.84680382994], "value": 5759.743117234765, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [533.1522878622989, 543.904816657085, 559.3735016781205, 559.5635404384578, 606.7300051477089, 35847.46228806567, 36190.457143142805, 36232.637673623256, 36320.455193172056, 36337.0, 36480.452793208126, 36795.89612311628, 37002.25995480095, 37124.81437592815, 37206.88379348624, 9302.906970930271, 9439.575219115157, 9531.475768832712, 9534.237261019136, 9564.90435095647, 9489.00365461627, 9549.236061115094, 9552.0, 9613.327067105305, 9635.566399512003, 9533.809323813519, 9593.328467007312, 9609.231261499064, 9634.421934683942, 9648.75878103046, 9587.280953928448, 9607.519624018842, 9610.135087842093, 9630.3258771886, 9670.468124253199, 9425.010373910778, 9501.90498095017, 9502.334836561444, 9509.144177024033, 9573.473458959754, 32185.35629287401, 36747.0, 36764.26471470582, 37101.0, 37272.0, 2677.611746296776, 3200.883551319097, 3210.646828848825, 3232.272738633812, 3425.794452332868, 25299.747002530108, 25911.740882591308, 26125.143770445233, 26136.085237016614, 26400.471990560272, 2627.395698989243, 2628.342914271432, 2661.653984981959, 2737.438825040862, 2765.908706088579, 365630.0, 366001.0, 366970.1651491752, 370372.0, 370405.0, 34976.475352869726, 35070.47394289088, 35217.0, 35265.823670882, 35291.823540882135, 55040.0, 67688.98466523006, 67756.98364524536, 68712.0, 68849.31150688429, 16622.25199866009, 16644.167791610373, 16838.158092095346, 16851.41020064292, 16906.830931690525, 12545.059120565995, 12920.41858116387, 12954.222746635232, 13028.934855325851, 13041.739165216643, 18998.335058272893, 19062.61874762497, 19265.51836204078, 19270.61458770845, 19669.704954425695, 6719.798406047827, 7757.612119394008, 8041.9947506561675, 8338.477468687111, 8458.703945361884, 909.3589019741066, 933.7572231219796, 975.190591808797, 999.8450240212633, 1014.5586669798661, 26834.5974810378, 28212.8589357056, 28986.855065724536, 29166.416671666448, 29573.260668483028, 1097.4471123360356, 1103.773726386089, 1114.1031469666996, 1136.4488223211736, 1251.942108917963, 14135.505257315945, 14186.71626567463, 14388.928055359656, 14509.92745036268, 14554.927225364017, 630165.8491707604, 642409.0, 643270.0, 644720.0, 646672.0, 48465.0, 58348.416515834295, 58604.7069764657, 58822.0, 58991.0, 1343.8845758020818, 1497.2064805653022, 1499.9100053996794, 1537.0, 1546.072356586062, 28819.711802881702, 28972.84108635631, 29145.56281655819, 29199.416011680074, 29809.701902980694, 46366.0, 47272.0, 47630.761846190544, 47770.76114619405, 47917.80205494891, 385102.0, 396379.0, 398860.0, 399286.00713992486, 400067.0, 26736.598951016138, 27107.322316942234, 27281.59077613798, 27495.862520687268, 27570.448591028467, 44314.55685443233, 44316.55683443124, 44524.777376112914, 45412.8646783833, 45502.77248613868, 37162.628373717, 37239.88280351594, 37253.62746372502, 37675.246495070496, 37908.43137352887, 31372.215694607818, 36498.8175059123, 36637.762210026, 37620.811895940344, 37694.0, 36135.45796813103, 36239.81880090583, 36712.449313259785, 36866.8156659215, 37004.44493332548, 31841.363172736877, 32544.186395340304, 32638.673613263563, 32707.672923270464, 32820.0, 22165.445863853533, 24081.759182408652, 24429.877850610632, 24471.632925505775, 24893.875530622954], "value": 18856.603658125743, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.47137052087186, 344.5710090936784, 391.8119302734687, 404.27029212271856, 413.243763912041, 19351.322703705373, 20390.796092039094, 20418.89790551049, 21018.0, 21123.68314475282, 20341.982900854935, 20757.688634670456, 20772.792272077273, 21162.25932092377, 21415.464613384633, 5323.760430780605, 5890.823275301748, 6112.205413296265, 6118.908216376758, 6133.570650054476, 6009.369016253296, 6026.8794624107495, 6042.697865106749, 6049.727762250687, 6071.817845464643, 5685.0, 5707.914381284284, 5785.074388097905, 5817.912731309034, 5832.825015249528, 5665.603407761459, 5728.198052272685, 5758.596898217126, 5772.624779389326, 5791.536677065825, 5168.069747445458, 5187.870303242411, 5235.136202526579, 5267.736613169364, 5278.762455689503, 21622.783772162235, 25137.49725005508, 25416.74583254181, 25742.48515029689, 26300.473990520273, 2110.018841238831, 2119.470132466883, 2121.978780212209, 2147.4953385954286, 2397.940051498709, 9992.800143997152, 10189.133923616502, 10266.332688375232, 10292.228082893813, 10310.7422314442, 1741.4688520001393, 1811.194018661696, 1844.483544607512, 1882.397632757518, 1955.8728682635726, 87945.0, 117099.41450292694, 121185.39407302906, 122665.0, 124587.37706311501, 9664.613415463444, 11788.23376480526, 11832.0, 11879.703007424883, 12071.456784444721, 11564.479598418091, 12438.626841194779, 13222.140560863512, 15112.546623601309, 15441.382344706086, 8717.692346148002, 8834.86747698785, 8849.557522123869, 8905.465672059698, 8942.955285223663, 7172.964135179395, 8196.0, 8625.78435539104, 8688.478691278544, 8803.383763136519, 4672.369230153954, 4706.388169537938, 4770.236762118045, 4790.616750659939, 4794.472608013116, 1708.3422882190446, 1982.8909409982589, 2011.3161525081543, 2031.086011294923, 2052.0868213644785, 396.3539430727895, 408.80173116038696, 410.8787907567275, 1005.4570531912685, 1068.8610480637467, 11499.3675347855, 11638.76722465546, 11790.587329443428, 11835.230710003994, 11924.0, 437.5318409302016, 454.50458999690494, 455.84956964201734, 462.1219682603014, 475.379629583397, 6005.939940600625, 6071.726772295257, 6109.262574320224, 6137.294211165684, 6141.692915354304, 547143.0, 578470.2152978501, 646907.0, 650353.2376366805, 657371.0, 93252.06747932434, 122264.0, 124897.0, 137379.31310343384, 138379.0, 450.30427988756793, 457.179363043338, 462.61140641861, 463.55498721227326, 464.6190124098207, 10974.725631858948, 11071.280366776135, 11114.44427778624, 11150.721231969266, 11278.041366483942, 50124.0, 50241.0, 50256.0, 50721.49278507168, 50922.23616645827, 69868.6506567464, 72753.6362318185, 74483.0, 74717.62641186977, 75025.62487187529, 7983.1617680142745, 8002.599870006593, 8010.359171266401, 8273.917260827315, 8282.088970213392, 11061.557537698402, 12435.378231088229, 12542.12205145631, 12737.108402411743, 12751.744965100832, 7460.850782984418, 9450.102240287162, 10511.474426278808, 11068.667939961813, 11092.778144437227, 8535.91464085376, 8603.65585376603, 9695.418274903528, 10693.89306106929, 10808.081313088162, 9468.573914173741, 10361.481925903523, 11257.943710281725, 11352.432378380883, 11379.715507112389, 6357.841053973688, 7621.847563048819, 7651.770446886602, 7985.321247694011, 8344.0, 9922.702318930444, 10580.576776928836, 10626.628068017582, 11148.163887708617, 11396.544138234378], "value": 8527.65041171318, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1611.2668735725242, 1640.302871279706, 1902.429271218634, 1953.6385768632813, 1968.625961067398, 7427.702891884318, 8459.4078414511, 8509.234168924811, 8632.309415246773, 8923.375363724543, 8594.91405085949, 8651.0, 8693.434926729758, 8744.169303916135, 8754.249150169959, 2475.6781618389628, 2487.1046423287603, 2487.179230853814, 2493.1897133431617, 2499.175272160192, 2415.1184817541557, 2477.4549599088173, 2486.105002199207, 2492.8005759539283, 2505.235903049569, 2469.0247352295833, 2474.7030356357172, 2493.2021753039035, 2510.8619025953567, 2515.0945659562544, 2456.115798312606, 2465.432950421395, 2478.615814548748, 2480.7519248075228, 2491.9003239870385, 2465.5561998840203, 2479.293401380598, 2480.082369523288, 2486.7761901428776, 2495.7504249575077, 8813.515256660881, 8815.735527934108, 8846.60190291432, 8872.290216782641, 8898.777530561723, 5308.840734777963, 5488.643238189505, 5490.203920431515, 5513.61404701671, 5528.530074943635, 3587.4260118380935, 3631.8365673544754, 3642.4900513928073, 3670.467782171597, 3674.3386190485703, 920.1304766995192, 984.3552473130111, 1046.0533217438156, 1051.3166441812807, 1061.0609610494691, 11410.828837567444, 11566.016888564482, 11707.47316370757, 11719.12106592009, 11726.35505047222, 3963.3064213762477, 4738.8341408050555, 4943.233798761198, 4949.406071271471, 4965.280034394992, 10009.499525023719, 10021.749456263506, 10024.248181386425, 10065.345752526062, 10107.140893024176, 5426.972865135728, 5446.128619420873, 5462.098753705594, 5473.890522189534, 5497.615166938356, 4450.577195166454, 4783.1868582341085, 4971.90056198874, 4985.750712464363, 4986.650934434628, 4070.9592904071174, 4090.476119970223, 4101.487314085739, 4110.609492098246, 4114.814833332447, 1204.3436327201696, 1325.5956933135294, 1357.6537982814318, 1363.7477066742683, 1369.1237607930932, 815.6288888555692, 898.9616992373818, 912.6167009855876, 923.9260859131253, 937.2455173585194, 5924.6149000314845, 6007.579469437185, 6008.519318454513, 6087.360827113178, 6159.5688301818445, 457.65904401221303, 460.8594378714524, 481.2997089235154, 482.93721816163674, 487.5738464989961, 3652.2878038782715, 3999.980000100039, 4047.8785636430953, 4066.1664358806374, 4076.980754811297, 10444.947775261227, 10768.084712799344, 10817.675469735921, 10947.959943805326, 10949.671509854717, 10706.839397409045, 10746.247762656696, 10839.945800270949, 10879.945600271947, 10881.945590271998, 7669.884951725729, 8111.310538604284, 8278.710245141512, 8282.50304981703, 8367.95816020916, 5807.186993820784, 5895.734691938959, 5958.0, 5990.730417131327, 5996.220491336098, 10015.949920250352, 10056.798864022825, 10059.39643621385, 10068.345557538736, 10144.188464922936, 9716.708498745049, 9941.353812002197, 10222.693319200436, 10228.948855255676, 10360.0, 6945.444364450933, 7318.890216646861, 7588.823732321499, 7657.119431265476, 7662.73180438682, 8217.342612591097, 8337.207965243293, 8380.622871970654, 8438.915610843813, 8440.788980275542, 6103.3591472894705, 7401.851962960818, 7409.777706668809, 7439.51643143194, 7649.388048956182, 7307.159676637042, 7307.744228951961, 7313.305236002571, 7323.86480095586, 7362.852742945218, 6947.062146610345, 7007.264237255014, 7015.333543313377, 7044.260352663102, 7048.471364647569, 4822.156122678587, 4875.219964805614, 4892.730899800403, 5042.218456139304, 5115.693058416507, 4797.592204662503, 4879.487653796442, 4959.231319145538, 5076.847694569169, 5238.816641417532], "value": 4572.62427250283, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.17338792119006, 319.48562813869665, 328.66968696460054, 330.0543941607296, 332.47966931751824, 6101.847453813657, 6146.231721034871, 6208.86452341568, 6213.316535181132, 6229.221347331583, 5041.395032596084, 6129.87740245196, 6159.938400615993, 6162.445379915818, 6163.784267550636, 4645.396098507189, 4658.86023419298, 4675.672702910798, 4693.7653117344, 4701.318308845215, 4288.635465985395, 4573.702709323883, 4587.151376995266, 4634.864458207727, 4688.578027977482, 4050.8177132029127, 4290.678199135062, 4517.051419201972, 4558.72647641141, 4573.501271527284, 3926.9607303927023, 4447.688661793676, 4599.126166028461, 4608.723476591382, 4629.120467111272, 3197.912709678697, 3395.2021275000357, 3570.821458927069, 3651.379265524867, 3919.000654833028, 5111.348672707855, 5331.653442526223, 5435.619506634537, 5851.3270973838125, 5891.939450898836, 5271.894562108775, 5287.947120528784, 5302.761375738101, 5307.203919412081, 5324.520793128599, 4771.734577873517, 5375.354957405098, 6519.663468988846, 6519.771807986745, 6521.08704781331, 3623.836927338276, 3816.656500914931, 4260.680448966309, 4288.24955632763, 4298.78506074695, 6339.8415039623915, 6614.437772789319, 6834.9064149735805, 6909.447244220451, 6911.965440172818, 3668.9633103669157, 3836.3094642963974, 4284.250256205151, 4317.222899878052, 4336.111097225062, 3725.9068523287133, 3737.112758057164, 4402.691811573223, 4428.601425871687, 4431.8448854289945, 5066.442691303953, 5232.476752324737, 5256.448072952361, 5268.15709486488, 5278.5249327560705, 6537.215534135934, 6557.0, 6591.045372776296, 6592.24189218246, 6622.966885165543, 1507.6984603079427, 1527.3050761903307, 1531.3461461621423, 1531.7089752947127, 1532.3947040918997, 846.5259454705262, 945.5981207986579, 992.3995982430525, 994.164901482758, 1004.0762498501397, 5545.223668686387, 5995.820125396245, 6050.455459008623, 6088.908666370008, 6104.4200800923845, 5611.7474713637985, 6444.742210311629, 6751.324867513307, 6802.591844489347, 6819.7272109116075, 5805.303363596396, 5868.67722275279, 6076.787312444043, 6087.512998960073, 6093.329733729286, 3495.8601655933476, 3553.6446355364255, 3574.749767516301, 3579.874704385334, 3584.713222942158, 6844.760433384908, 6987.196472405637, 7021.824454388681, 7039.648017599099, 7087.220405755363, 6926.722931082701, 6967.8606427871155, 6969.0940177776565, 6981.720731170696, 7021.087258656342, 6691.464682825363, 7022.754203602952, 7065.788026359218, 7070.6313385015565, 7106.299606149527, 5497.505224529811, 6451.870962580816, 6655.334466553306, 6779.93220067793, 6814.522983391115, 6390.680465976776, 6678.365555272241, 6716.3955244028275, 6739.663016849236, 6746.460283177236, 6135.662538560422, 6180.252365300314, 6763.86472270542, 7155.785326440215, 7181.389581885389, 4106.979465102655, 4327.242732521859, 4398.582134697199, 4412.9117417652105, 4429.80065897029, 6454.644994525346, 6532.856750068624, 6769.830754231184, 6808.62552559614, 6874.450043996569, 6009.969950150221, 6325.778597749057, 6516.446102081187, 6552.312007239362, 6645.933540664531, 5140.897182056413, 6074.78738244177, 6230.691554773548, 6287.868183726973, 6576.572522786004, 6366.840828979312, 6405.7117429714845, 6411.089235566394, 6478.740850366121, 6484.0, 5357.705326207096, 6511.869762604627, 6572.211334639874, 6596.80209593713, 6609.239937407067, 5190.429052804113, 6186.783462578788, 6416.935830641633, 6443.710033048618, 6482.643454610042], "value": 4703.068811245142, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [686.3273991488342, 742.7660287009595, 756.0889128600036, 775.5036776463064, 798.508917016035, 12581.937090314546, 14976.625584360369, 15007.549773506786, 15204.555567221096, 15455.536333909973, 13508.864911350884, 13574.660633484167, 13618.0, 13623.386947587358, 13644.249566273851, 728.8068661804599, 904.8506996345595, 905.3255324783046, 927.9628814847398, 947.393668052447, 896.0501868019887, 922.8338898998178, 923.3029063057382, 925.2505470568827, 926.3376685669745, 972.9027097290285, 982.4989255479685, 985.069109691342, 987.377951890308, 992.1566668331932, 960.1550635440802, 979.2166266986418, 982.6855406269997, 985.4973963278708, 987.6740675577079, 725.6081715873422, 729.2452311857255, 731.9707211711525, 734.3904559215838, 734.5042096584838, 14828.3327250274, 15084.321205545668, 15129.621759455991, 15165.393384264617, 15171.544853654297, 12878.356082195853, 12895.355232238444, 12925.67685807853, 13002.219866808022, 13009.089363744542, 10156.695299141038, 10305.84541231882, 10306.742331441774, 10328.948355258251, 10600.787984240273, 3476.7392445566684, 3491.8952431427097, 3544.3088597723195, 3578.928421431583, 3636.472711456824, 59167.112493312634, 83282.33435331259, 83795.58102209511, 85602.14397856004, 94605.16184514476, 7849.960750196213, 8366.498010119412, 9701.951490242503, 9719.465429401309, 9837.685180103064, 21968.45078873041, 22457.88771056167, 22459.663105053438, 22571.661425078637, 22668.773312266996, 6232.875342493216, 6654.534182607268, 7097.9290207097265, 7555.848883022309, 7740.303372696484, 3291.6050073990796, 4047.615476529725, 4143.233501802176, 4148.522919864194, 4198.517170525429, 3480.5823301203513, 3585.659362360572, 3595.2449985503335, 3606.4229723244157, 3614.945775813365, 600.5105838741412, 642.9935700643027, 646.6443456099126, 655.8260713323098, 661.6228749612675, 444.1538868455597, 470.82795491525565, 499.5578912662247, 582.7144699097412, 620.8944479438507, 6481.546291759531, 6590.472762179014, 7780.105287891852, 8069.757907262791, 8267.0, 584.3017593975159, 588.2206076948061, 590.4892268187987, 608.3946473259135, 611.6910959965189, 3390.677885600864, 3774.6791522720328, 3812.14226798968, 3910.198409326081, 3929.960700393017, 79013.60493197612, 83914.0, 87108.0, 87583.0, 89915.0, 74096.25903740893, 76907.61546192234, 77417.0, 77582.61208694034, 78208.60895695598, 52957.676058098856, 63566.0, 66691.33308666949, 68033.63932721318, 68556.97164542536, 8064.274215320649, 8209.096999330188, 8251.133630968901, 8290.917090829256, 8395.034571024411, 30217.244568885075, 42496.362554561085, 42912.0, 43384.69845904628, 43649.56350436455, 49479.010419792125, 52141.0, 63673.0, 63930.0, 64610.35389646043, 10559.841602375816, 10739.731506712395, 10771.084457821173, 11149.99650031501, 11509.769804603693, 9468.769060022152, 9996.3002589818, 10860.619878304222, 11196.216264861381, 11476.311421314747, 11166.776664466828, 11416.771664566497, 11426.371549564854, 11622.94188529052, 11630.6510804676, 10168.847467288144, 10990.450477475933, 11311.717207069889, 11571.305721656727, 11687.707807304885, 11230.438478075901, 11345.675002706428, 11419.429028548373, 11454.82817757751, 11479.655610331703, 9711.805763884542, 9762.609495620096, 9976.700698979042, 10043.296969212377, 10256.282060255711, 9665.130138287306, 9737.561809718722, 9747.902520974983, 9764.462954537568, 10015.499225038864], "value": 6765.809463867491, "unit": "score"}], "name": "dromaeo_css", "value": 7160.333582144841, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 108.0, 168.0, 173.0, 102.0, 116.0, 142.0, 151.0, 101.0, 157.0], "value": 133.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 154.0, 139.0, 195.0, 118.0, 138.0, 105.0, 178.0, 152.0, 150.0], "value": 149.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 214.0, 232.0, 198.0, 197.0, 197.0, 201.0, 201.0, 199.0, 199.0], "value": 203.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 76.0, 82.0, 145.0, 49.0, 49.0, 58.0, 59.0, 164.0, 87.0], "value": 83.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 85.0, 133.0, 72.0, 77.0, 82.0, 119.0, 80.0, 97.0, 123.0], "value": 94.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 125.0, 88.0, 86.0, 89.0, 87.0, 95.0, 88.0, 95.0, 77.0], "value": 92.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 94.0, 124.0, 111.0, 145.0, 106.0, 154.0, 112.0, 95.0], "value": 113.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 149.0, 89.0, 122.0, 144.0, 128.0, 130.0, 138.0, 137.0, 149.0], "value": 128.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 79.0, 91.0, 57.0, 55.0, 62.0, 82.0, 97.0, 98.0, 70.0], "value": 75.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 71.0, 94.0, 60.0, 69.0, 64.0, 79.0, 92.0, 101.0], "value": 75.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 79.0, 102.0, 82.0, 85.0, 84.0, 84.0, 83.0, 84.0, 82.0], "value": 84.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 142.0, 144.0, 140.0, 157.0, 152.0, 151.0, 153.0, 196.0, 153.0], "value": 152.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 168.0, 233.0, 225.0, 217.0, 175.0, 205.0, 169.0, 182.0, 227.0], "value": 196.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 94.0, 59.0, 92.0, 100.0, 97.0, 97.0, 96.0, 67.0, 68.0], "value": 86.8, "unit": "score"}], "name": "kraken", "value": 1670.7000000000003, "alertThreshold": 2.0}]} 06:45:20 INFO - Return code: 0 06:45:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:45:20 ERROR - # TBPL SUCCESS # 06:45:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:45:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:45:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:45:20 INFO - 2016-04-16 06:45:20.402 screenresolution[2795:33073] starting screenresolution argv=screenresolution get 06:45:20 INFO - 2016-04-16 06:45:20.405 screenresolution[2795:33073] Display 0: 1600x1200x32@60 06:45:20 INFO - 2016-04-16 06:45:20.410 screenresolution[2796:33076] starting screenresolution argv=screenresolution list 06:45:20 INFO - Available Modes on Display 0 06:45:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:45:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:45:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:45:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:45:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:45:20 INFO - Intel Iris: 06:45:20 INFO - Chipset Model: Intel Iris 06:45:20 INFO - Type: GPU 06:45:20 INFO - Bus: Built-In 06:45:20 INFO - VRAM (Dynamic, Max): 1536 MB 06:45:20 INFO - Vendor: Intel (0x8086) 06:45:20 INFO - Device ID: 0x0a2e 06:45:20 INFO - Revision ID: 0x0009 06:45:20 INFO - Displays: 06:45:20 INFO - Display: 06:45:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:45:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:45:20 INFO - Display Serial Number: 1600x1200 60 06:45:20 INFO - Main Display: Yes 06:45:20 INFO - Mirror: Off 06:45:20 INFO - Online: Yes 06:45:20 INFO - Rotation: Supported 06:45:20 INFO - Return code: 0 06:45:20 INFO - Running post-action listener: _resource_record_post_action 06:45:20 INFO - Running post-run listener: _resource_record_post_run 06:45:21 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 196608; Write bytes: 698237952; Read time: 1; Write time: 2042 06:45:21 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 375132672; Write bytes: 371192832; Read time: 28197; Write time: 787 06:45:21 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 196608; Write bytes: 299806720; Read time: 1; Write time: 1199 06:45:21 INFO - Running post-run listener: _upload_blobber_files 06:45:21 INFO - Blob upload gear active. 06:45:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:45:21 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:45:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:45:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:45:22 INFO - (blobuploader) - INFO - Open directory for files ... 06:45:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:45:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:45:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:45:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:45:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:45:22 INFO - (blobuploader) - INFO - Done attempting. 06:45:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:45:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:45:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:45:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:45:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:45:23 INFO - (blobuploader) - INFO - Done attempting. 06:45:23 INFO - (blobuploader) - INFO - Iteration through files over. 06:45:23 INFO - Return code: 0 06:45:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:45:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:45:23 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d49ee12a61bc4a0a76f35c0ce09b1d2b30fe04197f81f20e5a897f39b0c6a6ebdd95d297d8cdaa499615fb75afa1287074895e46eb54792792ef92281fe1a20b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/981da9a87975298d21f7e277efb39b751a0354e4dcd3c2b4f5fcccbb44e455e26dcc6b5095a47c0d9025536c275e572703b5d46c8805fcd37f2fbec2d18ae0ea"} 06:45:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:45:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:45:23 INFO - Contents: 06:45:23 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d49ee12a61bc4a0a76f35c0ce09b1d2b30fe04197f81f20e5a897f39b0c6a6ebdd95d297d8cdaa499615fb75afa1287074895e46eb54792792ef92281fe1a20b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/981da9a87975298d21f7e277efb39b751a0354e4dcd3c2b4f5fcccbb44e455e26dcc6b5095a47c0d9025536c275e572703b5d46c8805fcd37f2fbec2d18ae0ea"} 06:45:23 INFO - Running post-run listener: copy_logs_to_upload_dir 06:45:23 INFO - Copying logs to upload dir... 06:45:23 INFO - mkdir: /builds/slave/test/build/upload/logs 06:45:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1330.224671 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 10 secs) (at 2016-04-16 06:45:23.823103) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-16 06:45:23.829071) ========= 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.UWBjIpLiqX/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.NZC2IUAKHW/Listeners TMPDIR=/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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/Firefox/sha512/d49ee12a61bc4a0a76f35c0ce09b1d2b30fe04197f81f20e5a897f39b0c6a6ebdd95d297d8cdaa499615fb75afa1287074895e46eb54792792ef92281fe1a20b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/981da9a87975298d21f7e277efb39b751a0354e4dcd3c2b4f5fcccbb44e455e26dcc6b5095a47c0d9025536c275e572703b5d46c8805fcd37f2fbec2d18ae0ea"} build_url:https://queue.taskcluster.net/v1/task/HrFnlNu-TPqUvGxGGwnpSQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011481 build_url: 'https://queue.taskcluster.net/v1/task/HrFnlNu-TPqUvGxGGwnpSQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d49ee12a61bc4a0a76f35c0ce09b1d2b30fe04197f81f20e5a897f39b0c6a6ebdd95d297d8cdaa499615fb75afa1287074895e46eb54792792ef92281fe1a20b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/981da9a87975298d21f7e277efb39b751a0354e4dcd3c2b4f5fcccbb44e455e26dcc6b5095a47c0d9025536c275e572703b5d46c8805fcd37f2fbec2d18ae0ea"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-16 06:45:23.858064) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 06:45:23.858604) ========= 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.UWBjIpLiqX/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.NZC2IUAKHW/Listeners TMPDIR=/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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.005419 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 06:45:23.908266) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-16 06:45:23.908564) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-16 06:45:23.908960) ========= ========= Total master_lag: 0.17 =========