builder: mozilla-beta_yosemite_r7_devedition_test-dromaeojs slave: t-yosemite-r7-0314 starttime: 1496167691.18 results: success (0) buildid: 20170530100116 builduid: d1293e5697154ab4a26642989f8dea4c revision: 1bf2d9f8a5cb68370f9a797890beb14769f4144b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-30 11:08:11.179035) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-30 11:08:11.179548) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-30 11:08:11.179869) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-30 11:08:11.204913) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 11:08:11.205264) ========= 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.tC15EtIDol/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.KhDDQXCiZl/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-05-30 11:08:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 26.8M=0s 2017-05-30 11:08:11 (26.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.156639 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 11:08:11.385208) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 11:08:11.385574) ========= 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.tC15EtIDol/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.KhDDQXCiZl/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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.041691 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 11:08:11.448366) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-05-30 11:08:11.448772) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 1bf2d9f8a5cb68370f9a797890beb14769f4144b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 1bf2d9f8a5cb68370f9a797890beb14769f4144b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tC15EtIDol/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.KhDDQXCiZl/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-05-30 11:08:11,552 truncating revision to first 12 chars 2017-05-30 11:08:11,552 Setting DEBUG logging. 2017-05-30 11:08:11,552 attempt 1/10 2017-05-30 11:08:11,552 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/1bf2d9f8a5cb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-30 11:08:12,880 unpacking tar archive at: mozilla-beta-1bf2d9f8a5cb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.615702 ========= master_lag: 0.65 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-05-30 11:08:13.711453) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-30 11:08:13.711786) ========= script_repo_revision: 1bf2d9f8a5cb68370f9a797890beb14769f4144b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-30 11:08:13.712230) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-30 11:08:13.712503) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-30 11:08:13.732699) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2017-05-30 11:08:13.733007) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tC15EtIDol/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.KhDDQXCiZl/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 11:08:13 INFO - MultiFileLogger online at 20170530 11:08:13 in /builds/slave/test 11:08:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 11:08:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:08:13 INFO - {'append_to_log': False, 11:08:13 INFO - 'base_work_dir': '/builds/slave/test', 11:08:13 INFO - 'blob_upload_branch': 'Mozilla-Beta', 11:08:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:08:13 INFO - 'branch': 'Mozilla-Beta', 11:08:13 INFO - 'buildbot_json_path': 'buildprops.json', 11:08:13 INFO - 'config_files': ('talos/mac_config.py',), 11:08:13 INFO - 'default_actions': ('clobber', 11:08:13 INFO - 'read-buildbot-config', 11:08:13 INFO - 'download-and-extract', 11:08:13 INFO - 'populate-webroot', 11:08:13 INFO - 'create-virtualenv', 11:08:13 INFO - 'install', 11:08:13 INFO - 'run-tests'), 11:08:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:08:13 INFO - 'download_minidump_stackwalk': True, 11:08:13 INFO - 'download_symbols': 'ondemand', 11:08:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:08:13 INFO - 'tooltool.py': '/tools/tooltool.py', 11:08:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:08:13 INFO - '/tools/misc-python/virtualenv.py')}, 11:08:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:08:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:08:13 INFO - 'gecko_profile': False, 11:08:13 INFO - 'gecko_profile_interval': 0, 11:08:13 INFO - 'installer_path': 'installer.exe', 11:08:13 INFO - 'log_level': 'info', 11:08:13 INFO - 'log_name': 'talos', 11:08:13 INFO - 'log_to_console': True, 11:08:13 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:08:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:08:13 INFO - 'opt_config_files': (), 11:08:13 INFO - 'pip_index': False, 11:08:13 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:08:13 INFO - 'cmd': ('bash', 11:08:13 INFO - '-c', 11:08:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:08:13 INFO - 'enabled': True, 11:08:13 INFO - 'halt_on_failure': False, 11:08:13 INFO - 'name': 'check_screen_resolution'},), 11:08:13 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:08:13 INFO - 'cmd': ('bash', 11:08:13 INFO - '-c', 11:08:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:08:13 INFO - 'enabled': True, 11:08:13 INFO - 'halt_on_failure': False, 11:08:13 INFO - 'name': 'check_screen_resolution'},), 11:08:13 INFO - 'run_cmd_checks_enabled': True, 11:08:13 INFO - 'suite': 'dromaeojs', 11:08:13 INFO - 'system_bits': '32', 11:08:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:08:13 INFO - 'title': 't-yosemite-r7-0314', 11:08:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:08:13 INFO - 'use_talos_json': True, 11:08:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:08:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:08:13 INFO - 'work_dir': 'build'} 11:08:13 INFO - [mozharness: 2017-05-30 18:08:13.941283Z] Running clobber step. 11:08:13 INFO - Running pre-action listener: _resource_record_pre_action 11:08:13 INFO - Running main action method: clobber 11:08:13 INFO - rmtree: /builds/slave/test/build 11:08:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:08:16 INFO - Running post-action listener: _resource_record_post_action 11:08:16 INFO - [mozharness: 2017-05-30 18:08:16.373957Z] Finished clobber step (success) 11:08:16 INFO - [mozharness: 2017-05-30 18:08:16.374072Z] Running read-buildbot-config step. 11:08:16 INFO - Running pre-action listener: _resource_record_pre_action 11:08:16 INFO - Running main action method: read_buildbot_config 11:08:16 INFO - Using buildbot properties: 11:08:16 INFO - { 11:08:16 INFO - "project": "", 11:08:16 INFO - "product": "firefox", 11:08:16 INFO - "script_repo_revision": "production", 11:08:16 INFO - "builddir": "mozilla-beta_yosemite_r7_devedition_test-dromaeojs", 11:08:16 INFO - "repository": "", 11:08:16 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 DevEdition mozilla-beta talos dromaeojs", 11:08:16 INFO - "buildid": "20170530100116", 11:08:16 INFO - "pgo_build": "False", 11:08:16 INFO - "basedir": "/builds/slave/test", 11:08:16 INFO - "buildnumber": 7, 11:08:16 INFO - "slavename": "t-yosemite-r7-0314", 11:08:16 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 11:08:16 INFO - "platform": "yosemite_r7_devedition", 11:08:16 INFO - "scheduler": "tests-mozilla-beta-macosx64-devedition-talos", 11:08:16 INFO - "branch": "mozilla-beta", 11:08:16 INFO - "repo_path": "releases/mozilla-beta", 11:08:16 INFO - "revision": "1bf2d9f8a5cb68370f9a797890beb14769f4144b", 11:08:16 INFO - "stage_platform": "macosx64-devedition", 11:08:16 INFO - "builduid": "d1293e5697154ab4a26642989f8dea4c", 11:08:16 INFO - "slavebuilddir": "test" 11:08:16 INFO - } 11:08:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/THh22lUMT7q6VthAu3WBkg/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 11:08:16 INFO - Running post-action listener: _resource_record_post_action 11:08:16 INFO - [mozharness: 2017-05-30 18:08:16.377321Z] Finished read-buildbot-config step (success) 11:08:16 INFO - [mozharness: 2017-05-30 18:08:16.377456Z] Running download-and-extract step. 11:08:16 INFO - Running pre-action listener: _resource_record_pre_action 11:08:16 INFO - Running main action method: download_and_extract 11:08:16 INFO - mkdir: /builds/slave/test/build/tests 11:08:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:08:16 INFO - trying https://queue.taskcluster.net/v1/task/THh22lUMT7q6VthAu3WBkg/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 11:08:16 INFO - Downloading https://queue.taskcluster.net/v1/task/THh22lUMT7q6VthAu3WBkg/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 11:08:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/THh22lUMT7q6VthAu3WBkg/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json'}, attempt #1 11:08:17 INFO - Downloaded 1287 bytes. 11:08:17 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 11:08:17 INFO - Using the following test package requirements: 11:08:17 INFO - {u'awsy': [u'firefox-54.0.en-US.mac.common.tests.zip', 11:08:17 INFO - u'firefox-54.0.en-US.mac.awsy.tests.zip'], 11:08:17 INFO - u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 11:08:17 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 11:08:17 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 11:08:17 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 11:08:17 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 11:08:17 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 11:08:17 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 11:08:17 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 11:08:17 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 11:08:17 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 11:08:17 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 11:08:17 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 11:08:17 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 11:08:17 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 11:08:17 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 11:08:17 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 11:08:17 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 11:08:17 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 11:08:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/THh22lUMT7q6VthAu3WBkg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 11:08:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/THh22lUMT7q6VthAu3WBkg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 11:08:17 INFO - Fetch https://queue.taskcluster.net/v1/task/THh22lUMT7q6VthAu3WBkg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 11:08:19 INFO - Expected file size: 51963603 11:08:19 INFO - Obtained file size: 51963603 11:08:35 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip', u'firefox-54.0.en-US.mac.talos.tests.zip'] for test suite category: talos 11:08:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/THh22lUMT7q6VthAu3WBkg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 11:08:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/THh22lUMT7q6VthAu3WBkg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 11:08:35 INFO - Fetch https://queue.taskcluster.net/v1/task/THh22lUMT7q6VthAu3WBkg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 11:08:37 INFO - Expected file size: 51963603 11:08:37 INFO - Obtained file size: 51963603 11:08:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/THh22lUMT7q6VthAu3WBkg/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 11:08:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/THh22lUMT7q6VthAu3WBkg/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 11:08:52 INFO - Fetch https://queue.taskcluster.net/v1/task/THh22lUMT7q6VthAu3WBkg/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 11:08:53 INFO - Expected file size: 14404461 11:08:53 INFO - Obtained file size: 14404461 11:08:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:08:53 INFO - trying https://queue.taskcluster.net/v1/task/THh22lUMT7q6VthAu3WBkg/artifacts/public/build/firefox-54.0.en-US.mac.dmg 11:08:53 INFO - Downloading https://queue.taskcluster.net/v1/task/THh22lUMT7q6VthAu3WBkg/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 11:08:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/THh22lUMT7q6VthAu3WBkg/artifacts/public/build/firefox-54.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg'}, attempt #1 11:08:56 INFO - Downloaded 74893615 bytes. 11:08:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/THh22lUMT7q6VthAu3WBkg/artifacts/public/build/firefox-54.0.en-US.mac.dmg 11:08:56 INFO - mkdir: /builds/slave/test/properties 11:08:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:08:56 INFO - Writing to file /builds/slave/test/properties/build_url 11:08:56 INFO - Contents: 11:08:56 INFO - build_url:https://queue.taskcluster.net/v1/task/THh22lUMT7q6VthAu3WBkg/artifacts/public/build/firefox-54.0.en-US.mac.dmg 11:08:57 INFO - Running post-action listener: _resource_record_post_action 11:08:57 INFO - Running post-action listener: set_extra_try_arguments 11:08:57 INFO - [mozharness: 2017-05-30 18:08:57.303718Z] Finished download-and-extract step (success) 11:08:57 INFO - [mozharness: 2017-05-30 18:08:57.303823Z] Running populate-webroot step. 11:08:57 INFO - Running pre-action listener: _resource_record_pre_action 11:08:57 INFO - Running main action method: populate_webroot 11:08:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:08:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:08:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:08:57 INFO - '--tppagecycles', 11:08:57 INFO - '7'], 11:08:57 INFO - 'tests': ['tsvgm']}}, 11:08:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:08:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:08:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:08:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:08:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:08:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:08:57 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 11:08:57 INFO - 'talos_options': ['--disable-e10s'], 11:08:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:08:57 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:08:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:08:57 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 11:08:57 INFO - 'talos_options': ['--disable-e10s'], 11:08:57 INFO - 'tests': ['damp', 'tps']}, 11:08:57 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:08:57 INFO - 'tests': ['damp', 'tps']}, 11:08:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:08:57 INFO - 'tests': ['dromaeo_dom']}, 11:08:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:08:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:08:57 INFO - 'tests': ['basic_compositor_video']}, 11:08:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:08:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:08:57 INFO - 'tests': ['a11yr', 11:08:57 INFO - 'ts_paint', 11:08:57 INFO - 'tpaint', 11:08:57 INFO - 'sessionrestore', 11:08:57 INFO - 'sessionrestore_no_auto_restore', 11:08:57 INFO - 'tabpaint']}, 11:08:57 INFO - 'other-e10s': {'tests': ['a11yr', 11:08:57 INFO - 'ts_paint', 11:08:57 INFO - 'tpaint', 11:08:57 INFO - 'sessionrestore', 11:08:57 INFO - 'sessionrestore_no_auto_restore', 11:08:57 INFO - 'tabpaint']}, 11:08:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:08:57 INFO - 'ts_paint', 11:08:57 INFO - 'tpaint', 11:08:57 INFO - 'sessionrestore', 11:08:57 INFO - 'sessionrestore_no_auto_restore', 11:08:57 INFO - 'tabpaint']}, 11:08:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:08:57 INFO - 'ts_paint', 11:08:57 INFO - 'tpaint', 11:08:57 INFO - 'sessionrestore', 11:08:57 INFO - 'sessionrestore_no_auto_restore', 11:08:57 INFO - 'tabpaint']}, 11:08:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:08:57 INFO - 'tests': ['a11yr', 11:08:57 INFO - 'ts_paint', 11:08:57 INFO - 'tpaint', 11:08:57 INFO - 'sessionrestore', 11:08:57 INFO - 'sessionrestore_no_auto_restore', 11:08:57 INFO - 'tabpaint']}, 11:08:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:08:57 INFO - 'tests': ['a11yr', 11:08:57 INFO - 'ts_paint', 11:08:57 INFO - 'tpaint', 11:08:57 INFO - 'sessionrestore', 11:08:57 INFO - 'sessionrestore_no_auto_restore', 11:08:57 INFO - 'tabpaint']}, 11:08:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:08:57 INFO - 'tests': ['tsvgx', 11:08:57 INFO - 'tsvgr_opacity', 11:08:57 INFO - 'tart', 11:08:57 INFO - 'tscrollx', 11:08:57 INFO - 'cart', 11:08:57 INFO - 'tsvg_static']}, 11:08:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:08:57 INFO - 'tsvgr_opacity', 11:08:57 INFO - 'tart', 11:08:57 INFO - 'tscrollx', 11:08:57 INFO - 'cart', 11:08:57 INFO - 'tsvg_static']}, 11:08:57 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 11:08:57 INFO - 'talos_options': ['--disable-e10s'], 11:08:57 INFO - 'tests': ['tp5o']}, 11:08:57 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:08:57 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 11:08:57 INFO - 'talos_options': ['--disable-e10s', 11:08:57 INFO - '--xperf_path', 11:08:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:08:57 INFO - 'tests': ['tp5n']}, 11:08:57 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:08:57 INFO - 'talos_options': ['--xperf_path', 11:08:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:08:57 INFO - 'tests': ['tp5n']}}, 11:08:57 INFO - 'talos.zip': {'path': '', 11:08:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:08:57 INFO - Running post-action listener: _resource_record_post_action 11:08:57 INFO - [mozharness: 2017-05-30 18:08:57.321912Z] Finished populate-webroot step (success) 11:08:57 INFO - [mozharness: 2017-05-30 18:08:57.322051Z] Running create-virtualenv step. 11:08:57 INFO - Running pre-action listener: _resource_record_pre_action 11:08:57 INFO - Running main action method: create_virtualenv 11:08:57 INFO - Creating virtualenv /builds/slave/test/build/venv 11:08:57 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 11:08:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:08:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:08:57 INFO - Using real prefix '/tools/python27' 11:08:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:08:58 INFO - Installing distribute.............................................................................................................................................................................................done. 11:09:01 INFO - Installing pip.................done. 11:09:01 INFO - Return code: 0 11:09:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:09:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:09:01 INFO - Reading from file tmpfile_stdout 11:09:01 INFO - Output received: 11:09:01 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) 11:09:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:09:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:09:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09: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/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 0x1044b9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044bc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb38b46ef60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104297d30>, '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 0x1041bedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10428cbe8>, '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.tC15EtIDol/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.KhDDQXCiZl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 11:09:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 11:09:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:09:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tC15EtIDol/Render', 11:09:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:09:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:09:01 INFO - 'HOME': '/Users/cltbld', 11:09:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:09:01 INFO - 'LOGNAME': 'cltbld', 11:09:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:01 INFO - 'MOZ_NO_REMOTE': '1', 11:09:01 INFO - 'NO_EM_RESTART': '1', 11:09:01 INFO - 'PAGER': '/bin/cat', 11:09:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:09:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:01 INFO - 'PWD': '/builds/slave/test', 11:09:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:09:01 INFO - 'SHELL': '/bin/bash', 11:09:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KhDDQXCiZl/Listeners', 11:09:01 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 11:09:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:09:01 INFO - 'USER': 'cltbld', 11:09:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:09:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:09:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:01 INFO - 'XPC_FLAGS': '0x0', 11:09:01 INFO - 'XPC_SERVICE_NAME': '0', 11:09:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:09:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:01 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 11:09:01 INFO - Cleaning up... 11:09:01 INFO - Return code: 0 11:09:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:09:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:09:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09: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/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 0x1044b9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044bc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb38b46ef60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104297d30>, '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 0x1041bedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10428cbe8>, '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.tC15EtIDol/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.KhDDQXCiZl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 11:09:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 11:09:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:09:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tC15EtIDol/Render', 11:09:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:09:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:09:01 INFO - 'HOME': '/Users/cltbld', 11:09:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:09:01 INFO - 'LOGNAME': 'cltbld', 11:09:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:01 INFO - 'MOZ_NO_REMOTE': '1', 11:09:01 INFO - 'NO_EM_RESTART': '1', 11:09:01 INFO - 'PAGER': '/bin/cat', 11:09:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:09:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:01 INFO - 'PWD': '/builds/slave/test', 11:09:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:09:01 INFO - 'SHELL': '/bin/bash', 11:09:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KhDDQXCiZl/Listeners', 11:09:01 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 11:09:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:09:01 INFO - 'USER': 'cltbld', 11:09:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:09:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:09:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:01 INFO - 'XPC_FLAGS': '0x0', 11:09:01 INFO - 'XPC_SERVICE_NAME': '0', 11:09:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:09:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:01 INFO - Downloading/unpacking psutil>=3.1.1 11:09:01 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 11:09:01 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 11:09:01 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 11:09:01 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 11:09:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:09:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:09:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:09:03 INFO - Installing collected packages: psutil 11:09:03 INFO - Running setup.py install for psutil 11:09:03 INFO - building 'psutil._psutil_osx' extension 11:09:03 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 11:09:04 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 11:09:04 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 11:09:04 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 11:09:04 INFO - building 'psutil._psutil_posix' extension 11:09:04 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 11:09:04 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:09:04 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:09:04 INFO - ^ 11:09:04 INFO - 1 warning generated. 11:09:04 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 11:09:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:09:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:09:04 INFO - Successfully installed psutil 11:09:04 INFO - Cleaning up... 11:09:05 INFO - Return code: 0 11:09:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:09:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:09:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09: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/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 0x1044b9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044bc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb38b46ef60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104297d30>, '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 0x1041bedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10428cbe8>, '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.tC15EtIDol/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.KhDDQXCiZl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 11:09:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 11:09:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:09:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tC15EtIDol/Render', 11:09:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:09:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:09:05 INFO - 'HOME': '/Users/cltbld', 11:09:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:09:05 INFO - 'LOGNAME': 'cltbld', 11:09:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:05 INFO - 'MOZ_NO_REMOTE': '1', 11:09:05 INFO - 'NO_EM_RESTART': '1', 11:09:05 INFO - 'PAGER': '/bin/cat', 11:09:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:09:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:05 INFO - 'PWD': '/builds/slave/test', 11:09:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:09:05 INFO - 'SHELL': '/bin/bash', 11:09:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KhDDQXCiZl/Listeners', 11:09:05 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 11:09:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:09:05 INFO - 'USER': 'cltbld', 11:09:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:09:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:09:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:05 INFO - 'XPC_FLAGS': '0x0', 11:09:05 INFO - 'XPC_SERVICE_NAME': '0', 11:09:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:09:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:09:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:09:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:09:06 INFO - Installing collected packages: mozsystemmonitor 11:09:06 INFO - Running setup.py install for mozsystemmonitor 11:09:06 INFO - Successfully installed mozsystemmonitor 11:09:06 INFO - Cleaning up... 11:09:06 INFO - Return code: 0 11:09:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:09:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:09:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:09:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x1044b9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044bc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb38b46ef60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104297d30>, '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 0x1041bedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10428cbe8>, '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.tC15EtIDol/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.KhDDQXCiZl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 11:09:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 11:09:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:09:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tC15EtIDol/Render', 11:09:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:09:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:09:06 INFO - 'HOME': '/Users/cltbld', 11:09:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:09:06 INFO - 'LOGNAME': 'cltbld', 11:09:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:06 INFO - 'MOZ_NO_REMOTE': '1', 11:09:06 INFO - 'NO_EM_RESTART': '1', 11:09:06 INFO - 'PAGER': '/bin/cat', 11:09:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:09:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:06 INFO - 'PWD': '/builds/slave/test', 11:09:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:09:06 INFO - 'SHELL': '/bin/bash', 11:09:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KhDDQXCiZl/Listeners', 11:09:06 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 11:09:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:09:06 INFO - 'USER': 'cltbld', 11:09:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:09:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:09:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:06 INFO - 'XPC_FLAGS': '0x0', 11:09:06 INFO - 'XPC_SERVICE_NAME': '0', 11:09:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:09:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:07 INFO - Downloading/unpacking jsonschema==2.5.1 11:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:09:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:09: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 11:09: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 11:09: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 11:09: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 11:09:08 INFO - Downloading functools32-3.2.3-2.tar.gz 11:09:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:09:08 INFO - warning: no files found matching '*.txt' 11:09:08 INFO - no previously-included directories found matching 'build' 11:09:08 INFO - no previously-included directories found matching 'dist' 11:09:08 INFO - no previously-included directories found matching '.git*' 11:09:08 INFO - Installing collected packages: jsonschema, functools32 11:09:08 INFO - Running setup.py install for functools32 11:09:09 INFO - warning: no files found matching '*.txt' 11:09:09 INFO - no previously-included directories found matching 'build' 11:09:09 INFO - no previously-included directories found matching 'dist' 11:09:09 INFO - no previously-included directories found matching '.git*' 11:09:09 INFO - Successfully installed jsonschema functools32 11:09:09 INFO - Cleaning up... 11:09:09 INFO - Return code: 0 11:09:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:09:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:09:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:09 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/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 0x1044b9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044bc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb38b46ef60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104297d30>, '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 0x1041bedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10428cbe8>, '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.tC15EtIDol/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.KhDDQXCiZl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 11:09:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 11:09:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:09:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tC15EtIDol/Render', 11:09:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:09:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:09:09 INFO - 'HOME': '/Users/cltbld', 11:09:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:09:09 INFO - 'LOGNAME': 'cltbld', 11:09:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:09 INFO - 'MOZ_NO_REMOTE': '1', 11:09:09 INFO - 'NO_EM_RESTART': '1', 11:09:09 INFO - 'PAGER': '/bin/cat', 11:09:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:09:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:09 INFO - 'PWD': '/builds/slave/test', 11:09:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:09:09 INFO - 'SHELL': '/bin/bash', 11:09:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KhDDQXCiZl/Listeners', 11:09:09 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 11:09:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:09:09 INFO - 'USER': 'cltbld', 11:09:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:09:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:09:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:09 INFO - 'XPC_FLAGS': '0x0', 11:09:09 INFO - 'XPC_SERVICE_NAME': '0', 11:09:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:09:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:09:10 INFO - Cleaning up... 11:09:10 INFO - Return code: 0 11:09:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:09:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:09:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:09:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:10 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/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 0x1044b9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044bc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb38b46ef60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104297d30>, '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 0x1041bedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10428cbe8>, '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.tC15EtIDol/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.KhDDQXCiZl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 11:09:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 11:09:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:09:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tC15EtIDol/Render', 11:09:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:09:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:09:10 INFO - 'HOME': '/Users/cltbld', 11:09:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:09:10 INFO - 'LOGNAME': 'cltbld', 11:09:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:10 INFO - 'MOZ_NO_REMOTE': '1', 11:09:10 INFO - 'NO_EM_RESTART': '1', 11:09:10 INFO - 'PAGER': '/bin/cat', 11:09:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:09:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:10 INFO - 'PWD': '/builds/slave/test', 11:09:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:09:10 INFO - 'SHELL': '/bin/bash', 11:09:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KhDDQXCiZl/Listeners', 11:09:10 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 11:09:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:09:10 INFO - 'USER': 'cltbld', 11:09:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:09:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:09:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:10 INFO - 'XPC_FLAGS': '0x0', 11:09:10 INFO - 'XPC_SERVICE_NAME': '0', 11:09:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:09:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:10 INFO - Downloading/unpacking blobuploader==1.2.4 11:09:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:12 INFO - Downloading blobuploader-1.2.4.tar.gz 11:09:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:09:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:09:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:09:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:13 INFO - Downloading docopt-0.6.1.tar.gz 11:09:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:09:13 INFO - Installing collected packages: blobuploader, requests, docopt 11:09:13 INFO - Running setup.py install for blobuploader 11:09:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:09:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:09:13 INFO - Running setup.py install for requests 11:09:14 INFO - Running setup.py install for docopt 11:09:14 INFO - Successfully installed blobuploader requests docopt 11:09:14 INFO - Cleaning up... 11:09:14 INFO - Return code: 0 11:09:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:09:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:09:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:14 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/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 0x1044b9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044bc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb38b46ef60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104297d30>, '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 0x1041bedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10428cbe8>, '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.tC15EtIDol/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.KhDDQXCiZl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 11:09:14 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:09:14 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:09:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tC15EtIDol/Render', 11:09:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:09:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:09:14 INFO - 'HOME': '/Users/cltbld', 11:09:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:09:14 INFO - 'LOGNAME': 'cltbld', 11:09:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:14 INFO - 'MOZ_NO_REMOTE': '1', 11:09:14 INFO - 'NO_EM_RESTART': '1', 11:09:14 INFO - 'PAGER': '/bin/cat', 11:09:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:09:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:14 INFO - 'PWD': '/builds/slave/test', 11:09:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:09:14 INFO - 'SHELL': '/bin/bash', 11:09:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KhDDQXCiZl/Listeners', 11:09:14 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 11:09:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:09:14 INFO - 'USER': 'cltbld', 11:09:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:09:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:09:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:14 INFO - 'XPC_FLAGS': '0x0', 11:09:14 INFO - 'XPC_SERVICE_NAME': '0', 11:09:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:09:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:09:14 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-_nXBeH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:09:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:09:14 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-KEZglb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:09:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:09:14 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-ou0E1h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:09:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:09:14 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-ncf_ko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:09:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:09:14 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-6Nhtjx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:09:15 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-rYbdU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:09:15 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-t2r6_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:09:15 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-anDtTD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:09:15 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-PNWuQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:09:15 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-H4pKra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:09:15 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-KYahpk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:09:15 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-K6mEST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:09:15 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-ZmwUVJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:09:15 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-tuOvjf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:09:15 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-cagFHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:09:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:09:16 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-d_VByQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:09:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:09:16 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-2r0ClU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:09:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:09:16 INFO - Running setup.py install for manifestparser 11:09:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:09:16 INFO - Running setup.py install for mozcrash 11:09:16 INFO - Running setup.py install for mozdebug 11:09:16 INFO - Running setup.py install for mozdevice 11:09:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:09:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:09:16 INFO - Running setup.py install for mozfile 11:09:17 INFO - Running setup.py install for mozhttpd 11:09:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:09:17 INFO - Running setup.py install for mozinfo 11:09:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:09:17 INFO - Running setup.py install for mozInstall 11:09:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:09:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:09:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:09:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:09:17 INFO - Running setup.py install for mozleak 11:09:17 INFO - Running setup.py install for mozlog 11:09:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:09:17 INFO - Running setup.py install for moznetwork 11:09:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:09:17 INFO - Running setup.py install for mozprocess 11:09:18 INFO - Running setup.py install for mozprofile 11:09:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:09:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:09:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:09:18 INFO - Running setup.py install for mozrunner 11:09:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:09:18 INFO - Running setup.py install for mozscreenshot 11:09:18 INFO - Running setup.py install for moztest 11:09:18 INFO - Running setup.py install for mozversion 11:09:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:09:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:09:18 INFO - Cleaning up... 11:09:18 INFO - Return code: 0 11:09:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:09:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:09:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:18 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/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 0x1044b9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044bc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb38b46ef60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104297d30>, '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 0x1041bedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10428cbe8>, '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.tC15EtIDol/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.KhDDQXCiZl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 11:09:18 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:09:18 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:09:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tC15EtIDol/Render', 11:09:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:09:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:09:18 INFO - 'HOME': '/Users/cltbld', 11:09:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:09:18 INFO - 'LOGNAME': 'cltbld', 11:09:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:18 INFO - 'MOZ_NO_REMOTE': '1', 11:09:18 INFO - 'NO_EM_RESTART': '1', 11:09:18 INFO - 'PAGER': '/bin/cat', 11:09:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:09:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:18 INFO - 'PWD': '/builds/slave/test', 11:09:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:09:18 INFO - 'SHELL': '/bin/bash', 11:09:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KhDDQXCiZl/Listeners', 11:09:18 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 11:09:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:09:18 INFO - 'USER': 'cltbld', 11:09:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:09:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:09:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:18 INFO - 'XPC_FLAGS': '0x0', 11:09:18 INFO - 'XPC_SERVICE_NAME': '0', 11:09:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:09:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:09:19 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-9rOrY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:09:19 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)) 11:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:09:19 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-9RnHdp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:09:19 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)) 11:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:09:19 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-S6OpaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:09:19 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)) 11:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:09:19 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-CE7E52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:09:19 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)) 11:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:09:19 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-aXp7GD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:09:19 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)) 11:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:09:19 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-xKZErO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:09:19 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)) 11:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:09:19 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-rlChaB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:09:19 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)) 11:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:09:19 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-MUcN3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:09:19 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)) 11:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:09:19 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-oCJnji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:09:20 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)) 11:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:09:20 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-6Fw_ej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:09:20 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)) 11:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:09:20 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-IXAg51-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:09:20 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)) 11:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:09:20 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-aHzKUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:09:20 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)) 11:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:09:20 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-cnZrkI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:09:20 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)) 11:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:09:20 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-Nsju0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:09:20 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)) 11:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:09:20 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-s1cAYq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:09:20 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)) 11:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:09:20 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-rQepGj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:09:20 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)) 11:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:09:20 INFO - Running setup.py (path:/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/pip-KdVziY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:09:20 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)) 11:09:20 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)) 11:09:20 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)) 11:09:20 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)) 11:09:20 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)) 11:09:20 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)) 11:09:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:09:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:22 INFO - Downloading blessings-1.6.tar.gz 11:09:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:09:22 INFO - Installing collected packages: blessings 11:09:22 INFO - Running setup.py install for blessings 11:09:22 INFO - Successfully installed blessings 11:09:22 INFO - Cleaning up... 11:09:22 INFO - Return code: 0 11:09:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:09:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:09:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:09:22 INFO - Reading from file tmpfile_stdout 11:09:22 INFO - Current package versions: 11:09:22 INFO - blessings == 1.6 11:09:22 INFO - blobuploader == 1.2.4 11:09:22 INFO - docopt == 0.6.1 11:09:22 INFO - functools32 == 3.2.3-2 11:09:22 INFO - jsonschema == 2.5.1 11:09:22 INFO - manifestparser == 1.1 11:09:22 INFO - mozInstall == 1.12 11:09:22 INFO - mozcrash == 1.0 11:09:22 INFO - mozdebug == 0.1 11:09:22 INFO - mozdevice == 0.49 11:09:22 INFO - mozfile == 1.2 11:09:22 INFO - mozhttpd == 0.7 11:09:22 INFO - mozinfo == 0.9 11:09:22 INFO - mozleak == 0.1 11:09:22 INFO - mozlog == 3.4 11:09:22 INFO - moznetwork == 0.27 11:09:22 INFO - mozprocess == 0.25 11:09:22 INFO - mozprofile == 0.28 11:09:22 INFO - mozrunner == 6.13 11:09:22 INFO - mozscreenshot == 0.1 11:09:22 INFO - mozsystemmonitor == 0.3 11:09:22 INFO - moztest == 0.8 11:09:22 INFO - mozversion == 1.4 11:09:22 INFO - psutil == 3.1.1 11:09:22 INFO - requests == 1.2.3 11:09:22 INFO - wsgiref == 0.1.2 11:09:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:09:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:09:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:09:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:22 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/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 0x1044b9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044bc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb38b46ef60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104297d30>, '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 0x1041bedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10428cbe8>, '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.tC15EtIDol/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.KhDDQXCiZl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 11:09:22 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:09:22 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:09:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tC15EtIDol/Render', 11:09:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:09:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:09:22 INFO - 'HOME': '/Users/cltbld', 11:09:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:09:22 INFO - 'LOGNAME': 'cltbld', 11:09:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:22 INFO - 'MOZ_NO_REMOTE': '1', 11:09:22 INFO - 'NO_EM_RESTART': '1', 11:09:22 INFO - 'PAGER': '/bin/cat', 11:09:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:09:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:22 INFO - 'PWD': '/builds/slave/test', 11:09:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:09:22 INFO - 'SHELL': '/bin/bash', 11:09:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KhDDQXCiZl/Listeners', 11:09:22 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 11:09:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:09:22 INFO - 'USER': 'cltbld', 11:09:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:09:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:09:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:22 INFO - 'XPC_FLAGS': '0x0', 11:09:22 INFO - 'XPC_SERVICE_NAME': '0', 11:09:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:09:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:23 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)) 11:09:23 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)) 11:09:23 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)) 11:09:23 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)) 11:09:23 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)) 11:09:23 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)) 11:09:23 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)) 11:09:23 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)) 11:09:23 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)) 11:09:23 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)) 11:09:23 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)) 11:09:23 INFO - Cleaning up... 11:09:23 INFO - Return code: 0 11:09:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:09:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:09:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:09:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x1044b9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044bc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb38b46ef60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104297d30>, '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 0x1041bedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10428cbe8>, '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.tC15EtIDol/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.KhDDQXCiZl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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 11:09:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:09:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:09:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tC15EtIDol/Render', 11:09:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:09:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:09:23 INFO - 'HOME': '/Users/cltbld', 11:09:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:09:23 INFO - 'LOGNAME': 'cltbld', 11:09:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:23 INFO - 'MOZ_NO_REMOTE': '1', 11:09:23 INFO - 'NO_EM_RESTART': '1', 11:09:23 INFO - 'PAGER': '/bin/cat', 11:09:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:09:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:23 INFO - 'PWD': '/builds/slave/test', 11:09:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:09:23 INFO - 'SHELL': '/bin/bash', 11:09:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KhDDQXCiZl/Listeners', 11:09:23 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 11:09:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:09:23 INFO - 'USER': 'cltbld', 11:09:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:09:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:09:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:23 INFO - 'XPC_FLAGS': '0x0', 11:09:23 INFO - 'XPC_SERVICE_NAME': '0', 11:09:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:09:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:09:23 INFO - Cleaning up... 11:09:23 INFO - Return code: 0 11:09:23 INFO - Running post-action listener: _resource_record_post_action 11:09:23 INFO - Running post-action listener: _start_resource_monitoring 11:09:23 INFO - Starting resource monitoring. 11:09:23 INFO - [mozharness: 2017-05-30 18:09:23.501439Z] Finished create-virtualenv step (success) 11:09:23 INFO - [mozharness: 2017-05-30 18:09:23.502423Z] Running install step. 11:09:23 INFO - Running pre-action listener: _resource_record_pre_action 11:09:23 INFO - Running main action method: install 11:09:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:09:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:09:23 INFO - Reading from file tmpfile_stdout 11:09:23 INFO - Detecting whether we're running mozinstall >=1.0... 11:09:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:09:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:09:23 INFO - Reading from file tmpfile_stdout 11:09:23 INFO - Output received: 11:09:23 INFO - Usage: mozinstall [options] installer 11:09:23 INFO - Options: 11:09:23 INFO - -h, --help show this help message and exit 11:09:23 INFO - -d DEST, --destination=DEST 11:09:23 INFO - Directory to install application into. [default: 11:09:23 INFO - "/builds/slave/test"] 11:09:23 INFO - --app=APP Application being installed. [default: firefox] 11:09:23 INFO - mkdir: /builds/slave/test/build/application 11:09:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:09:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0.en-US.mac.dmg --destination /builds/slave/test/build/application 11:09:43 INFO - Reading from file tmpfile_stdout 11:09:43 INFO - Output received: 11:09:43 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 11:09:43 INFO - Running post-action listener: _resource_record_post_action 11:09:43 INFO - [mozharness: 2017-05-30 18:09:43.892370Z] Finished install step (success) 11:09:43 INFO - [mozharness: 2017-05-30 18:09:43.892530Z] Running run-tests step. 11:09:43 INFO - Running pre-action listener: _resource_record_pre_action 11:09:43 INFO - Running main action method: run_tests 11:09:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:09:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:09:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:09:43 INFO - 2017-05-30 11:09:43.906 screenresolution[1645:7372] starting screenresolution argv=screenresolution get 11:09:43 INFO - 2017-05-30 11:09:43.909 screenresolution[1645:7372] Display 0: 1600x1200x32@60 11:09:43 INFO - 2017-05-30 11:09:43.915 screenresolution[1646:7374] starting screenresolution argv=screenresolution list 11:09:43 INFO - Available Modes on Display 0 11:09:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:09:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:09:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:09:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:09:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:09:44 INFO - Intel Iris: 11:09:44 INFO - Chipset Model: Intel Iris 11:09:44 INFO - Type: GPU 11:09:44 INFO - Bus: Built-In 11:09:44 INFO - VRAM (Dynamic, Max): 1536 MB 11:09:44 INFO - Vendor: Intel (0x8086) 11:09:44 INFO - Device ID: 0x0a2e 11:09:44 INFO - Revision ID: 0x0009 11:09:44 INFO - Displays: 11:09:44 INFO - Display: 11:09:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:09:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:09:44 INFO - Display Serial Number: 1600x1200 60 11:09:44 INFO - Main Display: Yes 11:09:44 INFO - Mirror: Off 11:09:44 INFO - Online: Yes 11:09:44 INFO - Rotation: Supported 11:09:44 INFO - Return code: 0 11:09:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:09:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:09:44 INFO - Python 2.7.3 11:09:44 INFO - Return code: 0 11:09:44 INFO - grabbing minidump binary from tooltool 11:09:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:09:44 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 0x104297d30>, '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 0x1041bedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10428cbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:09:44 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 11:09:44 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 11:09:44 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 11:09:44 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:09:44 INFO - Return code: 0 11:09:44 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:09:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:09:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:09:44 INFO - ENV: RUST_BACKTRACE is now 1 11:09:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:09:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:09:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/THh22lUMT7q6VthAu3WBkg/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0314', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:09:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/THh22lUMT7q6VthAu3WBkg/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0314 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:09:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tC15EtIDol/Render', 11:09:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:09:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:09:44 INFO - 'HOME': '/Users/cltbld', 11:09:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:09:44 INFO - 'LOGNAME': 'cltbld', 11:09:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:09:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:09:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:44 INFO - 'MOZ_NO_REMOTE': '1', 11:09:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:09:44 INFO - 'NO_EM_RESTART': '1', 11:09:44 INFO - 'PAGER': '/bin/cat', 11:09:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:09:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:44 INFO - 'PWD': '/builds/slave/test', 11:09:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:09:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:09:44 INFO - 'RUST_BACKTRACE': '1', 11:09:44 INFO - 'SHELL': '/bin/bash', 11:09:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KhDDQXCiZl/Listeners', 11:09:44 INFO - 'TMPDIR': '/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/', 11:09:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:09:44 INFO - 'USER': 'cltbld', 11:09:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:09:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:09:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:44 INFO - 'XPC_FLAGS': '0x0', 11:09:44 INFO - 'XPC_SERVICE_NAME': '0', 11:09:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:09:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/THh22lUMT7q6VthAu3WBkg/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0314', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:09:44 INFO - mozversion application_buildid: 20170530100116 11:09:44 INFO - mozversion application_changeset: 1bf2d9f8a5cb68370f9a797890beb14769f4144b 11:09:44 INFO - mozversion application_display_name: FirefoxDeveloperEdition 11:09:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:09:44 INFO - mozversion application_name: Firefox 11:09:44 INFO - mozversion application_remotingname: firefox-dev 11:09:44 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:09:44 INFO - mozversion application_vendor: Mozilla 11:09:44 INFO - mozversion application_version: 54.0 11:09:44 INFO - mozversion platform_buildid: 20170530100116 11:09:44 INFO - mozversion platform_changeset: 1bf2d9f8a5cb68370f9a797890beb14769f4144b 11:09:44 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:09:44 INFO - mozversion platform_version: 54.0 11:09:44 INFO - using testdate: 1496167784 11:09:44 INFO - actual date: 1496167784 11:09:44 INFO - starting webserver on 'localhost:49221' 11:09:44 INFO - SUITE-START | Running 2 tests 11:09:44 INFO - TEST-START | dromaeo_css 11:09:44 INFO - operating with platform_type : mac_ 11:09:44 INFO - Initialising browser for dromaeo_css test... 11:09:44 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/tmpJ9YF0L/profile http://localhost:49221/getInfo.html) 11:09:47 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 11:09:47 INFO - PROCESS | 1656 | colorDepth:24 11:09:47 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 11:09:47 INFO - PROCESS | 1656 | __metrics 11:09:47 INFO - PROCESS | 1656 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:09:47 INFO - PROCESS | 1656 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:09:47 INFO - TEST-INFO | 1656: exit 0 11:09:47 INFO - Browser initialized. 11:09:47 INFO - Running cycle 1/1 for dromaeo_css test... 11:09:47 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/tmpJ9YF0L/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:09:59 INFO - PROCESS | 1659 | RSS: Main: 193908736 11:09:59 INFO - PROCESS | 1659 | 11:13:03 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49221/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49221/tests/dromaeo/cssquery-ext.html) 11:13:05 INFO - PROCESS | 1659 | RSS: Main: 371642368 11:13:05 INFO - PROCESS | 1659 | 11:16:08 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49221/tests/dromaeo/cssquery-ext.html (next: http://localhost:49221/tests/dromaeo/cssquery-jquery.html) 11:16:09 INFO - PROCESS | 1659 | RSS: Main: 328417280 11:16:09 INFO - PROCESS | 1659 | 11:19:11 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49221/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49221/tests/dromaeo/cssquery-mootools.html) 11:19:12 INFO - PROCESS | 1659 | RSS: Main: 305713152 11:19:12 INFO - PROCESS | 1659 | 11:22:14 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49221/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49221/tests/dromaeo/cssquery-prototype.html) 11:22:15 INFO - PROCESS | 1659 | RSS: Main: 305328128 11:22:15 INFO - PROCESS | 1659 | 11:25:18 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49221/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49221/tests/dromaeo/cssquery-yui.html) 11:25:19 INFO - PROCESS | 1659 | RSS: Main: 290988032 11:25:19 INFO - PROCESS | 1659 | 11:28:22 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49221/tests/dromaeo/cssquery-yui.html (next: http://localhost:49221/tests/dromaeo/cssquery-dojo.html) 11:28:22 INFO - PROCESS | 1659 | RSS: Main: 327626752 11:28:22 INFO - PROCESS | 1659 | 11:28:22 INFO - PROCESS | 1659 | __start_tp_report 11:28:22 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 11:28:22 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 11:28:22 INFO - PROCESS | 1659 | |i|pagename|runs| 11:28:22 INFO - PROCESS | 1659 | |0;dojo.html;3423.5207071010054;3433.227523807145;3442.3459542686905;3451.981665408705;3494.14393473599;5672.574556908227;5858.238429004229;5887;5889.587728858976;5984.521238300937;5790.797322093727;5902.232709747726;5909.054551271797;5913.763449462027;5924.792632257871;4355.390245365644;5298.947010529884;5368.8389348319615;5370.3287089113865;5391.191321301816;5267.631265811395;5272.367315922094;5276.894462110756;5446.210299506569;5460.972695136538;5373.892522149555;5381.461853814626;5397.919031214516;5398.6220964532495;5418.512333889949;5430.15832545956;5430.619856610039;5436.40199578048;5441.183822426668;5448.291722076125;5225.399079105913;5309.283246761676;5357.919631205535;5370.167624018283;5435.565154787608;5797.043487824504;5799.420057994209;5809.041508151192;5925.229720136398;5993.640381577119;6251.843703907393;6305.117283580303;6305.495560355161;6327.8418039548915;6328.873422531569;6323.588966717149;6350.174477317965;6364.109024736541;6364.904526432108;6372.299047104815;5756.597038207327;5849.736761845727;5854.970725146347;5870.26621672291;6023.307319658252;6298.118263443122;6307.274663413675;6374.936250637527;6396.808095757135;6437.517186211053;6336.303006669263;6339.936600633934;6340.492760579143;6348.301686814447;6361.8727625448155;6270.968645156836;6321.462675672619;6334.714937827716;6343.524235682342;6343.936560634427;6225.564210505221;6252.374762523711;6259.0924315973925;6322.652254125976;6322.810315690536;6299.96850015747;6300.369963003663;6307.463865571386;6308.337624549448;6310.684465776692;4828.589569886529;4869.586085182728;4873.6832105913;4875.414950205998;4897.706137631753;4301.247281725686;4319.719218250803;4348.326009468537;4405.801738921757;4408.581184787504;5643.068893632505;5741.913871291934;5744.080947048452;5822.097574875901;5830.2420685310635;6323.083152942798;6347.55567110307;6350.650714210763;6351.364863513611;6360.427561519486;5779.306483222041;5795.536357091422;5802.506786923074;5802.651840889475;5842.883142337129;5301.469853014745;5387.299651045339;5417.485338892799;5461.1808228766;5475.7262136893;6432.388923052303;6470.4823614110755;6493;6493.2857385688485;6496.480281577368;6329.936700633119;6333.113364128933;6336.081268216175;6343;6350.460210881942;6252.374762523711;6252.437280644764;6323.399277068671;6366.745330186926;6402.647854367868;6253.937460625518;6272.905906411499;6273.874522509615;6302.5588208826775;6328.557001009885;6263.498920086291;6298.338674439301;6321.52588555851;6330.145430367026;6356.968215158895;6237.688115594293;6239.937600623935;6260;6333.20834895638;6339.302676705651;5939.316978547522;6251.71867265965;6321.8735625288155;6348.650824204713;6351.555391122577;5935.287765467999;5998.70006499682;6048.092786082123;6197.81406557786;6211.472024877936;6163.753449861955;6186.5360097993735;6207.534434917489;6259.749610015549;6321.905171422341;6167.259928808392;6180.938190618036;6193;6198.783042593487;6218.751249950133 11:28:22 INFO - PROCESS | 1659 | |1;ext.html;812.9756107316779;834.0366876257922;875.7854325690207;897.7531178925799;898.2050884966802;40725.59274407255;41587.75236742895;41647.375289370684;41756.95607609811;41776.164476710524;40815;41178.38232426516;42466.57533424665;42512.57487425125;42527;7736.690532378698;9478.431294122358;9632.47021413822;9642.035796420372;9642.517874106301;7699.076110866704;7790.961045194795;7791.065072191345;7799.766007019798;11629.302241865473;11871.584494542692;11880;11900.107491938095;11910.7617847643;11954.521819127225;11818.699943006262;11836.289822610672;11849.763004739943;11873.990710789592;11883.584074557435;11435.42822858862;11455.369954652491;11462.656120316404;11485.483153258123;11491.02326302257;40210.79894600508;40486.797566011985;40504;40556.580519681964;40589.79705101485;3872.48972900569;3906.921861562753;3939.3500072488005;3970.007498125469;4004.519457665099;27875.721242787517;28329.85835070832;29757.851210743807;30472.84763576168;30540.389192216033;3071.539269109629;3171.9207019824457;3209.5506629071947;3257.5765150530515;3309.1561651778884;362539.18730406446;365614;366505;366715;366917;42635.786821065696;43377.783111084245;52879.73560132175;52988.205176922376;53080.73459632677;46364.768176158905;49725.25412118821;60183.69908150519;61392;61543;14863.479778207711;14988.175650339117;14988.47540336083;15277.38890444392;15280.159591222367;12947.482100716054;12985.28580928039;13026.739465210832;13029.283389413673;13031.934840325737;13858;13867.653308667364;13883.097598656055;13968.790468142986;13994.16035037901;6121.673763969663;6128.3565225651555;6157.96921015392;6180.825643127881;6201.565890387629;1118.4945721583595;1153.1005815463784;1174.371711134556;1196.1806162778526;1198.2391181599746;23970.7602923972;27275.590866137023;27454;27585.448291034467;27708.030218942644;1078.6925726168004;1082.929609575375;1119.121489630636;1120.506976930148;1123.8538989931258;13027.934860325828;13619.455221791215;13657.907367410584;14497.710045799025;14915.657590816878;422562.5487490233;468656;479562;481361.5931920388;482020;47278;47449;47476.28785568219;47529.049419011426;47622.76188619035;1406.9155850648995;1409.3657853965756;1415.900886937925;1435.6410897275682;1441.2505497141428;23369.532609348058;25045.246832721536;26996.59505107464;26999.865000674872;27136;36150.8192459036;36318;36337.454938176474;36447.453288200166;36528.81735591305;459904;462263;462373;462798;464397.6780116078;29169.56245656359;29576.408471830873;29997.65010574486;30029.69970300269;30050.69949300479;37919.81040094782;38170;38596.80701596474;38716.41925371178;39091.022724432114;27076.05233816807;27567;28269.293267668472;28435.43129137447;28502.287442814097;27719.445611088067;28522.42955140927;28658.85670571717;28801.855990719912;28850.99021534236;32060.839695801373;32156.678433216304;32179.35641287208;32717.345653087283;33072;28354.574681379385;28530.42939141164;29002.7099729;29031.693573789653;29083.56374654424;21825.781742182375;22787.202447914242;23174.768252317936;23205.3038408848;23213.071477140726 11:28:22 INFO - PROCESS | 1659 | |2;jquery.html;412.03378078406143;416.2382839403891;423.8770756480621;432.6409080463215;450.8016472751989;19652.21391144354;20974.475638109056;22210.66683999741;22242.666360004572;22372.88813555932;21809.23667671632;22453.887730561364;22473.32580022602;22822.543549129008;23169;6713.530052896299;6913;7061.788146355618;7116;7136.785896423115;6824.351686589791;6898.689558969833;6912.135983002125;6913.792586222421;6980;6618.801435956929;6889.965550172242;6944.895826562605;6971.477139214554;6971.511994160411;5673.801416950387;6815.693293801766;6867.690953907061;6896.793096207121;6901.62041087745;5098.974505127488;6731.49513786468;6732.663366831639;6749.392554670103;6750.8312292192595;27644.30889227765;27931.86034069837;28029.85985070082;28145.57781633277;28278.293042674097;3009.653889802657;3016.9849150754326;3039.6352437707396;3076.1848110250803;3092.3815236952473;16029.438969636007;16751.246193921303;16847.494575162764;17587.472375828747;17831.197596108075;2163.8052575268143;2179.28185478439;2182.0835249195375;2183.8908054597205;2206.4925067234467;130457;131775;133299.99999999904;134555;135585;13021.153625014344;17102;17984.910075449538;18941.715874261896;19035;28886.85556572204;29127;29273.707262927524;29351.266218344714;29452.852735736185;9689.498127790204;10169.898301017043;10176.185905127571;10187.439690817077;10298.742531436625;6931.965340173267;7041.2748876525575;8352.454795862785;8578.742637720878;8845.292376609985;7262.673179706926;8895.911040889509;9014.63941442348;9026.232770214605;9035.509140991662;3058.602381690366;3445.534852794891;3584.766990145632;3738.383166777451;3834.7890866002635;841.4278290762218;980.2501086668705;1013.5236438873718;1021.4382089850552;1059.3379138038727;19178.13698383576;20358.491037724176;20424.897875510527;21150;21938.892488660527;890.412327863607;910.8341323106434;1005.4269066631949;1014.9594016239415;1020.0870221152176;6765.627890466071;6807.285235050347;6924.861502770017;7153.964230178815;7195.92804071963;728573;788631;798861;814315;834932;170426;171795.14102429408;172474;174119;178617;1298.8636193199768;1307.4900788692419;1330.7804212305055;1332.240622844969;1335.0787956310114;11615.419229038345;12136;12624.87375126237;12880.420381082686;12920.289384083966;66825.33174668385;66847.66576167088;67062;67217.99173012507;67269;94906.52546737222;96824.03175968432;96945;98351;98521;7553.962230189034;11542.01892839118;11627.476763545492;11879.703007424883;11915.16593838423;13284.601461956157;13327.067105302536;13579.660508486972;13732.931335343259;13751.862481375058;11321.207515473838;11339.773204536028;11468.598599048993;11488;11758.294502329887;10239.43683097407;10304.536295866554;10647.946760266459;10747.946260268649;10815.24293299493;9320.580573874327;11407;11787.587434439753;11846.526138954345;11951.820722689341;9666.854997174907;11673.482447281798;11687.240329378563;11964.102692297938;11993.880061199276;11274.210805243882;11305.547778088785;11367.204295699552;11462.656120316404;11514.76970460603 11:28:22 INFO - PROCESS | 1659 | |3;mootools.html;1388.8750012498874;1579.194610748518;1584.532562893946;1608.404890190629;1616.0949868073878;10634.78730425391;10977.83533247002;10977.83533247002;10978.12175025998;11026.338419694825;10684.78630427393;10728.892711072887;10877.891221087786;10893.07408870245;11047;2172.4025892879467;2194.572058448603;2196.6814811852273;2198.604251234777;2200.702905107814;2199.197292988064;2256.740474845389;2268.9092436302612;2269;2290.450291929933;2193.1775584155944;2258.6386178211487;2269.7616750241236;2275.7724227577273;2282.5206706591634;2207.381933058746;2232.3191426614794;2233.8547994380315;2234.698315727372;2239.85440946338;2201.515666553356;2248.4378905273684;2252.707148070757;2255.334676270504;2256.4246117240164;10854.24020318578;10937.070349020343;10940.945295273472;10944.781104377947;10951.671449856518;5170.663906846081;5273.367195936474;5295.391030031518;5319.946800531984;5319.9734001330135;2907.6946920573246;3065.1724034510557;3145.5596216529702;3191.2181515528846;3216.758743094254;1096.5230124895695;1098.6868742408456;1123.3260043973632;1132.9376884271362;1144.4506636814292;14855.702885942328;14982.10107393549;15026.699466010728;15047.322870470745;15059.096454212782;3982.1040265939932;4120.299549076664;4199.9370009449885;4201.7268877522865;4204.600562946576;11343.432828358715;11352.091832653368;11353.943230283796;11364.659060228207;11378.203525753283;5192.844214673566;5198.064348417245;5198.81804136861;5212.166053431432;5215.165573508297;4653.488116307203;4676.111538807683;4714.57568818808;4774.880627984328;4812.013537224861;3408.1309266137473;3441.6558344165383;3445.448728203475;3506.1242235404447;3532.5760908691122;849.2314455417857;854.4232642965973;862.2153840005565;866.2680035370103;868.0668281597308;953.666216824106;955.1976339874539;958.6165533786402;973.3770386952356;1003.8494225866033;5364.463553644604;6377.585456945284;6378.712957916905;6425.325340839238;6451.677416129175;960.8078384323163;987.160913223754;987.195435719886;995.9103680668775;1037.9740506487246;3805.4482100095884;3960.8415663373144;4257.40396344512;4267.5732426757695;4282.229198744256;12787.61637150887;13380.732385352238;13391.598252052454;13392;13429.992750543748;12982.026348023935;13197.406116724771;13217;13310.46758129664;13426.932865335611;10010.599576016877;10042.849357259647;10049.29654924163;10056.949715251378;10172.491375431347;5643.266375371176;6507.511936604679;6519.185101862267;6634.104395906491;6705.6647167642395;11814;12104.273743575413;12107.515699371927;12165.939170304091;12223.69440763988;11945.880541194478;12199.085068620067;12282.140250182401;12306.876931230574;12336.013118950283;6811.8978215325815;8512.616932237941;8547.829043418973;8548.572571371282;8570.914290857012;10036.799264014824;10124.34191777532;10136.138428233682;10213.846792297973;10254.692359229235;8496.830063398822;8612.397132200937;8621.82756344857;8827.514486703036;8842.336824738299;8341.916580834113;8443.873341899754;8506.872396913928;8527;8561.10108438605;7695.038120234971;7759.379249659901;7786.610669466618;7869.095054068626;7886.211378862068;5812.854678632899;5829.76680932758;5989.910151347646;6008.459238668541;6042.395760423922;5906.114082887601;5958.76164953397;5979.461848433488;5987.700614969322;5997.580169388276 11:28:22 INFO - PROCESS | 1659 | |4;prototype.html;381.85871227645777;382.787552908136;383.9385698288271;391.4441493079826;391.9666828319595;4015.7791321477307;4528.388667529883;4980.9252861207115;5101.285819985205;5118.5905127589795;4146.647534959532;4232.809523571439;4347.130573885228;5062.620303477244;5086.084504789136;3881.874256465636;4142.689298302625;4244.936325955113;4266.957330426687;4268.701190916637;3689;3832.5784163741964;4120.486503233041;4259.70182087254;4275.102228532012;4267.570363928088;4287.464066991626;4300.569943005706;4311.426329389781;4330.805113769888;4105.678295334116;4198.200628431244;4226.725262857904;4290.4636920384955;4325.891852703692;3375.362948969748;3914.3149948759137;3925.980370098131;3957.34703773877;3995.4817169475705;4244.702870799046;4478.216312145361;4902.896848209124;5016.423111342206;5016.724080175589;4162.83348666056;4902.460729319772;4923.129210899871;4944.406671199443;4947.480514545957;4391.758453285068;4407.427034485529;4483.798229079699;5485.204645326446;5488.835334939959;3682.926341473182;3787.8484860605818;3897.5712671606384;4144.233316836395;4367.3448982652535;4546.954530454719;5115.130427827278;5459.69971651559;5605.859853503654;5637.577181711388;3617.0957260684827;4341.392205091227;4457.955420445819;4475.932861007088;4478.9328160076975;4275.572442755762;4535.387722657399;4548.295014272793;4570.542945705402;4594.563516465931;4878.219484882402;4944.431390390079;4959.305697202394;4984.90030199394;5005.998800239894;4732.455767586703;5145.4597267287145;5206.3752349717515;5412.104524079598;5581.553475721932;1641.9096949667644;1642.6632540329203;1704.4290162795603;1718.905460199676;1723.7244439114966;1343.657367371314;1350.5273154395884;1401.810755547988;1407.6480879780056;1426;4326.4159338489535;4535.410396648481;4757.595604373598;4936.753162341868;4950.282209079735;4887.971491830922;4924.556789888856;5202.03762303975;5316.574674026068;5365.865853353619;4489.573490518395;4699.365585645894;4900.956710713675;4925.729084900365;5034.697918124924;2380.274016425007;2644.2331723800266;2739.411026629284;2824.85875706218;2989.3274013346822;5015.849524514198;5492.286002819608;5645.322561292671;5922.644641321534;5929.822105336847;4463.152001119777;5058.772355244023;5754.712264386764;5779.913301300484;5793.754342816231;5500.202470641814;5704.516825625285;5715.828525144169;5785.623934444247;5884.529237660977;4536.642884265554;5148.4851514848215;5275.498827611371;5646.604737668488;5674.858128546819;5339.46605339463;5541.473560011793;5576.828865938199;5614.66991198648;5659.745311460912;5000.224785329929;5107.770150343318;5459.372172200247;5786.94213057864;5787.305523337226;3865.207632435288;3896.3960586109197;3906.824192911269;4462.642988560972;4486.528914464065;4999.575036121825;5078.921078921079;5438.7762753380175;5613.971930140323;5655.858603534944;4781.928271075867;5436.429174936575;5560.860978475571;5565.721713914207;5593.846369147988;4702;4951.900961980812;5451.618386712892;5540.75066622011;5549.612596850788;4825.083234185494;5108.182690769459;5173.896522069463;5353.0922426628;5361.865953351197;5411.594130440154;5448.945510544844;5459.798844254257;5517.420670829505;5572.903915622096;4934.605231581537;5301.655392399482;5342.839714808562;5382.650127741685;5415.83752487426 11:28:22 INFO - PROCESS | 1659 | |5;yui.html;754.121448512483;769.8113962079287;781.2109769133177;841.0790184747701;854.538549183441;15030.398784048639;15679.216039198052;15718.135502547355;15751.133687647174;16875.90306630068;15558.377664893418;15690.450834220805;15701.84298157018;15712.057276563386;15715.60710982226;964.2816102004017;987.1954357198896;987.8518222266646;988.8417853143499;995.1541189988488;972.4457059476066;988.3970777825521;994.3089552760835;994.8308787506141;1001.484235618657;1040.1107053469289;1042.8018676451488;1044.6918159143033;1045.4563626914;1046.3878631000835;1035.8964103589656;1037.2998226197362;1037.8495118207893;1038.5378506564582;1039.6880935719255;776.8290975985274;776.9611519424006;777.8560966221268;780.621398621668;780.8204113053972;16300.918495407566;16558.917205414018;16606.335746570123;16795;17149.657006859918;12134.575289864812;14002;14482.203478808662;14555.345009474599;14664.70670586593;11722.94138529302;11952.70118247042;11969.401529923469;12038.39808009596;12115.93942030293;3652.926941461156;3717.839836139287;3729.7948612826553;3747.306748251582;3803.3344164771056;103750;106503.93496065018;107204.39193412106;108685;108810.99999999921;10641.201909856636;10927.617533386294;10938.070264027647;11112.499937502831;11308.830367544493;22256.777432225794;22307.77692223057;22356.888215559142;22540.66189007166;22739.204127855446;7942;7961.164077771867;8002.319802816709;8032.759017229492;8032.919670803334;4431.512533621363;4443.200223959719;4493.618042466362;4747.667663263538;4750.358701575243;3196.5844440222622;3255.951160732591;3265.591801024872;3300.719438847677;3301.6863397977154;613.2058983616228;616.9444749972524;618.072890664004;633.5944995203074;638.4317957018258;671.4762485261504;705.2418649951322;716.6130289643638;721.6253037962689;724.3788203540563;9121.817563648823;9859.457729824928;10324.535395907202;10433;10461.372317660966;548.8353493951878;580.179046648987;626.614632001316;664.1333060356282;718.989215161773;4080.571539988318;4439.169964595915;5102.4897510248675;5107.259447380109;5119.411267704188;96783;99671;100955.99044009612;101280;103233;77717;81125.59437202894;82807.17192827995;84556.57721711352;85756.57121714352;73851.52296954139;76136;76808.46383072308;77249.22750772645;78699.21300786918;9835.409875407498;9849.359791613522;9854;9858.211343092393;9869.506524673881;47501.76249118732;48987.75506122447;49190;50287.74856125696;51318.7170320745;62814.68592657008;63034.424139396884;63700;63802;65629;12402.5659101931;12653.304068276333;12782.872171278541;13053.412596432994;13072.542461013818;14987.700245995236;15070;15163.393464261748;15633.921830390775;16048.839511604734;12723.745525089631;12776.808347874976;12931.5473958411;13052.608421747364;13554.254516001714;13656.453741850612;13726.478914023599;14277.785833212718;14349.282535872955;14851.331690073757;13425;13931.30343482842;14057.578272651837;14176.291185440481;14570.708585828012;9701.223902087957;9787.36382135159;10021.498925053864;10430.16558675289;10454.843177352497;11189.832152517556;11300.83048754253;11569.595064172714;11873.99071078968;11982.520699171935 11:28:22 INFO - PROCESS | 1659 | __end_tp_report 11:28:22 INFO - PROCESS | 1659 | __start_cc_report 11:28:22 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,2032 11:28:22 INFO - PROCESS | 1659 | __end_cc_report 11:28:22 INFO - PROCESS | 1659 | __startTimestamp1496168902800__endTimestamp 11:28:22 INFO - PROCESS | 1659 | 11:28:22 INFO - PROCESS | 1659 | ------- Summary: start ------- 11:28:22 INFO - PROCESS | 1659 | Number of tests: 6 11:28:22 INFO - PROCESS | 1659 | 11:28:22 INFO - PROCESS | 1659 | [#0] dojo.html Cycles:165 Average:5853.82 Median:6186.54 stddev:665.93 (10.8%) stddev-sans-first:640.10 11:28:22 INFO - PROCESS | 1659 | Values: 3423.5 3433.2 3442.3 3452.0 3494.1 5672.6 5858.2 5887.0 5889.6 5984.5 5790.8 5902.2 5909.1 5913.8 5924.8 4355.4 5298.9 5368.8 5370.3 5391.2 5267.6 5272.4 5276.9 5446.2 5461.0 5373.9 5381.5 5397.9 5398.6 5418.5 5430.2 5430.6 5436.4 5441.2 5448.3 5225.4 5309.3 5357.9 5370.2 5435.6 5797.0 5799.4 5809.0 5925.2 5993.6 6251.8 6305.1 6305.5 6327.8 6328.9 6323.6 6350.2 6364.1 6364.9 6372.3 5756.6 5849.7 5855.0 5870.3 6023.3 6298.1 6307.3 6374.9 6396.8 6437.5 6336.3 6339.9 6340.5 6348.3 6361.9 6271.0 6321.5 6334.7 6343.5 6343.9 6225.6 6252.4 6259.1 6322.7 6322.8 6300.0 6300.4 6307.5 6308.3 6310.7 4828.6 4869.6 4873.7 4875.4 4897.7 4301.2 4319.7 4348.3 4405.8 4408.6 5643.1 5741.9 5744.1 5822.1 5830.2 6323.1 6347.6 6350.7 6351.4 6360.4 5779.3 5795.5 5802.5 5802.7 5842.9 5301.5 5387.3 5417.5 5461.2 5475.7 6432.4 6470.5 6493.0 6493.3 6496.5 6329.9 6333.1 6336.1 6343.0 6350.5 6252.4 6252.4 6323.4 6366.7 6402.6 6253.9 6272.9 6273.9 6302.6 6328.6 6263.5 6298.3 6321.5 6330.1 6357.0 6237.7 6239.9 6260.0 6333.2 6339.3 5939.3 6251.7 6321.9 6348.7 6351.6 5935.3 5998.7 6048.1 6197.8 6211.5 6163.8 6186.5 6207.5 6259.7 6321.9 6167.3 6180.9 6193.0 6198.8 6218.8 11:28:22 INFO - PROCESS | 1659 | 11:28:22 INFO - PROCESS | 1659 | [#1] ext.html Cycles:180 Average:56252.39 Median:16805.96 stddev:115349.49 (686.4%) stddev-sans-first:115597.97 11:28:22 INFO - PROCESS | 1659 | Values: 813.0 834.0 875.8 897.8 898.2 40725.6 41587.8 41647.4 41757.0 41776.2 40815.0 41178.4 42466.6 42512.6 42527.0 7736.7 9478.4 9632.5 9642.0 9642.5 7699.1 7791.0 7791.1 7799.8 11629.3 11871.6 11880.0 11900.1 11910.8 11954.5 11818.7 11836.3 11849.8 11874.0 11883.6 11435.4 11455.4 11462.7 11485.5 11491.0 40210.8 40486.8 40504.0 40556.6 40589.8 3872.5 3906.9 3939.4 3970.0 4004.5 27875.7 28329.9 29757.9 30472.8 30540.4 3071.5 3171.9 3209.6 3257.6 3309.2 362539.2 365614.0 366505.0 366715.0 366917.0 42635.8 43377.8 52879.7 52988.2 53080.7 46364.8 49725.3 60183.7 61392.0 61543.0 14863.5 14988.2 14988.5 15277.4 15280.2 12947.5 12985.3 13026.7 13029.3 13031.9 13858.0 13867.7 13883.1 13968.8 13994.2 6121.7 6128.4 6158.0 6180.8 6201.6 1118.5 1153.1 1174.4 1196.2 1198.2 23970.8 27275.6 27454.0 27585.4 27708.0 1078.7 1082.9 1119.1 1120.5 1123.9 13027.9 13619.5 13657.9 14497.7 14915.7 422562.5 468656.0 479562.0 481361.6 482020.0 47278.0 47449.0 47476.3 47529.0 47622.8 1406.9 1409.4 1415.9 1435.6 1441.3 23369.5 25045.2 26996.6 26999.9 27136.0 36150.8 36318.0 36337.5 36447.5 36528.8 459904.0 462263.0 462373.0 462798.0 464397.7 29169.6 29576.4 29997.7 30029.7 30050.7 37919.8 38170.0 38596.8 38716.4 39091.0 27076.1 27567.0 28269.3 28435.4 28502.3 27719.4 28522.4 28658.9 28801.9 28851.0 32060.8 32156.7 32179.4 32717.3 33072.0 28354.6 28530.4 29002.7 29031.7 29083.6 21825.8 22787.2 23174.8 23205.3 23213.1 11:28:22 INFO - PROCESS | 1659 | 11:28:22 INFO - PROCESS | 1659 | [#2] jquery.html Cycles:180 Average:44245.25 Median:22995.77 stddev:132317.55 (575.4%) stddev-sans-first:132647.80 11:28:22 INFO - PROCESS | 1659 | Values: 412.0 416.2 423.9 432.6 450.8 19652.2 20974.5 22210.7 22242.7 22372.9 21809.2 22453.9 22473.3 22822.5 23169.0 6713.5 6913.0 7061.8 7116.0 7136.8 6824.4 6898.7 6912.1 6913.8 6980.0 6618.8 6890.0 6944.9 6971.5 6971.5 5673.8 6815.7 6867.7 6896.8 6901.6 5099.0 6731.5 6732.7 6749.4 6750.8 27644.3 27931.9 28029.9 28145.6 28278.3 3009.7 3017.0 3039.6 3076.2 3092.4 16029.4 16751.2 16847.5 17587.5 17831.2 2163.8 2179.3 2182.1 2183.9 2206.5 130457.0 131775.0 133300.0 134555.0 135585.0 13021.2 17102.0 17984.9 18941.7 19035.0 28886.9 29127.0 29273.7 29351.3 29452.9 9689.5 10169.9 10176.2 10187.4 10298.7 6932.0 7041.3 8352.5 8578.7 8845.3 7262.7 8895.9 9014.6 9026.2 9035.5 3058.6 3445.5 3584.8 3738.4 3834.8 841.4 980.3 1013.5 1021.4 1059.3 19178.1 20358.5 20424.9 21150.0 21938.9 890.4 910.8 1005.4 1015.0 1020.1 6765.6 6807.3 6924.9 7154.0 7195.9 728573.0 788631.0 798861.0 814315.0 834932.0 170426.0 171795.1 172474.0 174119.0 178617.0 1298.9 1307.5 1330.8 1332.2 1335.1 11615.4 12136.0 12624.9 12880.4 12920.3 66825.3 66847.7 67062.0 67218.0 67269.0 94906.5 96824.0 96945.0 98351.0 98521.0 7554.0 11542.0 11627.5 11879.7 11915.2 13284.6 13327.1 13579.7 13732.9 13751.9 11321.2 11339.8 11468.6 11488.0 11758.3 10239.4 10304.5 10647.9 10747.9 10815.2 9320.6 11407.0 11787.6 11846.5 11951.8 9666.9 11673.5 11687.2 11964.1 11993.9 11274.2 11305.5 11367.2 11462.7 11514.8 11:28:22 INFO - PROCESS | 1659 | 11:28:22 INFO - PROCESS | 1659 | [#3] mootools.html Cycles:180 Average:6511.97 Median:2286.49 stddev:4178.94 (182.8%) stddev-sans-first:4172.93 11:28:22 INFO - PROCESS | 1659 | Values: 1388.9 1579.2 1584.5 1608.4 1616.1 10634.8 10977.8 10977.8 10978.1 11026.3 10684.8 10728.9 10877.9 10893.1 11047.0 2172.4 2194.6 2196.7 2198.6 2200.7 2199.2 2256.7 2268.9 2269.0 2290.5 2193.2 2258.6 2269.8 2275.8 2282.5 2207.4 2232.3 2233.9 2234.7 2239.9 2201.5 2248.4 2252.7 2255.3 2256.4 10854.2 10937.1 10940.9 10944.8 10951.7 5170.7 5273.4 5295.4 5319.9 5320.0 2907.7 3065.2 3145.6 3191.2 3216.8 1096.5 1098.7 1123.3 1132.9 1144.5 14855.7 14982.1 15026.7 15047.3 15059.1 3982.1 4120.3 4199.9 4201.7 4204.6 11343.4 11352.1 11353.9 11364.7 11378.2 5192.8 5198.1 5198.8 5212.2 5215.2 4653.5 4676.1 4714.6 4774.9 4812.0 3408.1 3441.7 3445.4 3506.1 3532.6 849.2 854.4 862.2 866.3 868.1 953.7 955.2 958.6 973.4 1003.8 5364.5 6377.6 6378.7 6425.3 6451.7 960.8 987.2 987.2 995.9 1038.0 3805.4 3960.8 4257.4 4267.6 4282.2 12787.6 13380.7 13391.6 13392.0 13430.0 12982.0 13197.4 13217.0 13310.5 13426.9 10010.6 10042.8 10049.3 10056.9 10172.5 5643.3 6507.5 6519.2 6634.1 6705.7 11814.0 12104.3 12107.5 12165.9 12223.7 11945.9 12199.1 12282.1 12306.9 12336.0 6811.9 8512.6 8547.8 8548.6 8570.9 10036.8 10124.3 10136.1 10213.8 10254.7 8496.8 8612.4 8621.8 8827.5 8842.3 8341.9 8443.9 8506.9 8527.0 8561.1 7695.0 7759.4 7786.6 7869.1 7886.2 5812.9 5829.8 5989.9 6008.5 6042.4 5906.1 5958.8 5979.5 5987.7 5997.6 11:28:22 INFO - PROCESS | 1659 | 11:28:22 INFO - PROCESS | 1659 | [#4] prototype.html Cycles:180 Average:4506.01 Median:4901.71 stddev:1228.49 (25.1%) stddev-sans-first:1192.30 11:28:22 INFO - PROCESS | 1659 | Values: 381.9 382.8 383.9 391.4 392.0 4015.8 4528.4 4980.9 5101.3 5118.6 4146.6 4232.8 4347.1 5062.6 5086.1 3881.9 4142.7 4244.9 4267.0 4268.7 3689.0 3832.6 4120.5 4259.7 4275.1 4267.6 4287.5 4300.6 4311.4 4330.8 4105.7 4198.2 4226.7 4290.5 4325.9 3375.4 3914.3 3926.0 3957.3 3995.5 4244.7 4478.2 4902.9 5016.4 5016.7 4162.8 4902.5 4923.1 4944.4 4947.5 4391.8 4407.4 4483.8 5485.2 5488.8 3682.9 3787.8 3897.6 4144.2 4367.3 4547.0 5115.1 5459.7 5605.9 5637.6 3617.1 4341.4 4458.0 4475.9 4478.9 4275.6 4535.4 4548.3 4570.5 4594.6 4878.2 4944.4 4959.3 4984.9 5006.0 4732.5 5145.5 5206.4 5412.1 5581.6 1641.9 1642.7 1704.4 1718.9 1723.7 1343.7 1350.5 1401.8 1407.6 1426.0 4326.4 4535.4 4757.6 4936.8 4950.3 4888.0 4924.6 5202.0 5316.6 5365.9 4489.6 4699.4 4901.0 4925.7 5034.7 2380.3 2644.2 2739.4 2824.9 2989.3 5015.8 5492.3 5645.3 5922.6 5929.8 4463.2 5058.8 5754.7 5779.9 5793.8 5500.2 5704.5 5715.8 5785.6 5884.5 4536.6 5148.5 5275.5 5646.6 5674.9 5339.5 5541.5 5576.8 5614.7 5659.7 5000.2 5107.8 5459.4 5786.9 5787.3 3865.2 3896.4 3906.8 4462.6 4486.5 4999.6 5078.9 5438.8 5614.0 5655.9 4781.9 5436.4 5560.9 5565.7 5593.8 4702.0 4951.9 5451.6 5540.8 5549.6 4825.1 5108.2 5173.9 5353.1 5361.9 5411.6 5448.9 5459.8 5517.4 5572.9 4934.6 5301.7 5342.8 5382.7 5415.8 11:28:22 INFO - PROCESS | 1659 | 11:28:22 INFO - PROCESS | 1659 | [#5] yui.html Cycles:180 Average:20276.69 Median:3226.27 stddev:28553.06 (885.0%) stddev-sans-first:28595.53 11:28:22 INFO - PROCESS | 1659 | Values: 754.1 769.8 781.2 841.1 854.5 15030.4 15679.2 15718.1 15751.1 16875.9 15558.4 15690.5 15701.8 15712.1 15715.6 964.3 987.2 987.9 988.8 995.2 972.4 988.4 994.3 994.8 1001.5 1040.1 1042.8 1044.7 1045.5 1046.4 1035.9 1037.3 1037.8 1038.5 1039.7 776.8 777.0 777.9 780.6 780.8 16300.9 16558.9 16606.3 16795.0 17149.7 12134.6 14002.0 14482.2 14555.3 14664.7 11722.9 11952.7 11969.4 12038.4 12115.9 3652.9 3717.8 3729.8 3747.3 3803.3 103750.0 106503.9 107204.4 108685.0 108811.0 10641.2 10927.6 10938.1 11112.5 11308.8 22256.8 22307.8 22356.9 22540.7 22739.2 7942.0 7961.2 8002.3 8032.8 8032.9 4431.5 4443.2 4493.6 4747.7 4750.4 3196.6 3256.0 3265.6 3300.7 3301.7 613.2 616.9 618.1 633.6 638.4 671.5 705.2 716.6 721.6 724.4 9121.8 9859.5 10324.5 10433.0 10461.4 548.8 580.2 626.6 664.1 719.0 4080.6 4439.2 5102.5 5107.3 5119.4 96783.0 99671.0 100956.0 101280.0 103233.0 77717.0 81125.6 82807.2 84556.6 85756.6 73851.5 76136.0 76808.5 77249.2 78699.2 9835.4 9849.4 9854.0 9858.2 9869.5 47501.8 48987.8 49190.0 50287.7 51318.7 62814.7 63034.4 63700.0 63802.0 65629.0 12402.6 12653.3 12782.9 13053.4 13072.5 14987.7 15070.0 15163.4 15633.9 16048.8 12723.7 12776.8 12931.5 13052.6 13554.3 13656.5 13726.5 14277.8 14349.3 14851.3 13425.0 13931.3 14057.6 14176.3 14570.7 9701.2 9787.4 10021.5 10430.2 10454.8 11189.8 11300.8 11569.6 11874.0 11982.5 11:28:22 INFO - PROCESS | 1659 | -------- Summary: end -------- 11:28:22 INFO - PROCESS | 1659 | 11:28:23 INFO - TEST-INFO | 1659: exit 0 11:28:23 INFO - TEST-OK | dromaeo_css | took 1118874ms 11:28:23 INFO - TEST-START | kraken 11:28:23 INFO - operating with platform_type : mac_ 11:28:23 INFO - Initialising browser for kraken test... 11:28:23 INFO - TEST-INFO | started process 1780 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/tmpq1s0LH/profile http://localhost:49221/getInfo.html) 11:28:25 INFO - PROCESS | 1780 | __metrics Screen width/height:1600/1200 11:28:25 INFO - PROCESS | 1780 | colorDepth:24 11:28:25 INFO - PROCESS | 1780 | Browser inner width/height: 1024/689 11:28:25 INFO - PROCESS | 1780 | __metrics 11:28:25 INFO - PROCESS | 1780 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:28:25 INFO - PROCESS | 1780 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:28:26 INFO - TEST-INFO | 1780: exit 0 11:28:26 INFO - Browser initialized. 11:28:26 INFO - Running cycle 1/1 for kraken test... 11:28:26 INFO - TEST-INFO | started process 1783 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/T/tmpq1s0LH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:28:38 INFO - PROCESS | 1783 | RSS: Main: 193630208 11:28:38 INFO - PROCESS | 1783 | 11:28:41 INFO - PROCESS | 1783 | Cycle 1(1): loaded http://localhost:49221/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49221/tests/kraken/driver.html?testName=audio-beat-detection) 11:28:42 INFO - PROCESS | 1783 | RSS: Main: 244961280 11:28:42 INFO - PROCESS | 1783 | 11:28:44 INFO - PROCESS | 1783 | Cycle 1(1): loaded http://localhost:49221/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49221/tests/kraken/driver.html?testName=audio-dft) 11:28:45 INFO - PROCESS | 1783 | RSS: Main: 260395008 11:28:45 INFO - PROCESS | 1783 | 11:28:48 INFO - PROCESS | 1783 | Cycle 1(1): loaded http://localhost:49221/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49221/tests/kraken/driver.html?testName=audio-fft) 11:28:49 INFO - PROCESS | 1783 | RSS: Main: 356163584 11:28:49 INFO - PROCESS | 1783 | 11:28:51 INFO - PROCESS | 1783 | Cycle 1(1): loaded http://localhost:49221/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49221/tests/kraken/driver.html?testName=audio-oscillator) 11:28:52 INFO - PROCESS | 1783 | RSS: Main: 257572864 11:28:52 INFO - PROCESS | 1783 | 11:28:54 INFO - PROCESS | 1783 | Cycle 1(1): loaded http://localhost:49221/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49221/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:28:54 INFO - PROCESS | 1783 | RSS: Main: 259088384 11:28:54 INFO - PROCESS | 1783 | 11:28:57 INFO - PROCESS | 1783 | Cycle 1(1): loaded http://localhost:49221/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49221/tests/kraken/driver.html?testName=imaging-darkroom) 11:28:58 INFO - PROCESS | 1783 | RSS: Main: 299454464 11:28:58 INFO - PROCESS | 1783 | 11:29:01 INFO - PROCESS | 1783 | Cycle 1(1): loaded http://localhost:49221/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49221/tests/kraken/driver.html?testName=imaging-desaturate) 11:29:01 INFO - PROCESS | 1783 | RSS: Main: 300953600 11:29:01 INFO - PROCESS | 1783 | 11:29:04 INFO - PROCESS | 1783 | Cycle 1(1): loaded http://localhost:49221/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49221/tests/kraken/driver.html?testName=json-parse-financial) 11:29:05 INFO - PROCESS | 1783 | RSS: Main: 299167744 11:29:05 INFO - PROCESS | 1783 | 11:29:06 INFO - PROCESS | 1783 | Cycle 1(1): loaded http://localhost:49221/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49221/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:29:07 INFO - PROCESS | 1783 | RSS: Main: 276955136 11:29:07 INFO - PROCESS | 1783 | 11:29:09 INFO - PROCESS | 1783 | Cycle 1(1): loaded http://localhost:49221/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49221/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:29:10 INFO - PROCESS | 1783 | RSS: Main: 279416832 11:29:10 INFO - PROCESS | 1783 | 11:29:12 INFO - PROCESS | 1783 | Cycle 1(1): loaded http://localhost:49221/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49221/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:29:12 INFO - PROCESS | 1783 | RSS: Main: 282198016 11:29:12 INFO - PROCESS | 1783 | 11:29:15 INFO - PROCESS | 1783 | Cycle 1(1): loaded http://localhost:49221/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49221/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:29:16 INFO - PROCESS | 1783 | RSS: Main: 292921344 11:29:16 INFO - PROCESS | 1783 | 11:29:19 INFO - PROCESS | 1783 | Cycle 1(1): loaded http://localhost:49221/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49221/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:29:20 INFO - PROCESS | 1783 | RSS: Main: 291713024 11:29:20 INFO - PROCESS | 1783 | 11:29:21 INFO - PROCESS | 1783 | Cycle 1(1): loaded http://localhost:49221/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49221/tests/kraken/driver.html?testName=ai-astar) 11:29:21 INFO - PROCESS | 1783 | RSS: Main: 337326080 11:29:21 INFO - PROCESS | 1783 | 11:29:21 INFO - PROCESS | 1783 | __start_tp_report 11:29:21 INFO - PROCESS | 1783 | _x_x_mozilla_page_load 11:29:21 INFO - PROCESS | 1783 | _x_x_mozilla_page_load_details 11:29:21 INFO - PROCESS | 1783 | |i|pagename|runs| 11:29:21 INFO - PROCESS | 1783 | |0;ai-astar;104;115;115;114;115;116;114;115;115;115 11:29:21 INFO - PROCESS | 1783 | |1;audio-beat-detection;137;109;113;175;135;93;93;110;156;135 11:29:21 INFO - PROCESS | 1783 | |2;audio-dft;185;180;185;185;180;183;190;259;224;186 11:29:21 INFO - PROCESS | 1783 | |3;audio-fft;84;61;61;92;60;60;61;60;77;58 11:29:21 INFO - PROCESS | 1783 | |4;audio-oscillator;87;69;86;69;69;68;82;69;68;92 11:29:21 INFO - PROCESS | 1783 | |5;imaging-gaussian-blur;102;105;87;87;86;87;86;87;87;87 11:29:21 INFO - PROCESS | 1783 | |6;imaging-darkroom;134;94;95;98;94;94;94;94;94;93 11:29:21 INFO - PROCESS | 1783 | |7;imaging-desaturate;84;82;84;84;86;84;82;84;85;86 11:29:21 INFO - PROCESS | 1783 | |8;json-parse-financial;63;61;59;60;64;63;63;65;63;63 11:29:21 INFO - PROCESS | 1783 | |9;json-stringify-tinderbox;53;60;66;63;62;58;57;58;59;62 11:29:21 INFO - PROCESS | 1783 | |10;stanford-crypto-aes;87;82;83;85;88;104;98;77;82;83 11:29:21 INFO - PROCESS | 1783 | |11;stanford-crypto-ccm;138;135;136;140;139;150;140;139;232;146 11:29:21 INFO - PROCESS | 1783 | |12;stanford-crypto-pbkdf2;164;162;164;161;167;169;164;163;162;164 11:29:21 INFO - PROCESS | 1783 | |13;stanford-crypto-sha256-iterative;66;65;65;65;65;63;64;64;63;63 11:29:21 INFO - PROCESS | 1783 | __end_tp_report 11:29:21 INFO - PROCESS | 1783 | __start_cc_report 11:29:21 INFO - PROCESS | 1783 | _x_x_mozilla_cycle_collect,2177 11:29:21 INFO - PROCESS | 1783 | __end_cc_report 11:29:21 INFO - PROCESS | 1783 | __startTimestamp1496168961965__endTimestamp 11:29:21 INFO - PROCESS | 1783 | 11:29:21 INFO - PROCESS | 1783 | ------- Summary: start ------- 11:29:21 INFO - PROCESS | 1783 | Number of tests: 14 11:29:21 INFO - PROCESS | 1783 | 11:29:21 INFO - PROCESS | 1783 | [#0] ai-astar Cycles:10 Average:113.80 Median:115.00 stddev:3.49 (3.0%) stddev-sans-first:0.60 11:29:21 INFO - PROCESS | 1783 | Values: 104.0 115.0 115.0 114.0 115.0 116.0 114.0 115.0 115.0 115.0 11:29:21 INFO - PROCESS | 1783 | 11:29:21 INFO - PROCESS | 1783 | [#1] audio-beat-detection Cycles:10 Average:125.60 Median:146.50 stddev:26.82 (18.3%) stddev-sans-first:28.13 11:29:21 INFO - PROCESS | 1783 | Values: 137.0 109.0 113.0 175.0 135.0 93.0 93.0 110.0 156.0 135.0 11:29:21 INFO - PROCESS | 1783 | 11:29:21 INFO - PROCESS | 1783 | [#2] audio-dft Cycles:10 Average:195.70 Median:185.50 stddev:25.67 (13.8%) stddev-sans-first:26.94 11:29:21 INFO - PROCESS | 1783 | Values: 185.0 180.0 185.0 185.0 180.0 183.0 190.0 259.0 224.0 186.0 11:29:21 INFO - PROCESS | 1783 | 11:29:21 INFO - PROCESS | 1783 | [#3] audio-fft Cycles:10 Average:67.40 Median:61.00 stddev:12.24 (20.1%) stddev-sans-first:11.41 11:29:21 INFO - PROCESS | 1783 | Values: 84.0 61.0 61.0 92.0 60.0 60.0 61.0 60.0 77.0 58.0 11:29:21 INFO - PROCESS | 1783 | 11:29:21 INFO - PROCESS | 1783 | [#4] audio-oscillator Cycles:10 Average:75.90 Median:75.50 stddev:9.64 (12.8%) stddev-sans-first:9.35 11:29:21 INFO - PROCESS | 1783 | Values: 87.0 69.0 86.0 69.0 69.0 68.0 82.0 69.0 68.0 92.0 11:29:21 INFO - PROCESS | 1783 | 11:29:21 INFO - PROCESS | 1783 | [#5] imaging-gaussian-blur Cycles:10 Average:90.10 Median:87.00 stddev:7.11 (8.2%) stddev-sans-first:6.10 11:29:21 INFO - PROCESS | 1783 | Values: 102.0 105.0 87.0 87.0 86.0 87.0 86.0 87.0 87.0 87.0 11:29:21 INFO - PROCESS | 1783 | 11:29:21 INFO - PROCESS | 1783 | [#6] imaging-darkroom Cycles:10 Average:98.40 Median:94.00 stddev:12.58 (13.4%) stddev-sans-first:1.42 11:29:21 INFO - PROCESS | 1783 | Values: 134.0 94.0 95.0 98.0 94.0 94.0 94.0 94.0 94.0 93.0 11:29:21 INFO - PROCESS | 1783 | 11:29:21 INFO - PROCESS | 1783 | [#7] imaging-desaturate Cycles:10 Average:84.10 Median:84.00 stddev:1.37 (1.6%) stddev-sans-first:1.45 11:29:21 INFO - PROCESS | 1783 | Values: 84.0 82.0 84.0 84.0 86.0 84.0 82.0 84.0 85.0 86.0 11:29:21 INFO - PROCESS | 1783 | 11:29:21 INFO - PROCESS | 1783 | [#8] json-parse-financial Cycles:10 Average:62.40 Median:63.00 stddev:1.84 (2.9%) stddev-sans-first:1.94 11:29:21 INFO - PROCESS | 1783 | Values: 63.0 61.0 59.0 60.0 64.0 63.0 63.0 65.0 63.0 63.0 11:29:21 INFO - PROCESS | 1783 | 11:29:21 INFO - PROCESS | 1783 | [#9] json-stringify-tinderbox Cycles:10 Average:59.80 Median:61.00 stddev:3.65 (6.0%) stddev-sans-first:2.92 11:29:21 INFO - PROCESS | 1783 | Values: 53.0 60.0 66.0 63.0 62.0 58.0 57.0 58.0 59.0 62.0 11:29:21 INFO - PROCESS | 1783 | 11:29:21 INFO - PROCESS | 1783 | [#10] stanford-crypto-aes Cycles:10 Average:86.90 Median:84.00 stddev:8.14 (9.7%) stddev-sans-first:8.64 11:29:21 INFO - PROCESS | 1783 | Values: 87.0 82.0 83.0 85.0 88.0 104.0 98.0 77.0 82.0 83.0 11:29:21 INFO - PROCESS | 1783 | 11:29:21 INFO - PROCESS | 1783 | [#11] stanford-crypto-ccm Cycles:10 Average:149.50 Median:140.00 stddev:29.33 (21.0%) stddev-sans-first:30.82 11:29:21 INFO - PROCESS | 1783 | Values: 138.0 135.0 136.0 140.0 139.0 150.0 140.0 139.0 232.0 146.0 11:29:21 INFO - PROCESS | 1783 | 11:29:21 INFO - PROCESS | 1783 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.00 Median:164.00 stddev:2.40 (1.5%) stddev-sans-first:2.55 11:29:21 INFO - PROCESS | 1783 | Values: 164.0 162.0 164.0 161.0 167.0 169.0 164.0 163.0 162.0 164.0 11:29:21 INFO - PROCESS | 1783 | 11:29:21 INFO - PROCESS | 1783 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.30 Median:65.00 stddev:1.06 (1.6%) stddev-sans-first:0.93 11:29:21 INFO - PROCESS | 1783 | Values: 66.0 65.0 65.0 65.0 65.0 63.0 64.0 64.0 63.0 63.0 11:29:21 INFO - PROCESS | 1783 | -------- Summary: end -------- 11:29:21 INFO - PROCESS | 1783 | 11:29:22 INFO - TEST-INFO | 1783: exit 0 11:29:22 INFO - TEST-OK | kraken | took 59287ms 11:29:22 INFO - SUITE-END | took 1178s 11:29:23 INFO - Completed test suite (00:19:38) 11:29:23 INFO - javascript benchmark 11:29:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7605.946413437783, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3423.5207071010054, 3433.227523807145, 3442.3459542686905, 3451.981665408705, 3494.14393473599, 5672.574556908227, 5858.238429004229, 5887.0, 5889.587728858976, 5984.521238300937, 5790.797322093727, 5902.232709747726, 5909.054551271797, 5913.763449462027, 5924.792632257871, 4355.390245365644, 5298.947010529884, 5368.8389348319615, 5370.3287089113865, 5391.191321301816, 5267.631265811395, 5272.367315922094, 5276.894462110756, 5446.210299506569, 5460.972695136538, 5373.892522149555, 5381.461853814626, 5397.919031214516, 5398.6220964532495, 5418.512333889949, 5430.15832545956, 5430.619856610039, 5436.40199578048, 5441.183822426668, 5448.291722076125, 5225.399079105913, 5309.283246761676, 5357.919631205535, 5370.167624018283, 5435.565154787608, 5797.043487824504, 5799.420057994209, 5809.041508151192, 5925.229720136398, 5993.640381577119, 6251.843703907393, 6305.117283580303, 6305.495560355161, 6327.8418039548915, 6328.873422531569, 6323.588966717149, 6350.174477317965, 6364.109024736541, 6364.904526432108, 6372.299047104815, 5756.597038207327, 5849.736761845727, 5854.970725146347, 5870.26621672291, 6023.307319658252, 6298.118263443122, 6307.274663413675, 6374.936250637527, 6396.808095757135, 6437.517186211053, 6336.303006669263, 6339.936600633934, 6340.492760579143, 6348.301686814447, 6361.8727625448155, 6270.968645156836, 6321.462675672619, 6334.714937827716, 6343.524235682342, 6343.936560634427, 6225.564210505221, 6252.374762523711, 6259.0924315973925, 6322.652254125976, 6322.810315690536, 6299.96850015747, 6300.369963003663, 6307.463865571386, 6308.337624549448, 6310.684465776692, 4828.589569886529, 4869.586085182728, 4873.6832105913, 4875.414950205998, 4897.706137631753, 4301.247281725686, 4319.719218250803, 4348.326009468537, 4405.801738921757, 4408.581184787504, 5643.068893632505, 5741.913871291934, 5744.080947048452, 5822.097574875901, 5830.2420685310635, 6323.083152942798, 6347.55567110307, 6350.650714210763, 6351.364863513611, 6360.427561519486, 5779.306483222041, 5795.536357091422, 5802.506786923074, 5802.651840889475, 5842.883142337129, 5301.469853014745, 5387.299651045339, 5417.485338892799, 5461.1808228766, 5475.7262136893, 6432.388923052303, 6470.4823614110755, 6493.0, 6493.2857385688485, 6496.480281577368, 6329.936700633119, 6333.113364128933, 6336.081268216175, 6343.0, 6350.460210881942, 6252.374762523711, 6252.437280644764, 6323.399277068671, 6366.745330186926, 6402.647854367868, 6253.937460625518, 6272.905906411499, 6273.874522509615, 6302.5588208826775, 6328.557001009885, 6263.498920086291, 6298.338674439301, 6321.52588555851, 6330.145430367026, 6356.968215158895, 6237.688115594293, 6239.937600623935, 6260.0, 6333.20834895638, 6339.302676705651, 5939.316978547522, 6251.71867265965, 6321.8735625288155, 6348.650824204713, 6351.555391122577, 5935.287765467999, 5998.70006499682, 6048.092786082123, 6197.81406557786, 6211.472024877936, 6163.753449861955, 6186.5360097993735, 6207.534434917489, 6259.749610015549, 6321.905171422341, 6167.259928808392, 6180.938190618036, 6193.0, 6198.783042593487, 6218.751249950133], "value": 5809.702869631001, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [812.9756107316779, 834.0366876257922, 875.7854325690207, 897.7531178925799, 898.2050884966802, 40725.59274407255, 41587.75236742895, 41647.375289370684, 41756.95607609811, 41776.164476710524, 40815.0, 41178.38232426516, 42466.57533424665, 42512.57487425125, 42527.0, 7736.690532378698, 9478.431294122358, 9632.47021413822, 9642.035796420372, 9642.517874106301, 7699.076110866704, 7790.961045194795, 7791.065072191345, 7799.766007019798, 11629.302241865473, 11871.584494542692, 11880.0, 11900.107491938095, 11910.7617847643, 11954.521819127225, 11818.699943006262, 11836.289822610672, 11849.763004739943, 11873.990710789592, 11883.584074557435, 11435.42822858862, 11455.369954652491, 11462.656120316404, 11485.483153258123, 11491.02326302257, 40210.79894600508, 40486.797566011985, 40504.0, 40556.580519681964, 40589.79705101485, 3872.48972900569, 3906.921861562753, 3939.3500072488005, 3970.007498125469, 4004.519457665099, 27875.721242787517, 28329.85835070832, 29757.851210743807, 30472.84763576168, 30540.389192216033, 3071.539269109629, 3171.9207019824457, 3209.5506629071947, 3257.5765150530515, 3309.1561651778884, 362539.18730406446, 365614.0, 366505.0, 366715.0, 366917.0, 42635.786821065696, 43377.783111084245, 52879.73560132175, 52988.205176922376, 53080.73459632677, 46364.768176158905, 49725.25412118821, 60183.69908150519, 61392.0, 61543.0, 14863.479778207711, 14988.175650339117, 14988.47540336083, 15277.38890444392, 15280.159591222367, 12947.482100716054, 12985.28580928039, 13026.739465210832, 13029.283389413673, 13031.934840325737, 13858.0, 13867.653308667364, 13883.097598656055, 13968.790468142986, 13994.16035037901, 6121.673763969663, 6128.3565225651555, 6157.96921015392, 6180.825643127881, 6201.565890387629, 1118.4945721583595, 1153.1005815463784, 1174.371711134556, 1196.1806162778526, 1198.2391181599746, 23970.7602923972, 27275.590866137023, 27454.0, 27585.448291034467, 27708.030218942644, 1078.6925726168004, 1082.929609575375, 1119.121489630636, 1120.506976930148, 1123.8538989931258, 13027.934860325828, 13619.455221791215, 13657.907367410584, 14497.710045799025, 14915.657590816878, 422562.5487490233, 468656.0, 479562.0, 481361.5931920388, 482020.0, 47278.0, 47449.0, 47476.28785568219, 47529.049419011426, 47622.76188619035, 1406.9155850648995, 1409.3657853965756, 1415.900886937925, 1435.6410897275682, 1441.2505497141428, 23369.532609348058, 25045.246832721536, 26996.59505107464, 26999.865000674872, 27136.0, 36150.8192459036, 36318.0, 36337.454938176474, 36447.453288200166, 36528.81735591305, 459904.0, 462263.0, 462373.0, 462798.0, 464397.6780116078, 29169.56245656359, 29576.408471830873, 29997.65010574486, 30029.69970300269, 30050.69949300479, 37919.81040094782, 38170.0, 38596.80701596474, 38716.41925371178, 39091.022724432114, 27076.05233816807, 27567.0, 28269.293267668472, 28435.43129137447, 28502.287442814097, 27719.445611088067, 28522.42955140927, 28658.85670571717, 28801.855990719912, 28850.99021534236, 32060.839695801373, 32156.678433216304, 32179.35641287208, 32717.345653087283, 33072.0, 28354.574681379385, 28530.42939141164, 29002.7099729, 29031.693573789653, 29083.56374654424, 21825.781742182375, 22787.202447914242, 23174.768252317936, 23205.3038408848, 23213.071477140726], "value": 18712.216881682354, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [412.03378078406143, 416.2382839403891, 423.8770756480621, 432.6409080463215, 450.8016472751989, 19652.21391144354, 20974.475638109056, 22210.66683999741, 22242.666360004572, 22372.88813555932, 21809.23667671632, 22453.887730561364, 22473.32580022602, 22822.543549129008, 23169.0, 6713.530052896299, 6913.0, 7061.788146355618, 7116.0, 7136.785896423115, 6824.351686589791, 6898.689558969833, 6912.135983002125, 6913.792586222421, 6980.0, 6618.801435956929, 6889.965550172242, 6944.895826562605, 6971.477139214554, 6971.511994160411, 5673.801416950387, 6815.693293801766, 6867.690953907061, 6896.793096207121, 6901.62041087745, 5098.974505127488, 6731.49513786468, 6732.663366831639, 6749.392554670103, 6750.8312292192595, 27644.30889227765, 27931.86034069837, 28029.85985070082, 28145.57781633277, 28278.293042674097, 3009.653889802657, 3016.9849150754326, 3039.6352437707396, 3076.1848110250803, 3092.3815236952473, 16029.438969636007, 16751.246193921303, 16847.494575162764, 17587.472375828747, 17831.197596108075, 2163.8052575268143, 2179.28185478439, 2182.0835249195375, 2183.8908054597205, 2206.4925067234467, 130457.0, 131775.0, 133299.99999999904, 134555.0, 135585.0, 13021.153625014344, 17102.0, 17984.910075449538, 18941.715874261896, 19035.0, 28886.85556572204, 29127.0, 29273.707262927524, 29351.266218344714, 29452.852735736185, 9689.498127790204, 10169.898301017043, 10176.185905127571, 10187.439690817077, 10298.742531436625, 6931.965340173267, 7041.2748876525575, 8352.454795862785, 8578.742637720878, 8845.292376609985, 7262.673179706926, 8895.911040889509, 9014.63941442348, 9026.232770214605, 9035.509140991662, 3058.602381690366, 3445.534852794891, 3584.766990145632, 3738.383166777451, 3834.7890866002635, 841.4278290762218, 980.2501086668705, 1013.5236438873718, 1021.4382089850552, 1059.3379138038727, 19178.13698383576, 20358.491037724176, 20424.897875510527, 21150.0, 21938.892488660527, 890.412327863607, 910.8341323106434, 1005.4269066631949, 1014.9594016239415, 1020.0870221152176, 6765.627890466071, 6807.285235050347, 6924.861502770017, 7153.964230178815, 7195.92804071963, 728573.0, 788631.0, 798861.0, 814315.0, 834932.0, 170426.0, 171795.14102429408, 172474.0, 174119.0, 178617.0, 1298.8636193199768, 1307.4900788692419, 1330.7804212305055, 1332.240622844969, 1335.0787956310114, 11615.419229038345, 12136.0, 12624.87375126237, 12880.420381082686, 12920.289384083966, 66825.33174668385, 66847.66576167088, 67062.0, 67217.99173012507, 67269.0, 94906.52546737222, 96824.03175968432, 96945.0, 98351.0, 98521.0, 7553.962230189034, 11542.01892839118, 11627.476763545492, 11879.703007424883, 11915.16593838423, 13284.601461956157, 13327.067105302536, 13579.660508486972, 13732.931335343259, 13751.862481375058, 11321.207515473838, 11339.773204536028, 11468.598599048993, 11488.0, 11758.294502329887, 10239.43683097407, 10304.536295866554, 10647.946760266459, 10747.946260268649, 10815.24293299493, 9320.580573874327, 11407.0, 11787.587434439753, 11846.526138954345, 11951.820722689341, 9666.854997174907, 11673.482447281798, 11687.240329378563, 11964.102692297938, 11993.880061199276, 11274.210805243882, 11305.547778088785, 11367.204295699552, 11462.656120316404, 11514.76970460603], "value": 11295.823360099732, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1388.8750012498874, 1579.194610748518, 1584.532562893946, 1608.404890190629, 1616.0949868073878, 10634.78730425391, 10977.83533247002, 10977.83533247002, 10978.12175025998, 11026.338419694825, 10684.78630427393, 10728.892711072887, 10877.891221087786, 10893.07408870245, 11047.0, 2172.4025892879467, 2194.572058448603, 2196.6814811852273, 2198.604251234777, 2200.702905107814, 2199.197292988064, 2256.740474845389, 2268.9092436302612, 2269.0, 2290.450291929933, 2193.1775584155944, 2258.6386178211487, 2269.7616750241236, 2275.7724227577273, 2282.5206706591634, 2207.381933058746, 2232.3191426614794, 2233.8547994380315, 2234.698315727372, 2239.85440946338, 2201.515666553356, 2248.4378905273684, 2252.707148070757, 2255.334676270504, 2256.4246117240164, 10854.24020318578, 10937.070349020343, 10940.945295273472, 10944.781104377947, 10951.671449856518, 5170.663906846081, 5273.367195936474, 5295.391030031518, 5319.946800531984, 5319.9734001330135, 2907.6946920573246, 3065.1724034510557, 3145.5596216529702, 3191.2181515528846, 3216.758743094254, 1096.5230124895695, 1098.6868742408456, 1123.3260043973632, 1132.9376884271362, 1144.4506636814292, 14855.702885942328, 14982.10107393549, 15026.699466010728, 15047.322870470745, 15059.096454212782, 3982.1040265939932, 4120.299549076664, 4199.9370009449885, 4201.7268877522865, 4204.600562946576, 11343.432828358715, 11352.091832653368, 11353.943230283796, 11364.659060228207, 11378.203525753283, 5192.844214673566, 5198.064348417245, 5198.81804136861, 5212.166053431432, 5215.165573508297, 4653.488116307203, 4676.111538807683, 4714.57568818808, 4774.880627984328, 4812.013537224861, 3408.1309266137473, 3441.6558344165383, 3445.448728203475, 3506.1242235404447, 3532.5760908691122, 849.2314455417857, 854.4232642965973, 862.2153840005565, 866.2680035370103, 868.0668281597308, 953.666216824106, 955.1976339874539, 958.6165533786402, 973.3770386952356, 1003.8494225866033, 5364.463553644604, 6377.585456945284, 6378.712957916905, 6425.325340839238, 6451.677416129175, 960.8078384323163, 987.160913223754, 987.195435719886, 995.9103680668775, 1037.9740506487246, 3805.4482100095884, 3960.8415663373144, 4257.40396344512, 4267.5732426757695, 4282.229198744256, 12787.61637150887, 13380.732385352238, 13391.598252052454, 13392.0, 13429.992750543748, 12982.026348023935, 13197.406116724771, 13217.0, 13310.46758129664, 13426.932865335611, 10010.599576016877, 10042.849357259647, 10049.29654924163, 10056.949715251378, 10172.491375431347, 5643.266375371176, 6507.511936604679, 6519.185101862267, 6634.104395906491, 6705.6647167642395, 11814.0, 12104.273743575413, 12107.515699371927, 12165.939170304091, 12223.69440763988, 11945.880541194478, 12199.085068620067, 12282.140250182401, 12306.876931230574, 12336.013118950283, 6811.8978215325815, 8512.616932237941, 8547.829043418973, 8548.572571371282, 8570.914290857012, 10036.799264014824, 10124.34191777532, 10136.138428233682, 10213.846792297973, 10254.692359229235, 8496.830063398822, 8612.397132200937, 8621.82756344857, 8827.514486703036, 8842.336824738299, 8341.916580834113, 8443.873341899754, 8506.872396913928, 8527.0, 8561.10108438605, 7695.038120234971, 7759.379249659901, 7786.610669466618, 7869.095054068626, 7886.211378862068, 5812.854678632899, 5829.76680932758, 5989.910151347646, 6008.459238668541, 6042.395760423922, 5906.114082887601, 5958.76164953397, 5979.461848433488, 5987.700614969322, 5997.580169388276], "value": 4907.33130566517, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.85871227645777, 382.787552908136, 383.9385698288271, 391.4441493079826, 391.9666828319595, 4015.7791321477307, 4528.388667529883, 4980.9252861207115, 5101.285819985205, 5118.5905127589795, 4146.647534959532, 4232.809523571439, 4347.130573885228, 5062.620303477244, 5086.084504789136, 3881.874256465636, 4142.689298302625, 4244.936325955113, 4266.957330426687, 4268.701190916637, 3689.0, 3832.5784163741964, 4120.486503233041, 4259.70182087254, 4275.102228532012, 4267.570363928088, 4287.464066991626, 4300.569943005706, 4311.426329389781, 4330.805113769888, 4105.678295334116, 4198.200628431244, 4226.725262857904, 4290.4636920384955, 4325.891852703692, 3375.362948969748, 3914.3149948759137, 3925.980370098131, 3957.34703773877, 3995.4817169475705, 4244.702870799046, 4478.216312145361, 4902.896848209124, 5016.423111342206, 5016.724080175589, 4162.83348666056, 4902.460729319772, 4923.129210899871, 4944.406671199443, 4947.480514545957, 4391.758453285068, 4407.427034485529, 4483.798229079699, 5485.204645326446, 5488.835334939959, 3682.926341473182, 3787.8484860605818, 3897.5712671606384, 4144.233316836395, 4367.3448982652535, 4546.954530454719, 5115.130427827278, 5459.69971651559, 5605.859853503654, 5637.577181711388, 3617.0957260684827, 4341.392205091227, 4457.955420445819, 4475.932861007088, 4478.9328160076975, 4275.572442755762, 4535.387722657399, 4548.295014272793, 4570.542945705402, 4594.563516465931, 4878.219484882402, 4944.431390390079, 4959.305697202394, 4984.90030199394, 5005.998800239894, 4732.455767586703, 5145.4597267287145, 5206.3752349717515, 5412.104524079598, 5581.553475721932, 1641.9096949667644, 1642.6632540329203, 1704.4290162795603, 1718.905460199676, 1723.7244439114966, 1343.657367371314, 1350.5273154395884, 1401.810755547988, 1407.6480879780056, 1426.0, 4326.4159338489535, 4535.410396648481, 4757.595604373598, 4936.753162341868, 4950.282209079735, 4887.971491830922, 4924.556789888856, 5202.03762303975, 5316.574674026068, 5365.865853353619, 4489.573490518395, 4699.365585645894, 4900.956710713675, 4925.729084900365, 5034.697918124924, 2380.274016425007, 2644.2331723800266, 2739.411026629284, 2824.85875706218, 2989.3274013346822, 5015.849524514198, 5492.286002819608, 5645.322561292671, 5922.644641321534, 5929.822105336847, 4463.152001119777, 5058.772355244023, 5754.712264386764, 5779.913301300484, 5793.754342816231, 5500.202470641814, 5704.516825625285, 5715.828525144169, 5785.623934444247, 5884.529237660977, 4536.642884265554, 5148.4851514848215, 5275.498827611371, 5646.604737668488, 5674.858128546819, 5339.46605339463, 5541.473560011793, 5576.828865938199, 5614.66991198648, 5659.745311460912, 5000.224785329929, 5107.770150343318, 5459.372172200247, 5786.94213057864, 5787.305523337226, 3865.207632435288, 3896.3960586109197, 3906.824192911269, 4462.642988560972, 4486.528914464065, 4999.575036121825, 5078.921078921079, 5438.7762753380175, 5613.971930140323, 5655.858603534944, 4781.928271075867, 5436.429174936575, 5560.860978475571, 5565.721713914207, 5593.846369147988, 4702.0, 4951.900961980812, 5451.618386712892, 5540.75066622011, 5549.612596850788, 4825.083234185494, 5108.182690769459, 5173.896522069463, 5353.0922426628, 5361.865953351197, 5411.594130440154, 5448.945510544844, 5459.798844254257, 5517.420670829505, 5572.903915622096, 4934.605231581537, 5301.655392399482, 5342.839714808562, 5382.650127741685, 5415.83752487426], "value": 4169.653577739797, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [754.121448512483, 769.8113962079287, 781.2109769133177, 841.0790184747701, 854.538549183441, 15030.398784048639, 15679.216039198052, 15718.135502547355, 15751.133687647174, 16875.90306630068, 15558.377664893418, 15690.450834220805, 15701.84298157018, 15712.057276563386, 15715.60710982226, 964.2816102004017, 987.1954357198896, 987.8518222266646, 988.8417853143499, 995.1541189988488, 972.4457059476066, 988.3970777825521, 994.3089552760835, 994.8308787506141, 1001.484235618657, 1040.1107053469289, 1042.8018676451488, 1044.6918159143033, 1045.4563626914, 1046.3878631000835, 1035.8964103589656, 1037.2998226197362, 1037.8495118207893, 1038.5378506564582, 1039.6880935719255, 776.8290975985274, 776.9611519424006, 777.8560966221268, 780.621398621668, 780.8204113053972, 16300.918495407566, 16558.917205414018, 16606.335746570123, 16795.0, 17149.657006859918, 12134.575289864812, 14002.0, 14482.203478808662, 14555.345009474599, 14664.70670586593, 11722.94138529302, 11952.70118247042, 11969.401529923469, 12038.39808009596, 12115.93942030293, 3652.926941461156, 3717.839836139287, 3729.7948612826553, 3747.306748251582, 3803.3344164771056, 103750.0, 106503.93496065018, 107204.39193412106, 108685.0, 108810.99999999921, 10641.201909856636, 10927.617533386294, 10938.070264027647, 11112.499937502831, 11308.830367544493, 22256.777432225794, 22307.77692223057, 22356.888215559142, 22540.66189007166, 22739.204127855446, 7942.0, 7961.164077771867, 8002.319802816709, 8032.759017229492, 8032.919670803334, 4431.512533621363, 4443.200223959719, 4493.618042466362, 4747.667663263538, 4750.358701575243, 3196.5844440222622, 3255.951160732591, 3265.591801024872, 3300.719438847677, 3301.6863397977154, 613.2058983616228, 616.9444749972524, 618.072890664004, 633.5944995203074, 638.4317957018258, 671.4762485261504, 705.2418649951322, 716.6130289643638, 721.6253037962689, 724.3788203540563, 9121.817563648823, 9859.457729824928, 10324.535395907202, 10433.0, 10461.372317660966, 548.8353493951878, 580.179046648987, 626.614632001316, 664.1333060356282, 718.989215161773, 4080.571539988318, 4439.169964595915, 5102.4897510248675, 5107.259447380109, 5119.411267704188, 96783.0, 99671.0, 100955.99044009612, 101280.0, 103233.0, 77717.0, 81125.59437202894, 82807.17192827995, 84556.57721711352, 85756.57121714352, 73851.52296954139, 76136.0, 76808.46383072308, 77249.22750772645, 78699.21300786918, 9835.409875407498, 9849.359791613522, 9854.0, 9858.211343092393, 9869.506524673881, 47501.76249118732, 48987.75506122447, 49190.0, 50287.74856125696, 51318.7170320745, 62814.68592657008, 63034.424139396884, 63700.0, 63802.0, 65629.0, 12402.5659101931, 12653.304068276333, 12782.872171278541, 13053.412596432994, 13072.542461013818, 14987.700245995236, 15070.0, 15163.393464261748, 15633.921830390775, 16048.839511604734, 12723.745525089631, 12776.808347874976, 12931.5473958411, 13052.608421747364, 13554.254516001714, 13656.453741850612, 13726.478914023599, 14277.785833212718, 14349.282535872955, 14851.331690073757, 13425.0, 13931.30343482842, 14057.578272651837, 14176.291185440481, 14570.708585828012, 9701.223902087957, 9787.36382135159, 10021.498925053864, 10430.16558675289, 10454.843177352497, 11189.832152517556, 11300.83048754253, 11569.595064172714, 11873.99071078968, 11982.520699171935], "value": 7704.3203037024, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1437.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 115.0, 115.0, 114.0, 115.0, 116.0, 114.0, 115.0, 115.0, 115.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 109.0, 113.0, 175.0, 135.0, 93.0, 93.0, 110.0, 156.0, 135.0], "value": 125.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 180.0, 185.0, 185.0, 180.0, 183.0, 190.0, 259.0, 224.0, 186.0], "value": 195.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 61.0, 61.0, 92.0, 60.0, 60.0, 61.0, 60.0, 77.0, 58.0], "value": 67.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 69.0, 86.0, 69.0, 69.0, 68.0, 82.0, 69.0, 68.0, 92.0], "value": 75.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 105.0, 87.0, 87.0, 86.0, 87.0, 86.0, 87.0, 87.0, 87.0], "value": 90.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 94.0, 95.0, 98.0, 94.0, 94.0, 94.0, 94.0, 94.0, 93.0], "value": 98.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 84.0, 84.0, 86.0, 84.0, 82.0, 84.0, 85.0, 86.0], "value": 84.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 59.0, 60.0, 64.0, 63.0, 63.0, 65.0, 63.0, 63.0], "value": 62.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 60.0, 66.0, 63.0, 62.0, 58.0, 57.0, 58.0, 59.0, 62.0], "value": 59.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 82.0, 83.0, 85.0, 88.0, 104.0, 98.0, 77.0, 82.0, 83.0], "value": 86.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 135.0, 136.0, 140.0, 139.0, 150.0, 140.0, 139.0, 232.0, 146.0], "value": 149.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 164.0, 161.0, 167.0, 169.0, 164.0, 163.0, 162.0, 164.0], "value": 164.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 65.0, 65.0, 63.0, 64.0, 64.0, 63.0, 63.0], "value": 64.3, "unit": "score"}]}]} 11:29:23 INFO - Return code: 0 11:29:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:29:23 INFO - # TBPL SUCCESS # 11:29:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:29:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:29:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:29:23 INFO - 2017-05-30 11:29:23.279 screenresolution[1792:9933] starting screenresolution argv=screenresolution get 11:29:23 INFO - 2017-05-30 11:29:23.282 screenresolution[1792:9933] Display 0: 1600x1200x32@60 11:29:23 INFO - 2017-05-30 11:29:23.288 screenresolution[1793:9936] starting screenresolution argv=screenresolution list 11:29:23 INFO - Available Modes on Display 0 11:29:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:29:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:29:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:29:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:29:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:29:23 INFO - Intel Iris: 11:29:23 INFO - Chipset Model: Intel Iris 11:29:23 INFO - Type: GPU 11:29:23 INFO - Bus: Built-In 11:29:23 INFO - VRAM (Dynamic, Max): 1536 MB 11:29:23 INFO - Vendor: Intel (0x8086) 11:29:23 INFO - Device ID: 0x0a2e 11:29:23 INFO - Revision ID: 0x0009 11:29:23 INFO - Displays: 11:29:23 INFO - Display: 11:29:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:29:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:29:23 INFO - Display Serial Number: 1600x1200 60 11:29:23 INFO - Main Display: Yes 11:29:23 INFO - Mirror: Off 11:29:23 INFO - Online: Yes 11:29:23 INFO - Rotation: Supported 11:29:23 INFO - Return code: 0 11:29:23 INFO - Running post-action listener: _resource_record_post_action 11:29:23 INFO - [mozharness: 2017-05-30 18:29:23.521623Z] Finished run-tests step (success) 11:29:23 INFO - Running post-run listener: _resource_record_post_run 11:29:23 INFO - Total resource usage - Wall time: 1199s; CPU: 54.0%; Read bytes: 39265280; Write bytes: 513753088; Read time: 251; Write time: 1610 11:29:23 INFO - TinderboxPrint: CPU usage
53.8% 11:29:23 INFO - TinderboxPrint: I/O read bytes / time
39,265,280 / 251 11:29:23 INFO - TinderboxPrint: I/O write bytes / time
513,753,088 / 1,610 11:29:23 INFO - TinderboxPrint: CPU idle
2,215.4 (46.2%) 11:29:23 INFO - TinderboxPrint: CPU system
955.5 (19.9%) 11:29:23 INFO - TinderboxPrint: CPU user
1,626.7 (33.9%) 11:29:23 INFO - TinderboxPrint: Swap in / out
247,349,248 / 0 11:29:23 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 206338560; Write bytes: 202778624; Read time: 15762; Write time: 421 11:29:23 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 37151744; Write bytes: 299902976; Read time: 232; Write time: 1152 11:29:23 INFO - Running post-run listener: _upload_blobber_files 11:29:23 INFO - Blob upload gear active. 11:29:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:29: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 11:29: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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:29: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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:29:24 INFO - (blobuploader) - INFO - Open directory for files ... 11:29:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:29:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:29:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:29:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:29:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:29:25 INFO - (blobuploader) - INFO - Done attempting. 11:29:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:29:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:29:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:29:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:29:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:29:26 INFO - (blobuploader) - INFO - Done attempting. 11:29:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:29:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:29:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:29:27 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:29:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:29:27 INFO - (blobuploader) - INFO - Done attempting. 11:29:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:29:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:29:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:29:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:29:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:29:29 INFO - (blobuploader) - INFO - Done attempting. 11:29:29 INFO - (blobuploader) - INFO - Iteration through files over. 11:29:29 INFO - Return code: 0 11:29:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:29:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:29:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7865723f82c00064f91dcd3cbc8e692e7499468b1f645641079f17cbb9e7e9f9fe341dce75cdfd8fd7444e0c988284d5cf9621a5a4e33c3449afdc08713814c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bb3d4794b39357628f080e10327c0601b72bd4224388bcb2bcc4907a376c54dc06cd8e25a9491525de72fe7893e08e8cca4826ddc4f4526079438fbf6dc5d3dc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c17761669e5ab67414d2951be9911d2222a8fcc6ba71846bab0e0ac13bc6e7b45304415ad198ae6b9f57617a1bf6e18a79b7acff87b207a7da19e99ac0076f27", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f38409755fcffba9399bad56d5e29b44c2736c2c0de46acfab58db4503b195f031e6249fb9f94f6199f032c6d5ab3a8dc57ec818c2c307158178b08f3846c337"} 11:29:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:29:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:29:29 INFO - Contents: 11:29:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7865723f82c00064f91dcd3cbc8e692e7499468b1f645641079f17cbb9e7e9f9fe341dce75cdfd8fd7444e0c988284d5cf9621a5a4e33c3449afdc08713814c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bb3d4794b39357628f080e10327c0601b72bd4224388bcb2bcc4907a376c54dc06cd8e25a9491525de72fe7893e08e8cca4826ddc4f4526079438fbf6dc5d3dc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c17761669e5ab67414d2951be9911d2222a8fcc6ba71846bab0e0ac13bc6e7b45304415ad198ae6b9f57617a1bf6e18a79b7acff87b207a7da19e99ac0076f27", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f38409755fcffba9399bad56d5e29b44c2736c2c0de46acfab58db4503b195f031e6249fb9f94f6199f032c6d5ab3a8dc57ec818c2c307158178b08f3846c337"} 11:29:29 INFO - Running post-run listener: copy_logs_to_upload_dir 11:29:29 INFO - Copying logs to upload dir... 11:29:29 INFO - mkdir: /builds/slave/test/build/upload/logs 11:29:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.931755 ========= master_lag: -0.14 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2017-05-30 11:29:29.521766) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-30 11:29:29.525452) ========= 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.tC15EtIDol/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.KhDDQXCiZl/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7865723f82c00064f91dcd3cbc8e692e7499468b1f645641079f17cbb9e7e9f9fe341dce75cdfd8fd7444e0c988284d5cf9621a5a4e33c3449afdc08713814c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bb3d4794b39357628f080e10327c0601b72bd4224388bcb2bcc4907a376c54dc06cd8e25a9491525de72fe7893e08e8cca4826ddc4f4526079438fbf6dc5d3dc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c17761669e5ab67414d2951be9911d2222a8fcc6ba71846bab0e0ac13bc6e7b45304415ad198ae6b9f57617a1bf6e18a79b7acff87b207a7da19e99ac0076f27", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f38409755fcffba9399bad56d5e29b44c2736c2c0de46acfab58db4503b195f031e6249fb9f94f6199f032c6d5ab3a8dc57ec818c2c307158178b08f3846c337"} build_url:https://queue.taskcluster.net/v1/task/THh22lUMT7q6VthAu3WBkg/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011094 build_url: 'https://queue.taskcluster.net/v1/task/THh22lUMT7q6VthAu3WBkg/artifacts/public/build/firefox-54.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7865723f82c00064f91dcd3cbc8e692e7499468b1f645641079f17cbb9e7e9f9fe341dce75cdfd8fd7444e0c988284d5cf9621a5a4e33c3449afdc08713814c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bb3d4794b39357628f080e10327c0601b72bd4224388bcb2bcc4907a376c54dc06cd8e25a9491525de72fe7893e08e8cca4826ddc4f4526079438fbf6dc5d3dc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c17761669e5ab67414d2951be9911d2222a8fcc6ba71846bab0e0ac13bc6e7b45304415ad198ae6b9f57617a1bf6e18a79b7acff87b207a7da19e99ac0076f27", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f38409755fcffba9399bad56d5e29b44c2736c2c0de46acfab58db4503b195f031e6249fb9f94f6199f032c6d5ab3a8dc57ec818c2c307158178b08f3846c337"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-30 11:29:29.563386) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 11:29:29.563881) ========= 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.tC15EtIDol/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.KhDDQXCiZl/Listeners TMPDIR=/var/folders/gt/gzllwlfx58vgtmvns94gtby000000w/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.005154 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 11:29:29.612428) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-30 11:29:29.612979) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-30 11:29:29.613577) ========= ========= Total master_lag: 0.62 =========