builder: mozilla-beta_yosemite_r7_devedition_test-dromaeojs slave: t-yosemite-r7-0191 starttime: 1496913187.0 results: success (0) buildid: 20170608011525 builduid: 808df44897e6480c95c84513207ff0f4 revision: 2125aa846c90398be9d3b6c01ff48de8265aeba3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-08 02:13:06.997724) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-08 02:13:06.998238) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-08 02:13:06.998558) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-08 02:13:07.036746) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-08 02:13:07.037084) ========= 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.97uYPuZVzx/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.m6fZ8wET5b/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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-06-08 02:13:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.76M=0.001s 2017-06-08 02:13:07 (7.76 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.487600 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-08 02:13:07.547623) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-08 02:13:07.547989) ========= 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.97uYPuZVzx/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.m6fZ8wET5b/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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.021309 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-08 02:13:07.597321) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-08 02:13:07.597725) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 2125aa846c90398be9d3b6c01ff48de8265aeba3 --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 2125aa846c90398be9d3b6c01ff48de8265aeba3 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.97uYPuZVzx/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.m6fZ8wET5b/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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-06-08 02:13:07,676 truncating revision to first 12 chars 2017-06-08 02:13:07,676 Setting DEBUG logging. 2017-06-08 02:13:07,676 attempt 1/10 2017-06-08 02:13:07,676 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/2125aa846c90?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-08 02:13:09,142 unpacking tar archive at: mozilla-beta-2125aa846c90/testing/mozharness/ program finished with exit code 0 elapsedTime=1.724146 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-08 02:13:09.342978) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-08 02:13:09.343323) ========= script_repo_revision: 2125aa846c90398be9d3b6c01ff48de8265aeba3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-08 02:13:09.343703) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-08 02:13:09.343979) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-08 02:13:09.361266) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2017-06-08 02:13:09.361643) ========= /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.97uYPuZVzx/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.m6fZ8wET5b/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 02:13:09 INFO - MultiFileLogger online at 20170608 02:13:09 in /builds/slave/test 02:13:09 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 02:13:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:13:09 INFO - {'append_to_log': False, 02:13:09 INFO - 'base_work_dir': '/builds/slave/test', 02:13:09 INFO - 'blob_upload_branch': 'Mozilla-Beta', 02:13:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:13:09 INFO - 'branch': 'Mozilla-Beta', 02:13:09 INFO - 'buildbot_json_path': 'buildprops.json', 02:13:09 INFO - 'config_files': ('talos/mac_config.py',), 02:13:09 INFO - 'default_actions': ('clobber', 02:13:09 INFO - 'read-buildbot-config', 02:13:09 INFO - 'download-and-extract', 02:13:09 INFO - 'populate-webroot', 02:13:09 INFO - 'create-virtualenv', 02:13:09 INFO - 'install', 02:13:09 INFO - 'run-tests'), 02:13:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:13:09 INFO - 'download_minidump_stackwalk': True, 02:13:09 INFO - 'download_symbols': 'ondemand', 02:13:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:13:09 INFO - 'tooltool.py': '/tools/tooltool.py', 02:13:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:13:09 INFO - '/tools/misc-python/virtualenv.py')}, 02:13:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:13:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:13:09 INFO - 'gecko_profile': False, 02:13:09 INFO - 'gecko_profile_interval': 0, 02:13:09 INFO - 'installer_path': 'installer.exe', 02:13:09 INFO - 'log_level': 'info', 02:13:09 INFO - 'log_name': 'talos', 02:13:09 INFO - 'log_to_console': True, 02:13:09 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:13:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:13:09 INFO - 'opt_config_files': (), 02:13:09 INFO - 'pip_index': False, 02:13:09 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:13:09 INFO - 'cmd': ('bash', 02:13:09 INFO - '-c', 02:13:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:13:09 INFO - 'enabled': True, 02:13:09 INFO - 'halt_on_failure': False, 02:13:09 INFO - 'name': 'check_screen_resolution'},), 02:13:09 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:13:09 INFO - 'cmd': ('bash', 02:13:09 INFO - '-c', 02:13:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:13:09 INFO - 'enabled': True, 02:13:09 INFO - 'halt_on_failure': False, 02:13:09 INFO - 'name': 'check_screen_resolution'},), 02:13:09 INFO - 'run_cmd_checks_enabled': True, 02:13:09 INFO - 'suite': 'dromaeojs', 02:13:09 INFO - 'system_bits': '32', 02:13:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:13:09 INFO - 'title': 't-yosemite-r7-0191', 02:13:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:13:09 INFO - 'use_talos_json': True, 02:13:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:13:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:13:09 INFO - 'work_dir': 'build'} 02:13:09 INFO - [mozharness: 2017-06-08 09:13:09.551269Z] Running clobber step. 02:13:09 INFO - Running pre-action listener: _resource_record_pre_action 02:13:09 INFO - Running main action method: clobber 02:13:09 INFO - rmtree: /builds/slave/test/build 02:13:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:13:10 INFO - Running post-action listener: _resource_record_post_action 02:13:10 INFO - [mozharness: 2017-06-08 09:13:10.242849Z] Finished clobber step (success) 02:13:10 INFO - [mozharness: 2017-06-08 09:13:10.243001Z] Running read-buildbot-config step. 02:13:10 INFO - Running pre-action listener: _resource_record_pre_action 02:13:10 INFO - Running main action method: read_buildbot_config 02:13:10 INFO - Using buildbot properties: 02:13:10 INFO - { 02:13:10 INFO - "project": "", 02:13:10 INFO - "product": "firefox", 02:13:10 INFO - "script_repo_revision": "production", 02:13:10 INFO - "builddir": "mozilla-beta_yosemite_r7_devedition_test-dromaeojs", 02:13:10 INFO - "repository": "", 02:13:10 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 DevEdition mozilla-beta talos dromaeojs", 02:13:10 INFO - "buildid": "20170608011525", 02:13:10 INFO - "pgo_build": "False", 02:13:10 INFO - "basedir": "/builds/slave/test", 02:13:10 INFO - "buildnumber": 1, 02:13:10 INFO - "slavename": "t-yosemite-r7-0191", 02:13:10 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 02:13:10 INFO - "platform": "yosemite_r7_devedition", 02:13:10 INFO - "scheduler": "tests-mozilla-beta-macosx64-devedition-talos", 02:13:10 INFO - "branch": "mozilla-beta", 02:13:10 INFO - "repo_path": "releases/mozilla-beta", 02:13:10 INFO - "revision": "2125aa846c90398be9d3b6c01ff48de8265aeba3", 02:13:10 INFO - "stage_platform": "macosx64-devedition", 02:13:10 INFO - "builduid": "808df44897e6480c95c84513207ff0f4", 02:13:10 INFO - "slavebuilddir": "test" 02:13:10 INFO - } 02:13:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/PciA_TQOQl-ieW8oGe_nrA/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 02:13:10 INFO - Running post-action listener: _resource_record_post_action 02:13:10 INFO - [mozharness: 2017-06-08 09:13:10.246307Z] Finished read-buildbot-config step (success) 02:13:10 INFO - [mozharness: 2017-06-08 09:13:10.246420Z] Running download-and-extract step. 02:13:10 INFO - Running pre-action listener: _resource_record_pre_action 02:13:10 INFO - Running main action method: download_and_extract 02:13:10 INFO - mkdir: /builds/slave/test/build/tests 02:13: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')]} 02:13:10 INFO - trying https://queue.taskcluster.net/v1/task/PciA_TQOQl-ieW8oGe_nrA/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 02:13:10 INFO - Downloading https://queue.taskcluster.net/v1/task/PciA_TQOQl-ieW8oGe_nrA/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 02:13:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PciA_TQOQl-ieW8oGe_nrA/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 02:13:11 INFO - Downloaded 1287 bytes. 02:13:11 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 02:13:11 INFO - Using the following test package requirements: 02:13:11 INFO - {u'awsy': [u'firefox-54.0.en-US.mac.common.tests.zip', 02:13:11 INFO - u'firefox-54.0.en-US.mac.awsy.tests.zip'], 02:13:11 INFO - u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 02:13:11 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 02:13:11 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 02:13:11 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 02:13:11 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 02:13:11 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 02:13:11 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 02:13:11 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 02:13:11 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 02:13:11 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 02:13:11 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 02:13:11 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 02:13:11 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 02:13:11 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 02:13:11 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 02:13:11 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 02:13:11 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 02:13:11 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 02:13:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PciA_TQOQl-ieW8oGe_nrA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 02:13:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PciA_TQOQl-ieW8oGe_nrA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 02:13:11 INFO - Fetch https://queue.taskcluster.net/v1/task/PciA_TQOQl-ieW8oGe_nrA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 02:13:13 INFO - Expected file size: 51965551 02:13:13 INFO - Obtained file size: 51965551 02:13:30 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 02:13:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PciA_TQOQl-ieW8oGe_nrA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 02:13:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PciA_TQOQl-ieW8oGe_nrA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 02:13:30 INFO - Fetch https://queue.taskcluster.net/v1/task/PciA_TQOQl-ieW8oGe_nrA/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 02:13:31 INFO - Expected file size: 51965551 02:13:31 INFO - Obtained file size: 51965551 02:13:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PciA_TQOQl-ieW8oGe_nrA/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 02:13:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PciA_TQOQl-ieW8oGe_nrA/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 02:13:47 INFO - Fetch https://queue.taskcluster.net/v1/task/PciA_TQOQl-ieW8oGe_nrA/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 02:13:47 INFO - Expected file size: 14404461 02:13:47 INFO - Obtained file size: 14404461 02:13:48 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')]} 02:13:48 INFO - trying https://queue.taskcluster.net/v1/task/PciA_TQOQl-ieW8oGe_nrA/artifacts/public/build/firefox-54.0.en-US.mac.dmg 02:13:48 INFO - Downloading https://queue.taskcluster.net/v1/task/PciA_TQOQl-ieW8oGe_nrA/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 02:13:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PciA_TQOQl-ieW8oGe_nrA/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 02:13:50 INFO - Downloaded 74885757 bytes. 02:13:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PciA_TQOQl-ieW8oGe_nrA/artifacts/public/build/firefox-54.0.en-US.mac.dmg 02:13:50 INFO - mkdir: /builds/slave/test/properties 02:13:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:13:50 INFO - Writing to file /builds/slave/test/properties/build_url 02:13:50 INFO - Contents: 02:13:50 INFO - build_url:https://queue.taskcluster.net/v1/task/PciA_TQOQl-ieW8oGe_nrA/artifacts/public/build/firefox-54.0.en-US.mac.dmg 02:13:51 INFO - Running post-action listener: _resource_record_post_action 02:13:51 INFO - Running post-action listener: set_extra_try_arguments 02:13:51 INFO - [mozharness: 2017-06-08 09:13:51.204306Z] Finished download-and-extract step (success) 02:13:51 INFO - [mozharness: 2017-06-08 09:13:51.204430Z] Running populate-webroot step. 02:13:51 INFO - Running pre-action listener: _resource_record_pre_action 02:13:51 INFO - Running main action method: populate_webroot 02:13:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:13:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:13:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:13:51 INFO - '--tppagecycles', 02:13:51 INFO - '7'], 02:13:51 INFO - 'tests': ['tsvgm']}}, 02:13:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:13:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:13:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:13:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:13:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:13:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:13:51 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:13:51 INFO - 'talos_options': ['--disable-e10s'], 02:13:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:13:51 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:13:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:13:51 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:13:51 INFO - 'talos_options': ['--disable-e10s'], 02:13:51 INFO - 'tests': ['damp', 'tps']}, 02:13:51 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:13:51 INFO - 'tests': ['damp', 'tps']}, 02:13:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:13:51 INFO - 'tests': ['dromaeo_dom']}, 02:13:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:13:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:13:51 INFO - 'tests': ['basic_compositor_video']}, 02:13:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:13:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:13:51 INFO - 'tests': ['a11yr', 02:13:51 INFO - 'ts_paint', 02:13:51 INFO - 'tpaint', 02:13:51 INFO - 'sessionrestore', 02:13:51 INFO - 'sessionrestore_no_auto_restore', 02:13:51 INFO - 'tabpaint']}, 02:13:51 INFO - 'other-e10s': {'tests': ['a11yr', 02:13:51 INFO - 'ts_paint', 02:13:51 INFO - 'tpaint', 02:13:51 INFO - 'sessionrestore', 02:13:51 INFO - 'sessionrestore_no_auto_restore', 02:13:51 INFO - 'tabpaint']}, 02:13:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:13:51 INFO - 'ts_paint', 02:13:51 INFO - 'tpaint', 02:13:51 INFO - 'sessionrestore', 02:13:51 INFO - 'sessionrestore_no_auto_restore', 02:13:51 INFO - 'tabpaint']}, 02:13:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:13:51 INFO - 'ts_paint', 02:13:51 INFO - 'tpaint', 02:13:51 INFO - 'sessionrestore', 02:13:51 INFO - 'sessionrestore_no_auto_restore', 02:13:51 INFO - 'tabpaint']}, 02:13:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:13:51 INFO - 'tests': ['a11yr', 02:13:51 INFO - 'ts_paint', 02:13:51 INFO - 'tpaint', 02:13:51 INFO - 'sessionrestore', 02:13:51 INFO - 'sessionrestore_no_auto_restore', 02:13:51 INFO - 'tabpaint']}, 02:13:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:13:51 INFO - 'tests': ['a11yr', 02:13:51 INFO - 'ts_paint', 02:13:51 INFO - 'tpaint', 02:13:51 INFO - 'sessionrestore', 02:13:51 INFO - 'sessionrestore_no_auto_restore', 02:13:51 INFO - 'tabpaint']}, 02:13:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:13:51 INFO - 'tests': ['tsvgx', 02:13:51 INFO - 'tsvgr_opacity', 02:13:51 INFO - 'tart', 02:13:51 INFO - 'tscrollx', 02:13:51 INFO - 'cart', 02:13:51 INFO - 'tsvg_static']}, 02:13:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:13:51 INFO - 'tsvgr_opacity', 02:13:51 INFO - 'tart', 02:13:51 INFO - 'tscrollx', 02:13:51 INFO - 'cart', 02:13:51 INFO - 'tsvg_static']}, 02:13:51 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:13:51 INFO - 'talos_options': ['--disable-e10s'], 02:13:51 INFO - 'tests': ['tp5o']}, 02:13:51 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:13:51 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:13:51 INFO - 'talos_options': ['--disable-e10s', 02:13:51 INFO - '--xperf_path', 02:13:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:13:51 INFO - 'tests': ['tp5n']}, 02:13:51 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:13:51 INFO - 'talos_options': ['--xperf_path', 02:13:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:13:51 INFO - 'tests': ['tp5n']}}, 02:13:51 INFO - 'talos.zip': {'path': '', 02:13:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:13:51 INFO - Running post-action listener: _resource_record_post_action 02:13:51 INFO - [mozharness: 2017-06-08 09:13:51.223005Z] Finished populate-webroot step (success) 02:13:51 INFO - [mozharness: 2017-06-08 09:13:51.223136Z] Running create-virtualenv step. 02:13:51 INFO - Running pre-action listener: _resource_record_pre_action 02:13:51 INFO - Running main action method: create_virtualenv 02:13:51 INFO - Creating virtualenv /builds/slave/test/build/venv 02:13:51 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:13:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:13:51 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 02:13:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:13:51 INFO - Using real prefix '/tools/python27' 02:13:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:13:52 INFO - Installing distribute.............................................................................................................................................................................................done. 02:13:54 INFO - Installing pip.................done. 02:13:54 INFO - Return code: 0 02:13:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:13:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:13:55 INFO - Reading from file tmpfile_stdout 02:13:55 INFO - Output received: 02:13:55 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 02:13:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:13:55 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')]} 02:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:55 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')]} 02:13:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:55 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 0x109825b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109828768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb091496550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109603d30>, '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 0x10952adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095f8be8>, '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.97uYPuZVzx/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.m6fZ8wET5b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:13:55 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 02:13:55 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 02:13:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.97uYPuZVzx/Render', 02:13:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:13:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:13:55 INFO - 'HOME': '/Users/cltbld', 02:13:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:13:55 INFO - 'LOGNAME': 'cltbld', 02:13:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:55 INFO - 'MOZ_NO_REMOTE': '1', 02:13:55 INFO - 'NO_EM_RESTART': '1', 02:13:55 INFO - 'PAGER': '/bin/cat', 02:13:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:13:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:55 INFO - 'PWD': '/builds/slave/test', 02:13:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:13:55 INFO - 'SHELL': '/bin/bash', 02:13:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m6fZ8wET5b/Listeners', 02:13:55 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 02:13:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:13:55 INFO - 'USER': 'cltbld', 02:13:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:13:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:13:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:55 INFO - 'XPC_FLAGS': '0x0', 02:13:55 INFO - 'XPC_SERVICE_NAME': '0', 02:13:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:13:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:55 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:13:55 INFO - Cleaning up... 02:13:55 INFO - Return code: 0 02:13:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:13:55 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')]} 02:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:55 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')]} 02:13:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:55 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 0x109825b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109828768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb091496550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109603d30>, '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 0x10952adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095f8be8>, '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.97uYPuZVzx/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.m6fZ8wET5b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:13:55 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 02:13:55 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 02:13:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.97uYPuZVzx/Render', 02:13:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:13:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:13:55 INFO - 'HOME': '/Users/cltbld', 02:13:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:13:55 INFO - 'LOGNAME': 'cltbld', 02:13:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:55 INFO - 'MOZ_NO_REMOTE': '1', 02:13:55 INFO - 'NO_EM_RESTART': '1', 02:13:55 INFO - 'PAGER': '/bin/cat', 02:13:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:13:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:55 INFO - 'PWD': '/builds/slave/test', 02:13:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:13:55 INFO - 'SHELL': '/bin/bash', 02:13:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m6fZ8wET5b/Listeners', 02:13:55 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 02:13:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:13:55 INFO - 'USER': 'cltbld', 02:13:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:13:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:13:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:55 INFO - 'XPC_FLAGS': '0x0', 02:13:55 INFO - 'XPC_SERVICE_NAME': '0', 02:13:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:13:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:55 INFO - Downloading/unpacking psutil>=3.1.1 02:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:13:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:13:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:13:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:13:58 INFO - Installing collected packages: psutil 02:13:58 INFO - Running setup.py install for psutil 02:13:58 INFO - building 'psutil._psutil_osx' extension 02:13:58 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 02:13:58 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 02:13:58 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 02:13:58 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 02:13:58 INFO - building 'psutil._psutil_posix' extension 02:13:58 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 02:13:58 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:13:58 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:13:58 INFO - ^ 02:13:58 INFO - 1 warning generated. 02:13:58 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 02:13:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:13:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:13:58 INFO - Successfully installed psutil 02:13:58 INFO - Cleaning up... 02:13:58 INFO - Return code: 0 02:13:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:13:58 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')]} 02:13:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:58 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')]} 02:13:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x109825b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109828768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb091496550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109603d30>, '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 0x10952adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095f8be8>, '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.97uYPuZVzx/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.m6fZ8wET5b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:13:58 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 02:13:58 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 02:13:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.97uYPuZVzx/Render', 02:13:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:13:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:13:58 INFO - 'HOME': '/Users/cltbld', 02:13:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:13:58 INFO - 'LOGNAME': 'cltbld', 02:13:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:58 INFO - 'MOZ_NO_REMOTE': '1', 02:13:58 INFO - 'NO_EM_RESTART': '1', 02:13:58 INFO - 'PAGER': '/bin/cat', 02:13:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:13:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:58 INFO - 'PWD': '/builds/slave/test', 02:13:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:13:58 INFO - 'SHELL': '/bin/bash', 02:13:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m6fZ8wET5b/Listeners', 02:13:58 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 02:13:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:13:58 INFO - 'USER': 'cltbld', 02:13:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:13:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:13:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:58 INFO - 'XPC_FLAGS': '0x0', 02:13:58 INFO - 'XPC_SERVICE_NAME': '0', 02:13:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:13:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:14:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:14:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:14:00 INFO - Installing collected packages: mozsystemmonitor 02:14:00 INFO - Running setup.py install for mozsystemmonitor 02:14:00 INFO - Successfully installed mozsystemmonitor 02:14:00 INFO - Cleaning up... 02:14:00 INFO - Return code: 0 02:14:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:14:00 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')]} 02:14:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:00 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')]} 02:14:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:00 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 0x109825b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109828768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb091496550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109603d30>, '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 0x10952adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095f8be8>, '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.97uYPuZVzx/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.m6fZ8wET5b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:14:00 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 02:14:00 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 02:14:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.97uYPuZVzx/Render', 02:14:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:14:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:14:00 INFO - 'HOME': '/Users/cltbld', 02:14:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:14:00 INFO - 'LOGNAME': 'cltbld', 02:14:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:00 INFO - 'MOZ_NO_REMOTE': '1', 02:14:00 INFO - 'NO_EM_RESTART': '1', 02:14:00 INFO - 'PAGER': '/bin/cat', 02:14:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:14:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:00 INFO - 'PWD': '/builds/slave/test', 02:14:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:14:00 INFO - 'SHELL': '/bin/bash', 02:14:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m6fZ8wET5b/Listeners', 02:14:00 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 02:14:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:14:00 INFO - 'USER': 'cltbld', 02:14:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:14:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:14:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:00 INFO - 'XPC_FLAGS': '0x0', 02:14:00 INFO - 'XPC_SERVICE_NAME': '0', 02:14:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:14:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:01 INFO - Downloading/unpacking jsonschema==2.5.1 02:14: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 02:14: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 02:14: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 02:14: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 02:14:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:14:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:02 INFO - Downloading functools32-3.2.3-2.tar.gz 02:14:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:14:02 INFO - warning: no files found matching '*.txt' 02:14:02 INFO - no previously-included directories found matching 'build' 02:14:02 INFO - no previously-included directories found matching 'dist' 02:14:02 INFO - no previously-included directories found matching '.git*' 02:14:02 INFO - Installing collected packages: jsonschema, functools32 02:14:02 INFO - Running setup.py install for functools32 02:14:03 INFO - warning: no files found matching '*.txt' 02:14:03 INFO - no previously-included directories found matching 'build' 02:14:03 INFO - no previously-included directories found matching 'dist' 02:14:03 INFO - no previously-included directories found matching '.git*' 02:14:03 INFO - Successfully installed jsonschema functools32 02:14:03 INFO - Cleaning up... 02:14:03 INFO - Return code: 0 02:14:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:14:03 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')]} 02:14:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:03 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')]} 02:14:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x109825b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109828768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb091496550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109603d30>, '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 0x10952adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095f8be8>, '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.97uYPuZVzx/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.m6fZ8wET5b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:14:03 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 02:14:03 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 02:14:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.97uYPuZVzx/Render', 02:14:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:14:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:14:03 INFO - 'HOME': '/Users/cltbld', 02:14:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:14:03 INFO - 'LOGNAME': 'cltbld', 02:14:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:03 INFO - 'MOZ_NO_REMOTE': '1', 02:14:03 INFO - 'NO_EM_RESTART': '1', 02:14:03 INFO - 'PAGER': '/bin/cat', 02:14:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:14:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:03 INFO - 'PWD': '/builds/slave/test', 02:14:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:14:03 INFO - 'SHELL': '/bin/bash', 02:14:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m6fZ8wET5b/Listeners', 02:14:03 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 02:14:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:14:03 INFO - 'USER': 'cltbld', 02:14:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:14:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:14:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:03 INFO - 'XPC_FLAGS': '0x0', 02:14:03 INFO - 'XPC_SERVICE_NAME': '0', 02:14:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:14:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:14:03 INFO - Cleaning up... 02:14:03 INFO - Return code: 0 02:14:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:14:03 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')]} 02:14:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:03 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')]} 02:14:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x109825b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109828768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb091496550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109603d30>, '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 0x10952adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095f8be8>, '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.97uYPuZVzx/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.m6fZ8wET5b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:14:03 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 02:14:03 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 02:14:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.97uYPuZVzx/Render', 02:14:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:14:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:14:03 INFO - 'HOME': '/Users/cltbld', 02:14:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:14:03 INFO - 'LOGNAME': 'cltbld', 02:14:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:03 INFO - 'MOZ_NO_REMOTE': '1', 02:14:03 INFO - 'NO_EM_RESTART': '1', 02:14:03 INFO - 'PAGER': '/bin/cat', 02:14:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:14:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:03 INFO - 'PWD': '/builds/slave/test', 02:14:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:14:03 INFO - 'SHELL': '/bin/bash', 02:14:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m6fZ8wET5b/Listeners', 02:14:03 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 02:14:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:14:03 INFO - 'USER': 'cltbld', 02:14:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:14:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:14:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:03 INFO - 'XPC_FLAGS': '0x0', 02:14:03 INFO - 'XPC_SERVICE_NAME': '0', 02:14:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:14:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:03 INFO - Downloading/unpacking blobuploader==1.2.4 02:14:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:05 INFO - Downloading blobuploader-1.2.4.tar.gz 02:14:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:14:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:14: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 02:14: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 02:14: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 02:14: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 02:14:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:14:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:14: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 02:14: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 02:14: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 02:14: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 02:14:05 INFO - Downloading docopt-0.6.1.tar.gz 02:14:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:14:06 INFO - Installing collected packages: blobuploader, requests, docopt 02:14:06 INFO - Running setup.py install for blobuploader 02:14:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:14:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:14:06 INFO - Running setup.py install for requests 02:14:06 INFO - Running setup.py install for docopt 02:14:06 INFO - Successfully installed blobuploader requests docopt 02:14:06 INFO - Cleaning up... 02:14:06 INFO - Return code: 0 02:14:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:14: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')]} 02:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14: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')]} 02:14:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:06 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 0x109825b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109828768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb091496550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109603d30>, '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 0x10952adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095f8be8>, '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.97uYPuZVzx/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.m6fZ8wET5b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:14:06 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 02:14:06 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 02:14:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.97uYPuZVzx/Render', 02:14:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:14:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:14:06 INFO - 'HOME': '/Users/cltbld', 02:14:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:14:06 INFO - 'LOGNAME': 'cltbld', 02:14:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:06 INFO - 'MOZ_NO_REMOTE': '1', 02:14:06 INFO - 'NO_EM_RESTART': '1', 02:14:06 INFO - 'PAGER': '/bin/cat', 02:14:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:14:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:06 INFO - 'PWD': '/builds/slave/test', 02:14:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:14:06 INFO - 'SHELL': '/bin/bash', 02:14:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m6fZ8wET5b/Listeners', 02:14:06 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 02:14:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:14:06 INFO - 'USER': 'cltbld', 02:14:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:14:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:14:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:06 INFO - 'XPC_FLAGS': '0x0', 02:14:06 INFO - 'XPC_SERVICE_NAME': '0', 02:14:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:14:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:14:07 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-mBzcA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:14:07 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-dXCc_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:14:07 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-4_6_J2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:14:07 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-NvSFHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:14:07 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-GA48fZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:14:07 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-Cvl_2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:14:07 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-HCiNkC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:14:07 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-ETdrhW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:14:08 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-1n9Q3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:14:08 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-iKqXfU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:14:08 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-YsM4h3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:14:08 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-7Jyl6d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:14:08 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-EHOneZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:14:08 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-orbcPe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:14:08 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-Ot5_Zt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:14:08 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-HAZf0t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:14:08 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-WwFVcp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:14:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:14:08 INFO - Running setup.py install for manifestparser 02:14:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:14:09 INFO - Running setup.py install for mozcrash 02:14:09 INFO - Running setup.py install for mozdebug 02:14:09 INFO - Running setup.py install for mozdevice 02:14:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:14:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:14:09 INFO - Running setup.py install for mozfile 02:14:09 INFO - Running setup.py install for mozhttpd 02:14:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:14:09 INFO - Running setup.py install for mozinfo 02:14:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:14:09 INFO - Running setup.py install for mozInstall 02:14:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:14:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:14:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:14:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:14:10 INFO - Running setup.py install for mozleak 02:14:10 INFO - Running setup.py install for mozlog 02:14:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:14:10 INFO - Running setup.py install for moznetwork 02:14:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:14:10 INFO - Running setup.py install for mozprocess 02:14:10 INFO - Running setup.py install for mozprofile 02:14:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:14:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:14:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:14:10 INFO - Running setup.py install for mozrunner 02:14:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:14:11 INFO - Running setup.py install for mozscreenshot 02:14:11 INFO - Running setup.py install for moztest 02:14:11 INFO - Running setup.py install for mozversion 02:14:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:14:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:14:11 INFO - Cleaning up... 02:14:11 INFO - Return code: 0 02:14:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:14:11 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')]} 02:14:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:11 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')]} 02:14:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:11 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 0x109825b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109828768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb091496550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109603d30>, '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 0x10952adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095f8be8>, '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.97uYPuZVzx/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.m6fZ8wET5b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:14:11 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 02:14:11 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 02:14:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.97uYPuZVzx/Render', 02:14:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:14:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:14:11 INFO - 'HOME': '/Users/cltbld', 02:14:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:14:11 INFO - 'LOGNAME': 'cltbld', 02:14:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:11 INFO - 'MOZ_NO_REMOTE': '1', 02:14:11 INFO - 'NO_EM_RESTART': '1', 02:14:11 INFO - 'PAGER': '/bin/cat', 02:14:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:14:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:11 INFO - 'PWD': '/builds/slave/test', 02:14:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:14:11 INFO - 'SHELL': '/bin/bash', 02:14:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m6fZ8wET5b/Listeners', 02:14:11 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 02:14:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:14:11 INFO - 'USER': 'cltbld', 02:14:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:14:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:14:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:11 INFO - 'XPC_FLAGS': '0x0', 02:14:11 INFO - 'XPC_SERVICE_NAME': '0', 02:14:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:14:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:14:11 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-GIekBJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:14:11 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:14:11 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-ypjyoB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:14:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:14:12 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-upVgLS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:14:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:14:12 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-Yd6F17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:14:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:14:12 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-FQBsXy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:14:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:14:12 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-e5TmCB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:14:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:14:12 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-9xNYvr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:14:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:14:12 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-7P994S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:14:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:14:12 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-v_qMR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:14:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:14:12 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-9T8A3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:14:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:14:12 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-AXJ3vl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:14:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:14:13 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-B0bgfk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:14:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:14:13 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-QFlZj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:14:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:14:13 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-bRghxI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:14:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:14:13 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-EI6PRa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:14:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:14:13 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-8l9S8N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:14:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:14:13 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-bk_scI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:14:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:14:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:14:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:14:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:14:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:14:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:14:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:14:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:15 INFO - Downloading blessings-1.6.tar.gz 02:14:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:14:15 INFO - Installing collected packages: blessings 02:14:15 INFO - Running setup.py install for blessings 02:14:15 INFO - Successfully installed blessings 02:14:15 INFO - Cleaning up... 02:14:15 INFO - Return code: 0 02:14:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:14:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:14:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:14:15 INFO - Reading from file tmpfile_stdout 02:14:15 INFO - Current package versions: 02:14:15 INFO - blessings == 1.6 02:14:15 INFO - blobuploader == 1.2.4 02:14:15 INFO - docopt == 0.6.1 02:14:15 INFO - functools32 == 3.2.3-2 02:14:15 INFO - jsonschema == 2.5.1 02:14:15 INFO - manifestparser == 1.1 02:14:15 INFO - mozInstall == 1.12 02:14:15 INFO - mozcrash == 1.0 02:14:15 INFO - mozdebug == 0.1 02:14:15 INFO - mozdevice == 0.49 02:14:15 INFO - mozfile == 1.2 02:14:15 INFO - mozhttpd == 0.7 02:14:15 INFO - mozinfo == 0.9 02:14:15 INFO - mozleak == 0.1 02:14:15 INFO - mozlog == 3.4 02:14:15 INFO - moznetwork == 0.27 02:14:15 INFO - mozprocess == 0.25 02:14:15 INFO - mozprofile == 0.28 02:14:15 INFO - mozrunner == 6.13 02:14:15 INFO - mozscreenshot == 0.1 02:14:15 INFO - mozsystemmonitor == 0.3 02:14:15 INFO - moztest == 0.8 02:14:15 INFO - mozversion == 1.4 02:14:15 INFO - psutil == 3.1.1 02:14:15 INFO - requests == 1.2.3 02:14:15 INFO - wsgiref == 0.1.2 02:14:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:14:15 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')]} 02:14:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:15 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')]} 02:14:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:15 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 0x109825b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109828768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb091496550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109603d30>, '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 0x10952adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095f8be8>, '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.97uYPuZVzx/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.m6fZ8wET5b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:14:15 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 02:14:15 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 02:14:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.97uYPuZVzx/Render', 02:14:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:14:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:14:15 INFO - 'HOME': '/Users/cltbld', 02:14:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:14:15 INFO - 'LOGNAME': 'cltbld', 02:14:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:15 INFO - 'MOZ_NO_REMOTE': '1', 02:14:15 INFO - 'NO_EM_RESTART': '1', 02:14:15 INFO - 'PAGER': '/bin/cat', 02:14:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:14:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:15 INFO - 'PWD': '/builds/slave/test', 02:14:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:14:15 INFO - 'SHELL': '/bin/bash', 02:14:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m6fZ8wET5b/Listeners', 02:14:15 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 02:14:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:14:15 INFO - 'USER': 'cltbld', 02:14:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:14:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:14:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:15 INFO - 'XPC_FLAGS': '0x0', 02:14:15 INFO - 'XPC_SERVICE_NAME': '0', 02:14:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:14:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:14:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:14:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:14:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:14:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:14:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:14:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:14:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:14:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:14:16 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:14:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:14:16 INFO - Cleaning up... 02:14:16 INFO - Return code: 0 02:14:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:14: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')]} 02:14:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14: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')]} 02:14:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:16 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 0x109825b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109828768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb091496550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109603d30>, '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 0x10952adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095f8be8>, '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.97uYPuZVzx/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.m6fZ8wET5b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:14:16 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 02:14:16 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 02:14:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.97uYPuZVzx/Render', 02:14:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:14:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:14:16 INFO - 'HOME': '/Users/cltbld', 02:14:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:14:16 INFO - 'LOGNAME': 'cltbld', 02:14:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:16 INFO - 'MOZ_NO_REMOTE': '1', 02:14:16 INFO - 'NO_EM_RESTART': '1', 02:14:16 INFO - 'PAGER': '/bin/cat', 02:14:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:14:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:16 INFO - 'PWD': '/builds/slave/test', 02:14:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:14:16 INFO - 'SHELL': '/bin/bash', 02:14:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m6fZ8wET5b/Listeners', 02:14:16 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 02:14:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:14:16 INFO - 'USER': 'cltbld', 02:14:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:14:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:14:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:16 INFO - 'XPC_FLAGS': '0x0', 02:14:16 INFO - 'XPC_SERVICE_NAME': '0', 02:14:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:14:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:14:16 INFO - Cleaning up... 02:14:16 INFO - Return code: 0 02:14:16 INFO - Running post-action listener: _resource_record_post_action 02:14:16 INFO - Running post-action listener: _start_resource_monitoring 02:14:16 INFO - Starting resource monitoring. 02:14:16 INFO - [mozharness: 2017-06-08 09:14:16.317659Z] Finished create-virtualenv step (success) 02:14:16 INFO - [mozharness: 2017-06-08 09:14:16.318647Z] Running install step. 02:14:16 INFO - Running pre-action listener: _resource_record_pre_action 02:14:16 INFO - Running main action method: install 02:14:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:14:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:14:16 INFO - Reading from file tmpfile_stdout 02:14:16 INFO - Detecting whether we're running mozinstall >=1.0... 02:14:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:14:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:14:16 INFO - Reading from file tmpfile_stdout 02:14:16 INFO - Output received: 02:14:16 INFO - Usage: mozinstall [options] installer 02:14:16 INFO - Options: 02:14:16 INFO - -h, --help show this help message and exit 02:14:16 INFO - -d DEST, --destination=DEST 02:14:16 INFO - Directory to install application into. [default: 02:14:16 INFO - "/builds/slave/test"] 02:14:16 INFO - --app=APP Application being installed. [default: firefox] 02:14:16 INFO - mkdir: /builds/slave/test/build/application 02:14:16 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'] 02:14:16 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 02:14:36 INFO - Reading from file tmpfile_stdout 02:14:36 INFO - Output received: 02:14:36 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:14:36 INFO - Running post-action listener: _resource_record_post_action 02:14:36 INFO - [mozharness: 2017-06-08 09:14:36.696955Z] Finished install step (success) 02:14:36 INFO - [mozharness: 2017-06-08 09:14:36.697102Z] Running run-tests step. 02:14:36 INFO - Running pre-action listener: _resource_record_pre_action 02:14:36 INFO - Running main action method: run_tests 02:14:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:14:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:14:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:14:36 INFO - 2017-06-08 02:14:36.711 screenresolution[6630:123856] starting screenresolution argv=screenresolution get 02:14:36 INFO - 2017-06-08 02:14:36.714 screenresolution[6630:123856] Display 0: 1600x1200x32@60 02:14:36 INFO - 2017-06-08 02:14:36.720 screenresolution[6631:123859] starting screenresolution argv=screenresolution list 02:14:36 INFO - Available Modes on Display 0 02:14:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:14:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:14:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:14:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:14:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:14:36 INFO - Intel Iris: 02:14:36 INFO - Chipset Model: Intel Iris 02:14:36 INFO - Type: GPU 02:14:36 INFO - Bus: Built-In 02:14:36 INFO - VRAM (Dynamic, Max): 1536 MB 02:14:36 INFO - Vendor: Intel (0x8086) 02:14:36 INFO - Device ID: 0x0a2e 02:14:36 INFO - Revision ID: 0x0009 02:14:36 INFO - Displays: 02:14:36 INFO - Display: 02:14:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:14:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:14:36 INFO - Display Serial Number: 1600x1200 60 02:14:36 INFO - Main Display: Yes 02:14:36 INFO - Mirror: Off 02:14:36 INFO - Online: Yes 02:14:36 INFO - Rotation: Supported 02:14:36 INFO - Return code: 0 02:14:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:14:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:14:36 INFO - Python 2.7.3 02:14:36 INFO - Return code: 0 02:14:36 INFO - grabbing minidump binary from tooltool 02:14:36 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')]} 02:14:36 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 0x109603d30>, '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 0x10952adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095f8be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:14:36 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:14:36 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 02:14:36 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:14:37 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:14:37 INFO - Return code: 0 02:14:37 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:14:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:14:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:14:37 INFO - ENV: RUST_BACKTRACE is now 1 02:14:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:14:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:14:37 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/PciA_TQOQl-ieW8oGe_nrA/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0191', '--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 02:14:37 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/PciA_TQOQl-ieW8oGe_nrA/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0191 --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 02:14:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.97uYPuZVzx/Render', 02:14:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:14:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:14:37 INFO - 'HOME': '/Users/cltbld', 02:14:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:14:37 INFO - 'LOGNAME': 'cltbld', 02:14:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:14:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:14:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:37 INFO - 'MOZ_NO_REMOTE': '1', 02:14:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:14:37 INFO - 'NO_EM_RESTART': '1', 02:14:37 INFO - 'PAGER': '/bin/cat', 02:14:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:14:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:37 INFO - 'PWD': '/builds/slave/test', 02:14:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:14:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:14:37 INFO - 'RUST_BACKTRACE': '1', 02:14:37 INFO - 'SHELL': '/bin/bash', 02:14:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m6fZ8wET5b/Listeners', 02:14:37 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 02:14:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:14:37 INFO - 'USER': 'cltbld', 02:14:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:14:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:14:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:37 INFO - 'XPC_FLAGS': '0x0', 02:14:37 INFO - 'XPC_SERVICE_NAME': '0', 02:14:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:14:37 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/PciA_TQOQl-ieW8oGe_nrA/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0191', '--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 02:14:37 INFO - mozversion application_buildid: 20170608011525 02:14:37 INFO - mozversion application_changeset: 2125aa846c90398be9d3b6c01ff48de8265aeba3 02:14:37 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:14:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:14:37 INFO - mozversion application_name: Firefox 02:14:37 INFO - mozversion application_remotingname: firefox-dev 02:14:37 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 02:14:37 INFO - mozversion application_vendor: Mozilla 02:14:37 INFO - mozversion application_version: 54.0 02:14:37 INFO - mozversion platform_buildid: 20170608011525 02:14:37 INFO - mozversion platform_changeset: 2125aa846c90398be9d3b6c01ff48de8265aeba3 02:14:37 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 02:14:37 INFO - mozversion platform_version: 54.0 02:14:37 INFO - using testdate: 1496913277 02:14:37 INFO - actual date: 1496913277 02:14:37 INFO - starting webserver on 'localhost:57755' 02:14:37 INFO - SUITE-START | Running 2 tests 02:14:37 INFO - TEST-START | dromaeo_css 02:14:37 INFO - operating with platform_type : mac_ 02:14:37 INFO - Initialising browser for dromaeo_css test... 02:14:37 INFO - TEST-INFO | started process 6641 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/tmpI5cOeT/profile http://localhost:57755/getInfo.html) 02:14:39 INFO - PROCESS | 6641 | __metrics Screen width/height:1600/1200 02:14:39 INFO - PROCESS | 6641 | colorDepth:24 02:14:39 INFO - PROCESS | 6641 | Browser inner width/height: 1024/689 02:14:39 INFO - PROCESS | 6641 | __metrics 02:14:40 INFO - PROCESS | 6641 | 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" 02:14:40 INFO - PROCESS | 6641 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:14:40 INFO - TEST-INFO | 6641: exit 0 02:14:40 INFO - Browser initialized. 02:14:40 INFO - Running cycle 1/1 for dromaeo_css test... 02:14:40 INFO - TEST-INFO | started process 6645 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/tmpI5cOeT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:14:52 INFO - PROCESS | 6645 | RSS: Main: 197582848 02:14:52 INFO - PROCESS | 6645 | 02:17:56 INFO - PROCESS | 6645 | Cycle 1(1): loaded http://localhost:57755/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57755/tests/dromaeo/cssquery-ext.html) 02:17:58 INFO - PROCESS | 6645 | RSS: Main: 387608576 02:17:58 INFO - PROCESS | 6645 | 02:21:01 INFO - PROCESS | 6645 | Cycle 1(1): loaded http://localhost:57755/tests/dromaeo/cssquery-ext.html (next: http://localhost:57755/tests/dromaeo/cssquery-jquery.html) 02:21:02 INFO - PROCESS | 6645 | RSS: Main: 331001856 02:21:02 INFO - PROCESS | 6645 | 02:24:04 INFO - PROCESS | 6645 | Cycle 1(1): loaded http://localhost:57755/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57755/tests/dromaeo/cssquery-mootools.html) 02:24:05 INFO - PROCESS | 6645 | RSS: Main: 311492608 02:24:05 INFO - PROCESS | 6645 | 02:27:07 INFO - PROCESS | 6645 | Cycle 1(1): loaded http://localhost:57755/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57755/tests/dromaeo/cssquery-prototype.html) 02:27:08 INFO - PROCESS | 6645 | RSS: Main: 294281216 02:27:08 INFO - PROCESS | 6645 | 02:30:11 INFO - PROCESS | 6645 | Cycle 1(1): loaded http://localhost:57755/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57755/tests/dromaeo/cssquery-yui.html) 02:30:12 INFO - PROCESS | 6645 | RSS: Main: 290422784 02:30:12 INFO - PROCESS | 6645 | 02:33:15 INFO - PROCESS | 6645 | Cycle 1(1): loaded http://localhost:57755/tests/dromaeo/cssquery-yui.html (next: http://localhost:57755/tests/dromaeo/cssquery-dojo.html) 02:33:15 INFO - PROCESS | 6645 | RSS: Main: 353234944 02:33:15 INFO - PROCESS | 6645 | 02:33:15 INFO - PROCESS | 6645 | __start_tp_report 02:33:15 INFO - PROCESS | 6645 | _x_x_mozilla_page_load 02:33:15 INFO - PROCESS | 6645 | _x_x_mozilla_page_load_details 02:33:15 INFO - PROCESS | 6645 | |i|pagename|runs| 02:33:15 INFO - PROCESS | 6645 | |0;dojo.html;3320.1367644412453;3351.798892066476;3356.0770788033287;3359.8488068036936;3400;5836.1245813128;5879.971005074116;5888.970555147218;5904.822855314342;5907.113932910055;5739.51214146797;5825.533957283418;5882.058870580708;5892.675902825343;5909.084091965741;5232.92150617741;5257.815976440826;5259.6055295852775;5300.814471493499;5364.5708343332635;5204.9219261711105;5209.296744939423;5257.842264732045;5293.311869456985;5387.730613469331;5336.38631557372;5360.061989151903;5364.088105022156;5380.058489764295;5383.919241211365;5368.409474957752;5377.516023557879;5378.102655643845;5378.542823859937;5392.78428862847;5098.4136824265315;5147.202183661539;5231.947680523184;5293.550048245904;5365.973170134163;5699.68651724155;5725.198472213893;5728.312602487728;5750.913736293959;5754.510866576305;6174.475169610589;6232;6232.594881332699;6241.719122639447;6250.187475628185;6163.784267550659;6209.099680546341;6217.098520714471;6279.183706118175;6282.87434251317;6035;6045.939540604581;6047.69761511927;6066.332703402622;6096;6296.307406185316;6332.430081292706;6355.396237357444;6364.904526432108;6544.541882068304;4432.711873728197;6030.33666296707;6038.758449662052;6158.199434073542;6234.2830574483605;6295.433410993032;6316.084167795736;6316.526260530479;6320.462760665395;6332.651704156224;6136.23297087864;6325.209348831396;6327.683615819191;6340.4927605792345;6351.142595749607;6246;6259.217597800275;6273.686315684197;6281.026440901667;6313.684315784192;4835.2505361669;4835.984443266953;4838.395200599925;4840.515948405131;4867.902641947141;4318.093200427946;4355.15074560464;4371.169477799208;4381.430414046154;4393.472783265965;5548.0845660466375;5551.777928882881;5577.888442231133;5718.313802343745;5725.227094342211;6264.655443950626;6266.968665156736;6301.338359472281;6306.49548036156;6313.558050936482;5697.059985102412;5698.202251684767;5707.71461426927;5708.686022268732;5727.31272247333;5211.1662134059125;5460.672359658433;5464.972675136599;5472.616916815864;5482.150266708587;6295.779647712308;6305.96847015762;6325.778597749057;6327.936720632919;6332.841678957879;6242.28213755424;6274.341194174728;6298.275698294571;6301.590396624205;6327.810165695037;6306.590071645328;6332.176817013758;6358.205224346957;6361.141245931925;6383.585066970632;6345.587536810092;6367.490600752021;6370.77702280418;6372.808815735535;6374.872502550016;6218.689065546614;6259.718312675849;6260.311365749855;6260.812175634556;6306.337834527309;6302.558820882494;6305.432511074026;6306.085617585332;6311.90532142009;6312.05319202105;6201.1628430163155;6248.500119990299;6287.528435367457;6289.811305660837;6317.241930968313;5827.038538641077;5863.618864773776;5936.910946335722;5957.225560677258;6113.694315284307;6091.60404573719;6117.938820611737;6118;6121.510279177566;6144.218176728698;5869.589128760946;5893.174955506147;6109.175261339662;6140.815775526741;6144.56988010835 02:33:15 INFO - PROCESS | 6645 | |1;ext.html;808.1231863428181;823.7981694484852;884.7080463447063;892.6027917576681;898.2768871058795;32726.018219453425;39787.40318895215;40770.38844417329;40857.38713919286;40929.99999999996;42170.57829421705;42235.788821055925;42280.57719422805;42392;42397.7880110599;7448.068991376078;9438.480883551401;9574.904250957507;9592.232621390307;9610.183134433582;7561.395088392916;11386.886131138706;11604.955554000138;11780.93971542561;11787.587434439796;11574.016208622235;11586.42067896606;11588.768224635545;11595;11656.825147622792;10764.461776911123;11499.942500287487;11553.017993470565;11559.884401155965;11583.247088939192;10505.579776808918;10651.946740266327;11401.600943967005;11409.828852567218;11446.14153938458;39114;39139.41290880639;39228.21543569113;39264.21471570552;39289;3755.7518957652046;3830.636089571486;3870.2453021660785;3886.8833934981712;3934.783586902719;27621.447571048666;29131.126066218047;29169.854150729323;29740.55389169164;29795.851020744758;3060.709232622897;3095.6440009398984;3097.566340712302;3108.4560201964564;3111.2999575095423;345724;345735;346419;346697;346713;51783.48216517862;51965;52197.86812791245;52276;52296;54089;54327.6418089543;54342.18486722702;54355.72822135943;54505.72747136239;14931;15047.87140964432;15064;15066.397344106332;15070.945033847525;13004.21974681522;13016.479340826261;13026;13059.542915997894;13112.147710398793;11312.434378281054;11907.166498345206;11933.687294397609;11978.041756659446;12057.216280941711;5685.459881311269;5717.171010203498;5719.799807006735;5723.656580605177;5731.570132240098;1002.1131298800468;1118.8084689805332;1152.383474840956;1165.650304908524;1203.0330409780072;26279.60580591293;26423.47153056928;26933.326666833094;26958.460830783668;27056.729432705815;1186.5491113377034;1233.2600439736086;1247.8065899785547;1259.395490164726;1316.453671726242;10123.949380253052;10640.680779576625;14028.298585070706;14047.157170569799;14055.226962516956;423255;424009;429723;569286;571747;41419.37870931938;46975.29537056947;47348.76325618419;47478.76260618675;47831.760841196265;1266.5123927287875;1408.978865317021;1456.2354763748904;1459.532949456185;1459.7956286120163;25741.97032118769;26105.869470652524;26211.868940655175;26230.737692623592;26769.464610708066;38816.8354949352;38950;38992.83021509359;39030.2193956125;39051.80474097611;431727;432326.03021909395;432586;432793;433606;26886.32784180411;27427;27481.725182747916;27552.173434796987;27577.86211069012;35342;36040.27919441649;36101;36200.27599447944;36264.09339766527;25661.615075773505;26035.609465857648;26109.73890261149;26406.603900941886;27159;25600.103996360038;26226;26449.471010580066;26588;26593.33516662099;30583.929562466095;30613;30623.928162514207;31931;32537.83731081424;28065.71934280631;28269.717302827532;28641.42717145687;29004.274893126996;29078.69145888398;22334.657757804245;23404.922167664514;23413;23479.295621131394;23661.526769464857 02:33:15 INFO - PROCESS | 6645 | |2;jquery.html;385.5854955922383;390.56061930328383;405.1208876737479;429.4781840064321;456.9040501494686;13239.669008274786;15025.248737563119;21857.453563660918;22573;23083.076676932946;22944;22988.425289367733;23689.28932132039;23825.761742382572;23930;5950.196723442323;6234.937650623492;6589.143411356517;6699.6985135668765;6747.4602031837585;6450.4839612830865;6668.666566671672;6681.498887583426;6738.056672065914;6776.966115169417;6714.865702685944;6726;6731.1922569291755;6731.596104233738;6737.326267373248;5914.497267732248;6462.579932304408;6698.53110282278;6768.864622707519;6780.457563394916;6583.242927063401;6602.438792702626;6606.042123892009;6867.450603951722;7186.065811444479;25872.066910862028;25872.482550349076;27427.31431714203;27720.584191237147;27874;2887.5091234490187;2951.719586639266;2995.6255468066493;3008.714172153642;3018.335966087457;16655.917365371213;16680.416185433573;16781.993080415094;17050.573735656584;17162.22769975354;2093.05445817617;2116.132385721862;2118.5762847430574;2121.8514703970727;2148.699182114505;170583;171401.14299428422;172680;175629;176670;16532.669346613002;20525.38423847287;20552.28067017647;20829.479263018547;21125.89437052805;31931.84034079861;31937.201569960936;32520.512192317135;32541.34917301688;32574.674253257162;10268.537915793808;10460.215483838743;10608.363498190134;10659.84010239847;10799.298045627167;8817.635270541112;8894.955525222462;8904.287656987426;9087;9099.909000909905;9520.571574279174;9587;9634.863136045558;9752.609895604097;9774.902250977542;3486.8430920608635;3767.888472900501;3885.4560361549406;3946.940795888064;3967.5238971323624;935.4153653966271;1023.22746326523;1026.7997740440542;1041.5365162502615;1064.7870425914848;21020;22009.559808803733;22277.88861055717;22293.777062229496;22451.101955921582;1067.6903697927514;1069.1927594665976;1071.807074726541;1083.106437189322;1099.71957150926;10637.202209834293;11446.255993360404;11505.71235719097;11520;11527.76944461106;653933;742689;751959;775196;780182;140985;142713.77276479782;143320;148938;149780.75328870077;1257.2205232755566;1266.8479782426168;1297.9935100324626;1298;1301.7786976214065;18797.436076917715;18958.43124706261;19420.902895485997;19475.026248687227;19518.31685890987;58223.417765821796;64134.679326603065;64519.677401612695;65015.67492162698;65428;94012;96010.51994739982;97297;97317;97334.51332743291;9524.666636667684;11232.438378081226;11443.027342675965;11586.188966772244;11934.52261909514;13286.933565332112;13309.267990260629;13631.045826792426;13731.931340343235;13741.175529468264;11145.832812507657;11176.888231117584;11233;11681.357525336189;11914.225575337576;10524.421156836448;10659.360438373722;10709;11048.226624136554;11085.889141108808;11585.07319414428;11746.765064698488;11805.350705711267;11965.641030769091;11975.820362694392;11728.296302221894;11746.412679366169;11746.471408786796;11789.233699809485;12083.335416552174;9896.42924654998;11341.773164536828;11402.600908968147;11430.085593152362;11683.766324673288 02:33:15 INFO - PROCESS | 6645 | |3;mootools.html;1391.4781956766212;1561.0633619828104;1606.8152162501317;1627.0481768165614;1632.0941877258122;9328.067193280676;9747.463889486084;10207.775066991953;10974.835377469344;11123;10751.892481075187;11220.326780393181;11239.775204495925;11249.831252531198;11256;2315.131825565413;2364.467994701187;2371.1937941100023;2374;2378.500514891875;1974.5655955689726;2040.5918816236738;2042.611903738285;2048.5902819436096;2055.6916462530667;1898.5823118913886;2023.180611852195;2339.7833126774067;2340.719113706349;2343.16817529777;2337.1118974789556;2337.7194736631627;2339.3683705399617;2340.578695834749;2344.9648255276184;2247.6291411917014;2259.6836442898007;2283.200879692111;2298.425393651587;2298.7816157465013;10997.780044399147;11072;11086.16853735965;11092.500837462252;11159.051480624157;5465.863353416156;5637.238972738669;5651.039323315046;5660.688662123582;5669.149627555858;2845.587389828484;3162.596426715713;3508.122969257686;3567.661072198163;3572.678458938708;1127.9266847654876;1147.7933971885057;1165.9125565582615;1173.4426147579916;1204.807230843061;15836.920815395964;16009.199540023068;16039.27823247945;16040.438584649599;16092.517224483285;4434.933475997863;4658.440987081572;4663.207254766698;4719.009008108267;4731.621470282369;13025;13028.218306901616;13037.739245215043;13037.804432933513;13041;5516.062269414209;5641.464060914206;5652.067408877571;5652.9152062719095;5718.885622287531;4904.313396124546;5058.418281897555;5097.745112744422;5103.489651034867;5175.585953123741;3321.236115693404;3609.4224924012033;3683;3734.3091528067393;3746.550413950289;870.4864130163234;933.1741408853214;947.0671388682142;949.4445749236636;951.6914242915991;844.9028361738356;932;947.4836214263244;969.9757506062405;1009.5103874620803;6651.800445986628;6668.399844013965;6719.832004199934;6921.446284297244;6933.2720064393525;1028.5011769291887;1038.1539045677748;1062.6705721226444;1062.9893701063045;1073.5169173871789;3614.3855544557487;4103.343465045578;4170.311898536707;4269.932516870782;4419.535948725402;12872.613821585368;13973.301334933416;14074.859251407559;14158.079724817853;14162.85837141636;13579.864201358057;13802.240876751674;14076.014678972373;14080.859191408159;14098.365573549216;9201.079892010745;10288.12550933179;10333;10425.478726063819;10445.895541044492;6413.935860641521;6492.163338312798;6509.576877502947;6581.14445122131;6617.139771829631;12103.33431661267;12111.394430278628;12153.149279550347;12268.877311226774;12400.19398739079;12341.444634991267;12422.813657795321;12493.687657808627;12608;12639.05207109489;7356.411487081128;8618.569071546523;8618.741437756877;8910.688125915562;9391.436513809193;10528.473576321307;10635.255532112678;10732.73168170802;10741.355518668905;10751.408672522773;7742.225777422213;8958.596863141043;8989.505577193317;9041.457512549268;9134;8791.5164665944;8824.117588241124;8872.334574907038;8883.911160888309;8917.464952102895;7815.335696465864;7837.020372453443;7908.209179082046;7928.405369597419;7945.682172713026;5865.208196893364;5908.084246941731;6002.009668404664;6022.45797878193;6044.758209671564;5715.114157305624;5865.530757539302;5897.557683173865;6022.789202377896;6090.23872015998 02:33:15 INFO - PROCESS | 6645 | |4;prototype.html;376.87186356638745;379.5483374784007;381.0226768339208;386.9090763670538;389.73303287248257;4857.562819346258;4869.904271538902;4911.96848661781;4912.459629440763;4953;4252.493021537109;4362.974700945275;4700.670953033289;4836.709797412158;4844.467108618049;3906.882793516185;3971.8212680429306;4108.062735144371;4125.401816736571;4140.710150289481;3288.993713834559;3548.574171099459;3787;4113.239050775616;4166.916541729135;4010.9170523958514;4139.668826493873;4164.105332073899;4165.58344165584;4176.665866730655;4002.2595819773437;4055.4322394864744;4080.285949958775;4111.6299533042165;4211.178820130076;3335.7498187636024;3759.3045286622064;3773.3773927301963;3794.1842503861526;3853.5183102112237;4794.448638406593;4836.492168322311;4838.85483435494;4863.2461968394955;4898.681585696918;4450.1767173073085;4703.670743047988;4760.595349395306;4767.618590512785;4791.0178413425165;4989.775460104304;5166.689998600096;5176.6893986360565;5180.715060671661;5192.454792246797;3904.511936007999;4260.676672195661;4304.5480224576595;4306.181825453185;4325.956740432587;4732.408448943882;5253.9772187708;5269.473052694738;5277.86805329866;5571.526420254283;3816.9809150954625;3838.7120965927666;4087.243859885871;4099.0162361033135;4206.41110244566;4139.710220284551;4143.440635514227;4166.8749937501925;4289.6139347458875;4301.859642461021;4006.5359803720503;4103.871435355301;4349.499807522176;4475.679674496031;4703.83536576225;4785.904281914342;4787.826982389337;4894.583960363338;5085.669431486942;5228.895422091537;1221.9450124744408;1340.4316949169495;1440.5462279381961;1476.2766244540312;1488.8660020597981;1021.7139201023725;1100.6312885183393;1109.384291718088;1116.7096554895786;1134.750354921916;4709;4713.764311784397;4730.9763451182525;4735.95264047362;4738.8341408050555;5014.874628134253;5024.547790698782;5208.401033881152;5380.224525906441;5386.434424385461;4128.422020917074;4356.172327257874;4732.432108147044;4776.659436875975;4777.522247775195;2591.481703659238;2635.71007189209;2665.853378064225;2758.7655049321033;2767.4262935469806;5038.546530812245;5103.974480127576;5251.4485978972425;5478.657728856376;5581.469760372758;4368.650507959355;4906.386701662293;5449.891002180014;5478.329109621524;5490.835274941758;4683.859484215479;5471.50756431923;5505;5530.668159910419;5578.330600327987;4755.738434386142;5377.660717587862;5394.306952950958;5417.074779619119;5434.538064264581;4871.34236878017;5222.2688823565495;5231.29377534028;5273.894522109613;5354.527504936018;4816.373871396696;4848.248521479177;4873.926891096566;5029.108262749007;5527.419620939743;3765.981170094132;4286.828526859015;4289.485261768607;4308.763018034038;4321.870343889688;4414.536473670347;4952.826651067196;5065.645404821627;5141.794328226829;5370.355557333145;4536.795844186953;4578.381918441101;4800.3279540863605;5178.611604129781;5195.480451954925;4528.818847246073;5028.59771218309;5158.85309960916;5277.366715994105;5304;4779.474257831566;4942.33114118372;5104.719240441811;5132.871678208075;5140.329392947382;4653.232216684344;4834.492378300228;5072.630389794661;5223.52988231061;5327.242010136568;4495.291384607646;4750.738709371018;4961.156603377362;5181.3575076710395;5196.766145523385 02:33:15 INFO - PROCESS | 6645 | |5;yui.html;742.7734540965004;766.758471081609;767.6660652616113;846.5259454705365;860.2343913916613;15778.895477316593;15840;16593.834061659396;17255.396061137864;17358.913205433986;15650.843491565081;15773.369065237406;15796.289166987484;16786.160691965382;17305.653886922253;978.427619842393;1001.7295330260825;1005.7938122684868;1006.2805094357533;1007.4459047523869;947.1759569174827;985.7289245457484;991.6826615483048;1003.1322905686565;1005.1054561440324;1048.7535429174138;1050.9316894401838;1050.994745026274;1052.736815796051;1053.3627155570884;1045;1046.2937517175876;1046.3564907581858;1047.0158051431629;1047.4657924458504;775.3758224629171;776.1036003416064;777.2693667952107;777.8483195776826;779.3414564692825;16280.674386512203;16470.6705865882;16504.504864854072;17089.57276068096;17324.56688582783;14201;14432.567022989328;14452.710945781131;14489.347979340955;14577.635559111;11673.883261167364;11782;11816.763664726743;11953.40232988347;12398.81401778974;3485.686288234071;3532.964670353315;3705.888823335304;3797.1456422305037;3841.154945911895;111647;115258.84741152481;118041.40979295134;118067.40966295113;119987;10845.728856778485;11098.389588572545;11123.210485828733;11373.601923932623;11504.42477876103;23285.650715239284;23561.175358862358;23572.410689732893;23573.882130589238;23606.881965590404;7839.960800196077;7842.764717058498;7843.803904902309;7935.484193527403;8003.8799418008775;4282.314829627245;4324.956750432519;4432.2908334666945;4443.23414368468;4451.421315229064;3423.863045478203;3512.438009918452;3513.578370595545;3523.8238088096005;3534;601.9405845711492;602.457787990803;608.4402349838159;609.2141137932107;626.8150895485843;626.4111734969115;660.8182749743859;685.3968507713181;733.1275781819618;736.7237286017744;9582.472963987047;10461;10492.580296788195;10526.578936842594;10654.840177397346;662.456785435938;709.1454796969639;713.375796178344;715.2168375628678;715.7995761186876;4049.987503124219;4635.443746750411;5073.3911930568565;5077.669951453144;5107.387113546398;89074;98431;98998;103148;103703.96296036943;57683.71158144182;60175.69912150411;80875.78686319709;85664;86872.6969095464;77972;78807;78972.99999999885;79149.60425197837;82329;11050.281731687415;11087.611933582286;11111.44442777874;11249.775004500028;11250.381229032155;44274.114517710106;47644.52355476401;49324;51252.74373628257;52567.94864102773;59903.30435130342;60527.10452174942;62484.37515624786;62672.43318916881;63062.68468657627;12445.315507647167;12677.239365638092;12818.67953301175;12879.227246365248;13063.542776002794;14283;14460.710785784437;14463.421463141778;14647.19440430744;15265.618359540656;13181.275029873448;13586.845118165067;13804.861951380357;13858;13884.722305554034;11040.227184097035;11359.432028398713;11500.884991149982;11502.769944601228;13618.319084045559;11910.404479776149;13445.596632101053;13599.470512418637;14195.787063194268;14715.882221171487;9967.202623790225;10067.748306292402;10235.948820255851;10245.538950747383;10662.786744265226;11305.26515776472;11312.418470519453;11343.829842552534;11575.363355015555;11672.941635291769 02:33:15 INFO - PROCESS | 6645 | __end_tp_report 02:33:15 INFO - PROCESS | 6645 | __start_cc_report 02:33:15 INFO - PROCESS | 6645 | _x_x_mozilla_cycle_collect,2179 02:33:15 INFO - PROCESS | 6645 | __end_cc_report 02:33:15 INFO - PROCESS | 6645 | __startTimestamp1496914395640__endTimestamp 02:33:15 INFO - PROCESS | 6645 | 02:33:15 INFO - PROCESS | 6645 | ------- Summary: start ------- 02:33:15 INFO - PROCESS | 6645 | Number of tests: 6 02:33:15 INFO - PROCESS | 6645 | 02:33:15 INFO - PROCESS | 6645 | [#0] dojo.html Cycles:165 Average:5800.13 Median:6066.33 stddev:668.79 (11.0%) stddev-sans-first:641.92 02:33:15 INFO - PROCESS | 6645 | Values: 3320.1 3351.8 3356.1 3359.8 3400.0 5836.1 5880.0 5889.0 5904.8 5907.1 5739.5 5825.5 5882.1 5892.7 5909.1 5232.9 5257.8 5259.6 5300.8 5364.6 5204.9 5209.3 5257.8 5293.3 5387.7 5336.4 5360.1 5364.1 5380.1 5383.9 5368.4 5377.5 5378.1 5378.5 5392.8 5098.4 5147.2 5231.9 5293.6 5366.0 5699.7 5725.2 5728.3 5750.9 5754.5 6174.5 6232.0 6232.6 6241.7 6250.2 6163.8 6209.1 6217.1 6279.2 6282.9 6035.0 6045.9 6047.7 6066.3 6096.0 6296.3 6332.4 6355.4 6364.9 6544.5 4432.7 6030.3 6038.8 6158.2 6234.3 6295.4 6316.1 6316.5 6320.5 6332.7 6136.2 6325.2 6327.7 6340.5 6351.1 6246.0 6259.2 6273.7 6281.0 6313.7 4835.3 4836.0 4838.4 4840.5 4867.9 4318.1 4355.2 4371.2 4381.4 4393.5 5548.1 5551.8 5577.9 5718.3 5725.2 6264.7 6267.0 6301.3 6306.5 6313.6 5697.1 5698.2 5707.7 5708.7 5727.3 5211.2 5460.7 5465.0 5472.6 5482.2 6295.8 6306.0 6325.8 6327.9 6332.8 6242.3 6274.3 6298.3 6301.6 6327.8 6306.6 6332.2 6358.2 6361.1 6383.6 6345.6 6367.5 6370.8 6372.8 6374.9 6218.7 6259.7 6260.3 6260.8 6306.3 6302.6 6305.4 6306.1 6311.9 6312.1 6201.2 6248.5 6287.5 6289.8 6317.2 5827.0 5863.6 5936.9 5957.2 6113.7 6091.6 6117.9 6118.0 6121.5 6144.2 5869.6 5893.2 6109.2 6140.8 6144.6 02:33:15 INFO - PROCESS | 6645 | 02:33:15 INFO - PROCESS | 6645 | [#1] ext.html Cycles:180 Average:54987.21 Median:29150.49 stddev:113435.31 (389.1%) stddev-sans-first:113680.59 02:33:15 INFO - PROCESS | 6645 | Values: 808.1 823.8 884.7 892.6 898.3 32726.0 39787.4 40770.4 40857.4 40930.0 42170.6 42235.8 42280.6 42392.0 42397.8 7448.1 9438.5 9574.9 9592.2 9610.2 7561.4 11386.9 11605.0 11780.9 11787.6 11574.0 11586.4 11588.8 11595.0 11656.8 10764.5 11499.9 11553.0 11559.9 11583.2 10505.6 10651.9 11401.6 11409.8 11446.1 39114.0 39139.4 39228.2 39264.2 39289.0 3755.8 3830.6 3870.2 3886.9 3934.8 27621.4 29131.1 29169.9 29740.6 29795.9 3060.7 3095.6 3097.6 3108.5 3111.3 345724.0 345735.0 346419.0 346697.0 346713.0 51783.5 51965.0 52197.9 52276.0 52296.0 54089.0 54327.6 54342.2 54355.7 54505.7 14931.0 15047.9 15064.0 15066.4 15070.9 13004.2 13016.5 13026.0 13059.5 13112.1 11312.4 11907.2 11933.7 11978.0 12057.2 5685.5 5717.2 5719.8 5723.7 5731.6 1002.1 1118.8 1152.4 1165.7 1203.0 26279.6 26423.5 26933.3 26958.5 27056.7 1186.5 1233.3 1247.8 1259.4 1316.5 10123.9 10640.7 14028.3 14047.2 14055.2 423255.0 424009.0 429723.0 569286.0 571747.0 41419.4 46975.3 47348.8 47478.8 47831.8 1266.5 1409.0 1456.2 1459.5 1459.8 25742.0 26105.9 26211.9 26230.7 26769.5 38816.8 38950.0 38992.8 39030.2 39051.8 431727.0 432326.0 432586.0 432793.0 433606.0 26886.3 27427.0 27481.7 27552.2 27577.9 35342.0 36040.3 36101.0 36200.3 36264.1 25661.6 26035.6 26109.7 26406.6 27159.0 25600.1 26226.0 26449.5 26588.0 26593.3 30583.9 30613.0 30623.9 31931.0 32537.8 28065.7 28269.7 28641.4 29004.3 29078.7 22334.7 23404.9 23413.0 23479.3 23661.5 02:33:15 INFO - PROCESS | 6645 | 02:33:15 INFO - PROCESS | 6645 | [#2] jquery.html Cycles:180 Average:43531.49 Median:21933.51 stddev:124283.84 (566.6%) stddev-sans-first:124590.26 02:33:15 INFO - PROCESS | 6645 | Values: 385.6 390.6 405.1 429.5 456.9 13239.7 15025.2 21857.5 22573.0 23083.1 22944.0 22988.4 23689.3 23825.8 23930.0 5950.2 6234.9 6589.1 6699.7 6747.5 6450.5 6668.7 6681.5 6738.1 6777.0 6714.9 6726.0 6731.2 6731.6 6737.3 5914.5 6462.6 6698.5 6768.9 6780.5 6583.2 6602.4 6606.0 6867.5 7186.1 25872.1 25872.5 27427.3 27720.6 27874.0 2887.5 2951.7 2995.6 3008.7 3018.3 16655.9 16680.4 16782.0 17050.6 17162.2 2093.1 2116.1 2118.6 2121.9 2148.7 170583.0 171401.1 172680.0 175629.0 176670.0 16532.7 20525.4 20552.3 20829.5 21125.9 31931.8 31937.2 32520.5 32541.3 32574.7 10268.5 10460.2 10608.4 10659.8 10799.3 8817.6 8895.0 8904.3 9087.0 9099.9 9520.6 9587.0 9634.9 9752.6 9774.9 3486.8 3767.9 3885.5 3946.9 3967.5 935.4 1023.2 1026.8 1041.5 1064.8 21020.0 22009.6 22277.9 22293.8 22451.1 1067.7 1069.2 1071.8 1083.1 1099.7 10637.2 11446.3 11505.7 11520.0 11527.8 653933.0 742689.0 751959.0 775196.0 780182.0 140985.0 142713.8 143320.0 148938.0 149780.8 1257.2 1266.8 1298.0 1298.0 1301.8 18797.4 18958.4 19420.9 19475.0 19518.3 58223.4 64134.7 64519.7 65015.7 65428.0 94012.0 96010.5 97297.0 97317.0 97334.5 9524.7 11232.4 11443.0 11586.2 11934.5 13286.9 13309.3 13631.0 13731.9 13741.2 11145.8 11176.9 11233.0 11681.4 11914.2 10524.4 10659.4 10709.0 11048.2 11085.9 11585.1 11746.8 11805.4 11965.6 11975.8 11728.3 11746.4 11746.5 11789.2 12083.3 9896.4 11341.8 11402.6 11430.1 11683.8 02:33:15 INFO - PROCESS | 6645 | 02:33:15 INFO - PROCESS | 6645 | [#3] mootools.html Cycles:180 Average:6750.14 Median:2372.60 stddev:4364.96 (184.0%) stddev-sans-first:4358.64 02:33:15 INFO - PROCESS | 6645 | Values: 1391.5 1561.1 1606.8 1627.0 1632.1 9328.1 9747.5 10207.8 10974.8 11123.0 10751.9 11220.3 11239.8 11249.8 11256.0 2315.1 2364.5 2371.2 2374.0 2378.5 1974.6 2040.6 2042.6 2048.6 2055.7 1898.6 2023.2 2339.8 2340.7 2343.2 2337.1 2337.7 2339.4 2340.6 2345.0 2247.6 2259.7 2283.2 2298.4 2298.8 10997.8 11072.0 11086.2 11092.5 11159.1 5465.9 5637.2 5651.0 5660.7 5669.1 2845.6 3162.6 3508.1 3567.7 3572.7 1127.9 1147.8 1165.9 1173.4 1204.8 15836.9 16009.2 16039.3 16040.4 16092.5 4434.9 4658.4 4663.2 4719.0 4731.6 13025.0 13028.2 13037.7 13037.8 13041.0 5516.1 5641.5 5652.1 5652.9 5718.9 4904.3 5058.4 5097.7 5103.5 5175.6 3321.2 3609.4 3683.0 3734.3 3746.6 870.5 933.2 947.1 949.4 951.7 844.9 932.0 947.5 970.0 1009.5 6651.8 6668.4 6719.8 6921.4 6933.3 1028.5 1038.2 1062.7 1063.0 1073.5 3614.4 4103.3 4170.3 4269.9 4419.5 12872.6 13973.3 14074.9 14158.1 14162.9 13579.9 13802.2 14076.0 14080.9 14098.4 9201.1 10288.1 10333.0 10425.5 10445.9 6413.9 6492.2 6509.6 6581.1 6617.1 12103.3 12111.4 12153.1 12268.9 12400.2 12341.4 12422.8 12493.7 12608.0 12639.1 7356.4 8618.6 8618.7 8910.7 9391.4 10528.5 10635.3 10732.7 10741.4 10751.4 7742.2 8958.6 8989.5 9041.5 9134.0 8791.5 8824.1 8872.3 8883.9 8917.5 7815.3 7837.0 7908.2 7928.4 7945.7 5865.2 5908.1 6002.0 6022.5 6044.8 5715.1 5865.5 5897.6 6022.8 6090.2 02:33:15 INFO - PROCESS | 6645 | 02:33:15 INFO - PROCESS | 6645 | [#4] prototype.html Cycles:180 Average:4340.39 Median:4737.39 stddev:1191.62 (25.2%) stddev-sans-first:1157.23 02:33:15 INFO - PROCESS | 6645 | Values: 376.9 379.5 381.0 386.9 389.7 4857.6 4869.9 4912.0 4912.5 4953.0 4252.5 4363.0 4700.7 4836.7 4844.5 3906.9 3971.8 4108.1 4125.4 4140.7 3289.0 3548.6 3787.0 4113.2 4166.9 4010.9 4139.7 4164.1 4165.6 4176.7 4002.3 4055.4 4080.3 4111.6 4211.2 3335.7 3759.3 3773.4 3794.2 3853.5 4794.4 4836.5 4838.9 4863.2 4898.7 4450.2 4703.7 4760.6 4767.6 4791.0 4989.8 5166.7 5176.7 5180.7 5192.5 3904.5 4260.7 4304.5 4306.2 4326.0 4732.4 5254.0 5269.5 5277.9 5571.5 3817.0 3838.7 4087.2 4099.0 4206.4 4139.7 4143.4 4166.9 4289.6 4301.9 4006.5 4103.9 4349.5 4475.7 4703.8 4785.9 4787.8 4894.6 5085.7 5228.9 1221.9 1340.4 1440.5 1476.3 1488.9 1021.7 1100.6 1109.4 1116.7 1134.8 4709.0 4713.8 4731.0 4736.0 4738.8 5014.9 5024.5 5208.4 5380.2 5386.4 4128.4 4356.2 4732.4 4776.7 4777.5 2591.5 2635.7 2665.9 2758.8 2767.4 5038.5 5104.0 5251.4 5478.7 5581.5 4368.7 4906.4 5449.9 5478.3 5490.8 4683.9 5471.5 5505.0 5530.7 5578.3 4755.7 5377.7 5394.3 5417.1 5434.5 4871.3 5222.3 5231.3 5273.9 5354.5 4816.4 4848.2 4873.9 5029.1 5527.4 3766.0 4286.8 4289.5 4308.8 4321.9 4414.5 4952.8 5065.6 5141.8 5370.4 4536.8 4578.4 4800.3 5178.6 5195.5 4528.8 5028.6 5158.9 5277.4 5304.0 4779.5 4942.3 5104.7 5132.9 5140.3 4653.2 4834.5 5072.6 5223.5 5327.2 4495.3 4750.7 4961.2 5181.4 5196.8 02:33:15 INFO - PROCESS | 6645 | 02:33:15 INFO - PROCESS | 6645 | [#5] yui.html Cycles:180 Average:20329.35 Median:16937.87 stddev:28969.15 (171.0%) stddev-sans-first:29013.08 02:33:15 INFO - PROCESS | 6645 | Values: 742.8 766.8 767.7 846.5 860.2 15778.9 15840.0 16593.8 17255.4 17358.9 15650.8 15773.4 15796.3 16786.2 17305.7 978.4 1001.7 1005.8 1006.3 1007.4 947.2 985.7 991.7 1003.1 1005.1 1048.8 1050.9 1051.0 1052.7 1053.4 1045.0 1046.3 1046.4 1047.0 1047.5 775.4 776.1 777.3 777.8 779.3 16280.7 16470.7 16504.5 17089.6 17324.6 14201.0 14432.6 14452.7 14489.3 14577.6 11673.9 11782.0 11816.8 11953.4 12398.8 3485.7 3533.0 3705.9 3797.1 3841.2 111647.0 115258.8 118041.4 118067.4 119987.0 10845.7 11098.4 11123.2 11373.6 11504.4 23285.7 23561.2 23572.4 23573.9 23606.9 7840.0 7842.8 7843.8 7935.5 8003.9 4282.3 4325.0 4432.3 4443.2 4451.4 3423.9 3512.4 3513.6 3523.8 3534.0 601.9 602.5 608.4 609.2 626.8 626.4 660.8 685.4 733.1 736.7 9582.5 10461.0 10492.6 10526.6 10654.8 662.5 709.1 713.4 715.2 715.8 4050.0 4635.4 5073.4 5077.7 5107.4 89074.0 98431.0 98998.0 103148.0 103704.0 57683.7 60175.7 80875.8 85664.0 86872.7 77972.0 78807.0 78973.0 79149.6 82329.0 11050.3 11087.6 11111.4 11249.8 11250.4 44274.1 47644.5 49324.0 51252.7 52567.9 59903.3 60527.1 62484.4 62672.4 63062.7 12445.3 12677.2 12818.7 12879.2 13063.5 14283.0 14460.7 14463.4 14647.2 15265.6 13181.3 13586.8 13804.9 13858.0 13884.7 11040.2 11359.4 11500.9 11502.8 13618.3 11910.4 13445.6 13599.5 14195.8 14715.9 9967.2 10067.7 10235.9 10245.5 10662.8 11305.3 11312.4 11343.8 11575.4 11672.9 02:33:15 INFO - PROCESS | 6645 | -------- Summary: end -------- 02:33:15 INFO - PROCESS | 6645 | 02:33:16 INFO - TEST-INFO | 6645: exit 0 02:33:16 INFO - TEST-OK | dromaeo_css | took 1118868ms 02:33:16 INFO - TEST-START | kraken 02:33:16 INFO - operating with platform_type : mac_ 02:33:16 INFO - Initialising browser for kraken test... 02:33:16 INFO - TEST-INFO | started process 6648 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/tmpJta2qa/profile http://localhost:57755/getInfo.html) 02:33:18 INFO - PROCESS | 6648 | __metrics Screen width/height:1600/1200 02:33:18 INFO - PROCESS | 6648 | colorDepth:24 02:33:18 INFO - PROCESS | 6648 | Browser inner width/height: 1024/689 02:33:18 INFO - PROCESS | 6648 | __metrics 02:33:18 INFO - PROCESS | 6648 | 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" 02:33:18 INFO - PROCESS | 6648 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:33:19 INFO - TEST-INFO | 6648: exit 0 02:33:19 INFO - Browser initialized. 02:33:19 INFO - Running cycle 1/1 for kraken test... 02:33:19 INFO - TEST-INFO | started process 6650 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/tmpJta2qa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:33:31 INFO - PROCESS | 6650 | RSS: Main: 193703936 02:33:31 INFO - PROCESS | 6650 | 02:33:33 INFO - PROCESS | 6650 | Cycle 1(1): loaded http://localhost:57755/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57755/tests/kraken/driver.html?testName=audio-beat-detection) 02:33:34 INFO - PROCESS | 6650 | RSS: Main: 245063680 02:33:34 INFO - PROCESS | 6650 | 02:33:37 INFO - PROCESS | 6650 | Cycle 1(1): loaded http://localhost:57755/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57755/tests/kraken/driver.html?testName=audio-dft) 02:33:38 INFO - PROCESS | 6650 | RSS: Main: 260517888 02:33:38 INFO - PROCESS | 6650 | 02:33:41 INFO - PROCESS | 6650 | Cycle 1(1): loaded http://localhost:57755/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57755/tests/kraken/driver.html?testName=audio-fft) 02:33:42 INFO - PROCESS | 6650 | RSS: Main: 356769792 02:33:42 INFO - PROCESS | 6650 | 02:33:44 INFO - PROCESS | 6650 | Cycle 1(1): loaded http://localhost:57755/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57755/tests/kraken/driver.html?testName=audio-oscillator) 02:33:44 INFO - PROCESS | 6650 | RSS: Main: 257576960 02:33:44 INFO - PROCESS | 6650 | 02:33:46 INFO - PROCESS | 6650 | Cycle 1(1): loaded http://localhost:57755/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57755/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:33:47 INFO - PROCESS | 6650 | RSS: Main: 260280320 02:33:47 INFO - PROCESS | 6650 | 02:33:50 INFO - PROCESS | 6650 | Cycle 1(1): loaded http://localhost:57755/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57755/tests/kraken/driver.html?testName=imaging-darkroom) 02:33:51 INFO - PROCESS | 6650 | RSS: Main: 299855872 02:33:51 INFO - PROCESS | 6650 | 02:33:54 INFO - PROCESS | 6650 | Cycle 1(1): loaded http://localhost:57755/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57755/tests/kraken/driver.html?testName=imaging-desaturate) 02:33:54 INFO - PROCESS | 6650 | RSS: Main: 301682688 02:33:54 INFO - PROCESS | 6650 | 02:33:57 INFO - PROCESS | 6650 | Cycle 1(1): loaded http://localhost:57755/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57755/tests/kraken/driver.html?testName=json-parse-financial) 02:33:58 INFO - PROCESS | 6650 | RSS: Main: 296706048 02:33:58 INFO - PROCESS | 6650 | 02:34:00 INFO - PROCESS | 6650 | Cycle 1(1): loaded http://localhost:57755/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57755/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:34:00 INFO - PROCESS | 6650 | RSS: Main: 276914176 02:34:00 INFO - PROCESS | 6650 | 02:34:02 INFO - PROCESS | 6650 | Cycle 1(1): loaded http://localhost:57755/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57755/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:34:03 INFO - PROCESS | 6650 | RSS: Main: 279404544 02:34:03 INFO - PROCESS | 6650 | 02:34:05 INFO - PROCESS | 6650 | Cycle 1(1): loaded http://localhost:57755/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57755/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:34:06 INFO - PROCESS | 6650 | RSS: Main: 286285824 02:34:06 INFO - PROCESS | 6650 | 02:34:08 INFO - PROCESS | 6650 | Cycle 1(1): loaded http://localhost:57755/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57755/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:34:09 INFO - PROCESS | 6650 | RSS: Main: 301170688 02:34:09 INFO - PROCESS | 6650 | 02:34:12 INFO - PROCESS | 6650 | Cycle 1(1): loaded http://localhost:57755/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57755/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:34:13 INFO - PROCESS | 6650 | RSS: Main: 294719488 02:34:13 INFO - PROCESS | 6650 | 02:34:15 INFO - PROCESS | 6650 | Cycle 1(1): loaded http://localhost:57755/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57755/tests/kraken/driver.html?testName=ai-astar) 02:34:15 INFO - PROCESS | 6650 | RSS: Main: 339464192 02:34:15 INFO - PROCESS | 6650 | 02:34:15 INFO - PROCESS | 6650 | __start_tp_report 02:34:15 INFO - PROCESS | 6650 | _x_x_mozilla_page_load 02:34:15 INFO - PROCESS | 6650 | _x_x_mozilla_page_load_details 02:34:15 INFO - PROCESS | 6650 | |i|pagename|runs| 02:34:15 INFO - PROCESS | 6650 | |0;ai-astar;104;113;113;114;114;114;113;113;113;114 02:34:15 INFO - PROCESS | 6650 | |1;audio-beat-detection;158;110;110;146;111;111;108;109;130;108 02:34:15 INFO - PROCESS | 6650 | |2;audio-dft;185;184;192;261;211;184;195;259;204;187 02:34:15 INFO - PROCESS | 6650 | |3;audio-fft;84;60;59;89;53;67;75;81;99;80 02:34:15 INFO - PROCESS | 6650 | |4;audio-oscillator;87;68;88;69;69;68;82;68;69;83 02:34:15 INFO - PROCESS | 6650 | |5;imaging-gaussian-blur;95;103;88;88;91;118;88;87;89;131 02:34:15 INFO - PROCESS | 6650 | |6;imaging-darkroom;99;95;95;94;95;95;95;95;95;95 02:34:15 INFO - PROCESS | 6650 | |7;imaging-desaturate;86;86;86;83;84;87;82;83;84;111 02:34:15 INFO - PROCESS | 6650 | |8;json-parse-financial;61;60;60;63;66;66;65;63;64;66 02:34:15 INFO - PROCESS | 6650 | |9;json-stringify-tinderbox;54;66;89;89;87;81;58;59;60;59 02:34:15 INFO - PROCESS | 6650 | |10;stanford-crypto-aes;83;81;86;83;84;83;84;81;87;89 02:34:15 INFO - PROCESS | 6650 | |11;stanford-crypto-ccm;136;138;138;140;135;142;138;140;183;149 02:34:15 INFO - PROCESS | 6650 | |12;stanford-crypto-pbkdf2;164;161;164;213;210;165;167;164;163;164 02:34:15 INFO - PROCESS | 6650 | |13;stanford-crypto-sha256-iterative;65;65;66;67;76;81;78;69;64;65 02:34:15 INFO - PROCESS | 6650 | __end_tp_report 02:34:15 INFO - PROCESS | 6650 | __start_cc_report 02:34:15 INFO - PROCESS | 6650 | _x_x_mozilla_cycle_collect,2276 02:34:15 INFO - PROCESS | 6650 | __end_cc_report 02:34:15 INFO - PROCESS | 6650 | __startTimestamp1496914455437__endTimestamp 02:34:15 INFO - PROCESS | 6650 | 02:34:15 INFO - PROCESS | 6650 | ------- Summary: start ------- 02:34:15 INFO - PROCESS | 6650 | Number of tests: 14 02:34:15 INFO - PROCESS | 6650 | 02:34:15 INFO - PROCESS | 6650 | [#0] ai-astar Cycles:10 Average:112.50 Median:113.50 stddev:3.03 (2.7%) stddev-sans-first:0.53 02:34:15 INFO - PROCESS | 6650 | Values: 104.0 113.0 113.0 114.0 114.0 114.0 113.0 113.0 113.0 114.0 02:34:15 INFO - PROCESS | 6650 | 02:34:15 INFO - PROCESS | 6650 | [#1] audio-beat-detection Cycles:10 Average:120.10 Median:111.00 stddev:18.23 (16.4%) stddev-sans-first:13.20 02:34:15 INFO - PROCESS | 6650 | Values: 158.0 110.0 110.0 146.0 111.0 111.0 108.0 109.0 130.0 108.0 02:34:15 INFO - PROCESS | 6650 | 02:34:15 INFO - PROCESS | 6650 | [#2] audio-dft Cycles:10 Average:206.20 Median:199.50 stddev:29.72 (14.9%) stddev-sans-first:30.52 02:34:15 INFO - PROCESS | 6650 | Values: 185.0 184.0 192.0 261.0 211.0 184.0 195.0 259.0 204.0 187.0 02:34:15 INFO - PROCESS | 6650 | 02:34:15 INFO - PROCESS | 6650 | [#3] audio-fft Cycles:10 Average:74.70 Median:80.50 stddev:14.69 (18.2%) stddev-sans-first:15.19 02:34:15 INFO - PROCESS | 6650 | Values: 84.0 60.0 59.0 89.0 53.0 67.0 75.0 81.0 99.0 80.0 02:34:15 INFO - PROCESS | 6650 | 02:34:15 INFO - PROCESS | 6650 | [#4] audio-oscillator Cycles:10 Average:75.10 Median:75.50 stddev:8.70 (11.5%) stddev-sans-first:8.09 02:34:15 INFO - PROCESS | 6650 | Values: 87.0 68.0 88.0 69.0 69.0 68.0 82.0 68.0 69.0 83.0 02:34:15 INFO - PROCESS | 6650 | 02:34:15 INFO - PROCESS | 6650 | [#5] imaging-gaussian-blur Cycles:10 Average:97.80 Median:88.00 stddev:15.18 (17.2%) stddev-sans-first:16.07 02:34:15 INFO - PROCESS | 6650 | Values: 95.0 103.0 88.0 88.0 91.0 118.0 88.0 87.0 89.0 131.0 02:34:15 INFO - PROCESS | 6650 | 02:34:15 INFO - PROCESS | 6650 | [#6] imaging-darkroom Cycles:10 Average:95.30 Median:95.00 stddev:1.34 (1.4%) stddev-sans-first:0.33 02:34:15 INFO - PROCESS | 6650 | Values: 99.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 02:34:15 INFO - PROCESS | 6650 | 02:34:15 INFO - PROCESS | 6650 | [#7] imaging-desaturate Cycles:10 Average:87.20 Median:85.00 stddev:8.52 (10.0%) stddev-sans-first:9.03 02:34:15 INFO - PROCESS | 6650 | Values: 86.0 86.0 86.0 83.0 84.0 87.0 82.0 83.0 84.0 111.0 02:34:15 INFO - PROCESS | 6650 | 02:34:15 INFO - PROCESS | 6650 | [#8] json-parse-financial Cycles:10 Average:63.40 Median:64.50 stddev:2.41 (3.7%) stddev-sans-first:2.40 02:34:15 INFO - PROCESS | 6650 | Values: 61.0 60.0 60.0 63.0 66.0 66.0 65.0 63.0 64.0 66.0 02:34:15 INFO - PROCESS | 6650 | 02:34:15 INFO - PROCESS | 6650 | [#9] json-stringify-tinderbox Cycles:10 Average:70.20 Median:73.50 stddev:14.49 (19.7%) stddev-sans-first:14.13 02:34:15 INFO - PROCESS | 6650 | Values: 54.0 66.0 89.0 89.0 87.0 81.0 58.0 59.0 60.0 59.0 02:34:15 INFO - PROCESS | 6650 | 02:34:15 INFO - PROCESS | 6650 | [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:84.00 stddev:2.56 (3.0%) stddev-sans-first:2.68 02:34:15 INFO - PROCESS | 6650 | Values: 83.0 81.0 86.0 83.0 84.0 83.0 84.0 81.0 87.0 89.0 02:34:15 INFO - PROCESS | 6650 | 02:34:15 INFO - PROCESS | 6650 | [#11] stanford-crypto-ccm Cycles:10 Average:143.90 Median:140.00 stddev:14.28 (10.2%) stddev-sans-first:14.86 02:34:15 INFO - PROCESS | 6650 | Values: 136.0 138.0 138.0 140.0 135.0 142.0 138.0 140.0 183.0 149.0 02:34:15 INFO - PROCESS | 6650 | 02:34:15 INFO - PROCESS | 6650 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.50 Median:164.50 stddev:20.10 (12.2%) stddev-sans-first:21.02 02:34:15 INFO - PROCESS | 6650 | Values: 164.0 161.0 164.0 213.0 210.0 165.0 167.0 164.0 163.0 164.0 02:34:15 INFO - PROCESS | 6650 | 02:34:15 INFO - PROCESS | 6650 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:68.00 stddev:6.29 (9.3%) stddev-sans-first:6.45 02:34:15 INFO - PROCESS | 6650 | Values: 65.0 65.0 66.0 67.0 76.0 81.0 78.0 69.0 64.0 65.0 02:34:15 INFO - PROCESS | 6650 | -------- Summary: end -------- 02:34:15 INFO - PROCESS | 6650 | 02:34:16 INFO - TEST-INFO | 6650: exit 0 02:34:16 INFO - TEST-OK | kraken | took 59960ms 02:34:16 INFO - SUITE-END | took 1178s 02:34:16 INFO - Completed test suite (00:19:39) 02:34:16 INFO - javascript benchmark 02:34:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7617.176711327132, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3320.1367644412453, 3351.798892066476, 3356.0770788033287, 3359.8488068036936, 3400.0, 5836.1245813128, 5879.971005074116, 5888.970555147218, 5904.822855314342, 5907.113932910055, 5739.51214146797, 5825.533957283418, 5882.058870580708, 5892.675902825343, 5909.084091965741, 5232.92150617741, 5257.815976440826, 5259.6055295852775, 5300.814471493499, 5364.5708343332635, 5204.9219261711105, 5209.296744939423, 5257.842264732045, 5293.311869456985, 5387.730613469331, 5336.38631557372, 5360.061989151903, 5364.088105022156, 5380.058489764295, 5383.919241211365, 5368.409474957752, 5377.516023557879, 5378.102655643845, 5378.542823859937, 5392.78428862847, 5098.4136824265315, 5147.202183661539, 5231.947680523184, 5293.550048245904, 5365.973170134163, 5699.68651724155, 5725.198472213893, 5728.312602487728, 5750.913736293959, 5754.510866576305, 6174.475169610589, 6232.0, 6232.594881332699, 6241.719122639447, 6250.187475628185, 6163.784267550659, 6209.099680546341, 6217.098520714471, 6279.183706118175, 6282.87434251317, 6035.0, 6045.939540604581, 6047.69761511927, 6066.332703402622, 6096.0, 6296.307406185316, 6332.430081292706, 6355.396237357444, 6364.904526432108, 6544.541882068304, 4432.711873728197, 6030.33666296707, 6038.758449662052, 6158.199434073542, 6234.2830574483605, 6295.433410993032, 6316.084167795736, 6316.526260530479, 6320.462760665395, 6332.651704156224, 6136.23297087864, 6325.209348831396, 6327.683615819191, 6340.4927605792345, 6351.142595749607, 6246.0, 6259.217597800275, 6273.686315684197, 6281.026440901667, 6313.684315784192, 4835.2505361669, 4835.984443266953, 4838.395200599925, 4840.515948405131, 4867.902641947141, 4318.093200427946, 4355.15074560464, 4371.169477799208, 4381.430414046154, 4393.472783265965, 5548.0845660466375, 5551.777928882881, 5577.888442231133, 5718.313802343745, 5725.227094342211, 6264.655443950626, 6266.968665156736, 6301.338359472281, 6306.49548036156, 6313.558050936482, 5697.059985102412, 5698.202251684767, 5707.71461426927, 5708.686022268732, 5727.31272247333, 5211.1662134059125, 5460.672359658433, 5464.972675136599, 5472.616916815864, 5482.150266708587, 6295.779647712308, 6305.96847015762, 6325.778597749057, 6327.936720632919, 6332.841678957879, 6242.28213755424, 6274.341194174728, 6298.275698294571, 6301.590396624205, 6327.810165695037, 6306.590071645328, 6332.176817013758, 6358.205224346957, 6361.141245931925, 6383.585066970632, 6345.587536810092, 6367.490600752021, 6370.77702280418, 6372.808815735535, 6374.872502550016, 6218.689065546614, 6259.718312675849, 6260.311365749855, 6260.812175634556, 6306.337834527309, 6302.558820882494, 6305.432511074026, 6306.085617585332, 6311.90532142009, 6312.05319202105, 6201.1628430163155, 6248.500119990299, 6287.528435367457, 6289.811305660837, 6317.241930968313, 5827.038538641077, 5863.618864773776, 5936.910946335722, 5957.225560677258, 6113.694315284307, 6091.60404573719, 6117.938820611737, 6118.0, 6121.510279177566, 6144.218176728698, 5869.589128760946, 5893.174955506147, 6109.175261339662, 6140.815775526741, 6144.56988010835], "value": 5755.827214505009, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [808.1231863428181, 823.7981694484852, 884.7080463447063, 892.6027917576681, 898.2768871058795, 32726.018219453425, 39787.40318895215, 40770.38844417329, 40857.38713919286, 40929.99999999996, 42170.57829421705, 42235.788821055925, 42280.57719422805, 42392.0, 42397.7880110599, 7448.068991376078, 9438.480883551401, 9574.904250957507, 9592.232621390307, 9610.183134433582, 7561.395088392916, 11386.886131138706, 11604.955554000138, 11780.93971542561, 11787.587434439796, 11574.016208622235, 11586.42067896606, 11588.768224635545, 11595.0, 11656.825147622792, 10764.461776911123, 11499.942500287487, 11553.017993470565, 11559.884401155965, 11583.247088939192, 10505.579776808918, 10651.946740266327, 11401.600943967005, 11409.828852567218, 11446.14153938458, 39114.0, 39139.41290880639, 39228.21543569113, 39264.21471570552, 39289.0, 3755.7518957652046, 3830.636089571486, 3870.2453021660785, 3886.8833934981712, 3934.783586902719, 27621.447571048666, 29131.126066218047, 29169.854150729323, 29740.55389169164, 29795.851020744758, 3060.709232622897, 3095.6440009398984, 3097.566340712302, 3108.4560201964564, 3111.2999575095423, 345724.0, 345735.0, 346419.0, 346697.0, 346713.0, 51783.48216517862, 51965.0, 52197.86812791245, 52276.0, 52296.0, 54089.0, 54327.6418089543, 54342.18486722702, 54355.72822135943, 54505.72747136239, 14931.0, 15047.87140964432, 15064.0, 15066.397344106332, 15070.945033847525, 13004.21974681522, 13016.479340826261, 13026.0, 13059.542915997894, 13112.147710398793, 11312.434378281054, 11907.166498345206, 11933.687294397609, 11978.041756659446, 12057.216280941711, 5685.459881311269, 5717.171010203498, 5719.799807006735, 5723.656580605177, 5731.570132240098, 1002.1131298800468, 1118.8084689805332, 1152.383474840956, 1165.650304908524, 1203.0330409780072, 26279.60580591293, 26423.47153056928, 26933.326666833094, 26958.460830783668, 27056.729432705815, 1186.5491113377034, 1233.2600439736086, 1247.8065899785547, 1259.395490164726, 1316.453671726242, 10123.949380253052, 10640.680779576625, 14028.298585070706, 14047.157170569799, 14055.226962516956, 423255.0, 424009.0, 429723.0, 569286.0, 571747.0, 41419.37870931938, 46975.29537056947, 47348.76325618419, 47478.76260618675, 47831.760841196265, 1266.5123927287875, 1408.978865317021, 1456.2354763748904, 1459.532949456185, 1459.7956286120163, 25741.97032118769, 26105.869470652524, 26211.868940655175, 26230.737692623592, 26769.464610708066, 38816.8354949352, 38950.0, 38992.83021509359, 39030.2193956125, 39051.80474097611, 431727.0, 432326.03021909395, 432586.0, 432793.0, 433606.0, 26886.32784180411, 27427.0, 27481.725182747916, 27552.173434796987, 27577.86211069012, 35342.0, 36040.27919441649, 36101.0, 36200.27599447944, 36264.09339766527, 25661.615075773505, 26035.609465857648, 26109.73890261149, 26406.603900941886, 27159.0, 25600.103996360038, 26226.0, 26449.471010580066, 26588.0, 26593.33516662099, 30583.929562466095, 30613.0, 30623.928162514207, 31931.0, 32537.83731081424, 28065.71934280631, 28269.717302827532, 28641.42717145687, 29004.274893126996, 29078.69145888398, 22334.657757804245, 23404.922167664514, 23413.0, 23479.295621131394, 23661.526769464857], "value": 18400.174528662203, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.5854955922383, 390.56061930328383, 405.1208876737479, 429.4781840064321, 456.9040501494686, 13239.669008274786, 15025.248737563119, 21857.453563660918, 22573.0, 23083.076676932946, 22944.0, 22988.425289367733, 23689.28932132039, 23825.761742382572, 23930.0, 5950.196723442323, 6234.937650623492, 6589.143411356517, 6699.6985135668765, 6747.4602031837585, 6450.4839612830865, 6668.666566671672, 6681.498887583426, 6738.056672065914, 6776.966115169417, 6714.865702685944, 6726.0, 6731.1922569291755, 6731.596104233738, 6737.326267373248, 5914.497267732248, 6462.579932304408, 6698.53110282278, 6768.864622707519, 6780.457563394916, 6583.242927063401, 6602.438792702626, 6606.042123892009, 6867.450603951722, 7186.065811444479, 25872.066910862028, 25872.482550349076, 27427.31431714203, 27720.584191237147, 27874.0, 2887.5091234490187, 2951.719586639266, 2995.6255468066493, 3008.714172153642, 3018.335966087457, 16655.917365371213, 16680.416185433573, 16781.993080415094, 17050.573735656584, 17162.22769975354, 2093.05445817617, 2116.132385721862, 2118.5762847430574, 2121.8514703970727, 2148.699182114505, 170583.0, 171401.14299428422, 172680.0, 175629.0, 176670.0, 16532.669346613002, 20525.38423847287, 20552.28067017647, 20829.479263018547, 21125.89437052805, 31931.84034079861, 31937.201569960936, 32520.512192317135, 32541.34917301688, 32574.674253257162, 10268.537915793808, 10460.215483838743, 10608.363498190134, 10659.84010239847, 10799.298045627167, 8817.635270541112, 8894.955525222462, 8904.287656987426, 9087.0, 9099.909000909905, 9520.571574279174, 9587.0, 9634.863136045558, 9752.609895604097, 9774.902250977542, 3486.8430920608635, 3767.888472900501, 3885.4560361549406, 3946.940795888064, 3967.5238971323624, 935.4153653966271, 1023.22746326523, 1026.7997740440542, 1041.5365162502615, 1064.7870425914848, 21020.0, 22009.559808803733, 22277.88861055717, 22293.777062229496, 22451.101955921582, 1067.6903697927514, 1069.1927594665976, 1071.807074726541, 1083.106437189322, 1099.71957150926, 10637.202209834293, 11446.255993360404, 11505.71235719097, 11520.0, 11527.76944461106, 653933.0, 742689.0, 751959.0, 775196.0, 780182.0, 140985.0, 142713.77276479782, 143320.0, 148938.0, 149780.75328870077, 1257.2205232755566, 1266.8479782426168, 1297.9935100324626, 1298.0, 1301.7786976214065, 18797.436076917715, 18958.43124706261, 19420.902895485997, 19475.026248687227, 19518.31685890987, 58223.417765821796, 64134.679326603065, 64519.677401612695, 65015.67492162698, 65428.0, 94012.0, 96010.51994739982, 97297.0, 97317.0, 97334.51332743291, 9524.666636667684, 11232.438378081226, 11443.027342675965, 11586.188966772244, 11934.52261909514, 13286.933565332112, 13309.267990260629, 13631.045826792426, 13731.931340343235, 13741.175529468264, 11145.832812507657, 11176.888231117584, 11233.0, 11681.357525336189, 11914.225575337576, 10524.421156836448, 10659.360438373722, 10709.0, 11048.226624136554, 11085.889141108808, 11585.07319414428, 11746.765064698488, 11805.350705711267, 11965.641030769091, 11975.820362694392, 11728.296302221894, 11746.412679366169, 11746.471408786796, 11789.233699809485, 12083.335416552174, 9896.42924654998, 11341.773164536828, 11402.600908968147, 11430.085593152362, 11683.766324673288], "value": 11759.972494633244, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1391.4781956766212, 1561.0633619828104, 1606.8152162501317, 1627.0481768165614, 1632.0941877258122, 9328.067193280676, 9747.463889486084, 10207.775066991953, 10974.835377469344, 11123.0, 10751.892481075187, 11220.326780393181, 11239.775204495925, 11249.831252531198, 11256.0, 2315.131825565413, 2364.467994701187, 2371.1937941100023, 2374.0, 2378.500514891875, 1974.5655955689726, 2040.5918816236738, 2042.611903738285, 2048.5902819436096, 2055.6916462530667, 1898.5823118913886, 2023.180611852195, 2339.7833126774067, 2340.719113706349, 2343.16817529777, 2337.1118974789556, 2337.7194736631627, 2339.3683705399617, 2340.578695834749, 2344.9648255276184, 2247.6291411917014, 2259.6836442898007, 2283.200879692111, 2298.425393651587, 2298.7816157465013, 10997.780044399147, 11072.0, 11086.16853735965, 11092.500837462252, 11159.051480624157, 5465.863353416156, 5637.238972738669, 5651.039323315046, 5660.688662123582, 5669.149627555858, 2845.587389828484, 3162.596426715713, 3508.122969257686, 3567.661072198163, 3572.678458938708, 1127.9266847654876, 1147.7933971885057, 1165.9125565582615, 1173.4426147579916, 1204.807230843061, 15836.920815395964, 16009.199540023068, 16039.27823247945, 16040.438584649599, 16092.517224483285, 4434.933475997863, 4658.440987081572, 4663.207254766698, 4719.009008108267, 4731.621470282369, 13025.0, 13028.218306901616, 13037.739245215043, 13037.804432933513, 13041.0, 5516.062269414209, 5641.464060914206, 5652.067408877571, 5652.9152062719095, 5718.885622287531, 4904.313396124546, 5058.418281897555, 5097.745112744422, 5103.489651034867, 5175.585953123741, 3321.236115693404, 3609.4224924012033, 3683.0, 3734.3091528067393, 3746.550413950289, 870.4864130163234, 933.1741408853214, 947.0671388682142, 949.4445749236636, 951.6914242915991, 844.9028361738356, 932.0, 947.4836214263244, 969.9757506062405, 1009.5103874620803, 6651.800445986628, 6668.399844013965, 6719.832004199934, 6921.446284297244, 6933.2720064393525, 1028.5011769291887, 1038.1539045677748, 1062.6705721226444, 1062.9893701063045, 1073.5169173871789, 3614.3855544557487, 4103.343465045578, 4170.311898536707, 4269.932516870782, 4419.535948725402, 12872.613821585368, 13973.301334933416, 14074.859251407559, 14158.079724817853, 14162.85837141636, 13579.864201358057, 13802.240876751674, 14076.014678972373, 14080.859191408159, 14098.365573549216, 9201.079892010745, 10288.12550933179, 10333.0, 10425.478726063819, 10445.895541044492, 6413.935860641521, 6492.163338312798, 6509.576877502947, 6581.14445122131, 6617.139771829631, 12103.33431661267, 12111.394430278628, 12153.149279550347, 12268.877311226774, 12400.19398739079, 12341.444634991267, 12422.813657795321, 12493.687657808627, 12608.0, 12639.05207109489, 7356.411487081128, 8618.569071546523, 8618.741437756877, 8910.688125915562, 9391.436513809193, 10528.473576321307, 10635.255532112678, 10732.73168170802, 10741.355518668905, 10751.408672522773, 7742.225777422213, 8958.596863141043, 8989.505577193317, 9041.457512549268, 9134.0, 8791.5164665944, 8824.117588241124, 8872.334574907038, 8883.911160888309, 8917.464952102895, 7815.335696465864, 7837.020372453443, 7908.209179082046, 7928.405369597419, 7945.682172713026, 5865.208196893364, 5908.084246941731, 6002.009668404664, 6022.45797878193, 6044.758209671564, 5715.114157305624, 5865.530757539302, 5897.557683173865, 6022.789202377896, 6090.23872015998], "value": 5070.651301407673, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.87186356638745, 379.5483374784007, 381.0226768339208, 386.9090763670538, 389.73303287248257, 4857.562819346258, 4869.904271538902, 4911.96848661781, 4912.459629440763, 4953.0, 4252.493021537109, 4362.974700945275, 4700.670953033289, 4836.709797412158, 4844.467108618049, 3906.882793516185, 3971.8212680429306, 4108.062735144371, 4125.401816736571, 4140.710150289481, 3288.993713834559, 3548.574171099459, 3787.0, 4113.239050775616, 4166.916541729135, 4010.9170523958514, 4139.668826493873, 4164.105332073899, 4165.58344165584, 4176.665866730655, 4002.2595819773437, 4055.4322394864744, 4080.285949958775, 4111.6299533042165, 4211.178820130076, 3335.7498187636024, 3759.3045286622064, 3773.3773927301963, 3794.1842503861526, 3853.5183102112237, 4794.448638406593, 4836.492168322311, 4838.85483435494, 4863.2461968394955, 4898.681585696918, 4450.1767173073085, 4703.670743047988, 4760.595349395306, 4767.618590512785, 4791.0178413425165, 4989.775460104304, 5166.689998600096, 5176.6893986360565, 5180.715060671661, 5192.454792246797, 3904.511936007999, 4260.676672195661, 4304.5480224576595, 4306.181825453185, 4325.956740432587, 4732.408448943882, 5253.9772187708, 5269.473052694738, 5277.86805329866, 5571.526420254283, 3816.9809150954625, 3838.7120965927666, 4087.243859885871, 4099.0162361033135, 4206.41110244566, 4139.710220284551, 4143.440635514227, 4166.8749937501925, 4289.6139347458875, 4301.859642461021, 4006.5359803720503, 4103.871435355301, 4349.499807522176, 4475.679674496031, 4703.83536576225, 4785.904281914342, 4787.826982389337, 4894.583960363338, 5085.669431486942, 5228.895422091537, 1221.9450124744408, 1340.4316949169495, 1440.5462279381961, 1476.2766244540312, 1488.8660020597981, 1021.7139201023725, 1100.6312885183393, 1109.384291718088, 1116.7096554895786, 1134.750354921916, 4709.0, 4713.764311784397, 4730.9763451182525, 4735.95264047362, 4738.8341408050555, 5014.874628134253, 5024.547790698782, 5208.401033881152, 5380.224525906441, 5386.434424385461, 4128.422020917074, 4356.172327257874, 4732.432108147044, 4776.659436875975, 4777.522247775195, 2591.481703659238, 2635.71007189209, 2665.853378064225, 2758.7655049321033, 2767.4262935469806, 5038.546530812245, 5103.974480127576, 5251.4485978972425, 5478.657728856376, 5581.469760372758, 4368.650507959355, 4906.386701662293, 5449.891002180014, 5478.329109621524, 5490.835274941758, 4683.859484215479, 5471.50756431923, 5505.0, 5530.668159910419, 5578.330600327987, 4755.738434386142, 5377.660717587862, 5394.306952950958, 5417.074779619119, 5434.538064264581, 4871.34236878017, 5222.2688823565495, 5231.29377534028, 5273.894522109613, 5354.527504936018, 4816.373871396696, 4848.248521479177, 4873.926891096566, 5029.108262749007, 5527.419620939743, 3765.981170094132, 4286.828526859015, 4289.485261768607, 4308.763018034038, 4321.870343889688, 4414.536473670347, 4952.826651067196, 5065.645404821627, 5141.794328226829, 5370.355557333145, 4536.795844186953, 4578.381918441101, 4800.3279540863605, 5178.611604129781, 5195.480451954925, 4528.818847246073, 5028.59771218309, 5158.85309960916, 5277.366715994105, 5304.0, 4779.474257831566, 4942.33114118372, 5104.719240441811, 5132.871678208075, 5140.329392947382, 4653.232216684344, 4834.492378300228, 5072.630389794661, 5223.52988231061, 5327.242010136568, 4495.291384607646, 4750.738709371018, 4961.156603377362, 5181.3575076710395, 5196.766145523385], "value": 3995.4878940490157, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [742.7734540965004, 766.758471081609, 767.6660652616113, 846.5259454705365, 860.2343913916613, 15778.895477316593, 15840.0, 16593.834061659396, 17255.396061137864, 17358.913205433986, 15650.843491565081, 15773.369065237406, 15796.289166987484, 16786.160691965382, 17305.653886922253, 978.427619842393, 1001.7295330260825, 1005.7938122684868, 1006.2805094357533, 1007.4459047523869, 947.1759569174827, 985.7289245457484, 991.6826615483048, 1003.1322905686565, 1005.1054561440324, 1048.7535429174138, 1050.9316894401838, 1050.994745026274, 1052.736815796051, 1053.3627155570884, 1045.0, 1046.2937517175876, 1046.3564907581858, 1047.0158051431629, 1047.4657924458504, 775.3758224629171, 776.1036003416064, 777.2693667952107, 777.8483195776826, 779.3414564692825, 16280.674386512203, 16470.6705865882, 16504.504864854072, 17089.57276068096, 17324.56688582783, 14201.0, 14432.567022989328, 14452.710945781131, 14489.347979340955, 14577.635559111, 11673.883261167364, 11782.0, 11816.763664726743, 11953.40232988347, 12398.81401778974, 3485.686288234071, 3532.964670353315, 3705.888823335304, 3797.1456422305037, 3841.154945911895, 111647.0, 115258.84741152481, 118041.40979295134, 118067.40966295113, 119987.0, 10845.728856778485, 11098.389588572545, 11123.210485828733, 11373.601923932623, 11504.42477876103, 23285.650715239284, 23561.175358862358, 23572.410689732893, 23573.882130589238, 23606.881965590404, 7839.960800196077, 7842.764717058498, 7843.803904902309, 7935.484193527403, 8003.8799418008775, 4282.314829627245, 4324.956750432519, 4432.2908334666945, 4443.23414368468, 4451.421315229064, 3423.863045478203, 3512.438009918452, 3513.578370595545, 3523.8238088096005, 3534.0, 601.9405845711492, 602.457787990803, 608.4402349838159, 609.2141137932107, 626.8150895485843, 626.4111734969115, 660.8182749743859, 685.3968507713181, 733.1275781819618, 736.7237286017744, 9582.472963987047, 10461.0, 10492.580296788195, 10526.578936842594, 10654.840177397346, 662.456785435938, 709.1454796969639, 713.375796178344, 715.2168375628678, 715.7995761186876, 4049.987503124219, 4635.443746750411, 5073.3911930568565, 5077.669951453144, 5107.387113546398, 89074.0, 98431.0, 98998.0, 103148.0, 103703.96296036943, 57683.71158144182, 60175.69912150411, 80875.78686319709, 85664.0, 86872.6969095464, 77972.0, 78807.0, 78972.99999999885, 79149.60425197837, 82329.0, 11050.281731687415, 11087.611933582286, 11111.44442777874, 11249.775004500028, 11250.381229032155, 44274.114517710106, 47644.52355476401, 49324.0, 51252.74373628257, 52567.94864102773, 59903.30435130342, 60527.10452174942, 62484.37515624786, 62672.43318916881, 63062.68468657627, 12445.315507647167, 12677.239365638092, 12818.67953301175, 12879.227246365248, 13063.542776002794, 14283.0, 14460.710785784437, 14463.421463141778, 14647.19440430744, 15265.618359540656, 13181.275029873448, 13586.845118165067, 13804.861951380357, 13858.0, 13884.722305554034, 11040.227184097035, 11359.432028398713, 11500.884991149982, 11502.769944601228, 13618.319084045559, 11910.404479776149, 13445.596632101053, 13599.470512418637, 14195.787063194268, 14715.882221171487, 9967.202623790225, 10067.748306292402, 10235.948820255851, 10245.538950747383, 10662.786744265226, 11305.26515776472, 11312.418470519453, 11343.829842552534, 11575.363355015555, 11672.941635291769], "value": 7740.166215442004, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1473.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 113.0, 114.0, 114.0, 114.0, 113.0, 113.0, 113.0, 114.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 110.0, 110.0, 146.0, 111.0, 111.0, 108.0, 109.0, 130.0, 108.0], "value": 120.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 192.0, 261.0, 211.0, 184.0, 195.0, 259.0, 204.0, 187.0], "value": 206.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 60.0, 59.0, 89.0, 53.0, 67.0, 75.0, 81.0, 99.0, 80.0], "value": 74.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 68.0, 88.0, 69.0, 69.0, 68.0, 82.0, 68.0, 69.0, 83.0], "value": 75.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 103.0, 88.0, 88.0, 91.0, 118.0, 88.0, 87.0, 89.0, 131.0], "value": 97.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 86.0, 83.0, 84.0, 87.0, 82.0, 83.0, 84.0, 111.0], "value": 87.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 60.0, 63.0, 66.0, 66.0, 65.0, 63.0, 64.0, 66.0], "value": 63.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 66.0, 89.0, 89.0, 87.0, 81.0, 58.0, 59.0, 60.0, 59.0], "value": 70.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 86.0, 83.0, 84.0, 83.0, 84.0, 81.0, 87.0, 89.0], "value": 84.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 138.0, 138.0, 140.0, 135.0, 142.0, 138.0, 140.0, 183.0, 149.0], "value": 143.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 161.0, 164.0, 213.0, 210.0, 165.0, 167.0, 164.0, 163.0, 164.0], "value": 173.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 67.0, 76.0, 81.0, 78.0, 69.0, 64.0, 65.0], "value": 69.6, "unit": "score"}]}]} 02:34:16 INFO - Return code: 0 02:34:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:34:16 INFO - # TBPL SUCCESS # 02:34:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:34:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:34:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:34:16 INFO - 2017-06-08 02:34:16.790 screenresolution[6654:125888] starting screenresolution argv=screenresolution get 02:34:16 INFO - 2017-06-08 02:34:16.793 screenresolution[6654:125888] Display 0: 1600x1200x32@60 02:34:16 INFO - 2017-06-08 02:34:16.798 screenresolution[6655:125891] starting screenresolution argv=screenresolution list 02:34:16 INFO - Available Modes on Display 0 02:34:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:34:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:34:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:34:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:34:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:34:17 INFO - Intel Iris: 02:34:17 INFO - Chipset Model: Intel Iris 02:34:17 INFO - Type: GPU 02:34:17 INFO - Bus: Built-In 02:34:17 INFO - VRAM (Dynamic, Max): 1536 MB 02:34:17 INFO - Vendor: Intel (0x8086) 02:34:17 INFO - Device ID: 0x0a2e 02:34:17 INFO - Revision ID: 0x0009 02:34:17 INFO - Displays: 02:34:17 INFO - Display: 02:34:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:34:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:34:17 INFO - Display Serial Number: 1600x1200 60 02:34:17 INFO - Main Display: Yes 02:34:17 INFO - Mirror: Off 02:34:17 INFO - Online: Yes 02:34:17 INFO - Rotation: Supported 02:34:17 INFO - Return code: 0 02:34:17 INFO - Running post-action listener: _resource_record_post_action 02:34:17 INFO - [mozharness: 2017-06-08 09:34:17.032814Z] Finished run-tests step (success) 02:34:17 INFO - Running post-run listener: _resource_record_post_run 02:34:17 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 1371136; Write bytes: 509248512; Read time: 17; Write time: 1636 02:34:17 INFO - TinderboxPrint: CPU usage
54.1% 02:34:17 INFO - TinderboxPrint: I/O read bytes / time
1,371,136 / 17 02:34:17 INFO - TinderboxPrint: I/O write bytes / time
509,248,512 / 1,636 02:34:17 INFO - TinderboxPrint: CPU idle
2,204.4 (45.9%) 02:34:17 INFO - TinderboxPrint: CPU system
963.5 (20.1%) 02:34:17 INFO - TinderboxPrint: CPU user
1,633.7 (34.0%) 02:34:17 INFO - TinderboxPrint: Swap in / out
211,013,632 / 0 02:34:17 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 206109184; Write bytes: 202864640; Read time: 15667; Write time: 460 02:34:17 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 1326080; Write bytes: 295246848; Read time: 16; Write time: 1135 02:34:17 INFO - Running post-run listener: _upload_blobber_files 02:34:17 INFO - Blob upload gear active. 02:34:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:34:17 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:34:17 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'] 02:34:17 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 02:34:17 INFO - (blobuploader) - INFO - Open directory for files ... 02:34:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:34:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:34:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:34:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:34:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:34:19 INFO - (blobuploader) - INFO - Done attempting. 02:34:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:34:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:34:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:34:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:34:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:34:19 INFO - (blobuploader) - INFO - Done attempting. 02:34:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:34:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:34:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:34:20 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:34:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:34:20 INFO - (blobuploader) - INFO - Done attempting. 02:34:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:34:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:34:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:34:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:34:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:34:22 INFO - (blobuploader) - INFO - Done attempting. 02:34:22 INFO - (blobuploader) - INFO - Iteration through files over. 02:34:22 INFO - Return code: 0 02:34:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:34:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:34:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e49ba306662320af324415dc89c917a08faa7e2e38b7ef55498797c40d19aa09dcdfee705b51a15048aedaf6d5e64e13d403112adf0070e43d8ca5ba5d0dc115", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/71fb894c1c2f469f85dd63fb603cb333eb1223be45668f2429e21f21c98801a227dcd31b062dddeb27ad7f80b3f1bc46b4a37040957461d6d5dcb941fa524b07", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e261f3e05f507b95cc4227e08920c9b668e83f672364a6da9ffc74eddc261b36956200acdf7aa2c6412db4f759226f545324864bd2bdc9d875eb49f1958a18d6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5dad7d93e9a7debed28c6514de41166095be26ebf5d154fb9b1e170872a98728ffe99f4371b84541e7731e050da8c704dce4b10ee3a9d0899e8603e4a305cf9c"} 02:34:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:34:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:34:22 INFO - Contents: 02:34:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e49ba306662320af324415dc89c917a08faa7e2e38b7ef55498797c40d19aa09dcdfee705b51a15048aedaf6d5e64e13d403112adf0070e43d8ca5ba5d0dc115", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/71fb894c1c2f469f85dd63fb603cb333eb1223be45668f2429e21f21c98801a227dcd31b062dddeb27ad7f80b3f1bc46b4a37040957461d6d5dcb941fa524b07", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e261f3e05f507b95cc4227e08920c9b668e83f672364a6da9ffc74eddc261b36956200acdf7aa2c6412db4f759226f545324864bd2bdc9d875eb49f1958a18d6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5dad7d93e9a7debed28c6514de41166095be26ebf5d154fb9b1e170872a98728ffe99f4371b84541e7731e050da8c704dce4b10ee3a9d0899e8603e4a305cf9c"} 02:34:22 INFO - Running post-run listener: copy_logs_to_upload_dir 02:34:22 INFO - Copying logs to upload dir... 02:34:22 INFO - mkdir: /builds/slave/test/build/upload/logs 02:34:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.397626 ========= master_lag: 2.19 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2017-06-08 02:34:24.945460) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-08 02:34:24.949544) ========= 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.97uYPuZVzx/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.m6fZ8wET5b/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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/e49ba306662320af324415dc89c917a08faa7e2e38b7ef55498797c40d19aa09dcdfee705b51a15048aedaf6d5e64e13d403112adf0070e43d8ca5ba5d0dc115", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/71fb894c1c2f469f85dd63fb603cb333eb1223be45668f2429e21f21c98801a227dcd31b062dddeb27ad7f80b3f1bc46b4a37040957461d6d5dcb941fa524b07", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e261f3e05f507b95cc4227e08920c9b668e83f672364a6da9ffc74eddc261b36956200acdf7aa2c6412db4f759226f545324864bd2bdc9d875eb49f1958a18d6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5dad7d93e9a7debed28c6514de41166095be26ebf5d154fb9b1e170872a98728ffe99f4371b84541e7731e050da8c704dce4b10ee3a9d0899e8603e4a305cf9c"} build_url:https://queue.taskcluster.net/v1/task/PciA_TQOQl-ieW8oGe_nrA/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011130 build_url: 'https://queue.taskcluster.net/v1/task/PciA_TQOQl-ieW8oGe_nrA/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/e49ba306662320af324415dc89c917a08faa7e2e38b7ef55498797c40d19aa09dcdfee705b51a15048aedaf6d5e64e13d403112adf0070e43d8ca5ba5d0dc115", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/71fb894c1c2f469f85dd63fb603cb333eb1223be45668f2429e21f21c98801a227dcd31b062dddeb27ad7f80b3f1bc46b4a37040957461d6d5dcb941fa524b07", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e261f3e05f507b95cc4227e08920c9b668e83f672364a6da9ffc74eddc261b36956200acdf7aa2c6412db4f759226f545324864bd2bdc9d875eb49f1958a18d6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5dad7d93e9a7debed28c6514de41166095be26ebf5d154fb9b1e170872a98728ffe99f4371b84541e7731e050da8c704dce4b10ee3a9d0899e8603e4a305cf9c"}' ========= master_lag: 0.10 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-08 02:34:25.064166) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-08 02:34:25.064486) ========= 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.97uYPuZVzx/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.m6fZ8wET5b/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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.005330 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-08 02:34:25.092808) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-08 02:34:25.093487) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-08 02:34:25.094244) ========= ========= Total master_lag: 2.38 =========