builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0087 starttime: 1491970403.59 results: success (0) buildid: 20170411195108 builduid: 423cbe87a30748e0aa6165ec20c9c591 revision: 928b5958a1dcbfa22ecac8e5773f674d5f56f214 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-11 21:13:23.593692) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-11 21:13:23.594146) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-11 21:13:23.594421) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-11 21:13:23.621486) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 21:13:23.622000) ========= 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.vVoAQeLDXY/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.gLfCUIOMOL/Listeners TMPDIR=/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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-11 21:13:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 155M=0s 2017-04-11 21:13:23 (155 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.108861 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 21:13:23.755371) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 21:13:23.755679) ========= 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.vVoAQeLDXY/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.gLfCUIOMOL/Listeners TMPDIR=/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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.030737 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 21:13:23.807949) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-11 21:13:23.808294) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 928b5958a1dcbfa22ecac8e5773f674d5f56f214 --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 928b5958a1dcbfa22ecac8e5773f674d5f56f214 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.vVoAQeLDXY/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.gLfCUIOMOL/Listeners TMPDIR=/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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-11 21:13:23,914 truncating revision to first 12 chars 2017-04-11 21:13:23,915 Setting DEBUG logging. 2017-04-11 21:13:23,915 attempt 1/10 2017-04-11 21:13:23,915 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/928b5958a1dc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-11 21:13:25,648 unpacking tar archive at: mozilla-aurora-928b5958a1dc/testing/mozharness/ program finished with exit code 0 elapsedTime=1.999115 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-11 21:13:25.832715) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-11 21:13:25.833251) ========= script_repo_revision: 928b5958a1dcbfa22ecac8e5773f674d5f56f214 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-11 21:13:25.833890) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-11 21:13:25.834349) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-11 21:13:25.855775) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-04-11 21:13:25.856185) ========= /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.vVoAQeLDXY/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.gLfCUIOMOL/Listeners TMPDIR=/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 21:13:26 INFO - MultiFileLogger online at 20170411 21:13:26 in /builds/slave/test 21:13:26 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 21:13:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:13:26 INFO - {'append_to_log': False, 21:13:26 INFO - 'base_work_dir': '/builds/slave/test', 21:13:26 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 21:13:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:13:26 INFO - 'branch': 'Mozilla-Aurora', 21:13:26 INFO - 'buildbot_json_path': 'buildprops.json', 21:13:26 INFO - 'config_files': ('talos/mac_config.py',), 21:13:26 INFO - 'default_actions': ('clobber', 21:13:26 INFO - 'read-buildbot-config', 21:13:26 INFO - 'download-and-extract', 21:13:26 INFO - 'populate-webroot', 21:13:26 INFO - 'create-virtualenv', 21:13:26 INFO - 'install', 21:13:26 INFO - 'run-tests'), 21:13:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:13:26 INFO - 'download_minidump_stackwalk': True, 21:13:26 INFO - 'download_symbols': 'ondemand', 21:13:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:13:26 INFO - 'tooltool.py': '/tools/tooltool.py', 21:13:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:13:26 INFO - '/tools/misc-python/virtualenv.py')}, 21:13:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:13:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:13:26 INFO - 'gecko_profile': False, 21:13:26 INFO - 'gecko_profile_interval': 0, 21:13:26 INFO - 'installer_path': 'installer.exe', 21:13:26 INFO - 'log_level': 'info', 21:13:26 INFO - 'log_name': 'talos', 21:13:26 INFO - 'log_to_console': True, 21:13:26 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:13:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:13:26 INFO - 'opt_config_files': (), 21:13:26 INFO - 'pip_index': False, 21:13:26 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:13:26 INFO - 'cmd': ('bash', 21:13:26 INFO - '-c', 21:13:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:13:26 INFO - 'enabled': True, 21:13:26 INFO - 'halt_on_failure': False, 21:13:26 INFO - 'name': 'check_screen_resolution'},), 21:13:26 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:13:26 INFO - 'cmd': ('bash', 21:13:26 INFO - '-c', 21:13:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:13:26 INFO - 'enabled': True, 21:13:26 INFO - 'halt_on_failure': False, 21:13:26 INFO - 'name': 'check_screen_resolution'},), 21:13:26 INFO - 'run_cmd_checks_enabled': True, 21:13:26 INFO - 'suite': 'dromaeojs-e10s', 21:13:26 INFO - 'system_bits': '32', 21:13:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:13:26 INFO - 'title': 't-yosemite-r7-0087', 21:13:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:13:26 INFO - 'use_talos_json': True, 21:13:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:13:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:13:26 INFO - 'work_dir': 'build'} 21:13:26 INFO - [mozharness: 2017-04-12 04:13:26.076759Z] Running clobber step. 21:13:26 INFO - Running pre-action listener: _resource_record_pre_action 21:13:26 INFO - Running main action method: clobber 21:13:26 INFO - rmtree: /builds/slave/test/build 21:13:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:13:28 INFO - Running post-action listener: _resource_record_post_action 21:13:28 INFO - [mozharness: 2017-04-12 04:13:28.553264Z] Finished clobber step (success) 21:13:28 INFO - [mozharness: 2017-04-12 04:13:28.553390Z] Running read-buildbot-config step. 21:13:28 INFO - Running pre-action listener: _resource_record_pre_action 21:13:28 INFO - Running main action method: read_buildbot_config 21:13:28 INFO - Using buildbot properties: 21:13:28 INFO - { 21:13:28 INFO - "project": "", 21:13:28 INFO - "product": "firefox", 21:13:28 INFO - "script_repo_revision": "production", 21:13:28 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 21:13:28 INFO - "repository": "", 21:13:28 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 21:13:28 INFO - "buildid": "20170411195108", 21:13:28 INFO - "pgo_build": "False", 21:13:28 INFO - "basedir": "/builds/slave/test", 21:13:28 INFO - "buildnumber": 13, 21:13:28 INFO - "slavename": "t-yosemite-r7-0087", 21:13:28 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 21:13:28 INFO - "platform": "yosemite_r7", 21:13:28 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 21:13:28 INFO - "branch": "mozilla-aurora", 21:13:28 INFO - "repo_path": "releases/mozilla-aurora", 21:13:28 INFO - "revision": "928b5958a1dcbfa22ecac8e5773f674d5f56f214", 21:13:28 INFO - "stage_platform": "macosx64", 21:13:28 INFO - "builduid": "423cbe87a30748e0aa6165ec20c9c591", 21:13:28 INFO - "slavebuilddir": "test" 21:13:28 INFO - } 21:13:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/NZH_8-2ARTmp4eH0FKwqCw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 21:13:28 INFO - Running post-action listener: _resource_record_post_action 21:13:28 INFO - [mozharness: 2017-04-12 04:13:28.556870Z] Finished read-buildbot-config step (success) 21:13:28 INFO - [mozharness: 2017-04-12 04:13:28.556986Z] Running download-and-extract step. 21:13:28 INFO - Running pre-action listener: _resource_record_pre_action 21:13:28 INFO - Running main action method: download_and_extract 21:13:28 INFO - mkdir: /builds/slave/test/build/tests 21:13:28 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')]} 21:13:28 INFO - trying https://queue.taskcluster.net/v1/task/NZH_8-2ARTmp4eH0FKwqCw/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 21:13:28 INFO - Downloading https://queue.taskcluster.net/v1/task/NZH_8-2ARTmp4eH0FKwqCw/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 21:13:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NZH_8-2ARTmp4eH0FKwqCw/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 21:13:29 INFO - Downloaded 1199 bytes. 21:13:29 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 21:13:29 INFO - Using the following test package requirements: 21:13:29 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 21:13:29 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 21:13:29 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 21:13:29 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 21:13:29 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 21:13:29 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 21:13:29 INFO - u'jsshell-mac.zip'], 21:13:29 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 21:13:29 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 21:13:29 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 21:13:29 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 21:13:29 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 21:13:29 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 21:13:29 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 21:13:29 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 21:13:29 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 21:13:29 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 21:13:29 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 21:13:29 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 21:13:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NZH_8-2ARTmp4eH0FKwqCw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 21:13:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NZH_8-2ARTmp4eH0FKwqCw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 21:13:29 INFO - Fetch https://queue.taskcluster.net/v1/task/NZH_8-2ARTmp4eH0FKwqCw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 21:13:31 INFO - Expected file size: 51792244 21:13:31 INFO - Obtained file size: 51792244 21:13:47 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 21:13:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NZH_8-2ARTmp4eH0FKwqCw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 21:13:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NZH_8-2ARTmp4eH0FKwqCw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 21:13:47 INFO - Fetch https://queue.taskcluster.net/v1/task/NZH_8-2ARTmp4eH0FKwqCw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 21:13:48 INFO - Expected file size: 51792244 21:13:48 INFO - Obtained file size: 51792244 21:14:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NZH_8-2ARTmp4eH0FKwqCw/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 21:14:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NZH_8-2ARTmp4eH0FKwqCw/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 21:14:04 INFO - Fetch https://queue.taskcluster.net/v1/task/NZH_8-2ARTmp4eH0FKwqCw/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 21:14:05 INFO - Expected file size: 14404424 21:14:05 INFO - Obtained file size: 14404424 21:14:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:14:05 INFO - trying https://queue.taskcluster.net/v1/task/NZH_8-2ARTmp4eH0FKwqCw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 21:14:05 INFO - Downloading https://queue.taskcluster.net/v1/task/NZH_8-2ARTmp4eH0FKwqCw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 21:14:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NZH_8-2ARTmp4eH0FKwqCw/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 21:14:07 INFO - Downloaded 74726654 bytes. 21:14:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NZH_8-2ARTmp4eH0FKwqCw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 21:14:07 INFO - mkdir: /builds/slave/test/properties 21:14:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:14:07 INFO - Writing to file /builds/slave/test/properties/build_url 21:14:07 INFO - Contents: 21:14:07 INFO - build_url:https://queue.taskcluster.net/v1/task/NZH_8-2ARTmp4eH0FKwqCw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 21:14:08 INFO - Running post-action listener: _resource_record_post_action 21:14:08 INFO - Running post-action listener: set_extra_try_arguments 21:14:08 INFO - [mozharness: 2017-04-12 04:14:08.344378Z] Finished download-and-extract step (success) 21:14:08 INFO - [mozharness: 2017-04-12 04:14:08.344498Z] Running populate-webroot step. 21:14:08 INFO - Running pre-action listener: _resource_record_pre_action 21:14:08 INFO - Running main action method: populate_webroot 21:14:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:14:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:14:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:14:08 INFO - '--tppagecycles', 21:14:08 INFO - '7'], 21:14:08 INFO - 'tests': ['tsvgm']}}, 21:14:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:14:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:14:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:14:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:14:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:14:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:14:08 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 21:14:08 INFO - 'talos_options': ['--disable-e10s'], 21:14:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:14:08 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 21:14:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:14:08 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 21:14:08 INFO - 'talos_options': ['--disable-e10s'], 21:14:08 INFO - 'tests': ['damp', 'tps']}, 21:14:08 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 21:14:08 INFO - 'tests': ['damp', 'tps']}, 21:14:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:14:08 INFO - 'tests': ['dromaeo_dom']}, 21:14:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:14:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:14:08 INFO - 'tests': ['basic_compositor_video']}, 21:14:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:14:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:14:08 INFO - 'tests': ['a11yr', 21:14:08 INFO - 'ts_paint', 21:14:08 INFO - 'tpaint', 21:14:08 INFO - 'sessionrestore', 21:14:08 INFO - 'sessionrestore_no_auto_restore', 21:14:08 INFO - 'tabpaint']}, 21:14:08 INFO - 'other-e10s': {'tests': ['a11yr', 21:14:08 INFO - 'ts_paint', 21:14:08 INFO - 'tpaint', 21:14:08 INFO - 'sessionrestore', 21:14:08 INFO - 'sessionrestore_no_auto_restore', 21:14:08 INFO - 'tabpaint']}, 21:14:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:14:08 INFO - 'ts_paint', 21:14:08 INFO - 'tpaint', 21:14:08 INFO - 'sessionrestore', 21:14:08 INFO - 'sessionrestore_no_auto_restore', 21:14:08 INFO - 'tabpaint']}, 21:14:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:14:08 INFO - 'ts_paint', 21:14:08 INFO - 'tpaint', 21:14:08 INFO - 'sessionrestore', 21:14:08 INFO - 'sessionrestore_no_auto_restore', 21:14:08 INFO - 'tabpaint']}, 21:14:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:14:08 INFO - 'tests': ['a11yr', 21:14:08 INFO - 'ts_paint', 21:14:08 INFO - 'tpaint', 21:14:08 INFO - 'sessionrestore', 21:14:08 INFO - 'sessionrestore_no_auto_restore', 21:14:08 INFO - 'tabpaint']}, 21:14:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:14:08 INFO - 'tests': ['a11yr', 21:14:08 INFO - 'ts_paint', 21:14:08 INFO - 'tpaint', 21:14:08 INFO - 'sessionrestore', 21:14:08 INFO - 'sessionrestore_no_auto_restore', 21:14:08 INFO - 'tabpaint']}, 21:14:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:14:08 INFO - 'tests': ['tsvgx', 21:14:08 INFO - 'tsvgr_opacity', 21:14:08 INFO - 'tart', 21:14:08 INFO - 'tscrollx', 21:14:08 INFO - 'cart', 21:14:08 INFO - 'tsvg_static']}, 21:14:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:14:08 INFO - 'tsvgr_opacity', 21:14:08 INFO - 'tart', 21:14:08 INFO - 'tscrollx', 21:14:08 INFO - 'cart', 21:14:08 INFO - 'tsvg_static']}, 21:14:08 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 21:14:08 INFO - 'talos_options': ['--disable-e10s'], 21:14:08 INFO - 'tests': ['tp5o']}, 21:14:08 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 21:14:08 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 21:14:08 INFO - 'talos_options': ['--disable-e10s', 21:14:08 INFO - '--xperf_path', 21:14:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:14:08 INFO - 'tests': ['tp5n']}, 21:14:08 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 21:14:08 INFO - 'talos_options': ['--xperf_path', 21:14:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:14:08 INFO - 'tests': ['tp5n']}}, 21:14:08 INFO - 'talos.zip': {'path': '', 21:14:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:14:08 INFO - Running post-action listener: _resource_record_post_action 21:14:08 INFO - [mozharness: 2017-04-12 04:14:08.363208Z] Finished populate-webroot step (success) 21:14:08 INFO - [mozharness: 2017-04-12 04:14:08.363318Z] Running create-virtualenv step. 21:14:08 INFO - Running pre-action listener: _resource_record_pre_action 21:14:08 INFO - Running main action method: create_virtualenv 21:14:08 INFO - Creating virtualenv /builds/slave/test/build/venv 21:14:08 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 21:14:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:14:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:14:08 INFO - Using real prefix '/tools/python27' 21:14:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:14:09 INFO - Installing distribute.............................................................................................................................................................................................done. 21:14:12 INFO - Installing pip.................done. 21:14:12 INFO - Return code: 0 21:14:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:14:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:14:12 INFO - Reading from file tmpfile_stdout 21:14:12 INFO - Output received: 21:14:12 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) 21:14:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:14:12 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')]} 21:14:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:14:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:12 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')]} 21:14:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:14:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:12 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 0x10e9acb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9af768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4d3cd1100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e78ad30>, '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 0x10e6b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e77fbe8>, '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.vVoAQeLDXY/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.gLfCUIOMOL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 21:14:12 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 21:14:12 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 21:14:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vVoAQeLDXY/Render', 21:14:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:14:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:14:12 INFO - 'HOME': '/Users/cltbld', 21:14:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:14:12 INFO - 'LOGNAME': 'cltbld', 21:14:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:12 INFO - 'MOZ_NO_REMOTE': '1', 21:14:12 INFO - 'NO_EM_RESTART': '1', 21:14:12 INFO - 'PAGER': '/bin/cat', 21:14:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:14:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:12 INFO - 'PWD': '/builds/slave/test', 21:14:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:14:12 INFO - 'SHELL': '/bin/bash', 21:14:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gLfCUIOMOL/Listeners', 21:14:12 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 21:14:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:14:12 INFO - 'USER': 'cltbld', 21:14:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:14:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:14:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:12 INFO - 'XPC_FLAGS': '0x0', 21:14:12 INFO - 'XPC_SERVICE_NAME': '0', 21:14:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:14:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:14:12 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 21:14:12 INFO - Cleaning up... 21:14:12 INFO - Return code: 0 21:14:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:14:12 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')]} 21:14:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:14:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:12 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')]} 21:14:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:14:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:12 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 0x10e9acb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9af768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4d3cd1100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e78ad30>, '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 0x10e6b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e77fbe8>, '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.vVoAQeLDXY/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.gLfCUIOMOL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 21:14:12 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 21:14:12 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 21:14:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vVoAQeLDXY/Render', 21:14:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:14:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:14:12 INFO - 'HOME': '/Users/cltbld', 21:14:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:14:12 INFO - 'LOGNAME': 'cltbld', 21:14:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:12 INFO - 'MOZ_NO_REMOTE': '1', 21:14:12 INFO - 'NO_EM_RESTART': '1', 21:14:12 INFO - 'PAGER': '/bin/cat', 21:14:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:14:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:12 INFO - 'PWD': '/builds/slave/test', 21:14:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:14:12 INFO - 'SHELL': '/bin/bash', 21:14:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gLfCUIOMOL/Listeners', 21:14:12 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 21:14:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:14:12 INFO - 'USER': 'cltbld', 21:14:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:14:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:14:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:12 INFO - 'XPC_FLAGS': '0x0', 21:14:12 INFO - 'XPC_SERVICE_NAME': '0', 21:14:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:14:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:14:12 INFO - Downloading/unpacking psutil>=3.1.1 21:14:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:14:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:14:12 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 21:14:12 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 21:14:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:14:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:14:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:14:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:14:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:14:16 INFO - Installing collected packages: psutil 21:14:16 INFO - Running setup.py install for psutil 21:14:16 INFO - building 'psutil._psutil_osx' extension 21:14:16 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 21:14:17 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 21:14:17 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 21:14:17 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 21:14:17 INFO - building 'psutil._psutil_posix' extension 21:14:17 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 21:14:17 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:14:17 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:14:17 INFO - ^ 21:14:17 INFO - 1 warning generated. 21:14:17 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 21:14:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:14:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:14:17 INFO - Successfully installed psutil 21:14:17 INFO - Cleaning up... 21:14:17 INFO - Return code: 0 21:14:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:14:17 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')]} 21:14:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:14:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:17 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')]} 21:14:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:14:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:17 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 0x10e9acb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9af768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4d3cd1100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e78ad30>, '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 0x10e6b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e77fbe8>, '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.vVoAQeLDXY/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.gLfCUIOMOL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 21:14:17 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 21:14:17 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 21:14:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vVoAQeLDXY/Render', 21:14:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:14:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:14:17 INFO - 'HOME': '/Users/cltbld', 21:14:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:14:17 INFO - 'LOGNAME': 'cltbld', 21:14:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:17 INFO - 'MOZ_NO_REMOTE': '1', 21:14:17 INFO - 'NO_EM_RESTART': '1', 21:14:17 INFO - 'PAGER': '/bin/cat', 21:14:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:14:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:17 INFO - 'PWD': '/builds/slave/test', 21:14:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:14:17 INFO - 'SHELL': '/bin/bash', 21:14:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gLfCUIOMOL/Listeners', 21:14:17 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 21:14:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:14:17 INFO - 'USER': 'cltbld', 21:14:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:14:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:14:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:17 INFO - 'XPC_FLAGS': '0x0', 21:14:17 INFO - 'XPC_SERVICE_NAME': '0', 21:14:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:14:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:14:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:14:18 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 21:14:18 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 21:14:18 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 21:14:18 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 21:14:18 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 21:14:18 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 21:14:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:14:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:14:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:14:20 INFO - Installing collected packages: mozsystemmonitor 21:14:20 INFO - Running setup.py install for mozsystemmonitor 21:14:20 INFO - Successfully installed mozsystemmonitor 21:14:20 INFO - Cleaning up... 21:14:20 INFO - Return code: 0 21:14:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:14:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:14:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:14:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:14:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:14:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e9acb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9af768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4d3cd1100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e78ad30>, '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 0x10e6b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e77fbe8>, '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.vVoAQeLDXY/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.gLfCUIOMOL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 21:14:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:14:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:14:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vVoAQeLDXY/Render', 21:14:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:14:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:14:21 INFO - 'HOME': '/Users/cltbld', 21:14:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:14:21 INFO - 'LOGNAME': 'cltbld', 21:14:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:21 INFO - 'MOZ_NO_REMOTE': '1', 21:14:21 INFO - 'NO_EM_RESTART': '1', 21:14:21 INFO - 'PAGER': '/bin/cat', 21:14:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:14:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:21 INFO - 'PWD': '/builds/slave/test', 21:14:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:14:21 INFO - 'SHELL': '/bin/bash', 21:14:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gLfCUIOMOL/Listeners', 21:14:21 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 21:14:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:14:21 INFO - 'USER': 'cltbld', 21:14:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:14:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:14:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:21 INFO - 'XPC_FLAGS': '0x0', 21:14:21 INFO - 'XPC_SERVICE_NAME': '0', 21:14:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:14:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:14:21 INFO - Downloading/unpacking jsonschema==2.5.1 21:14:21 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 21:14:21 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 21:14:21 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 21:14:21 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 21:14:21 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 21:14:21 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 21:14:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:14:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:14:25 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 21:14:25 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 21:14:25 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 21:14:25 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 21:14:25 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 21:14:25 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 21:14:25 INFO - Downloading functools32-3.2.3-2.tar.gz 21:14:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:14:25 INFO - warning: no files found matching '*.txt' 21:14:25 INFO - no previously-included directories found matching 'build' 21:14:25 INFO - no previously-included directories found matching 'dist' 21:14:25 INFO - no previously-included directories found matching '.git*' 21:14:25 INFO - Installing collected packages: jsonschema, functools32 21:14:25 INFO - Running setup.py install for functools32 21:14:25 INFO - warning: no files found matching '*.txt' 21:14:25 INFO - no previously-included directories found matching 'build' 21:14:25 INFO - no previously-included directories found matching 'dist' 21:14:25 INFO - no previously-included directories found matching '.git*' 21:14:25 INFO - Successfully installed jsonschema functools32 21:14:25 INFO - Cleaning up... 21:14:25 INFO - Return code: 0 21:14:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:14:25 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')]} 21:14:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:14:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:25 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')]} 21:14:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:14:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:25 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 0x10e9acb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9af768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4d3cd1100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e78ad30>, '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 0x10e6b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e77fbe8>, '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.vVoAQeLDXY/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.gLfCUIOMOL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 21:14:25 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 21:14:25 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 21:14:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vVoAQeLDXY/Render', 21:14:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:14:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:14:25 INFO - 'HOME': '/Users/cltbld', 21:14:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:14:25 INFO - 'LOGNAME': 'cltbld', 21:14:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:25 INFO - 'MOZ_NO_REMOTE': '1', 21:14:25 INFO - 'NO_EM_RESTART': '1', 21:14:25 INFO - 'PAGER': '/bin/cat', 21:14:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:14:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:25 INFO - 'PWD': '/builds/slave/test', 21:14:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:14:25 INFO - 'SHELL': '/bin/bash', 21:14:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gLfCUIOMOL/Listeners', 21:14:25 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 21:14:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:14:25 INFO - 'USER': 'cltbld', 21:14:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:14:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:14:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:25 INFO - 'XPC_FLAGS': '0x0', 21:14:25 INFO - 'XPC_SERVICE_NAME': '0', 21:14:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:14:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:14:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:14:26 INFO - Cleaning up... 21:14:26 INFO - Return code: 0 21:14:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:14:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:14:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:14:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:14:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:14:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:26 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 0x10e9acb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9af768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4d3cd1100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e78ad30>, '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 0x10e6b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e77fbe8>, '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.vVoAQeLDXY/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.gLfCUIOMOL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 21:14:26 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 21:14:26 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 21:14:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vVoAQeLDXY/Render', 21:14:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:14:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:14:26 INFO - 'HOME': '/Users/cltbld', 21:14:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:14:26 INFO - 'LOGNAME': 'cltbld', 21:14:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:26 INFO - 'MOZ_NO_REMOTE': '1', 21:14:26 INFO - 'NO_EM_RESTART': '1', 21:14:26 INFO - 'PAGER': '/bin/cat', 21:14:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:14:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:26 INFO - 'PWD': '/builds/slave/test', 21:14:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:14:26 INFO - 'SHELL': '/bin/bash', 21:14:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gLfCUIOMOL/Listeners', 21:14:26 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 21:14:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:14:26 INFO - 'USER': 'cltbld', 21:14:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:14:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:14:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:26 INFO - 'XPC_FLAGS': '0x0', 21:14:26 INFO - 'XPC_SERVICE_NAME': '0', 21:14:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:14:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:14:26 INFO - Downloading/unpacking blobuploader==1.2.4 21:14:26 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 21:14:26 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 21:14:26 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 21:14:26 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 21:14:26 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 21:14:26 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 21:14:29 INFO - Downloading blobuploader-1.2.4.tar.gz 21:14:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:14:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:14:29 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 21:14:29 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 21:14:29 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 21:14:29 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 21:14:29 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 21:14:29 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 21:14:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:14:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:14:29 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 21:14:29 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 21:14:29 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 21:14:29 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 21:14:29 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 21:14:29 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 21:14:30 INFO - Downloading docopt-0.6.1.tar.gz 21:14:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:14:30 INFO - Installing collected packages: blobuploader, requests, docopt 21:14:30 INFO - Running setup.py install for blobuploader 21:14:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:14:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:14:30 INFO - Running setup.py install for requests 21:14:30 INFO - Running setup.py install for docopt 21:14:31 INFO - Successfully installed blobuploader requests docopt 21:14:31 INFO - Cleaning up... 21:14:31 INFO - Return code: 0 21:14:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:14:31 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')]} 21:14:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:14:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:31 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')]} 21:14:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:14:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:31 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 0x10e9acb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9af768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4d3cd1100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e78ad30>, '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 0x10e6b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e77fbe8>, '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.vVoAQeLDXY/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.gLfCUIOMOL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 21:14:31 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 21:14:31 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 21:14:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vVoAQeLDXY/Render', 21:14:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:14:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:14:31 INFO - 'HOME': '/Users/cltbld', 21:14:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:14:31 INFO - 'LOGNAME': 'cltbld', 21:14:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:31 INFO - 'MOZ_NO_REMOTE': '1', 21:14:31 INFO - 'NO_EM_RESTART': '1', 21:14:31 INFO - 'PAGER': '/bin/cat', 21:14:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:14:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:31 INFO - 'PWD': '/builds/slave/test', 21:14:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:14:31 INFO - 'SHELL': '/bin/bash', 21:14:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gLfCUIOMOL/Listeners', 21:14:31 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 21:14:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:14:31 INFO - 'USER': 'cltbld', 21:14:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:14:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:14:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:31 INFO - 'XPC_FLAGS': '0x0', 21:14:31 INFO - 'XPC_SERVICE_NAME': '0', 21:14:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:14:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:14:31 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-y6aUh_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:14:31 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-Tk54Sx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:14:31 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-3IzK9G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:14:31 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-5G8kSd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:14:31 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-O4A0Tu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:14:32 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-y7hX_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:14:32 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-q7zrXg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:14:32 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-7IOLw4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:14:32 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-ZuZDUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:14:32 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-UHgon5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:14:32 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-sOZG8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:14:32 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-yP8jOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:14:32 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-jT1Hog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:14:32 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-kyfMhg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:14:32 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-k_LVSR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:14:33 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-jQj3da-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:14:33 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-yh9xex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:14:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:14:33 INFO - Running setup.py install for manifestparser 21:14:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:14:33 INFO - Running setup.py install for mozcrash 21:14:33 INFO - Running setup.py install for mozdebug 21:14:33 INFO - Running setup.py install for mozdevice 21:14:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:14:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:14:33 INFO - Running setup.py install for mozfile 21:14:34 INFO - Running setup.py install for mozhttpd 21:14:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:14:34 INFO - Running setup.py install for mozinfo 21:14:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:14:34 INFO - Running setup.py install for mozInstall 21:14:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:14:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:14:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:14:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:14:34 INFO - Running setup.py install for mozleak 21:14:34 INFO - Running setup.py install for mozlog 21:14:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:14:34 INFO - Running setup.py install for moznetwork 21:14:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:14:34 INFO - Running setup.py install for mozprocess 21:14:35 INFO - Running setup.py install for mozprofile 21:14:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:14:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:14:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:14:35 INFO - Running setup.py install for mozrunner 21:14:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:14:35 INFO - Running setup.py install for mozscreenshot 21:14:35 INFO - Running setup.py install for moztest 21:14:35 INFO - Running setup.py install for mozversion 21:14:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:14:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:14:35 INFO - Cleaning up... 21:14:35 INFO - Return code: 0 21:14:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:14:35 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')]} 21:14:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:14:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:35 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')]} 21:14:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:14:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:35 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 0x10e9acb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9af768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4d3cd1100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e78ad30>, '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 0x10e6b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e77fbe8>, '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.vVoAQeLDXY/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.gLfCUIOMOL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 21:14:35 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 21:14:35 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 21:14:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vVoAQeLDXY/Render', 21:14:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:14:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:14:35 INFO - 'HOME': '/Users/cltbld', 21:14:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:14:35 INFO - 'LOGNAME': 'cltbld', 21:14:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:35 INFO - 'MOZ_NO_REMOTE': '1', 21:14:35 INFO - 'NO_EM_RESTART': '1', 21:14:35 INFO - 'PAGER': '/bin/cat', 21:14:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:14:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:35 INFO - 'PWD': '/builds/slave/test', 21:14:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:14:35 INFO - 'SHELL': '/bin/bash', 21:14:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gLfCUIOMOL/Listeners', 21:14:35 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 21:14:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:14:35 INFO - 'USER': 'cltbld', 21:14:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:14:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:14:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:35 INFO - 'XPC_FLAGS': '0x0', 21:14:35 INFO - 'XPC_SERVICE_NAME': '0', 21:14:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:14:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:14:36 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-dBeuRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:14:36 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)) 21:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:14:36 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-6xzh39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:14:36 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)) 21:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:14:36 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-uzFpMT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:14:36 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)) 21:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:14:36 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-LjMCtl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:14:36 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)) 21:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:14:36 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-vxJaKL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:14:36 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)) 21:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:14:36 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-CT0eoc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:14:36 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)) 21:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:14:36 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-u4RpfD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:14:36 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)) 21:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:14:36 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-OnLeMQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:14:36 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)) 21:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:14:36 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-gLzt7P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:14:37 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)) 21:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:14:37 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-vWZLlO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:14:37 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)) 21:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:14:37 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-mb4LbX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:14:37 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)) 21:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:14:37 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-TU3Rxo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:14:37 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)) 21:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:14:37 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-nGEio2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:14:37 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)) 21:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:14:37 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-MM774m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:14:37 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)) 21:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:14:37 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-foInbz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:14:37 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)) 21:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:14:37 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-YGEfur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:14:37 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)) 21:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:14:37 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-KfoeUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:14:37 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)) 21:14:37 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)) 21:14:37 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)) 21:14:37 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)) 21:14:37 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)) 21:14:37 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)) 21:14:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:14:37 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 21:14:37 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 21:14:37 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 21:14:37 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 21:14:37 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 21:14:37 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 21:14:40 INFO - Downloading blessings-1.6.tar.gz 21:14:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:14:40 INFO - Installing collected packages: blessings 21:14:40 INFO - Running setup.py install for blessings 21:14:40 INFO - Successfully installed blessings 21:14:40 INFO - Cleaning up... 21:14:41 INFO - Return code: 0 21:14:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:14:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:14:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:14:41 INFO - Reading from file tmpfile_stdout 21:14:41 INFO - Current package versions: 21:14:41 INFO - blessings == 1.6 21:14:41 INFO - blobuploader == 1.2.4 21:14:41 INFO - docopt == 0.6.1 21:14:41 INFO - functools32 == 3.2.3-2 21:14:41 INFO - jsonschema == 2.5.1 21:14:41 INFO - manifestparser == 1.1 21:14:41 INFO - mozInstall == 1.12 21:14:41 INFO - mozcrash == 1.0 21:14:41 INFO - mozdebug == 0.1 21:14:41 INFO - mozdevice == 0.49 21:14:41 INFO - mozfile == 1.2 21:14:41 INFO - mozhttpd == 0.7 21:14:41 INFO - mozinfo == 0.9 21:14:41 INFO - mozleak == 0.1 21:14:41 INFO - mozlog == 3.4 21:14:41 INFO - moznetwork == 0.27 21:14:41 INFO - mozprocess == 0.25 21:14:41 INFO - mozprofile == 0.28 21:14:41 INFO - mozrunner == 6.13 21:14:41 INFO - mozscreenshot == 0.1 21:14:41 INFO - mozsystemmonitor == 0.3 21:14:41 INFO - moztest == 0.8 21:14:41 INFO - mozversion == 1.4 21:14:41 INFO - psutil == 3.1.1 21:14:41 INFO - requests == 1.2.3 21:14:41 INFO - wsgiref == 0.1.2 21:14:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:14:41 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')]} 21:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:14:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:41 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')]} 21:14:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:14:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:41 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 0x10e9acb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9af768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4d3cd1100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e78ad30>, '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 0x10e6b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e77fbe8>, '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.vVoAQeLDXY/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.gLfCUIOMOL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 21:14:41 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 21:14:41 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 21:14:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vVoAQeLDXY/Render', 21:14:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:14:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:14:41 INFO - 'HOME': '/Users/cltbld', 21:14:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:14:41 INFO - 'LOGNAME': 'cltbld', 21:14:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:41 INFO - 'MOZ_NO_REMOTE': '1', 21:14:41 INFO - 'NO_EM_RESTART': '1', 21:14:41 INFO - 'PAGER': '/bin/cat', 21:14:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:14:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:41 INFO - 'PWD': '/builds/slave/test', 21:14:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:14:41 INFO - 'SHELL': '/bin/bash', 21:14:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gLfCUIOMOL/Listeners', 21:14:41 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 21:14:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:14:41 INFO - 'USER': 'cltbld', 21:14:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:14:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:14:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:41 INFO - 'XPC_FLAGS': '0x0', 21:14:41 INFO - 'XPC_SERVICE_NAME': '0', 21:14:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:14:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:14:41 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)) 21:14:41 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)) 21:14:41 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)) 21:14:41 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)) 21:14:41 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)) 21:14:41 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)) 21:14:41 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)) 21:14:41 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)) 21:14:41 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)) 21:14:41 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)) 21:14:41 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)) 21:14:41 INFO - Cleaning up... 21:14:41 INFO - Return code: 0 21:14:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:14:41 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')]} 21:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:14:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:41 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')]} 21:14:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:14:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:41 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 0x10e9acb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9af768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4d3cd1100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e78ad30>, '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 0x10e6b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e77fbe8>, '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.vVoAQeLDXY/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.gLfCUIOMOL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 21:14:41 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 21:14:41 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 21:14:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vVoAQeLDXY/Render', 21:14:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:14:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:14:41 INFO - 'HOME': '/Users/cltbld', 21:14:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:14:41 INFO - 'LOGNAME': 'cltbld', 21:14:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:41 INFO - 'MOZ_NO_REMOTE': '1', 21:14:41 INFO - 'NO_EM_RESTART': '1', 21:14:41 INFO - 'PAGER': '/bin/cat', 21:14:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:14:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:41 INFO - 'PWD': '/builds/slave/test', 21:14:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:14:41 INFO - 'SHELL': '/bin/bash', 21:14:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gLfCUIOMOL/Listeners', 21:14:41 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 21:14:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:14:41 INFO - 'USER': 'cltbld', 21:14:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:14:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:14:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:41 INFO - 'XPC_FLAGS': '0x0', 21:14:41 INFO - 'XPC_SERVICE_NAME': '0', 21:14:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:14:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:14:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:14:41 INFO - Cleaning up... 21:14:41 INFO - Return code: 0 21:14:41 INFO - Running post-action listener: _resource_record_post_action 21:14:41 INFO - Running post-action listener: _start_resource_monitoring 21:14:41 INFO - Starting resource monitoring. 21:14:41 INFO - [mozharness: 2017-04-12 04:14:41.877268Z] Finished create-virtualenv step (success) 21:14:41 INFO - [mozharness: 2017-04-12 04:14:41.878223Z] Running install step. 21:14:41 INFO - Running pre-action listener: _resource_record_pre_action 21:14:41 INFO - Running main action method: install 21:14:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:14:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:14:42 INFO - Reading from file tmpfile_stdout 21:14:42 INFO - Detecting whether we're running mozinstall >=1.0... 21:14:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:14:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:14:42 INFO - Reading from file tmpfile_stdout 21:14:42 INFO - Output received: 21:14:42 INFO - Usage: mozinstall [options] installer 21:14:42 INFO - Options: 21:14:42 INFO - -h, --help show this help message and exit 21:14:42 INFO - -d DEST, --destination=DEST 21:14:42 INFO - Directory to install application into. [default: 21:14:42 INFO - "/builds/slave/test"] 21:14:42 INFO - --app=APP Application being installed. [default: firefox] 21:14:42 INFO - mkdir: /builds/slave/test/build/application 21:14:42 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'] 21:14:42 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 21:15:02 INFO - Reading from file tmpfile_stdout 21:15:02 INFO - Output received: 21:15:02 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 21:15:02 INFO - Running post-action listener: _resource_record_post_action 21:15:02 INFO - [mozharness: 2017-04-12 04:15:02.470824Z] Finished install step (success) 21:15:02 INFO - [mozharness: 2017-04-12 04:15:02.470970Z] Running run-tests step. 21:15:02 INFO - Running pre-action listener: _resource_record_pre_action 21:15:02 INFO - Running main action method: run_tests 21:15:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:15:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:15:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:15:02 INFO - 2017-04-11 21:15:02.485 screenresolution[1622:7391] starting screenresolution argv=screenresolution get 21:15:02 INFO - 2017-04-11 21:15:02.488 screenresolution[1622:7391] Display 0: 1600x1200x32@60 21:15:02 INFO - 2017-04-11 21:15:02.493 screenresolution[1623:7393] starting screenresolution argv=screenresolution list 21:15:02 INFO - Available Modes on Display 0 21:15:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:15:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:15:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:15:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:15:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:15:02 INFO - Intel Iris: 21:15:02 INFO - Chipset Model: Intel Iris 21:15:02 INFO - Type: GPU 21:15:02 INFO - Bus: Built-In 21:15:02 INFO - VRAM (Dynamic, Max): 1536 MB 21:15:02 INFO - Vendor: Intel (0x8086) 21:15:02 INFO - Device ID: 0x0a2e 21:15:02 INFO - Revision ID: 0x0009 21:15:02 INFO - Displays: 21:15:02 INFO - Display: 21:15:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:15:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:15:02 INFO - Display Serial Number: 1600x1200 60 21:15:02 INFO - Main Display: Yes 21:15:02 INFO - Mirror: Off 21:15:02 INFO - Online: Yes 21:15:02 INFO - Rotation: Supported 21:15:02 INFO - Return code: 0 21:15:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:15:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:15:02 INFO - Python 2.7.3 21:15:02 INFO - Return code: 0 21:15:02 INFO - grabbing minidump binary from tooltool 21:15:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:15:02 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 0x10e78ad30>, '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 0x10e6b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e77fbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:15:02 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 21:15:02 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 21:15:02 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 21:15:02 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:15:02 INFO - Return code: 0 21:15:02 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:15:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:15:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:15:02 INFO - ENV: RUST_BACKTRACE is now 1 21:15:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:15:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:15:02 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/NZH_8-2ARTmp4eH0FKwqCw/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0087', '--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 21:15:02 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/NZH_8-2ARTmp4eH0FKwqCw/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0087 --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 21:15:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vVoAQeLDXY/Render', 21:15:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:15:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:15:02 INFO - 'HOME': '/Users/cltbld', 21:15:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:15:02 INFO - 'LOGNAME': 'cltbld', 21:15:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:15:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:15:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:15:02 INFO - 'MOZ_NO_REMOTE': '1', 21:15:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:15:02 INFO - 'NO_EM_RESTART': '1', 21:15:02 INFO - 'PAGER': '/bin/cat', 21:15:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:15:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:15:02 INFO - 'PWD': '/builds/slave/test', 21:15:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:15:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:15:02 INFO - 'RUST_BACKTRACE': '1', 21:15:02 INFO - 'SHELL': '/bin/bash', 21:15:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gLfCUIOMOL/Listeners', 21:15:02 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 21:15:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:15:02 INFO - 'USER': 'cltbld', 21:15:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:15:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:15:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:15:02 INFO - 'XPC_FLAGS': '0x0', 21:15:02 INFO - 'XPC_SERVICE_NAME': '0', 21:15:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:15:02 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/NZH_8-2ARTmp4eH0FKwqCw/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0087', '--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 21:15:03 INFO - mozversion application_buildid: 20170411195108 21:15:03 INFO - mozversion application_changeset: 928b5958a1dcbfa22ecac8e5773f674d5f56f214 21:15:03 INFO - mozversion application_display_name: FirefoxDeveloperEdition 21:15:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:15:03 INFO - mozversion application_name: Firefox 21:15:03 INFO - mozversion application_remotingname: firefox-dev 21:15:03 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:15:03 INFO - mozversion application_vendor: Mozilla 21:15:03 INFO - mozversion application_version: 54.0a2 21:15:03 INFO - mozversion platform_buildid: 20170411195108 21:15:03 INFO - mozversion platform_changeset: 928b5958a1dcbfa22ecac8e5773f674d5f56f214 21:15:03 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:15:03 INFO - mozversion platform_version: 54.0a2 21:15:03 INFO - using testdate: 1491970503 21:15:03 INFO - actual date: 1491970503 21:15:03 INFO - starting webserver on 'localhost:49241' 21:15:03 INFO - SUITE-START | Running 2 tests 21:15:03 INFO - TEST-START | dromaeo_css 21:15:03 INFO - operating with platform_type : mac_ 21:15:03 INFO - Initialising browser for dromaeo_css test... 21:15:03 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/tmpGsnakz/profile http://localhost:49241/getInfo.html) 21:15:05 INFO - PROCESS | 1633 | 2017-04-11 21:15:05.905 plugin-container[1635:7568] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b37, name = 'com.apple.tsm.portname' 21:15:05 INFO - PROCESS | 1633 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:15:05 INFO - PROCESS | 1633 | 2017-04-11 21:15:05.908 plugin-container[1635:7568] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f4b, name = 'com.apple.CFPasteboardClient' 21:15:05 INFO - PROCESS | 1633 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:15:05 INFO - PROCESS | 1633 | 2017-04-11 21:15:05.908 plugin-container[1635:7568] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 21:15:05 INFO - PROCESS | 1633 | __metrics Screen width/height:1600/1200 21:15:05 INFO - PROCESS | 1633 | colorDepth:24 21:15:05 INFO - PROCESS | 1633 | Browser inner width/height: 1024/689 21:15:05 INFO - PROCESS | 1633 | __metrics 21:15:06 ERROR - PROCESS | 1633 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3360: TypeError: this.tabs is undefined 21:15:06 INFO - TEST-INFO | 1633: exit 0 21:15:06 INFO - Browser initialized. 21:15:06 INFO - Running cycle 1/1 for dromaeo_css test... 21:15:06 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/tmpGsnakz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:15:09 INFO - PROCESS | 1636 | 2017-04-11 21:15:09.144 plugin-container[1637:7697] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 21:15:09 INFO - PROCESS | 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:15:09 INFO - PROCESS | 1636 | 2017-04-11 21:15:09.144 plugin-container[1637:7697] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 21:15:09 INFO - PROCESS | 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:15:09 INFO - PROCESS | 1636 | 2017-04-11 21:15:09.144 plugin-container[1637:7697] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 21:15:18 INFO - PROCESS | 1636 | RSS: Main: 220594176 21:15:18 INFO - PROCESS | 1636 | 21:18:21 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 21:18:24 INFO - PROCESS | 1636 | RSS: Main: 244346880 21:18:24 INFO - PROCESS | 1636 | 21:20:07 INFO - PROCESS | 1636 | ************************* 21:20:07 INFO - PROCESS | 1636 | A coding exception was thrown and uncaught in a Task. 21:20:07 INFO - PROCESS | 1636 | 21:20:07 ERROR - PROCESS | 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 21:20:07 INFO - PROCESS | 1636 | Full stack: 21:20:07 INFO - PROCESS | 1636 | ************************* 21:20:07 INFO - PROCESS | 1636 | ************************* 21:20:07 INFO - PROCESS | 1636 | A coding exception was thrown and uncaught in a Task. 21:20:07 INFO - PROCESS | 1636 | 21:20:07 ERROR - PROCESS | 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 21:20:07 INFO - PROCESS | 1636 | Full stack: 21:20:07 INFO - PROCESS | 1636 | ************************* 21:20:07 INFO - PROCESS | 1636 | ************************* 21:20:07 INFO - PROCESS | 1636 | A coding exception was thrown and uncaught in a Task. 21:20:07 INFO - PROCESS | 1636 | 21:20:07 ERROR - PROCESS | 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 21:20:07 INFO - PROCESS | 1636 | Full stack: 21:20:07 INFO - PROCESS | 1636 | ************************* 21:20:07 INFO - PROCESS | 1636 | ************************* 21:20:07 INFO - PROCESS | 1636 | A coding exception was thrown and uncaught in a Task. 21:20:07 INFO - PROCESS | 1636 | 21:20:07 ERROR - PROCESS | 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 21:20:07 INFO - PROCESS | 1636 | Full stack: 21:20:07 INFO - PROCESS | 1636 | ************************* 21:21:26 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 21:21:27 INFO - PROCESS | 1636 | RSS: Main: 247877632 21:21:27 INFO - PROCESS | 1636 | 21:24:29 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 21:24:30 INFO - PROCESS | 1636 | RSS: Main: 256413696 21:24:30 INFO - PROCESS | 1636 | 21:27:32 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 21:27:32 INFO - PROCESS | 1636 | RSS: Main: 253186048 21:27:32 INFO - PROCESS | 1636 | 21:30:35 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 21:30:36 INFO - PROCESS | 1636 | RSS: Main: 258674688 21:30:36 INFO - PROCESS | 1636 | 21:33:39 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 21:33:39 INFO - PROCESS | 1636 | RSS: Main: 254980096 21:33:39 INFO - PROCESS | 1636 | 21:33:39 INFO - PROCESS | 1636 | __start_tp_report 21:33:39 INFO - PROCESS | 1636 | _x_x_mozilla_page_load 21:33:39 INFO - PROCESS | 1636 | _x_x_mozilla_page_load_details 21:33:39 INFO - PROCESS | 1636 | |i|pagename|runs| 21:33:39 INFO - PROCESS | 1636 | |0;dojo.html;3053.2519532714487;3203.2792621660124;3435.690787829095;3482.686558209762;3523.5947865995417;6007.819765407034;6056.939430605698;6060.2424696912885;6065.636061836293;6075.392460753934;6070.878582428349;6088.939110608892;6096.969515152418;6104.145419641242;6118.6634735089665;5414.242006119156;5473.507384335409;5492.80775172869;5493.450654934514;5575.2473416088715;5536.058869992091;5538.252335934638;5542.279503664538;5545.140503222007;5550.361708403525;5333.653312534692;5355.6251062425645;5534.640248383842;5540.50135487806;5559.054960656698;5432.782688692468;5448.101063324547;5499.670019798825;5536.667799932017;5595.692236926968;4496.7077139985795;5362.329708786402;5455.290812194429;5462.562994960394;5502.257195278627;5005.374328208974;5805.651660900359;6091.238595175603;6124.2957059938235;6138.7237574309265;6298.6535740534255;6309.305976342599;6323.399277068671;6357.554971152022;6360.840978975516;6539.738410463576;6550.70521826519;6552.443042341407;6577.14497115372;6596.967015164942;5066.974665126724;6175.66033868137;6181.598196117283;6181.8454538636;6195.380461953813;6373.681315934185;6447.161868957006;6466.870662586722;6632.2704502504685;6671.699773510204;6242.09489624002;6251.374862513712;6293.685315734195;6309.652969086745;6320.778772742932;6487.935120648827;6503.804885853432;6511.055896895018;6514.348565143542;6523.478121750343;6193.876122477525;6211.440970312694;6425.678716064178;6436.356364363526;6453.193350831146;4895.363602731693;6241.968790156111;6344.143540621957;6355.428011478989;6364;4215.367694845736;5134.435212126663;5176.352955880515;5187.403448603383;5194.3766747990485;3860.2665493556133;4577.153226653079;4585.853536615846;4627.0514544518965;4644.303354496852;6106.358832322631;6172.814815555541;6199.287081985539;6201.255849298113;6209.565330426917;6229.408206220402;6267.373262673696;6411.775587854403;6417;6472.35276472349;6165.167702360213;6183.81448556535;6188.947878860605;6192.628442293477;6196.411340922605;4795.592374648194;4858.878528036827;5731.283589551306;5745.741441635137;5765;6452.7418903245225;6516;6601.9009714853355;6609.074729537772;6781.11845460087;5082.796688132434;6448.677566121769;6457.418832305115;6494.3505649436565;6521.576097553644;6676;6686.431653309523;6757.155355580552;6779.457643388419;6781.084553585203;4802.903941921072;5294.576433885203;6261.9373806263175;6438.002109673008;6451.645159516272;6329.841753956188;6369.1401660777055;6378.138951241523;6411.96794016027;6433.903491447539;6285.025820997753;6299.716512757029;6302.117703521419;6321.1782468278825;6350.396712312323;6174.938250617616;6256.655883926428;6259.655718935503;6308.842278943063;6314.305426403183;5005.4744251853035;5923.644581325134;6129.939558357133;6144.354842741448;6146.6004709693725;6307.747690092345;6312.526560508072;6327.651979141191;6351.9047214290895;6366.936330636634;6003.189569408074;6065.272167339771;6128.387161283836;6168.228971378578;6205.348438414082 21:33:39 INFO - PROCESS | 1636 | |1;ext.html;686.2794066230458;708.2846325211535;811.6875003123797;866.3762091294266;882.9514376709278;26313.60529592055;37330;37356.43965340522;38742;38750.418743718794;37351.813240933756;37682.24635507288;37689.81155094228;37721.62278377215;37762.86711398663;7219.819504512377;7413.184549699528;7744.457887947846;7909.683612655487;11064.944675276653;11020.44897755113;11141.22011459194;11158.107351411867;11162.832557511603;11182.993530582246;11128.61049863255;11144.777104457906;11155.944220278929;11180.552777888875;11204.66386008421;11088.55645774168;11113.166512511554;11114.61098861544;11181.937715917016;11189.664310070712;10903.01872831449;10961.342319460859;10973.23187376884;10991.945040274828;10997.725056873642;38531.42202866959;38834.417483737765;38844;38861;39042.82871513859;3696.669199088326;3830.8467661293516;3854.9807250963845;3896.8636097736726;3905.6094390560716;24303.63544546833;27540.311492212655;29331.560026599618;29386.265343366373;29392.559111613344;3012.487877060905;3095.1952492351925;3095.6749541298063;3267.7059064684054;3272.443684573628;313620;315236.42381788173;315768;316052;316934;50272.99454010899;50551.736206594396;50598.49401506012;50671.23993140106;50929.74535127375;43883.561164388586;49857.00285994332;53052.67368315746;53127.734361327944;53240;14018.789718154236;14071;14196.929015354857;14233.64415889611;14237.216953067473;8695.304375649934;12139.089568282414;12178;12321.952634026029;12336.876631233572;10577.57689692419;11890.524379024742;12034.277943323428;12105.273683579013;12222.511099555919;4921.630877684188;5689.886202275931;5701.662318449416;5707.172459993278;5728.971355143198;955.441066975827;1134.9943250283695;1135.7047167736448;1135.840982262484;1147.7532330548972;25750.48499030009;26001.349966250997;26241.21276361674;26416.8679156603;26487.47025059488;982.4792859784183;983.8819341679044;1046.4558429616557;1242.9502819887102;1260.7959398774149;9488.29210742073;10901.672949811518;13056.477740890448;13273.867261327263;13306.600801975956;314327;314876;315135.84864151524;315146;315550;41336.793316033225;41444.96387590334;41723.7913810429;41740.37389439161;41750.74747757572;1388.271157642246;1430.9499167529086;1432.6704857882537;1434.4405681784112;1440.481426686392;21700.565988679824;25537.87231063833;26394.73605263923;27591.896324147612;27794.5830812542;38919.22161556697;39554.01114972149;39632.60367396289;39651.2069758609;39748.60251397449;414440;414957;415554.92222538695;416625;417365;27867.303317417227;28305;28546.57180142341;28562.85748570034;28674.713252867205;36223.91328260156;36361.45457818082;36996;37014.44478332881;37087;26161.345966350993;26346.604800927616;26750.732492674822;27455.45089098247;27548.586771198046;22315.442113946632;25839.61240581355;26716.8664156678;26874.731252687223;27164.070265167535;30695.2326191847;31283;31288.904888328798;31298.90453834105;31402.685973139975;22268.665970010137;25928.8703556481;27146.72853271442;27569.310767230178;27713.86143069272;17148.571285717957;21908.561828763017;22072.896355182496;22424.439389015406;22471.213507527158 21:33:39 INFO - PROCESS | 1636 | |2;jquery.html;409.144887185782;410.72481437436915;419.86984034949165;428.1223491841725;449.975251361175;15983.76024359634;20595.897020514894;21136.365909022716;21192.152313907445;21500.784992150115;21931;22148.66776998342;22377.216797412093;22558.43603909903;22582.548349033008;6537.5423720339595;6784.084148639944;6816.216135144447;6829.351211634887;6841.042254084432;6690.33096690332;6926.826829329257;7252.637368131599;7335.193128755833;7370.078740157481;7099.396551293146;7212.927870721278;7390.519616224955;7393.07586551681;7394.297541733554;7200.783976480714;7405.925940740577;7435.776926692208;7465.552066876005;7482.476226664108;6503.577267477599;6731.865362692768;7137.964310178468;7213.990041394157;7263.709451621929;25359.492810143878;25601.35996600081;25757.74242257591;25906.704664766687;26070.087546935956;2812.4375124975086;2846.4164846206477;2870.7559857412143;2884.62499875017;2897.6377952755906;15110.698713919452;15887.36450541977;16123.516294511184;16316;16567.25447354872;1903.7334773131772;2019.6869485229813;2025.574629327843;2041.8264447521979;2053.219776484941;123773;144614;164428.17785910994;165743;166604.5009324849;21126;21397.502174847923;21613.891930540245;21615.243466478598;21617.02723377452;32555.51166732501;32562.185945351557;32895;33187.66812331894;33278.8336058323;8221.465604735673;9736.221102311798;9807.019298070136;9973.60105595768;10110.797784044278;8062.113167551564;8079.4344395892895;8136.860839482477;8221.712240071569;8230.341572674171;7327.596982166032;8238.752837414888;8794.472331660121;9817.361871478332;9887.703368898945;3460.7750496217664;4033.193361327746;4126.690498212646;4138.896527586774;4147.875563733093;1030.9175265978704;1052.8157572424948;1056.8837427882927;1063.2025980514613;1098.4397957041806;21542.676859847114;21826;21862.453438663844;21889.233876814236;21965.121395144015;1081.3457857995957;1092.6339676208559;1106.590561492253;1118.8713297970837;1123.8651361836633;8880.555972201364;10840.024397804078;11310.151738619636;11611.535538578531;11632.825507617392;733647;748013;751030;760699;761050;150313.49686502994;151773.24113379582;165515;169702;172727.8635743229;1259.030546479206;1259.5591542959892;1315.4343632238038;1315.500109958229;1316.5852756381519;16098.919505402398;17431.04129272902;17992.10039498046;20774.480637984172;20779.064942077945;50785.74607126941;62213.68893155505;62666;63990;64594.67702661457;91151;91326.54336728273;92563.53718231365;92668.53665731628;93503;11478.253913495597;11794.823077654013;11919.52321907114;11920.940395298316;12196.146269761386;13262.33688315561;13308.800367994681;13362.465501379836;13654.590362289147;13701.657458563615;9409.576569054547;11048.834267485834;11355;11647.534098635959;11740.706482337668;8966;10604.363738175734;10640.733981650521;10674.306170098918;10730.89269107299;9487.715368538955;11439.370834604177;11650.88349116498;11731.41342932867;11794.646160615195;11668.474918628512;11704.94147529257;11826.645200643994;11867.821982670093;12057.698557536132;11251.268667536584;11471.770564588829;11576.073914086684;11637.5344986203;11740.941295293469 21:33:39 INFO - PROCESS | 1636 | |3;mootools.html;1253.6301790971663;1266.7466506698656;1364.8671602569875;1492.932818023189;1577.1089334525996;9478.336516443851;10712.46437678116;10960.068394186485;11315.547378104866;11468.48391822368;11067.612633557826;11094.389808560525;11230.775384492305;11236.66290011299;11255.155863310243;2372.667826504295;2413.034786085571;2415.5651982643117;2416.794572461343;2423.2245681381964;2318.9536209275802;2404.338806828119;2442.987785061081;2443.814749846323;2445.303088619744;2138.540213854021;2322.85018915637;2356.893939772706;2441.218809980807;2443.8778061096873;2351.7177938647474;2383.1301574925114;2403.459221675118;2408.4701365699516;2437.8659173745436;2326.3835083702834;2393.1384701507445;2401.6997875265592;2404.675368825221;2424.684790977179;11341.546338146465;11383.886161138365;11385.316880987168;11441;11453.770924581546;5925.585209035369;6097.69511524422;6099.207103076572;6105.755769769248;6106.3893610639025;2784.693683694812;3601.6673830682553;3702.629737026303;3794.772313661189;3798.90502737431;1209.6492017315056;1218.3299185447968;1252.0484431831874;1255.8241846141548;1262.236347010064;13774.517891873737;14004.22976736279;15133.470328538559;15798.605034874105;15935.964162329412;4716.551927566876;4724.669273150916;4764.040911537774;4855.562999330006;4877.219644856806;11800.704982375337;11872.22830516031;11971.102167337485;11982.460789264504;11998.880011199952;5817.476427121579;5929.73316200772;5934.910976335358;5942.316633587193;5955.464008239279;5142.948570514322;5363.678179309254;5370.355557333067;5380.488853558905;5470.097433923438;3885.417187421909;4001.3197756381487;4023.959760402417;4090.5909409058854;4094.488188976378;1052.1214785653913;1054.4604876879841;1060.5121644043827;1067.989320106789;1074.3607553505651;819.1317203764029;940.7789169545151;951.286535098676;971.455984648585;1013.9188864890791;5654.349749778746;6640;6837.726490940406;6878.484113691493;6997.825054373681;964.8070385922844;1003.5684655598163;1012.3520946594185;1012.3925644613173;1070.8126077936486;4183.226103170923;4334.523202447728;4340.590972010501;4421.9336709949375;4566.70316429431;10105.797884042426;14111.717765644835;14114.364853581614;14119.64700882486;14120.22338771357;12254.326012069243;13639.454421823215;13968.860311396958;14050.718985620231;14085.15489070659;8792.824143516966;9747.756306092262;10074.244431667654;10317.019883111092;10588.364698118137;5434.918476222939;5528.723563821713;6280.591761535486;6577.80266592003;6678.365555272241;12321.07591930591;12330.876691232972;12396.194247373893;12415.44130514111;12435.689107772016;10114.494275286354;12453.066020048715;12516.561920332744;12555.183913045623;12878.67803304925;7856.764297071097;9349.719508414759;9421.858672119786;9422.29332800029;9552.57013434411;10325.225608079274;10399.480025998519;10405.323653962469;10494.68515944523;10525.9473702631;8926.419782714363;8930.464172149692;8962.058983806606;9064.320175986959;9198.03420640823;8767.649294028168;8797.912020879965;8827.955860220658;8885.155910188521;8919.063498332842;7912.84174316522;7944.880826787487;7961.920380796118;8025;8045.195480451908;5921.970390148022;5938.8218353449465;6005.099235114593;6044.667543285162;6177.598456100339;5927;6079.787207447718;6146.877062458636;6159.384061593805;6203.596766210182 21:33:39 INFO - PROCESS | 1636 | |4;prototype.html;341.34972876669946;366.4100797715677;375.271972373595;384.39457853880145;392.93122706239035;4798.5441383068555;4955.15078829673;5057.760848592091;5071.123684236837;5087.982403519292;4326.718763280384;5000;5123.257127716479;5155.690658560489;5216.7913283468615;4467.374567560536;4487.730736155841;4497.14554234696;4510.481294651108;4533.9319910201375;3825.827837747308;4048.7044145873333;4074.470318858559;4414.29371300592;4554.476235232941;3766.303233901737;3766.871717479629;4095.6313931746135;4480.775961201927;4484.304932735431;3749.212665340282;4060.4924384451942;4425.782909699826;4492.438445194351;4509.954900451019;3966.3852102924093;4005.83976640934;4263.552327005682;4312.374705667692;4339.414179085815;4852.320675105488;5022.271770593244;5024.9748751256375;5028.7988480460735;5037.722925239111;4604.194266003436;4892.0705066037335;5035.62232832539;5308;5347.331583552056;4584.610308123813;4812.593703148425;5049.873753156164;5185.274061631375;5644.294463192101;4569;4773.570378665937;4779.160023391019;4816.95183048172;4869.634777391674;5694.84956247252;5706.258186435737;5807.477327040544;5857.456238975444;5858.882822343529;4466.03980144264;4713.10451014313;4731.739754313477;4883.4628190898975;4980.9080186321835;4553.749543775124;4765.4996225395835;5145.434002259748;5179.637425380187;5208.583313334924;4638.327442520816;4864.902701946012;5066.518680725399;5276.472352764769;5315.415304316522;4660.533946605312;5446.945530544723;5687.630304030225;5694;5694.4590263924865;1607.1964017991004;1635.8691304695597;1754.079108468039;1755.4119370010933;1776.5913839816915;1300.9089363744447;1432.6919712261913;1439.5465428390023;1444.8049513315777;1482.4218554763436;4496.132547026163;4771.475137734847;4954.603631709455;4965.988774546315;4989.5758860496535;4944.579710724629;5000.449950505442;5059.848204553869;5275.918436720463;5815.360310365856;4701.623870090384;4968.900621987612;5057.848264552069;5132.948670513321;5238.292830467914;2502.273431332375;2609.3346196719717;2780.694123646397;2821.929451763722;3035.514317709156;5322.893542129135;5406.4321346809775;5717.559723986764;5927.170196172539;6059.545534084873;4722.6221902247735;4933.990265937775;5193.428722840485;5294.629375943647;5747.770089196469;5323.087530665036;5571.247881536103;5694.515966142924;5960.284765828128;5989.490893274121;4298.720583162084;5346.759395827275;5739.368669446274;5806.593538452268;5806.622569532967;4781.354517140281;4860.878478038077;4920.40955085392;5572.60991730575;5662.915056274077;4905.632077594266;5273.829619345452;5727.422659803022;5740.555666600007;5916.911246331395;4207.032382551969;4475.455967691141;4686.437627484724;4908.233036106927;4919.376605720176;4986.351774269322;5245.554127899019;5376.817100237941;5580.832575022756;5683.7442315095095;4930.309756634146;5003.249512573143;5477.424870388551;5505.917411238915;5544;4694.953050469451;4865.9026819464125;5125.846224613268;5352.277442545363;5551.861203469945;5115.516500215045;5303.443138470405;5330.227117068081;5441.83674489766;5445.175866084906;5204.193350030751;5645.350784659817;5647.237622920853;5649.491545760901;5651.632643878134;5127.87180320495;5430.945690543202;5526.159319273067;5554.50009499147;5559.33288005442 21:33:39 INFO - PROCESS | 1636 | |5;yui.html;704.5134765644492;722.093772315744;730.1894896664702;784.5018413307548;864.948103113813;15083.095014299137;16343.91828040861;16347.182640867939;16353.264103115374;16414.261358238877;11779.469923853425;14848.851511484881;14982.175980321104;15075.246237688127;15201.315940782664;895.373238732888;915.922146617535;920.8572671235969;927.0266220468515;927.661403587689;900.8288425199224;926.967556135532;927.0544045074021;929.1962452478591;930.1814403325064;979.7256768104942;991.6281394477071;992.4293531219541;999.2206079258154;1003.5283416794096;987.501311837521;996.8355221388463;997.8004399120205;999.0858364596386;999.3054826895311;741.7922981565171;742.109468637637;743.5575832379725;743.6207534157564;746.6863917154808;16446.506604801874;16476;16679.749803752955;16698.83301166985;16849.91575042117;14133.646658833508;14149.504767333197;14197.290135493184;14398.496052638213;14405.567832965027;11674.182807203499;11720.648380548597;11759.529618815322;11872.465739041763;11945.343006134659;3458.602260740022;3631.2555926035097;3663.688586470153;3685.1155722626645;3725.1432170600915;82822.17177828205;97030;104132;104480;104775.99999999924;10389.013043760831;10598;10637.9468102659;10677.51951162184;10814.78370432587;20688.965551722355;20938.895305523376;20972.951352432316;21030.789692102884;21119;7459.291367320096;7538.0954285484995;7566.583837888969;7635.885461718079;7726.9227307726205;3890.4553362528704;4193.811278492475;4216.072464057902;4267.64227966463;4377.671674624416;3440.501127336572;3504.649535046526;3507.9298414031578;3526.682598566141;3601.585817631006;679.5548915460381;685.2359619024752;689.5276735436242;697.316629702894;697.6337422852941;674.1404708995972;675.4765057080801;700.2752151523149;705.6401235369896;724.1635910523248;10042.19662427004;10084.546195421224;10128.240381971234;10314.896851031544;10483.37099774016;705.5942832871119;711.8540699156661;713.8001359619315;717.6519388096768;720.8738470767595;4538.72767633943;4697.694649847749;4946.62900282473;4957.876053098701;4985.925211121836;87976;90434.54782726044;90906;96385.51807240919;101061.49469252607;49964;56528.58678532987;65435;72712.4550640725;84725.31088883757;73573.63213184007;77056.61471692605;78023.60988195136;78428;79172.60413697895;10455.790884182426;10743.785124297627;10834.133269338592;10837.295575787548;10967.341959482457;31046.0686179415;50020;51071.74464127656;51383.45849624517;52733.47266527286;63135;65166;65669.67165164143;66401.33598663952;66868.66565667141;12354.567590134302;12413.44139513706;12574.49702011946;12600.810987835373;13053.34733263314;14377.928110359382;14395.280235988368;14711.852881471048;14925.776113358526;15210.014627884195;13207.273599952096;13817.240051796845;13871.86128138746;14335.92832035833;14599.197044162673;13077.280749558866;13812.516561920285;13967.650808729863;14006.43974241019;14481;10624.946875265574;11046.668599941693;11072.723181920517;11078.833817492905;11425.657230283105;9151;9281.443113413217;9425.764355891157;9534.475603841578;9717.854232186664;10130.290879638354;10473.416312084892;10980.945095274792;11007.944960275147;11021.83467247976 21:33:39 INFO - PROCESS | 1636 | __end_tp_report 21:33:39 INFO - PROCESS | 1636 | __start_cc_report 21:33:39 INFO - PROCESS | 1636 | _x_x_mozilla_cycle_collect,427 21:33:39 INFO - PROCESS | 1636 | __end_cc_report 21:33:39 INFO - PROCESS | 1636 | __startTimestamp1491971619813__endTimestamp 21:33:39 INFO - PROCESS | 1636 | 21:33:39 INFO - PROCESS | 1636 | ------- Summary: start ------- 21:33:39 INFO - PROCESS | 1636 | Number of tests: 6 21:33:39 INFO - PROCESS | 1636 | 21:33:39 INFO - PROCESS | 1636 | [#0] dojo.html Cycles:165 Average:5918.89 Median:6188.95 stddev:728.24 (11.8%) stddev-sans-first:694.91 21:33:39 INFO - PROCESS | 1636 | Values: 3053.3 3203.3 3435.7 3482.7 3523.6 6007.8 6056.9 6060.2 6065.6 6075.4 6070.9 6088.9 6097.0 6104.1 6118.7 5414.2 5473.5 5492.8 5493.5 5575.2 5536.1 5538.3 5542.3 5545.1 5550.4 5333.7 5355.6 5534.6 5540.5 5559.1 5432.8 5448.1 5499.7 5536.7 5595.7 4496.7 5362.3 5455.3 5462.6 5502.3 5005.4 5805.7 6091.2 6124.3 6138.7 6298.7 6309.3 6323.4 6357.6 6360.8 6539.7 6550.7 6552.4 6577.1 6597.0 5067.0 6175.7 6181.6 6181.8 6195.4 6373.7 6447.2 6466.9 6632.3 6671.7 6242.1 6251.4 6293.7 6309.7 6320.8 6487.9 6503.8 6511.1 6514.3 6523.5 6193.9 6211.4 6425.7 6436.4 6453.2 4895.4 6242.0 6344.1 6355.4 6364.0 4215.4 5134.4 5176.4 5187.4 5194.4 3860.3 4577.2 4585.9 4627.1 4644.3 6106.4 6172.8 6199.3 6201.3 6209.6 6229.4 6267.4 6411.8 6417.0 6472.4 6165.2 6183.8 6188.9 6192.6 6196.4 4795.6 4858.9 5731.3 5745.7 5765.0 6452.7 6516.0 6601.9 6609.1 6781.1 5082.8 6448.7 6457.4 6494.4 6521.6 6676.0 6686.4 6757.2 6779.5 6781.1 4802.9 5294.6 6261.9 6438.0 6451.6 6329.8 6369.1 6378.1 6412.0 6433.9 6285.0 6299.7 6302.1 6321.2 6350.4 6174.9 6256.7 6259.7 6308.8 6314.3 5005.5 5923.6 6129.9 6144.4 6146.6 6307.7 6312.5 6327.7 6351.9 6366.9 6003.2 6065.3 6128.4 6168.2 6205.3 21:33:39 INFO - PROCESS | 1636 | 21:33:39 INFO - PROCESS | 1636 | [#1] ext.html Cycles:180 Average:48226.75 Median:29389.41 stddev:92999.80 (316.4%) stddev-sans-first:93192.19 21:33:39 INFO - PROCESS | 1636 | Values: 686.3 708.3 811.7 866.4 883.0 26313.6 37330.0 37356.4 38742.0 38750.4 37351.8 37682.2 37689.8 37721.6 37762.9 7219.8 7413.2 7744.5 7909.7 11064.9 11020.4 11141.2 11158.1 11162.8 11183.0 11128.6 11144.8 11155.9 11180.6 11204.7 11088.6 11113.2 11114.6 11181.9 11189.7 10903.0 10961.3 10973.2 10991.9 10997.7 38531.4 38834.4 38844.0 38861.0 39042.8 3696.7 3830.8 3855.0 3896.9 3905.6 24303.6 27540.3 29331.6 29386.3 29392.6 3012.5 3095.2 3095.7 3267.7 3272.4 313620.0 315236.4 315768.0 316052.0 316934.0 50273.0 50551.7 50598.5 50671.2 50929.7 43883.6 49857.0 53052.7 53127.7 53240.0 14018.8 14071.0 14196.9 14233.6 14237.2 8695.3 12139.1 12178.0 12322.0 12336.9 10577.6 11890.5 12034.3 12105.3 12222.5 4921.6 5689.9 5701.7 5707.2 5729.0 955.4 1135.0 1135.7 1135.8 1147.8 25750.5 26001.3 26241.2 26416.9 26487.5 982.5 983.9 1046.5 1243.0 1260.8 9488.3 10901.7 13056.5 13273.9 13306.6 314327.0 314876.0 315135.8 315146.0 315550.0 41336.8 41445.0 41723.8 41740.4 41750.7 1388.3 1430.9 1432.7 1434.4 1440.5 21700.6 25537.9 26394.7 27591.9 27794.6 38919.2 39554.0 39632.6 39651.2 39748.6 414440.0 414957.0 415554.9 416625.0 417365.0 27867.3 28305.0 28546.6 28562.9 28674.7 36223.9 36361.5 36996.0 37014.4 37087.0 26161.3 26346.6 26750.7 27455.5 27548.6 22315.4 25839.6 26716.9 26874.7 27164.1 30695.2 31283.0 31288.9 31298.9 31402.7 22268.7 25928.9 27146.7 27569.3 27713.9 17148.6 21908.6 22072.9 22424.4 22471.2 21:33:39 INFO - PROCESS | 1636 | 21:33:39 INFO - PROCESS | 1636 | [#2] jquery.html Cycles:180 Average:43469.15 Median:21910.12 stddev:125511.81 (572.8%) stddev-sans-first:125822.26 21:33:39 INFO - PROCESS | 1636 | Values: 409.1 410.7 419.9 428.1 450.0 15983.8 20595.9 21136.4 21192.2 21500.8 21931.0 22148.7 22377.2 22558.4 22582.5 6537.5 6784.1 6816.2 6829.4 6841.0 6690.3 6926.8 7252.6 7335.2 7370.1 7099.4 7212.9 7390.5 7393.1 7394.3 7200.8 7405.9 7435.8 7465.6 7482.5 6503.6 6731.9 7138.0 7214.0 7263.7 25359.5 25601.4 25757.7 25906.7 26070.1 2812.4 2846.4 2870.8 2884.6 2897.6 15110.7 15887.4 16123.5 16316.0 16567.3 1903.7 2019.7 2025.6 2041.8 2053.2 123773.0 144614.0 164428.2 165743.0 166604.5 21126.0 21397.5 21613.9 21615.2 21617.0 32555.5 32562.2 32895.0 33187.7 33278.8 8221.5 9736.2 9807.0 9973.6 10110.8 8062.1 8079.4 8136.9 8221.7 8230.3 7327.6 8238.8 8794.5 9817.4 9887.7 3460.8 4033.2 4126.7 4138.9 4147.9 1030.9 1052.8 1056.9 1063.2 1098.4 21542.7 21826.0 21862.5 21889.2 21965.1 1081.3 1092.6 1106.6 1118.9 1123.9 8880.6 10840.0 11310.2 11611.5 11632.8 733647.0 748013.0 751030.0 760699.0 761050.0 150313.5 151773.2 165515.0 169702.0 172727.9 1259.0 1259.6 1315.4 1315.5 1316.6 16098.9 17431.0 17992.1 20774.5 20779.1 50785.7 62213.7 62666.0 63990.0 64594.7 91151.0 91326.5 92563.5 92668.5 93503.0 11478.3 11794.8 11919.5 11920.9 12196.1 13262.3 13308.8 13362.5 13654.6 13701.7 9409.6 11048.8 11355.0 11647.5 11740.7 8966.0 10604.4 10640.7 10674.3 10730.9 9487.7 11439.4 11650.9 11731.4 11794.6 11668.5 11704.9 11826.6 11867.8 12057.7 11251.3 11471.8 11576.1 11637.5 11740.9 21:33:39 INFO - PROCESS | 1636 | 21:33:39 INFO - PROCESS | 1636 | [#3] mootools.html Cycles:180 Average:6760.03 Median:2431.28 stddev:4207.17 (173.0%) stddev-sans-first:4198.62 21:33:39 INFO - PROCESS | 1636 | Values: 1253.6 1266.7 1364.9 1492.9 1577.1 9478.3 10712.5 10960.1 11315.5 11468.5 11067.6 11094.4 11230.8 11236.7 11255.2 2372.7 2413.0 2415.6 2416.8 2423.2 2319.0 2404.3 2443.0 2443.8 2445.3 2138.5 2322.9 2356.9 2441.2 2443.9 2351.7 2383.1 2403.5 2408.5 2437.9 2326.4 2393.1 2401.7 2404.7 2424.7 11341.5 11383.9 11385.3 11441.0 11453.8 5925.6 6097.7 6099.2 6105.8 6106.4 2784.7 3601.7 3702.6 3794.8 3798.9 1209.6 1218.3 1252.0 1255.8 1262.2 13774.5 14004.2 15133.5 15798.6 15936.0 4716.6 4724.7 4764.0 4855.6 4877.2 11800.7 11872.2 11971.1 11982.5 11998.9 5817.5 5929.7 5934.9 5942.3 5955.5 5142.9 5363.7 5370.4 5380.5 5470.1 3885.4 4001.3 4024.0 4090.6 4094.5 1052.1 1054.5 1060.5 1068.0 1074.4 819.1 940.8 951.3 971.5 1013.9 5654.3 6640.0 6837.7 6878.5 6997.8 964.8 1003.6 1012.4 1012.4 1070.8 4183.2 4334.5 4340.6 4421.9 4566.7 10105.8 14111.7 14114.4 14119.6 14120.2 12254.3 13639.5 13968.9 14050.7 14085.2 8792.8 9747.8 10074.2 10317.0 10588.4 5434.9 5528.7 6280.6 6577.8 6678.4 12321.1 12330.9 12396.2 12415.4 12435.7 10114.5 12453.1 12516.6 12555.2 12878.7 7856.8 9349.7 9421.9 9422.3 9552.6 10325.2 10399.5 10405.3 10494.7 10525.9 8926.4 8930.5 8962.1 9064.3 9198.0 8767.6 8797.9 8828.0 8885.2 8919.1 7912.8 7944.9 7961.9 8025.0 8045.2 5922.0 5938.8 6005.1 6044.7 6177.6 5927.0 6079.8 6146.9 6159.4 6203.6 21:33:39 INFO - PROCESS | 1636 | 21:33:39 INFO - PROCESS | 1636 | [#4] prototype.html Cycles:180 Average:4659.20 Median:4987.96 stddev:1236.84 (24.8%) stddev-sans-first:1197.10 21:33:39 INFO - PROCESS | 1636 | Values: 341.3 366.4 375.3 384.4 392.9 4798.5 4955.2 5057.8 5071.1 5088.0 4326.7 5000.0 5123.3 5155.7 5216.8 4467.4 4487.7 4497.1 4510.5 4533.9 3825.8 4048.7 4074.5 4414.3 4554.5 3766.3 3766.9 4095.6 4480.8 4484.3 3749.2 4060.5 4425.8 4492.4 4510.0 3966.4 4005.8 4263.6 4312.4 4339.4 4852.3 5022.3 5025.0 5028.8 5037.7 4604.2 4892.1 5035.6 5308.0 5347.3 4584.6 4812.6 5049.9 5185.3 5644.3 4569.0 4773.6 4779.2 4817.0 4869.6 5694.8 5706.3 5807.5 5857.5 5858.9 4466.0 4713.1 4731.7 4883.5 4980.9 4553.7 4765.5 5145.4 5179.6 5208.6 4638.3 4864.9 5066.5 5276.5 5315.4 4660.5 5446.9 5687.6 5694.0 5694.5 1607.2 1635.9 1754.1 1755.4 1776.6 1300.9 1432.7 1439.5 1444.8 1482.4 4496.1 4771.5 4954.6 4966.0 4989.6 4944.6 5000.4 5059.8 5275.9 5815.4 4701.6 4968.9 5057.8 5132.9 5238.3 2502.3 2609.3 2780.7 2821.9 3035.5 5322.9 5406.4 5717.6 5927.2 6059.5 4722.6 4934.0 5193.4 5294.6 5747.8 5323.1 5571.2 5694.5 5960.3 5989.5 4298.7 5346.8 5739.4 5806.6 5806.6 4781.4 4860.9 4920.4 5572.6 5662.9 4905.6 5273.8 5727.4 5740.6 5916.9 4207.0 4475.5 4686.4 4908.2 4919.4 4986.4 5245.6 5376.8 5580.8 5683.7 4930.3 5003.2 5477.4 5505.9 5544.0 4695.0 4865.9 5125.8 5352.3 5551.9 5115.5 5303.4 5330.2 5441.8 5445.2 5204.2 5645.4 5647.2 5649.5 5651.6 5127.9 5430.9 5526.2 5554.5 5559.3 21:33:39 INFO - PROCESS | 1636 | 21:33:39 INFO - PROCESS | 1636 | [#5] yui.html Cycles:180 Average:19196.66 Median:3807.80 stddev:26634.17 (699.5%) stddev-sans-first:26672.69 21:33:39 INFO - PROCESS | 1636 | Values: 704.5 722.1 730.2 784.5 864.9 15083.1 16343.9 16347.2 16353.3 16414.3 11779.5 14848.9 14982.2 15075.2 15201.3 895.4 915.9 920.9 927.0 927.7 900.8 927.0 927.1 929.2 930.2 979.7 991.6 992.4 999.2 1003.5 987.5 996.8 997.8 999.1 999.3 741.8 742.1 743.6 743.6 746.7 16446.5 16476.0 16679.7 16698.8 16849.9 14133.6 14149.5 14197.3 14398.5 14405.6 11674.2 11720.6 11759.5 11872.5 11945.3 3458.6 3631.3 3663.7 3685.1 3725.1 82822.2 97030.0 104132.0 104480.0 104776.0 10389.0 10598.0 10637.9 10677.5 10814.8 20689.0 20938.9 20973.0 21030.8 21119.0 7459.3 7538.1 7566.6 7635.9 7726.9 3890.5 4193.8 4216.1 4267.6 4377.7 3440.5 3504.6 3507.9 3526.7 3601.6 679.6 685.2 689.5 697.3 697.6 674.1 675.5 700.3 705.6 724.2 10042.2 10084.5 10128.2 10314.9 10483.4 705.6 711.9 713.8 717.7 720.9 4538.7 4697.7 4946.6 4957.9 4985.9 87976.0 90434.5 90906.0 96385.5 101061.5 49964.0 56528.6 65435.0 72712.5 84725.3 73573.6 77056.6 78023.6 78428.0 79172.6 10455.8 10743.8 10834.1 10837.3 10967.3 31046.1 50020.0 51071.7 51383.5 52733.5 63135.0 65166.0 65669.7 66401.3 66868.7 12354.6 12413.4 12574.5 12600.8 13053.3 14377.9 14395.3 14711.9 14925.8 15210.0 13207.3 13817.2 13871.9 14335.9 14599.2 13077.3 13812.5 13967.7 14006.4 14481.0 10624.9 11046.7 11072.7 11078.8 11425.7 9151.0 9281.4 9425.8 9534.5 9717.9 10130.3 10473.4 10980.9 11007.9 11021.8 21:33:39 INFO - PROCESS | 1636 | -------- Summary: end -------- 21:33:39 INFO - PROCESS | 1636 | 21:33:40 INFO - TEST-INFO | 1636: exit 0 21:33:40 INFO - TEST-OK | dromaeo_css | took 1117377ms 21:33:40 INFO - TEST-START | kraken 21:33:40 INFO - operating with platform_type : mac_ 21:33:40 INFO - Initialising browser for kraken test... 21:33:40 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/tmphiCFKz/profile http://localhost:49241/getInfo.html) 21:33:43 INFO - PROCESS | 1648 | 2017-04-11 21:33:43.404 plugin-container[1649:10061] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a3b, name = 'com.apple.tsm.portname' 21:33:43 INFO - PROCESS | 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:33:43 INFO - PROCESS | 1648 | 2017-04-11 21:33:43.406 plugin-container[1649:10061] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x431b, name = 'com.apple.CFPasteboardClient' 21:33:43 INFO - PROCESS | 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:33:43 INFO - PROCESS | 1648 | 2017-04-11 21:33:43.406 plugin-container[1649:10061] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 21:33:43 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 21:33:43 INFO - PROCESS | 1648 | colorDepth:24 21:33:43 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 21:33:43 INFO - PROCESS | 1648 | __metrics 21:33:43 ERROR - PROCESS | 1648 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3360: TypeError: this.tabs is undefined 21:33:44 INFO - TEST-INFO | 1648: exit 0 21:33:44 INFO - Browser initialized. 21:33:44 INFO - Running cycle 1/1 for kraken test... 21:33:44 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/tmphiCFKz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:33:46 INFO - PROCESS | 1650 | 2017-04-11 21:33:46.732 plugin-container[1651:10190] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4443, name = 'com.apple.tsm.portname' 21:33:46 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:33:46 INFO - PROCESS | 1650 | 2017-04-11 21:33:46.733 plugin-container[1651:10190] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 21:33:46 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:33:46 INFO - PROCESS | 1650 | 2017-04-11 21:33:46.733 plugin-container[1651:10190] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 21:33:56 INFO - PROCESS | 1650 | RSS: Main: 220823552 21:33:56 INFO - PROCESS | 1650 | 21:33:59 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 21:34:00 INFO - PROCESS | 1650 | RSS: Main: 235171840 21:34:00 INFO - PROCESS | 1650 | 21:34:03 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 21:34:03 INFO - PROCESS | 1650 | RSS: Main: 243154944 21:34:03 INFO - PROCESS | 1650 | 21:34:07 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 21:34:07 INFO - PROCESS | 1650 | RSS: Main: 246771712 21:34:07 INFO - PROCESS | 1650 | 21:34:09 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 21:34:10 INFO - PROCESS | 1650 | RSS: Main: 247173120 21:34:10 INFO - PROCESS | 1650 | 21:34:12 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:34:12 INFO - PROCESS | 1650 | RSS: Main: 247238656 21:34:12 INFO - PROCESS | 1650 | 21:34:15 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 21:34:16 INFO - PROCESS | 1650 | RSS: Main: 252727296 21:34:16 INFO - PROCESS | 1650 | 21:34:19 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 21:34:20 INFO - PROCESS | 1650 | RSS: Main: 251670528 21:34:20 INFO - PROCESS | 1650 | 21:34:23 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 21:34:23 INFO - PROCESS | 1650 | RSS: Main: 251764736 21:34:23 INFO - PROCESS | 1650 | 21:34:25 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:34:26 INFO - PROCESS | 1650 | RSS: Main: 251232256 21:34:26 INFO - PROCESS | 1650 | 21:34:28 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:34:28 INFO - PROCESS | 1650 | RSS: Main: 251211776 21:34:28 INFO - PROCESS | 1650 | 21:34:31 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:34:31 INFO - PROCESS | 1650 | RSS: Main: 251269120 21:34:31 INFO - PROCESS | 1650 | 21:34:34 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:34:35 INFO - PROCESS | 1650 | RSS: Main: 251650048 21:34:35 INFO - PROCESS | 1650 | 21:34:38 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:34:38 INFO - PROCESS | 1650 | RSS: Main: 251359232 21:34:38 INFO - PROCESS | 1650 | 21:34:40 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 21:34:40 INFO - PROCESS | 1650 | RSS: Main: 253218816 21:34:40 INFO - PROCESS | 1650 | 21:34:40 INFO - PROCESS | 1650 | __start_tp_report 21:34:40 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 21:34:40 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 21:34:40 INFO - PROCESS | 1650 | |i|pagename|runs| 21:34:40 INFO - PROCESS | 1650 | |0;ai-astar;139;115;162;178;163;121;118;120;119;116 21:34:40 INFO - PROCESS | 1650 | |1;audio-beat-detection;157;138;97;180;97;100;113;98;149;144 21:34:40 INFO - PROCESS | 1650 | |2;audio-dft;197;195;193;195;200;193;195;195;199;196 21:34:40 INFO - PROCESS | 1650 | |3;audio-fft;84;64;63;86;67;62;63;63;74;61 21:34:40 INFO - PROCESS | 1650 | |4;audio-oscillator;89;71;86;71;73;70;82;73;88;113 21:34:40 INFO - PROCESS | 1650 | |5;imaging-gaussian-blur;90;90;89;91;93;121;136;91;92;89 21:34:40 INFO - PROCESS | 1650 | |6;imaging-darkroom;99;114;99;115;98;98;100;97;98;156 21:34:40 INFO - PROCESS | 1650 | |7;imaging-desaturate;91;94;86;90;119;91;146;90;90;132 21:34:40 INFO - PROCESS | 1650 | |8;json-parse-financial;66;67;69;82;108;108;108;74;69;70 21:34:40 INFO - PROCESS | 1650 | |9;json-stringify-tinderbox;59;60;65;66;64;58;60;58;61;63 21:34:40 INFO - PROCESS | 1650 | |10;stanford-crypto-aes;81;88;84;94;105;96;84;83;83;90 21:34:40 INFO - PROCESS | 1650 | |11;stanford-crypto-ccm;133;133;137;140;140;141;142;144;182;138 21:34:40 INFO - PROCESS | 1650 | |12;stanford-crypto-pbkdf2;172;172;169;168;174;169;173;174;208;170 21:34:40 INFO - PROCESS | 1650 | |13;stanford-crypto-sha256-iterative;66;66;67;63;70;68;78;86;90;85 21:34:40 INFO - PROCESS | 1650 | __end_tp_report 21:34:40 INFO - PROCESS | 1650 | __start_cc_report 21:34:40 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,1011 21:34:40 INFO - PROCESS | 1650 | __end_cc_report 21:34:40 INFO - PROCESS | 1650 | __startTimestamp1491971680965__endTimestamp 21:34:40 INFO - PROCESS | 1650 | 21:34:40 INFO - PROCESS | 1650 | ------- Summary: start ------- 21:34:40 INFO - PROCESS | 1650 | Number of tests: 14 21:34:40 INFO - PROCESS | 1650 | 21:34:40 INFO - PROCESS | 1650 | [#0] ai-astar Cycles:10 Average:135.10 Median:130.00 stddev:23.82 (18.3%) stddev-sans-first:25.22 21:34:40 INFO - PROCESS | 1650 | Values: 139.0 115.0 162.0 178.0 163.0 121.0 118.0 120.0 119.0 116.0 21:34:40 INFO - PROCESS | 1650 | 21:34:40 INFO - PROCESS | 1650 | [#1] audio-beat-detection Cycles:10 Average:127.30 Median:168.50 stddev:30.13 (17.9%) stddev-sans-first:29.97 21:34:40 INFO - PROCESS | 1650 | Values: 157.0 138.0 97.0 180.0 97.0 100.0 113.0 98.0 149.0 144.0 21:34:40 INFO - PROCESS | 1650 | 21:34:40 INFO - PROCESS | 1650 | [#2] audio-dft Cycles:10 Average:195.80 Median:195.50 stddev:2.30 (1.2%) stddev-sans-first:2.40 21:34:40 INFO - PROCESS | 1650 | Values: 197.0 195.0 193.0 195.0 200.0 193.0 195.0 195.0 199.0 196.0 21:34:40 INFO - PROCESS | 1650 | 21:34:40 INFO - PROCESS | 1650 | [#3] audio-fft Cycles:10 Average:68.70 Median:65.50 stddev:9.36 (14.3%) stddev-sans-first:8.12 21:34:40 INFO - PROCESS | 1650 | Values: 84.0 64.0 63.0 86.0 67.0 62.0 63.0 63.0 74.0 61.0 21:34:40 INFO - PROCESS | 1650 | 21:34:40 INFO - PROCESS | 1650 | [#4] audio-oscillator Cycles:10 Average:81.60 Median:77.50 stddev:13.37 (17.2%) stddev-sans-first:13.91 21:34:40 INFO - PROCESS | 1650 | Values: 89.0 71.0 86.0 71.0 73.0 70.0 82.0 73.0 88.0 113.0 21:34:40 INFO - PROCESS | 1650 | 21:34:40 INFO - PROCESS | 1650 | [#5] imaging-gaussian-blur Cycles:10 Average:98.20 Median:90.50 stddev:16.40 (18.1%) stddev-sans-first:17.13 21:34:40 INFO - PROCESS | 1650 | Values: 90.0 90.0 89.0 91.0 93.0 121.0 136.0 91.0 92.0 89.0 21:34:40 INFO - PROCESS | 1650 | 21:34:40 INFO - PROCESS | 1650 | [#6] imaging-darkroom Cycles:10 Average:107.40 Median:98.00 stddev:18.36 (18.7%) stddev-sans-first:19.22 21:34:40 INFO - PROCESS | 1650 | Values: 99.0 114.0 99.0 115.0 98.0 98.0 100.0 97.0 98.0 156.0 21:34:40 INFO - PROCESS | 1650 | 21:34:40 INFO - PROCESS | 1650 | [#7] imaging-desaturate Cycles:10 Average:102.90 Median:90.00 stddev:21.37 (23.7%) stddev-sans-first:22.23 21:34:40 INFO - PROCESS | 1650 | Values: 91.0 94.0 86.0 90.0 119.0 91.0 146.0 90.0 90.0 132.0 21:34:40 INFO - PROCESS | 1650 | 21:34:40 INFO - PROCESS | 1650 | [#8] json-parse-financial Cycles:10 Average:82.10 Median:69.00 stddev:18.42 (26.7%) stddev-sans-first:18.60 21:34:40 INFO - PROCESS | 1650 | Values: 66.0 67.0 69.0 82.0 108.0 108.0 108.0 74.0 69.0 70.0 21:34:40 INFO - PROCESS | 1650 | 21:34:40 INFO - PROCESS | 1650 | [#9] json-stringify-tinderbox Cycles:10 Average:61.40 Median:62.00 stddev:2.91 (4.7%) stddev-sans-first:2.96 21:34:40 INFO - PROCESS | 1650 | Values: 59.0 60.0 65.0 66.0 64.0 58.0 60.0 58.0 61.0 63.0 21:34:40 INFO - PROCESS | 1650 | 21:34:40 INFO - PROCESS | 1650 | [#10] stanford-crypto-aes Cycles:10 Average:88.80 Median:86.00 stddev:7.58 (8.8%) stddev-sans-first:7.50 21:34:40 INFO - PROCESS | 1650 | Values: 81.0 88.0 84.0 94.0 105.0 96.0 84.0 83.0 83.0 90.0 21:34:40 INFO - PROCESS | 1650 | 21:34:40 INFO - PROCESS | 1650 | [#11] stanford-crypto-ccm Cycles:10 Average:143.00 Median:140.50 stddev:14.17 (10.1%) stddev-sans-first:14.56 21:34:40 INFO - PROCESS | 1650 | Values: 133.0 133.0 137.0 140.0 140.0 141.0 142.0 144.0 182.0 138.0 21:34:40 INFO - PROCESS | 1650 | 21:34:40 INFO - PROCESS | 1650 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.90 Median:172.50 stddev:11.83 (6.9%) stddev-sans-first:12.50 21:34:40 INFO - PROCESS | 1650 | Values: 172.0 172.0 169.0 168.0 174.0 169.0 173.0 174.0 208.0 170.0 21:34:40 INFO - PROCESS | 1650 | 21:34:40 INFO - PROCESS | 1650 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.90 Median:74.00 stddev:9.93 (13.4%) stddev-sans-first:10.11 21:34:40 INFO - PROCESS | 1650 | Values: 66.0 66.0 67.0 63.0 70.0 68.0 78.0 86.0 90.0 85.0 21:34:40 INFO - PROCESS | 1650 | -------- Summary: end -------- 21:34:40 INFO - PROCESS | 1650 | 21:34:42 INFO - TEST-INFO | 1650: exit 0 21:34:42 INFO - TEST-OK | kraken | took 61612ms 21:34:42 INFO - SUITE-END | took 1178s 21:34:42 INFO - Completed test suite (00:19:39) 21:34:42 INFO - javascript benchmark 21:34:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7651.410431390187, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3053.2519532714487, 3203.2792621660124, 3435.690787829095, 3482.686558209762, 3523.5947865995417, 6007.819765407034, 6056.939430605698, 6060.2424696912885, 6065.636061836293, 6075.392460753934, 6070.878582428349, 6088.939110608892, 6096.969515152418, 6104.145419641242, 6118.6634735089665, 5414.242006119156, 5473.507384335409, 5492.80775172869, 5493.450654934514, 5575.2473416088715, 5536.058869992091, 5538.252335934638, 5542.279503664538, 5545.140503222007, 5550.361708403525, 5333.653312534692, 5355.6251062425645, 5534.640248383842, 5540.50135487806, 5559.054960656698, 5432.782688692468, 5448.101063324547, 5499.670019798825, 5536.667799932017, 5595.692236926968, 4496.7077139985795, 5362.329708786402, 5455.290812194429, 5462.562994960394, 5502.257195278627, 5005.374328208974, 5805.651660900359, 6091.238595175603, 6124.2957059938235, 6138.7237574309265, 6298.6535740534255, 6309.305976342599, 6323.399277068671, 6357.554971152022, 6360.840978975516, 6539.738410463576, 6550.70521826519, 6552.443042341407, 6577.14497115372, 6596.967015164942, 5066.974665126724, 6175.66033868137, 6181.598196117283, 6181.8454538636, 6195.380461953813, 6373.681315934185, 6447.161868957006, 6466.870662586722, 6632.2704502504685, 6671.699773510204, 6242.09489624002, 6251.374862513712, 6293.685315734195, 6309.652969086745, 6320.778772742932, 6487.935120648827, 6503.804885853432, 6511.055896895018, 6514.348565143542, 6523.478121750343, 6193.876122477525, 6211.440970312694, 6425.678716064178, 6436.356364363526, 6453.193350831146, 4895.363602731693, 6241.968790156111, 6344.143540621957, 6355.428011478989, 6364.0, 4215.367694845736, 5134.435212126663, 5176.352955880515, 5187.403448603383, 5194.3766747990485, 3860.2665493556133, 4577.153226653079, 4585.853536615846, 4627.0514544518965, 4644.303354496852, 6106.358832322631, 6172.814815555541, 6199.287081985539, 6201.255849298113, 6209.565330426917, 6229.408206220402, 6267.373262673696, 6411.775587854403, 6417.0, 6472.35276472349, 6165.167702360213, 6183.81448556535, 6188.947878860605, 6192.628442293477, 6196.411340922605, 4795.592374648194, 4858.878528036827, 5731.283589551306, 5745.741441635137, 5765.0, 6452.7418903245225, 6516.0, 6601.9009714853355, 6609.074729537772, 6781.11845460087, 5082.796688132434, 6448.677566121769, 6457.418832305115, 6494.3505649436565, 6521.576097553644, 6676.0, 6686.431653309523, 6757.155355580552, 6779.457643388419, 6781.084553585203, 4802.903941921072, 5294.576433885203, 6261.9373806263175, 6438.002109673008, 6451.645159516272, 6329.841753956188, 6369.1401660777055, 6378.138951241523, 6411.96794016027, 6433.903491447539, 6285.025820997753, 6299.716512757029, 6302.117703521419, 6321.1782468278825, 6350.396712312323, 6174.938250617616, 6256.655883926428, 6259.655718935503, 6308.842278943063, 6314.305426403183, 5005.4744251853035, 5923.644581325134, 6129.939558357133, 6144.354842741448, 6146.6004709693725, 6307.747690092345, 6312.526560508072, 6327.651979141191, 6351.9047214290895, 6366.936330636634, 6003.189569408074, 6065.272167339771, 6128.387161283836, 6168.228971378578, 6205.348438414082], "value": 5872.166688975579, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [686.2794066230458, 708.2846325211535, 811.6875003123797, 866.3762091294266, 882.9514376709278, 26313.60529592055, 37330.0, 37356.43965340522, 38742.0, 38750.418743718794, 37351.813240933756, 37682.24635507288, 37689.81155094228, 37721.62278377215, 37762.86711398663, 7219.819504512377, 7413.184549699528, 7744.457887947846, 7909.683612655487, 11064.944675276653, 11020.44897755113, 11141.22011459194, 11158.107351411867, 11162.832557511603, 11182.993530582246, 11128.61049863255, 11144.777104457906, 11155.944220278929, 11180.552777888875, 11204.66386008421, 11088.55645774168, 11113.166512511554, 11114.61098861544, 11181.937715917016, 11189.664310070712, 10903.01872831449, 10961.342319460859, 10973.23187376884, 10991.945040274828, 10997.725056873642, 38531.42202866959, 38834.417483737765, 38844.0, 38861.0, 39042.82871513859, 3696.669199088326, 3830.8467661293516, 3854.9807250963845, 3896.8636097736726, 3905.6094390560716, 24303.63544546833, 27540.311492212655, 29331.560026599618, 29386.265343366373, 29392.559111613344, 3012.487877060905, 3095.1952492351925, 3095.6749541298063, 3267.7059064684054, 3272.443684573628, 313620.0, 315236.42381788173, 315768.0, 316052.0, 316934.0, 50272.99454010899, 50551.736206594396, 50598.49401506012, 50671.23993140106, 50929.74535127375, 43883.561164388586, 49857.00285994332, 53052.67368315746, 53127.734361327944, 53240.0, 14018.789718154236, 14071.0, 14196.929015354857, 14233.64415889611, 14237.216953067473, 8695.304375649934, 12139.089568282414, 12178.0, 12321.952634026029, 12336.876631233572, 10577.57689692419, 11890.524379024742, 12034.277943323428, 12105.273683579013, 12222.511099555919, 4921.630877684188, 5689.886202275931, 5701.662318449416, 5707.172459993278, 5728.971355143198, 955.441066975827, 1134.9943250283695, 1135.7047167736448, 1135.840982262484, 1147.7532330548972, 25750.48499030009, 26001.349966250997, 26241.21276361674, 26416.8679156603, 26487.47025059488, 982.4792859784183, 983.8819341679044, 1046.4558429616557, 1242.9502819887102, 1260.7959398774149, 9488.29210742073, 10901.672949811518, 13056.477740890448, 13273.867261327263, 13306.600801975956, 314327.0, 314876.0, 315135.84864151524, 315146.0, 315550.0, 41336.793316033225, 41444.96387590334, 41723.7913810429, 41740.37389439161, 41750.74747757572, 1388.271157642246, 1430.9499167529086, 1432.6704857882537, 1434.4405681784112, 1440.481426686392, 21700.565988679824, 25537.87231063833, 26394.73605263923, 27591.896324147612, 27794.5830812542, 38919.22161556697, 39554.01114972149, 39632.60367396289, 39651.2069758609, 39748.60251397449, 414440.0, 414957.0, 415554.92222538695, 416625.0, 417365.0, 27867.303317417227, 28305.0, 28546.57180142341, 28562.85748570034, 28674.713252867205, 36223.91328260156, 36361.45457818082, 36996.0, 37014.44478332881, 37087.0, 26161.345966350993, 26346.604800927616, 26750.732492674822, 27455.45089098247, 27548.586771198046, 22315.442113946632, 25839.61240581355, 26716.8664156678, 26874.731252687223, 27164.070265167535, 30695.2326191847, 31283.0, 31288.904888328798, 31298.90453834105, 31402.685973139975, 22268.665970010137, 25928.8703556481, 27146.72853271442, 27569.310767230178, 27713.86143069272, 17148.571285717957, 21908.561828763017, 22072.896355182496, 22424.439389015406, 22471.213507527158], "value": 17508.98880035136, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [409.144887185782, 410.72481437436915, 419.86984034949165, 428.1223491841725, 449.975251361175, 15983.76024359634, 20595.897020514894, 21136.365909022716, 21192.152313907445, 21500.784992150115, 21931.0, 22148.66776998342, 22377.216797412093, 22558.43603909903, 22582.548349033008, 6537.5423720339595, 6784.084148639944, 6816.216135144447, 6829.351211634887, 6841.042254084432, 6690.33096690332, 6926.826829329257, 7252.637368131599, 7335.193128755833, 7370.078740157481, 7099.396551293146, 7212.927870721278, 7390.519616224955, 7393.07586551681, 7394.297541733554, 7200.783976480714, 7405.925940740577, 7435.776926692208, 7465.552066876005, 7482.476226664108, 6503.577267477599, 6731.865362692768, 7137.964310178468, 7213.990041394157, 7263.709451621929, 25359.492810143878, 25601.35996600081, 25757.74242257591, 25906.704664766687, 26070.087546935956, 2812.4375124975086, 2846.4164846206477, 2870.7559857412143, 2884.62499875017, 2897.6377952755906, 15110.698713919452, 15887.36450541977, 16123.516294511184, 16316.0, 16567.25447354872, 1903.7334773131772, 2019.6869485229813, 2025.574629327843, 2041.8264447521979, 2053.219776484941, 123773.0, 144614.0, 164428.17785910994, 165743.0, 166604.5009324849, 21126.0, 21397.502174847923, 21613.891930540245, 21615.243466478598, 21617.02723377452, 32555.51166732501, 32562.185945351557, 32895.0, 33187.66812331894, 33278.8336058323, 8221.465604735673, 9736.221102311798, 9807.019298070136, 9973.60105595768, 10110.797784044278, 8062.113167551564, 8079.4344395892895, 8136.860839482477, 8221.712240071569, 8230.341572674171, 7327.596982166032, 8238.752837414888, 8794.472331660121, 9817.361871478332, 9887.703368898945, 3460.7750496217664, 4033.193361327746, 4126.690498212646, 4138.896527586774, 4147.875563733093, 1030.9175265978704, 1052.8157572424948, 1056.8837427882927, 1063.2025980514613, 1098.4397957041806, 21542.676859847114, 21826.0, 21862.453438663844, 21889.233876814236, 21965.121395144015, 1081.3457857995957, 1092.6339676208559, 1106.590561492253, 1118.8713297970837, 1123.8651361836633, 8880.555972201364, 10840.024397804078, 11310.151738619636, 11611.535538578531, 11632.825507617392, 733647.0, 748013.0, 751030.0, 760699.0, 761050.0, 150313.49686502994, 151773.24113379582, 165515.0, 169702.0, 172727.8635743229, 1259.030546479206, 1259.5591542959892, 1315.4343632238038, 1315.500109958229, 1316.5852756381519, 16098.919505402398, 17431.04129272902, 17992.10039498046, 20774.480637984172, 20779.064942077945, 50785.74607126941, 62213.68893155505, 62666.0, 63990.0, 64594.67702661457, 91151.0, 91326.54336728273, 92563.53718231365, 92668.53665731628, 93503.0, 11478.253913495597, 11794.823077654013, 11919.52321907114, 11920.940395298316, 12196.146269761386, 13262.33688315561, 13308.800367994681, 13362.465501379836, 13654.590362289147, 13701.657458563615, 9409.576569054547, 11048.834267485834, 11355.0, 11647.534098635959, 11740.706482337668, 8966.0, 10604.363738175734, 10640.733981650521, 10674.306170098918, 10730.89269107299, 9487.715368538955, 11439.370834604177, 11650.88349116498, 11731.41342932867, 11794.646160615195, 11668.474918628512, 11704.94147529257, 11826.645200643994, 11867.821982670093, 12057.698557536132, 11251.268667536584, 11471.770564588829, 11576.073914086684, 11637.5344986203, 11740.941295293469], "value": 11724.587406716177, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1253.6301790971663, 1266.7466506698656, 1364.8671602569875, 1492.932818023189, 1577.1089334525996, 9478.336516443851, 10712.46437678116, 10960.068394186485, 11315.547378104866, 11468.48391822368, 11067.612633557826, 11094.389808560525, 11230.775384492305, 11236.66290011299, 11255.155863310243, 2372.667826504295, 2413.034786085571, 2415.5651982643117, 2416.794572461343, 2423.2245681381964, 2318.9536209275802, 2404.338806828119, 2442.987785061081, 2443.814749846323, 2445.303088619744, 2138.540213854021, 2322.85018915637, 2356.893939772706, 2441.218809980807, 2443.8778061096873, 2351.7177938647474, 2383.1301574925114, 2403.459221675118, 2408.4701365699516, 2437.8659173745436, 2326.3835083702834, 2393.1384701507445, 2401.6997875265592, 2404.675368825221, 2424.684790977179, 11341.546338146465, 11383.886161138365, 11385.316880987168, 11441.0, 11453.770924581546, 5925.585209035369, 6097.69511524422, 6099.207103076572, 6105.755769769248, 6106.3893610639025, 2784.693683694812, 3601.6673830682553, 3702.629737026303, 3794.772313661189, 3798.90502737431, 1209.6492017315056, 1218.3299185447968, 1252.0484431831874, 1255.8241846141548, 1262.236347010064, 13774.517891873737, 14004.22976736279, 15133.470328538559, 15798.605034874105, 15935.964162329412, 4716.551927566876, 4724.669273150916, 4764.040911537774, 4855.562999330006, 4877.219644856806, 11800.704982375337, 11872.22830516031, 11971.102167337485, 11982.460789264504, 11998.880011199952, 5817.476427121579, 5929.73316200772, 5934.910976335358, 5942.316633587193, 5955.464008239279, 5142.948570514322, 5363.678179309254, 5370.355557333067, 5380.488853558905, 5470.097433923438, 3885.417187421909, 4001.3197756381487, 4023.959760402417, 4090.5909409058854, 4094.488188976378, 1052.1214785653913, 1054.4604876879841, 1060.5121644043827, 1067.989320106789, 1074.3607553505651, 819.1317203764029, 940.7789169545151, 951.286535098676, 971.455984648585, 1013.9188864890791, 5654.349749778746, 6640.0, 6837.726490940406, 6878.484113691493, 6997.825054373681, 964.8070385922844, 1003.5684655598163, 1012.3520946594185, 1012.3925644613173, 1070.8126077936486, 4183.226103170923, 4334.523202447728, 4340.590972010501, 4421.9336709949375, 4566.70316429431, 10105.797884042426, 14111.717765644835, 14114.364853581614, 14119.64700882486, 14120.22338771357, 12254.326012069243, 13639.454421823215, 13968.860311396958, 14050.718985620231, 14085.15489070659, 8792.824143516966, 9747.756306092262, 10074.244431667654, 10317.019883111092, 10588.364698118137, 5434.918476222939, 5528.723563821713, 6280.591761535486, 6577.80266592003, 6678.365555272241, 12321.07591930591, 12330.876691232972, 12396.194247373893, 12415.44130514111, 12435.689107772016, 10114.494275286354, 12453.066020048715, 12516.561920332744, 12555.183913045623, 12878.67803304925, 7856.764297071097, 9349.719508414759, 9421.858672119786, 9422.29332800029, 9552.57013434411, 10325.225608079274, 10399.480025998519, 10405.323653962469, 10494.68515944523, 10525.9473702631, 8926.419782714363, 8930.464172149692, 8962.058983806606, 9064.320175986959, 9198.03420640823, 8767.649294028168, 8797.912020879965, 8827.955860220658, 8885.155910188521, 8919.063498332842, 7912.84174316522, 7944.880826787487, 7961.920380796118, 8025.0, 8045.195480451908, 5921.970390148022, 5938.8218353449465, 6005.099235114593, 6044.667543285162, 6177.598456100339, 5927.0, 6079.787207447718, 6146.877062458636, 6159.384061593805, 6203.596766210182], "value": 5161.386372575139, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.34972876669946, 366.4100797715677, 375.271972373595, 384.39457853880145, 392.93122706239035, 4798.5441383068555, 4955.15078829673, 5057.760848592091, 5071.123684236837, 5087.982403519292, 4326.718763280384, 5000.0, 5123.257127716479, 5155.690658560489, 5216.7913283468615, 4467.374567560536, 4487.730736155841, 4497.14554234696, 4510.481294651108, 4533.9319910201375, 3825.827837747308, 4048.7044145873333, 4074.470318858559, 4414.29371300592, 4554.476235232941, 3766.303233901737, 3766.871717479629, 4095.6313931746135, 4480.775961201927, 4484.304932735431, 3749.212665340282, 4060.4924384451942, 4425.782909699826, 4492.438445194351, 4509.954900451019, 3966.3852102924093, 4005.83976640934, 4263.552327005682, 4312.374705667692, 4339.414179085815, 4852.320675105488, 5022.271770593244, 5024.9748751256375, 5028.7988480460735, 5037.722925239111, 4604.194266003436, 4892.0705066037335, 5035.62232832539, 5308.0, 5347.331583552056, 4584.610308123813, 4812.593703148425, 5049.873753156164, 5185.274061631375, 5644.294463192101, 4569.0, 4773.570378665937, 4779.160023391019, 4816.95183048172, 4869.634777391674, 5694.84956247252, 5706.258186435737, 5807.477327040544, 5857.456238975444, 5858.882822343529, 4466.03980144264, 4713.10451014313, 4731.739754313477, 4883.4628190898975, 4980.9080186321835, 4553.749543775124, 4765.4996225395835, 5145.434002259748, 5179.637425380187, 5208.583313334924, 4638.327442520816, 4864.902701946012, 5066.518680725399, 5276.472352764769, 5315.415304316522, 4660.533946605312, 5446.945530544723, 5687.630304030225, 5694.0, 5694.4590263924865, 1607.1964017991004, 1635.8691304695597, 1754.079108468039, 1755.4119370010933, 1776.5913839816915, 1300.9089363744447, 1432.6919712261913, 1439.5465428390023, 1444.8049513315777, 1482.4218554763436, 4496.132547026163, 4771.475137734847, 4954.603631709455, 4965.988774546315, 4989.5758860496535, 4944.579710724629, 5000.449950505442, 5059.848204553869, 5275.918436720463, 5815.360310365856, 4701.623870090384, 4968.900621987612, 5057.848264552069, 5132.948670513321, 5238.292830467914, 2502.273431332375, 2609.3346196719717, 2780.694123646397, 2821.929451763722, 3035.514317709156, 5322.893542129135, 5406.4321346809775, 5717.559723986764, 5927.170196172539, 6059.545534084873, 4722.6221902247735, 4933.990265937775, 5193.428722840485, 5294.629375943647, 5747.770089196469, 5323.087530665036, 5571.247881536103, 5694.515966142924, 5960.284765828128, 5989.490893274121, 4298.720583162084, 5346.759395827275, 5739.368669446274, 5806.593538452268, 5806.622569532967, 4781.354517140281, 4860.878478038077, 4920.40955085392, 5572.60991730575, 5662.915056274077, 4905.632077594266, 5273.829619345452, 5727.422659803022, 5740.555666600007, 5916.911246331395, 4207.032382551969, 4475.455967691141, 4686.437627484724, 4908.233036106927, 4919.376605720176, 4986.351774269322, 5245.554127899019, 5376.817100237941, 5580.832575022756, 5683.7442315095095, 4930.309756634146, 5003.249512573143, 5477.424870388551, 5505.917411238915, 5544.0, 4694.953050469451, 4865.9026819464125, 5125.846224613268, 5352.277442545363, 5551.861203469945, 5115.516500215045, 5303.443138470405, 5330.227117068081, 5441.83674489766, 5445.175866084906, 5204.193350030751, 5645.350784659817, 5647.237622920853, 5649.491545760901, 5651.632643878134, 5127.87180320495, 5430.945690543202, 5526.159319273067, 5554.50009499147, 5559.33288005442], "value": 4308.149330834574, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [704.5134765644492, 722.093772315744, 730.1894896664702, 784.5018413307548, 864.948103113813, 15083.095014299137, 16343.91828040861, 16347.182640867939, 16353.264103115374, 16414.261358238877, 11779.469923853425, 14848.851511484881, 14982.175980321104, 15075.246237688127, 15201.315940782664, 895.373238732888, 915.922146617535, 920.8572671235969, 927.0266220468515, 927.661403587689, 900.8288425199224, 926.967556135532, 927.0544045074021, 929.1962452478591, 930.1814403325064, 979.7256768104942, 991.6281394477071, 992.4293531219541, 999.2206079258154, 1003.5283416794096, 987.501311837521, 996.8355221388463, 997.8004399120205, 999.0858364596386, 999.3054826895311, 741.7922981565171, 742.109468637637, 743.5575832379725, 743.6207534157564, 746.6863917154808, 16446.506604801874, 16476.0, 16679.749803752955, 16698.83301166985, 16849.91575042117, 14133.646658833508, 14149.504767333197, 14197.290135493184, 14398.496052638213, 14405.567832965027, 11674.182807203499, 11720.648380548597, 11759.529618815322, 11872.465739041763, 11945.343006134659, 3458.602260740022, 3631.2555926035097, 3663.688586470153, 3685.1155722626645, 3725.1432170600915, 82822.17177828205, 97030.0, 104132.0, 104480.0, 104775.99999999924, 10389.013043760831, 10598.0, 10637.9468102659, 10677.51951162184, 10814.78370432587, 20688.965551722355, 20938.895305523376, 20972.951352432316, 21030.789692102884, 21119.0, 7459.291367320096, 7538.0954285484995, 7566.583837888969, 7635.885461718079, 7726.9227307726205, 3890.4553362528704, 4193.811278492475, 4216.072464057902, 4267.64227966463, 4377.671674624416, 3440.501127336572, 3504.649535046526, 3507.9298414031578, 3526.682598566141, 3601.585817631006, 679.5548915460381, 685.2359619024752, 689.5276735436242, 697.316629702894, 697.6337422852941, 674.1404708995972, 675.4765057080801, 700.2752151523149, 705.6401235369896, 724.1635910523248, 10042.19662427004, 10084.546195421224, 10128.240381971234, 10314.896851031544, 10483.37099774016, 705.5942832871119, 711.8540699156661, 713.8001359619315, 717.6519388096768, 720.8738470767595, 4538.72767633943, 4697.694649847749, 4946.62900282473, 4957.876053098701, 4985.925211121836, 87976.0, 90434.54782726044, 90906.0, 96385.51807240919, 101061.49469252607, 49964.0, 56528.58678532987, 65435.0, 72712.4550640725, 84725.31088883757, 73573.63213184007, 77056.61471692605, 78023.60988195136, 78428.0, 79172.60413697895, 10455.790884182426, 10743.785124297627, 10834.133269338592, 10837.295575787548, 10967.341959482457, 31046.0686179415, 50020.0, 51071.74464127656, 51383.45849624517, 52733.47266527286, 63135.0, 65166.0, 65669.67165164143, 66401.33598663952, 66868.66565667141, 12354.567590134302, 12413.44139513706, 12574.49702011946, 12600.810987835373, 13053.34733263314, 14377.928110359382, 14395.280235988368, 14711.852881471048, 14925.776113358526, 15210.014627884195, 13207.273599952096, 13817.240051796845, 13871.86128138746, 14335.92832035833, 14599.197044162673, 13077.280749558866, 13812.516561920285, 13967.650808729863, 14006.43974241019, 14481.0, 10624.946875265574, 11046.668599941693, 11072.723181920517, 11078.833817492905, 11425.657230283105, 9151.0, 9281.443113413217, 9425.764355891157, 9534.475603841578, 9717.854232186664, 10130.290879638354, 10473.416312084892, 10980.945095274792, 11007.944960275147, 11021.83467247976], "value": 7485.083663227046, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1541.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 115.0, 162.0, 178.0, 163.0, 121.0, 118.0, 120.0, 119.0, 116.0], "value": 135.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 138.0, 97.0, 180.0, 97.0, 100.0, 113.0, 98.0, 149.0, 144.0], "value": 127.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 195.0, 193.0, 195.0, 200.0, 193.0, 195.0, 195.0, 199.0, 196.0], "value": 195.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 64.0, 63.0, 86.0, 67.0, 62.0, 63.0, 63.0, 74.0, 61.0], "value": 68.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 71.0, 86.0, 71.0, 73.0, 70.0, 82.0, 73.0, 88.0, 113.0], "value": 81.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 90.0, 89.0, 91.0, 93.0, 121.0, 136.0, 91.0, 92.0, 89.0], "value": 98.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 114.0, 99.0, 115.0, 98.0, 98.0, 100.0, 97.0, 98.0, 156.0], "value": 107.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 94.0, 86.0, 90.0, 119.0, 91.0, 146.0, 90.0, 90.0, 132.0], "value": 102.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 69.0, 82.0, 108.0, 108.0, 108.0, 74.0, 69.0, 70.0], "value": 82.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 65.0, 66.0, 64.0, 58.0, 60.0, 58.0, 61.0, 63.0], "value": 61.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 88.0, 84.0, 94.0, 105.0, 96.0, 84.0, 83.0, 83.0, 90.0], "value": 88.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 133.0, 137.0, 140.0, 140.0, 141.0, 142.0, 144.0, 182.0, 138.0], "value": 143.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 172.0, 169.0, 168.0, 174.0, 169.0, 173.0, 174.0, 208.0, 170.0], "value": 174.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 63.0, 70.0, 68.0, 78.0, 86.0, 90.0, 85.0], "value": 73.9, "unit": "score"}]}]} 21:34:42 INFO - Return code: 0 21:34:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:34:42 ERROR - # TBPL SUCCESS # 21:34:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:34:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:34:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:34:42 INFO - 2017-04-11 21:34:42.289 screenresolution[1655:10571] starting screenresolution argv=screenresolution get 21:34:42 INFO - 2017-04-11 21:34:42.292 screenresolution[1655:10571] Display 0: 1600x1200x32@60 21:34:42 INFO - 2017-04-11 21:34:42.297 screenresolution[1656:10574] starting screenresolution argv=screenresolution list 21:34:42 INFO - Available Modes on Display 0 21:34:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:34:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:34:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:34:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:34:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:34:42 INFO - Intel Iris: 21:34:42 INFO - Chipset Model: Intel Iris 21:34:42 INFO - Type: GPU 21:34:42 INFO - Bus: Built-In 21:34:42 INFO - VRAM (Dynamic, Max): 1536 MB 21:34:42 INFO - Vendor: Intel (0x8086) 21:34:42 INFO - Device ID: 0x0a2e 21:34:42 INFO - Revision ID: 0x0009 21:34:42 INFO - Displays: 21:34:42 INFO - Display: 21:34:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:34:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:34:42 INFO - Display Serial Number: 1600x1200 60 21:34:42 INFO - Main Display: Yes 21:34:42 INFO - Mirror: Off 21:34:42 INFO - Online: Yes 21:34:42 INFO - Rotation: Supported 21:34:42 INFO - Return code: 0 21:34:42 INFO - Running post-action listener: _resource_record_post_action 21:34:42 INFO - [mozharness: 2017-04-12 04:34:42.543341Z] Finished run-tests step (success) 21:34:42 INFO - Running post-run listener: _resource_record_post_run 21:34:42 INFO - Total resource usage - Wall time: 1200s; CPU: 55.0%; Read bytes: 40483328; Write bytes: 513443328; Read time: 399; Write time: 1703 21:34:42 INFO - TinderboxPrint: CPU usage
54.5% 21:34:42 INFO - TinderboxPrint: I/O read bytes / time
40,483,328 / 399 21:34:42 INFO - TinderboxPrint: I/O write bytes / time
513,443,328 / 1,703 21:34:42 INFO - TinderboxPrint: CPU idle
2,183.8 (45.5%) 21:34:42 INFO - TinderboxPrint: CPU system
964.2 (20.1%) 21:34:42 INFO - TinderboxPrint: CPU user
1,653.7 (34.4%) 21:34:42 INFO - TinderboxPrint: Swap in / out
247,939,072 / 0 21:34:42 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 201851392; Write bytes: 202180608; Read time: 15614; Write time: 399 21:34:42 INFO - run-tests - Wall time: 1180s; CPU: 55.0%; Read bytes: 38611456; Write bytes: 300424704; Read time: 373; Write time: 1269 21:34:43 INFO - Running post-run listener: _upload_blobber_files 21:34:43 INFO - Blob upload gear active. 21:34:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:34:43 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 21:34:43 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'] 21:34:43 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 21:34:43 INFO - (blobuploader) - INFO - Open directory for files ... 21:34:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:34:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:34:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:34:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:34:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:34:44 INFO - (blobuploader) - INFO - Done attempting. 21:34:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:34:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:34:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:34:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:34:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:34:45 INFO - (blobuploader) - INFO - Done attempting. 21:34:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 21:34:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:34:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:34:46 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 21:34:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:34:46 INFO - (blobuploader) - INFO - Done attempting. 21:34:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:34:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:34:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:34:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:34:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:34:48 INFO - (blobuploader) - INFO - Done attempting. 21:34:48 INFO - (blobuploader) - INFO - Iteration through files over. 21:34:48 INFO - Return code: 0 21:34:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:34:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:34:48 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3d42d35a9079876915318d50f65f388400eaab595cd376c675717bf944158f6d82c7f545f8d38a7ed3c5be44a7dd0bdd175110a3fc3cb2eb742005df8da405bc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ea2be1f6a8d6f7068948c70d8f169682157a3e24d97d9c2f93f946195cbbae03a2a85c0b3238e905de697e34b161448b22e14f58c46a013fde9bfeddf943a1bf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1605d442d446f46f0784f81dc07f457d66251c23f64b48ab0ef8426b593289ddf7ed5698fd13041a6e40e8f650b1b4fdaa73c60ef93f773fc17102c0922f5fba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/558c677ad76d19f7dc2add92274f5b517b1821b0b4661074ec9caae15e8c367e506d04856490b76a31fc743b9b4f7719a673b216e0dfedfeb3227168a317f0b7"} 21:34:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:34:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:34:48 INFO - Contents: 21:34:48 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3d42d35a9079876915318d50f65f388400eaab595cd376c675717bf944158f6d82c7f545f8d38a7ed3c5be44a7dd0bdd175110a3fc3cb2eb742005df8da405bc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ea2be1f6a8d6f7068948c70d8f169682157a3e24d97d9c2f93f946195cbbae03a2a85c0b3238e905de697e34b161448b22e14f58c46a013fde9bfeddf943a1bf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1605d442d446f46f0784f81dc07f457d66251c23f64b48ab0ef8426b593289ddf7ed5698fd13041a6e40e8f650b1b4fdaa73c60ef93f773fc17102c0922f5fba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/558c677ad76d19f7dc2add92274f5b517b1821b0b4661074ec9caae15e8c367e506d04856490b76a31fc743b9b4f7719a673b216e0dfedfeb3227168a317f0b7"} 21:34:48 INFO - Running post-run listener: copy_logs_to_upload_dir 21:34:48 INFO - Copying logs to upload dir... 21:34:48 INFO - mkdir: /builds/slave/test/build/upload/logs 21:34:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.262089 ========= master_lag: 0.20 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-04-11 21:34:48.316067) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-11 21:34:48.325360) ========= 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.vVoAQeLDXY/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.gLfCUIOMOL/Listeners TMPDIR=/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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/3d42d35a9079876915318d50f65f388400eaab595cd376c675717bf944158f6d82c7f545f8d38a7ed3c5be44a7dd0bdd175110a3fc3cb2eb742005df8da405bc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ea2be1f6a8d6f7068948c70d8f169682157a3e24d97d9c2f93f946195cbbae03a2a85c0b3238e905de697e34b161448b22e14f58c46a013fde9bfeddf943a1bf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1605d442d446f46f0784f81dc07f457d66251c23f64b48ab0ef8426b593289ddf7ed5698fd13041a6e40e8f650b1b4fdaa73c60ef93f773fc17102c0922f5fba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/558c677ad76d19f7dc2add92274f5b517b1821b0b4661074ec9caae15e8c367e506d04856490b76a31fc743b9b4f7719a673b216e0dfedfeb3227168a317f0b7"} build_url:https://queue.taskcluster.net/v1/task/NZH_8-2ARTmp4eH0FKwqCw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011112 build_url: 'https://queue.taskcluster.net/v1/task/NZH_8-2ARTmp4eH0FKwqCw/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/3d42d35a9079876915318d50f65f388400eaab595cd376c675717bf944158f6d82c7f545f8d38a7ed3c5be44a7dd0bdd175110a3fc3cb2eb742005df8da405bc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ea2be1f6a8d6f7068948c70d8f169682157a3e24d97d9c2f93f946195cbbae03a2a85c0b3238e905de697e34b161448b22e14f58c46a013fde9bfeddf943a1bf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1605d442d446f46f0784f81dc07f457d66251c23f64b48ab0ef8426b593289ddf7ed5698fd13041a6e40e8f650b1b4fdaa73c60ef93f773fc17102c0922f5fba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/558c677ad76d19f7dc2add92274f5b517b1821b0b4661074ec9caae15e8c367e506d04856490b76a31fc743b9b4f7719a673b216e0dfedfeb3227168a317f0b7"}' ========= master_lag: 0.33 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-11 21:34:48.664098) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 21:34:48.664419) ========= 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.vVoAQeLDXY/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.gLfCUIOMOL/Listeners TMPDIR=/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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.005347 ========= master_lag: 0.03 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 21:34:48.702040) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-11 21:34:48.702365) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-11 21:34:48.702750) ========= ========= Total master_lag: 0.63 =========