builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0365 starttime: 1487862600.68 results: success (0) buildid: 20170223055822 builduid: 0b4a1849b127477f80fddab871f8daf9 revision: 27dade5e0c8350189eeb6495d70a9fb25ce137a9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-23 07:10:00.676723) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-23 07:10:00.677200) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-23 07:10:00.677527) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-23 07:10:00.714580) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 07:10:00.715413) ========= 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.cCGSNYmsMD/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.3czKX7moan/Listeners TMPDIR=/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-23 07:10:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 164M=0s 2017-02-23 07:10:01 (164 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.735132 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 07:10:01.478513) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 07:10:01.479189) ========= 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.cCGSNYmsMD/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.3czKX7moan/Listeners TMPDIR=/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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.025645 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 07:10:01.528181) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-23 07:10:01.528570) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 27dade5e0c8350189eeb6495d70a9fb25ce137a9 --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 27dade5e0c8350189eeb6495d70a9fb25ce137a9 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.cCGSNYmsMD/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.3czKX7moan/Listeners TMPDIR=/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-23 07:10:01,635 truncating revision to first 12 chars 2017-02-23 07:10:01,635 Setting DEBUG logging. 2017-02-23 07:10:01,635 attempt 1/10 2017-02-23 07:10:01,635 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/27dade5e0c83?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-23 07:10:03,598 unpacking tar archive at: mozilla-central-27dade5e0c83/testing/mozharness/ program finished with exit code 0 elapsedTime=2.237007 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-23 07:10:03.790277) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-23 07:10:03.790960) ========= script_repo_revision: 27dade5e0c8350189eeb6495d70a9fb25ce137a9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-23 07:10:03.791927) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-23 07:10:03.792379) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-23 07:10:03.810903) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-02-23 07:10:03.811485) ========= /tools/buildbot/bin/python -u 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', '-u', '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.cCGSNYmsMD/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.3czKX7moan/Listeners TMPDIR=/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 07:10:04 INFO - MultiFileLogger online at 20170223 07:10:04 in /builds/slave/test 07:10:04 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 07:10:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:10:04 INFO - {'append_to_log': False, 07:10:04 INFO - 'base_work_dir': '/builds/slave/test', 07:10:04 INFO - 'blob_upload_branch': 'Firefox', 07:10:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:10:04 INFO - 'branch': 'Firefox', 07:10:04 INFO - 'buildbot_json_path': 'buildprops.json', 07:10:04 INFO - 'config_files': ('talos/mac_config.py',), 07:10:04 INFO - 'default_actions': ('clobber', 07:10:04 INFO - 'read-buildbot-config', 07:10:04 INFO - 'download-and-extract', 07:10:04 INFO - 'populate-webroot', 07:10:04 INFO - 'create-virtualenv', 07:10:04 INFO - 'install', 07:10:04 INFO - 'run-tests'), 07:10:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:10:04 INFO - 'download_minidump_stackwalk': True, 07:10:04 INFO - 'download_symbols': 'ondemand', 07:10:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:10:04 INFO - 'tooltool.py': '/tools/tooltool.py', 07:10:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:10:04 INFO - '/tools/misc-python/virtualenv.py')}, 07:10:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:10:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:10:04 INFO - 'gecko_profile': False, 07:10:04 INFO - 'gecko_profile_interval': 0, 07:10:04 INFO - 'installer_path': 'installer.exe', 07:10:04 INFO - 'log_level': 'info', 07:10:04 INFO - 'log_name': 'talos', 07:10:04 INFO - 'log_to_console': True, 07:10:04 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:10:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:10:04 INFO - 'opt_config_files': (), 07:10:04 INFO - 'pip_index': False, 07:10:04 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:10:04 INFO - 'cmd': ('bash', 07:10:04 INFO - '-c', 07:10:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:10:04 INFO - 'enabled': True, 07:10:04 INFO - 'halt_on_failure': False, 07:10:04 INFO - 'name': 'check_screen_resolution'},), 07:10:04 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:10:04 INFO - 'cmd': ('bash', 07:10:04 INFO - '-c', 07:10:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:10:04 INFO - 'enabled': True, 07:10:04 INFO - 'halt_on_failure': False, 07:10:04 INFO - 'name': 'check_screen_resolution'},), 07:10:04 INFO - 'run_cmd_checks_enabled': True, 07:10:04 INFO - 'suite': 'dromaeojs-e10s', 07:10:04 INFO - 'system_bits': '32', 07:10:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:10:04 INFO - 'title': 't-yosemite-r7-0365', 07:10:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:10:04 INFO - 'use_talos_json': True, 07:10:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:10:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:10:04 INFO - 'work_dir': 'build'} 07:10:04 INFO - [mozharness: 2017-02-23 15:10:04.029395Z] Running clobber step. 07:10:04 INFO - Running pre-action listener: _resource_record_pre_action 07:10:04 INFO - Running main action method: clobber 07:10:04 INFO - rmtree: /builds/slave/test/build 07:10:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:10:06 INFO - Running post-action listener: _resource_record_post_action 07:10:06 INFO - [mozharness: 2017-02-23 15:10:06.464855Z] Finished clobber step (success) 07:10:06 INFO - [mozharness: 2017-02-23 15:10:06.465030Z] Running read-buildbot-config step. 07:10:06 INFO - Running pre-action listener: _resource_record_pre_action 07:10:06 INFO - Running main action method: read_buildbot_config 07:10:06 INFO - Using buildbot properties: 07:10:06 INFO - { 07:10:06 INFO - "project": "", 07:10:06 INFO - "product": "firefox", 07:10:06 INFO - "script_repo_revision": "production", 07:10:06 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 07:10:06 INFO - "repository": "", 07:10:06 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 07:10:06 INFO - "buildid": "20170223055822", 07:10:06 INFO - "pgo_build": "False", 07:10:06 INFO - "basedir": "/builds/slave/test", 07:10:06 INFO - "buildnumber": 63, 07:10:06 INFO - "slavename": "t-yosemite-r7-0365", 07:10:06 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 07:10:06 INFO - "platform": "yosemite_r7", 07:10:06 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 07:10:06 INFO - "branch": "mozilla-central", 07:10:06 INFO - "repo_path": "mozilla-central", 07:10:06 INFO - "revision": "27dade5e0c8350189eeb6495d70a9fb25ce137a9", 07:10:06 INFO - "stage_platform": "macosx64", 07:10:06 INFO - "builduid": "0b4a1849b127477f80fddab871f8daf9", 07:10:06 INFO - "slavebuilddir": "test" 07:10:06 INFO - } 07:10:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/KcJ43fEsQ-yH2Nxw7F4_Pw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 07:10:06 INFO - Running post-action listener: _resource_record_post_action 07:10:06 INFO - [mozharness: 2017-02-23 15:10:06.468635Z] Finished read-buildbot-config step (success) 07:10:06 INFO - [mozharness: 2017-02-23 15:10:06.468752Z] Running download-and-extract step. 07:10:06 INFO - Running pre-action listener: _resource_record_pre_action 07:10:06 INFO - Running main action method: download_and_extract 07:10:06 INFO - mkdir: /builds/slave/test/build/tests 07:10:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:10:06 INFO - trying https://queue.taskcluster.net/v1/task/KcJ43fEsQ-yH2Nxw7F4_Pw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 07:10:06 INFO - Downloading https://queue.taskcluster.net/v1/task/KcJ43fEsQ-yH2Nxw7F4_Pw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 07:10:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KcJ43fEsQ-yH2Nxw7F4_Pw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 07:10:07 INFO - Downloaded 1199 bytes. 07:10:07 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 07:10:07 INFO - Using the following test package requirements: 07:10:07 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 07:10:07 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:10:07 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 07:10:07 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:10:07 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 07:10:07 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:10:07 INFO - u'jsshell-mac.zip'], 07:10:07 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:10:07 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 07:10:07 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 07:10:07 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:10:07 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 07:10:07 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:10:07 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 07:10:07 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:10:07 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 07:10:07 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:10:07 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 07:10:07 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:10:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KcJ43fEsQ-yH2Nxw7F4_Pw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 07:10:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KcJ43fEsQ-yH2Nxw7F4_Pw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:10:07 INFO - Fetch https://queue.taskcluster.net/v1/task/KcJ43fEsQ-yH2Nxw7F4_Pw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 07:10:09 INFO - Expected file size: 51467455 07:10:09 INFO - Obtained file size: 51467455 07:10:25 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 07:10:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KcJ43fEsQ-yH2Nxw7F4_Pw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 07:10:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KcJ43fEsQ-yH2Nxw7F4_Pw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:10:25 INFO - Fetch https://queue.taskcluster.net/v1/task/KcJ43fEsQ-yH2Nxw7F4_Pw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 07:10:27 INFO - Expected file size: 51467455 07:10:27 INFO - Obtained file size: 51467455 07:10:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KcJ43fEsQ-yH2Nxw7F4_Pw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 07:10:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KcJ43fEsQ-yH2Nxw7F4_Pw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 07:10:42 INFO - Fetch https://queue.taskcluster.net/v1/task/KcJ43fEsQ-yH2Nxw7F4_Pw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 07:10:43 INFO - Expected file size: 14404306 07:10:43 INFO - Obtained file size: 14404306 07:10:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:10:43 INFO - trying https://queue.taskcluster.net/v1/task/KcJ43fEsQ-yH2Nxw7F4_Pw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 07:10:43 INFO - Downloading https://queue.taskcluster.net/v1/task/KcJ43fEsQ-yH2Nxw7F4_Pw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 07:10:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KcJ43fEsQ-yH2Nxw7F4_Pw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 07:10:47 INFO - Downloaded 74942729 bytes. 07:10:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KcJ43fEsQ-yH2Nxw7F4_Pw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 07:10:47 INFO - mkdir: /builds/slave/test/properties 07:10:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:10:47 INFO - Writing to file /builds/slave/test/properties/build_url 07:10:47 INFO - Contents: 07:10:47 INFO - build_url:https://queue.taskcluster.net/v1/task/KcJ43fEsQ-yH2Nxw7F4_Pw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 07:10:48 INFO - Running post-action listener: _resource_record_post_action 07:10:48 INFO - Running post-action listener: set_extra_try_arguments 07:10:48 INFO - [mozharness: 2017-02-23 15:10:48.646856Z] Finished download-and-extract step (success) 07:10:48 INFO - [mozharness: 2017-02-23 15:10:48.646986Z] Running populate-webroot step. 07:10:48 INFO - Running pre-action listener: _resource_record_pre_action 07:10:48 INFO - Running main action method: populate_webroot 07:10:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:10:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:10:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:10:48 INFO - '--tppagecycles', 07:10:48 INFO - '7'], 07:10:48 INFO - 'tests': ['tsvgm']}}, 07:10:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:10:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:10:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:10:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:10:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:10:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:10:48 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:10:48 INFO - 'talos_options': ['--disable-e10s'], 07:10:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:10:48 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:10:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:10:48 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:10:48 INFO - 'talos_options': ['--disable-e10s'], 07:10:48 INFO - 'tests': ['damp', 'tps']}, 07:10:48 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:10:48 INFO - 'tests': ['damp', 'tps']}, 07:10:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:10:48 INFO - 'tests': ['dromaeo_dom']}, 07:10:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:10:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:10:48 INFO - 'tests': ['basic_compositor_video']}, 07:10:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:10:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:10:48 INFO - 'tests': ['a11yr', 07:10:48 INFO - 'ts_paint', 07:10:48 INFO - 'tpaint', 07:10:48 INFO - 'sessionrestore', 07:10:48 INFO - 'sessionrestore_no_auto_restore', 07:10:48 INFO - 'tabpaint']}, 07:10:48 INFO - 'other-e10s': {'tests': ['a11yr', 07:10:48 INFO - 'ts_paint', 07:10:48 INFO - 'tpaint', 07:10:48 INFO - 'sessionrestore', 07:10:48 INFO - 'sessionrestore_no_auto_restore', 07:10:48 INFO - 'tabpaint']}, 07:10:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:10:48 INFO - 'ts_paint', 07:10:48 INFO - 'tpaint', 07:10:48 INFO - 'sessionrestore', 07:10:48 INFO - 'sessionrestore_no_auto_restore', 07:10:48 INFO - 'tabpaint']}, 07:10:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:10:48 INFO - 'ts_paint', 07:10:48 INFO - 'tpaint', 07:10:48 INFO - 'sessionrestore', 07:10:48 INFO - 'sessionrestore_no_auto_restore', 07:10:48 INFO - 'tabpaint']}, 07:10:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:10:48 INFO - 'tests': ['a11yr', 07:10:48 INFO - 'ts_paint', 07:10:48 INFO - 'tpaint', 07:10:48 INFO - 'sessionrestore', 07:10:48 INFO - 'sessionrestore_no_auto_restore', 07:10:48 INFO - 'tabpaint']}, 07:10:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:10:48 INFO - 'tests': ['a11yr', 07:10:48 INFO - 'ts_paint', 07:10:48 INFO - 'tpaint', 07:10:48 INFO - 'sessionrestore', 07:10:48 INFO - 'sessionrestore_no_auto_restore', 07:10:48 INFO - 'tabpaint']}, 07:10:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:10:48 INFO - 'tests': ['tsvgx', 07:10:48 INFO - 'tsvgr_opacity', 07:10:48 INFO - 'tart', 07:10:48 INFO - 'tscrollx', 07:10:48 INFO - 'cart', 07:10:48 INFO - 'tsvg_static']}, 07:10:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:10:48 INFO - 'tsvgr_opacity', 07:10:48 INFO - 'tart', 07:10:48 INFO - 'tscrollx', 07:10:48 INFO - 'cart', 07:10:48 INFO - 'tsvg_static']}, 07:10:48 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:10:48 INFO - 'talos_options': ['--disable-e10s'], 07:10:48 INFO - 'tests': ['tp5o']}, 07:10:48 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:10:48 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:10:48 INFO - 'talos_options': ['--disable-e10s', 07:10:48 INFO - '--xperf_path', 07:10:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:10:48 INFO - 'tests': ['tp5n']}, 07:10:48 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:10:48 INFO - 'talos_options': ['--xperf_path', 07:10:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:10:48 INFO - 'tests': ['tp5n']}}, 07:10:48 INFO - 'talos.zip': {'path': '', 07:10:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:10:48 INFO - Running post-action listener: _resource_record_post_action 07:10:48 INFO - [mozharness: 2017-02-23 15:10:48.665384Z] Finished populate-webroot step (success) 07:10:48 INFO - [mozharness: 2017-02-23 15:10:48.665487Z] Running create-virtualenv step. 07:10:48 INFO - Running pre-action listener: _resource_record_pre_action 07:10:48 INFO - Running main action method: create_virtualenv 07:10:48 INFO - Creating virtualenv /builds/slave/test/build/venv 07:10:48 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:10:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:10:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:10:48 INFO - Using real prefix '/tools/python27' 07:10:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:10:49 INFO - Installing distribute.............................................................................................................................................................................................done. 07:10:52 INFO - Installing pip.................done. 07:10:52 INFO - Return code: 0 07:10:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:10:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:10:52 INFO - Reading from file tmpfile_stdout 07:10:52 INFO - Output received: 07:10:52 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 07:10:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:10:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:10:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:10:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:52 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 0x103d32b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d35768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7f95c3130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b10d30>, '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 0x103a37db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b05be8>, '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.cCGSNYmsMD/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.3czKX7moan/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:10:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:10:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:10:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cCGSNYmsMD/Render', 07:10:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:10:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:10:52 INFO - 'HOME': '/Users/cltbld', 07:10:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:10:52 INFO - 'LOGNAME': 'cltbld', 07:10:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:52 INFO - 'MOZ_NO_REMOTE': '1', 07:10:52 INFO - 'NO_EM_RESTART': '1', 07:10:52 INFO - 'PAGER': '/bin/cat', 07:10:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:10:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:52 INFO - 'PWD': '/builds/slave/test', 07:10:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:10:52 INFO - 'SHELL': '/bin/bash', 07:10:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3czKX7moan/Listeners', 07:10:52 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 07:10:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:10:52 INFO - 'USER': 'cltbld', 07:10:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:10:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:10:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:52 INFO - 'XPC_FLAGS': '0x0', 07:10:52 INFO - 'XPC_SERVICE_NAME': '0', 07:10:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:10:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:52 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:10:52 INFO - Cleaning up... 07:10:52 INFO - Return code: 0 07:10:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:10:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:10:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:10:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103d32b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d35768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7f95c3130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b10d30>, '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 0x103a37db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b05be8>, '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.cCGSNYmsMD/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.3czKX7moan/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:10:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:10:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:10:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cCGSNYmsMD/Render', 07:10:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:10:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:10:52 INFO - 'HOME': '/Users/cltbld', 07:10:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:10:52 INFO - 'LOGNAME': 'cltbld', 07:10:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:52 INFO - 'MOZ_NO_REMOTE': '1', 07:10:52 INFO - 'NO_EM_RESTART': '1', 07:10:52 INFO - 'PAGER': '/bin/cat', 07:10:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:10:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:52 INFO - 'PWD': '/builds/slave/test', 07:10:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:10:52 INFO - 'SHELL': '/bin/bash', 07:10:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3czKX7moan/Listeners', 07:10:52 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 07:10:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:10:52 INFO - 'USER': 'cltbld', 07:10:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:10:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:10:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:52 INFO - 'XPC_FLAGS': '0x0', 07:10:52 INFO - 'XPC_SERVICE_NAME': '0', 07:10:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:10:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:53 INFO - Downloading/unpacking psutil>=3.1.1 07:10:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:10:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:10:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:10:57 INFO - Installing collected packages: psutil 07:10:57 INFO - Running setup.py install for psutil 07:10:57 INFO - building 'psutil._psutil_osx' extension 07:10:57 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 07:10:58 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 07:10:58 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 07:10:58 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 07:10:58 INFO - building 'psutil._psutil_posix' extension 07:10:58 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 07:10:58 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:10:58 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:10:58 INFO - ^ 07:10:58 INFO - 1 warning generated. 07:10:58 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 07:10:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:10:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:10:58 INFO - Successfully installed psutil 07:10:58 INFO - Cleaning up... 07:10:58 INFO - Return code: 0 07:10:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:10:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:10:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:10:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103d32b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d35768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7f95c3130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b10d30>, '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 0x103a37db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b05be8>, '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.cCGSNYmsMD/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.3czKX7moan/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:10:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:10:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:10:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cCGSNYmsMD/Render', 07:10:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:10:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:10:58 INFO - 'HOME': '/Users/cltbld', 07:10:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:10:58 INFO - 'LOGNAME': 'cltbld', 07:10:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:58 INFO - 'MOZ_NO_REMOTE': '1', 07:10:58 INFO - 'NO_EM_RESTART': '1', 07:10:58 INFO - 'PAGER': '/bin/cat', 07:10:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:10:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:58 INFO - 'PWD': '/builds/slave/test', 07:10:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:10:58 INFO - 'SHELL': '/bin/bash', 07:10:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3czKX7moan/Listeners', 07:10:58 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 07:10:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:10:58 INFO - 'USER': 'cltbld', 07:10:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:10:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:10:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:58 INFO - 'XPC_FLAGS': '0x0', 07:10:58 INFO - 'XPC_SERVICE_NAME': '0', 07:10:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:10:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:10:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:11:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:11:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:11:01 INFO - Installing collected packages: mozsystemmonitor 07:11:01 INFO - Running setup.py install for mozsystemmonitor 07:11:01 INFO - Successfully installed mozsystemmonitor 07:11:01 INFO - Cleaning up... 07:11:01 INFO - Return code: 0 07:11:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:11:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:11:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:11:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103d32b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d35768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7f95c3130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b10d30>, '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 0x103a37db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b05be8>, '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.cCGSNYmsMD/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.3czKX7moan/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:11:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:11:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:11:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cCGSNYmsMD/Render', 07:11:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:11:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:11:01 INFO - 'HOME': '/Users/cltbld', 07:11:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:11:01 INFO - 'LOGNAME': 'cltbld', 07:11:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:01 INFO - 'MOZ_NO_REMOTE': '1', 07:11:01 INFO - 'NO_EM_RESTART': '1', 07:11:01 INFO - 'PAGER': '/bin/cat', 07:11:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:11:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:01 INFO - 'PWD': '/builds/slave/test', 07:11:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:11:01 INFO - 'SHELL': '/bin/bash', 07:11:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3czKX7moan/Listeners', 07:11:01 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 07:11:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:11:01 INFO - 'USER': 'cltbld', 07:11:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:11:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:11:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:01 INFO - 'XPC_FLAGS': '0x0', 07:11:01 INFO - 'XPC_SERVICE_NAME': '0', 07:11:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:11:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:02 INFO - Downloading/unpacking jsonschema==2.5.1 07:11:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:11:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:11:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:05 INFO - Downloading functools32-3.2.3-2.tar.gz 07:11:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:11:05 INFO - warning: no files found matching '*.txt' 07:11:05 INFO - no previously-included directories found matching 'build' 07:11:05 INFO - no previously-included directories found matching 'dist' 07:11:05 INFO - no previously-included directories found matching '.git*' 07:11:05 INFO - Installing collected packages: jsonschema, functools32 07:11:05 INFO - Running setup.py install for functools32 07:11:05 INFO - warning: no files found matching '*.txt' 07:11:05 INFO - no previously-included directories found matching 'build' 07:11:05 INFO - no previously-included directories found matching 'dist' 07:11:05 INFO - no previously-included directories found matching '.git*' 07:11:05 INFO - Successfully installed jsonschema functools32 07:11:05 INFO - Cleaning up... 07:11:05 INFO - Return code: 0 07:11:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:11:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:11:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:11:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103d32b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d35768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7f95c3130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b10d30>, '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 0x103a37db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b05be8>, '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.cCGSNYmsMD/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.3czKX7moan/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:11:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:11:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:11:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cCGSNYmsMD/Render', 07:11:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:11:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:11:05 INFO - 'HOME': '/Users/cltbld', 07:11:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:11:05 INFO - 'LOGNAME': 'cltbld', 07:11:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:05 INFO - 'MOZ_NO_REMOTE': '1', 07:11:05 INFO - 'NO_EM_RESTART': '1', 07:11:05 INFO - 'PAGER': '/bin/cat', 07:11:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:11:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:05 INFO - 'PWD': '/builds/slave/test', 07:11:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:11:05 INFO - 'SHELL': '/bin/bash', 07:11:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3czKX7moan/Listeners', 07:11:05 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 07:11:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:11:05 INFO - 'USER': 'cltbld', 07:11:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:11:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:11:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:05 INFO - 'XPC_FLAGS': '0x0', 07:11:05 INFO - 'XPC_SERVICE_NAME': '0', 07:11:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:11:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:11:05 INFO - Cleaning up... 07:11:05 INFO - Return code: 0 07:11:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:11:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:11:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:11:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103d32b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d35768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7f95c3130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b10d30>, '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 0x103a37db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b05be8>, '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.cCGSNYmsMD/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.3czKX7moan/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:11:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:11:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:11:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cCGSNYmsMD/Render', 07:11:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:11:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:11:05 INFO - 'HOME': '/Users/cltbld', 07:11:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:11:05 INFO - 'LOGNAME': 'cltbld', 07:11:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:05 INFO - 'MOZ_NO_REMOTE': '1', 07:11:05 INFO - 'NO_EM_RESTART': '1', 07:11:05 INFO - 'PAGER': '/bin/cat', 07:11:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:11:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:05 INFO - 'PWD': '/builds/slave/test', 07:11:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:11:05 INFO - 'SHELL': '/bin/bash', 07:11:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3czKX7moan/Listeners', 07:11:05 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 07:11:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:11:05 INFO - 'USER': 'cltbld', 07:11:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:11:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:11:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:05 INFO - 'XPC_FLAGS': '0x0', 07:11:05 INFO - 'XPC_SERVICE_NAME': '0', 07:11:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:11:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:06 INFO - Downloading/unpacking blobuploader==1.2.4 07:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:08 INFO - Downloading blobuploader-1.2.4.tar.gz 07:11:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:11:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:11:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:11:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:11: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 07:11: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 07:11: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 07:11: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 07:11: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 07:11: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 07:11:09 INFO - Downloading docopt-0.6.1.tar.gz 07:11:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:11:10 INFO - Installing collected packages: blobuploader, requests, docopt 07:11:10 INFO - Running setup.py install for blobuploader 07:11:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:11:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:11:10 INFO - Running setup.py install for requests 07:11:10 INFO - Running setup.py install for docopt 07:11:10 INFO - Successfully installed blobuploader requests docopt 07:11:10 INFO - Cleaning up... 07:11:10 INFO - Return code: 0 07:11:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:11:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:11:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:10 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 0x103d32b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d35768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7f95c3130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b10d30>, '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 0x103a37db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b05be8>, '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.cCGSNYmsMD/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.3czKX7moan/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:11:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:11:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:11:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cCGSNYmsMD/Render', 07:11:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:11:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:11:10 INFO - 'HOME': '/Users/cltbld', 07:11:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:11:10 INFO - 'LOGNAME': 'cltbld', 07:11:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:10 INFO - 'MOZ_NO_REMOTE': '1', 07:11:10 INFO - 'NO_EM_RESTART': '1', 07:11:10 INFO - 'PAGER': '/bin/cat', 07:11:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:11:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:10 INFO - 'PWD': '/builds/slave/test', 07:11:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:11:10 INFO - 'SHELL': '/bin/bash', 07:11:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3czKX7moan/Listeners', 07:11:10 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 07:11:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:11:10 INFO - 'USER': 'cltbld', 07:11:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:11:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:11:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:10 INFO - 'XPC_FLAGS': '0x0', 07:11:10 INFO - 'XPC_SERVICE_NAME': '0', 07:11:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:11:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:11:11 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-QY4h0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:11:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:11:11 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-8WlEYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:11:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:11:11 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-9yHSB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:11:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:11:11 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-0_rY3C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:11:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:11:11 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-_zqEsd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:11:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:11:11 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-GWEYJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:11:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:11:11 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-8XTVmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:11:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:11:11 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-bQUFaK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:11:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:11:11 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-xAO9We-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:11:12 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-AtYgt6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:11:12 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-71qlGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:11:12 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-_V53jA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:11:12 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-XVhhT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:11:12 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-0W8mK0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:11:12 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-MAfK95-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:11:12 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-pfVm1S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:11:12 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-Fg1nmP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:11:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:11:12 INFO - Running setup.py install for manifestparser 07:11:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:11:13 INFO - Running setup.py install for mozcrash 07:11:13 INFO - Running setup.py install for mozdebug 07:11:13 INFO - Running setup.py install for mozdevice 07:11:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:11:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:11:13 INFO - Running setup.py install for mozfile 07:11:13 INFO - Running setup.py install for mozhttpd 07:11:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:11:13 INFO - Running setup.py install for mozinfo 07:11:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:11:13 INFO - Running setup.py install for mozInstall 07:11:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:11:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:11:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:11:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:11:14 INFO - Running setup.py install for mozleak 07:11:14 INFO - Running setup.py install for mozlog 07:11:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:11:14 INFO - Running setup.py install for moznetwork 07:11:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:11:14 INFO - Running setup.py install for mozprocess 07:11:14 INFO - Running setup.py install for mozprofile 07:11:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:11:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:11:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:11:14 INFO - Running setup.py install for mozrunner 07:11:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:11:15 INFO - Running setup.py install for mozscreenshot 07:11:15 INFO - Running setup.py install for moztest 07:11:15 INFO - Running setup.py install for mozversion 07:11:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:11:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:11:15 INFO - Cleaning up... 07:11:15 INFO - Return code: 0 07:11:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:11:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:11:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:11:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:15 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 0x103d32b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d35768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7f95c3130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b10d30>, '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 0x103a37db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b05be8>, '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.cCGSNYmsMD/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.3czKX7moan/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:11:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:11:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:11:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cCGSNYmsMD/Render', 07:11:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:11:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:11:15 INFO - 'HOME': '/Users/cltbld', 07:11:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:11:15 INFO - 'LOGNAME': 'cltbld', 07:11:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:15 INFO - 'MOZ_NO_REMOTE': '1', 07:11:15 INFO - 'NO_EM_RESTART': '1', 07:11:15 INFO - 'PAGER': '/bin/cat', 07:11:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:11:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:15 INFO - 'PWD': '/builds/slave/test', 07:11:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:11:15 INFO - 'SHELL': '/bin/bash', 07:11:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3czKX7moan/Listeners', 07:11:15 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 07:11:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:11:15 INFO - 'USER': 'cltbld', 07:11:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:11:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:11:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:15 INFO - 'XPC_FLAGS': '0x0', 07:11:15 INFO - 'XPC_SERVICE_NAME': '0', 07:11:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:11:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:11:15 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-s8Gyj2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:11:15 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:11:15 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-ol3DWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:11:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:11:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:11:15 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-lprmI3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:11:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:11:16 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-1P0FZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:11:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:11:16 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-WzUg1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:11:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:11:16 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-f1VtWA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:11:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:11:16 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-UlJane-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:11:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:11:16 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-CJgkKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:11:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:11:16 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-tvJpEb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:11:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:11:16 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-GlUR5y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:11:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:11:16 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-IrMvvN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:11:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:11:16 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-wP0SM9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:11:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:11:17 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-MXtOCg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:11:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:11:17 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-aplI8Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:11:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:11:17 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-wgmOjd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:11:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:11:17 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-K_Y8fT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:11:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:11:17 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-2oIyWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:11:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:11:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:11:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:11:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:11:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:11:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:11:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:11:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:20 INFO - Downloading blessings-1.6.tar.gz 07:11:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:11:20 INFO - Installing collected packages: blessings 07:11:20 INFO - Running setup.py install for blessings 07:11:20 INFO - Successfully installed blessings 07:11:20 INFO - Cleaning up... 07:11:20 INFO - Return code: 0 07:11:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:11:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:11:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:11:20 INFO - Reading from file tmpfile_stdout 07:11:20 INFO - Current package versions: 07:11:20 INFO - blessings == 1.6 07:11:20 INFO - blobuploader == 1.2.4 07:11:20 INFO - docopt == 0.6.1 07:11:20 INFO - functools32 == 3.2.3-2 07:11:20 INFO - jsonschema == 2.5.1 07:11:20 INFO - manifestparser == 1.1 07:11:20 INFO - mozInstall == 1.12 07:11:20 INFO - mozcrash == 1.0 07:11:20 INFO - mozdebug == 0.1 07:11:20 INFO - mozdevice == 0.49 07:11:20 INFO - mozfile == 1.2 07:11:20 INFO - mozhttpd == 0.7 07:11:20 INFO - mozinfo == 0.9 07:11:20 INFO - mozleak == 0.1 07:11:20 INFO - mozlog == 3.4 07:11:20 INFO - moznetwork == 0.27 07:11:20 INFO - mozprocess == 0.25 07:11:20 INFO - mozprofile == 0.28 07:11:20 INFO - mozrunner == 6.13 07:11:20 INFO - mozscreenshot == 0.1 07:11:20 INFO - mozsystemmonitor == 0.3 07:11:20 INFO - moztest == 0.8 07:11:20 INFO - mozversion == 1.4 07:11:20 INFO - psutil == 3.1.1 07:11:20 INFO - requests == 1.2.3 07:11:20 INFO - wsgiref == 0.1.2 07:11:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:11:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:11:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:11:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:20 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 0x103d32b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d35768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7f95c3130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b10d30>, '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 0x103a37db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b05be8>, '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.cCGSNYmsMD/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.3czKX7moan/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:11:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:11:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:11:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cCGSNYmsMD/Render', 07:11:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:11:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:11:20 INFO - 'HOME': '/Users/cltbld', 07:11:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:11:20 INFO - 'LOGNAME': 'cltbld', 07:11:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:20 INFO - 'MOZ_NO_REMOTE': '1', 07:11:20 INFO - 'NO_EM_RESTART': '1', 07:11:20 INFO - 'PAGER': '/bin/cat', 07:11:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:11:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:20 INFO - 'PWD': '/builds/slave/test', 07:11:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:11:20 INFO - 'SHELL': '/bin/bash', 07:11:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3czKX7moan/Listeners', 07:11:20 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 07:11:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:11:20 INFO - 'USER': 'cltbld', 07:11:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:11:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:11:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:20 INFO - 'XPC_FLAGS': '0x0', 07:11:20 INFO - 'XPC_SERVICE_NAME': '0', 07:11:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:11:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:11:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:11:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:11:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:11:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:11:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:11:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:11:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:11:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:11:21 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:11:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:11:21 INFO - Cleaning up... 07:11:21 INFO - Return code: 0 07:11:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:11: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:11:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:11:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:21 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 0x103d32b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d35768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7f95c3130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b10d30>, '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 0x103a37db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b05be8>, '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.cCGSNYmsMD/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.3czKX7moan/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:11:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:11:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:11:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cCGSNYmsMD/Render', 07:11:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:11:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:11:21 INFO - 'HOME': '/Users/cltbld', 07:11:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:11:21 INFO - 'LOGNAME': 'cltbld', 07:11:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:21 INFO - 'MOZ_NO_REMOTE': '1', 07:11:21 INFO - 'NO_EM_RESTART': '1', 07:11:21 INFO - 'PAGER': '/bin/cat', 07:11:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:11:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:21 INFO - 'PWD': '/builds/slave/test', 07:11:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:11:21 INFO - 'SHELL': '/bin/bash', 07:11:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3czKX7moan/Listeners', 07:11:21 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 07:11:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:11:21 INFO - 'USER': 'cltbld', 07:11:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:11:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:11:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:21 INFO - 'XPC_FLAGS': '0x0', 07:11:21 INFO - 'XPC_SERVICE_NAME': '0', 07:11:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:11:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:11:21 INFO - Cleaning up... 07:11:21 INFO - Return code: 0 07:11:21 INFO - Running post-action listener: _resource_record_post_action 07:11:21 INFO - Running post-action listener: _start_resource_monitoring 07:11:21 INFO - Starting resource monitoring. 07:11:21 INFO - [mozharness: 2017-02-23 15:11:21.438751Z] Finished create-virtualenv step (success) 07:11:21 INFO - [mozharness: 2017-02-23 15:11:21.439778Z] Running install step. 07:11:21 INFO - Running pre-action listener: _resource_record_pre_action 07:11:21 INFO - Running main action method: install 07:11:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:11:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:11:21 INFO - Reading from file tmpfile_stdout 07:11:21 INFO - Detecting whether we're running mozinstall >=1.0... 07:11:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:11:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:11:21 INFO - Reading from file tmpfile_stdout 07:11:21 INFO - Output received: 07:11:21 INFO - Usage: mozinstall [options] installer 07:11:21 INFO - Options: 07:11:21 INFO - -h, --help show this help message and exit 07:11:21 INFO - -d DEST, --destination=DEST 07:11:21 INFO - Directory to install application into. [default: 07:11:21 INFO - "/builds/slave/test"] 07:11:21 INFO - --app=APP Application being installed. [default: firefox] 07:11:21 INFO - mkdir: /builds/slave/test/build/application 07:11:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:11:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 07:11:42 INFO - Reading from file tmpfile_stdout 07:11:42 INFO - Output received: 07:11:42 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:11:42 INFO - Running post-action listener: _resource_record_post_action 07:11:42 INFO - [mozharness: 2017-02-23 15:11:42.417930Z] Finished install step (success) 07:11:42 INFO - [mozharness: 2017-02-23 15:11:42.418070Z] Running run-tests step. 07:11:42 INFO - Running pre-action listener: _resource_record_pre_action 07:11:42 INFO - Running main action method: run_tests 07:11:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:11:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:11:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:11:42 INFO - 2017-02-23 07:11:42.433 screenresolution[1639:8822] starting screenresolution argv=screenresolution get 07:11:42 INFO - 2017-02-23 07:11:42.435 screenresolution[1639:8822] Display 0: 1600x1200x32@60 07:11:42 INFO - 2017-02-23 07:11:42.441 screenresolution[1640:8824] starting screenresolution argv=screenresolution list 07:11:42 INFO - Available Modes on Display 0 07:11:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:11:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:11:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:11:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:11:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:11:42 INFO - Intel Iris: 07:11:42 INFO - Chipset Model: Intel Iris 07:11:42 INFO - Type: GPU 07:11:42 INFO - Bus: Built-In 07:11:42 INFO - VRAM (Dynamic, Max): 1536 MB 07:11:42 INFO - Vendor: Intel (0x8086) 07:11:42 INFO - Device ID: 0x0a2e 07:11:42 INFO - Revision ID: 0x0009 07:11:42 INFO - Displays: 07:11:42 INFO - Display: 07:11:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:11:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:11:42 INFO - Display Serial Number: 1600x1200 60 07:11:42 INFO - Main Display: Yes 07:11:42 INFO - Mirror: Off 07:11:42 INFO - Online: Yes 07:11:42 INFO - Rotation: Supported 07:11:42 INFO - Return code: 0 07:11:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:11:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:11:42 INFO - Python 2.7.3 07:11:42 INFO - Return code: 0 07:11:42 INFO - grabbing minidump binary from tooltool 07:11:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:11:42 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b10d30>, '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 0x103a37db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b05be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:11:42 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:11:42 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 07:11:42 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:11:42 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:11:42 INFO - Return code: 0 07:11:42 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:11:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:11:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:11:42 INFO - ENV: RUST_BACKTRACE is now 1 07:11:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:11:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:11:42 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/KcJ43fEsQ-yH2Nxw7F4_Pw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0365', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:11:42 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/KcJ43fEsQ-yH2Nxw7F4_Pw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0365 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:11:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cCGSNYmsMD/Render', 07:11:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:11:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:11:42 INFO - 'HOME': '/Users/cltbld', 07:11:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:11:42 INFO - 'LOGNAME': 'cltbld', 07:11:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:11:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:11:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:42 INFO - 'MOZ_NO_REMOTE': '1', 07:11:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:11:42 INFO - 'NO_EM_RESTART': '1', 07:11:42 INFO - 'PAGER': '/bin/cat', 07:11:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:11:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:42 INFO - 'PWD': '/builds/slave/test', 07:11:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:11:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:11:42 INFO - 'RUST_BACKTRACE': '1', 07:11:42 INFO - 'SHELL': '/bin/bash', 07:11:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3czKX7moan/Listeners', 07:11:42 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 07:11:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:11:42 INFO - 'USER': 'cltbld', 07:11:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:11:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:11:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:42 INFO - 'XPC_FLAGS': '0x0', 07:11:42 INFO - 'XPC_SERVICE_NAME': '0', 07:11:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:11:42 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/KcJ43fEsQ-yH2Nxw7F4_Pw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0365', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:11:43 INFO - mozversion application_buildid: 20170223055822 07:11:43 INFO - mozversion application_changeset: 27dade5e0c8350189eeb6495d70a9fb25ce137a9 07:11:43 INFO - mozversion application_display_name: Nightly 07:11:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:11:43 INFO - mozversion application_name: Firefox 07:11:43 INFO - mozversion application_remotingname: firefox 07:11:43 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:11:43 INFO - mozversion application_vendor: Mozilla 07:11:43 INFO - mozversion application_version: 54.0a1 07:11:43 INFO - mozversion platform_buildid: 20170223055822 07:11:43 INFO - mozversion platform_changeset: 27dade5e0c8350189eeb6495d70a9fb25ce137a9 07:11:43 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:11:43 INFO - mozversion platform_version: 54.0a1 07:11:43 INFO - using testdate: 1487862703 07:11:43 INFO - actual date: 1487862703 07:11:43 INFO - starting webserver on 'localhost:49241' 07:11:43 INFO - SUITE-START | Running 2 tests 07:11:43 INFO - TEST-START | dromaeo_css 07:11:43 INFO - operating with platform_type : mac_ 07:11:43 INFO - Initialising browser for dromaeo_css test... 07:11:43 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/tmpVFFCXI/profile http://localhost:49241/getInfo.html) 07:11:43 INFO - PROCESS | 1650 | 1487862703582 addons.xpi WARN Error loading bootstrap.js for disableSHA1rollout@mozilla.org: Error opening input stream (invalid filename?): jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/disableSHA1rollout@mozilla.org.xpi!/bootstrap.js 07:11:43 INFO - PROCESS | 1650 | 1487862703582 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method install 07:11:43 INFO - PROCESS | 1650 | 1487862703623 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method startup 07:11:45 INFO - PROCESS | 1650 | 2017-02-23 07:11:45.916 plugin-container[1652:9005] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9243, name = 'com.apple.tsm.portname' 07:11:45 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:11:45 INFO - PROCESS | 1650 | 2017-02-23 07:11:45.918 plugin-container[1652:9005] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4917, name = 'com.apple.CFPasteboardClient' 07:11:45 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:11:45 INFO - PROCESS | 1650 | 2017-02-23 07:11:45.918 plugin-container[1652:9005] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:11:45 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 07:11:45 INFO - PROCESS | 1650 | colorDepth:24 07:11:45 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 07:11:45 INFO - PROCESS | 1650 | __metrics 07:11:46 ERROR - PROCESS | 1650 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 07:11:46 INFO - PROCESS | 1650 | 1487862706080 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method shutdown 07:11:46 INFO - TEST-INFO | 1650: exit 0 07:11:46 INFO - Browser initialized. 07:11:46 INFO - Running cycle 1/1 for dromaeo_css test... 07:11:46 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/tmpVFFCXI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:11:47 INFO - PROCESS | 1654 | 1487862707102 addons.xpi WARN Error loading bootstrap.js for disableSHA1rollout@mozilla.org: Error opening input stream (invalid filename?): jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/disableSHA1rollout@mozilla.org.xpi!/bootstrap.js 07:11:47 INFO - PROCESS | 1654 | 1487862707103 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method startup 07:11:49 INFO - PROCESS | 1654 | 2017-02-23 07:11:49.301 plugin-container[1655:9145] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 07:11:49 INFO - PROCESS | 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:11:49 INFO - PROCESS | 1654 | 2017-02-23 07:11:49.302 plugin-container[1655:9145] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8843, name = 'com.apple.CFPasteboardClient' 07:11:49 INFO - PROCESS | 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:11:49 INFO - PROCESS | 1654 | 2017-02-23 07:11:49.302 plugin-container[1655:9145] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:11:58 INFO - PROCESS | 1654 | RSS: Main: 227430400 07:11:58 INFO - PROCESS | 1654 | 07:15:01 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 07:15:04 INFO - PROCESS | 1654 | RSS: Main: 249405440 07:15:04 INFO - PROCESS | 1654 | 07:16:47 INFO - PROCESS | 1654 | ************************* 07:16:47 INFO - PROCESS | 1654 | A coding exception was thrown and uncaught in a Task. 07:16:47 INFO - PROCESS | 1654 | 07:16:47 ERROR - PROCESS | 1654 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:16:47 INFO - PROCESS | 1654 | Full stack: 07:16:47 INFO - PROCESS | 1654 | ************************* 07:18:07 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 07:18:08 INFO - PROCESS | 1654 | RSS: Main: 256491520 07:18:08 INFO - PROCESS | 1654 | 07:21:10 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 07:21:10 INFO - PROCESS | 1654 | RSS: Main: 267456512 07:21:10 INFO - PROCESS | 1654 | 07:24:12 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 07:24:13 INFO - PROCESS | 1654 | RSS: Main: 260382720 07:24:13 INFO - PROCESS | 1654 | 07:27:16 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 07:27:17 INFO - PROCESS | 1654 | RSS: Main: 271298560 07:27:17 INFO - PROCESS | 1654 | 07:30:19 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 07:30:20 INFO - PROCESS | 1654 | RSS: Main: 264974336 07:30:20 INFO - PROCESS | 1654 | 07:30:20 INFO - PROCESS | 1654 | __start_tp_report 07:30:20 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 07:30:20 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 07:30:20 INFO - PROCESS | 1654 | |i|pagename|runs| 07:30:20 INFO - PROCESS | 1654 | |0;dojo.html;3370.376480351135;3372.9156771080707;3390.9152271193225;3402.5916889973205;3404.4212483877736;5534.252875861757;5702.971485142573;5704.657720536766;5743.081107022877;5822.563307751914;4497.437820272466;4686.765661716918;5578.2748242728385;5718.456746609066;5842.240508733858;5118.129917913963;5131.692098474085;5173.379194496666;5268.947310526884;5273.235380869772;4360.280553708634;5149.4335623081615;5331.946680533184;5356.196570514435;5366.91949620756;4250.617444429985;5015.5736762375245;5191.532762051395;5244.239585260135;5244.527992480657;4302.290122129845;5048.939722658246;5118.564921981599;5129.487051294841;5132.692038477703;5054.292399064134;5061.772220250061;5126.077306084903;5159.690418574897;5196.45437229093;5543.501084902378;5626.887462250732;5679.460451257165;5680.744366503517;5682.687452190128;6131.080337949299;6248.0627905814035;6249.7187626556915;6258.561900666955;6268.404501572343;6176.598521096114;6190.164327815777;6196.566240363177;6215.098810672427;6258.4680302174365;4829.3480380148585;5769.624974376652;5840.1239814027385;5848.181254624356;5853.122031695238;6193.6903154842075;6195.411435913581;6247.687615619201;6249.625022498664;6254.687265636791;6012.909806352908;6078.392160783975;6088.178095957078;6137.140800287963;6141.263048434216;6180.227471566054;6182.350853160443;6191.226096737908;6194.845128871814;6263.530235232376;6105.572609917352;6137.140800287963;6188.752449901954;6223.533235007392;6234.220722409699;5186.844394668166;6220.377962203744;6276.780312689125;6289.276733175652;6308.495320374359;4849.175640141185;5019.548240658358;5020.648554601143;5032.169692000852;5033.0688822567945;4356.520782713899;4407.382966384709;4415.271480205794;4472.463304403493;4486.865394038184;5297.258383826267;5363.839084827461;5807.128930660435;5807.216025836458;5812.680302583314;5295.861389801211;6260.530460215411;6278.654673992883;6278.717457714414;6298.685065746694;5565.721713914288;5603.775848966077;5650.124230744241;5677.630953987978;5698.3162020556965;5410.702411367412;5427.0773968425465;5428.83713488596;5453.481919217747;5534.252875861787;5553.639358357228;6322.209723784527;6339.985602303609;6354.872902542016;6376.33048529907;6007.068904319837;6133.84665383369;6247.00047992319;6276.058591211355;6303.590266632654;5165.276861239355;6164.167837341902;6191.535634827316;6248.187735594343;6259.2488901332135;5066.44269130388;6213.130161777445;6222.439980401786;6238.469730072995;6241.21984751906;4889.364382630235;6158.199434073542;6185.783497577563;6236.875262494816;6257.0614407837365;5898.262717160355;5987.101934709828;5988.760449581968;6055.63666180013;6189.783357582463;5949.196858424058;5958.582899197015;6002.459778619946;6052.939470605237;6065.4541091302;5480.342358916955;5773.942260577341;5787.479126878433;5856.326522449973;5867.061270196748;5990.7903223386975;6046.969765151146;6053.122297266959;6054.0918862169265;6062.272527296753;5882.323532793613;5896;5901.380355062828;5915.290165180206;5916.55625828056 07:30:20 INFO - PROCESS | 1654 | |1;ext.html;461.7991173839379;482.2910321826913;493.2330226497797;526.1082465221449;583.361219464686;37180;39662.8016859916;39736.80131599341;39784.99999999996;39857.800710996475;39959.60141395052;40558.39162412566;40583.59416405835;40662.59337406625;40798;7432.962835185816;7620.847583048336;9206.769830754218;9463.668771592995;11074.889251107466;11469.541218351256;11547.711307217303;11575.826362604526;11576;11589.188756787029;11539.596114136008;11621.360825154614;11630.825537616942;11640.941795291012;11652.592159274427;11509.597164099257;11553.826692599618;11581;11591.6522504325;11643.767124657545;11354.43227838613;11422.485988130555;11429.42852857362;11436.599719009795;11486.195966282363;32935.835320823484;39385.60614393877;39448.40827387592;39760.20479590392;39891.40162897559;3871.264459752666;3898.083950271684;3912.8630497932722;3929.607039296076;4092.6112019358116;29278.85360573205;29887.551686724717;30165;30969;31056.223594410094;3105.1460848266684;3119.485284927984;3139.152428844222;3230.7415406767404;3245.983770081158;414051;418111;418733;418873;419419;47057.76471117623;48310.75844620755;56862;57846.71076644674;58437.70781146067;59532.70233648891;59652;60110.39889601136;60179;60417.395826041175;14953.850461495245;15042.924785376223;15043.097414155185;15053.473128440672;15074.773878391832;11489.712757181138;11607.76784464306;11620.244684095507;11626.709332266591;11693.766124677459;15548.378064877505;15712.057276563442;15749.763753543706;15791.842081579267;15798.104227492775;6127.142200091991;6164.352742961924;6204.5967012144065;6217.378262173836;6251.593646412968;862.6587738346715;864.148813418782;866.7443104284251;871.3987348729484;893.5353616119581;25882.870585647328;28632.14103576896;28967.855160724062;29336.15953367713;29805.85097074544;1033.1424917318607;1037.527924794232;1061.984070238947;1088.216484131424;1194.6595220362155;15116.470923517623;15190.164540950354;15215.478452154917;15321.770173447407;15502.372250913491;478083;479584;480337;480909;481988;42516.57483425188;49569;55832.72083639556;57645.71177144171;57829;1373.7733274009677;1395.4627468424933;1406.563965170821;1408.9084209526347;1410.0693542262059;23972.52054958856;26351.34121646974;27039.59440608353;29060;29385.706142938296;47765.761171193924;47996.280055798496;48459.5154048455;48496.787580310775;48589;363254;363850;364206;365672.1716391401;366041;24077.638835417834;24539;24730.381740455912;25315.87342063278;37920;34615.653843461245;41332.41470209426;41445;42398.788006059774;42466.36300455434;33225.335493289516;34390.65609343975;35120.82439587888;35416.29167416689;35522;34111.829440852634;34909.65090349064;35028.82485587556;35155.82422087975;35256.64743352534;34230.82884585561;34585.65414345925;34633.48049779205;34736.478952815225;34907.650923491456;28155;29018.27454313659;31230.531542026434;31270.68729312678;31316.843415782776;23410;23529.882350588137;23660.408489787893;23801.52396952086;23813.761862381154 07:30:20 INFO - PROCESS | 1654 | |2;jquery.html;340.06990879943356;379.74936541882363;390.1475276520802;398.9002749312672;411.7318658531723;14082.507112251073;14163.92918035411;18689.34587289445;21449.67825482617;22180.11279548818;15835.445759398423;21231.57536849266;21335.613185142956;21360.145594176254;21704.023318950647;5765.971170144144;5849.619774714641;5917.852053698649;6085.087236914476;6089.81730548082;5865.208196893429;5923.378045305246;5946.791862284821;5955.434233747787;5959.731812068468;5712.1431785232135;6025.758969641209;6085.478630342414;6126.7549298028025;6128.9080663789855;5874.853128671774;6010.489108425789;6047.879042419149;6064.363241859607;6101.786437474711;5911.704414779244;5929.762809487615;5939.821805345847;5943.078822782432;5951.732172052268;13099.934500327437;13145.408456619474;13181.86818131816;13606.31968401576;13653.86346136536;2594.8702564871683;2623.2392606144194;2629.0929629277866;2633.1573896353175;2643.035292118382;9858.802823943553;9943.75140621483;10122.24083193756;10151.949240253825;14159.646008849759;1753.6931037068462;1779.715245560704;1818.4362847517311;1823.6899727046434;1837.1916356802965;110375;126063;136072.31963840118;138267;140530;11404.600838970762;11711.121665875093;11805.645830625095;11813.173077884638;11852.703682407837;12897.871021289668;14779.778303325458;15469.922650386676;15500.689986200212;15577.68844623124;6873.621950792754;8442.704505342284;8477.194666506672;8558.315334773204;8589.226969572768;6638.269790323061;6770.187577490733;7917.366610671133;8182.059063207688;8258.710945117013;3872.8381485554783;4661.720296782204;4739.364919102904;4811.446683631357;4835.709857408567;1687.325069972021;1952.4825921130628;1976.8813871167777;2027.7870823563608;2035.18592562976;805.64551597297;963.9878127965749;964.8277343028115;1006.6778630838062;1010.2625083688948;20737.481562961046;21164.535853252062;21174.894125529274;21220.893895530422;21244.681329780065;901.7520181950016;1033.4987531047436;1059.8569193158978;1069.1500257295468;1069.8769641491172;8743.256823169975;10336.17310615149;11285.435728213557;11292;11319.320840749417;647471;650957;654064;654755;673981;133920.62555621014;141896.29051854674;147500.26249868682;147503;151923.24038379738;849.8980122385353;926.333040211047;977.0571398600384;987.3187500624546;1004.7036124343336;18353.3576324828;18391.988440635894;18651.440456786317;18770.436886893414;19061.142248598568;53912.730436349135;54243.72878135584;56547.434525654215;56914.86170276654;57655.71172144113;79589.60205198936;84252.3149537018;84467.15532844592;93607.06392935984;93733.53133234564;6648.90026649591;7976.800579985546;8072.677092916218;8369.95815020921;8441;9179.495127768037;11812.3503207321;12573.87426125727;12832.871671283168;12936;9145.451272923647;10694.41180735036;10720.463976801284;10761.246712730033;11167.888321116685;10663.253572250178;10684.41235732011;10990.120790336914;11182.384968826793;11226.775464490502;9475;10910.672679819618;11160.609378671708;11360;11381.203315768147;7563.584002879895;8105.8784118239455;8242.835143297221;8333;8377.413581049512;9369.344145909721;10036.714821613787;10879.891201087888;11013.394263315595;11215.775684486427 07:30:20 INFO - PROCESS | 1654 | |3;mootools.html;1316.8683131686832;1431.856814318569;1454.4691187716483;1462.3857979648546;1476.298758089908;8141.715039973602;8220.424570280084;8517.31861451084;8584.012838523571;8606.096359882209;8367;8555.529445880475;8575.056743758181;8576.0995095515;8581.442206256588;2232.5088480534296;2281.897314620846;2288.8397812153157;2295.150794206146;2295.931122066341;1972.4970132616234;2275.9644361815417;2302.5510025545027;2311.826613004023;2319.5013072189477;2245.10195921631;2254.3124347074136;2265.920692775753;2276.4764104256033;2286.7598902115287;2181.1275489804048;2235.865848049122;2269.217120093573;2270.3075561953597;2273.9090436382526;1914.1864707499258;2004.4387571480008;2240.260713964388;2287.8284128690416;2302.781235782598;8272.875906861402;8519.10549392311;8525.275351595123;8613.095624959415;8626.784330391727;5045.4197767256865;5202.817901373472;5215.869603259911;5219.616801547593;5220.269162317279;3448;3472.9826350868084;3492.7205823534055;3504.404251277289;3567.9643203567894;1207.885250901163;1214.7995580729169;1243.359669770069;1263.412513181375;1277.3804704718204;8441.746747597583;10266.948665256701;10993.230473866832;11045.668629941114;11057.557697692082;3513.648635136517;4097;4152.43942067817;4499.460064792246;4515.435570553681;8710.390272680977;8794.472331659992;8799.076097009849;8801.779955501035;8822.86765698515;5121.411037730634;5127.66670166438;5134.435212126663;5135;5143;4605.562471565196;4618.307253911873;4731.101090792738;4801.087793319258;4815.566599006106;3599.874004409833;3657.158853463718;3658.506101676293;3692.9076773080888;3709.5548534176073;1130.0620484997596;1132.2300835431986;1142.7543078238218;1148.1446322489799;1151.6084531259244;838.9286910612544;871.8692196170498;877.5129802959291;910.5583791860943;922.2529750901791;5462.9726851365485;5584.720763961785;5628.155776633538;5647.717614119278;5898;905.42053086025;956.6747305916022;957.5595226196028;957.5636545182226;973.5035132082547;3063.877444902179;3396.371671240779;3476.800503826176;3547.2728090741334;3733.328000959799;9488.33581649278;9879.555420006118;9904.900950990543;10032.996700329908;10035.046670566284;9976.05227503386;9991.400515969066;10001.79996400068;10017.649382271731;10019;7736.574488403079;7910.762677119696;7939.364850811921;7947.523148610986;7985.800354991055;4270.615644591878;5331.067063263991;5508.834734957958;5597.63615365;5776.768929242783;9097.454152750855;9173.44959302444;9187.77030574241;9310.674126405544;9341.766455838659;7384.409247260099;7538.982237398101;8325.916740832756;8353.624086915981;9569.856452153084;6211.565190436626;6592.7033283503315;7258.419326453765;7285.526440781332;7319.158296795724;7754.224577542201;7864.410169237216;7934.761957141295;7959.363250939795;7965.721199757981;7187.209406965334;7205.639718014183;7224.927750722636;7271.672774725256;7275.563466192046;6879.3120687930805;6999.020137180697;7090.361867431956;7154.892676609959;7162.391196748335;6221.47117495018;6355.52333574993;6395.488360931021;6405.615663060231;6428.582142160744;4788.904221915612;4861.586765125004;4864.391951006124;4953.529414705597;5049.722265275445;4881.90236195267;4927.162382394929;5043.773030213576;5057.443681194992;5121.9743901281745 07:30:20 INFO - PROCESS | 1654 | |4;prototype.html;332.20602759405017;349.914271003604;361.882388223827;362.24110488526526;365.34238370932326;5054.570361519271;5318.707471089088;5545.445455454453;5559.360673522546;5566.332040155177;4315.899445641365;4988.675736077153;5307.601929855257;5412.648177868436;5413.377461591918;4109.383592461132;4155.667546596265;4173.895652608679;4175.3945677876845;4185.22573323936;3713.755891776258;3773.0755964788664;3871.5354157500997;4011.4785077939828;4197.16056788642;3744.775313481186;3961.207758448322;4100.6924480664065;4110.753354798707;4138.779060177255;3313.7017668409717;4068.0643452005907;4088.1619268049976;4106.240345536071;4134.751914885116;2811.9156425307274;2960.8223506589675;3549.2014296783277;3575.535180426554;3596.37063513884;4831.541003604652;4919.975400122977;5267.683938963674;5334.413214546396;5366.114591092465;3985.481887354654;4338.826446942118;4519.435070616173;4566.903943053643;4712.575868171881;4718.764061796931;5125;5247.580193584504;5764.74058667361;5875.471207591295;3676;3846.1922896238725;3863.787491687956;3946.289667859784;3952.229315283521;5330.893382132335;5387.437643083501;5634.7182640867795;5806.419358064202;5820.941790582082;3262.5269335946155;3552.7335449841366;3623.710103191738;3857.267119247334;3893.6106389361403;3953.8220780064967;3962.9696278967676;3966.424868394067;3972.3048466518244;3979.621935916083;4091.6112969267874;4333.609975102256;4418.4918734345965;4643.698159619614;4709.175894218498;5767.452092051249;5785.4214578541805;5793.333766616809;5809.779946211258;5888.941110588925;1134.7617000429836;1203.175824560179;1229.7786398448366;1244.3467179730715;1296.5332480307081;810.428647803309;857.9832898015871;867.6789587852409;879.4503435352905;889.3952112563389;4601.285241707409;4857.465678775332;4891.828785992544;5222.060029194781;5249.343832020997;5650.7174641267775;5688.431156884279;5753.3958934311295;5766.279215098113;5795.001449000177;4771.950170962383;5025.673331233458;5098.923516147261;5117.513836185556;5188.247704082887;2805.5931889875856;2899.391127863172;2967.2581854536365;2993.413490849853;3013.1111322160014;5501.5970927413255;5506.229127922094;5866.73599688015;5885;5925.822225333247;5166.675522536646;5171.560417364566;5615.719214039282;5878.617889837147;5962.34414214436;5020.422651395136;5251.527362537314;5270.262163297218;5925.614835035795;5926.555508336892;5459.918101228564;5461.399246083007;5690.914636280542;5727.513161381163;5757.453041961007;5118.41138269089;5594.720263986866;5893.970530147321;5896.7936122235515;5916;5233.142234506695;5393.86515337104;5488.204210389391;5810.501484361596;6193.38066193377;4239.279322515242;4262.637675797592;4278.128244030998;4293.91412171761;4310.4611923509565;4792.784324705327;5317.9468205319;5983.076754013582;5987.670678112746;5991;5196.896062078813;5391.519900845498;5517.337919449692;5762.596618236683;5770.6249093808765;4777.689450185866;5104;5162.561182299547;5736.196932429547;5768.480836724715;5264.9736751315995;5563.888722225452;5592.384837667934;5597.4327188387315;5657.236273103243;5724.74238659253;5733.856653583527;5735.569832262514;5758.971205143947;5772.8063335932075;5096.46487118862;5622.891415719106;5658.688772117573;5692.430756924275;5705.971470142623 07:30:20 INFO - PROCESS | 1654 | |5;yui.html;688.9001094841249;704.7760455332839;772.4940164192456;798.2496453333865;800.3357213512785;14156.575302740908;14822.555323340317;15200.239988000598;15278.694426111471;15397.538073857802;14029.579112626612;14268.215248161347;14310.785338219936;14332.498362557313;15201.17585889692;860.0668274921702;891.8350105230521;897.0177655467253;898.1153563739712;899.3704406915153;854.7264875239925;894.959726812295;898.2679116520048;900.045951291633;901.5942825728448;920.9631614735403;931.8509038553833;936.1293996583175;936.6113063078814;939.5865819039635;919.6183583812743;927.0868194828123;935.349931797401;935.4948327902924;939.9060093990614;691.4502970138701;693.774523279936;694.5103701890155;696.4532841719276;696.8571442854203;14006.299685015709;14516.274186290642;15278.923605382013;15499.690006199926;15605.45380911674;11742.765144697143;11864.169508134433;13753.106048106942;13764.93117534416;13926.721465570632;9276.814463710756;11635.185537012412;11635.185537012412;11645.534178632844;12073.517059317617;3602.819859007039;3722.1253005543676;3722.813859307024;3784.9621503784883;3809.5047643806406;93296.53351733266;96497.0350296495;99953.5002324991;104611.4769426148;104767.99999999924;9722.805543889082;10463.319884207502;10474;10682.252242343116;10973.50619222121;21824;21869.781302187093;21957.451063723536;22177.778222217894;22203.444913877283;7193.208747037822;7432.777016689508;7455.366293864974;7644.808879777939;7671.769846904602;4171.561985991488;4243.660507159481;4298.914021719548;4301.462317210348;4465.017696106851;3636.4363523653874;3659.5774415899923;3704.259148170323;3726.105734623725;3728.105254738843;619.485826763785;663.151166506872;672.4855485553555;685.6468918506973;687.8589889072728;541.6479288462452;552.5082676417991;571.2630706388795;579.7825815319255;634.5875181132301;9537.380070295409;9910.653127140515;9923.65267215644;10091.69724908254;10131.797364052825;517.2861451197324;520.232656831171;566.6684989281234;614.5053232148074;692.9861402771917;4851.289878197396;4876.429105938451;4903.554157285478;4944.283078953532;4972.950270497248;78763;94723.05276947281;95976;97998.02001980031;99486.00513994912;83721.6278372158;84667.15332846592;84703;86466.27067458615;87156.12843871607;67645;70250;71747.20631984138;71971.64014179895;72208.55582888312;9251.67619133327;9700.369475984038;10426.530806113591;10536.578536858746;10543.789124217627;44698.55301447074;45362.639120826425;46395;46551.53448465472;46736.7663161682;57069.714651426475;63773;65572.68854622977;68181;68254.65872670803;12626.512280491768;12789.488420463078;12801.423935923092;12830;12936.408356734564;14096.647583810076;14209.857901420854;14277.64305892361;14444;15021;13058.15122017066;13326.666833329244;13355.732885342433;13385.799213012007;13821.378037988114;12717.300548469922;13093.148945318524;13108.672283192996;13275.336233188495;14031.158130512202;10036.899631003596;12572.580162419981;12775.425105870445;12815.679608009874;12840.807387889376;9566.426014439156;10213.948930255301;10657.840132397865;10780.191485638452;11588.956993870592;8670.956645216733;9024.774380640536;10234.948825255826;10254.6410875619;10422.270441069053 07:30:20 INFO - PROCESS | 1654 | __end_tp_report 07:30:20 INFO - PROCESS | 1654 | __start_cc_report 07:30:20 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,432 07:30:20 INFO - PROCESS | 1654 | __end_cc_report 07:30:20 INFO - PROCESS | 1654 | __startTimestamp1487863820185__endTimestamp 07:30:20 INFO - PROCESS | 1654 | 07:30:20 INFO - PROCESS | 1654 | ------- Summary: start ------- 07:30:20 INFO - PROCESS | 1654 | Number of tests: 6 07:30:20 INFO - PROCESS | 1654 | 07:30:20 INFO - PROCESS | 1654 | [#0] dojo.html Cycles:165 Average:5649.91 Median:5848.18 stddev:667.25 (11.4%) stddev-sans-first:644.89 07:30:20 INFO - PROCESS | 1654 | Values: 3370.4 3372.9 3390.9 3402.6 3404.4 5534.3 5703.0 5704.7 5743.1 5822.6 4497.4 4686.8 5578.3 5718.5 5842.2 5118.1 5131.7 5173.4 5268.9 5273.2 4360.3 5149.4 5331.9 5356.2 5366.9 4250.6 5015.6 5191.5 5244.2 5244.5 4302.3 5048.9 5118.6 5129.5 5132.7 5054.3 5061.8 5126.1 5159.7 5196.5 5543.5 5626.9 5679.5 5680.7 5682.7 6131.1 6248.1 6249.7 6258.6 6268.4 6176.6 6190.2 6196.6 6215.1 6258.5 4829.3 5769.6 5840.1 5848.2 5853.1 6193.7 6195.4 6247.7 6249.6 6254.7 6012.9 6078.4 6088.2 6137.1 6141.3 6180.2 6182.4 6191.2 6194.8 6263.5 6105.6 6137.1 6188.8 6223.5 6234.2 5186.8 6220.4 6276.8 6289.3 6308.5 4849.2 5019.5 5020.6 5032.2 5033.1 4356.5 4407.4 4415.3 4472.5 4486.9 5297.3 5363.8 5807.1 5807.2 5812.7 5295.9 6260.5 6278.7 6278.7 6298.7 5565.7 5603.8 5650.1 5677.6 5698.3 5410.7 5427.1 5428.8 5453.5 5534.3 5553.6 6322.2 6340.0 6354.9 6376.3 6007.1 6133.8 6247.0 6276.1 6303.6 5165.3 6164.2 6191.5 6248.2 6259.2 5066.4 6213.1 6222.4 6238.5 6241.2 4889.4 6158.2 6185.8 6236.9 6257.1 5898.3 5987.1 5988.8 6055.6 6189.8 5949.2 5958.6 6002.5 6052.9 6065.5 5480.3 5773.9 5787.5 5856.3 5867.1 5990.8 6047.0 6053.1 6054.1 6062.3 5882.3 5896.0 5901.4 5915.3 5916.6 07:30:20 INFO - PROCESS | 1654 | 07:30:20 INFO - PROCESS | 1654 | [#1] ext.html Cycles:180 Average:56584.03 Median:34600.65 stddev:112196.92 (324.3%) stddev-sans-first:112432.53 07:30:20 INFO - PROCESS | 1654 | Values: 461.8 482.3 493.2 526.1 583.4 37180.0 39662.8 39736.8 39785.0 39857.8 39959.6 40558.4 40583.6 40662.6 40798.0 7433.0 7620.8 9206.8 9463.7 11074.9 11469.5 11547.7 11575.8 11576.0 11589.2 11539.6 11621.4 11630.8 11640.9 11652.6 11509.6 11553.8 11581.0 11591.7 11643.8 11354.4 11422.5 11429.4 11436.6 11486.2 32935.8 39385.6 39448.4 39760.2 39891.4 3871.3 3898.1 3912.9 3929.6 4092.6 29278.9 29887.6 30165.0 30969.0 31056.2 3105.1 3119.5 3139.2 3230.7 3246.0 414051.0 418111.0 418733.0 418873.0 419419.0 47057.8 48310.8 56862.0 57846.7 58437.7 59532.7 59652.0 60110.4 60179.0 60417.4 14953.9 15042.9 15043.1 15053.5 15074.8 11489.7 11607.8 11620.2 11626.7 11693.8 15548.4 15712.1 15749.8 15791.8 15798.1 6127.1 6164.4 6204.6 6217.4 6251.6 862.7 864.1 866.7 871.4 893.5 25882.9 28632.1 28967.9 29336.2 29805.9 1033.1 1037.5 1062.0 1088.2 1194.7 15116.5 15190.2 15215.5 15321.8 15502.4 478083.0 479584.0 480337.0 480909.0 481988.0 42516.6 49569.0 55832.7 57645.7 57829.0 1373.8 1395.5 1406.6 1408.9 1410.1 23972.5 26351.3 27039.6 29060.0 29385.7 47765.8 47996.3 48459.5 48496.8 48589.0 363254.0 363850.0 364206.0 365672.2 366041.0 24077.6 24539.0 24730.4 25315.9 37920.0 34615.7 41332.4 41445.0 42398.8 42466.4 33225.3 34390.7 35120.8 35416.3 35522.0 34111.8 34909.7 35028.8 35155.8 35256.6 34230.8 34585.7 34633.5 34736.5 34907.7 28155.0 29018.3 31230.5 31270.7 31316.8 23410.0 23529.9 23660.4 23801.5 23813.8 07:30:20 INFO - PROCESS | 1654 | 07:30:20 INFO - PROCESS | 1654 | [#2] jquery.html Cycles:180 Average:37335.75 Median:2609.05 stddev:109942.05 (4213.9%) stddev-sans-first:110215.37 07:30:20 INFO - PROCESS | 1654 | Values: 340.1 379.7 390.1 398.9 411.7 14082.5 14163.9 18689.3 21449.7 22180.1 15835.4 21231.6 21335.6 21360.1 21704.0 5766.0 5849.6 5917.9 6085.1 6089.8 5865.2 5923.4 5946.8 5955.4 5959.7 5712.1 6025.8 6085.5 6126.8 6128.9 5874.9 6010.5 6047.9 6064.4 6101.8 5911.7 5929.8 5939.8 5943.1 5951.7 13099.9 13145.4 13181.9 13606.3 13653.9 2594.9 2623.2 2629.1 2633.2 2643.0 9858.8 9943.8 10122.2 10151.9 14159.6 1753.7 1779.7 1818.4 1823.7 1837.2 110375.0 126063.0 136072.3 138267.0 140530.0 11404.6 11711.1 11805.6 11813.2 11852.7 12897.9 14779.8 15469.9 15500.7 15577.7 6873.6 8442.7 8477.2 8558.3 8589.2 6638.3 6770.2 7917.4 8182.1 8258.7 3872.8 4661.7 4739.4 4811.4 4835.7 1687.3 1952.5 1976.9 2027.8 2035.2 805.6 964.0 964.8 1006.7 1010.3 20737.5 21164.5 21174.9 21220.9 21244.7 901.8 1033.5 1059.9 1069.2 1069.9 8743.3 10336.2 11285.4 11292.0 11319.3 647471.0 650957.0 654064.0 654755.0 673981.0 133920.6 141896.3 147500.3 147503.0 151923.2 849.9 926.3 977.1 987.3 1004.7 18353.4 18392.0 18651.4 18770.4 19061.1 53912.7 54243.7 56547.4 56914.9 57655.7 79589.6 84252.3 84467.2 93607.1 93733.5 6648.9 7976.8 8072.7 8370.0 8441.0 9179.5 11812.4 12573.9 12832.9 12936.0 9145.5 10694.4 10720.5 10761.2 11167.9 10663.3 10684.4 10990.1 11182.4 11226.8 9475.0 10910.7 11160.6 11360.0 11381.2 7563.6 8105.9 8242.8 8333.0 8377.4 9369.3 10036.7 10879.9 11013.4 11215.8 07:30:20 INFO - PROCESS | 1654 | 07:30:20 INFO - PROCESS | 1654 | [#3] mootools.html Cycles:180 Average:5354.86 Median:5172.91 stddev:2929.87 (56.6%) stddev-sans-first:2922.37 07:30:20 INFO - PROCESS | 1654 | Values: 1316.9 1431.9 1454.5 1462.4 1476.3 8141.7 8220.4 8517.3 8584.0 8606.1 8367.0 8555.5 8575.1 8576.1 8581.4 2232.5 2281.9 2288.8 2295.2 2295.9 1972.5 2276.0 2302.6 2311.8 2319.5 2245.1 2254.3 2265.9 2276.5 2286.8 2181.1 2235.9 2269.2 2270.3 2273.9 1914.2 2004.4 2240.3 2287.8 2302.8 8272.9 8519.1 8525.3 8613.1 8626.8 5045.4 5202.8 5215.9 5219.6 5220.3 3448.0 3473.0 3492.7 3504.4 3568.0 1207.9 1214.8 1243.4 1263.4 1277.4 8441.7 10266.9 10993.2 11045.7 11057.6 3513.6 4097.0 4152.4 4499.5 4515.4 8710.4 8794.5 8799.1 8801.8 8822.9 5121.4 5127.7 5134.4 5135.0 5143.0 4605.6 4618.3 4731.1 4801.1 4815.6 3599.9 3657.2 3658.5 3692.9 3709.6 1130.1 1132.2 1142.8 1148.1 1151.6 838.9 871.9 877.5 910.6 922.3 5463.0 5584.7 5628.2 5647.7 5898.0 905.4 956.7 957.6 957.6 973.5 3063.9 3396.4 3476.8 3547.3 3733.3 9488.3 9879.6 9904.9 10033.0 10035.0 9976.1 9991.4 10001.8 10017.6 10019.0 7736.6 7910.8 7939.4 7947.5 7985.8 4270.6 5331.1 5508.8 5597.6 5776.8 9097.5 9173.4 9187.8 9310.7 9341.8 7384.4 7539.0 8325.9 8353.6 9569.9 6211.6 6592.7 7258.4 7285.5 7319.2 7754.2 7864.4 7934.8 7959.4 7965.7 7187.2 7205.6 7224.9 7271.7 7275.6 6879.3 6999.0 7090.4 7154.9 7162.4 6221.5 6355.5 6395.5 6405.6 6428.6 4788.9 4861.6 4864.4 4953.5 5049.7 4881.9 4927.2 5043.8 5057.4 5122.0 07:30:20 INFO - PROCESS | 1654 | 07:30:20 INFO - PROCESS | 1654 | [#4] prototype.html Cycles:180 Average:4567.18 Median:5164.62 stddev:1407.47 (27.3%) stddev-sans-first:1375.06 07:30:20 INFO - PROCESS | 1654 | Values: 332.2 349.9 361.9 362.2 365.3 5054.6 5318.7 5545.4 5559.4 5566.3 4315.9 4988.7 5307.6 5412.6 5413.4 4109.4 4155.7 4173.9 4175.4 4185.2 3713.8 3773.1 3871.5 4011.5 4197.2 3744.8 3961.2 4100.7 4110.8 4138.8 3313.7 4068.1 4088.2 4106.2 4134.8 2811.9 2960.8 3549.2 3575.5 3596.4 4831.5 4920.0 5267.7 5334.4 5366.1 3985.5 4338.8 4519.4 4566.9 4712.6 4718.8 5125.0 5247.6 5764.7 5875.5 3676.0 3846.2 3863.8 3946.3 3952.2 5330.9 5387.4 5634.7 5806.4 5820.9 3262.5 3552.7 3623.7 3857.3 3893.6 3953.8 3963.0 3966.4 3972.3 3979.6 4091.6 4333.6 4418.5 4643.7 4709.2 5767.5 5785.4 5793.3 5809.8 5888.9 1134.8 1203.2 1229.8 1244.3 1296.5 810.4 858.0 867.7 879.5 889.4 4601.3 4857.5 4891.8 5222.1 5249.3 5650.7 5688.4 5753.4 5766.3 5795.0 4772.0 5025.7 5098.9 5117.5 5188.2 2805.6 2899.4 2967.3 2993.4 3013.1 5501.6 5506.2 5866.7 5885.0 5925.8 5166.7 5171.6 5615.7 5878.6 5962.3 5020.4 5251.5 5270.3 5925.6 5926.6 5459.9 5461.4 5690.9 5727.5 5757.5 5118.4 5594.7 5894.0 5896.8 5916.0 5233.1 5393.9 5488.2 5810.5 6193.4 4239.3 4262.6 4278.1 4293.9 4310.5 4792.8 5317.9 5983.1 5987.7 5991.0 5196.9 5391.5 5517.3 5762.6 5770.6 4777.7 5104.0 5162.6 5736.2 5768.5 5265.0 5563.9 5592.4 5597.4 5657.2 5724.7 5733.9 5735.6 5759.0 5772.8 5096.5 5622.9 5658.7 5692.4 5706.0 07:30:20 INFO - PROCESS | 1654 | 07:30:20 INFO - PROCESS | 1654 | [#5] yui.html Cycles:180 Average:19397.74 Median:46644.15 stddev:27348.40 (58.6%) stddev-sans-first:27389.04 07:30:20 INFO - PROCESS | 1654 | Values: 688.9 704.8 772.5 798.2 800.3 14156.6 14822.6 15200.2 15278.7 15397.5 14029.6 14268.2 14310.8 14332.5 15201.2 860.1 891.8 897.0 898.1 899.4 854.7 895.0 898.3 900.0 901.6 921.0 931.9 936.1 936.6 939.6 919.6 927.1 935.3 935.5 939.9 691.5 693.8 694.5 696.5 696.9 14006.3 14516.3 15278.9 15499.7 15605.5 11742.8 11864.2 13753.1 13764.9 13926.7 9276.8 11635.2 11635.2 11645.5 12073.5 3602.8 3722.1 3722.8 3785.0 3809.5 93296.5 96497.0 99953.5 104611.5 104768.0 9722.8 10463.3 10474.0 10682.3 10973.5 21824.0 21869.8 21957.5 22177.8 22203.4 7193.2 7432.8 7455.4 7644.8 7671.8 4171.6 4243.7 4298.9 4301.5 4465.0 3636.4 3659.6 3704.3 3726.1 3728.1 619.5 663.2 672.5 685.6 687.9 541.6 552.5 571.3 579.8 634.6 9537.4 9910.7 9923.7 10091.7 10131.8 517.3 520.2 566.7 614.5 693.0 4851.3 4876.4 4903.6 4944.3 4973.0 78763.0 94723.1 95976.0 97998.0 99486.0 83721.6 84667.2 84703.0 86466.3 87156.1 67645.0 70250.0 71747.2 71971.6 72208.6 9251.7 9700.4 10426.5 10536.6 10543.8 44698.6 45362.6 46395.0 46551.5 46736.8 57069.7 63773.0 65572.7 68181.0 68254.7 12626.5 12789.5 12801.4 12830.0 12936.4 14096.6 14209.9 14277.6 14444.0 15021.0 13058.2 13326.7 13355.7 13385.8 13821.4 12717.3 13093.1 13108.7 13275.3 14031.2 10036.9 12572.6 12775.4 12815.7 12840.8 9566.4 10213.9 10657.8 10780.2 11589.0 8671.0 9024.8 10234.9 10254.6 10422.3 07:30:20 INFO - PROCESS | 1654 | -------- Summary: end -------- 07:30:20 INFO - PROCESS | 1654 | 07:30:20 INFO - PROCESS | 1654 | 1487863820214 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method shutdown 07:30:20 INFO - TEST-INFO | 1654: exit 0 07:30:20 INFO - TEST-OK | dromaeo_css | took 1117875ms 07:30:20 INFO - TEST-START | kraken 07:30:20 INFO - operating with platform_type : mac_ 07:30:20 INFO - Initialising browser for kraken test... 07:30:20 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/tmpqXfa9f/profile http://localhost:49241/getInfo.html) 07:30:21 INFO - PROCESS | 1663 | 1487863821439 addons.xpi WARN Error loading bootstrap.js for disableSHA1rollout@mozilla.org: Error opening input stream (invalid filename?): jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/disableSHA1rollout@mozilla.org.xpi!/bootstrap.js 07:30:21 INFO - PROCESS | 1663 | 1487863821440 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method install 07:30:21 INFO - PROCESS | 1663 | 1487863821481 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method startup 07:30:23 INFO - PROCESS | 1663 | 2017-02-23 07:30:23.790 plugin-container[1664:11420] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x434b, name = 'com.apple.tsm.portname' 07:30:23 INFO - PROCESS | 1663 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:30:23 INFO - PROCESS | 1663 | 2017-02-23 07:30:23.792 plugin-container[1664:11420] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 07:30:23 INFO - PROCESS | 1663 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:30:23 INFO - PROCESS | 1663 | 2017-02-23 07:30:23.792 plugin-container[1664:11420] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:30:23 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 07:30:23 INFO - PROCESS | 1663 | colorDepth:24 07:30:23 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 07:30:23 INFO - PROCESS | 1663 | __metrics 07:30:24 ERROR - PROCESS | 1663 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 07:30:24 INFO - PROCESS | 1663 | 1487863824006 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method shutdown 07:30:24 INFO - TEST-INFO | 1663: exit 0 07:30:24 INFO - Browser initialized. 07:30:24 INFO - Running cycle 1/1 for kraken test... 07:30:24 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/tmpqXfa9f/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:30:25 INFO - PROCESS | 1665 | 1487863825035 addons.xpi WARN Error loading bootstrap.js for disableSHA1rollout@mozilla.org: Error opening input stream (invalid filename?): jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/disableSHA1rollout@mozilla.org.xpi!/bootstrap.js 07:30:25 INFO - PROCESS | 1665 | 1487863825036 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method startup 07:30:27 INFO - PROCESS | 1665 | 2017-02-23 07:30:27.070 plugin-container[1666:11552] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a4b, name = 'com.apple.tsm.portname' 07:30:27 INFO - PROCESS | 1665 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:30:27 INFO - PROCESS | 1665 | 2017-02-23 07:30:27.071 plugin-container[1666:11552] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9017, name = 'com.apple.CFPasteboardClient' 07:30:27 INFO - PROCESS | 1665 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:30:27 INFO - PROCESS | 1665 | 2017-02-23 07:30:27.071 plugin-container[1666:11552] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:30:36 INFO - PROCESS | 1665 | RSS: Main: 225886208 07:30:36 INFO - PROCESS | 1665 | 07:30:39 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 07:30:40 INFO - PROCESS | 1665 | RSS: Main: 240635904 07:30:40 INFO - PROCESS | 1665 | 07:30:43 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 07:30:44 INFO - PROCESS | 1665 | RSS: Main: 248664064 07:30:44 INFO - PROCESS | 1665 | 07:30:47 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 07:30:48 INFO - PROCESS | 1665 | RSS: Main: 251305984 07:30:48 INFO - PROCESS | 1665 | 07:30:50 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 07:30:50 INFO - PROCESS | 1665 | RSS: Main: 252518400 07:30:50 INFO - PROCESS | 1665 | 07:30:52 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:30:53 INFO - PROCESS | 1665 | RSS: Main: 254193664 07:30:53 INFO - PROCESS | 1665 | 07:30:56 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 07:30:56 INFO - PROCESS | 1665 | RSS: Main: 259534848 07:30:56 INFO - PROCESS | 1665 | 07:30:59 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 07:31:00 INFO - PROCESS | 1665 | RSS: Main: 258895872 07:31:00 INFO - PROCESS | 1665 | 07:31:03 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 07:31:04 INFO - PROCESS | 1665 | RSS: Main: 258912256 07:31:04 INFO - PROCESS | 1665 | 07:31:05 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:31:06 INFO - PROCESS | 1665 | RSS: Main: 258215936 07:31:06 INFO - PROCESS | 1665 | 07:31:08 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:31:09 INFO - PROCESS | 1665 | RSS: Main: 258260992 07:31:09 INFO - PROCESS | 1665 | 07:31:11 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:31:11 INFO - PROCESS | 1665 | RSS: Main: 258281472 07:31:11 INFO - PROCESS | 1665 | 07:31:14 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:31:15 INFO - PROCESS | 1665 | RSS: Main: 258576384 07:31:15 INFO - PROCESS | 1665 | 07:31:18 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:31:19 INFO - PROCESS | 1665 | RSS: Main: 258338816 07:31:19 INFO - PROCESS | 1665 | 07:31:21 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 07:31:21 INFO - PROCESS | 1665 | RSS: Main: 260526080 07:31:21 INFO - PROCESS | 1665 | 07:31:21 INFO - PROCESS | 1665 | __start_tp_report 07:31:21 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 07:31:21 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 07:31:21 INFO - PROCESS | 1665 | |i|pagename|runs| 07:31:21 INFO - PROCESS | 1665 | |0;ai-astar;107;118;120;119;118;119;122;118;120;119 07:31:21 INFO - PROCESS | 1665 | |1;audio-beat-detection;155;116;116;148;144;117;117;114;136;114 07:31:21 INFO - PROCESS | 1665 | |2;audio-dft;200;210;209;242;247;286;194;199;213;202 07:31:21 INFO - PROCESS | 1665 | |3;audio-fft;84;60;60;85;64;64;63;86;69;73 07:31:21 INFO - PROCESS | 1665 | |4;audio-oscillator;86;71;86;73;72;71;83;73;70;84 07:31:21 INFO - PROCESS | 1665 | |5;imaging-gaussian-blur;89;93;90;92;90;89;90;90;90;89 07:31:21 INFO - PROCESS | 1665 | |6;imaging-darkroom;98;101;101;98;98;101;113;128;98;100 07:31:21 INFO - PROCESS | 1665 | |7;imaging-desaturate;99;121;93;145;146;127;94;91;92;149 07:31:21 INFO - PROCESS | 1665 | |8;json-parse-financial;64;65;64;65;69;66;64;65;65;63 07:31:21 INFO - PROCESS | 1665 | |9;json-stringify-tinderbox;72;71;78;81;77;70;69;70;72;70 07:31:21 INFO - PROCESS | 1665 | |10;stanford-crypto-aes;93;88;91;99;84;89;86;89;89;103 07:31:21 INFO - PROCESS | 1665 | |11;stanford-crypto-ccm;152;169;156;159;156;148;146;146;186;167 07:31:21 INFO - PROCESS | 1665 | |12;stanford-crypto-pbkdf2;175;179;182;176;179;173;168;205;179;179 07:31:21 INFO - PROCESS | 1665 | |13;stanford-crypto-sha256-iterative;74;69;80;74;66;69;66;70;69;67 07:31:21 INFO - PROCESS | 1665 | __end_tp_report 07:31:21 INFO - PROCESS | 1665 | __start_cc_report 07:31:21 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,1004 07:31:21 INFO - PROCESS | 1665 | __end_cc_report 07:31:21 INFO - PROCESS | 1665 | __startTimestamp1487863881448__endTimestamp 07:31:21 INFO - PROCESS | 1665 | 07:31:21 INFO - PROCESS | 1665 | ------- Summary: start ------- 07:31:21 INFO - PROCESS | 1665 | Number of tests: 14 07:31:21 INFO - PROCESS | 1665 | 07:31:21 INFO - PROCESS | 1665 | [#0] ai-astar Cycles:10 Average:118.00 Median:119.00 stddev:4.06 (3.4%) stddev-sans-first:1.30 07:31:21 INFO - PROCESS | 1665 | Values: 107.0 118.0 120.0 119.0 118.0 119.0 122.0 118.0 120.0 119.0 07:31:21 INFO - PROCESS | 1665 | 07:31:21 INFO - PROCESS | 1665 | [#1] audio-beat-detection Cycles:10 Average:127.70 Median:126.50 stddev:16.23 (12.8%) stddev-sans-first:13.88 07:31:21 INFO - PROCESS | 1665 | Values: 155.0 116.0 116.0 148.0 144.0 117.0 117.0 114.0 136.0 114.0 07:31:21 INFO - PROCESS | 1665 | 07:31:21 INFO - PROCESS | 1665 | [#2] audio-dft Cycles:10 Average:220.20 Median:211.50 stddev:29.21 (13.8%) stddev-sans-first:30.05 07:31:21 INFO - PROCESS | 1665 | Values: 200.0 210.0 209.0 242.0 247.0 286.0 194.0 199.0 213.0 202.0 07:31:21 INFO - PROCESS | 1665 | 07:31:21 INFO - PROCESS | 1665 | [#3] audio-fft Cycles:10 Average:70.80 Median:71.00 stddev:10.55 (14.9%) stddev-sans-first:10.05 07:31:21 INFO - PROCESS | 1665 | Values: 84.0 60.0 60.0 85.0 64.0 64.0 63.0 86.0 69.0 73.0 07:31:21 INFO - PROCESS | 1665 | 07:31:21 INFO - PROCESS | 1665 | [#4] audio-oscillator Cycles:10 Average:76.90 Median:78.00 stddev:6.87 (8.8%) stddev-sans-first:6.45 07:31:21 INFO - PROCESS | 1665 | Values: 86.0 71.0 86.0 73.0 72.0 71.0 83.0 73.0 70.0 84.0 07:31:21 INFO - PROCESS | 1665 | 07:31:21 INFO - PROCESS | 1665 | [#5] imaging-gaussian-blur Cycles:10 Average:90.20 Median:90.00 stddev:1.32 (1.5%) stddev-sans-first:1.32 07:31:21 INFO - PROCESS | 1665 | Values: 89.0 93.0 90.0 92.0 90.0 89.0 90.0 90.0 90.0 89.0 07:31:21 INFO - PROCESS | 1665 | 07:31:21 INFO - PROCESS | 1665 | [#6] imaging-darkroom Cycles:10 Average:103.60 Median:113.00 stddev:9.67 (8.6%) stddev-sans-first:10.05 07:31:21 INFO - PROCESS | 1665 | Values: 98.0 101.0 101.0 98.0 98.0 101.0 113.0 128.0 98.0 100.0 07:31:21 INFO - PROCESS | 1665 | 07:31:21 INFO - PROCESS | 1665 | [#7] imaging-desaturate Cycles:10 Average:115.70 Median:91.50 stddev:24.67 (27.0%) stddev-sans-first:25.42 07:31:21 INFO - PROCESS | 1665 | Values: 99.0 121.0 93.0 145.0 146.0 127.0 94.0 91.0 92.0 149.0 07:31:21 INFO - PROCESS | 1665 | 07:31:21 INFO - PROCESS | 1665 | [#8] json-parse-financial Cycles:10 Average:65.00 Median:65.00 stddev:1.63 (2.5%) stddev-sans-first:1.69 07:31:21 INFO - PROCESS | 1665 | Values: 64.0 65.0 64.0 65.0 69.0 66.0 64.0 65.0 65.0 63.0 07:31:21 INFO - PROCESS | 1665 | 07:31:21 INFO - PROCESS | 1665 | [#9] json-stringify-tinderbox Cycles:10 Average:73.00 Median:72.00 stddev:4.14 (5.7%) stddev-sans-first:4.37 07:31:21 INFO - PROCESS | 1665 | Values: 72.0 71.0 78.0 81.0 77.0 70.0 69.0 70.0 72.0 70.0 07:31:21 INFO - PROCESS | 1665 | 07:31:21 INFO - PROCESS | 1665 | [#10] stanford-crypto-aes Cycles:10 Average:91.10 Median:89.00 stddev:5.84 (6.6%) stddev-sans-first:6.15 07:31:21 INFO - PROCESS | 1665 | Values: 93.0 88.0 91.0 99.0 84.0 89.0 86.0 89.0 89.0 103.0 07:31:21 INFO - PROCESS | 1665 | 07:31:21 INFO - PROCESS | 1665 | [#11] stanford-crypto-ccm Cycles:10 Average:158.50 Median:157.50 stddev:12.55 (8.0%) stddev-sans-first:13.08 07:31:21 INFO - PROCESS | 1665 | Values: 152.0 169.0 156.0 159.0 156.0 148.0 146.0 146.0 186.0 167.0 07:31:21 INFO - PROCESS | 1665 | 07:31:21 INFO - PROCESS | 1665 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.50 Median:179.00 stddev:9.80 (5.5%) stddev-sans-first:10.26 07:31:21 INFO - PROCESS | 1665 | Values: 175.0 179.0 182.0 176.0 179.0 173.0 168.0 205.0 179.0 179.0 07:31:21 INFO - PROCESS | 1665 | 07:31:21 INFO - PROCESS | 1665 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:69.50 stddev:4.40 (6.3%) stddev-sans-first:4.47 07:31:21 INFO - PROCESS | 1665 | Values: 74.0 69.0 80.0 74.0 66.0 69.0 66.0 70.0 69.0 67.0 07:31:21 INFO - PROCESS | 1665 | -------- Summary: end -------- 07:31:21 INFO - PROCESS | 1665 | 07:31:21 INFO - PROCESS | 1665 | 1487863881471 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method shutdown 07:31:22 INFO - TEST-INFO | 1665: exit 0 07:31:22 INFO - TEST-OK | kraken | took 61466ms 07:31:22 INFO - SUITE-END | took 1179s 07:31:22 INFO - Completed test suite (00:19:39) 07:31:22 INFO - javascript benchmark 07:31:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7140.994342670259, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3370.376480351135, 3372.9156771080707, 3390.9152271193225, 3402.5916889973205, 3404.4212483877736, 5534.252875861757, 5702.971485142573, 5704.657720536766, 5743.081107022877, 5822.563307751914, 4497.437820272466, 4686.765661716918, 5578.2748242728385, 5718.456746609066, 5842.240508733858, 5118.129917913963, 5131.692098474085, 5173.379194496666, 5268.947310526884, 5273.235380869772, 4360.280553708634, 5149.4335623081615, 5331.946680533184, 5356.196570514435, 5366.91949620756, 4250.617444429985, 5015.5736762375245, 5191.532762051395, 5244.239585260135, 5244.527992480657, 4302.290122129845, 5048.939722658246, 5118.564921981599, 5129.487051294841, 5132.692038477703, 5054.292399064134, 5061.772220250061, 5126.077306084903, 5159.690418574897, 5196.45437229093, 5543.501084902378, 5626.887462250732, 5679.460451257165, 5680.744366503517, 5682.687452190128, 6131.080337949299, 6248.0627905814035, 6249.7187626556915, 6258.561900666955, 6268.404501572343, 6176.598521096114, 6190.164327815777, 6196.566240363177, 6215.098810672427, 6258.4680302174365, 4829.3480380148585, 5769.624974376652, 5840.1239814027385, 5848.181254624356, 5853.122031695238, 6193.6903154842075, 6195.411435913581, 6247.687615619201, 6249.625022498664, 6254.687265636791, 6012.909806352908, 6078.392160783975, 6088.178095957078, 6137.140800287963, 6141.263048434216, 6180.227471566054, 6182.350853160443, 6191.226096737908, 6194.845128871814, 6263.530235232376, 6105.572609917352, 6137.140800287963, 6188.752449901954, 6223.533235007392, 6234.220722409699, 5186.844394668166, 6220.377962203744, 6276.780312689125, 6289.276733175652, 6308.495320374359, 4849.175640141185, 5019.548240658358, 5020.648554601143, 5032.169692000852, 5033.0688822567945, 4356.520782713899, 4407.382966384709, 4415.271480205794, 4472.463304403493, 4486.865394038184, 5297.258383826267, 5363.839084827461, 5807.128930660435, 5807.216025836458, 5812.680302583314, 5295.861389801211, 6260.530460215411, 6278.654673992883, 6278.717457714414, 6298.685065746694, 5565.721713914288, 5603.775848966077, 5650.124230744241, 5677.630953987978, 5698.3162020556965, 5410.702411367412, 5427.0773968425465, 5428.83713488596, 5453.481919217747, 5534.252875861787, 5553.639358357228, 6322.209723784527, 6339.985602303609, 6354.872902542016, 6376.33048529907, 6007.068904319837, 6133.84665383369, 6247.00047992319, 6276.058591211355, 6303.590266632654, 5165.276861239355, 6164.167837341902, 6191.535634827316, 6248.187735594343, 6259.2488901332135, 5066.44269130388, 6213.130161777445, 6222.439980401786, 6238.469730072995, 6241.21984751906, 4889.364382630235, 6158.199434073542, 6185.783497577563, 6236.875262494816, 6257.0614407837365, 5898.262717160355, 5987.101934709828, 5988.760449581968, 6055.63666180013, 6189.783357582463, 5949.196858424058, 5958.582899197015, 6002.459778619946, 6052.939470605237, 6065.4541091302, 5480.342358916955, 5773.942260577341, 5787.479126878433, 5856.326522449973, 5867.061270196748, 5990.7903223386975, 6046.969765151146, 6053.122297266959, 6054.0918862169265, 6062.272527296753, 5882.323532793613, 5896.0, 5901.380355062828, 5915.290165180206, 5916.55625828056], "value": 5610.651725308953, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [461.7991173839379, 482.2910321826913, 493.2330226497797, 526.1082465221449, 583.361219464686, 37180.0, 39662.8016859916, 39736.80131599341, 39784.99999999996, 39857.800710996475, 39959.60141395052, 40558.39162412566, 40583.59416405835, 40662.59337406625, 40798.0, 7432.962835185816, 7620.847583048336, 9206.769830754218, 9463.668771592995, 11074.889251107466, 11469.541218351256, 11547.711307217303, 11575.826362604526, 11576.0, 11589.188756787029, 11539.596114136008, 11621.360825154614, 11630.825537616942, 11640.941795291012, 11652.592159274427, 11509.597164099257, 11553.826692599618, 11581.0, 11591.6522504325, 11643.767124657545, 11354.43227838613, 11422.485988130555, 11429.42852857362, 11436.599719009795, 11486.195966282363, 32935.835320823484, 39385.60614393877, 39448.40827387592, 39760.20479590392, 39891.40162897559, 3871.264459752666, 3898.083950271684, 3912.8630497932722, 3929.607039296076, 4092.6112019358116, 29278.85360573205, 29887.551686724717, 30165.0, 30969.0, 31056.223594410094, 3105.1460848266684, 3119.485284927984, 3139.152428844222, 3230.7415406767404, 3245.983770081158, 414051.0, 418111.0, 418733.0, 418873.0, 419419.0, 47057.76471117623, 48310.75844620755, 56862.0, 57846.71076644674, 58437.70781146067, 59532.70233648891, 59652.0, 60110.39889601136, 60179.0, 60417.395826041175, 14953.850461495245, 15042.924785376223, 15043.097414155185, 15053.473128440672, 15074.773878391832, 11489.712757181138, 11607.76784464306, 11620.244684095507, 11626.709332266591, 11693.766124677459, 15548.378064877505, 15712.057276563442, 15749.763753543706, 15791.842081579267, 15798.104227492775, 6127.142200091991, 6164.352742961924, 6204.5967012144065, 6217.378262173836, 6251.593646412968, 862.6587738346715, 864.148813418782, 866.7443104284251, 871.3987348729484, 893.5353616119581, 25882.870585647328, 28632.14103576896, 28967.855160724062, 29336.15953367713, 29805.85097074544, 1033.1424917318607, 1037.527924794232, 1061.984070238947, 1088.216484131424, 1194.6595220362155, 15116.470923517623, 15190.164540950354, 15215.478452154917, 15321.770173447407, 15502.372250913491, 478083.0, 479584.0, 480337.0, 480909.0, 481988.0, 42516.57483425188, 49569.0, 55832.72083639556, 57645.71177144171, 57829.0, 1373.7733274009677, 1395.4627468424933, 1406.563965170821, 1408.9084209526347, 1410.0693542262059, 23972.52054958856, 26351.34121646974, 27039.59440608353, 29060.0, 29385.706142938296, 47765.761171193924, 47996.280055798496, 48459.5154048455, 48496.787580310775, 48589.0, 363254.0, 363850.0, 364206.0, 365672.1716391401, 366041.0, 24077.638835417834, 24539.0, 24730.381740455912, 25315.87342063278, 37920.0, 34615.653843461245, 41332.41470209426, 41445.0, 42398.788006059774, 42466.36300455434, 33225.335493289516, 34390.65609343975, 35120.82439587888, 35416.29167416689, 35522.0, 34111.829440852634, 34909.65090349064, 35028.82485587556, 35155.82422087975, 35256.64743352534, 34230.82884585561, 34585.65414345925, 34633.48049779205, 34736.478952815225, 34907.650923491456, 28155.0, 29018.27454313659, 31230.531542026434, 31270.68729312678, 31316.843415782776, 23410.0, 23529.882350588137, 23660.408489787893, 23801.52396952086, 23813.761862381154], "value": 18949.761678486826, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.06990879943356, 379.74936541882363, 390.1475276520802, 398.9002749312672, 411.7318658531723, 14082.507112251073, 14163.92918035411, 18689.34587289445, 21449.67825482617, 22180.11279548818, 15835.445759398423, 21231.57536849266, 21335.613185142956, 21360.145594176254, 21704.023318950647, 5765.971170144144, 5849.619774714641, 5917.852053698649, 6085.087236914476, 6089.81730548082, 5865.208196893429, 5923.378045305246, 5946.791862284821, 5955.434233747787, 5959.731812068468, 5712.1431785232135, 6025.758969641209, 6085.478630342414, 6126.7549298028025, 6128.9080663789855, 5874.853128671774, 6010.489108425789, 6047.879042419149, 6064.363241859607, 6101.786437474711, 5911.704414779244, 5929.762809487615, 5939.821805345847, 5943.078822782432, 5951.732172052268, 13099.934500327437, 13145.408456619474, 13181.86818131816, 13606.31968401576, 13653.86346136536, 2594.8702564871683, 2623.2392606144194, 2629.0929629277866, 2633.1573896353175, 2643.035292118382, 9858.802823943553, 9943.75140621483, 10122.24083193756, 10151.949240253825, 14159.646008849759, 1753.6931037068462, 1779.715245560704, 1818.4362847517311, 1823.6899727046434, 1837.1916356802965, 110375.0, 126063.0, 136072.31963840118, 138267.0, 140530.0, 11404.600838970762, 11711.121665875093, 11805.645830625095, 11813.173077884638, 11852.703682407837, 12897.871021289668, 14779.778303325458, 15469.922650386676, 15500.689986200212, 15577.68844623124, 6873.621950792754, 8442.704505342284, 8477.194666506672, 8558.315334773204, 8589.226969572768, 6638.269790323061, 6770.187577490733, 7917.366610671133, 8182.059063207688, 8258.710945117013, 3872.8381485554783, 4661.720296782204, 4739.364919102904, 4811.446683631357, 4835.709857408567, 1687.325069972021, 1952.4825921130628, 1976.8813871167777, 2027.7870823563608, 2035.18592562976, 805.64551597297, 963.9878127965749, 964.8277343028115, 1006.6778630838062, 1010.2625083688948, 20737.481562961046, 21164.535853252062, 21174.894125529274, 21220.893895530422, 21244.681329780065, 901.7520181950016, 1033.4987531047436, 1059.8569193158978, 1069.1500257295468, 1069.8769641491172, 8743.256823169975, 10336.17310615149, 11285.435728213557, 11292.0, 11319.320840749417, 647471.0, 650957.0, 654064.0, 654755.0, 673981.0, 133920.62555621014, 141896.29051854674, 147500.26249868682, 147503.0, 151923.24038379738, 849.8980122385353, 926.333040211047, 977.0571398600384, 987.3187500624546, 1004.7036124343336, 18353.3576324828, 18391.988440635894, 18651.440456786317, 18770.436886893414, 19061.142248598568, 53912.730436349135, 54243.72878135584, 56547.434525654215, 56914.86170276654, 57655.71172144113, 79589.60205198936, 84252.3149537018, 84467.15532844592, 93607.06392935984, 93733.53133234564, 6648.90026649591, 7976.800579985546, 8072.677092916218, 8369.95815020921, 8441.0, 9179.495127768037, 11812.3503207321, 12573.87426125727, 12832.871671283168, 12936.0, 9145.451272923647, 10694.41180735036, 10720.463976801284, 10761.246712730033, 11167.888321116685, 10663.253572250178, 10684.41235732011, 10990.120790336914, 11182.384968826793, 11226.775464490502, 9475.0, 10910.672679819618, 11160.609378671708, 11360.0, 11381.203315768147, 7563.584002879895, 8105.8784118239455, 8242.835143297221, 8333.0, 8377.413581049512, 9369.344145909721, 10036.714821613787, 10879.891201087888, 11013.394263315595, 11215.775684486427], "value": 9508.660558586338, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1316.8683131686832, 1431.856814318569, 1454.4691187716483, 1462.3857979648546, 1476.298758089908, 8141.715039973602, 8220.424570280084, 8517.31861451084, 8584.012838523571, 8606.096359882209, 8367.0, 8555.529445880475, 8575.056743758181, 8576.0995095515, 8581.442206256588, 2232.5088480534296, 2281.897314620846, 2288.8397812153157, 2295.150794206146, 2295.931122066341, 1972.4970132616234, 2275.9644361815417, 2302.5510025545027, 2311.826613004023, 2319.5013072189477, 2245.10195921631, 2254.3124347074136, 2265.920692775753, 2276.4764104256033, 2286.7598902115287, 2181.1275489804048, 2235.865848049122, 2269.217120093573, 2270.3075561953597, 2273.9090436382526, 1914.1864707499258, 2004.4387571480008, 2240.260713964388, 2287.8284128690416, 2302.781235782598, 8272.875906861402, 8519.10549392311, 8525.275351595123, 8613.095624959415, 8626.784330391727, 5045.4197767256865, 5202.817901373472, 5215.869603259911, 5219.616801547593, 5220.269162317279, 3448.0, 3472.9826350868084, 3492.7205823534055, 3504.404251277289, 3567.9643203567894, 1207.885250901163, 1214.7995580729169, 1243.359669770069, 1263.412513181375, 1277.3804704718204, 8441.746747597583, 10266.948665256701, 10993.230473866832, 11045.668629941114, 11057.557697692082, 3513.648635136517, 4097.0, 4152.43942067817, 4499.460064792246, 4515.435570553681, 8710.390272680977, 8794.472331659992, 8799.076097009849, 8801.779955501035, 8822.86765698515, 5121.411037730634, 5127.66670166438, 5134.435212126663, 5135.0, 5143.0, 4605.562471565196, 4618.307253911873, 4731.101090792738, 4801.087793319258, 4815.566599006106, 3599.874004409833, 3657.158853463718, 3658.506101676293, 3692.9076773080888, 3709.5548534176073, 1130.0620484997596, 1132.2300835431986, 1142.7543078238218, 1148.1446322489799, 1151.6084531259244, 838.9286910612544, 871.8692196170498, 877.5129802959291, 910.5583791860943, 922.2529750901791, 5462.9726851365485, 5584.720763961785, 5628.155776633538, 5647.717614119278, 5898.0, 905.42053086025, 956.6747305916022, 957.5595226196028, 957.5636545182226, 973.5035132082547, 3063.877444902179, 3396.371671240779, 3476.800503826176, 3547.2728090741334, 3733.328000959799, 9488.33581649278, 9879.555420006118, 9904.900950990543, 10032.996700329908, 10035.046670566284, 9976.05227503386, 9991.400515969066, 10001.79996400068, 10017.649382271731, 10019.0, 7736.574488403079, 7910.762677119696, 7939.364850811921, 7947.523148610986, 7985.800354991055, 4270.615644591878, 5331.067063263991, 5508.834734957958, 5597.63615365, 5776.768929242783, 9097.454152750855, 9173.44959302444, 9187.77030574241, 9310.674126405544, 9341.766455838659, 7384.409247260099, 7538.982237398101, 8325.916740832756, 8353.624086915981, 9569.856452153084, 6211.565190436626, 6592.7033283503315, 7258.419326453765, 7285.526440781332, 7319.158296795724, 7754.224577542201, 7864.410169237216, 7934.761957141295, 7959.363250939795, 7965.721199757981, 7187.209406965334, 7205.639718014183, 7224.927750722636, 7271.672774725256, 7275.563466192046, 6879.3120687930805, 6999.020137180697, 7090.361867431956, 7154.892676609959, 7162.391196748335, 6221.47117495018, 6355.52333574993, 6395.488360931021, 6405.615663060231, 6428.582142160744, 4788.904221915612, 4861.586765125004, 4864.391951006124, 4953.529414705597, 5049.722265275445, 4881.90236195267, 4927.162382394929, 5043.773030213576, 5057.443681194992, 5121.9743901281745], "value": 4346.389762845992, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.20602759405017, 349.914271003604, 361.882388223827, 362.24110488526526, 365.34238370932326, 5054.570361519271, 5318.707471089088, 5545.445455454453, 5559.360673522546, 5566.332040155177, 4315.899445641365, 4988.675736077153, 5307.601929855257, 5412.648177868436, 5413.377461591918, 4109.383592461132, 4155.667546596265, 4173.895652608679, 4175.3945677876845, 4185.22573323936, 3713.755891776258, 3773.0755964788664, 3871.5354157500997, 4011.4785077939828, 4197.16056788642, 3744.775313481186, 3961.207758448322, 4100.6924480664065, 4110.753354798707, 4138.779060177255, 3313.7017668409717, 4068.0643452005907, 4088.1619268049976, 4106.240345536071, 4134.751914885116, 2811.9156425307274, 2960.8223506589675, 3549.2014296783277, 3575.535180426554, 3596.37063513884, 4831.541003604652, 4919.975400122977, 5267.683938963674, 5334.413214546396, 5366.114591092465, 3985.481887354654, 4338.826446942118, 4519.435070616173, 4566.903943053643, 4712.575868171881, 4718.764061796931, 5125.0, 5247.580193584504, 5764.74058667361, 5875.471207591295, 3676.0, 3846.1922896238725, 3863.787491687956, 3946.289667859784, 3952.229315283521, 5330.893382132335, 5387.437643083501, 5634.7182640867795, 5806.419358064202, 5820.941790582082, 3262.5269335946155, 3552.7335449841366, 3623.710103191738, 3857.267119247334, 3893.6106389361403, 3953.8220780064967, 3962.9696278967676, 3966.424868394067, 3972.3048466518244, 3979.621935916083, 4091.6112969267874, 4333.609975102256, 4418.4918734345965, 4643.698159619614, 4709.175894218498, 5767.452092051249, 5785.4214578541805, 5793.333766616809, 5809.779946211258, 5888.941110588925, 1134.7617000429836, 1203.175824560179, 1229.7786398448366, 1244.3467179730715, 1296.5332480307081, 810.428647803309, 857.9832898015871, 867.6789587852409, 879.4503435352905, 889.3952112563389, 4601.285241707409, 4857.465678775332, 4891.828785992544, 5222.060029194781, 5249.343832020997, 5650.7174641267775, 5688.431156884279, 5753.3958934311295, 5766.279215098113, 5795.001449000177, 4771.950170962383, 5025.673331233458, 5098.923516147261, 5117.513836185556, 5188.247704082887, 2805.5931889875856, 2899.391127863172, 2967.2581854536365, 2993.413490849853, 3013.1111322160014, 5501.5970927413255, 5506.229127922094, 5866.73599688015, 5885.0, 5925.822225333247, 5166.675522536646, 5171.560417364566, 5615.719214039282, 5878.617889837147, 5962.34414214436, 5020.422651395136, 5251.527362537314, 5270.262163297218, 5925.614835035795, 5926.555508336892, 5459.918101228564, 5461.399246083007, 5690.914636280542, 5727.513161381163, 5757.453041961007, 5118.41138269089, 5594.720263986866, 5893.970530147321, 5896.7936122235515, 5916.0, 5233.142234506695, 5393.86515337104, 5488.204210389391, 5810.501484361596, 6193.38066193377, 4239.279322515242, 4262.637675797592, 4278.128244030998, 4293.91412171761, 4310.4611923509565, 4792.784324705327, 5317.9468205319, 5983.076754013582, 5987.670678112746, 5991.0, 5196.896062078813, 5391.519900845498, 5517.337919449692, 5762.596618236683, 5770.6249093808765, 4777.689450185866, 5104.0, 5162.561182299547, 5736.196932429547, 5768.480836724715, 5264.9736751315995, 5563.888722225452, 5592.384837667934, 5597.4327188387315, 5657.236273103243, 5724.74238659253, 5733.856653583527, 5735.569832262514, 5758.971205143947, 5772.8063335932075, 5096.46487118862, 5622.891415719106, 5658.688772117573, 5692.430756924275, 5705.971470142623], "value": 4122.986167148988, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [688.9001094841249, 704.7760455332839, 772.4940164192456, 798.2496453333865, 800.3357213512785, 14156.575302740908, 14822.555323340317, 15200.239988000598, 15278.694426111471, 15397.538073857802, 14029.579112626612, 14268.215248161347, 14310.785338219936, 14332.498362557313, 15201.17585889692, 860.0668274921702, 891.8350105230521, 897.0177655467253, 898.1153563739712, 899.3704406915153, 854.7264875239925, 894.959726812295, 898.2679116520048, 900.045951291633, 901.5942825728448, 920.9631614735403, 931.8509038553833, 936.1293996583175, 936.6113063078814, 939.5865819039635, 919.6183583812743, 927.0868194828123, 935.349931797401, 935.4948327902924, 939.9060093990614, 691.4502970138701, 693.774523279936, 694.5103701890155, 696.4532841719276, 696.8571442854203, 14006.299685015709, 14516.274186290642, 15278.923605382013, 15499.690006199926, 15605.45380911674, 11742.765144697143, 11864.169508134433, 13753.106048106942, 13764.93117534416, 13926.721465570632, 9276.814463710756, 11635.185537012412, 11635.185537012412, 11645.534178632844, 12073.517059317617, 3602.819859007039, 3722.1253005543676, 3722.813859307024, 3784.9621503784883, 3809.5047643806406, 93296.53351733266, 96497.0350296495, 99953.5002324991, 104611.4769426148, 104767.99999999924, 9722.805543889082, 10463.319884207502, 10474.0, 10682.252242343116, 10973.50619222121, 21824.0, 21869.781302187093, 21957.451063723536, 22177.778222217894, 22203.444913877283, 7193.208747037822, 7432.777016689508, 7455.366293864974, 7644.808879777939, 7671.769846904602, 4171.561985991488, 4243.660507159481, 4298.914021719548, 4301.462317210348, 4465.017696106851, 3636.4363523653874, 3659.5774415899923, 3704.259148170323, 3726.105734623725, 3728.105254738843, 619.485826763785, 663.151166506872, 672.4855485553555, 685.6468918506973, 687.8589889072728, 541.6479288462452, 552.5082676417991, 571.2630706388795, 579.7825815319255, 634.5875181132301, 9537.380070295409, 9910.653127140515, 9923.65267215644, 10091.69724908254, 10131.797364052825, 517.2861451197324, 520.232656831171, 566.6684989281234, 614.5053232148074, 692.9861402771917, 4851.289878197396, 4876.429105938451, 4903.554157285478, 4944.283078953532, 4972.950270497248, 78763.0, 94723.05276947281, 95976.0, 97998.02001980031, 99486.00513994912, 83721.6278372158, 84667.15332846592, 84703.0, 86466.27067458615, 87156.12843871607, 67645.0, 70250.0, 71747.20631984138, 71971.64014179895, 72208.55582888312, 9251.67619133327, 9700.369475984038, 10426.530806113591, 10536.578536858746, 10543.789124217627, 44698.55301447074, 45362.639120826425, 46395.0, 46551.53448465472, 46736.7663161682, 57069.714651426475, 63773.0, 65572.68854622977, 68181.0, 68254.65872670803, 12626.512280491768, 12789.488420463078, 12801.423935923092, 12830.0, 12936.408356734564, 14096.647583810076, 14209.857901420854, 14277.64305892361, 14444.0, 15021.0, 13058.15122017066, 13326.666833329244, 13355.732885342433, 13385.799213012007, 13821.378037988114, 12717.300548469922, 13093.148945318524, 13108.672283192996, 13275.336233188495, 14031.158130512202, 10036.899631003596, 12572.580162419981, 12775.425105870445, 12815.679608009874, 12840.807387889376, 9566.426014439156, 10213.948930255301, 10657.840132397865, 10780.191485638452, 11588.956993870592, 8670.956645216733, 9024.774380640536, 10234.948825255826, 10254.6410875619, 10422.270441069053], "value": 7318.625100386658, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1560.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 118.0, 120.0, 119.0, 118.0, 119.0, 122.0, 118.0, 120.0, 119.0], "value": 118.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 116.0, 116.0, 148.0, 144.0, 117.0, 117.0, 114.0, 136.0, 114.0], "value": 127.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 210.0, 209.0, 242.0, 247.0, 286.0, 194.0, 199.0, 213.0, 202.0], "value": 220.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 60.0, 60.0, 85.0, 64.0, 64.0, 63.0, 86.0, 69.0, 73.0], "value": 70.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 71.0, 86.0, 73.0, 72.0, 71.0, 83.0, 73.0, 70.0, 84.0], "value": 76.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 93.0, 90.0, 92.0, 90.0, 89.0, 90.0, 90.0, 90.0, 89.0], "value": 90.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 101.0, 101.0, 98.0, 98.0, 101.0, 113.0, 128.0, 98.0, 100.0], "value": 103.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 121.0, 93.0, 145.0, 146.0, 127.0, 94.0, 91.0, 92.0, 149.0], "value": 115.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 65.0, 69.0, 66.0, 64.0, 65.0, 65.0, 63.0], "value": 65.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 78.0, 81.0, 77.0, 70.0, 69.0, 70.0, 72.0, 70.0], "value": 73.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 88.0, 91.0, 99.0, 84.0, 89.0, 86.0, 89.0, 89.0, 103.0], "value": 91.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 169.0, 156.0, 159.0, 156.0, 148.0, 146.0, 146.0, 186.0, 167.0], "value": 158.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 179.0, 182.0, 176.0, 179.0, 173.0, 168.0, 205.0, 179.0, 179.0], "value": 179.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 69.0, 80.0, 74.0, 66.0, 69.0, 66.0, 70.0, 69.0, 67.0], "value": 70.4, "unit": "score"}]}]} 07:31:22 INFO - Return code: 0 07:31:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:31:22 ERROR - # TBPL SUCCESS # 07:31:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:31:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:31:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:31:22 INFO - 2017-02-23 07:31:22.757 screenresolution[1670:11943] starting screenresolution argv=screenresolution get 07:31:22 INFO - 2017-02-23 07:31:22.760 screenresolution[1670:11943] Display 0: 1600x1200x32@60 07:31:22 INFO - 2017-02-23 07:31:22.766 screenresolution[1671:11946] starting screenresolution argv=screenresolution list 07:31:22 INFO - Available Modes on Display 0 07:31:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:31:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:31:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:31:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:31:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:31:22 INFO - Intel Iris: 07:31:22 INFO - Chipset Model: Intel Iris 07:31:22 INFO - Type: GPU 07:31:22 INFO - Bus: Built-In 07:31:22 INFO - VRAM (Dynamic, Max): 1536 MB 07:31:22 INFO - Vendor: Intel (0x8086) 07:31:22 INFO - Device ID: 0x0a2e 07:31:22 INFO - Revision ID: 0x0009 07:31:22 INFO - Displays: 07:31:22 INFO - Display: 07:31:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:31:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:31:22 INFO - Display Serial Number: 1600x1200 60 07:31:22 INFO - Main Display: Yes 07:31:22 INFO - Mirror: Off 07:31:22 INFO - Online: Yes 07:31:22 INFO - Rotation: Supported 07:31:23 INFO - Return code: 0 07:31:23 INFO - Running post-action listener: _resource_record_post_action 07:31:23 INFO - [mozharness: 2017-02-23 15:31:23.002699Z] Finished run-tests step (success) 07:31:23 INFO - Running post-run listener: _resource_record_post_run 07:31:23 INFO - Total resource usage - Wall time: 1201s; CPU: 55.0%; Read bytes: 33833472; Write bytes: 517392896; Read time: 206; Write time: 1638 07:31:23 INFO - TinderboxPrint: CPU usage
54.6% 07:31:23 INFO - TinderboxPrint: I/O read bytes / time
33,833,472 / 206 07:31:23 INFO - TinderboxPrint: I/O write bytes / time
517,392,896 / 1,638 07:31:23 INFO - TinderboxPrint: CPU idle
2,184.0 (45.4%) 07:31:23 INFO - TinderboxPrint: CPU system
968.8 (20.2%) 07:31:23 INFO - TinderboxPrint: CPU user
1,652.9 (34.4%) 07:31:23 INFO - TinderboxPrint: Swap in / out
240,852,992 / 0 07:31:23 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 198746624; Write bytes: 192349696; Read time: 15533; Write time: 425 07:31:23 INFO - run-tests - Wall time: 1181s; CPU: 55.0%; Read bytes: 32903680; Write bytes: 304632832; Read time: 195; Write time: 1159 07:31:23 INFO - Running post-run listener: _upload_blobber_files 07:31:23 INFO - Blob upload gear active. 07:31:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:31:23 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:31:23 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'] 07:31:23 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 07:31:23 INFO - (blobuploader) - INFO - Open directory for files ... 07:31:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:31:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:31:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:31:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:31:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:31:24 INFO - (blobuploader) - INFO - Done attempting. 07:31:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:31:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:31:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:31:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:31:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:31:25 INFO - (blobuploader) - INFO - Done attempting. 07:31:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:31:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:31:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:31:26 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:31:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:31:26 INFO - (blobuploader) - INFO - Done attempting. 07:31:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:31:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:31:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:31:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:31:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:31:29 INFO - (blobuploader) - INFO - Done attempting. 07:31:29 INFO - (blobuploader) - INFO - Iteration through files over. 07:31:29 INFO - Return code: 0 07:31:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:31:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:31:29 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5cc7da4210c80126479998bf263c623939196614adb81cb4f84bad5a196f4461766be89087a49298b74d8aebe85fb561ebbe4401a38d6c82742c47699bf291e4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/30868e8652f0b4d2f245b0c6406aaa28c9b24bb872a5f7b4f0e72ddcf62aa759d5ec6e90ac7654fb6566138677232a5a8e18e80680715b43455ca6f1643fb44e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a93bbad0d457fc312f40364022e84fd8190759c1f9290200517b04622dec6c1b763e7640501bac1953d95cec964c9680bef6376a62989d9f0948b583b64deab2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f305a068b09f81aa9a633567839342f3c4aebb8eef8c94e834d62d774de4737b0f24b587f0ade6bd2416f1863fd235ae7bb04b3a32e7853e741fd9567198f0d5"} 07:31:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:31:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:31:29 INFO - Contents: 07:31:29 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5cc7da4210c80126479998bf263c623939196614adb81cb4f84bad5a196f4461766be89087a49298b74d8aebe85fb561ebbe4401a38d6c82742c47699bf291e4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/30868e8652f0b4d2f245b0c6406aaa28c9b24bb872a5f7b4f0e72ddcf62aa759d5ec6e90ac7654fb6566138677232a5a8e18e80680715b43455ca6f1643fb44e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a93bbad0d457fc312f40364022e84fd8190759c1f9290200517b04622dec6c1b763e7640501bac1953d95cec964c9680bef6376a62989d9f0948b583b64deab2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f305a068b09f81aa9a633567839342f3c4aebb8eef8c94e834d62d774de4737b0f24b587f0ade6bd2416f1863fd235ae7bb04b3a32e7853e741fd9567198f0d5"} 07:31:29 INFO - Running post-run listener: copy_logs_to_upload_dir 07:31:29 INFO - Copying logs to upload dir... 07:31:29 INFO - mkdir: /builds/slave/test/build/upload/logs 07:31:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1285.501413 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-02-23 07:31:29.364436) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-23 07:31:29.367744) ========= 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.cCGSNYmsMD/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.3czKX7moan/Listeners TMPDIR=/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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/5cc7da4210c80126479998bf263c623939196614adb81cb4f84bad5a196f4461766be89087a49298b74d8aebe85fb561ebbe4401a38d6c82742c47699bf291e4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/30868e8652f0b4d2f245b0c6406aaa28c9b24bb872a5f7b4f0e72ddcf62aa759d5ec6e90ac7654fb6566138677232a5a8e18e80680715b43455ca6f1643fb44e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a93bbad0d457fc312f40364022e84fd8190759c1f9290200517b04622dec6c1b763e7640501bac1953d95cec964c9680bef6376a62989d9f0948b583b64deab2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f305a068b09f81aa9a633567839342f3c4aebb8eef8c94e834d62d774de4737b0f24b587f0ade6bd2416f1863fd235ae7bb04b3a32e7853e741fd9567198f0d5"} build_url:https://queue.taskcluster.net/v1/task/KcJ43fEsQ-yH2Nxw7F4_Pw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011246 build_url: 'https://queue.taskcluster.net/v1/task/KcJ43fEsQ-yH2Nxw7F4_Pw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5cc7da4210c80126479998bf263c623939196614adb81cb4f84bad5a196f4461766be89087a49298b74d8aebe85fb561ebbe4401a38d6c82742c47699bf291e4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/30868e8652f0b4d2f245b0c6406aaa28c9b24bb872a5f7b4f0e72ddcf62aa759d5ec6e90ac7654fb6566138677232a5a8e18e80680715b43455ca6f1643fb44e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a93bbad0d457fc312f40364022e84fd8190759c1f9290200517b04622dec6c1b763e7640501bac1953d95cec964c9680bef6376a62989d9f0948b583b64deab2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f305a068b09f81aa9a633567839342f3c4aebb8eef8c94e834d62d774de4737b0f24b587f0ade6bd2416f1863fd235ae7bb04b3a32e7853e741fd9567198f0d5"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-23 07:31:29.404537) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 07:31:29.405266) ========= 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.cCGSNYmsMD/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.3czKX7moan/Listeners TMPDIR=/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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.005199 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 07:31:29.458418) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-23 07:31:29.459145) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-23 07:31:29.459853) ========= ========= Total master_lag: 0.20 =========