builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0265 starttime: 1493284435.49 results: success (0) buildid: 20170427004028 builduid: d422d9e9691b4d69bc8df63b780f2a1f revision: 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-27 02:13:55.495234) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-27 02:13:55.495725) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-27 02:13:55.496024) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-27 02:13:55.523132) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-27 02:13:55.523453) ========= 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.LptxlqJa1L/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.KTWt4od89l/Listeners TMPDIR=/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/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-04-27 02:13:55-- 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% 219M=0s 2017-04-27 02:13:55 (219 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.137139 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-27 02:13:55.685952) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-27 02:13:55.686321) ========= 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.LptxlqJa1L/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.KTWt4od89l/Listeners TMPDIR=/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/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.026959 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-27 02:13:55.736111) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-27 02:13:55.736485) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.LptxlqJa1L/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.KTWt4od89l/Listeners TMPDIR=/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/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-04-27 02:13:55,846 truncating revision to first 12 chars 2017-04-27 02:13:55,846 Setting DEBUG logging. 2017-04-27 02:13:55,846 attempt 1/10 2017-04-27 02:13:55,846 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/94b7e538af7d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-27 02:13:57,473 unpacking tar archive at: mozilla-aurora-94b7e538af7d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.895730 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-27 02:13:57.658261) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-27 02:13:57.658776) ========= script_repo_revision: 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-27 02:13:57.659414) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-27 02:13:57.659862) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-27 02:13:57.681910) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-04-27 02:13:57.682369) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.LptxlqJa1L/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.KTWt4od89l/Listeners TMPDIR=/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/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:57 INFO - MultiFileLogger online at 20170427 02:13:57 in /builds/slave/test 02:13:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:13:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:13:57 INFO - {'append_to_log': False, 02:13:57 INFO - 'base_work_dir': '/builds/slave/test', 02:13:57 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:13:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:13:57 INFO - 'branch': 'Mozilla-Aurora', 02:13:57 INFO - 'buildbot_json_path': 'buildprops.json', 02:13:57 INFO - 'config_files': ('talos/mac_config.py',), 02:13:57 INFO - 'default_actions': ('clobber', 02:13:57 INFO - 'read-buildbot-config', 02:13:57 INFO - 'download-and-extract', 02:13:57 INFO - 'populate-webroot', 02:13:57 INFO - 'create-virtualenv', 02:13:57 INFO - 'install', 02:13:57 INFO - 'run-tests'), 02:13:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:13:57 INFO - 'download_minidump_stackwalk': True, 02:13:57 INFO - 'download_symbols': 'ondemand', 02:13:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:13:57 INFO - 'tooltool.py': '/tools/tooltool.py', 02:13:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:13:57 INFO - '/tools/misc-python/virtualenv.py')}, 02:13:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:13:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:13:57 INFO - 'gecko_profile': False, 02:13:57 INFO - 'gecko_profile_interval': 0, 02:13:57 INFO - 'installer_path': 'installer.exe', 02:13:57 INFO - 'log_level': 'info', 02:13:57 INFO - 'log_name': 'talos', 02:13:57 INFO - 'log_to_console': True, 02:13:57 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:13:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:13:57 INFO - 'opt_config_files': (), 02:13:57 INFO - 'pip_index': False, 02:13:57 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:13:57 INFO - 'cmd': ('bash', 02:13:57 INFO - '-c', 02:13:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:13:57 INFO - 'enabled': True, 02:13:57 INFO - 'halt_on_failure': False, 02:13:57 INFO - 'name': 'check_screen_resolution'},), 02:13:57 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:13:57 INFO - 'cmd': ('bash', 02:13:57 INFO - '-c', 02:13:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:13:57 INFO - 'enabled': True, 02:13:57 INFO - 'halt_on_failure': False, 02:13:57 INFO - 'name': 'check_screen_resolution'},), 02:13:57 INFO - 'run_cmd_checks_enabled': True, 02:13:57 INFO - 'suite': 'dromaeojs-e10s', 02:13:57 INFO - 'system_bits': '32', 02:13:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:13:57 INFO - 'title': 't-yosemite-r7-0265', 02:13:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:13:57 INFO - 'use_talos_json': True, 02:13:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:13:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:13:57 INFO - 'work_dir': 'build'} 02:13:57 INFO - [mozharness: 2017-04-27 09:13:57.900650Z] Running clobber step. 02:13:57 INFO - Running pre-action listener: _resource_record_pre_action 02:13:57 INFO - Running main action method: clobber 02:13:57 INFO - rmtree: /builds/slave/test/build 02:13:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:14:00 INFO - Running post-action listener: _resource_record_post_action 02:14:00 INFO - [mozharness: 2017-04-27 09:14:00.383690Z] Finished clobber step (success) 02:14:00 INFO - [mozharness: 2017-04-27 09:14:00.383830Z] Running read-buildbot-config step. 02:14:00 INFO - Running pre-action listener: _resource_record_pre_action 02:14:00 INFO - Running main action method: read_buildbot_config 02:14:00 INFO - Using buildbot properties: 02:14:00 INFO - { 02:14:00 INFO - "project": "", 02:14:00 INFO - "product": "firefox", 02:14:00 INFO - "script_repo_revision": "production", 02:14:00 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 02:14:00 INFO - "repository": "", 02:14:00 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 02:14:00 INFO - "buildid": "20170427004028", 02:14:00 INFO - "stage_platform": "macosx64", 02:14:00 INFO - "basedir": "/builds/slave/test", 02:14:00 INFO - "nightly_build": "True", 02:14:00 INFO - "buildnumber": 20, 02:14:00 INFO - "slavename": "t-yosemite-r7-0265", 02:14:00 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 02:14:00 INFO - "platform": "yosemite_r7", 02:14:00 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:14:00 INFO - "branch": "mozilla-aurora", 02:14:00 INFO - "repo_path": "releases/mozilla-aurora", 02:14:00 INFO - "revision": "94b7e538af7dbb9a6567cad9125c2f5411e7fb80", 02:14:00 INFO - "pgo_build": "False", 02:14:00 INFO - "builduid": "d422d9e9691b4d69bc8df63b780f2a1f", 02:14:00 INFO - "slavebuilddir": "test" 02:14:00 INFO - } 02:14:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/Y7auEGk7T6mmt4dNvRVQIg/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 02:14:00 INFO - Running post-action listener: _resource_record_post_action 02:14:00 INFO - [mozharness: 2017-04-27 09:14:00.388177Z] Finished read-buildbot-config step (success) 02:14:00 INFO - [mozharness: 2017-04-27 09:14:00.388315Z] Running download-and-extract step. 02:14:00 INFO - Running pre-action listener: _resource_record_pre_action 02:14:00 INFO - Running main action method: download_and_extract 02:14:00 INFO - mkdir: /builds/slave/test/build/tests 02:14:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:14:00 INFO - trying https://queue.taskcluster.net/v1/task/Y7auEGk7T6mmt4dNvRVQIg/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 02:14:00 INFO - Downloading https://queue.taskcluster.net/v1/task/Y7auEGk7T6mmt4dNvRVQIg/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 02:14:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y7auEGk7T6mmt4dNvRVQIg/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json'}, attempt #1 02:14:01 INFO - Downloaded 1199 bytes. 02:14:01 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 02:14:01 INFO - Using the following test package requirements: 02:14:01 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 02:14:01 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:14:01 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 02:14:01 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:14:01 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 02:14:01 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:14:01 INFO - u'jsshell-mac.zip'], 02:14:01 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:14:01 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 02:14:01 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 02:14:01 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:14:01 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 02:14:01 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:14:01 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 02:14:01 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:14:01 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 02:14:01 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:14:01 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 02:14:01 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:14:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y7auEGk7T6mmt4dNvRVQIg/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 02:14:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y7auEGk7T6mmt4dNvRVQIg/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:14:01 INFO - Fetch https://queue.taskcluster.net/v1/task/Y7auEGk7T6mmt4dNvRVQIg/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 02:14:02 INFO - Expected file size: 51791492 02:14:02 INFO - Obtained file size: 51791492 02:14:19 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip', u'firefox-54.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:14:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y7auEGk7T6mmt4dNvRVQIg/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 02:14:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y7auEGk7T6mmt4dNvRVQIg/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:14:19 INFO - Fetch https://queue.taskcluster.net/v1/task/Y7auEGk7T6mmt4dNvRVQIg/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 02:14:20 INFO - Expected file size: 51791492 02:14:20 INFO - Obtained file size: 51791492 02:14:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y7auEGk7T6mmt4dNvRVQIg/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 02:14:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y7auEGk7T6mmt4dNvRVQIg/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:14:36 INFO - Fetch https://queue.taskcluster.net/v1/task/Y7auEGk7T6mmt4dNvRVQIg/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 02:14:37 INFO - Expected file size: 14404424 02:14:37 INFO - Obtained file size: 14404424 02:14:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:14:37 INFO - trying https://queue.taskcluster.net/v1/task/Y7auEGk7T6mmt4dNvRVQIg/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 02:14:37 INFO - Downloading https://queue.taskcluster.net/v1/task/Y7auEGk7T6mmt4dNvRVQIg/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 02:14:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y7auEGk7T6mmt4dNvRVQIg/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg'}, attempt #1 02:14:40 INFO - Downloaded 74781899 bytes. 02:14:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Y7auEGk7T6mmt4dNvRVQIg/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 02:14:40 INFO - mkdir: /builds/slave/test/properties 02:14:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:14:40 INFO - Writing to file /builds/slave/test/properties/build_url 02:14:40 INFO - Contents: 02:14:40 INFO - build_url:https://queue.taskcluster.net/v1/task/Y7auEGk7T6mmt4dNvRVQIg/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 02:14:41 INFO - Running post-action listener: _resource_record_post_action 02:14:41 INFO - Running post-action listener: set_extra_try_arguments 02:14:41 INFO - [mozharness: 2017-04-27 09:14:41.250671Z] Finished download-and-extract step (success) 02:14:41 INFO - [mozharness: 2017-04-27 09:14:41.250798Z] Running populate-webroot step. 02:14:41 INFO - Running pre-action listener: _resource_record_pre_action 02:14:41 INFO - Running main action method: populate_webroot 02:14:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:14:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:14:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:14:41 INFO - '--tppagecycles', 02:14:41 INFO - '7'], 02:14:41 INFO - 'tests': ['tsvgm']}}, 02:14:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:14:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:14:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:14:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:14:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:14:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:14:41 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:14:41 INFO - 'talos_options': ['--disable-e10s'], 02:14:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:14:41 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:14:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:14:41 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:14:41 INFO - 'talos_options': ['--disable-e10s'], 02:14:41 INFO - 'tests': ['damp', 'tps']}, 02:14:41 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:14:41 INFO - 'tests': ['damp', 'tps']}, 02:14:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:14:41 INFO - 'tests': ['dromaeo_dom']}, 02:14:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:14:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:14:41 INFO - 'tests': ['basic_compositor_video']}, 02:14:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:14:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:14:41 INFO - 'tests': ['a11yr', 02:14:41 INFO - 'ts_paint', 02:14:41 INFO - 'tpaint', 02:14:41 INFO - 'sessionrestore', 02:14:41 INFO - 'sessionrestore_no_auto_restore', 02:14:41 INFO - 'tabpaint']}, 02:14:41 INFO - 'other-e10s': {'tests': ['a11yr', 02:14:41 INFO - 'ts_paint', 02:14:41 INFO - 'tpaint', 02:14:41 INFO - 'sessionrestore', 02:14:41 INFO - 'sessionrestore_no_auto_restore', 02:14:41 INFO - 'tabpaint']}, 02:14:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:14:41 INFO - 'ts_paint', 02:14:41 INFO - 'tpaint', 02:14:41 INFO - 'sessionrestore', 02:14:41 INFO - 'sessionrestore_no_auto_restore', 02:14:41 INFO - 'tabpaint']}, 02:14:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:14:41 INFO - 'ts_paint', 02:14:41 INFO - 'tpaint', 02:14:41 INFO - 'sessionrestore', 02:14:41 INFO - 'sessionrestore_no_auto_restore', 02:14:41 INFO - 'tabpaint']}, 02:14:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:14:41 INFO - 'tests': ['a11yr', 02:14:41 INFO - 'ts_paint', 02:14:41 INFO - 'tpaint', 02:14:41 INFO - 'sessionrestore', 02:14:41 INFO - 'sessionrestore_no_auto_restore', 02:14:41 INFO - 'tabpaint']}, 02:14:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:14:41 INFO - 'tests': ['a11yr', 02:14:41 INFO - 'ts_paint', 02:14:41 INFO - 'tpaint', 02:14:41 INFO - 'sessionrestore', 02:14:41 INFO - 'sessionrestore_no_auto_restore', 02:14:41 INFO - 'tabpaint']}, 02:14:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:14:41 INFO - 'tests': ['tsvgx', 02:14:41 INFO - 'tsvgr_opacity', 02:14:41 INFO - 'tart', 02:14:41 INFO - 'tscrollx', 02:14:41 INFO - 'cart', 02:14:41 INFO - 'tsvg_static']}, 02:14:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:14:41 INFO - 'tsvgr_opacity', 02:14:41 INFO - 'tart', 02:14:41 INFO - 'tscrollx', 02:14:41 INFO - 'cart', 02:14:41 INFO - 'tsvg_static']}, 02:14:41 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:14:41 INFO - 'talos_options': ['--disable-e10s'], 02:14:41 INFO - 'tests': ['tp5o']}, 02:14:41 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:14:41 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:14:41 INFO - 'talos_options': ['--disable-e10s', 02:14:41 INFO - '--xperf_path', 02:14:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:14:41 INFO - 'tests': ['tp5n']}, 02:14:41 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:14:41 INFO - 'talos_options': ['--xperf_path', 02:14:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:14:41 INFO - 'tests': ['tp5n']}}, 02:14:41 INFO - 'talos.zip': {'path': '', 02:14:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:14:41 INFO - Running post-action listener: _resource_record_post_action 02:14:41 INFO - [mozharness: 2017-04-27 09:14:41.268983Z] Finished populate-webroot step (success) 02:14:41 INFO - [mozharness: 2017-04-27 09:14:41.269091Z] Running create-virtualenv step. 02:14:41 INFO - Running pre-action listener: _resource_record_pre_action 02:14:41 INFO - Running main action method: create_virtualenv 02:14:41 INFO - Creating virtualenv /builds/slave/test/build/venv 02:14:41 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:14:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:14:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:14:41 INFO - Using real prefix '/tools/python27' 02:14:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:14:42 INFO - Installing distribute.............................................................................................................................................................................................done. 02:14:45 INFO - Installing pip.................done. 02:14:45 INFO - Return code: 0 02:14:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:14:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:14:45 INFO - Reading from file tmpfile_stdout 02:14:45 INFO - Output received: 02:14:45 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:14:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:14:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:14:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:14:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101e1db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e20768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff15ad728b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bfbd30>, '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 0x101b22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bf0be8>, '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.LptxlqJa1L/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.KTWt4od89l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/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:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:14:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:14:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LptxlqJa1L/Render', 02:14:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:14:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:14:45 INFO - 'HOME': '/Users/cltbld', 02:14:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:14:45 INFO - 'LOGNAME': 'cltbld', 02:14:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:45 INFO - 'MOZ_NO_REMOTE': '1', 02:14:45 INFO - 'NO_EM_RESTART': '1', 02:14:45 INFO - 'PAGER': '/bin/cat', 02:14:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:14:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:45 INFO - 'PWD': '/builds/slave/test', 02:14:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:14:45 INFO - 'SHELL': '/bin/bash', 02:14:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KTWt4od89l/Listeners', 02:14:45 INFO - 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/', 02:14:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:14:45 INFO - 'USER': 'cltbld', 02:14:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:14:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:14:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:45 INFO - 'XPC_FLAGS': '0x0', 02:14:45 INFO - 'XPC_SERVICE_NAME': '0', 02:14:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:14:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:45 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:14:45 INFO - Cleaning up... 02:14:45 INFO - Return code: 0 02:14:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:14:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:14:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:14:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101e1db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e20768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff15ad728b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bfbd30>, '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 0x101b22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bf0be8>, '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.LptxlqJa1L/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.KTWt4od89l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/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:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:14:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:14:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LptxlqJa1L/Render', 02:14:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:14:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:14:45 INFO - 'HOME': '/Users/cltbld', 02:14:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:14:45 INFO - 'LOGNAME': 'cltbld', 02:14:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:45 INFO - 'MOZ_NO_REMOTE': '1', 02:14:45 INFO - 'NO_EM_RESTART': '1', 02:14:45 INFO - 'PAGER': '/bin/cat', 02:14:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:14:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:45 INFO - 'PWD': '/builds/slave/test', 02:14:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:14:45 INFO - 'SHELL': '/bin/bash', 02:14:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KTWt4od89l/Listeners', 02:14:45 INFO - 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/', 02:14:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:14:45 INFO - 'USER': 'cltbld', 02:14:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:14:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:14:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:45 INFO - 'XPC_FLAGS': '0x0', 02:14:45 INFO - 'XPC_SERVICE_NAME': '0', 02:14:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:14:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:45 INFO - Downloading/unpacking psutil>=3.1.1 02:14:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:14:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:14:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:14:49 INFO - Installing collected packages: psutil 02:14:49 INFO - Running setup.py install for psutil 02:14:49 INFO - building 'psutil._psutil_osx' extension 02:14:49 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:14:49 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:14:49 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:14:50 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:14:50 INFO - building 'psutil._psutil_posix' extension 02:14:50 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:14:50 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:14:50 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:14:50 INFO - ^ 02:14:50 INFO - 1 warning generated. 02:14:50 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:14:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:14:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:14:50 INFO - Successfully installed psutil 02:14:50 INFO - Cleaning up... 02:14:50 INFO - Return code: 0 02:14:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:14:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:14:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:14:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101e1db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e20768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff15ad728b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bfbd30>, '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 0x101b22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bf0be8>, '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.LptxlqJa1L/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.KTWt4od89l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/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:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:14:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:14:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LptxlqJa1L/Render', 02:14:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:14:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:14:50 INFO - 'HOME': '/Users/cltbld', 02:14:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:14:50 INFO - 'LOGNAME': 'cltbld', 02:14:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:50 INFO - 'MOZ_NO_REMOTE': '1', 02:14:50 INFO - 'NO_EM_RESTART': '1', 02:14:50 INFO - 'PAGER': '/bin/cat', 02:14:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:14:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:50 INFO - 'PWD': '/builds/slave/test', 02:14:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:14:50 INFO - 'SHELL': '/bin/bash', 02:14:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KTWt4od89l/Listeners', 02:14:50 INFO - 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/', 02:14:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:14:50 INFO - 'USER': 'cltbld', 02:14:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:14:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:14:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:50 INFO - 'XPC_FLAGS': '0x0', 02:14:50 INFO - 'XPC_SERVICE_NAME': '0', 02:14:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:14:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:14:50 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:50 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:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:50 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:50 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:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:14:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:14:53 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:53 INFO - Installing collected packages: mozsystemmonitor 02:14:53 INFO - Running setup.py install for mozsystemmonitor 02:14:53 INFO - Successfully installed mozsystemmonitor 02:14:53 INFO - Cleaning up... 02:14:53 INFO - Return code: 0 02:14:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:14:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:14:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101e1db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e20768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff15ad728b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bfbd30>, '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 0x101b22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bf0be8>, '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.LptxlqJa1L/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.KTWt4od89l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/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:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:14:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:14:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LptxlqJa1L/Render', 02:14:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:14:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:14:54 INFO - 'HOME': '/Users/cltbld', 02:14:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:14:54 INFO - 'LOGNAME': 'cltbld', 02:14:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:54 INFO - 'MOZ_NO_REMOTE': '1', 02:14:54 INFO - 'NO_EM_RESTART': '1', 02:14:54 INFO - 'PAGER': '/bin/cat', 02:14:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:14:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:54 INFO - 'PWD': '/builds/slave/test', 02:14:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:14:54 INFO - 'SHELL': '/bin/bash', 02:14:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KTWt4od89l/Listeners', 02:14:54 INFO - 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/', 02:14:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:14:54 INFO - 'USER': 'cltbld', 02:14:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:14:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:14:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:54 INFO - 'XPC_FLAGS': '0x0', 02:14:54 INFO - 'XPC_SERVICE_NAME': '0', 02:14:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:14:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:54 INFO - Downloading/unpacking jsonschema==2.5.1 02:14:54 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:54 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:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:54 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:54 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:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:14:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:14:57 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:57 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:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:57 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:57 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:57 INFO - Downloading functools32-3.2.3-2.tar.gz 02:14:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:14:57 INFO - warning: no files found matching '*.txt' 02:14:57 INFO - no previously-included directories found matching 'build' 02:14:57 INFO - no previously-included directories found matching 'dist' 02:14:57 INFO - no previously-included directories found matching '.git*' 02:14:57 INFO - Installing collected packages: jsonschema, functools32 02:14:57 INFO - Running setup.py install for functools32 02:14:57 INFO - warning: no files found matching '*.txt' 02:14:57 INFO - no previously-included directories found matching 'build' 02:14:57 INFO - no previously-included directories found matching 'dist' 02:14:57 INFO - no previously-included directories found matching '.git*' 02:14:57 INFO - Successfully installed jsonschema functools32 02:14:57 INFO - Cleaning up... 02:14:58 INFO - Return code: 0 02:14:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:14:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:14:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:14:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101e1db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e20768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff15ad728b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bfbd30>, '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 0x101b22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bf0be8>, '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.LptxlqJa1L/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.KTWt4od89l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/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:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:14:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:14:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LptxlqJa1L/Render', 02:14:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:14:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:14:58 INFO - 'HOME': '/Users/cltbld', 02:14:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:14:58 INFO - 'LOGNAME': 'cltbld', 02:14:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:58 INFO - 'MOZ_NO_REMOTE': '1', 02:14:58 INFO - 'NO_EM_RESTART': '1', 02:14:58 INFO - 'PAGER': '/bin/cat', 02:14:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:14:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:58 INFO - 'PWD': '/builds/slave/test', 02:14:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:14:58 INFO - 'SHELL': '/bin/bash', 02:14:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KTWt4od89l/Listeners', 02:14:58 INFO - 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/', 02:14:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:14:58 INFO - 'USER': 'cltbld', 02:14:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:14:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:14:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:58 INFO - 'XPC_FLAGS': '0x0', 02:14:58 INFO - 'XPC_SERVICE_NAME': '0', 02:14:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:14:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:14:58 INFO - Cleaning up... 02:14:58 INFO - Return code: 0 02:14:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:14:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:14:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:14:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101e1db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e20768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff15ad728b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bfbd30>, '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 0x101b22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bf0be8>, '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.LptxlqJa1L/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.KTWt4od89l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/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:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:14:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:14:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LptxlqJa1L/Render', 02:14:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:14:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:14:58 INFO - 'HOME': '/Users/cltbld', 02:14:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:14:58 INFO - 'LOGNAME': 'cltbld', 02:14:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:58 INFO - 'MOZ_NO_REMOTE': '1', 02:14:58 INFO - 'NO_EM_RESTART': '1', 02:14:58 INFO - 'PAGER': '/bin/cat', 02:14:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:14:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:58 INFO - 'PWD': '/builds/slave/test', 02:14:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:14:58 INFO - 'SHELL': '/bin/bash', 02:14:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KTWt4od89l/Listeners', 02:14:58 INFO - 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/', 02:14:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:14:58 INFO - 'USER': 'cltbld', 02:14:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:14:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:14:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:58 INFO - 'XPC_FLAGS': '0x0', 02:14:58 INFO - 'XPC_SERVICE_NAME': '0', 02:14:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:14:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:58 INFO - Downloading/unpacking blobuploader==1.2.4 02:14:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:15:01 INFO - Downloading blobuploader-1.2.4.tar.gz 02:15:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:15:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:15: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:15: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:15:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:15:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:15: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:15: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:15:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:15:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:15: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:15: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:15:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:15:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:15: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:15: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:15:02 INFO - Downloading docopt-0.6.1.tar.gz 02:15:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:15:02 INFO - Installing collected packages: blobuploader, requests, docopt 02:15:02 INFO - Running setup.py install for blobuploader 02:15:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:15:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:15:02 INFO - Running setup.py install for requests 02:15:03 INFO - Running setup.py install for docopt 02:15:03 INFO - Successfully installed blobuploader requests docopt 02:15:03 INFO - Cleaning up... 02:15:03 INFO - Return code: 0 02:15:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:15:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:15:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:15:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:15:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101e1db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e20768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff15ad728b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bfbd30>, '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 0x101b22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bf0be8>, '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.LptxlqJa1L/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.KTWt4od89l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/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:15:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:15:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:15:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LptxlqJa1L/Render', 02:15:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:15:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:15:03 INFO - 'HOME': '/Users/cltbld', 02:15:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:15:03 INFO - 'LOGNAME': 'cltbld', 02:15:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:15:03 INFO - 'MOZ_NO_REMOTE': '1', 02:15:03 INFO - 'NO_EM_RESTART': '1', 02:15:03 INFO - 'PAGER': '/bin/cat', 02:15:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:15:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:15:03 INFO - 'PWD': '/builds/slave/test', 02:15:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:15:03 INFO - 'SHELL': '/bin/bash', 02:15:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KTWt4od89l/Listeners', 02:15:03 INFO - 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/', 02:15:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:15:03 INFO - 'USER': 'cltbld', 02:15:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:15:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:15:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:15:03 INFO - 'XPC_FLAGS': '0x0', 02:15:03 INFO - 'XPC_SERVICE_NAME': '0', 02:15:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:15:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:15:03 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-8pA9bk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:15:03 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-2umica-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:15:03 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-iEtGVj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:15:04 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-iXOwps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:15:04 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-nKNRHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:15:04 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-JtCfRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:15:04 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-MTnpfC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:15:04 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-3o1rS7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:15:04 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-zoIEmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:15:04 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-_ed7D1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:15:04 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-ezWY_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:15:04 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-2bMRvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:15:04 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-lzeVy8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:15:05 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-rDIiFJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:15:05 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-FmnixE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:15:05 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-rpDapg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:15:05 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-GD0MSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:15:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:15:05 INFO - Running setup.py install for manifestparser 02:15:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:15:05 INFO - Running setup.py install for mozcrash 02:15:05 INFO - Running setup.py install for mozdebug 02:15:05 INFO - Running setup.py install for mozdevice 02:15:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:15:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:15:06 INFO - Running setup.py install for mozfile 02:15:06 INFO - Running setup.py install for mozhttpd 02:15:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:15:06 INFO - Running setup.py install for mozinfo 02:15:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:15:06 INFO - Running setup.py install for mozInstall 02:15:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:15:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:15:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:15:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:15:06 INFO - Running setup.py install for mozleak 02:15:06 INFO - Running setup.py install for mozlog 02:15:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:15:07 INFO - Running setup.py install for moznetwork 02:15:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:15:07 INFO - Running setup.py install for mozprocess 02:15:07 INFO - Running setup.py install for mozprofile 02:15:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:15:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:15:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:15:07 INFO - Running setup.py install for mozrunner 02:15:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:15:07 INFO - Running setup.py install for mozscreenshot 02:15:07 INFO - Running setup.py install for moztest 02:15:07 INFO - Running setup.py install for mozversion 02:15:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:15:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:15:08 INFO - Cleaning up... 02:15:08 INFO - Return code: 0 02:15:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:15:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:15:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:15:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:15:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101e1db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e20768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff15ad728b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bfbd30>, '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 0x101b22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bf0be8>, '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.LptxlqJa1L/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.KTWt4od89l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/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:15:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:15:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:15:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LptxlqJa1L/Render', 02:15:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:15:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:15:08 INFO - 'HOME': '/Users/cltbld', 02:15:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:15:08 INFO - 'LOGNAME': 'cltbld', 02:15:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:15:08 INFO - 'MOZ_NO_REMOTE': '1', 02:15:08 INFO - 'NO_EM_RESTART': '1', 02:15:08 INFO - 'PAGER': '/bin/cat', 02:15:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:15:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:15:08 INFO - 'PWD': '/builds/slave/test', 02:15:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:15:08 INFO - 'SHELL': '/bin/bash', 02:15:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KTWt4od89l/Listeners', 02:15:08 INFO - 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/', 02:15:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:15:08 INFO - 'USER': 'cltbld', 02:15:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:15:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:15:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:15:08 INFO - 'XPC_FLAGS': '0x0', 02:15:08 INFO - 'XPC_SERVICE_NAME': '0', 02:15:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:15:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:15:08 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-c_OZpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:15:08 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:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:15:08 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-eMICMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:15:08 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:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:15:08 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-WZn1ih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:15:08 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:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:15:08 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-c0j9AZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:15:08 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:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:15:08 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-ETN_KG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:15:08 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:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:15:08 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-mKzKOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:15:08 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:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:15:09 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-cDDviL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:15:09 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:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:15:09 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-FMPvoU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:15:09 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:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:15:09 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-PsoGZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:15:09 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:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:15:09 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-gHhFxv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:15:09 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:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:15:09 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-Z2B7Nz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:15:09 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:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:15:09 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-H_Sh6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:15:09 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:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:15:09 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-15QvUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:15:09 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:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:15:09 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-ffrR5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:15:09 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:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:15:09 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-p0TtOd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:15:09 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:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:15:09 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-ShtlhU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:15:10 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:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:15:10 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-zRCLJo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:15:10 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:15:10 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:15:10 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:15:10 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:15:10 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:15:10 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:15:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:15:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:15:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:15:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:15:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:15:12 INFO - Downloading blessings-1.6.tar.gz 02:15:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:15:12 INFO - Installing collected packages: blessings 02:15:12 INFO - Running setup.py install for blessings 02:15:13 INFO - Successfully installed blessings 02:15:13 INFO - Cleaning up... 02:15:13 INFO - Return code: 0 02:15:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:15:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:15:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:15:13 INFO - Reading from file tmpfile_stdout 02:15:13 INFO - Current package versions: 02:15:13 INFO - blessings == 1.6 02:15:13 INFO - blobuploader == 1.2.4 02:15:13 INFO - docopt == 0.6.1 02:15:13 INFO - functools32 == 3.2.3-2 02:15:13 INFO - jsonschema == 2.5.1 02:15:13 INFO - manifestparser == 1.1 02:15:13 INFO - mozInstall == 1.12 02:15:13 INFO - mozcrash == 1.0 02:15:13 INFO - mozdebug == 0.1 02:15:13 INFO - mozdevice == 0.49 02:15:13 INFO - mozfile == 1.2 02:15:13 INFO - mozhttpd == 0.7 02:15:13 INFO - mozinfo == 0.9 02:15:13 INFO - mozleak == 0.1 02:15:13 INFO - mozlog == 3.4 02:15:13 INFO - moznetwork == 0.27 02:15:13 INFO - mozprocess == 0.25 02:15:13 INFO - mozprofile == 0.28 02:15:13 INFO - mozrunner == 6.13 02:15:13 INFO - mozscreenshot == 0.1 02:15:13 INFO - mozsystemmonitor == 0.3 02:15:13 INFO - moztest == 0.8 02:15:13 INFO - mozversion == 1.4 02:15:13 INFO - psutil == 3.1.1 02:15:13 INFO - requests == 1.2.3 02:15:13 INFO - wsgiref == 0.1.2 02:15:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:15:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:15:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:15:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:15:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101e1db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e20768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff15ad728b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bfbd30>, '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 0x101b22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bf0be8>, '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.LptxlqJa1L/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.KTWt4od89l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/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:15:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:15:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:15:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LptxlqJa1L/Render', 02:15:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:15:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:15:13 INFO - 'HOME': '/Users/cltbld', 02:15:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:15:13 INFO - 'LOGNAME': 'cltbld', 02:15:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:15:13 INFO - 'MOZ_NO_REMOTE': '1', 02:15:13 INFO - 'NO_EM_RESTART': '1', 02:15:13 INFO - 'PAGER': '/bin/cat', 02:15:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:15:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:15:13 INFO - 'PWD': '/builds/slave/test', 02:15:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:15:13 INFO - 'SHELL': '/bin/bash', 02:15:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KTWt4od89l/Listeners', 02:15:13 INFO - 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/', 02:15:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:15:13 INFO - 'USER': 'cltbld', 02:15:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:15:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:15:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:15:13 INFO - 'XPC_FLAGS': '0x0', 02:15:13 INFO - 'XPC_SERVICE_NAME': '0', 02:15:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:15:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:15:13 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:15:13 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:15:13 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:15:13 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:15:13 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:15:13 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:15:13 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:15:13 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:15:13 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:15:13 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:15:13 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:15:13 INFO - Cleaning up... 02:15:13 INFO - Return code: 0 02:15:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:15:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:15:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:15:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:15:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101e1db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e20768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff15ad728b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bfbd30>, '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 0x101b22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bf0be8>, '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.LptxlqJa1L/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.KTWt4od89l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/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:15:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:15:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:15:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LptxlqJa1L/Render', 02:15:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:15:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:15:13 INFO - 'HOME': '/Users/cltbld', 02:15:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:15:13 INFO - 'LOGNAME': 'cltbld', 02:15:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:15:13 INFO - 'MOZ_NO_REMOTE': '1', 02:15:13 INFO - 'NO_EM_RESTART': '1', 02:15:13 INFO - 'PAGER': '/bin/cat', 02:15:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:15:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:15:13 INFO - 'PWD': '/builds/slave/test', 02:15:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:15:13 INFO - 'SHELL': '/bin/bash', 02:15:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KTWt4od89l/Listeners', 02:15:13 INFO - 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/', 02:15:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:15:13 INFO - 'USER': 'cltbld', 02:15:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:15:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:15:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:15:13 INFO - 'XPC_FLAGS': '0x0', 02:15:13 INFO - 'XPC_SERVICE_NAME': '0', 02:15:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:15:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:15:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:15:14 INFO - Cleaning up... 02:15:14 INFO - Return code: 0 02:15:14 INFO - Running post-action listener: _resource_record_post_action 02:15:14 INFO - Running post-action listener: _start_resource_monitoring 02:15:14 INFO - Starting resource monitoring. 02:15:14 INFO - [mozharness: 2017-04-27 09:15:14.045498Z] Finished create-virtualenv step (success) 02:15:14 INFO - [mozharness: 2017-04-27 09:15:14.046453Z] Running install step. 02:15:14 INFO - Running pre-action listener: _resource_record_pre_action 02:15:14 INFO - Running main action method: install 02:15:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:15:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:15:14 INFO - Reading from file tmpfile_stdout 02:15:14 INFO - Detecting whether we're running mozinstall >=1.0... 02:15:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:15:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:15:14 INFO - Reading from file tmpfile_stdout 02:15:14 INFO - Output received: 02:15:14 INFO - Usage: mozinstall [options] installer 02:15:14 INFO - Options: 02:15:14 INFO - -h, --help show this help message and exit 02:15:14 INFO - -d DEST, --destination=DEST 02:15:14 INFO - Directory to install application into. [default: 02:15:14 INFO - "/builds/slave/test"] 02:15:14 INFO - --app=APP Application being installed. [default: firefox] 02:15:14 INFO - mkdir: /builds/slave/test/build/application 02:15:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:15:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:15:34 INFO - Reading from file tmpfile_stdout 02:15:34 INFO - Output received: 02:15:34 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:15:34 INFO - Running post-action listener: _resource_record_post_action 02:15:34 INFO - [mozharness: 2017-04-27 09:15:34.711410Z] Finished install step (success) 02:15:34 INFO - [mozharness: 2017-04-27 09:15:34.711585Z] Running run-tests step. 02:15:34 INFO - Running pre-action listener: _resource_record_pre_action 02:15:34 INFO - Running main action method: run_tests 02:15:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:15:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:15:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:15:34 INFO - 2017-04-27 02:15:34.726 screenresolution[1633:7503] starting screenresolution argv=screenresolution get 02:15:34 INFO - 2017-04-27 02:15:34.728 screenresolution[1633:7503] Display 0: 1600x1200x32@60 02:15:34 INFO - 2017-04-27 02:15:34.734 screenresolution[1634:7506] starting screenresolution argv=screenresolution list 02:15:34 INFO - Available Modes on Display 0 02:15:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:15:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:15:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:15:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:15:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:15:34 INFO - Intel Iris: 02:15:34 INFO - Chipset Model: Intel Iris 02:15:34 INFO - Type: GPU 02:15:34 INFO - Bus: Built-In 02:15:34 INFO - VRAM (Dynamic, Max): 1536 MB 02:15:34 INFO - Vendor: Intel (0x8086) 02:15:34 INFO - Device ID: 0x0a2e 02:15:34 INFO - Revision ID: 0x0009 02:15:34 INFO - Displays: 02:15:34 INFO - Display: 02:15:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:15:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:15:34 INFO - Display Serial Number: 1600x1200 60 02:15:34 INFO - Main Display: Yes 02:15:34 INFO - Mirror: Off 02:15:34 INFO - Online: Yes 02:15:34 INFO - Rotation: Supported 02:15:34 INFO - Return code: 0 02:15:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:15:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:15:34 INFO - Python 2.7.3 02:15:34 INFO - Return code: 0 02:15:34 INFO - grabbing minidump binary from tooltool 02:15:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:15:34 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 0x101bfbd30>, '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 0x101b22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bf0be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:15:34 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:15:34 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:15:34 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:15:35 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:15:35 INFO - Return code: 0 02:15:35 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:15:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:15:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:15:35 INFO - ENV: RUST_BACKTRACE is now 1 02:15:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:15:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:15:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Y7auEGk7T6mmt4dNvRVQIg/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0265', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 02:15:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Y7auEGk7T6mmt4dNvRVQIg/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0265 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 02:15:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LptxlqJa1L/Render', 02:15:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:15:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:15:35 INFO - 'HOME': '/Users/cltbld', 02:15:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:15:35 INFO - 'LOGNAME': 'cltbld', 02:15:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:15:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:15:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:15:35 INFO - 'MOZ_NO_REMOTE': '1', 02:15:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:15:35 INFO - 'NO_EM_RESTART': '1', 02:15:35 INFO - 'PAGER': '/bin/cat', 02:15:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:15:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:15:35 INFO - 'PWD': '/builds/slave/test', 02:15:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:15:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:15:35 INFO - 'RUST_BACKTRACE': '1', 02:15:35 INFO - 'SHELL': '/bin/bash', 02:15:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KTWt4od89l/Listeners', 02:15:35 INFO - 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/', 02:15:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:15:35 INFO - 'USER': 'cltbld', 02:15:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:15:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:15:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:15:35 INFO - 'XPC_FLAGS': '0x0', 02:15:35 INFO - 'XPC_SERVICE_NAME': '0', 02:15:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:15:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Y7auEGk7T6mmt4dNvRVQIg/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0265', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 02:15:35 INFO - mozversion application_buildid: 20170427004028 02:15:35 INFO - mozversion application_changeset: 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 02:15:35 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:15:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:15:35 INFO - mozversion application_name: Firefox 02:15:35 INFO - mozversion application_remotingname: firefox-dev 02:15:35 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:15:35 INFO - mozversion application_vendor: Mozilla 02:15:35 INFO - mozversion application_version: 54.0a2 02:15:35 INFO - mozversion platform_buildid: 20170427004028 02:15:35 INFO - mozversion platform_changeset: 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 02:15:35 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:15:35 INFO - mozversion platform_version: 54.0a2 02:15:35 INFO - using testdate: 1493284535 02:15:35 INFO - actual date: 1493284535 02:15:35 INFO - starting webserver on 'localhost:49245' 02:15:35 INFO - SUITE-START | Running 2 tests 02:15:35 INFO - TEST-START | dromaeo_css 02:15:35 INFO - operating with platform_type : mac_ 02:15:35 INFO - Initialising browser for dromaeo_css test... 02:15:35 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/tmpUcWw65/profile http://localhost:49245/getInfo.html) 02:15:38 INFO - PROCESS | 1644 | 2017-04-27 02:15:38.433 plugin-container[1647:7685] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x903f, name = 'com.apple.tsm.portname' 02:15:38 INFO - PROCESS | 1644 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:15:38 INFO - PROCESS | 1644 | 2017-04-27 02:15:38.433 plugin-container[1647:7685] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x950b, name = 'com.apple.CFPasteboardClient' 02:15:38 INFO - PROCESS | 1644 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:15:38 INFO - PROCESS | 1644 | 2017-04-27 02:15:38.433 plugin-container[1647:7685] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:15:38 INFO - PROCESS | 1644 | __metrics Screen width/height:1600/1200 02:15:38 INFO - PROCESS | 1644 | colorDepth:24 02:15:38 INFO - PROCESS | 1644 | Browser inner width/height: 1024/689 02:15:38 INFO - PROCESS | 1644 | __metrics 02:15:38 ERROR - PROCESS | 1644 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3360: TypeError: this.tabs is undefined 02:15:39 INFO - TEST-INFO | 1644: exit 0 02:15:39 INFO - Browser initialized. 02:15:39 INFO - Running cycle 1/1 for dromaeo_css test... 02:15:39 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/tmpUcWw65/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:15:41 INFO - PROCESS | 1648 | 2017-04-27 02:15:41.765 plugin-container[1649:7826] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x893f, name = 'com.apple.tsm.portname' 02:15:41 INFO - PROCESS | 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:15:41 INFO - PROCESS | 1648 | 2017-04-27 02:15:41.766 plugin-container[1649:7826] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x451f, name = 'com.apple.CFPasteboardClient' 02:15:41 INFO - PROCESS | 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:15:41 INFO - PROCESS | 1648 | 2017-04-27 02:15:41.766 plugin-container[1649:7826] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:15:51 INFO - PROCESS | 1648 | RSS: Main: 220655616 02:15:51 INFO - PROCESS | 1648 | 02:18:54 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49245/tests/dromaeo/cssquery-ext.html) 02:18:56 INFO - PROCESS | 1648 | RSS: Main: 238485504 02:18:56 INFO - PROCESS | 1648 | 02:20:39 INFO - PROCESS | 1648 | ************************* 02:20:39 INFO - PROCESS | 1648 | A coding exception was thrown and uncaught in a Task. 02:20:39 INFO - PROCESS | 1648 | 02:20:39 ERROR - PROCESS | 1648 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:20:39 INFO - PROCESS | 1648 | Full stack: 02:20:39 INFO - PROCESS | 1648 | ************************* 02:20:39 INFO - PROCESS | 1648 | ************************* 02:20:39 INFO - PROCESS | 1648 | A coding exception was thrown and uncaught in a Task. 02:20:39 INFO - PROCESS | 1648 | 02:20:39 ERROR - PROCESS | 1648 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:20:39 INFO - PROCESS | 1648 | Full stack: 02:20:39 INFO - PROCESS | 1648 | ************************* 02:20:39 INFO - PROCESS | 1648 | ************************* 02:20:39 INFO - PROCESS | 1648 | A coding exception was thrown and uncaught in a Task. 02:20:39 INFO - PROCESS | 1648 | 02:20:39 ERROR - PROCESS | 1648 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:20:39 INFO - PROCESS | 1648 | Full stack: 02:20:39 INFO - PROCESS | 1648 | ************************* 02:20:39 INFO - PROCESS | 1648 | ************************* 02:20:39 INFO - PROCESS | 1648 | A coding exception was thrown and uncaught in a Task. 02:20:39 INFO - PROCESS | 1648 | 02:20:39 ERROR - PROCESS | 1648 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:20:39 INFO - PROCESS | 1648 | Full stack: 02:20:39 INFO - PROCESS | 1648 | ************************* 02:21:58 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-ext.html (next: http://localhost:49245/tests/dromaeo/cssquery-jquery.html) 02:21:59 INFO - PROCESS | 1648 | RSS: Main: 248258560 02:21:59 INFO - PROCESS | 1648 | 02:25:01 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49245/tests/dromaeo/cssquery-mootools.html) 02:25:01 INFO - PROCESS | 1648 | RSS: Main: 255774720 02:25:01 INFO - PROCESS | 1648 | 02:28:03 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49245/tests/dromaeo/cssquery-prototype.html) 02:28:04 INFO - PROCESS | 1648 | RSS: Main: 254390272 02:28:04 INFO - PROCESS | 1648 | 02:31:07 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49245/tests/dromaeo/cssquery-yui.html) 02:31:08 INFO - PROCESS | 1648 | RSS: Main: 259989504 02:31:08 INFO - PROCESS | 1648 | 02:34:11 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-yui.html (next: http://localhost:49245/tests/dromaeo/cssquery-dojo.html) 02:34:11 INFO - PROCESS | 1648 | RSS: Main: 256237568 02:34:11 INFO - PROCESS | 1648 | 02:34:11 INFO - PROCESS | 1648 | __start_tp_report 02:34:11 INFO - PROCESS | 1648 | _x_x_mozilla_page_load 02:34:11 INFO - PROCESS | 1648 | _x_x_mozilla_page_load_details 02:34:11 INFO - PROCESS | 1648 | |i|pagename|runs| 02:34:11 INFO - PROCESS | 1648 | |0;dojo.html;3291.7162306700375;3409.7272218222543;3419.3503234385466;3442.191085095004;3455.8617655293788;5661.575381846357;5685.033544297474;5692.0323544997345;5703.800366987156;5718.828435146952;5079.03498335316;5502.449755024496;5662.207290979256;5706.885862282752;5723.713814309289;5178.663386879841;5191.896162076756;5243.2659427680155;5263.921041184385;5299.49654782795;5301.363836339645;5307.840764777063;5322.121849894763;5326.946730532703;5375.462453754632;4381.9561804381865;5128.384593848725;5143.996920600484;5313.884084342293;5354.250404943292;5235.031519168947;5270.631055826094;5281.155015197569;5322.574194064504;5332.120200166968;5153.896922061575;5254.710990895499;5258;5269;5323.307969963918;5522.889542209174;5736.68448235351;5763.279590051244;5852.4440178183;5870.090136028923;6131.662758548278;6147.415995480422;6184.165137706397;6201.410865967726;6209.751609935643;6223.222097237845;6235.064740288993;6248.187735594389;6250.312465628777;6255.155554000243;5855.06318988964;5859.531237501075;5894.410558944114;5898.705064746831;5942.554308426799;6126.36500017443;6182.6599537024995;6187.752489900444;6218.160548325918;6255.812325630239;6128.816135515942;6177.722002509898;6182;6197.411245931629;6212.161358216673;6168.660723660242;6228.439440450381;6231.532635052389;6238.064290356392;6281.277653069864;6060.636361818305;6086.969565152146;6087.4521293083835;6088.8782224356155;6230.937690623126;5570.192322113352;5842.269716285465;6114.327782088734;6242.094896240111;6275.403836635513;4994.2508623706735;4995.525425084611;4996.525330093636;5009.499050094962;5012.473690262543;3897.785621790829;4319.6976211665515;4477.283634618446;4480.103979204107;4503.099380123988;5675.177099320658;5752.741126649311;5755.913661295084;5783.537317014629;5786.218860453869;6185.536084793568;6210.31686514483;6211.720472578745;6213.875722485615;6226.533010024266;5591.273134492571;5640;5710.65736055838;5764.048931926185;5826.941730582725;5432.212329212242;5498.3127109111365;5501.587380946365;5507.944920550824;5508.063629183049;5219.76511057011;6151.138840562415;6158.168647232566;6179.969100154471;6209.348018458178;5233.267342572119;6200.968995154995;6225.221847269091;6225.346338634378;6226.937730622636;6271.167053744929;6290.0879372491645;6300.495960323072;6302.84242893913;6316.115743795965;6030.819075427568;6071.2714474263375;6107.583301036431;6126;6185.319614842274;6121.816345509642;6164.568480206342;6171.876562468636;6193.380661933951;6197.907031394623;5298;6108.236470441195;6129.724162412613;6160.44555989963;6187.566870319034;5912.615679980788;6095.939040609537;6097.664628445301;6098.207233059674;6115.816525504242;4994.200927851526;5333.7066461345;5396.541293990055;5861.413858614104;5956.136360227656;6132.20254427538;6133.60131591463;6135.35515879939;6176.197094377702;6177.135201071944;5987.550933679904;5996.310424301261;6003.099535069775;6014.338422773579;6030.819075427744 02:34:11 INFO - PROCESS | 1648 | |1;ext.html;713.4613366907984;729.1541811498662;744.757953665059;946.1484663802572;958.8226178157037;37210.81394593027;37913.05217369567;39184.60815391845;39281.214375712465;39325.80337098314;38068.42897356535;38307;38316.23367532655;38319.616803832025;39152.41271380932;7765.92234077659;10397;10682.732931676692;10844.240903136744;10848.728781780479;10541.209409294295;10576.894231057668;10614.097801686867;10619.46902654868;10628.149748020178;10590.09984151348;10603.310784799001;10639.521221545048;10642.62750803722;10664.946675266612;10575.68272951805;10589.894101058968;10639.840402393931;10647.307924984929;10647.893521064767;10407.271490995634;10455.059044686015;10464.319819211803;10465.215108866865;10502.369857808557;33112.83443582791;33203;33252.6674733252;33312.666873331196;33684.32631347384;3645.471406646048;3691.9446208306895;3695.907602309937;3707.4624179494094;3744.7378683491893;24548.386290342885;24686;24969.62545561818;25883.74116258832;25979.830907609205;3019.9396012079856;3056.5567992640945;3128.906132816019;3211.6948889855425;3235.1912021994503;355303;357000;360614;360736.19631901936;361171.1941440302;43584;43619.56380436155;43815.90460238456;43843.78078109653;43889.561104388544;44948.55051449444;45220.54779452229;45337.54662453333;45378.546214538095;45493;13548.119372240773;13826.861731382558;13850.65373365674;13852.584422467342;13931.930340348234;11799.997000255074;12009.039276857831;12009.819852702216;12012.399380030964;12037.398130093636;11128.109751219883;11635.76728465426;11691.240069395462;11744.647660570197;11798.292102473708;4430.623397011225;4651.511591282867;4917.139500587455;5294.841154765363;5431.864203394946;1104.447776111944;1106.7620461600795;1131.2748059209607;1151.9424028798526;1196.3958201108385;26017.609735853977;26220;26455.603165952525;26473.867630661724;26625.33436664099;777.4247057177648;1004.5630150884389;1224.3266203587991;1255.1151438236022;1280.359820089955;11112.665920358111;12641.367931603383;14782.556523304318;14880.032797868103;14890.329935152944;483878;487510;487847;488780;488985.55507222237;47656.76171619189;47787.522124779;48332;48397;48460.757696212;1400.6288333591606;1420.7584710599224;1430.0918916488106;1432.1550285331705;1433.7419264532484;26269.605955911058;26618.733812661627;26771.86614066917;27201.591976119977;27302.317442064108;40324.79837600793;40421.393679094246;40517.59482405138;40562.391564125974;40658.59341406548;482074;482569;482597;483179;483234;28938.565921510773;29670;29941.401171976875;30037.69962300349;30062.947796827008;36769.71306004384;37143.62856371402;37738.86783396502;37788.62211377851;37840.24319513649;26731.33171670724;26751.598726019514;26825.463490730468;27355.316117096434;27651.308717281423;25296.494070118864;26957.3260668477;27546.89812407481;27773;27799.44401111926;30463.847680761453;30913.8454307727;31272.68727312789;31427.528587070756;31524.842375788892;27033.59449608218;27483.862580686968;27549.586756199074;27826.86086569554;28052.018179363626;19144.329948451737;22161.778382216617;22178.001989910816;22215.666764998216;22267.554648907255 02:34:11 INFO - PROCESS | 1648 | |2;jquery.html;407.3299422450068;409.5044995555378;415.53875198529636;430.3093534876523;444.95435726043803;18854.90572547137;20556.280530181448;21214.787852121473;21268;21368.786312136912;21623.45941351467;21717.565648687018;21746.782532174675;22271;22544.88727556364;6462.5153113516435;6675.866482670343;6697.464202863759;6740.325967403245;6751;6580.835479113012;6865.41643960264;7212.170600380945;7340.596267205302;7367.8894816577795;7134.643267836614;7322.304381083789;7354.2645735426295;7358.117025956866;7383.446241531879;7145.642717864086;7399.741009064684;7447.851042979137;7459.067616547904;7470.4397170211905;6568.835779105513;6802.829929251809;7119.50163488556;7181.138263408372;7217.097862767154;24924;25377;26073;26413.867930660224;26598.468030639473;2860.9713902860913;2936.2219011961847;2943.175910744995;2949.2037149969387;3277.5903012123485;15375.692486150327;16262.75605865913;16399.59001024972;16568.917155414267;16688.499345019667;2098.0034483620157;2155.2025750472426;2162.1135334512774;2162.38372063961;2162.535054963175;102414.98127340824;133705.331473343;153612.92774144455;156868;161804.38195618012;17018.14909254557;20317.898410508147;21342.89328553347;21501.67747483789;21550.89224553867;30597.388052239276;30634.69365306363;31186.68813311883;31206.907758228353;31228.531572026437;8416.452930559493;10153.289269751194;10337.121344685636;10553.31403458788;10623.468826558641;7820.748680211139;8190.959045204736;8705.825883482295;8727.301815854717;8853.29173666105;7615.923840761521;7776.688932442752;9577.521123943776;9577.616895324249;9617.23062155026;3578.6600272974024;4188.958110418917;4201.264778663722;4216.451861258078;4218.514870789899;759.2862709053472;866.4627930682891;885.1502557544829;914.3279689428265;930.59054016234;20834.27080052191;21603.243886463897;21616.891915540637;21686;21744.78255217459;907.9682211122579;917.4907926100944;936.7564433247405;938.3853575907791;940.1022023967095;10580.841287380696;10627.309224900357;11347.148963827745;11405.486753096131;11405.942970285096;760289;766289;770035;777227;791872;145639.81540276905;145652.27173864274;150661.24669376583;151073;155096;1125.6960620632383;1138.6584024792528;1157.473349625935;1158.889905458997;1165.1086918507349;14883.255837208313;16004.519864404087;17661.82338176602;17764.84528505643;19151.32970346087;46383.76808115938;47528.762356187995;52617.73691131673;61315.38684613275;63902.680486597266;88817.11182888347;89288.10711893058;90368.54815726142;91334;92418.33593218963;9054.275657947217;11202.38386888729;11514.94242528782;11716.589919353122;11809.937105660532;12449;12735.490580377053;12926.289054102115;13026.934865325613;13191.40638671243;11080.168987325822;11129.777404452028;11392.145589080686;11492;11539.884601154217;10080.24398170155;10293.948530257301;10520.842187367043;10612.310199836986;10650.414227217267;9266.721998340061;10963.574735284363;11088.501017454395;11529.942350288195;11594.826077609012;8459.027211870467;10650.147988161083;10919.39943303126;11250.943745281222;11565.768684626428;11096.445177741241;11534.538618455503;11637.76724465523;11694.649160525198;11698.824517632072 02:34:11 INFO - PROCESS | 1648 | |3;mootools.html;1391.7912313153029;1520.2246854104403;1524.161711058918;1532.9310181041851;1541.1061584281117;10502.054815066642;10837.620683276067;11043.282186657862;11074.335539867603;11081;10822.891771082286;10990.065844403236;11007.009369156774;11014.944925275382;11049.779004419906;2347.448349637834;2363.8108951283943;2373.679553260305;2377.6314671225987;2388.0925248405583;1953.5799803042344;1995.730576372193;2362.917297894574;2368.4789346343778;2371.727251366089;2337.520808234308;2355.5759963206615;2366.20732054761;2375.406148462884;2388.8088952883813;2332.650102484624;2347.9060837566476;2349.7650234976536;2371.4071482129466;2384.9642255366184;2373.6320870264963;2379.310000099986;2381.404648837791;2381.4641705616273;2386.4511162432736;10909.945450272777;10916.563337466492;10946.960038796382;10954.890451095547;10977.83533247002;5427.158790387496;5477.3427188737605;5630.662160270397;5661.971690141564;5664.320281566197;3246.8863589774483;3297.3240485700376;3408.5909690837257;3414.641462646411;3591.9281614367565;1158.3339579741598;1224.3878060969516;1252.3362617812575;1254;1831.230883029131;13311.801937825641;13460.663483412894;14741.336639851232;14886.478973235884;14991.025583337158;4673.859784206479;4775.198427508674;4804;4846.079244943449;4866.878328041827;12694.365281735876;12731.108822382344;12737.108402411743;12744.6813829655;12756.234625922474;5801.9419805802245;5814.738336774855;5881.558883083786;5891.675957822361;5898.203742494708;5043.949560504421;5113.130767769489;5182.948170518322;5203.167493201146;5216.556592689664;4128.710990230715;4143.564061289017;4172.2658220892135;4205.789710514462;4214.831406743696;1140.6235942139074;1156.5778490850946;1162.7325715085578;1165.7493638867516;1172.9237599556002;932.9533523323806;938.5870217104452;956.2302346611045;962.4177372689562;999.2256001598819;5872.236609240771;6470.417662410406;6479.8056058318325;6515.6742162892615;6548.70530826114;983.5672304186278;987.2151639446657;1002.8495725641212;1011.5043628622069;1012.9493525323704;4040.252553277653;4232.090100628379;4238.427812245307;4240.194363071068;4269.359596060615;13009.284489353176;13383.866161338457;13602.183868967893;13613;13633;13355.866441335656;13501.324933753272;13642.93178534101;13659.112157709716;13826.962977776708;8432.988041434945;10000.499975001221;10126.797464050678;10127.088562029452;10133;5101.387833460009;6638.734450621921;6816.011678306519;6899.689513971783;6932.618705971018;11668.416579171177;11725.179237453638;11983.76032479328;12001.1599188056;12008.879911200776;11884.524619015488;11884.643460696192;11992.76014479723;12007.879921200676;12049.698757531132;8559.74320770378;8672.176143266379;8714.172153645393;8725.127487251479;8732.69435569752;10166.085052345325;10208.846867297145;10209.591616335263;10296.433696146783;10315.48422578883;8641.82716345657;8711.433756805787;8720.345974052098;8941.776455588662;8944.552772361225;7284;8495.150484951455;8497.362697797565;8589.742307730778;8601.532092123956;7522.059742532184;7523.172451030273;7538.472306938462;7558.773236802905;7588.8482230353975;5852.824415267549;5893.292804863444;5993.760249589967;6024.849378765566;6103.633781973096;5956.583039187389;5983.431574000463;6056.697165141637;6098.359672234529;6334.208223972004 02:34:11 INFO - PROCESS | 1648 | |4;prototype.html;335.70793409733534;341.9811910344932;375.3356558890765;377.71671246565074;387.5117352136309;4104.938425923606;4404.867853964378;4935.6051515878735;5300.310959575255;5328.866778330544;4545.931811022837;4574.908501829961;4600.102979918909;5132.538071573557;5154.458781827911;3564.465330200465;4271.295236286009;4470.195364834329;4490.348899409583;4599.356090147382;3441.122513758988;3978.345335956923;4326.913461730779;4461.460796025366;4543.386642803229;3939.5469521005166;3980.3772982889886;4179.247735407641;4399.802008909607;4447.466304043519;4413.867583972486;4416.580424859633;4436.911261774779;4466.955330446686;4476.940607320636;3876.8836934891997;3907.5310962684375;4304.203722311382;4316.244657185011;4320.438343015419;4340.587644173798;4579.244424669925;4771.308160316769;4988.725620090893;5019.623528235397;4548.431446069241;4904.705717656916;5162.74186290684;5182.585393168538;5250.343707036621;4615.515370886043;5411.374379165929;5571.804986825442;5645.491905728504;5707.3721890592005;4694;4695.652173913043;4733.715977041388;4752.122911449993;4807.927881081787;5048.318477005557;5953.690188158598;5966.791162309341;5982.06479654287;5991.820245392645;3783.829727662262;4272.444582204355;4287.506936702257;4675.579197872208;5001.374553270201;4487.371767952489;4554.635629149726;4754;5025.346704928409;5092.402874534015;4668.883277918079;4884.755762211875;5186.144286192812;5216.947830521722;5258.789648414097;4434.711743736647;4864.148773964542;4941.604671626261;5398.758285594336;5616.97191514048;1356.5455572383362;1521.6119889428126;1597.8096318242983;1659.9502014939571;1678.2531773360738;1252.4594748459447;1370.5134677189653;1387.8896882493964;1409.8872090232962;1423.5729281215595;4645.352149274949;5142.879972832317;5180.766865491062;5201.713905735145;5234.257505883312;5707.34365547959;5734.254546908875;5735.913961290584;5773.037167363117;5870.501007414332;3644.526211592476;4588.655850811202;4790.353302304214;4855.519066684625;5190.351206099238;2777.888844462231;3027.6215473065868;3040.236662735608;3053.8167709937475;3083.152133163398;5627.43725627434;5729.822667386366;5923.072765951195;5988.9101663475085;6132.724027418777;4775.6657034007985;5405.297311349578;5571.303587051619;5695.886082278331;5868.911966320508;4995.550400463903;5557.333120025542;5961.7615295387695;6014.233452611673;6084.300305464928;4405.229149813754;4865.791090706584;5751.338596061507;5805.345476539166;5831.35855055952;4868.561829435368;5751.252337196138;5779.566532509994;5785.42145785435;5796.62321949072;5910.852228694317;5987.43119403656;6022.8857661332795;6062.030075188125;6064.363241859542;4390.9022744313925;4441.666874984454;4574.324020448075;4605.309203619484;4646.83736069236;5458.5087342139395;5663.377028526941;5760.1935728998815;5765.4522820332;5885.852853678693;4646.9107185676385;4881.975590122027;5290.788368465218;5465.972670136783;5537;4523.683342166017;4651.813927442864;5500.614956952975;5510.173473978935;5562.944370556243;4614.838480653161;4697.600703940203;4909;5150.99555586657;5348.358197016383;4575.604440645635;5387.89548142622;5524.171374293727;5652.463016013472;5669.858253543694;5053.47713796143;5277.991544819416;5406.783218880398;5458.645188062763;5494.615376923577 02:34:11 INFO - PROCESS | 1648 | |5;yui.html;605.7122866638344;722.9783106506807;772.4361216312092;776.3750181104213;837.1620207496586;14777.852221477782;15682.607934801636;16260.105694186816;16569.17154142294;16583.83416165841;12811.103222774385;13293.601191964231;14307.642308942255;14925.402983880631;15306.081635101902;914.9451032938028;941.8540126280403;943.6319835264218;944.489975413276;945.7635591102224;905.6603773584906;925.5881132895864;940.0129863643182;942.5428667096453;944.0936700767272;978.70149604371;982.7248370456284;986.856905748666;989.2975987049203;1006.16488314699;978.5205249427801;980.9656662016866;983.1102851919024;984.8670429492034;985.074030411411;629.4020680353682;725.1044959475045;731.469684478754;733.1751779248345;734.1813877526573;15786.210689465595;15899.60250993723;16236.675266494603;16587;16873.903196292325;13826.170429774245;14091.2954352283;14096.50662226817;14130.717385652331;14154.292285385689;9971.850422243671;11546.549607011679;11712.88287117135;11887.762244755142;12317.69205769854;3583.211693427442;3679;3697.9445308320396;3709.981450092759;3819.3698039823394;91980;96309.36906309384;106147.46926265319;106198.46900765524;106301.46849265705;10402.115820155372;10667.679969600924;10718.08896243828;10729.78540429187;10751.78496430067;18995.525111872314;21565.490415671065;22044.559108818055;22115.668264976037;22127;6835.384815366541;6866;6945.374916257561;6949.583025018515;7087.503874728823;4294.3558466230315;4409.250427427345;4422.071365013383;4460.576245256695;4577.633789296849;3347.313800670857;3421.23022319981;3485.738569607239;3492.511048453219;3492.930141397158;643.4723526708054;669.5045666206972;670.2024590737008;691.2959554697594;692.2350802363417;586.3169407640052;661.8940969444866;698.8078278473461;699.8250437390652;702.220535205921;9611.711648650551;10111.544980475895;10399.53202105907;10443.425611591436;10716.410597417216;503.39417258943854;595.4938302442889;599.5173885022599;641.7272659119856;715.0561259137992;4685.6017238535105;4892.217245240744;5005.899882002413;5009.874753131201;5037.899242015213;65113.348866511675;85988.57005715056;86412.1358786404;87765;88719;74423.25576744163;74761.6261918687;75805;76667;76712.61643691745;62653;65382.673086635215;68420.6578967112;68662;70566.64716676384;10793.946030269799;10914.126869850234;10958.452077396258;11057;11252.831207532057;44628;46524;47117.52882471269;47284.7635761819;48957.75521122372;45662;53865;59435;61060.69469652623;61337.693311533156;12150.836597008367;12165.756684866075;12234;12380.380980951097;12732.936335318635;14176.574702758933;14202.360893759598;14278.286085695881;14415.78376324335;14938.701225975637;12358.98249301084;12399.690007749878;12985.740285194055;13031.348432578523;13076.215427074407;10088.344257623232;10425.582976680847;12366.690832729253;13245.867541324464;13291.933540332237;12592.496300147892;13042.608721738363;13386.19682818995;13554.622435443287;13785.586432407044;9275.72172834816;9381.624735010522;9658.3722058066;9697.321187516805;9754.317197796086;11194.2723722961;11271.549138034386;11275.170465323094;11299.37853418037;11301.660950171508 02:34:11 INFO - PROCESS | 1648 | __end_tp_report 02:34:11 INFO - PROCESS | 1648 | __start_cc_report 02:34:11 INFO - PROCESS | 1648 | _x_x_mozilla_cycle_collect,427 02:34:11 INFO - PROCESS | 1648 | __end_cc_report 02:34:11 INFO - PROCESS | 1648 | __startTimestamp1493285651617__endTimestamp 02:34:11 INFO - PROCESS | 1648 | 02:34:11 INFO - PROCESS | 1648 | ------- Summary: start ------- 02:34:11 INFO - PROCESS | 1648 | Number of tests: 6 02:34:11 INFO - PROCESS | 1648 | 02:34:11 INFO - PROCESS | 1648 | [#0] dojo.html Cycles:165 Average:5707.69 Median:5898.71 stddev:630.37 (10.7%) stddev-sans-first:603.14 02:34:11 INFO - PROCESS | 1648 | Values: 3291.7 3409.7 3419.4 3442.2 3455.9 5661.6 5685.0 5692.0 5703.8 5718.8 5079.0 5502.4 5662.2 5706.9 5723.7 5178.7 5191.9 5243.3 5263.9 5299.5 5301.4 5307.8 5322.1 5326.9 5375.5 4382.0 5128.4 5144.0 5313.9 5354.3 5235.0 5270.6 5281.2 5322.6 5332.1 5153.9 5254.7 5258.0 5269.0 5323.3 5522.9 5736.7 5763.3 5852.4 5870.1 6131.7 6147.4 6184.2 6201.4 6209.8 6223.2 6235.1 6248.2 6250.3 6255.2 5855.1 5859.5 5894.4 5898.7 5942.6 6126.4 6182.7 6187.8 6218.2 6255.8 6128.8 6177.7 6182.0 6197.4 6212.2 6168.7 6228.4 6231.5 6238.1 6281.3 6060.6 6087.0 6087.5 6088.9 6230.9 5570.2 5842.3 6114.3 6242.1 6275.4 4994.3 4995.5 4996.5 5009.5 5012.5 3897.8 4319.7 4477.3 4480.1 4503.1 5675.2 5752.7 5755.9 5783.5 5786.2 6185.5 6210.3 6211.7 6213.9 6226.5 5591.3 5640.0 5710.7 5764.0 5826.9 5432.2 5498.3 5501.6 5507.9 5508.1 5219.8 6151.1 6158.2 6180.0 6209.3 5233.3 6201.0 6225.2 6225.3 6226.9 6271.2 6290.1 6300.5 6302.8 6316.1 6030.8 6071.3 6107.6 6126.0 6185.3 6121.8 6164.6 6171.9 6193.4 6197.9 5298.0 6108.2 6129.7 6160.4 6187.6 5912.6 6095.9 6097.7 6098.2 6115.8 4994.2 5333.7 5396.5 5861.4 5956.1 6132.2 6133.6 6135.4 6176.2 6177.1 5987.6 5996.3 6003.1 6014.3 6030.8 02:34:11 INFO - PROCESS | 1648 | 02:34:11 INFO - PROCESS | 1648 | [#1] ext.html Cycles:180 Average:56022.65 Median:27813.15 stddev:119089.46 (428.2%) stddev-sans-first:119351.14 02:34:11 INFO - PROCESS | 1648 | Values: 713.5 729.2 744.8 946.1 958.8 37210.8 37913.1 39184.6 39281.2 39325.8 38068.4 38307.0 38316.2 38319.6 39152.4 7765.9 10397.0 10682.7 10844.2 10848.7 10541.2 10576.9 10614.1 10619.5 10628.1 10590.1 10603.3 10639.5 10642.6 10664.9 10575.7 10589.9 10639.8 10647.3 10647.9 10407.3 10455.1 10464.3 10465.2 10502.4 33112.8 33203.0 33252.7 33312.7 33684.3 3645.5 3691.9 3695.9 3707.5 3744.7 24548.4 24686.0 24969.6 25883.7 25979.8 3019.9 3056.6 3128.9 3211.7 3235.2 355303.0 357000.0 360614.0 360736.2 361171.2 43584.0 43619.6 43815.9 43843.8 43889.6 44948.6 45220.5 45337.5 45378.5 45493.0 13548.1 13826.9 13850.7 13852.6 13931.9 11800.0 12009.0 12009.8 12012.4 12037.4 11128.1 11635.8 11691.2 11744.6 11798.3 4430.6 4651.5 4917.1 5294.8 5431.9 1104.4 1106.8 1131.3 1151.9 1196.4 26017.6 26220.0 26455.6 26473.9 26625.3 777.4 1004.6 1224.3 1255.1 1280.4 11112.7 12641.4 14782.6 14880.0 14890.3 483878.0 487510.0 487847.0 488780.0 488985.6 47656.8 47787.5 48332.0 48397.0 48460.8 1400.6 1420.8 1430.1 1432.2 1433.7 26269.6 26618.7 26771.9 27201.6 27302.3 40324.8 40421.4 40517.6 40562.4 40658.6 482074.0 482569.0 482597.0 483179.0 483234.0 28938.6 29670.0 29941.4 30037.7 30062.9 36769.7 37143.6 37738.9 37788.6 37840.2 26731.3 26751.6 26825.5 27355.3 27651.3 25296.5 26957.3 27546.9 27773.0 27799.4 30463.8 30913.8 31272.7 31427.5 31524.8 27033.6 27483.9 27549.6 27826.9 28052.0 19144.3 22161.8 22178.0 22215.7 22267.6 02:34:11 INFO - PROCESS | 1648 | 02:34:11 INFO - PROCESS | 1648 | [#2] jquery.html Cycles:180 Average:43027.24 Median:23734.44 stddev:128472.39 (541.3%) stddev-sans-first:128792.93 02:34:11 INFO - PROCESS | 1648 | Values: 407.3 409.5 415.5 430.3 445.0 18854.9 20556.3 21214.8 21268.0 21368.8 21623.5 21717.6 21746.8 22271.0 22544.9 6462.5 6675.9 6697.5 6740.3 6751.0 6580.8 6865.4 7212.2 7340.6 7367.9 7134.6 7322.3 7354.3 7358.1 7383.4 7145.6 7399.7 7447.9 7459.1 7470.4 6568.8 6802.8 7119.5 7181.1 7217.1 24924.0 25377.0 26073.0 26413.9 26598.5 2861.0 2936.2 2943.2 2949.2 3277.6 15375.7 16262.8 16399.6 16568.9 16688.5 2098.0 2155.2 2162.1 2162.4 2162.5 102415.0 133705.3 153612.9 156868.0 161804.4 17018.1 20317.9 21342.9 21501.7 21550.9 30597.4 30634.7 31186.7 31206.9 31228.5 8416.5 10153.3 10337.1 10553.3 10623.5 7820.7 8191.0 8705.8 8727.3 8853.3 7615.9 7776.7 9577.5 9577.6 9617.2 3578.7 4189.0 4201.3 4216.5 4218.5 759.3 866.5 885.2 914.3 930.6 20834.3 21603.2 21616.9 21686.0 21744.8 908.0 917.5 936.8 938.4 940.1 10580.8 10627.3 11347.1 11405.5 11405.9 760289.0 766289.0 770035.0 777227.0 791872.0 145639.8 145652.3 150661.2 151073.0 155096.0 1125.7 1138.7 1157.5 1158.9 1165.1 14883.3 16004.5 17661.8 17764.8 19151.3 46383.8 47528.8 52617.7 61315.4 63902.7 88817.1 89288.1 90368.5 91334.0 92418.3 9054.3 11202.4 11514.9 11716.6 11809.9 12449.0 12735.5 12926.3 13026.9 13191.4 11080.2 11129.8 11392.1 11492.0 11539.9 10080.2 10293.9 10520.8 10612.3 10650.4 9266.7 10963.6 11088.5 11529.9 11594.8 8459.0 10650.1 10919.4 11250.9 11565.8 11096.4 11534.5 11637.8 11694.6 11698.8 02:34:11 INFO - PROCESS | 1648 | 02:34:11 INFO - PROCESS | 1648 | [#3] mootools.html Cycles:180 Average:6659.58 Median:2380.36 stddev:4130.24 (173.5%) stddev-sans-first:4122.86 02:34:11 INFO - PROCESS | 1648 | Values: 1391.8 1520.2 1524.2 1532.9 1541.1 10502.1 10837.6 11043.3 11074.3 11081.0 10822.9 10990.1 11007.0 11014.9 11049.8 2347.4 2363.8 2373.7 2377.6 2388.1 1953.6 1995.7 2362.9 2368.5 2371.7 2337.5 2355.6 2366.2 2375.4 2388.8 2332.7 2347.9 2349.8 2371.4 2385.0 2373.6 2379.3 2381.4 2381.5 2386.5 10909.9 10916.6 10947.0 10954.9 10977.8 5427.2 5477.3 5630.7 5662.0 5664.3 3246.9 3297.3 3408.6 3414.6 3591.9 1158.3 1224.4 1252.3 1254.0 1831.2 13311.8 13460.7 14741.3 14886.5 14991.0 4673.9 4775.2 4804.0 4846.1 4866.9 12694.4 12731.1 12737.1 12744.7 12756.2 5801.9 5814.7 5881.6 5891.7 5898.2 5043.9 5113.1 5182.9 5203.2 5216.6 4128.7 4143.6 4172.3 4205.8 4214.8 1140.6 1156.6 1162.7 1165.7 1172.9 933.0 938.6 956.2 962.4 999.2 5872.2 6470.4 6479.8 6515.7 6548.7 983.6 987.2 1002.8 1011.5 1012.9 4040.3 4232.1 4238.4 4240.2 4269.4 13009.3 13383.9 13602.2 13613.0 13633.0 13355.9 13501.3 13642.9 13659.1 13827.0 8433.0 10000.5 10126.8 10127.1 10133.0 5101.4 6638.7 6816.0 6899.7 6932.6 11668.4 11725.2 11983.8 12001.2 12008.9 11884.5 11884.6 11992.8 12007.9 12049.7 8559.7 8672.2 8714.2 8725.1 8732.7 10166.1 10208.8 10209.6 10296.4 10315.5 8641.8 8711.4 8720.3 8941.8 8944.6 7284.0 8495.2 8497.4 8589.7 8601.5 7522.1 7523.2 7538.5 7558.8 7588.8 5852.8 5893.3 5993.8 6024.8 6103.6 5956.6 5983.4 6056.7 6098.4 6334.2 02:34:11 INFO - PROCESS | 1648 | 02:34:11 INFO - PROCESS | 1648 | [#4] prototype.html Cycles:180 Average:4658.92 Median:4883.37 stddev:1281.57 (26.2%) stddev-sans-first:1243.41 02:34:11 INFO - PROCESS | 1648 | Values: 335.7 342.0 375.3 377.7 387.5 4104.9 4404.9 4935.6 5300.3 5328.9 4545.9 4574.9 4600.1 5132.5 5154.5 3564.5 4271.3 4470.2 4490.3 4599.4 3441.1 3978.3 4326.9 4461.5 4543.4 3939.5 3980.4 4179.2 4399.8 4447.5 4413.9 4416.6 4436.9 4467.0 4476.9 3876.9 3907.5 4304.2 4316.2 4320.4 4340.6 4579.2 4771.3 4988.7 5019.6 4548.4 4904.7 5162.7 5182.6 5250.3 4615.5 5411.4 5571.8 5645.5 5707.4 4694.0 4695.7 4733.7 4752.1 4807.9 5048.3 5953.7 5966.8 5982.1 5991.8 3783.8 4272.4 4287.5 4675.6 5001.4 4487.4 4554.6 4754.0 5025.3 5092.4 4668.9 4884.8 5186.1 5216.9 5258.8 4434.7 4864.1 4941.6 5398.8 5617.0 1356.5 1521.6 1597.8 1660.0 1678.3 1252.5 1370.5 1387.9 1409.9 1423.6 4645.4 5142.9 5180.8 5201.7 5234.3 5707.3 5734.3 5735.9 5773.0 5870.5 3644.5 4588.7 4790.4 4855.5 5190.4 2777.9 3027.6 3040.2 3053.8 3083.2 5627.4 5729.8 5923.1 5988.9 6132.7 4775.7 5405.3 5571.3 5695.9 5868.9 4995.6 5557.3 5961.8 6014.2 6084.3 4405.2 4865.8 5751.3 5805.3 5831.4 4868.6 5751.3 5779.6 5785.4 5796.6 5910.9 5987.4 6022.9 6062.0 6064.4 4390.9 4441.7 4574.3 4605.3 4646.8 5458.5 5663.4 5760.2 5765.5 5885.9 4646.9 4882.0 5290.8 5466.0 5537.0 4523.7 4651.8 5500.6 5510.2 5562.9 4614.8 4697.6 4909.0 5151.0 5348.4 4575.6 5387.9 5524.2 5652.5 5669.9 5053.5 5278.0 5406.8 5458.6 5494.6 02:34:11 INFO - PROCESS | 1648 | 02:34:11 INFO - PROCESS | 1648 | [#5] yui.html Cycles:180 Average:18654.13 Median:24544.29 stddev:25568.40 (104.2%) stddev-sans-first:25604.21 02:34:11 INFO - PROCESS | 1648 | Values: 605.7 723.0 772.4 776.4 837.2 14777.9 15682.6 16260.1 16569.2 16583.8 12811.1 13293.6 14307.6 14925.4 15306.1 914.9 941.9 943.6 944.5 945.8 905.7 925.6 940.0 942.5 944.1 978.7 982.7 986.9 989.3 1006.2 978.5 981.0 983.1 984.9 985.1 629.4 725.1 731.5 733.2 734.2 15786.2 15899.6 16236.7 16587.0 16873.9 13826.2 14091.3 14096.5 14130.7 14154.3 9971.9 11546.5 11712.9 11887.8 12317.7 3583.2 3679.0 3697.9 3710.0 3819.4 91980.0 96309.4 106147.5 106198.5 106301.5 10402.1 10667.7 10718.1 10729.8 10751.8 18995.5 21565.5 22044.6 22115.7 22127.0 6835.4 6866.0 6945.4 6949.6 7087.5 4294.4 4409.3 4422.1 4460.6 4577.6 3347.3 3421.2 3485.7 3492.5 3492.9 643.5 669.5 670.2 691.3 692.2 586.3 661.9 698.8 699.8 702.2 9611.7 10111.5 10399.5 10443.4 10716.4 503.4 595.5 599.5 641.7 715.1 4685.6 4892.2 5005.9 5009.9 5037.9 65113.3 85988.6 86412.1 87765.0 88719.0 74423.3 74761.6 75805.0 76667.0 76712.6 62653.0 65382.7 68420.7 68662.0 70566.6 10793.9 10914.1 10958.5 11057.0 11252.8 44628.0 46524.0 47117.5 47284.8 48957.8 45662.0 53865.0 59435.0 61060.7 61337.7 12150.8 12165.8 12234.0 12380.4 12732.9 14176.6 14202.4 14278.3 14415.8 14938.7 12359.0 12399.7 12985.7 13031.3 13076.2 10088.3 10425.6 12366.7 13245.9 13291.9 12592.5 13042.6 13386.2 13554.6 13785.6 9275.7 9381.6 9658.4 9697.3 9754.3 11194.3 11271.5 11275.2 11299.4 11301.7 02:34:11 INFO - PROCESS | 1648 | -------- Summary: end -------- 02:34:11 INFO - PROCESS | 1648 | 02:34:12 INFO - TEST-INFO | 1648: exit 0 02:34:12 INFO - TEST-OK | dromaeo_css | took 1116912ms 02:34:12 INFO - TEST-START | kraken 02:34:12 INFO - operating with platform_type : mac_ 02:34:12 INFO - Initialising browser for kraken test... 02:34:12 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/tmpjjVov7/profile http://localhost:49245/getInfo.html) 02:34:14 INFO - PROCESS | 1661 | 2017-04-27 02:34:14.954 plugin-container[1663:10328] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d4f, name = 'com.apple.tsm.portname' 02:34:14 INFO - PROCESS | 1661 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:34:14 INFO - PROCESS | 1661 | 2017-04-27 02:34:14.954 plugin-container[1663:10328] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a33, name = 'com.apple.CFPasteboardClient' 02:34:14 INFO - PROCESS | 1661 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:34:14 INFO - PROCESS | 1661 | 2017-04-27 02:34:14.955 plugin-container[1663:10328] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:34:14 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 02:34:14 INFO - PROCESS | 1661 | colorDepth:24 02:34:14 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 02:34:14 INFO - PROCESS | 1661 | __metrics 02:34:15 ERROR - PROCESS | 1661 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3360: TypeError: this.tabs is undefined 02:34:15 INFO - TEST-INFO | 1661: exit 0 02:34:15 INFO - Browser initialized. 02:34:15 INFO - Running cycle 1/1 for kraken test... 02:34:15 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/tmpjjVov7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:34:18 INFO - PROCESS | 1664 | 2017-04-27 02:34:18.330 plugin-container[1665:10455] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 02:34:18 INFO - PROCESS | 1664 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:34:18 INFO - PROCESS | 1664 | 2017-04-27 02:34:18.330 plugin-container[1665:10455] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0f, name = 'com.apple.CFPasteboardClient' 02:34:18 INFO - PROCESS | 1664 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:34:18 INFO - PROCESS | 1664 | 2017-04-27 02:34:18.331 plugin-container[1665:10455] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:34:28 INFO - PROCESS | 1664 | RSS: Main: 220934144 02:34:28 INFO - PROCESS | 1664 | 02:34:31 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-beat-detection) 02:34:32 INFO - PROCESS | 1664 | RSS: Main: 235642880 02:34:32 INFO - PROCESS | 1664 | 02:34:34 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-dft) 02:34:35 INFO - PROCESS | 1664 | RSS: Main: 243499008 02:34:35 INFO - PROCESS | 1664 | 02:34:38 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-fft) 02:34:39 INFO - PROCESS | 1664 | RSS: Main: 245035008 02:34:39 INFO - PROCESS | 1664 | 02:34:41 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-oscillator) 02:34:42 INFO - PROCESS | 1664 | RSS: Main: 246800384 02:34:42 INFO - PROCESS | 1664 | 02:34:44 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49245/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:34:44 INFO - PROCESS | 1664 | RSS: Main: 247107584 02:34:44 INFO - PROCESS | 1664 | 02:34:47 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49245/tests/kraken/driver.html?testName=imaging-darkroom) 02:34:48 INFO - PROCESS | 1664 | RSS: Main: 251133952 02:34:48 INFO - PROCESS | 1664 | 02:34:51 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49245/tests/kraken/driver.html?testName=imaging-desaturate) 02:34:52 INFO - PROCESS | 1664 | RSS: Main: 250892288 02:34:52 INFO - PROCESS | 1664 | 02:34:55 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49245/tests/kraken/driver.html?testName=json-parse-financial) 02:34:56 INFO - PROCESS | 1664 | RSS: Main: 250871808 02:34:56 INFO - PROCESS | 1664 | 02:34:57 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49245/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:34:58 INFO - PROCESS | 1664 | RSS: Main: 250318848 02:34:58 INFO - PROCESS | 1664 | 02:35:00 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:35:01 INFO - PROCESS | 1664 | RSS: Main: 251617280 02:35:01 INFO - PROCESS | 1664 | 02:35:03 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:35:03 INFO - PROCESS | 1664 | RSS: Main: 251658240 02:35:03 INFO - PROCESS | 1664 | 02:35:06 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:35:07 INFO - PROCESS | 1664 | RSS: Main: 252051456 02:35:07 INFO - PROCESS | 1664 | 02:35:10 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:35:11 INFO - PROCESS | 1664 | RSS: Main: 252039168 02:35:11 INFO - PROCESS | 1664 | 02:35:13 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49245/tests/kraken/driver.html?testName=ai-astar) 02:35:13 INFO - PROCESS | 1664 | RSS: Main: 255217664 02:35:13 INFO - PROCESS | 1664 | 02:35:13 INFO - PROCESS | 1664 | __start_tp_report 02:35:13 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 02:35:13 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 02:35:13 INFO - PROCESS | 1664 | |i|pagename|runs| 02:35:13 INFO - PROCESS | 1664 | |0;ai-astar;112;123;128;122;123;168;176;141;123;122 02:35:13 INFO - PROCESS | 1664 | |1;audio-beat-detection;143;113;113;163;141;120;110;113;147;145 02:35:13 INFO - PROCESS | 1664 | |2;audio-dft;198;193;197;200;199;264;194;182;280;279 02:35:13 INFO - PROCESS | 1664 | |3;audio-fft;90;50;55;79;54;59;84;79;98;85 02:35:13 INFO - PROCESS | 1664 | |4;audio-oscillator;87;73;88;73;71;71;86;72;106;69 02:35:13 INFO - PROCESS | 1664 | |5;imaging-gaussian-blur;90;86;88;103;78;126;84;130;136;89 02:35:13 INFO - PROCESS | 1664 | |6;imaging-darkroom;97;98;97;96;122;153;97;96;97;122 02:35:13 INFO - PROCESS | 1664 | |7;imaging-desaturate;99;92;90;91;104;105;144;139;91;90 02:35:13 INFO - PROCESS | 1664 | |8;json-parse-financial;67;66;65;65;68;68;69;61;60;94 02:35:13 INFO - PROCESS | 1664 | |9;json-stringify-tinderbox;58;63;66;74;94;85;72;57;78;53 02:35:13 INFO - PROCESS | 1664 | |10;stanford-crypto-aes;85;84;86;97;99;86;87;87;91;105 02:35:13 INFO - PROCESS | 1664 | |11;stanford-crypto-ccm;141;142;147;115;144;131;150;160;201;185 02:35:13 INFO - PROCESS | 1664 | |12;stanford-crypto-pbkdf2;173;170;167;166;179;170;177;221;210;172 02:35:13 INFO - PROCESS | 1664 | |13;stanford-crypto-sha256-iterative;66;69;67;66;76;87;85;68;65;66 02:35:13 INFO - PROCESS | 1664 | __end_tp_report 02:35:13 INFO - PROCESS | 1664 | __start_cc_report 02:35:13 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,1036 02:35:13 INFO - PROCESS | 1664 | __end_cc_report 02:35:13 INFO - PROCESS | 1664 | __startTimestamp1493285713374__endTimestamp 02:35:13 INFO - PROCESS | 1664 | 02:35:13 INFO - PROCESS | 1664 | ------- Summary: start ------- 02:35:13 INFO - PROCESS | 1664 | Number of tests: 14 02:35:13 INFO - PROCESS | 1664 | 02:35:13 INFO - PROCESS | 1664 | [#0] ai-astar Cycles:10 Average:133.80 Median:125.50 stddev:21.45 (17.1%) stddev-sans-first:21.25 02:35:13 INFO - PROCESS | 1664 | Values: 112.0 123.0 128.0 122.0 123.0 168.0 176.0 141.0 123.0 122.0 02:35:13 INFO - PROCESS | 1664 | 02:35:13 INFO - PROCESS | 1664 | [#1] audio-beat-detection Cycles:10 Average:130.80 Median:142.00 stddev:19.01 (13.4%) stddev-sans-first:19.65 02:35:13 INFO - PROCESS | 1664 | Values: 143.0 113.0 113.0 163.0 141.0 120.0 110.0 113.0 147.0 145.0 02:35:13 INFO - PROCESS | 1664 | 02:35:13 INFO - PROCESS | 1664 | [#2] audio-dft Cycles:10 Average:218.60 Median:199.50 stddev:39.02 (19.6%) stddev-sans-first:40.66 02:35:13 INFO - PROCESS | 1664 | Values: 198.0 193.0 197.0 200.0 199.0 264.0 194.0 182.0 280.0 279.0 02:35:13 INFO - PROCESS | 1664 | 02:35:13 INFO - PROCESS | 1664 | [#3] audio-fft Cycles:10 Average:73.30 Median:81.50 stddev:17.19 (21.1%) stddev-sans-first:17.14 02:35:13 INFO - PROCESS | 1664 | Values: 90.0 50.0 55.0 79.0 54.0 59.0 84.0 79.0 98.0 85.0 02:35:13 INFO - PROCESS | 1664 | 02:35:13 INFO - PROCESS | 1664 | [#4] audio-oscillator Cycles:10 Average:79.60 Median:73.00 stddev:11.87 (16.3%) stddev-sans-first:12.29 02:35:13 INFO - PROCESS | 1664 | Values: 87.0 73.0 88.0 73.0 71.0 71.0 86.0 72.0 106.0 69.0 02:35:13 INFO - PROCESS | 1664 | 02:35:13 INFO - PROCESS | 1664 | [#5] imaging-gaussian-blur Cycles:10 Average:101.00 Median:85.00 stddev:21.53 (25.3%) stddev-sans-first:22.47 02:35:13 INFO - PROCESS | 1664 | Values: 90.0 86.0 88.0 103.0 78.0 126.0 84.0 130.0 136.0 89.0 02:35:13 INFO - PROCESS | 1664 | 02:35:13 INFO - PROCESS | 1664 | [#6] imaging-darkroom Cycles:10 Average:107.50 Median:97.00 stddev:19.11 (19.7%) stddev-sans-first:19.89 02:35:13 INFO - PROCESS | 1664 | Values: 97.0 98.0 97.0 96.0 122.0 153.0 97.0 96.0 97.0 122.0 02:35:13 INFO - PROCESS | 1664 | 02:35:13 INFO - PROCESS | 1664 | [#7] imaging-desaturate Cycles:10 Average:104.50 Median:90.50 stddev:20.34 (22.5%) stddev-sans-first:21.47 02:35:13 INFO - PROCESS | 1664 | Values: 99.0 92.0 90.0 91.0 104.0 105.0 144.0 139.0 91.0 90.0 02:35:13 INFO - PROCESS | 1664 | 02:35:13 INFO - PROCESS | 1664 | [#8] json-parse-financial Cycles:10 Average:68.30 Median:67.50 stddev:9.50 (14.1%) stddev-sans-first:10.06 02:35:13 INFO - PROCESS | 1664 | Values: 67.0 66.0 65.0 65.0 68.0 68.0 69.0 61.0 60.0 94.0 02:35:13 INFO - PROCESS | 1664 | 02:35:13 INFO - PROCESS | 1664 | [#9] json-stringify-tinderbox Cycles:10 Average:70.00 Median:73.00 stddev:13.13 (18.0%) stddev-sans-first:13.19 02:35:13 INFO - PROCESS | 1664 | Values: 58.0 63.0 66.0 74.0 94.0 85.0 72.0 57.0 78.0 53.0 02:35:13 INFO - PROCESS | 1664 | 02:35:13 INFO - PROCESS | 1664 | [#10] stanford-crypto-aes Cycles:10 Average:90.70 Median:87.00 stddev:7.17 (8.2%) stddev-sans-first:7.30 02:35:13 INFO - PROCESS | 1664 | Values: 85.0 84.0 86.0 97.0 99.0 86.0 87.0 87.0 91.0 105.0 02:35:13 INFO - PROCESS | 1664 | 02:35:13 INFO - PROCESS | 1664 | [#11] stanford-crypto-ccm Cycles:10 Average:151.60 Median:148.50 stddev:25.11 (16.9%) stddev-sans-first:26.34 02:35:13 INFO - PROCESS | 1664 | Values: 141.0 142.0 147.0 115.0 144.0 131.0 150.0 160.0 201.0 185.0 02:35:13 INFO - PROCESS | 1664 | 02:35:13 INFO - PROCESS | 1664 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.50 Median:175.00 stddev:19.05 (10.9%) stddev-sans-first:20.01 02:35:13 INFO - PROCESS | 1664 | Values: 173.0 170.0 167.0 166.0 179.0 170.0 177.0 221.0 210.0 172.0 02:35:13 INFO - PROCESS | 1664 | 02:35:13 INFO - PROCESS | 1664 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.50 Median:68.50 stddev:8.26 (12.1%) stddev-sans-first:8.52 02:35:13 INFO - PROCESS | 1664 | Values: 66.0 69.0 67.0 66.0 76.0 87.0 85.0 68.0 65.0 66.0 02:35:13 INFO - PROCESS | 1664 | -------- Summary: end -------- 02:35:13 INFO - PROCESS | 1664 | 02:35:14 INFO - TEST-INFO | 1664: exit 0 02:35:14 INFO - TEST-OK | kraken | took 62034ms 02:35:14 INFO - SUITE-END | took 1178s 02:35:14 INFO - Completed test suite (00:19:39) 02:35:14 INFO - javascript benchmark 02:35:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7563.202040512374, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3291.7162306700375, 3409.7272218222543, 3419.3503234385466, 3442.191085095004, 3455.8617655293788, 5661.575381846357, 5685.033544297474, 5692.0323544997345, 5703.800366987156, 5718.828435146952, 5079.03498335316, 5502.449755024496, 5662.207290979256, 5706.885862282752, 5723.713814309289, 5178.663386879841, 5191.896162076756, 5243.2659427680155, 5263.921041184385, 5299.49654782795, 5301.363836339645, 5307.840764777063, 5322.121849894763, 5326.946730532703, 5375.462453754632, 4381.9561804381865, 5128.384593848725, 5143.996920600484, 5313.884084342293, 5354.250404943292, 5235.031519168947, 5270.631055826094, 5281.155015197569, 5322.574194064504, 5332.120200166968, 5153.896922061575, 5254.710990895499, 5258.0, 5269.0, 5323.307969963918, 5522.889542209174, 5736.68448235351, 5763.279590051244, 5852.4440178183, 5870.090136028923, 6131.662758548278, 6147.415995480422, 6184.165137706397, 6201.410865967726, 6209.751609935643, 6223.222097237845, 6235.064740288993, 6248.187735594389, 6250.312465628777, 6255.155554000243, 5855.06318988964, 5859.531237501075, 5894.410558944114, 5898.705064746831, 5942.554308426799, 6126.36500017443, 6182.6599537024995, 6187.752489900444, 6218.160548325918, 6255.812325630239, 6128.816135515942, 6177.722002509898, 6182.0, 6197.411245931629, 6212.161358216673, 6168.660723660242, 6228.439440450381, 6231.532635052389, 6238.064290356392, 6281.277653069864, 6060.636361818305, 6086.969565152146, 6087.4521293083835, 6088.8782224356155, 6230.937690623126, 5570.192322113352, 5842.269716285465, 6114.327782088734, 6242.094896240111, 6275.403836635513, 4994.2508623706735, 4995.525425084611, 4996.525330093636, 5009.499050094962, 5012.473690262543, 3897.785621790829, 4319.6976211665515, 4477.283634618446, 4480.103979204107, 4503.099380123988, 5675.177099320658, 5752.741126649311, 5755.913661295084, 5783.537317014629, 5786.218860453869, 6185.536084793568, 6210.31686514483, 6211.720472578745, 6213.875722485615, 6226.533010024266, 5591.273134492571, 5640.0, 5710.65736055838, 5764.048931926185, 5826.941730582725, 5432.212329212242, 5498.3127109111365, 5501.587380946365, 5507.944920550824, 5508.063629183049, 5219.76511057011, 6151.138840562415, 6158.168647232566, 6179.969100154471, 6209.348018458178, 5233.267342572119, 6200.968995154995, 6225.221847269091, 6225.346338634378, 6226.937730622636, 6271.167053744929, 6290.0879372491645, 6300.495960323072, 6302.84242893913, 6316.115743795965, 6030.819075427568, 6071.2714474263375, 6107.583301036431, 6126.0, 6185.319614842274, 6121.816345509642, 6164.568480206342, 6171.876562468636, 6193.380661933951, 6197.907031394623, 5298.0, 6108.236470441195, 6129.724162412613, 6160.44555989963, 6187.566870319034, 5912.615679980788, 6095.939040609537, 6097.664628445301, 6098.207233059674, 6115.816525504242, 4994.200927851526, 5333.7066461345, 5396.541293990055, 5861.413858614104, 5956.136360227656, 6132.20254427538, 6133.60131591463, 6135.35515879939, 6176.197094377702, 6177.135201071944, 5987.550933679904, 5996.310424301261, 6003.099535069775, 6014.338422773579, 6030.819075427744], "value": 5669.2492898494875, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [713.4613366907984, 729.1541811498662, 744.757953665059, 946.1484663802572, 958.8226178157037, 37210.81394593027, 37913.05217369567, 39184.60815391845, 39281.214375712465, 39325.80337098314, 38068.42897356535, 38307.0, 38316.23367532655, 38319.616803832025, 39152.41271380932, 7765.92234077659, 10397.0, 10682.732931676692, 10844.240903136744, 10848.728781780479, 10541.209409294295, 10576.894231057668, 10614.097801686867, 10619.46902654868, 10628.149748020178, 10590.09984151348, 10603.310784799001, 10639.521221545048, 10642.62750803722, 10664.946675266612, 10575.68272951805, 10589.894101058968, 10639.840402393931, 10647.307924984929, 10647.893521064767, 10407.271490995634, 10455.059044686015, 10464.319819211803, 10465.215108866865, 10502.369857808557, 33112.83443582791, 33203.0, 33252.6674733252, 33312.666873331196, 33684.32631347384, 3645.471406646048, 3691.9446208306895, 3695.907602309937, 3707.4624179494094, 3744.7378683491893, 24548.386290342885, 24686.0, 24969.62545561818, 25883.74116258832, 25979.830907609205, 3019.9396012079856, 3056.5567992640945, 3128.906132816019, 3211.6948889855425, 3235.1912021994503, 355303.0, 357000.0, 360614.0, 360736.19631901936, 361171.1941440302, 43584.0, 43619.56380436155, 43815.90460238456, 43843.78078109653, 43889.561104388544, 44948.55051449444, 45220.54779452229, 45337.54662453333, 45378.546214538095, 45493.0, 13548.119372240773, 13826.861731382558, 13850.65373365674, 13852.584422467342, 13931.930340348234, 11799.997000255074, 12009.039276857831, 12009.819852702216, 12012.399380030964, 12037.398130093636, 11128.109751219883, 11635.76728465426, 11691.240069395462, 11744.647660570197, 11798.292102473708, 4430.623397011225, 4651.511591282867, 4917.139500587455, 5294.841154765363, 5431.864203394946, 1104.447776111944, 1106.7620461600795, 1131.2748059209607, 1151.9424028798526, 1196.3958201108385, 26017.609735853977, 26220.0, 26455.603165952525, 26473.867630661724, 26625.33436664099, 777.4247057177648, 1004.5630150884389, 1224.3266203587991, 1255.1151438236022, 1280.359820089955, 11112.665920358111, 12641.367931603383, 14782.556523304318, 14880.032797868103, 14890.329935152944, 483878.0, 487510.0, 487847.0, 488780.0, 488985.55507222237, 47656.76171619189, 47787.522124779, 48332.0, 48397.0, 48460.757696212, 1400.6288333591606, 1420.7584710599224, 1430.0918916488106, 1432.1550285331705, 1433.7419264532484, 26269.605955911058, 26618.733812661627, 26771.86614066917, 27201.591976119977, 27302.317442064108, 40324.79837600793, 40421.393679094246, 40517.59482405138, 40562.391564125974, 40658.59341406548, 482074.0, 482569.0, 482597.0, 483179.0, 483234.0, 28938.565921510773, 29670.0, 29941.401171976875, 30037.69962300349, 30062.947796827008, 36769.71306004384, 37143.62856371402, 37738.86783396502, 37788.62211377851, 37840.24319513649, 26731.33171670724, 26751.598726019514, 26825.463490730468, 27355.316117096434, 27651.308717281423, 25296.494070118864, 26957.3260668477, 27546.89812407481, 27773.0, 27799.44401111926, 30463.847680761453, 30913.8454307727, 31272.68727312789, 31427.528587070756, 31524.842375788892, 27033.59449608218, 27483.862580686968, 27549.586756199074, 27826.86086569554, 28052.018179363626, 19144.329948451737, 22161.778382216617, 22178.001989910816, 22215.666764998216, 22267.554648907255], "value": 17879.191276235593, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [407.3299422450068, 409.5044995555378, 415.53875198529636, 430.3093534876523, 444.95435726043803, 18854.90572547137, 20556.280530181448, 21214.787852121473, 21268.0, 21368.786312136912, 21623.45941351467, 21717.565648687018, 21746.782532174675, 22271.0, 22544.88727556364, 6462.5153113516435, 6675.866482670343, 6697.464202863759, 6740.325967403245, 6751.0, 6580.835479113012, 6865.41643960264, 7212.170600380945, 7340.596267205302, 7367.8894816577795, 7134.643267836614, 7322.304381083789, 7354.2645735426295, 7358.117025956866, 7383.446241531879, 7145.642717864086, 7399.741009064684, 7447.851042979137, 7459.067616547904, 7470.4397170211905, 6568.835779105513, 6802.829929251809, 7119.50163488556, 7181.138263408372, 7217.097862767154, 24924.0, 25377.0, 26073.0, 26413.867930660224, 26598.468030639473, 2860.9713902860913, 2936.2219011961847, 2943.175910744995, 2949.2037149969387, 3277.5903012123485, 15375.692486150327, 16262.75605865913, 16399.59001024972, 16568.917155414267, 16688.499345019667, 2098.0034483620157, 2155.2025750472426, 2162.1135334512774, 2162.38372063961, 2162.535054963175, 102414.98127340824, 133705.331473343, 153612.92774144455, 156868.0, 161804.38195618012, 17018.14909254557, 20317.898410508147, 21342.89328553347, 21501.67747483789, 21550.89224553867, 30597.388052239276, 30634.69365306363, 31186.68813311883, 31206.907758228353, 31228.531572026437, 8416.452930559493, 10153.289269751194, 10337.121344685636, 10553.31403458788, 10623.468826558641, 7820.748680211139, 8190.959045204736, 8705.825883482295, 8727.301815854717, 8853.29173666105, 7615.923840761521, 7776.688932442752, 9577.521123943776, 9577.616895324249, 9617.23062155026, 3578.6600272974024, 4188.958110418917, 4201.264778663722, 4216.451861258078, 4218.514870789899, 759.2862709053472, 866.4627930682891, 885.1502557544829, 914.3279689428265, 930.59054016234, 20834.27080052191, 21603.243886463897, 21616.891915540637, 21686.0, 21744.78255217459, 907.9682211122579, 917.4907926100944, 936.7564433247405, 938.3853575907791, 940.1022023967095, 10580.841287380696, 10627.309224900357, 11347.148963827745, 11405.486753096131, 11405.942970285096, 760289.0, 766289.0, 770035.0, 777227.0, 791872.0, 145639.81540276905, 145652.27173864274, 150661.24669376583, 151073.0, 155096.0, 1125.6960620632383, 1138.6584024792528, 1157.473349625935, 1158.889905458997, 1165.1086918507349, 14883.255837208313, 16004.519864404087, 17661.82338176602, 17764.84528505643, 19151.32970346087, 46383.76808115938, 47528.762356187995, 52617.73691131673, 61315.38684613275, 63902.680486597266, 88817.11182888347, 89288.10711893058, 90368.54815726142, 91334.0, 92418.33593218963, 9054.275657947217, 11202.38386888729, 11514.94242528782, 11716.589919353122, 11809.937105660532, 12449.0, 12735.490580377053, 12926.289054102115, 13026.934865325613, 13191.40638671243, 11080.168987325822, 11129.777404452028, 11392.145589080686, 11492.0, 11539.884601154217, 10080.24398170155, 10293.948530257301, 10520.842187367043, 10612.310199836986, 10650.414227217267, 9266.721998340061, 10963.574735284363, 11088.501017454395, 11529.942350288195, 11594.826077609012, 8459.027211870467, 10650.147988161083, 10919.39943303126, 11250.943745281222, 11565.768684626428, 11096.445177741241, 11534.538618455503, 11637.76724465523, 11694.649160525198, 11698.824517632072], "value": 11424.832057281794, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1391.7912313153029, 1520.2246854104403, 1524.161711058918, 1532.9310181041851, 1541.1061584281117, 10502.054815066642, 10837.620683276067, 11043.282186657862, 11074.335539867603, 11081.0, 10822.891771082286, 10990.065844403236, 11007.009369156774, 11014.944925275382, 11049.779004419906, 2347.448349637834, 2363.8108951283943, 2373.679553260305, 2377.6314671225987, 2388.0925248405583, 1953.5799803042344, 1995.730576372193, 2362.917297894574, 2368.4789346343778, 2371.727251366089, 2337.520808234308, 2355.5759963206615, 2366.20732054761, 2375.406148462884, 2388.8088952883813, 2332.650102484624, 2347.9060837566476, 2349.7650234976536, 2371.4071482129466, 2384.9642255366184, 2373.6320870264963, 2379.310000099986, 2381.404648837791, 2381.4641705616273, 2386.4511162432736, 10909.945450272777, 10916.563337466492, 10946.960038796382, 10954.890451095547, 10977.83533247002, 5427.158790387496, 5477.3427188737605, 5630.662160270397, 5661.971690141564, 5664.320281566197, 3246.8863589774483, 3297.3240485700376, 3408.5909690837257, 3414.641462646411, 3591.9281614367565, 1158.3339579741598, 1224.3878060969516, 1252.3362617812575, 1254.0, 1831.230883029131, 13311.801937825641, 13460.663483412894, 14741.336639851232, 14886.478973235884, 14991.025583337158, 4673.859784206479, 4775.198427508674, 4804.0, 4846.079244943449, 4866.878328041827, 12694.365281735876, 12731.108822382344, 12737.108402411743, 12744.6813829655, 12756.234625922474, 5801.9419805802245, 5814.738336774855, 5881.558883083786, 5891.675957822361, 5898.203742494708, 5043.949560504421, 5113.130767769489, 5182.948170518322, 5203.167493201146, 5216.556592689664, 4128.710990230715, 4143.564061289017, 4172.2658220892135, 4205.789710514462, 4214.831406743696, 1140.6235942139074, 1156.5778490850946, 1162.7325715085578, 1165.7493638867516, 1172.9237599556002, 932.9533523323806, 938.5870217104452, 956.2302346611045, 962.4177372689562, 999.2256001598819, 5872.236609240771, 6470.417662410406, 6479.8056058318325, 6515.6742162892615, 6548.70530826114, 983.5672304186278, 987.2151639446657, 1002.8495725641212, 1011.5043628622069, 1012.9493525323704, 4040.252553277653, 4232.090100628379, 4238.427812245307, 4240.194363071068, 4269.359596060615, 13009.284489353176, 13383.866161338457, 13602.183868967893, 13613.0, 13633.0, 13355.866441335656, 13501.324933753272, 13642.93178534101, 13659.112157709716, 13826.962977776708, 8432.988041434945, 10000.499975001221, 10126.797464050678, 10127.088562029452, 10133.0, 5101.387833460009, 6638.734450621921, 6816.011678306519, 6899.689513971783, 6932.618705971018, 11668.416579171177, 11725.179237453638, 11983.76032479328, 12001.1599188056, 12008.879911200776, 11884.524619015488, 11884.643460696192, 11992.76014479723, 12007.879921200676, 12049.698757531132, 8559.74320770378, 8672.176143266379, 8714.172153645393, 8725.127487251479, 8732.69435569752, 10166.085052345325, 10208.846867297145, 10209.591616335263, 10296.433696146783, 10315.48422578883, 8641.82716345657, 8711.433756805787, 8720.345974052098, 8941.776455588662, 8944.552772361225, 7284.0, 8495.150484951455, 8497.362697797565, 8589.742307730778, 8601.532092123956, 7522.059742532184, 7523.172451030273, 7538.472306938462, 7558.773236802905, 7588.8482230353975, 5852.824415267549, 5893.292804863444, 5993.760249589967, 6024.849378765566, 6103.633781973096, 5956.583039187389, 5983.431574000463, 6056.697165141637, 6098.359672234529, 6334.208223972004], "value": 5116.220288196166, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.70793409733534, 341.9811910344932, 375.3356558890765, 377.71671246565074, 387.5117352136309, 4104.938425923606, 4404.867853964378, 4935.6051515878735, 5300.310959575255, 5328.866778330544, 4545.931811022837, 4574.908501829961, 4600.102979918909, 5132.538071573557, 5154.458781827911, 3564.465330200465, 4271.295236286009, 4470.195364834329, 4490.348899409583, 4599.356090147382, 3441.122513758988, 3978.345335956923, 4326.913461730779, 4461.460796025366, 4543.386642803229, 3939.5469521005166, 3980.3772982889886, 4179.247735407641, 4399.802008909607, 4447.466304043519, 4413.867583972486, 4416.580424859633, 4436.911261774779, 4466.955330446686, 4476.940607320636, 3876.8836934891997, 3907.5310962684375, 4304.203722311382, 4316.244657185011, 4320.438343015419, 4340.587644173798, 4579.244424669925, 4771.308160316769, 4988.725620090893, 5019.623528235397, 4548.431446069241, 4904.705717656916, 5162.74186290684, 5182.585393168538, 5250.343707036621, 4615.515370886043, 5411.374379165929, 5571.804986825442, 5645.491905728504, 5707.3721890592005, 4694.0, 4695.652173913043, 4733.715977041388, 4752.122911449993, 4807.927881081787, 5048.318477005557, 5953.690188158598, 5966.791162309341, 5982.06479654287, 5991.820245392645, 3783.829727662262, 4272.444582204355, 4287.506936702257, 4675.579197872208, 5001.374553270201, 4487.371767952489, 4554.635629149726, 4754.0, 5025.346704928409, 5092.402874534015, 4668.883277918079, 4884.755762211875, 5186.144286192812, 5216.947830521722, 5258.789648414097, 4434.711743736647, 4864.148773964542, 4941.604671626261, 5398.758285594336, 5616.97191514048, 1356.5455572383362, 1521.6119889428126, 1597.8096318242983, 1659.9502014939571, 1678.2531773360738, 1252.4594748459447, 1370.5134677189653, 1387.8896882493964, 1409.8872090232962, 1423.5729281215595, 4645.352149274949, 5142.879972832317, 5180.766865491062, 5201.713905735145, 5234.257505883312, 5707.34365547959, 5734.254546908875, 5735.913961290584, 5773.037167363117, 5870.501007414332, 3644.526211592476, 4588.655850811202, 4790.353302304214, 4855.519066684625, 5190.351206099238, 2777.888844462231, 3027.6215473065868, 3040.236662735608, 3053.8167709937475, 3083.152133163398, 5627.43725627434, 5729.822667386366, 5923.072765951195, 5988.9101663475085, 6132.724027418777, 4775.6657034007985, 5405.297311349578, 5571.303587051619, 5695.886082278331, 5868.911966320508, 4995.550400463903, 5557.333120025542, 5961.7615295387695, 6014.233452611673, 6084.300305464928, 4405.229149813754, 4865.791090706584, 5751.338596061507, 5805.345476539166, 5831.35855055952, 4868.561829435368, 5751.252337196138, 5779.566532509994, 5785.42145785435, 5796.62321949072, 5910.852228694317, 5987.43119403656, 6022.8857661332795, 6062.030075188125, 6064.363241859542, 4390.9022744313925, 4441.666874984454, 4574.324020448075, 4605.309203619484, 4646.83736069236, 5458.5087342139395, 5663.377028526941, 5760.1935728998815, 5765.4522820332, 5885.852853678693, 4646.9107185676385, 4881.975590122027, 5290.788368465218, 5465.972670136783, 5537.0, 4523.683342166017, 4651.813927442864, 5500.614956952975, 5510.173473978935, 5562.944370556243, 4614.838480653161, 4697.600703940203, 4909.0, 5150.99555586657, 5348.358197016383, 4575.604440645635, 5387.89548142622, 5524.171374293727, 5652.463016013472, 5669.858253543694, 5053.47713796143, 5277.991544819416, 5406.783218880398, 5458.645188062763, 5494.615376923577], "value": 4293.537419330078, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [605.7122866638344, 722.9783106506807, 772.4361216312092, 776.3750181104213, 837.1620207496586, 14777.852221477782, 15682.607934801636, 16260.105694186816, 16569.17154142294, 16583.83416165841, 12811.103222774385, 13293.601191964231, 14307.642308942255, 14925.402983880631, 15306.081635101902, 914.9451032938028, 941.8540126280403, 943.6319835264218, 944.489975413276, 945.7635591102224, 905.6603773584906, 925.5881132895864, 940.0129863643182, 942.5428667096453, 944.0936700767272, 978.70149604371, 982.7248370456284, 986.856905748666, 989.2975987049203, 1006.16488314699, 978.5205249427801, 980.9656662016866, 983.1102851919024, 984.8670429492034, 985.074030411411, 629.4020680353682, 725.1044959475045, 731.469684478754, 733.1751779248345, 734.1813877526573, 15786.210689465595, 15899.60250993723, 16236.675266494603, 16587.0, 16873.903196292325, 13826.170429774245, 14091.2954352283, 14096.50662226817, 14130.717385652331, 14154.292285385689, 9971.850422243671, 11546.549607011679, 11712.88287117135, 11887.762244755142, 12317.69205769854, 3583.211693427442, 3679.0, 3697.9445308320396, 3709.981450092759, 3819.3698039823394, 91980.0, 96309.36906309384, 106147.46926265319, 106198.46900765524, 106301.46849265705, 10402.115820155372, 10667.679969600924, 10718.08896243828, 10729.78540429187, 10751.78496430067, 18995.525111872314, 21565.490415671065, 22044.559108818055, 22115.668264976037, 22127.0, 6835.384815366541, 6866.0, 6945.374916257561, 6949.583025018515, 7087.503874728823, 4294.3558466230315, 4409.250427427345, 4422.071365013383, 4460.576245256695, 4577.633789296849, 3347.313800670857, 3421.23022319981, 3485.738569607239, 3492.511048453219, 3492.930141397158, 643.4723526708054, 669.5045666206972, 670.2024590737008, 691.2959554697594, 692.2350802363417, 586.3169407640052, 661.8940969444866, 698.8078278473461, 699.8250437390652, 702.220535205921, 9611.711648650551, 10111.544980475895, 10399.53202105907, 10443.425611591436, 10716.410597417216, 503.39417258943854, 595.4938302442889, 599.5173885022599, 641.7272659119856, 715.0561259137992, 4685.6017238535105, 4892.217245240744, 5005.899882002413, 5009.874753131201, 5037.899242015213, 65113.348866511675, 85988.57005715056, 86412.1358786404, 87765.0, 88719.0, 74423.25576744163, 74761.6261918687, 75805.0, 76667.0, 76712.61643691745, 62653.0, 65382.673086635215, 68420.6578967112, 68662.0, 70566.64716676384, 10793.946030269799, 10914.126869850234, 10958.452077396258, 11057.0, 11252.831207532057, 44628.0, 46524.0, 47117.52882471269, 47284.7635761819, 48957.75521122372, 45662.0, 53865.0, 59435.0, 61060.69469652623, 61337.693311533156, 12150.836597008367, 12165.756684866075, 12234.0, 12380.380980951097, 12732.936335318635, 14176.574702758933, 14202.360893759598, 14278.286085695881, 14415.78376324335, 14938.701225975637, 12358.98249301084, 12399.690007749878, 12985.740285194055, 13031.348432578523, 13076.215427074407, 10088.344257623232, 10425.582976680847, 12366.690832729253, 13245.867541324464, 13291.933540332237, 12592.496300147892, 13042.608721738363, 13386.19682818995, 13554.622435443287, 13785.586432407044, 9275.72172834816, 9381.624735010522, 9658.3722058066, 9697.321187516805, 9754.317197796086, 11194.2723722961, 11271.549138034386, 11275.170465323094, 11299.37853418037, 11301.660950171508], "value": 7357.106482144173, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1581.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 123.0, 128.0, 122.0, 123.0, 168.0, 176.0, 141.0, 123.0, 122.0], "value": 133.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 113.0, 113.0, 163.0, 141.0, 120.0, 110.0, 113.0, 147.0, 145.0], "value": 130.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 193.0, 197.0, 200.0, 199.0, 264.0, 194.0, 182.0, 280.0, 279.0], "value": 218.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 50.0, 55.0, 79.0, 54.0, 59.0, 84.0, 79.0, 98.0, 85.0], "value": 73.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 73.0, 88.0, 73.0, 71.0, 71.0, 86.0, 72.0, 106.0, 69.0], "value": 79.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 86.0, 88.0, 103.0, 78.0, 126.0, 84.0, 130.0, 136.0, 89.0], "value": 101.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 98.0, 97.0, 96.0, 122.0, 153.0, 97.0, 96.0, 97.0, 122.0], "value": 107.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 92.0, 90.0, 91.0, 104.0, 105.0, 144.0, 139.0, 91.0, 90.0], "value": 104.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 65.0, 65.0, 68.0, 68.0, 69.0, 61.0, 60.0, 94.0], "value": 68.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 63.0, 66.0, 74.0, 94.0, 85.0, 72.0, 57.0, 78.0, 53.0], "value": 70.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 86.0, 97.0, 99.0, 86.0, 87.0, 87.0, 91.0, 105.0], "value": 90.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 142.0, 147.0, 115.0, 144.0, 131.0, 150.0, 160.0, 201.0, 185.0], "value": 151.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 170.0, 167.0, 166.0, 179.0, 170.0, 177.0, 221.0, 210.0, 172.0], "value": 180.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 67.0, 66.0, 76.0, 87.0, 85.0, 68.0, 65.0, 66.0], "value": 71.5, "unit": "score"}]}]} 02:35:14 INFO - Return code: 0 02:35:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:35:14 ERROR - # TBPL SUCCESS # 02:35:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:35:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:35:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:35:14 INFO - 2017-04-27 02:35:14.736 screenresolution[1669:10834] starting screenresolution argv=screenresolution get 02:35:14 INFO - 2017-04-27 02:35:14.739 screenresolution[1669:10834] Display 0: 1600x1200x32@60 02:35:14 INFO - 2017-04-27 02:35:14.745 screenresolution[1670:10837] starting screenresolution argv=screenresolution list 02:35:14 INFO - Available Modes on Display 0 02:35:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:35:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:35:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:35:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:35:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:35:14 INFO - Intel Iris: 02:35:14 INFO - Chipset Model: Intel Iris 02:35:14 INFO - Type: GPU 02:35:14 INFO - Bus: Built-In 02:35:14 INFO - VRAM (Dynamic, Max): 1536 MB 02:35:14 INFO - Vendor: Intel (0x8086) 02:35:14 INFO - Device ID: 0x0a2e 02:35:14 INFO - Revision ID: 0x0009 02:35:14 INFO - Displays: 02:35:14 INFO - Display: 02:35:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:35:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:35:14 INFO - Display Serial Number: 1600x1200 60 02:35:14 INFO - Main Display: Yes 02:35:14 INFO - Mirror: Off 02:35:14 INFO - Online: Yes 02:35:14 INFO - Rotation: Supported 02:35:14 INFO - Return code: 0 02:35:14 INFO - Running post-action listener: _resource_record_post_action 02:35:14 INFO - [mozharness: 2017-04-27 09:35:14.979556Z] Finished run-tests step (success) 02:35:14 INFO - Running post-run listener: _resource_record_post_run 02:35:15 INFO - Total resource usage - Wall time: 1200s; CPU: 55.0%; Read bytes: 39512064; Write bytes: 511669248; Read time: 248; Write time: 1604 02:35:15 INFO - TinderboxPrint: CPU usage
54.6% 02:35:15 INFO - TinderboxPrint: I/O read bytes / time
39,512,064 / 248 02:35:15 INFO - TinderboxPrint: I/O write bytes / time
511,669,248 / 1,604 02:35:15 INFO - TinderboxPrint: CPU idle
2,181.8 (45.4%) 02:35:15 INFO - TinderboxPrint: CPU system
959.9 (20.0%) 02:35:15 INFO - TinderboxPrint: CPU user
1,659.9 (34.6%) 02:35:15 INFO - TinderboxPrint: Swap in / out
248,242,176 / 0 02:35:15 INFO - install - Wall time: 21s; CPU: 55.0%; Read bytes: 201806336; Write bytes: 200693760; Read time: 15642; Write time: 427 02:35:15 INFO - run-tests - Wall time: 1180s; CPU: 55.0%; Read bytes: 37677056; Write bytes: 300186624; Read time: 230; Write time: 1146 02:35:15 INFO - Running post-run listener: _upload_blobber_files 02:35:15 INFO - Blob upload gear active. 02:35:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:35:15 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:35:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:35:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:35:15 INFO - (blobuploader) - INFO - Open directory for files ... 02:35:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:35:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:35:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:35:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:35:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:35:16 INFO - (blobuploader) - INFO - Done attempting. 02:35:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:35:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:35:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:35:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:35:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:35:17 INFO - (blobuploader) - INFO - Done attempting. 02:35:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:35:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:35:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:35:18 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:35:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:35:18 INFO - (blobuploader) - INFO - Done attempting. 02:35:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:35:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:35:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:35:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:35:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:35:20 INFO - (blobuploader) - INFO - Done attempting. 02:35:20 INFO - (blobuploader) - INFO - Iteration through files over. 02:35:20 INFO - Return code: 0 02:35:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:35:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:35:20 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f8b5490dd6aa804afcdc74de824aae08c58a005a99bc76ae4db9e008c7af1fe84f6bde21ea1cbc55bdc6ddc4d7e6b988782b01ff0d39718de5c4296044832b38", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/03fd25751ea95f2567fc07a714ff651122869d6935f64446f82e72005973ebb520777015116d113c8f5e45809e516850107f74b64215f17d92a296474396f5c6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c4844562c90ddce74922e23f0b37eed9898f41f393265fad85bf9794771017d4942c8ab14db58a29f745b4c77a566eb0ac282ece2c2650df5cec571e9db61198", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bc3fd00a28586c2e37c6b89b68579a64760846f00d0cd2d4757dd3c025837311eea048e62d790fdf4d8943a84b41c90d7120b1525ad8d23432364ae69155e50e"} 02:35:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:35:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:35:20 INFO - Contents: 02:35:20 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f8b5490dd6aa804afcdc74de824aae08c58a005a99bc76ae4db9e008c7af1fe84f6bde21ea1cbc55bdc6ddc4d7e6b988782b01ff0d39718de5c4296044832b38", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/03fd25751ea95f2567fc07a714ff651122869d6935f64446f82e72005973ebb520777015116d113c8f5e45809e516850107f74b64215f17d92a296474396f5c6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c4844562c90ddce74922e23f0b37eed9898f41f393265fad85bf9794771017d4942c8ab14db58a29f745b4c77a566eb0ac282ece2c2650df5cec571e9db61198", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bc3fd00a28586c2e37c6b89b68579a64760846f00d0cd2d4757dd3c025837311eea048e62d790fdf4d8943a84b41c90d7120b1525ad8d23432364ae69155e50e"} 02:35:20 INFO - Running post-run listener: copy_logs_to_upload_dir 02:35:20 INFO - Copying logs to upload dir... 02:35:20 INFO - mkdir: /builds/slave/test/build/upload/logs 02:35:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1283.032092 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-04-27 02:35:20.754406) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-27 02:35:20.757569) ========= 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.LptxlqJa1L/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.KTWt4od89l/Listeners TMPDIR=/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f8b5490dd6aa804afcdc74de824aae08c58a005a99bc76ae4db9e008c7af1fe84f6bde21ea1cbc55bdc6ddc4d7e6b988782b01ff0d39718de5c4296044832b38", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/03fd25751ea95f2567fc07a714ff651122869d6935f64446f82e72005973ebb520777015116d113c8f5e45809e516850107f74b64215f17d92a296474396f5c6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c4844562c90ddce74922e23f0b37eed9898f41f393265fad85bf9794771017d4942c8ab14db58a29f745b4c77a566eb0ac282ece2c2650df5cec571e9db61198", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bc3fd00a28586c2e37c6b89b68579a64760846f00d0cd2d4757dd3c025837311eea048e62d790fdf4d8943a84b41c90d7120b1525ad8d23432364ae69155e50e"} build_url:https://queue.taskcluster.net/v1/task/Y7auEGk7T6mmt4dNvRVQIg/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011139 build_url: 'https://queue.taskcluster.net/v1/task/Y7auEGk7T6mmt4dNvRVQIg/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f8b5490dd6aa804afcdc74de824aae08c58a005a99bc76ae4db9e008c7af1fe84f6bde21ea1cbc55bdc6ddc4d7e6b988782b01ff0d39718de5c4296044832b38", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/03fd25751ea95f2567fc07a714ff651122869d6935f64446f82e72005973ebb520777015116d113c8f5e45809e516850107f74b64215f17d92a296474396f5c6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c4844562c90ddce74922e23f0b37eed9898f41f393265fad85bf9794771017d4942c8ab14db58a29f745b4c77a566eb0ac282ece2c2650df5cec571e9db61198", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bc3fd00a28586c2e37c6b89b68579a64760846f00d0cd2d4757dd3c025837311eea048e62d790fdf4d8943a84b41c90d7120b1525ad8d23432364ae69155e50e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-27 02:35:20.792557) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-27 02:35:20.792856) ========= 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.LptxlqJa1L/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.KTWt4od89l/Listeners TMPDIR=/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/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.005076 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-27 02:35:20.840767) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-27 02:35:20.841065) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-27 02:35:20.841364) ========= ========= Total master_lag: 0.18 =========