builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0320 starttime: 1491667595.13 results: success (0) buildid: 20170408075421 builduid: d9bc240c7b7d4d7599d809cb0863dddc revision: 794adb67ec4a6d8ebcf786c9b9a0d8207bd5b2c4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-08 09:06:35.133000) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-08 09:06:35.133450) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-08 09:06:35.133747) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-08 09:06:35.160399) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-08 09:06:35.160796) ========= 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.prrqYMnQLF/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.eYswjMDGlB/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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-08 09:06:35-- 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% 59.3M=0s 2017-04-08 09:06:35 (59.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.634718 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-08 09:06:35.819673) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-08 09:06:35.820012) ========= 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.prrqYMnQLF/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.eYswjMDGlB/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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.034356 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-08 09:06:35.878445) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-08 09:06:35.878771) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 794adb67ec4a6d8ebcf786c9b9a0d8207bd5b2c4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 794adb67ec4a6d8ebcf786c9b9a0d8207bd5b2c4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.prrqYMnQLF/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.eYswjMDGlB/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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-08 09:06:35,991 truncating revision to first 12 chars 2017-04-08 09:06:35,991 Setting DEBUG logging. 2017-04-08 09:06:35,991 attempt 1/10 2017-04-08 09:06:35,991 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/794adb67ec4a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-08 09:06:36,790 unpacking tar archive at: mozilla-central-794adb67ec4a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.080616 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-08 09:06:36.983449) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-08 09:06:36.983786) ========= script_repo_revision: 794adb67ec4a6d8ebcf786c9b9a0d8207bd5b2c4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-08 09:06:36.984250) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-08 09:06:36.984585) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-08 09:06:37.004387) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-04-08 09:06:37.004685) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.prrqYMnQLF/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.eYswjMDGlB/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 09:06:37 INFO - MultiFileLogger online at 20170408 09:06:37 in /builds/slave/test 09:06:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 09:06:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:06:37 INFO - {'append_to_log': False, 09:06:37 INFO - 'base_work_dir': '/builds/slave/test', 09:06:37 INFO - 'blob_upload_branch': 'Firefox', 09:06:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:06:37 INFO - 'branch': 'Firefox', 09:06:37 INFO - 'buildbot_json_path': 'buildprops.json', 09:06:37 INFO - 'config_files': ('talos/mac_config.py',), 09:06:37 INFO - 'default_actions': ('clobber', 09:06:37 INFO - 'read-buildbot-config', 09:06:37 INFO - 'download-and-extract', 09:06:37 INFO - 'populate-webroot', 09:06:37 INFO - 'create-virtualenv', 09:06:37 INFO - 'install', 09:06:37 INFO - 'run-tests'), 09:06:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:06:37 INFO - 'download_minidump_stackwalk': True, 09:06:37 INFO - 'download_symbols': 'ondemand', 09:06:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:06:37 INFO - 'tooltool.py': '/tools/tooltool.py', 09:06:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:06:37 INFO - '/tools/misc-python/virtualenv.py')}, 09:06:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:06:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:06:37 INFO - 'gecko_profile': False, 09:06:37 INFO - 'gecko_profile_interval': 0, 09:06:37 INFO - 'installer_path': 'installer.exe', 09:06:37 INFO - 'log_level': 'info', 09:06:37 INFO - 'log_name': 'talos', 09:06:37 INFO - 'log_to_console': True, 09:06:37 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:06:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:06:37 INFO - 'opt_config_files': (), 09:06:37 INFO - 'pip_index': False, 09:06:37 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:06:37 INFO - 'cmd': ('bash', 09:06:37 INFO - '-c', 09:06:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:06:37 INFO - 'enabled': True, 09:06:37 INFO - 'halt_on_failure': False, 09:06:37 INFO - 'name': 'check_screen_resolution'},), 09:06:37 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:06:37 INFO - 'cmd': ('bash', 09:06:37 INFO - '-c', 09:06:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:06:37 INFO - 'enabled': True, 09:06:37 INFO - 'halt_on_failure': False, 09:06:37 INFO - 'name': 'check_screen_resolution'},), 09:06:37 INFO - 'run_cmd_checks_enabled': True, 09:06:37 INFO - 'suite': 'dromaeojs-e10s', 09:06:37 INFO - 'system_bits': '32', 09:06:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:06:37 INFO - 'title': 't-yosemite-r7-0320', 09:06:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:06:37 INFO - 'use_talos_json': True, 09:06:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:06:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:06:37 INFO - 'work_dir': 'build'} 09:06:37 INFO - [mozharness: 2017-04-08 16:06:37.225470Z] Running clobber step. 09:06:37 INFO - Running pre-action listener: _resource_record_pre_action 09:06:37 INFO - Running main action method: clobber 09:06:37 INFO - rmtree: /builds/slave/test/build 09:06:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:06:39 INFO - Running post-action listener: _resource_record_post_action 09:06:39 INFO - [mozharness: 2017-04-08 16:06:39.729548Z] Finished clobber step (success) 09:06:39 INFO - [mozharness: 2017-04-08 16:06:39.729673Z] Running read-buildbot-config step. 09:06:39 INFO - Running pre-action listener: _resource_record_pre_action 09:06:39 INFO - Running main action method: read_buildbot_config 09:06:39 INFO - Using buildbot properties: 09:06:39 INFO - { 09:06:39 INFO - "project": "", 09:06:39 INFO - "product": "firefox", 09:06:39 INFO - "script_repo_revision": "production", 09:06:39 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 09:06:39 INFO - "repository": "", 09:06:39 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 09:06:39 INFO - "buildid": "20170408075421", 09:06:39 INFO - "pgo_build": "False", 09:06:39 INFO - "basedir": "/builds/slave/test", 09:06:39 INFO - "buildnumber": 17, 09:06:39 INFO - "slavename": "t-yosemite-r7-0320", 09:06:39 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 09:06:39 INFO - "platform": "yosemite_r7", 09:06:39 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 09:06:39 INFO - "branch": "mozilla-central", 09:06:39 INFO - "repo_path": "mozilla-central", 09:06:39 INFO - "revision": "794adb67ec4a6d8ebcf786c9b9a0d8207bd5b2c4", 09:06:39 INFO - "stage_platform": "macosx64", 09:06:39 INFO - "builduid": "d9bc240c7b7d4d7599d809cb0863dddc", 09:06:39 INFO - "slavebuilddir": "test" 09:06:39 INFO - } 09:06:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/EcasZOetREOO4XVgNywWvg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 09:06:39 INFO - Running post-action listener: _resource_record_post_action 09:06:39 INFO - [mozharness: 2017-04-08 16:06:39.732938Z] Finished read-buildbot-config step (success) 09:06:39 INFO - [mozharness: 2017-04-08 16:06:39.733085Z] Running download-and-extract step. 09:06:39 INFO - Running pre-action listener: _resource_record_pre_action 09:06:39 INFO - Running main action method: download_and_extract 09:06:39 INFO - mkdir: /builds/slave/test/build/tests 09:06:39 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')]} 09:06:39 INFO - trying https://queue.taskcluster.net/v1/task/EcasZOetREOO4XVgNywWvg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 09:06:39 INFO - Downloading https://queue.taskcluster.net/v1/task/EcasZOetREOO4XVgNywWvg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 09:06:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EcasZOetREOO4XVgNywWvg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 09:06:41 INFO - Downloaded 1325 bytes. 09:06:41 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 09:06:41 INFO - Using the following test package requirements: 09:06:41 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:06:41 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 09:06:41 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 09:06:41 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:06:41 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 09:06:41 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:06:41 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 09:06:41 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:06:41 INFO - u'jsshell-mac.zip'], 09:06:41 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:06:41 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 09:06:41 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 09:06:41 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:06:41 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 09:06:41 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:06:41 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 09:06:41 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:06:41 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 09:06:41 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:06:41 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 09:06:41 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:06:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EcasZOetREOO4XVgNywWvg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 09:06:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EcasZOetREOO4XVgNywWvg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:06:41 INFO - Fetch https://queue.taskcluster.net/v1/task/EcasZOetREOO4XVgNywWvg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 09:06:42 INFO - Expected file size: 52522719 09:06:42 INFO - Obtained file size: 52522719 09:06:58 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 09:06:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EcasZOetREOO4XVgNywWvg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 09:06:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EcasZOetREOO4XVgNywWvg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:06:58 INFO - Fetch https://queue.taskcluster.net/v1/task/EcasZOetREOO4XVgNywWvg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 09:07:00 INFO - Expected file size: 52522719 09:07:00 INFO - Obtained file size: 52522719 09:07:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EcasZOetREOO4XVgNywWvg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 09:07:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EcasZOetREOO4XVgNywWvg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:07:15 INFO - Fetch https://queue.taskcluster.net/v1/task/EcasZOetREOO4XVgNywWvg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 09:07:17 INFO - Expected file size: 14404138 09:07:17 INFO - Obtained file size: 14404138 09:07: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')]} 09:07:17 INFO - trying https://queue.taskcluster.net/v1/task/EcasZOetREOO4XVgNywWvg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:07:17 INFO - Downloading https://queue.taskcluster.net/v1/task/EcasZOetREOO4XVgNywWvg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 09:07:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EcasZOetREOO4XVgNywWvg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 09:07:19 INFO - Downloaded 70939076 bytes. 09:07:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EcasZOetREOO4XVgNywWvg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:07:19 INFO - mkdir: /builds/slave/test/properties 09:07:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:07:19 INFO - Writing to file /builds/slave/test/properties/build_url 09:07:19 INFO - Contents: 09:07:19 INFO - build_url:https://queue.taskcluster.net/v1/task/EcasZOetREOO4XVgNywWvg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:07:20 INFO - Running post-action listener: _resource_record_post_action 09:07:20 INFO - Running post-action listener: set_extra_try_arguments 09:07:20 INFO - [mozharness: 2017-04-08 16:07:20.318048Z] Finished download-and-extract step (success) 09:07:20 INFO - [mozharness: 2017-04-08 16:07:20.318196Z] Running populate-webroot step. 09:07:20 INFO - Running pre-action listener: _resource_record_pre_action 09:07:20 INFO - Running main action method: populate_webroot 09:07:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:07:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:07:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:07:20 INFO - '--tppagecycles', 09:07:20 INFO - '7'], 09:07:20 INFO - 'tests': ['tsvgm']}}, 09:07:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:07:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:07:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:07:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:07:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:07:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:07:20 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:07:20 INFO - 'talos_options': ['--disable-e10s'], 09:07:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:07:20 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:07:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:07:20 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:07:20 INFO - 'talos_options': ['--disable-e10s'], 09:07:20 INFO - 'tests': ['damp', 'tps']}, 09:07:20 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:07:20 INFO - 'tests': ['damp', 'tps']}, 09:07:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:07:20 INFO - 'tests': ['dromaeo_dom']}, 09:07:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:07:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:07:20 INFO - 'tests': ['basic_compositor_video']}, 09:07:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:07:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:07:20 INFO - 'tests': ['a11yr', 09:07:20 INFO - 'ts_paint', 09:07:20 INFO - 'tpaint', 09:07:20 INFO - 'sessionrestore', 09:07:20 INFO - 'sessionrestore_no_auto_restore', 09:07:20 INFO - 'tabpaint']}, 09:07:20 INFO - 'other-e10s': {'tests': ['a11yr', 09:07:20 INFO - 'ts_paint', 09:07:20 INFO - 'tpaint', 09:07:20 INFO - 'sessionrestore', 09:07:20 INFO - 'sessionrestore_no_auto_restore', 09:07:20 INFO - 'tabpaint']}, 09:07:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:07:20 INFO - 'ts_paint', 09:07:20 INFO - 'tpaint', 09:07:20 INFO - 'sessionrestore', 09:07:20 INFO - 'sessionrestore_no_auto_restore', 09:07:20 INFO - 'tabpaint']}, 09:07:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:07:20 INFO - 'ts_paint', 09:07:20 INFO - 'tpaint', 09:07:20 INFO - 'sessionrestore', 09:07:20 INFO - 'sessionrestore_no_auto_restore', 09:07:20 INFO - 'tabpaint']}, 09:07:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:07:20 INFO - 'tests': ['a11yr', 09:07:20 INFO - 'ts_paint', 09:07:20 INFO - 'tpaint', 09:07:20 INFO - 'sessionrestore', 09:07:20 INFO - 'sessionrestore_no_auto_restore', 09:07:20 INFO - 'tabpaint']}, 09:07:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:07:20 INFO - 'tests': ['a11yr', 09:07:20 INFO - 'ts_paint', 09:07:20 INFO - 'tpaint', 09:07:20 INFO - 'sessionrestore', 09:07:20 INFO - 'sessionrestore_no_auto_restore', 09:07:20 INFO - 'tabpaint']}, 09:07:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:07:20 INFO - 'tests': ['tsvgx', 09:07:20 INFO - 'tsvgr_opacity', 09:07:20 INFO - 'tart', 09:07:20 INFO - 'tscrollx', 09:07:20 INFO - 'cart', 09:07:20 INFO - 'tsvg_static']}, 09:07:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:07:20 INFO - 'tsvgr_opacity', 09:07:20 INFO - 'tart', 09:07:20 INFO - 'tscrollx', 09:07:20 INFO - 'cart', 09:07:20 INFO - 'tsvg_static']}, 09:07:20 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:07:20 INFO - 'talos_options': ['--disable-e10s'], 09:07:20 INFO - 'tests': ['tp5o']}, 09:07:20 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:07:20 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:07:20 INFO - 'talos_options': ['--disable-e10s', 09:07:20 INFO - '--xperf_path', 09:07:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:07:20 INFO - 'tests': ['tp5n']}, 09:07:20 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:07:20 INFO - 'talos_options': ['--xperf_path', 09:07:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:07:20 INFO - 'tests': ['tp5n']}}, 09:07:20 INFO - 'talos.zip': {'path': '', 09:07:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:07:20 INFO - Running post-action listener: _resource_record_post_action 09:07:20 INFO - [mozharness: 2017-04-08 16:07:20.336290Z] Finished populate-webroot step (success) 09:07:20 INFO - [mozharness: 2017-04-08 16:07:20.336424Z] Running create-virtualenv step. 09:07:20 INFO - Running pre-action listener: _resource_record_pre_action 09:07:20 INFO - Running main action method: create_virtualenv 09:07:20 INFO - Creating virtualenv /builds/slave/test/build/venv 09:07:20 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 09:07:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:07:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:07:20 INFO - Using real prefix '/tools/python27' 09:07:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:07:21 INFO - Installing distribute.............................................................................................................................................................................................done. 09:07:24 INFO - Installing pip.................done. 09:07:24 INFO - Return code: 0 09:07:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:07:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:07:24 INFO - Reading from file tmpfile_stdout 09:07:24 INFO - Output received: 09:07:24 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) 09:07:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:07:24 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')]} 09:07:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:24 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')]} 09:07:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:24 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 0x10a45ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a45d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fccc85e43e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a238d30>, '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 0x10a15fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a22dbe8>, '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.prrqYMnQLF/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.eYswjMDGlB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 09:07:24 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 09:07:24 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 09:07:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.prrqYMnQLF/Render', 09:07:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:07:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:07:24 INFO - 'HOME': '/Users/cltbld', 09:07:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:07:24 INFO - 'LOGNAME': 'cltbld', 09:07:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:24 INFO - 'MOZ_NO_REMOTE': '1', 09:07:24 INFO - 'NO_EM_RESTART': '1', 09:07:24 INFO - 'PAGER': '/bin/cat', 09:07:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:07:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:24 INFO - 'PWD': '/builds/slave/test', 09:07:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:07:24 INFO - 'SHELL': '/bin/bash', 09:07:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eYswjMDGlB/Listeners', 09:07:24 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 09:07:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:07:24 INFO - 'USER': 'cltbld', 09:07:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:07:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:07:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:24 INFO - 'XPC_FLAGS': '0x0', 09:07:24 INFO - 'XPC_SERVICE_NAME': '0', 09:07:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:07:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:24 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 09:07:24 INFO - Cleaning up... 09:07:24 INFO - Return code: 0 09:07:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:07:24 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')]} 09:07:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:24 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')]} 09:07:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:24 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 0x10a45ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a45d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fccc85e43e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a238d30>, '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 0x10a15fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a22dbe8>, '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.prrqYMnQLF/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.eYswjMDGlB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 09:07:24 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 09:07:24 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 09:07:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.prrqYMnQLF/Render', 09:07:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:07:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:07:24 INFO - 'HOME': '/Users/cltbld', 09:07:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:07:24 INFO - 'LOGNAME': 'cltbld', 09:07:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:24 INFO - 'MOZ_NO_REMOTE': '1', 09:07:24 INFO - 'NO_EM_RESTART': '1', 09:07:24 INFO - 'PAGER': '/bin/cat', 09:07:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:07:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:24 INFO - 'PWD': '/builds/slave/test', 09:07:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:07:24 INFO - 'SHELL': '/bin/bash', 09:07:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eYswjMDGlB/Listeners', 09:07:24 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 09:07:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:07:24 INFO - 'USER': 'cltbld', 09:07:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:07:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:07:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:24 INFO - 'XPC_FLAGS': '0x0', 09:07:24 INFO - 'XPC_SERVICE_NAME': '0', 09:07:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:07:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:24 INFO - Downloading/unpacking psutil>=3.1.1 09:07:24 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 09:07:24 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 09:07:24 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 09:07:24 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 09:07:24 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 09:07:24 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 09:07:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:07:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:07:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:07:28 INFO - Installing collected packages: psutil 09:07:28 INFO - Running setup.py install for psutil 09:07:28 INFO - building 'psutil._psutil_osx' extension 09:07:28 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 09:07:29 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 09:07:29 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 09:07:29 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 09:07:29 INFO - building 'psutil._psutil_posix' extension 09:07:29 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 09:07:29 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:07:29 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:07:29 INFO - ^ 09:07:29 INFO - 1 warning generated. 09:07:29 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 09:07:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:07:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:07:29 INFO - Successfully installed psutil 09:07:29 INFO - Cleaning up... 09:07:29 INFO - Return code: 0 09:07:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:07:29 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')]} 09:07:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:29 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')]} 09:07:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:29 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 0x10a45ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a45d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fccc85e43e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a238d30>, '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 0x10a15fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a22dbe8>, '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.prrqYMnQLF/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.eYswjMDGlB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 09:07:29 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 09:07:29 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 09:07:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.prrqYMnQLF/Render', 09:07:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:07:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:07:29 INFO - 'HOME': '/Users/cltbld', 09:07:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:07:29 INFO - 'LOGNAME': 'cltbld', 09:07:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:29 INFO - 'MOZ_NO_REMOTE': '1', 09:07:29 INFO - 'NO_EM_RESTART': '1', 09:07:29 INFO - 'PAGER': '/bin/cat', 09:07:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:07:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:29 INFO - 'PWD': '/builds/slave/test', 09:07:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:07:29 INFO - 'SHELL': '/bin/bash', 09:07:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eYswjMDGlB/Listeners', 09:07:29 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 09:07:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:07:29 INFO - 'USER': 'cltbld', 09:07:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:07:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:07:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:29 INFO - 'XPC_FLAGS': '0x0', 09:07:29 INFO - 'XPC_SERVICE_NAME': '0', 09:07:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:07:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:07:30 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 09:07:30 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 09:07:30 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 09:07:30 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 09:07:30 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 09:07:30 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 09:07:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:07:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:07:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:07:32 INFO - Installing collected packages: mozsystemmonitor 09:07:32 INFO - Running setup.py install for mozsystemmonitor 09:07:33 INFO - Successfully installed mozsystemmonitor 09:07:33 INFO - Cleaning up... 09:07:33 INFO - Return code: 0 09:07:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:07:33 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')]} 09:07:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:33 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')]} 09:07:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:33 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 0x10a45ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a45d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fccc85e43e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a238d30>, '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 0x10a15fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a22dbe8>, '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.prrqYMnQLF/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.eYswjMDGlB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 09:07:33 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 09:07:33 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 09:07:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.prrqYMnQLF/Render', 09:07:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:07:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:07:33 INFO - 'HOME': '/Users/cltbld', 09:07:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:07:33 INFO - 'LOGNAME': 'cltbld', 09:07:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:33 INFO - 'MOZ_NO_REMOTE': '1', 09:07:33 INFO - 'NO_EM_RESTART': '1', 09:07:33 INFO - 'PAGER': '/bin/cat', 09:07:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:07:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:33 INFO - 'PWD': '/builds/slave/test', 09:07:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:07:33 INFO - 'SHELL': '/bin/bash', 09:07:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eYswjMDGlB/Listeners', 09:07:33 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 09:07:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:07:33 INFO - 'USER': 'cltbld', 09:07:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:07:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:07:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:33 INFO - 'XPC_FLAGS': '0x0', 09:07:33 INFO - 'XPC_SERVICE_NAME': '0', 09:07:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:07:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:33 INFO - Downloading/unpacking jsonschema==2.5.1 09:07:33 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 09:07:33 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 09:07:33 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 09:07:33 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 09:07:33 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 09:07:33 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 09:07:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:07:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:07:36 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 09:07:36 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 09:07:36 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 09:07:36 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 09:07:36 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 09:07:36 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 09:07:36 INFO - Downloading functools32-3.2.3-2.tar.gz 09:07:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:07:36 INFO - warning: no files found matching '*.txt' 09:07:36 INFO - no previously-included directories found matching 'build' 09:07:36 INFO - no previously-included directories found matching 'dist' 09:07:36 INFO - no previously-included directories found matching '.git*' 09:07:36 INFO - Installing collected packages: jsonschema, functools32 09:07:36 INFO - Running setup.py install for functools32 09:07:36 INFO - warning: no files found matching '*.txt' 09:07:36 INFO - no previously-included directories found matching 'build' 09:07:36 INFO - no previously-included directories found matching 'dist' 09:07:36 INFO - no previously-included directories found matching '.git*' 09:07:36 INFO - Successfully installed jsonschema functools32 09:07:36 INFO - Cleaning up... 09:07:36 INFO - Return code: 0 09:07:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:07:36 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')]} 09:07:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:36 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')]} 09:07:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:36 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 0x10a45ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a45d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fccc85e43e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a238d30>, '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 0x10a15fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a22dbe8>, '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.prrqYMnQLF/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.eYswjMDGlB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 09:07:36 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 09:07:36 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 09:07:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.prrqYMnQLF/Render', 09:07:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:07:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:07:36 INFO - 'HOME': '/Users/cltbld', 09:07:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:07:36 INFO - 'LOGNAME': 'cltbld', 09:07:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:36 INFO - 'MOZ_NO_REMOTE': '1', 09:07:36 INFO - 'NO_EM_RESTART': '1', 09:07:36 INFO - 'PAGER': '/bin/cat', 09:07:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:07:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:36 INFO - 'PWD': '/builds/slave/test', 09:07:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:07:36 INFO - 'SHELL': '/bin/bash', 09:07:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eYswjMDGlB/Listeners', 09:07:36 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 09:07:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:07:36 INFO - 'USER': 'cltbld', 09:07:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:07:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:07:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:36 INFO - 'XPC_FLAGS': '0x0', 09:07:36 INFO - 'XPC_SERVICE_NAME': '0', 09:07:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:07:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:07:37 INFO - Cleaning up... 09:07:37 INFO - Return code: 0 09:07:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:07:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:07:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:07:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:37 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 0x10a45ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a45d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fccc85e43e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a238d30>, '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 0x10a15fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a22dbe8>, '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.prrqYMnQLF/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.eYswjMDGlB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 09:07:37 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 09:07:37 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 09:07:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.prrqYMnQLF/Render', 09:07:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:07:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:07:37 INFO - 'HOME': '/Users/cltbld', 09:07:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:07:37 INFO - 'LOGNAME': 'cltbld', 09:07:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:37 INFO - 'MOZ_NO_REMOTE': '1', 09:07:37 INFO - 'NO_EM_RESTART': '1', 09:07:37 INFO - 'PAGER': '/bin/cat', 09:07:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:07:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:37 INFO - 'PWD': '/builds/slave/test', 09:07:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:07:37 INFO - 'SHELL': '/bin/bash', 09:07:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eYswjMDGlB/Listeners', 09:07:37 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 09:07:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:07:37 INFO - 'USER': 'cltbld', 09:07:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:07:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:07:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:37 INFO - 'XPC_FLAGS': '0x0', 09:07:37 INFO - 'XPC_SERVICE_NAME': '0', 09:07:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:07:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:37 INFO - Downloading/unpacking blobuploader==1.2.4 09:07: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 09:07: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 09:07: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 09:07: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 09:07: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 09:07: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 09:07:40 INFO - Downloading blobuploader-1.2.4.tar.gz 09:07:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:07:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:07:40 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 09:07:40 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 09:07:40 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 09:07:40 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 09:07:40 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 09:07:40 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 09:07:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:07:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:07:40 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 09:07:40 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 09:07:40 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 09:07:40 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 09:07:40 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 09:07:40 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 09:07:41 INFO - Downloading docopt-0.6.1.tar.gz 09:07:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:07:41 INFO - Installing collected packages: blobuploader, requests, docopt 09:07:41 INFO - Running setup.py install for blobuploader 09:07:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:07:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:07:41 INFO - Running setup.py install for requests 09:07:42 INFO - Running setup.py install for docopt 09:07:42 INFO - Successfully installed blobuploader requests docopt 09:07:42 INFO - Cleaning up... 09:07:42 INFO - Return code: 0 09:07:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:07:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:07:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:07:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:42 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 0x10a45ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a45d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fccc85e43e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a238d30>, '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 0x10a15fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a22dbe8>, '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.prrqYMnQLF/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.eYswjMDGlB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 09:07:42 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 09:07:42 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 09:07:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.prrqYMnQLF/Render', 09:07:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:07:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:07:42 INFO - 'HOME': '/Users/cltbld', 09:07:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:07:42 INFO - 'LOGNAME': 'cltbld', 09:07:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:42 INFO - 'MOZ_NO_REMOTE': '1', 09:07:42 INFO - 'NO_EM_RESTART': '1', 09:07:42 INFO - 'PAGER': '/bin/cat', 09:07:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:07:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:42 INFO - 'PWD': '/builds/slave/test', 09:07:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:07:42 INFO - 'SHELL': '/bin/bash', 09:07:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eYswjMDGlB/Listeners', 09:07:42 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 09:07:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:07:42 INFO - 'USER': 'cltbld', 09:07:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:07:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:07:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:42 INFO - 'XPC_FLAGS': '0x0', 09:07:42 INFO - 'XPC_SERVICE_NAME': '0', 09:07:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:07:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:07:42 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-iEafyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:07:42 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-Sz_vzI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:07:42 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-9eB_Sp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:07:42 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-mB7LL9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:07:42 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-eQE5vD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:07:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:07:43 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-9o1ClP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:07:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:07:43 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-HTi1Zy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:07:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:07:43 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-i2KkqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:07:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:07:43 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-23WsRi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:07:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:07:43 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-Jg1Y4Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:07:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:07:43 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-NQ2XKx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:07:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:07:43 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-YEJzH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:07:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:07:43 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-RiYv29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:07:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:07:43 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-RVQrgv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:07:44 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-OkHnOT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:07:44 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-NGSIQT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:07:44 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-7PzHyr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:07:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:07:44 INFO - Running setup.py install for manifestparser 09:07:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:07:44 INFO - Running setup.py install for mozcrash 09:07:44 INFO - Running setup.py install for mozdebug 09:07:44 INFO - Running setup.py install for mozdevice 09:07:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:07:44 INFO - Running setup.py install for mozfile 09:07:45 INFO - Running setup.py install for mozhttpd 09:07:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:07:45 INFO - Running setup.py install for mozinfo 09:07:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:07:45 INFO - Running setup.py install for mozInstall 09:07:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:07:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:07:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:07:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:07:45 INFO - Running setup.py install for mozleak 09:07:45 INFO - Running setup.py install for mozlog 09:07:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:07:45 INFO - Running setup.py install for moznetwork 09:07:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:07:45 INFO - Running setup.py install for mozprocess 09:07:46 INFO - Running setup.py install for mozprofile 09:07:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:07:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:07:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:07:46 INFO - Running setup.py install for mozrunner 09:07:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:07:46 INFO - Running setup.py install for mozscreenshot 09:07:46 INFO - Running setup.py install for moztest 09:07:46 INFO - Running setup.py install for mozversion 09:07:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:07:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:07:46 INFO - Cleaning up... 09:07:46 INFO - Return code: 0 09:07:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:07:46 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')]} 09:07:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:46 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')]} 09:07:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:46 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 0x10a45ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a45d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fccc85e43e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a238d30>, '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 0x10a15fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a22dbe8>, '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.prrqYMnQLF/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.eYswjMDGlB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 09:07:46 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 09:07:46 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 09:07:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.prrqYMnQLF/Render', 09:07:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:07:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:07:46 INFO - 'HOME': '/Users/cltbld', 09:07:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:07:46 INFO - 'LOGNAME': 'cltbld', 09:07:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:46 INFO - 'MOZ_NO_REMOTE': '1', 09:07:46 INFO - 'NO_EM_RESTART': '1', 09:07:46 INFO - 'PAGER': '/bin/cat', 09:07:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:07:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:46 INFO - 'PWD': '/builds/slave/test', 09:07:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:07:46 INFO - 'SHELL': '/bin/bash', 09:07:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eYswjMDGlB/Listeners', 09:07:46 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 09:07:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:07:46 INFO - 'USER': 'cltbld', 09:07:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:07:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:07:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:46 INFO - 'XPC_FLAGS': '0x0', 09:07:46 INFO - 'XPC_SERVICE_NAME': '0', 09:07:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:07:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:07:47 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-KaJp7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:07:47 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)) 09:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:07:47 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-G5QXGO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:07:47 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)) 09:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:07:47 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-yUJ8VA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:07:47 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)) 09:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:07:47 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-Cqmy6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:07:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 09:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:07:47 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-uOwMQv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:07:47 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)) 09:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:07:47 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-52zLGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:07:47 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)) 09:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:07:47 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-sRABQH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:07:47 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)) 09:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:07:47 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-FCfdTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:07:47 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)) 09:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:07:47 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-Gy83JA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:07:48 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)) 09:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:07:48 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-4DfVhC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:07:48 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)) 09:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:07:48 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-UpAIKI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:07:48 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)) 09:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:07:48 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-XvqPXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:07:48 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)) 09:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:07:48 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-iLAN4l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:07:48 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)) 09:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:07:48 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-86JzcV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:07:48 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)) 09:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:07:48 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-gwTzOC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:07:48 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)) 09:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:07:48 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-d0ix5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:07:48 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)) 09:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:07:48 INFO - Running setup.py (path:/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/pip-YMMCR1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:07:48 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)) 09:07:48 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)) 09:07:48 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)) 09:07:48 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)) 09:07:48 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:07:48 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:07:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:07:48 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 09:07:48 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 09:07:48 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 09:07:48 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 09:07:48 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 09:07:48 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 09:07:51 INFO - Downloading blessings-1.6.tar.gz 09:07:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:07:51 INFO - Installing collected packages: blessings 09:07:51 INFO - Running setup.py install for blessings 09:07:51 INFO - Successfully installed blessings 09:07:51 INFO - Cleaning up... 09:07:51 INFO - Return code: 0 09:07:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:07:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:07:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:07:52 INFO - Reading from file tmpfile_stdout 09:07:52 INFO - Current package versions: 09:07:52 INFO - blessings == 1.6 09:07:52 INFO - blobuploader == 1.2.4 09:07:52 INFO - docopt == 0.6.1 09:07:52 INFO - functools32 == 3.2.3-2 09:07:52 INFO - jsonschema == 2.5.1 09:07:52 INFO - manifestparser == 1.1 09:07:52 INFO - mozInstall == 1.12 09:07:52 INFO - mozcrash == 1.0 09:07:52 INFO - mozdebug == 0.1 09:07:52 INFO - mozdevice == 0.50 09:07:52 INFO - mozfile == 1.2 09:07:52 INFO - mozhttpd == 0.7 09:07:52 INFO - mozinfo == 0.9 09:07:52 INFO - mozleak == 0.1 09:07:52 INFO - mozlog == 3.4 09:07:52 INFO - moznetwork == 0.27 09:07:52 INFO - mozprocess == 0.25 09:07:52 INFO - mozprofile == 0.28 09:07:52 INFO - mozrunner == 6.13 09:07:52 INFO - mozscreenshot == 0.1 09:07:52 INFO - mozsystemmonitor == 0.3 09:07:52 INFO - moztest == 0.8 09:07:52 INFO - mozversion == 1.4 09:07:52 INFO - psutil == 3.1.1 09:07:52 INFO - requests == 1.2.3 09:07:52 INFO - wsgiref == 0.1.2 09:07:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:07:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:07:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:52 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 0x10a45ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a45d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fccc85e43e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a238d30>, '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 0x10a15fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a22dbe8>, '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.prrqYMnQLF/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.eYswjMDGlB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 09:07:52 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 09:07:52 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 09:07:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.prrqYMnQLF/Render', 09:07:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:07:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:07:52 INFO - 'HOME': '/Users/cltbld', 09:07:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:07:52 INFO - 'LOGNAME': 'cltbld', 09:07:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:52 INFO - 'MOZ_NO_REMOTE': '1', 09:07:52 INFO - 'NO_EM_RESTART': '1', 09:07:52 INFO - 'PAGER': '/bin/cat', 09:07:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:07:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:52 INFO - 'PWD': '/builds/slave/test', 09:07:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:07:52 INFO - 'SHELL': '/bin/bash', 09:07:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eYswjMDGlB/Listeners', 09:07:52 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 09:07:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:07:52 INFO - 'USER': 'cltbld', 09:07:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:07:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:07:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:52 INFO - 'XPC_FLAGS': '0x0', 09:07:52 INFO - 'XPC_SERVICE_NAME': '0', 09:07:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:07:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:52 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)) 09:07:52 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)) 09:07:52 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)) 09:07:52 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)) 09:07:52 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)) 09:07:52 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)) 09:07:52 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)) 09:07:52 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)) 09:07:52 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)) 09:07:52 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)) 09:07:52 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)) 09:07:52 INFO - Cleaning up... 09:07:52 INFO - Return code: 0 09:07:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:07:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:07:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a45ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a45d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fccc85e43e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a238d30>, '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 0x10a15fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a22dbe8>, '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.prrqYMnQLF/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.eYswjMDGlB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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 09:07:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:07:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:07:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.prrqYMnQLF/Render', 09:07:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:07:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:07:52 INFO - 'HOME': '/Users/cltbld', 09:07:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:07:52 INFO - 'LOGNAME': 'cltbld', 09:07:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:52 INFO - 'MOZ_NO_REMOTE': '1', 09:07:52 INFO - 'NO_EM_RESTART': '1', 09:07:52 INFO - 'PAGER': '/bin/cat', 09:07:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:07:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:52 INFO - 'PWD': '/builds/slave/test', 09:07:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:07:52 INFO - 'SHELL': '/bin/bash', 09:07:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eYswjMDGlB/Listeners', 09:07:52 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 09:07:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:07:52 INFO - 'USER': 'cltbld', 09:07:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:07:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:07:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:52 INFO - 'XPC_FLAGS': '0x0', 09:07:52 INFO - 'XPC_SERVICE_NAME': '0', 09:07:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:07:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:07:52 INFO - Cleaning up... 09:07:52 INFO - Return code: 0 09:07:52 INFO - Running post-action listener: _resource_record_post_action 09:07:52 INFO - Running post-action listener: _start_resource_monitoring 09:07:52 INFO - Starting resource monitoring. 09:07:52 INFO - [mozharness: 2017-04-08 16:07:52.751137Z] Finished create-virtualenv step (success) 09:07:52 INFO - [mozharness: 2017-04-08 16:07:52.752071Z] Running install step. 09:07:52 INFO - Running pre-action listener: _resource_record_pre_action 09:07:52 INFO - Running main action method: install 09:07:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:07:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:07:53 INFO - Reading from file tmpfile_stdout 09:07:53 INFO - Detecting whether we're running mozinstall >=1.0... 09:07:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:07:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:07:53 INFO - Reading from file tmpfile_stdout 09:07:53 INFO - Output received: 09:07:53 INFO - Usage: mozinstall [options] installer 09:07:53 INFO - Options: 09:07:53 INFO - -h, --help show this help message and exit 09:07:53 INFO - -d DEST, --destination=DEST 09:07:53 INFO - Directory to install application into. [default: 09:07:53 INFO - "/builds/slave/test"] 09:07:53 INFO - --app=APP Application being installed. [default: firefox] 09:07:53 INFO - mkdir: /builds/slave/test/build/application 09:07:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:07:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 09:08:12 INFO - Reading from file tmpfile_stdout 09:08:12 INFO - Output received: 09:08:12 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:08:12 INFO - Running post-action listener: _resource_record_post_action 09:08:12 INFO - [mozharness: 2017-04-08 16:08:12.556529Z] Finished install step (success) 09:08:12 INFO - [mozharness: 2017-04-08 16:08:12.556681Z] Running run-tests step. 09:08:12 INFO - Running pre-action listener: _resource_record_pre_action 09:08:12 INFO - Running main action method: run_tests 09:08:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:08:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:08:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:08:12 INFO - 2017-04-08 09:08:12.571 screenresolution[1633:9315] starting screenresolution argv=screenresolution get 09:08:12 INFO - 2017-04-08 09:08:12.573 screenresolution[1633:9315] Display 0: 1600x1200x32@60 09:08:12 INFO - 2017-04-08 09:08:12.579 screenresolution[1634:9318] starting screenresolution argv=screenresolution list 09:08:12 INFO - Available Modes on Display 0 09:08:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:08:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:08:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:08:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:08:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:08:12 INFO - Intel Iris: 09:08:12 INFO - Chipset Model: Intel Iris 09:08:12 INFO - Type: GPU 09:08:12 INFO - Bus: Built-In 09:08:12 INFO - VRAM (Dynamic, Max): 1536 MB 09:08:12 INFO - Vendor: Intel (0x8086) 09:08:12 INFO - Device ID: 0x0a2e 09:08:12 INFO - Revision ID: 0x0009 09:08:12 INFO - Displays: 09:08:12 INFO - Display: 09:08:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:08:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:08:12 INFO - Display Serial Number: 1600x1200 60 09:08:12 INFO - Main Display: Yes 09:08:12 INFO - Mirror: Off 09:08:12 INFO - Online: Yes 09:08:12 INFO - Rotation: Supported 09:08:12 INFO - Return code: 0 09:08:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:08:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:08:12 INFO - Python 2.7.3 09:08:12 INFO - Return code: 0 09:08:12 INFO - grabbing minidump binary from tooltool 09:08: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')]} 09:08:12 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 0x10a238d30>, '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 0x10a15fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a22dbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:08:12 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 09:08:12 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 09:08:12 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 09:08:12 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:08:12 INFO - Return code: 0 09:08:12 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:08:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:08:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:08:12 INFO - ENV: RUST_BACKTRACE is now 1 09:08:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:08:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:08:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EcasZOetREOO4XVgNywWvg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0320', '--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 09:08:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EcasZOetREOO4XVgNywWvg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0320 --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 09:08:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.prrqYMnQLF/Render', 09:08:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:08:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:08:12 INFO - 'HOME': '/Users/cltbld', 09:08:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:08:12 INFO - 'LOGNAME': 'cltbld', 09:08:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:08:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:08:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:12 INFO - 'MOZ_NO_REMOTE': '1', 09:08:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:08:12 INFO - 'NO_EM_RESTART': '1', 09:08:12 INFO - 'PAGER': '/bin/cat', 09:08:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:08:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:12 INFO - 'PWD': '/builds/slave/test', 09:08:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:08:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:08:12 INFO - 'RUST_BACKTRACE': '1', 09:08:12 INFO - 'SHELL': '/bin/bash', 09:08:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eYswjMDGlB/Listeners', 09:08:12 INFO - 'TMPDIR': '/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/', 09:08:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:08:12 INFO - 'USER': 'cltbld', 09:08:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:08:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:08:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:12 INFO - 'XPC_FLAGS': '0x0', 09:08:12 INFO - 'XPC_SERVICE_NAME': '0', 09:08:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:08:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EcasZOetREOO4XVgNywWvg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0320', '--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 09:08:13 INFO - mozversion application_buildid: 20170408075421 09:08:13 INFO - mozversion application_changeset: 794adb67ec4a6d8ebcf786c9b9a0d8207bd5b2c4 09:08:13 INFO - mozversion application_display_name: Nightly 09:08:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:08:13 INFO - mozversion application_name: Firefox 09:08:13 INFO - mozversion application_remotingname: firefox 09:08:13 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:08:13 INFO - mozversion application_vendor: Mozilla 09:08:13 INFO - mozversion application_version: 55.0a1 09:08:13 INFO - mozversion platform_buildid: 20170408075421 09:08:13 INFO - mozversion platform_changeset: 794adb67ec4a6d8ebcf786c9b9a0d8207bd5b2c4 09:08:13 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:08:13 INFO - mozversion platform_version: 55.0a1 09:08:13 INFO - using testdate: 1491667693 09:08:13 INFO - actual date: 1491667693 09:08:13 INFO - starting webserver on 'localhost:49241' 09:08:13 INFO - SUITE-START | Running 2 tests 09:08:13 INFO - TEST-START | dromaeo_css 09:08:13 INFO - operating with platform_type : mac_ 09:08:13 INFO - Initialising browser for dromaeo_css test... 09:08:13 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/tmpTPHqU9/profile http://localhost:49241/getInfo.html) 09:08:14 INFO - PID 1644 | 1491667694025 addons.xpi WARN Error loading bootstrap.js for deployment-checker@mozilla.org: Error opening input stream (invalid filename?): jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/deployment-checker@mozilla.org.xpi!/bootstrap.js 09:08:14 INFO - PID 1644 | 1491667694026 addons.xpi WARN Add-on deployment-checker@mozilla.org is missing bootstrap method install 09:08:14 INFO - PID 1644 | 1491667694074 addons.xpi WARN Add-on deployment-checker@mozilla.org is missing bootstrap method startup 09:08:16 INFO - PID 1644 | 2017-04-08 09:08:16.576 plugin-container[1647:9510] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f37, name = 'com.apple.tsm.portname' 09:08:16 INFO - PID 1644 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:08:16 INFO - PID 1644 | 2017-04-08 09:08:16.579 plugin-container[1647:9510] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c07, name = 'com.apple.CFPasteboardClient' 09:08:16 INFO - PID 1644 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:08:16 INFO - PID 1644 | 2017-04-08 09:08:16.579 plugin-container[1647:9510] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:08:16 INFO - PID 1644 | __metrics Screen width/height:1600/1200 09:08:16 INFO - PID 1644 | colorDepth:24 09:08:16 INFO - PID 1644 | Browser inner width/height: 1024/689 09:08:16 INFO - PID 1644 | __metrics 09:08:16 ERROR - PID 1644 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3364: TypeError: this.tabs is undefined 09:08:16 INFO - PID 1644 | 1491667696758 addons.xpi WARN Add-on deployment-checker@mozilla.org is missing bootstrap method shutdown 09:08:17 INFO - TEST-INFO | 1644: exit 0 09:08:17 INFO - Browser initialized. 09:08:17 INFO - Running cycle 1/1 for dromaeo_css test... 09:08:17 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/tmpTPHqU9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:08:17 INFO - PID 1649 | 1491667697952 addons.xpi WARN Error loading bootstrap.js for deployment-checker@mozilla.org: Error opening input stream (invalid filename?): jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/deployment-checker@mozilla.org.xpi!/bootstrap.js 09:08:17 INFO - PID 1649 | 1491667697953 addons.xpi WARN Add-on deployment-checker@mozilla.org is missing bootstrap method startup 09:08:20 INFO - PID 1649 | 2017-04-08 09:08:20.202 plugin-container[1650:9644] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873f, name = 'com.apple.tsm.portname' 09:08:20 INFO - PID 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:08:20 INFO - PID 1649 | 2017-04-08 09:08:20.203 plugin-container[1650:9644] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c17, name = 'com.apple.CFPasteboardClient' 09:08:20 INFO - PID 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:08:20 INFO - PID 1649 | 2017-04-08 09:08:20.203 plugin-container[1650:9644] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:08:29 INFO - PID 1649 | RSS: Main: 233545728 09:08:29 INFO - PID 1649 | 09:11:34 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 09:11:35 INFO - PID 1649 | RSS: Main: 251781120 09:11:35 INFO - PID 1649 | 09:13:18 INFO - PID 1649 | ************************* 09:13:18 INFO - PID 1649 | A coding exception was thrown and uncaught in a Task. 09:13:18 INFO - PID 1649 | 09:13:18 ERROR - PID 1649 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:13:18 INFO - PID 1649 | Full stack: 09:13:18 INFO - PID 1649 | ************************* 09:13:18 INFO - PID 1649 | ************************* 09:13:18 INFO - PID 1649 | A coding exception was thrown and uncaught in a Task. 09:13:18 INFO - PID 1649 | 09:13:18 ERROR - PID 1649 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:13:18 INFO - PID 1649 | Full stack: 09:13:18 INFO - PID 1649 | ************************* 09:13:18 INFO - PID 1649 | ************************* 09:13:18 INFO - PID 1649 | A coding exception was thrown and uncaught in a Task. 09:13:18 INFO - PID 1649 | 09:13:18 ERROR - PID 1649 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:13:18 INFO - PID 1649 | Full stack: 09:13:18 INFO - PID 1649 | ************************* 09:13:18 INFO - PID 1649 | ************************* 09:13:18 INFO - PID 1649 | A coding exception was thrown and uncaught in a Task. 09:13:18 INFO - PID 1649 | 09:13:18 ERROR - PID 1649 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:13:18 INFO - PID 1649 | Full stack: 09:13:18 INFO - PID 1649 | ************************* 09:14:37 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 09:14:38 INFO - PID 1649 | RSS: Main: 259837952 09:14:38 INFO - PID 1649 | 09:17:40 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 09:17:40 INFO - PID 1649 | RSS: Main: 272240640 09:17:40 INFO - PID 1649 | 09:20:42 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 09:20:43 INFO - PID 1649 | RSS: Main: 264384512 09:20:43 INFO - PID 1649 | 09:23:46 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 09:23:46 INFO - PID 1649 | RSS: Main: 275632128 09:23:46 INFO - PID 1649 | 09:26:48 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 09:26:48 INFO - PID 1649 | RSS: Main: 272683008 09:26:48 INFO - PID 1649 | 09:26:48 INFO - PID 1649 | __start_tp_report 09:26:48 INFO - PID 1649 | _x_x_mozilla_page_load 09:26:48 INFO - PID 1649 | _x_x_mozilla_page_load_details 09:26:48 INFO - PID 1649 | |i|pagename|runs| 09:26:48 INFO - PID 1649 | |0;dojo.html;3444.6555344465555;3656.7623104498207;3681.742278040535;3689.852405903764;3709.7588656737303;6268.279147897993;6344.936550634498;6376.968115159423;6412.903806442901;6445.9677701611545;6367.9363206367925;6421.004744264635;6426.38949299817;6436.131122298489;6449.709763060662;5136.255242989764;5137.3064636274;5639.68981706006;5707.885842283152;5892.057270836667;5450.5367043801325;5703.600747947625;5744.138379243105;5882.235309409771;5942.989691752391;5071.518205770482;5527.2538207341895;5538.252335934638;5552.7223638817895;5561.221428999943;5527.751251193706;5535.474129957647;5545.611807173499;5547.140193270049;5553.361363443175;5529.889402211974;5604.859878503029;5619;5629.887402251973;5700.600957932947;6104.542159338067;6373.585716928431;6383.680815959184;6401.455876250524;6406.679666016727;6659.467242620579;6802.931970680279;6914.654267286615;6931.549449285781;6963.199232088324;6837.213720422165;6993.440524758007;7013.193482749498;7081.362677359062;7091.858162836715;5716.456936591017;5852.326982396994;6531.412172904366;6536.379043990766;6552.213734351813;7106.467014973794;7176.677049532784;7195.604241766753;7196.532225405332;7197.4601904857345;6074.483668888194;6501.772437964743;6626.403623673892;6629.966850165815;6793.252742198354;6729.899051514231;7064.43484521237;7072.681729322193;7072.71709131629;7078.4691148163065;5771.278590176228;6811.4550835933005;6899.206591242071;6945.16658001033;6957.234704182536;6665.933340666531;6757.087793147961;6884.896726549106;6962;6987.510874238755;5510.972445137829;5542.251796007487;5546.750396232179;5553.333599968029;5573.498385145356;4434.268345722984;4885.560299573055;4901.730404827768;4916.901661966741;4980;5334.493223143795;6027.668478233739;6118.724657390339;6216.160818289473;6436;6942;6994.650267486605;7024.929750702529;7045.7181712731945;7054.153501579844;6453.128827608213;6470.708818103102;6471.611703297817;6478.190226221723;6482.837929051717;5993.400659934059;6048.5161187105805;6228.5951413158;6235.906461403082;6252.09344645033;5781.971090144607;6956.40870526011;7108.857822843617;7111.53775004623;7191.065161528968;7048.083749112582;7056.188538317954;7060.952323826238;7079.079719636415;7098.858022839618;7160;7171.49799514029;7197.028401165776;7238.52949558277;7242.637868106679;6679.966600166968;6767.390934815693;6826.078479405217;6886.414654754402;6970.581765094111;7043.190033146254;7096.290370962863;7101.82245443868;7113.893291600527;7118.110236220473;5649.152627105967;6442.516811239082;6561.606303621798;6781.38967492928;6824.624645644339;6704.329567043452;6779.288174741581;6780.186377634715;6784.76253331131;6793.320667933167;5413.5127838493145;6418.679066046772;6491.48068154537;6581.572197807127;6676.632785196861;6707.765228216989;6776.288489708707;6814.727410903508;6817.7272909083085;6884.621345826027;5487.506124448819;6629.270780214269;6639.970804525306;6640.335966403321;6656.0348749430095 09:26:48 INFO - PID 1649 | |1;ext.html;752.3792870881523;1123.8089524780787;1133.0425790207275;1157.369233767597;1289.4584274604665;30622.54066189009;31896.68103318966;38523.036924076914;38592.228155436875;38815.223695526074;38193.236135277344;38373.42439863397;38628.42057369135;38669.226615467676;38680.613193868056;6016.939830601682;7859.764207073797;7975.282224599785;8003.599820009005;8014.919850801505;6128.4178003089855;7304.598247096407;7305.963470182642;8509.617067231959;8534.914650853474;8528.445651032695;8551.957240213791;8606.268467180296;8622.913770862306;8625.913740862605;7598.582077985709;8358.665653373857;8593.527355995418;8595.95702021492;8599.484030958163;8521.275691566225;8531.957340213321;8590.527520986343;8594.785130371729;8596.183362580545;38247.852564422836;38265.23469530594;38315;38365.84902452931;38393.040173995876;3671.3942199537046;3716.163863130801;3721.1255354991554;3723.422869455239;3731.6641502264656;30738.616762245754;30880.691193088005;30914.690853091408;30927.845360773277;31026.379472410426;3187.7131058204873;3199.04028791364;3222.871085156591;3229.7900636458553;3233.2078640732934;282996;283712;285869.57065214746;288365;290055.5497222521;40431.59568404337;41397.1720565587;50221.74889125531;50494.99010019779;50597.24104138441;39763.427205871114;50208.497915021115;50675.49324506782;50837;51081.48918510842;14194.14835109876;14325.426982920566;14327.35526901292;14336.354864031144;14365.856341436662;11477.598284060185;11624.825627615592;11642.592509262304;11661.591844285409;11676.124290678234;12442.81335779964;12445.502179912883;12459.626211213677;12477.875221247852;12536.059795515373;5272.261883336336;5277.97079569488;5281.9207711884355;5293.338332708411;5295.338082739658;1034.5189486888632;1035.4563853976722;1035.5184839049878;1066.9146468282675;1075.6127793994156;18836;24177.516449670908;24482.265532034067;24499.26502204901;24644.630330545056;1113.3264375052977;1113.9275947063416;1147.8565179352581;1155.2202263472122;1155.2779512804498;12250;12399.690007749878;12511;12538.435770390355;12539.623811285675;352949;356311;357241;357966;358168;53970;54468;54513.90972180534;54535.72732136314;54565;1491.970160596782;1534.2175490499926;1542.1209910351217;1543.6835448732984;1547.4506550174751;18368.816311836712;24106.51786964286;24216.636750448404;24249.63625545583;24347.14784982517;38372.808135959145;38374.23251534898;38411.80794096012;38629.03427414225;38649.03377415587;319939;321409;321437;321798;322967.3851630821;34231;34944.475832863034;35024.94925152249;35168.76909308162;35173;45424.869026829816;45709.77145114253;46244.306335404326;46285.611431657104;46344;29902.70097298999;29972.250693732833;30990;31696.20759480939;31840.5223921646;30667.846660766554;30968.535471967487;31010.712482566127;31079.533806993364;31295.530567041056;30956.845215773777;31181.68818311788;37631.43552846655;37849.432258516696;37909.620903791714;24349.513009739352;28476.288092797844;30949.535756963214;31339.216519587193;31617.683823162395;23227.767722323235;24374.26877193687;24609.753902460747;24634.260972170865;24748.38129046788 09:26:48 INFO - PID 1649 | |2;jquery.html;409.3450479233227;430.3759548654452;443.04660266022705;444.53990120225563;466.91828929937253;18002.729959050626;21687;22431.55136897261;22520.662190067163;22691.773082269174;19892.701609475833;22588.66117008246;22605.886970565167;22770.975306111224;22961;6085.665288409146;6293.685315734195;6311.305756366796;6365.554411191195;6371.904421433659;6014.639121652693;6148.292946311187;6213.782517611885;6224.626522408647;6228.781992630259;6110.3889611038985;6124.816255512342;6140.600860944047;6191.4118158774845;6199.907001394983;6053.303870054934;6241.531885108612;6241.531885108635;6248.094026366151;6262.2798378186635;5448.863778405532;5471.069918113891;5525.281713377275;5528.834134975958;5533.197686335499;26146.73853261462;26635.934562617473;26708.931642734267;26981.865090674422;27088.32279193036;2178.074318414683;2227.9554408911895;2245.0458555114174;2249.8650080995194;2250.3024062540503;14349.56951291463;17355.826441735673;17519.386821461187;17922.462326130106;18083.54791130219;2149.9032543535577;2188.420068681801;2216.5012872103807;2222.9333120006427;2228.4094714900566;117869.41065294704;124269;150919.24540377338;151362.24318878446;151437;12149.08881833866;12289.815652765215;12444.937775311066;12460.688482787822;12626.179298345578;16154.030758154548;16436.6712665746;16448.506544803677;16455.588610284838;16592.751108733377;8767.079456657088;9041.63833446668;9044.196299147285;9075.818483630423;9210.861837072449;7312.268773122645;8285.130061343592;8675.00237472686;8759.386842921062;8774.29805615562;6743.055972163901;6831.6242606657115;7683.039620047494;7788.883166752503;7915.366770658334;2235.6087684655445;2253.4929640830683;2257.9774202257768;2260.536589999046;2434.4400787818545;947.6020071569957;956.784723437221;960.1934375124929;961.5480524662083;1005.2460654509118;18937.526561836065;19484.051594840403;19896.50258743543;19979.800201998085;20187.596248074955;906.5376657904384;916.0427353415697;982.3712823792779;1009.9697009089739;1010.883748368947;8914.643414263357;10288.639897603547;10339.793204135874;10365.274430789772;10369.325993810378;688693;696352;697021;704231;718238;143307;145263.54736452713;158801;164001.17999409928;166311.168444157;1054.330500132406;1157.785809625222;1181.8522684664417;1198.3888217009214;1207.1248344950016;16773.748393774345;17429.564260893578;17461.30154793794;17496.387626433014;17715.468535943943;55456.722716387776;56167.15749263683;56857.431425685216;60704.6964765191;65048.674756627806;75547.24452755402;77120.61439692766;77527.61236193783;78516;78929;7453;8688.087750786077;8796.076411976906;8848.1151884811;8938.37431379797;13568;13835.654108647364;13836.515721950087;14122.929385353007;14194.716105678035;9872.420412733929;11744.725780425098;11806.291622502677;11906.737719833203;12037.578684745991;10851.837222441512;10989.945050274697;11182.713987891171;11253.212275140662;11333.886661133283;11303.434828258718;11713.004394626212;12128.514859405524;12166.39168041612;12252.387380630755;6631.3700198481065;7385.224551422023;8804.647814087364;8878.955605221932;8910.198082172636;11539.596114135966;11784.58753943608;12001.819972700241;12011.939940300243;12109.394530273627 09:26:48 INFO - PID 1649 | |3;mootools.html;1356.5116558039103;1410.3935307817642;1411.0404924651239;1416.3201663201658;1435.2967046147392;11548.769024619503;11849.585264515743;11881.049516038707;11957.880421195785;12254.326012069332;11712.531498740062;11881.742468930897;11889.7622047559;11905.797427475924;11915.987141092995;2370.8577485350847;2400.195934361991;2411.855288682676;2413.5776239158076;2421.116292553223;2384.4396566806786;2460.2004348586693;2465.7287698353166;2481.280428675682;2484.813638977075;2326.7673232676766;2351.811855051592;2358.5636657218383;2442.4016116051594;2460.1266550374626;2296.471811483368;2406.278116565032;2416.540857237128;2423.9151629692965;2450.375154335633;2059.783722709124;2153.4723992621907;2379.892904819287;2460.3480077779404;2463;11953.22304050234;12026.759464810742;12106.394680265952;12107.39463026854;12127.09046821492;6410.294867564564;6572.507061970371;6648.401643852028;6655.733770649168;6663.4669226461765;3408.744344174172;4173.833046678129;4190.5180904195795;4237;4245.915081698348;1249.8125281207801;1259.055708218836;1269.8603153653091;1285.4408332375353;1301.8633043530483;14987.475438359714;15383.615409614737;16691.332346706116;16825.83174168255;16869.66260674792;4722.1028004679;5262.526372626406;5470.835874923759;5578.748956296977;5611.859703507445;12113.273203607812;12384.380780960915;12410.503579856886;12415.068869834618;12520.1235913487;6474.902876456857;6483.513736469784;6492.772752953719;6513.088167656532;6513.739450422025;5956;6012.6392416455155;6033.637981721111;6077.513798896166;6105;4432.977835110868;4506.481754598198;4561.384213131185;4597.448306203277;4598.908021839611;1289.2071376103816;1307.378994977397;1313.9211647301192;1326.7545504081775;1331.2877610478347;687.7249100359896;783.4280974888363;797.2625321577517;798.9480683755537;804.3324041045918;4586.334981427674;6213.409726076015;6378.712957916812;6381.202349706286;6413.749318882867;542.3925203771801;545.0380079160285;552.6269767906647;555.2310050579895;566.3260719743492;3527.7530572859655;4315.07225946423;4471.23988921884;4571.885702857455;4641.512641172696;14972.17653029072;15006.774898376532;15453.768193477106;15530.223488825513;15569.377224911103;15325.23373831304;15400;15489.922550387177;15497.302621382065;15503.767443488357;10819.621313253998;10905.509252083675;11022.669319920415;11024.779504409868;11186.832197517206;7028.297170282931;7039.824004399931;7128.108986376703;7172.892406613801;7190.604516751629;13498.59504214875;13637.113587616774;13861.722765544431;14018.018738688603;14140.363683634056;13527.526536571173;13982.300884955916;14040.578782636538;14106.788398174242;14196.006279560332;7683.961580192287;9544.713658590254;9680.709578712649;9689.273304502332;9728.416295022322;10839.945800270949;10937.671869843918;10954.068904143238;10955.780884382428;10958.178136639943;9179.495127768037;9317.72046838596;9391.248700104112;9401.20089792348;9518.428894266366;9210.585523651318;9253.074692530694;9287.164155226063;9304.860427093734;9325.487098209664;8051.637676304697;8336.708215212439;8402.327813775006;8460.407771456184;8473.57632118404;6078.635281883101;6093.421124993119;6136.171616831671;6201.317855036033;6321.083442900662;6094.481969032682;6151.784687535915;6275.466585340115;6329.90505142414;6330.113784070326 09:26:48 INFO - PID 1649 | |4;prototype.html;331.96348401675795;370.3666729891885;389.69409013924076;389.8927794856414;394.5009562902927;5518.503334699886;5768.932747441721;6184.381561843819;6195.614688344986;6399.64801935894;4905.969746353261;6180.1656776335185;6191.845203869905;6209.2924445777435;6222.782202622909;3580.427131658935;3752.8123593820337;4477.686561940665;4514.480834704002;4540.296254080615;4328.891777705551;4329.610335069843;4473.910521789562;4533.6146427553695;4581.450225972888;3509.9294715111882;4262.254105531535;4344.45694288214;4414.492333381654;4440.378347031418;3547.9113022174392;4150.709450338478;4244.731556701338;4296.6777491687935;4433.578810013044;3079.491883839164;3819.236152769457;3821.48409964654;3825.2540754552874;3828.55971563271;4963.652544321899;4971.4282857471135;6013.338532761437;6107.106796892977;6121.694285086048;5142.974285128588;5322.441143679896;5326.174442961347;5363;5365.624406291561;6436.195475565554;6611.4380277676455;6615.636140012298;6624.635645039569;6691.397774200345;3526.7531272810916;3872.625218047581;4320.4599425071865;4334.241507736134;4353.28170851809;6231.813045608639;6736.595804251711;6835.282295359015;6947.305269473063;6964.303569643046;4391.60475557195;4393.045094932788;4431.0694754102;4471.306947423154;4549.158405694957;3642.4718415829557;4151.813168407429;4264.189803937304;4532.342810292489;4535.387722657465;4541.091781643684;5091.5672167865405;5270.522854258493;5378.78484860609;5393.8112166074;5488.368837583729;6484.286728459866;6694.397504224643;6726.22648395431;6764.5603035802515;1316.8222289990729;1535.7696345548034;1544.1970175508673;1550.3488534815406;1554.401555401156;850.8468475674438;957.7270477913901;1000.3047881722279;1005.3565717940523;1018.5467466977273;5386.357161065913;5609.156828669017;5627.859303517363;6331.430171284606;6422.614643121427;6674.599524028574;7004.299570042955;7021.297870212938;7026.367626913602;7070.292970702992;5709.600327977002;5742.306019724191;5970.432808883236;6048.334683184846;6302.842428939313;3361.378145043126;3364.6467120951947;3592.1558433768046;3612.422012477991;3678.3746763050344;6131.570790044743;6153.815385538441;6601.73593056282;7082.433405327562;7162.033125527987;7061.576305421691;7128.6435678215885;7143.678534465961;7175.748848790267;7176.461765367514;5907.320658124285;6932.3414275644745;7179.317964793337;7181.676824543013;7223.8328501450405;5643.435656434323;6269.40440658155;6555.2133743951035;6984.476164287597;6986.4979029508895;5759.683217423082;6430.549861509649;6561.212654481493;6830.521863469509;6865.828354291183;5889.764409423747;7015.842870708099;7221.566705997657;7235.493515454078;7244.275572442713;4432.35730819023;4438.9556104439835;4492.685512014127;4494.325851122358;4495.303227999665;6066.090086487062;6794.199537122765;7014.40377567892;7026.367626913602;7067.25793791665;5666.886662266814;6691.1636045494315;6715.294894036251;6717.462602991846;6719.740925651153;5582.581306401955;6438.036398898381;6656.633885136364;6702.564333318319;6762;6632.104665870239;6648.335166483506;6659.500537459807;6672.332766723289;6689.665516724242;6484.795169642344;6666.83332916681;6799.354061364163;6822.624755638289;6850.623215722983;5621.297337832771;6392.4246817786625;6560;6563.474922006323;6591.824697849602 09:26:48 INFO - PID 1649 | |5;yui.html;839.1482645115213;853.7438768369492;870;874.923843672283;888.9199972002518;16235.83764162358;16959.83040169598;17019.574510637223;18276.90338579686;19059.714104288447;18021.549461263476;18242.726359104625;18307.816921830778;18446.631067378643;18694.065296735178;986.6349450703214;990.3067852503259;999.3953658036892;1016.6645007147661;1022.8823685276177;824.9793755156109;1029.474967766437;1030.8969103089705;1031.3193292426963;1031.700806766037;1059.4808543813554;1062.978740425191;1068;1080.4975686305866;1081.5295346524288;1057.8254587992972;1067.140951534015;1070.3203465799195;1072.7264547540406;1074.312440038376;763.2977660552306;770.1989930472303;781.4998401023349;789.1556035042507;789.9368050556;16605.4188103417;17249.22378492971;17389.82610173895;17420.216090275968;17439.38962136332;14342.856571434257;17333.04668243246;17421.912890435593;17433;17664.823351766445;13666.863331366658;13956.860431395658;14206.786898196535;14207.928960355131;14304.785428218585;3472.531208286874;3519.5072689823446;3520.2959408118477;3549.2546565221332;3553.982230088859;122953;123407;123945;125853.19027668067;126488.47023059579;13128.934355328352;13354.933225334005;13456.125351852099;13471.797923031163;13495.25776082325;24825.5034899301;25187.496250074895;25321.366965826;25448.363790905376;25476.363090922874;8768.07935166811;8828.028916819145;8868.423552469068;8870.246029087471;8884.200421962054;4117.5882411758585;4667.603253723403;4771.856844294677;4838.129136755418;4838.830640927551;4355.281378572563;4452.8218871245435;4453;4457.9331310030375;4465.776711164429;950.1780959470009;955.398099197515;967.6468089147411;972.5720682899502;973.7955029443755;644.3685188515282;665.065582856088;673.2560520624737;679.7281087564915;698.5354739098544;11268.774624507463;11943.940280298542;12139.271643701406;12196.57311994076;12323.75352492963;648.2628735689113;664.7008846019311;669.9062131301622;694.5763084518439;697.4037198195571;5508.91736623951;5557.694326811983;5647.435256474319;5709.857253568611;5818.185454036438;80145;107711;110260.89739102506;111648.44175779069;112486;87473;88814;89784;90433.09566904379;90651;74165.88751168629;74482;78601;79984;80226.79659805108;11883.108766842348;12365.876341236832;12440.19138755978;12499.250044997329;12518;40610.79694601508;41151.38272925848;41850.79074604608;41917.95205119896;42576.5742342585;50313.748431259075;50340.74148146326;50710.746446267534;50843.74578127086;51499.742501287255;13198.472061117447;15902.920485397499;16115.113668748332;16223.432179873647;16336.836631633532;14614.780778288547;17938.730919036487;17950.640987179922;18239.0880455974;18301.176447059646;16190.595235118744;16342.918285408972;16384.67230655404;16505.17474126265;16641.83358166403;13462.663433414244;16226.67546649084;16538.255778489754;16590;16688.916555417632;15726.842731572995;15805.920970395075;16299.266533006281;16302.755458667893;16351.59121021984;11687;11799.292042477478;11919.76160476803;12164.330961797186;12261.69345766363;12859;13780.724385512032;13868.375923083284;14006.859931400963;14072.859271407155 09:26:48 INFO - PID 1649 | __end_tp_report 09:26:48 INFO - PID 1649 | __start_cc_report 09:26:48 INFO - PID 1649 | _x_x_mozilla_cycle_collect,421 09:26:48 INFO - PID 1649 | __end_cc_report 09:26:48 INFO - PID 1649 | __startTimestamp1491668808643__endTimestamp 09:26:48 INFO - PID 1649 | 09:26:48 INFO - PID 1649 | ------- Summary: start ------- 09:26:48 INFO - PID 1649 | Number of tests: 6 09:26:48 INFO - PID 1649 | 09:26:48 INFO - PID 1649 | [#0] dojo.html Cycles:165 Average:6325.57 Median:6531.41 stddev:792.32 (12.1%) stddev-sans-first:761.84 09:26:48 INFO - PID 1649 | Values: 3444.7 3656.8 3681.7 3689.9 3709.8 6268.3 6344.9 6377.0 6412.9 6446.0 6367.9 6421.0 6426.4 6436.1 6449.7 5136.3 5137.3 5639.7 5707.9 5892.1 5450.5 5703.6 5744.1 5882.2 5943.0 5071.5 5527.3 5538.3 5552.7 5561.2 5527.8 5535.5 5545.6 5547.1 5553.4 5529.9 5604.9 5619.0 5629.9 5700.6 6104.5 6373.6 6383.7 6401.5 6406.7 6659.5 6802.9 6914.7 6931.5 6963.2 6837.2 6993.4 7013.2 7081.4 7091.9 5716.5 5852.3 6531.4 6536.4 6552.2 7106.5 7176.7 7195.6 7196.5 7197.5 6074.5 6501.8 6626.4 6630.0 6793.3 6729.9 7064.4 7072.7 7072.7 7078.5 5771.3 6811.5 6899.2 6945.2 6957.2 6665.9 6757.1 6884.9 6962.0 6987.5 5511.0 5542.3 5546.8 5553.3 5573.5 4434.3 4885.6 4901.7 4916.9 4980.0 5334.5 6027.7 6118.7 6216.2 6436.0 6942.0 6994.7 7024.9 7045.7 7054.2 6453.1 6470.7 6471.6 6478.2 6482.8 5993.4 6048.5 6228.6 6235.9 6252.1 5782.0 6956.4 7108.9 7111.5 7191.1 7048.1 7056.2 7061.0 7079.1 7098.9 7160.0 7171.5 7197.0 7238.5 7242.6 6680.0 6767.4 6826.1 6886.4 6970.6 7043.2 7096.3 7101.8 7113.9 7118.1 5649.2 6442.5 6561.6 6781.4 6824.6 6704.3 6779.3 6780.2 6784.8 6793.3 5413.5 6418.7 6491.5 6581.6 6676.6 6707.8 6776.3 6814.7 6817.7 6884.6 5487.5 6629.3 6640.0 6640.3 6656.0 09:26:48 INFO - PID 1649 | 09:26:48 INFO - PID 1649 | [#1] ext.html Cycles:180 Average:46726.22 Median:163098.59 stddev:84906.70 (52.1%) stddev-sans-first:85074.72 09:26:48 INFO - PID 1649 | Values: 752.4 1123.8 1133.0 1157.4 1289.5 30622.5 31896.7 38523.0 38592.2 38815.2 38193.2 38373.4 38628.4 38669.2 38680.6 6016.9 7859.8 7975.3 8003.6 8014.9 6128.4 7304.6 7306.0 8509.6 8534.9 8528.4 8552.0 8606.3 8622.9 8625.9 7598.6 8358.7 8593.5 8596.0 8599.5 8521.3 8532.0 8590.5 8594.8 8596.2 38247.9 38265.2 38315.0 38365.8 38393.0 3671.4 3716.2 3721.1 3723.4 3731.7 30738.6 30880.7 30914.7 30927.8 31026.4 3187.7 3199.0 3222.9 3229.8 3233.2 282996.0 283712.0 285869.6 288365.0 290055.5 40431.6 41397.2 50221.7 50495.0 50597.2 39763.4 50208.5 50675.5 50837.0 51081.5 14194.1 14325.4 14327.4 14336.4 14365.9 11477.6 11624.8 11642.6 11661.6 11676.1 12442.8 12445.5 12459.6 12477.9 12536.1 5272.3 5278.0 5281.9 5293.3 5295.3 1034.5 1035.5 1035.5 1066.9 1075.6 18836.0 24177.5 24482.3 24499.3 24644.6 1113.3 1113.9 1147.9 1155.2 1155.3 12250.0 12399.7 12511.0 12538.4 12539.6 352949.0 356311.0 357241.0 357966.0 358168.0 53970.0 54468.0 54513.9 54535.7 54565.0 1492.0 1534.2 1542.1 1543.7 1547.5 18368.8 24106.5 24216.6 24249.6 24347.1 38372.8 38374.2 38411.8 38629.0 38649.0 319939.0 321409.0 321437.0 321798.0 322967.4 34231.0 34944.5 35024.9 35168.8 35173.0 45424.9 45709.8 46244.3 46285.6 46344.0 29902.7 29972.3 30990.0 31696.2 31840.5 30667.8 30968.5 31010.7 31079.5 31295.5 30956.8 31181.7 37631.4 37849.4 37909.6 24349.5 28476.3 30949.5 31339.2 31617.7 23227.8 24374.3 24609.8 24634.3 24748.4 09:26:48 INFO - PID 1649 | 09:26:48 INFO - PID 1649 | [#2] jquery.html Cycles:180 Average:39934.52 Median:12433.21 stddev:117204.38 (942.7%) stddev-sans-first:117495.60 09:26:48 INFO - PID 1649 | Values: 409.3 430.4 443.0 444.5 466.9 18002.7 21687.0 22431.6 22520.7 22691.8 19892.7 22588.7 22605.9 22771.0 22961.0 6085.7 6293.7 6311.3 6365.6 6371.9 6014.6 6148.3 6213.8 6224.6 6228.8 6110.4 6124.8 6140.6 6191.4 6199.9 6053.3 6241.5 6241.5 6248.1 6262.3 5448.9 5471.1 5525.3 5528.8 5533.2 26146.7 26635.9 26708.9 26981.9 27088.3 2178.1 2228.0 2245.0 2249.9 2250.3 14349.6 17355.8 17519.4 17922.5 18083.5 2149.9 2188.4 2216.5 2222.9 2228.4 117869.4 124269.0 150919.2 151362.2 151437.0 12149.1 12289.8 12444.9 12460.7 12626.2 16154.0 16436.7 16448.5 16455.6 16592.8 8767.1 9041.6 9044.2 9075.8 9210.9 7312.3 8285.1 8675.0 8759.4 8774.3 6743.1 6831.6 7683.0 7788.9 7915.4 2235.6 2253.5 2258.0 2260.5 2434.4 947.6 956.8 960.2 961.5 1005.2 18937.5 19484.1 19896.5 19979.8 20187.6 906.5 916.0 982.4 1010.0 1010.9 8914.6 10288.6 10339.8 10365.3 10369.3 688693.0 696352.0 697021.0 704231.0 718238.0 143307.0 145263.5 158801.0 164001.2 166311.2 1054.3 1157.8 1181.9 1198.4 1207.1 16773.7 17429.6 17461.3 17496.4 17715.5 55456.7 56167.2 56857.4 60704.7 65048.7 75547.2 77120.6 77527.6 78516.0 78929.0 7453.0 8688.1 8796.1 8848.1 8938.4 13568.0 13835.7 13836.5 14122.9 14194.7 9872.4 11744.7 11806.3 11906.7 12037.6 10851.8 10989.9 11182.7 11253.2 11333.9 11303.4 11713.0 12128.5 12166.4 12252.4 6631.4 7385.2 8804.6 8879.0 8910.2 11539.6 11784.6 12001.8 12011.9 12109.4 09:26:48 INFO - PID 1649 | 09:26:48 INFO - PID 1649 | [#3] mootools.html Cycles:180 Average:7255.28 Median:2461.67 stddev:4674.14 (189.9%) stddev-sans-first:4666.23 09:26:48 INFO - PID 1649 | Values: 1356.5 1410.4 1411.0 1416.3 1435.3 11548.8 11849.6 11881.0 11957.9 12254.3 11712.5 11881.7 11889.8 11905.8 11916.0 2370.9 2400.2 2411.9 2413.6 2421.1 2384.4 2460.2 2465.7 2481.3 2484.8 2326.8 2351.8 2358.6 2442.4 2460.1 2296.5 2406.3 2416.5 2423.9 2450.4 2059.8 2153.5 2379.9 2460.3 2463.0 11953.2 12026.8 12106.4 12107.4 12127.1 6410.3 6572.5 6648.4 6655.7 6663.5 3408.7 4173.8 4190.5 4237.0 4245.9 1249.8 1259.1 1269.9 1285.4 1301.9 14987.5 15383.6 16691.3 16825.8 16869.7 4722.1 5262.5 5470.8 5578.7 5611.9 12113.3 12384.4 12410.5 12415.1 12520.1 6474.9 6483.5 6492.8 6513.1 6513.7 5956.0 6012.6 6033.6 6077.5 6105.0 4433.0 4506.5 4561.4 4597.4 4598.9 1289.2 1307.4 1313.9 1326.8 1331.3 687.7 783.4 797.3 798.9 804.3 4586.3 6213.4 6378.7 6381.2 6413.7 542.4 545.0 552.6 555.2 566.3 3527.8 4315.1 4471.2 4571.9 4641.5 14972.2 15006.8 15453.8 15530.2 15569.4 15325.2 15400.0 15489.9 15497.3 15503.8 10819.6 10905.5 11022.7 11024.8 11186.8 7028.3 7039.8 7128.1 7172.9 7190.6 13498.6 13637.1 13861.7 14018.0 14140.4 13527.5 13982.3 14040.6 14106.8 14196.0 7684.0 9544.7 9680.7 9689.3 9728.4 10839.9 10937.7 10954.1 10955.8 10958.2 9179.5 9317.7 9391.2 9401.2 9518.4 9210.6 9253.1 9287.2 9304.9 9325.5 8051.6 8336.7 8402.3 8460.4 8473.6 6078.6 6093.4 6136.2 6201.3 6321.1 6094.5 6151.8 6275.5 6329.9 6330.1 09:26:48 INFO - PID 1649 | 09:26:48 INFO - PID 1649 | [#4] prototype.html Cycles:180 Average:5300.21 Median:5938.88 stddev:1740.14 (29.3%) stddev-sans-first:1704.60 09:26:48 INFO - PID 1649 | Values: 332.0 370.4 389.7 389.9 394.5 5518.5 5768.9 6184.4 6195.6 6399.6 4906.0 6180.2 6191.8 6209.3 6222.8 3580.4 3752.8 4477.7 4514.5 4540.3 4328.9 4329.6 4473.9 4533.6 4581.5 3509.9 4262.3 4344.5 4414.5 4440.4 3547.9 4150.7 4244.7 4296.7 4433.6 3079.5 3819.2 3821.5 3825.3 3828.6 4963.7 4971.4 6013.3 6107.1 6121.7 5143.0 5322.4 5326.2 5363.0 5365.6 6436.2 6611.4 6615.6 6624.6 6691.4 3526.8 3872.6 4320.5 4334.2 4353.3 6231.8 6736.6 6835.3 6947.3 6964.3 4391.6 4393.0 4431.1 4471.3 4549.2 3642.5 4151.8 4264.2 4532.3 4535.4 4541.1 5091.6 5270.5 5378.8 5393.8 5488.4 6484.3 6694.4 6726.2 6764.6 1316.8 1535.8 1544.2 1550.3 1554.4 850.8 957.7 1000.3 1005.4 1018.5 5386.4 5609.2 5627.9 6331.4 6422.6 6674.6 7004.3 7021.3 7026.4 7070.3 5709.6 5742.3 5970.4 6048.3 6302.8 3361.4 3364.6 3592.2 3612.4 3678.4 6131.6 6153.8 6601.7 7082.4 7162.0 7061.6 7128.6 7143.7 7175.7 7176.5 5907.3 6932.3 7179.3 7181.7 7223.8 5643.4 6269.4 6555.2 6984.5 6986.5 5759.7 6430.5 6561.2 6830.5 6865.8 5889.8 7015.8 7221.6 7235.5 7244.3 4432.4 4439.0 4492.7 4494.3 4495.3 6066.1 6794.2 7014.4 7026.4 7067.3 5666.9 6691.2 6715.3 6717.5 6719.7 5582.6 6438.0 6656.6 6702.6 6762.0 6632.1 6648.3 6659.5 6672.3 6689.7 6484.8 6666.8 6799.4 6822.6 6850.6 5621.3 6392.4 6560.0 6563.5 6591.8 09:26:48 INFO - PID 1649 | 09:26:48 INFO - PID 1649 | [#5] yui.html Cycles:180 Average:21595.62 Median:17986.10 stddev:30116.29 (167.4%) stddev-sans-first:30160.44 09:26:48 INFO - PID 1649 | Values: 839.1 853.7 870.0 874.9 888.9 16235.8 16959.8 17019.6 18276.9 19059.7 18021.5 18242.7 18307.8 18446.6 18694.1 986.6 990.3 999.4 1016.7 1022.9 825.0 1029.5 1030.9 1031.3 1031.7 1059.5 1063.0 1068.0 1080.5 1081.5 1057.8 1067.1 1070.3 1072.7 1074.3 763.3 770.2 781.5 789.2 789.9 16605.4 17249.2 17389.8 17420.2 17439.4 14342.9 17333.0 17421.9 17433.0 17664.8 13666.9 13956.9 14206.8 14207.9 14304.8 3472.5 3519.5 3520.3 3549.3 3554.0 122953.0 123407.0 123945.0 125853.2 126488.5 13128.9 13354.9 13456.1 13471.8 13495.3 24825.5 25187.5 25321.4 25448.4 25476.4 8768.1 8828.0 8868.4 8870.2 8884.2 4117.6 4667.6 4771.9 4838.1 4838.8 4355.3 4452.8 4453.0 4457.9 4465.8 950.2 955.4 967.6 972.6 973.8 644.4 665.1 673.3 679.7 698.5 11268.8 11943.9 12139.3 12196.6 12323.8 648.3 664.7 669.9 694.6 697.4 5508.9 5557.7 5647.4 5709.9 5818.2 80145.0 107711.0 110260.9 111648.4 112486.0 87473.0 88814.0 89784.0 90433.1 90651.0 74165.9 74482.0 78601.0 79984.0 80226.8 11883.1 12365.9 12440.2 12499.3 12518.0 40610.8 41151.4 41850.8 41918.0 42576.6 50313.7 50340.7 50710.7 50843.7 51499.7 13198.5 15902.9 16115.1 16223.4 16336.8 14614.8 17938.7 17950.6 18239.1 18301.2 16190.6 16342.9 16384.7 16505.2 16641.8 13462.7 16226.7 16538.3 16590.0 16688.9 15726.8 15805.9 16299.3 16302.8 16351.6 11687.0 11799.3 11919.8 12164.3 12261.7 12859.0 13780.7 13868.4 14006.9 14072.9 09:26:48 INFO - PID 1649 | -------- Summary: end -------- 09:26:48 INFO - PID 1649 | 09:26:48 INFO - PID 1649 | 1491668808672 addons.xpi WARN Add-on deployment-checker@mozilla.org is missing bootstrap method shutdown 09:26:49 INFO - TEST-INFO | 1649: exit 0 09:26:49 INFO - TEST-OK | dromaeo_css | took 1116125ms 09:26:49 INFO - TEST-START | kraken 09:26:49 INFO - operating with platform_type : mac_ 09:26:49 INFO - Initialising browser for kraken test... 09:26:49 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/tmp21s8rI/profile http://localhost:49241/getInfo.html) 09:26:49 INFO - PID 1657 | 1491668809900 addons.xpi WARN Error loading bootstrap.js for deployment-checker@mozilla.org: Error opening input stream (invalid filename?): jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/deployment-checker@mozilla.org.xpi!/bootstrap.js 09:26:49 INFO - PID 1657 | 1491668809901 addons.xpi WARN Add-on deployment-checker@mozilla.org is missing bootstrap method install 09:26:49 INFO - PID 1657 | 1491668809952 addons.xpi WARN Add-on deployment-checker@mozilla.org is missing bootstrap method startup 09:26:52 INFO - PID 1657 | 2017-04-08 09:26:52.061 plugin-container[1658:12068] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 09:26:52 INFO - PID 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:26:52 INFO - PID 1657 | 2017-04-08 09:26:52.065 plugin-container[1658:12068] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 09:26:52 INFO - PID 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:26:52 INFO - PID 1657 | 2017-04-08 09:26:52.065 plugin-container[1658:12068] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:26:52 INFO - PID 1657 | __metrics Screen width/height:1600/1200 09:26:52 INFO - PID 1657 | colorDepth:24 09:26:52 INFO - PID 1657 | Browser inner width/height: 1024/689 09:26:52 INFO - PID 1657 | __metrics 09:26:52 ERROR - PID 1657 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3364: TypeError: this.tabs is undefined 09:26:52 INFO - PID 1657 | 1491668812480 addons.xpi WARN Add-on deployment-checker@mozilla.org is missing bootstrap method shutdown 09:26:53 INFO - TEST-INFO | 1657: exit 0 09:26:53 INFO - Browser initialized. 09:26:53 INFO - Running cycle 1/1 for kraken test... 09:26:53 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/tmp21s8rI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:26:53 INFO - PID 1659 | 1491668813929 addons.xpi WARN Error loading bootstrap.js for deployment-checker@mozilla.org: Error opening input stream (invalid filename?): jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/deployment-checker@mozilla.org.xpi!/bootstrap.js 09:26:53 INFO - PID 1659 | 1491668813930 addons.xpi WARN Add-on deployment-checker@mozilla.org is missing bootstrap method startup 09:26:56 INFO - PID 1659 | 2017-04-08 09:26:56.039 plugin-container[1660:12194] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883b, name = 'com.apple.tsm.portname' 09:26:56 INFO - PID 1659 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:26:56 INFO - PID 1659 | 2017-04-08 09:26:56.040 plugin-container[1660:12194] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a17, name = 'com.apple.CFPasteboardClient' 09:26:56 INFO - PID 1659 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:26:56 INFO - PID 1659 | 2017-04-08 09:26:56.040 plugin-container[1660:12194] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:27:05 INFO - PID 1659 | RSS: Main: 250712064 09:27:05 INFO - PID 1659 | 09:27:08 INFO - PID 1659 | 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) 09:27:09 INFO - PID 1659 | RSS: Main: 259690496 09:27:09 INFO - PID 1659 | 09:27:12 INFO - PID 1659 | 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) 09:27:12 INFO - PID 1659 | RSS: Main: 266706944 09:27:12 INFO - PID 1659 | 09:27:16 INFO - PID 1659 | 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) 09:27:17 INFO - PID 1659 | RSS: Main: 262598656 09:27:17 INFO - PID 1659 | 09:27:19 INFO - PID 1659 | 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) 09:27:20 INFO - PID 1659 | RSS: Main: 264732672 09:27:20 INFO - PID 1659 | 09:27:22 INFO - PID 1659 | 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) 09:27:22 INFO - PID 1659 | RSS: Main: 265052160 09:27:22 INFO - PID 1659 | 09:27:25 INFO - PID 1659 | 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) 09:27:26 INFO - PID 1659 | RSS: Main: 270585856 09:27:26 INFO - PID 1659 | 09:27:29 INFO - PID 1659 | 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) 09:27:30 INFO - PID 1659 | RSS: Main: 270962688 09:27:30 INFO - PID 1659 | 09:27:33 INFO - PID 1659 | 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) 09:27:34 INFO - PID 1659 | RSS: Main: 271114240 09:27:34 INFO - PID 1659 | 09:27:35 INFO - PID 1659 | 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) 09:27:36 INFO - PID 1659 | RSS: Main: 270630912 09:27:36 INFO - PID 1659 | 09:27:38 INFO - PID 1659 | 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) 09:27:38 INFO - PID 1659 | RSS: Main: 270655488 09:27:38 INFO - PID 1659 | 09:27:41 INFO - PID 1659 | 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) 09:27:41 INFO - PID 1659 | RSS: Main: 270643200 09:27:41 INFO - PID 1659 | 09:27:44 INFO - PID 1659 | 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) 09:27:45 INFO - PID 1659 | RSS: Main: 270966784 09:27:45 INFO - PID 1659 | 09:27:48 INFO - PID 1659 | 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) 09:27:49 INFO - PID 1659 | RSS: Main: 276250624 09:27:49 INFO - PID 1659 | 09:27:51 INFO - PID 1659 | 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) 09:27:51 INFO - PID 1659 | RSS: Main: 279064576 09:27:51 INFO - PID 1659 | 09:27:51 INFO - PID 1659 | __start_tp_report 09:27:51 INFO - PID 1659 | _x_x_mozilla_page_load 09:27:51 INFO - PID 1659 | _x_x_mozilla_page_load_details 09:27:51 INFO - PID 1659 | |i|pagename|runs| 09:27:51 INFO - PID 1659 | |0;ai-astar;111;123;123;123;124;118;123;122;121;123 09:27:51 INFO - PID 1659 | |1;audio-beat-detection;140;115;133;152;115;114;115;120;137;117 09:27:51 INFO - PID 1659 | |2;audio-dft;220;213;261;231;314;305;215;206;211;211 09:27:51 INFO - PID 1659 | |3;audio-fft;86;59;68;119;73;65;61;77;93;49 09:27:51 INFO - PID 1659 | |4;audio-oscillator;83;71;91;71;74;70;86;73;75;122 09:27:51 INFO - PID 1659 | |5;imaging-gaussian-blur;91;90;104;139;90;92;91;92;96;90 09:27:51 INFO - PID 1659 | |6;imaging-darkroom;99;100;100;99;114;110;114;113;160;140 09:27:51 INFO - PID 1659 | |7;imaging-desaturate;100;101;98;103;106;120;102;103;103;143 09:27:51 INFO - PID 1659 | |8;json-parse-financial;52;51;52;49;53;54;54;52;53;52 09:27:51 INFO - PID 1659 | |9;json-stringify-tinderbox;61;66;62;73;73;67;62;63;62;60 09:27:51 INFO - PID 1659 | |10;stanford-crypto-aes;90;90;88;87;92;101;92;89;90;90 09:27:51 INFO - PID 1659 | |11;stanford-crypto-ccm;135;150;147;156;165;167;164;169;212;166 09:27:51 INFO - PID 1659 | |12;stanford-crypto-pbkdf2;185;205;202;204;239;252;190;191;203;250 09:27:51 INFO - PID 1659 | |13;stanford-crypto-sha256-iterative;74;85;82;63;97;95;95;101;94;73 09:27:51 INFO - PID 1659 | __end_tp_report 09:27:51 INFO - PID 1659 | __start_cc_report 09:27:51 INFO - PID 1659 | _x_x_mozilla_cycle_collect,1010 09:27:51 INFO - PID 1659 | __end_cc_report 09:27:51 INFO - PID 1659 | __startTimestamp1491668871762__endTimestamp 09:27:51 INFO - PID 1659 | 09:27:51 INFO - PID 1659 | ------- Summary: start ------- 09:27:51 INFO - PID 1659 | Number of tests: 14 09:27:51 INFO - PID 1659 | 09:27:51 INFO - PID 1659 | [#0] ai-astar Cycles:10 Average:121.10 Median:123.00 stddev:3.93 (3.2%) stddev-sans-first:1.79 09:27:51 INFO - PID 1659 | Values: 111.0 123.0 123.0 123.0 124.0 118.0 123.0 122.0 121.0 123.0 09:27:51 INFO - PID 1659 | 09:27:51 INFO - PID 1659 | [#1] audio-beat-detection Cycles:10 Average:125.80 Median:126.50 stddev:13.60 (10.8%) stddev-sans-first:13.42 09:27:51 INFO - PID 1659 | Values: 140.0 115.0 133.0 152.0 115.0 114.0 115.0 120.0 137.0 117.0 09:27:51 INFO - PID 1659 | 09:27:51 INFO - PID 1659 | [#2] audio-dft Cycles:10 Average:238.70 Median:225.50 stddev:40.55 (18.0%) stddev-sans-first:42.44 09:27:51 INFO - PID 1659 | Values: 220.0 213.0 261.0 231.0 314.0 305.0 215.0 206.0 211.0 211.0 09:27:51 INFO - PID 1659 | 09:27:51 INFO - PID 1659 | [#3] audio-fft Cycles:10 Average:75.00 Median:70.50 stddev:20.18 (28.6%) stddev-sans-first:21.01 09:27:51 INFO - PID 1659 | Values: 86.0 59.0 68.0 119.0 73.0 65.0 61.0 77.0 93.0 49.0 09:27:51 INFO - PID 1659 | 09:27:51 INFO - PID 1659 | [#4] audio-oscillator Cycles:10 Average:81.60 Median:74.50 stddev:15.90 (21.3%) stddev-sans-first:16.86 09:27:51 INFO - PID 1659 | Values: 83.0 71.0 91.0 71.0 74.0 70.0 86.0 73.0 75.0 122.0 09:27:51 INFO - PID 1659 | 09:27:51 INFO - PID 1659 | [#5] imaging-gaussian-blur Cycles:10 Average:97.50 Median:91.00 stddev:15.20 (16.7%) stddev-sans-first:15.94 09:27:51 INFO - PID 1659 | Values: 91.0 90.0 104.0 139.0 90.0 92.0 91.0 92.0 96.0 90.0 09:27:51 INFO - PID 1659 | 09:27:51 INFO - PID 1659 | [#6] imaging-darkroom Cycles:10 Average:114.90 Median:127.00 stddev:20.12 (15.8%) stddev-sans-first:20.50 09:27:51 INFO - PID 1659 | Values: 99.0 100.0 100.0 99.0 114.0 110.0 114.0 113.0 160.0 140.0 09:27:51 INFO - PID 1659 | 09:27:51 INFO - PID 1659 | [#7] imaging-desaturate Cycles:10 Average:107.90 Median:104.50 stddev:13.73 (13.1%) stddev-sans-first:14.26 09:27:51 INFO - PID 1659 | Values: 100.0 101.0 98.0 103.0 106.0 120.0 102.0 103.0 103.0 143.0 09:27:51 INFO - PID 1659 | 09:27:51 INFO - PID 1659 | [#8] json-parse-financial Cycles:10 Average:52.20 Median:52.50 stddev:1.48 (2.8%) stddev-sans-first:1.56 09:27:51 INFO - PID 1659 | Values: 52.0 51.0 52.0 49.0 53.0 54.0 54.0 52.0 53.0 52.0 09:27:51 INFO - PID 1659 | 09:27:51 INFO - PID 1659 | [#9] json-stringify-tinderbox Cycles:10 Average:64.90 Median:64.50 stddev:4.77 (7.4%) stddev-sans-first:4.85 09:27:51 INFO - PID 1659 | Values: 61.0 66.0 62.0 73.0 73.0 67.0 62.0 63.0 62.0 60.0 09:27:51 INFO - PID 1659 | 09:27:51 INFO - PID 1659 | [#10] stanford-crypto-aes Cycles:10 Average:90.90 Median:90.00 stddev:3.87 (4.3%) stddev-sans-first:4.09 09:27:51 INFO - PID 1659 | Values: 90.0 90.0 88.0 87.0 92.0 101.0 92.0 89.0 90.0 90.0 09:27:51 INFO - PID 1659 | 09:27:51 INFO - PID 1659 | [#11] stanford-crypto-ccm Cycles:10 Average:163.10 Median:165.50 stddev:20.34 (12.3%) stddev-sans-first:18.87 09:27:51 INFO - PID 1659 | Values: 135.0 150.0 147.0 156.0 165.0 167.0 164.0 169.0 212.0 166.0 09:27:51 INFO - PID 1659 | 09:27:51 INFO - PID 1659 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:212.10 Median:204.50 stddev:25.21 (12.3%) stddev-sans-first:24.76 09:27:51 INFO - PID 1659 | Values: 185.0 205.0 202.0 204.0 239.0 252.0 190.0 191.0 203.0 250.0 09:27:51 INFO - PID 1659 | 09:27:51 INFO - PID 1659 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:85.90 Median:89.50 stddev:12.61 (14.1%) stddev-sans-first:12.62 09:27:51 INFO - PID 1659 | Values: 74.0 85.0 82.0 63.0 97.0 95.0 95.0 101.0 94.0 73.0 09:27:51 INFO - PID 1659 | -------- Summary: end -------- 09:27:51 INFO - PID 1659 | 09:27:51 INFO - PID 1659 | 1491668871788 addons.xpi WARN Add-on deployment-checker@mozilla.org is missing bootstrap method shutdown 09:27:52 INFO - TEST-INFO | 1659: exit 0 09:27:52 INFO - TEST-OK | kraken | took 63524ms 09:27:52 INFO - SUITE-END | took 1179s 09:27:52 INFO - Completed test suite (00:19:39) 09:27:52 INFO - javascript benchmark 09:27:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7926.019520322716, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3444.6555344465555, 3656.7623104498207, 3681.742278040535, 3689.852405903764, 3709.7588656737303, 6268.279147897993, 6344.936550634498, 6376.968115159423, 6412.903806442901, 6445.9677701611545, 6367.9363206367925, 6421.004744264635, 6426.38949299817, 6436.131122298489, 6449.709763060662, 5136.255242989764, 5137.3064636274, 5639.68981706006, 5707.885842283152, 5892.057270836667, 5450.5367043801325, 5703.600747947625, 5744.138379243105, 5882.235309409771, 5942.989691752391, 5071.518205770482, 5527.2538207341895, 5538.252335934638, 5552.7223638817895, 5561.221428999943, 5527.751251193706, 5535.474129957647, 5545.611807173499, 5547.140193270049, 5553.361363443175, 5529.889402211974, 5604.859878503029, 5619.0, 5629.887402251973, 5700.600957932947, 6104.542159338067, 6373.585716928431, 6383.680815959184, 6401.455876250524, 6406.679666016727, 6659.467242620579, 6802.931970680279, 6914.654267286615, 6931.549449285781, 6963.199232088324, 6837.213720422165, 6993.440524758007, 7013.193482749498, 7081.362677359062, 7091.858162836715, 5716.456936591017, 5852.326982396994, 6531.412172904366, 6536.379043990766, 6552.213734351813, 7106.467014973794, 7176.677049532784, 7195.604241766753, 7196.532225405332, 7197.4601904857345, 6074.483668888194, 6501.772437964743, 6626.403623673892, 6629.966850165815, 6793.252742198354, 6729.899051514231, 7064.43484521237, 7072.681729322193, 7072.71709131629, 7078.4691148163065, 5771.278590176228, 6811.4550835933005, 6899.206591242071, 6945.16658001033, 6957.234704182536, 6665.933340666531, 6757.087793147961, 6884.896726549106, 6962.0, 6987.510874238755, 5510.972445137829, 5542.251796007487, 5546.750396232179, 5553.333599968029, 5573.498385145356, 4434.268345722984, 4885.560299573055, 4901.730404827768, 4916.901661966741, 4980.0, 5334.493223143795, 6027.668478233739, 6118.724657390339, 6216.160818289473, 6436.0, 6942.0, 6994.650267486605, 7024.929750702529, 7045.7181712731945, 7054.153501579844, 6453.128827608213, 6470.708818103102, 6471.611703297817, 6478.190226221723, 6482.837929051717, 5993.400659934059, 6048.5161187105805, 6228.5951413158, 6235.906461403082, 6252.09344645033, 5781.971090144607, 6956.40870526011, 7108.857822843617, 7111.53775004623, 7191.065161528968, 7048.083749112582, 7056.188538317954, 7060.952323826238, 7079.079719636415, 7098.858022839618, 7160.0, 7171.49799514029, 7197.028401165776, 7238.52949558277, 7242.637868106679, 6679.966600166968, 6767.390934815693, 6826.078479405217, 6886.414654754402, 6970.581765094111, 7043.190033146254, 7096.290370962863, 7101.82245443868, 7113.893291600527, 7118.110236220473, 5649.152627105967, 6442.516811239082, 6561.606303621798, 6781.38967492928, 6824.624645644339, 6704.329567043452, 6779.288174741581, 6780.186377634715, 6784.76253331131, 6793.320667933167, 5413.5127838493145, 6418.679066046772, 6491.48068154537, 6581.572197807127, 6676.632785196861, 6707.765228216989, 6776.288489708707, 6814.727410903508, 6817.7272909083085, 6884.621345826027, 5487.506124448819, 6629.270780214269, 6639.970804525306, 6640.335966403321, 6656.0348749430095], "value": 6272.4542375873525, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [752.3792870881523, 1123.8089524780787, 1133.0425790207275, 1157.369233767597, 1289.4584274604665, 30622.54066189009, 31896.68103318966, 38523.036924076914, 38592.228155436875, 38815.223695526074, 38193.236135277344, 38373.42439863397, 38628.42057369135, 38669.226615467676, 38680.613193868056, 6016.939830601682, 7859.764207073797, 7975.282224599785, 8003.599820009005, 8014.919850801505, 6128.4178003089855, 7304.598247096407, 7305.963470182642, 8509.617067231959, 8534.914650853474, 8528.445651032695, 8551.957240213791, 8606.268467180296, 8622.913770862306, 8625.913740862605, 7598.582077985709, 8358.665653373857, 8593.527355995418, 8595.95702021492, 8599.484030958163, 8521.275691566225, 8531.957340213321, 8590.527520986343, 8594.785130371729, 8596.183362580545, 38247.852564422836, 38265.23469530594, 38315.0, 38365.84902452931, 38393.040173995876, 3671.3942199537046, 3716.163863130801, 3721.1255354991554, 3723.422869455239, 3731.6641502264656, 30738.616762245754, 30880.691193088005, 30914.690853091408, 30927.845360773277, 31026.379472410426, 3187.7131058204873, 3199.04028791364, 3222.871085156591, 3229.7900636458553, 3233.2078640732934, 282996.0, 283712.0, 285869.57065214746, 288365.0, 290055.5497222521, 40431.59568404337, 41397.1720565587, 50221.74889125531, 50494.99010019779, 50597.24104138441, 39763.427205871114, 50208.497915021115, 50675.49324506782, 50837.0, 51081.48918510842, 14194.14835109876, 14325.426982920566, 14327.35526901292, 14336.354864031144, 14365.856341436662, 11477.598284060185, 11624.825627615592, 11642.592509262304, 11661.591844285409, 11676.124290678234, 12442.81335779964, 12445.502179912883, 12459.626211213677, 12477.875221247852, 12536.059795515373, 5272.261883336336, 5277.97079569488, 5281.9207711884355, 5293.338332708411, 5295.338082739658, 1034.5189486888632, 1035.4563853976722, 1035.5184839049878, 1066.9146468282675, 1075.6127793994156, 18836.0, 24177.516449670908, 24482.265532034067, 24499.26502204901, 24644.630330545056, 1113.3264375052977, 1113.9275947063416, 1147.8565179352581, 1155.2202263472122, 1155.2779512804498, 12250.0, 12399.690007749878, 12511.0, 12538.435770390355, 12539.623811285675, 352949.0, 356311.0, 357241.0, 357966.0, 358168.0, 53970.0, 54468.0, 54513.90972180534, 54535.72732136314, 54565.0, 1491.970160596782, 1534.2175490499926, 1542.1209910351217, 1543.6835448732984, 1547.4506550174751, 18368.816311836712, 24106.51786964286, 24216.636750448404, 24249.63625545583, 24347.14784982517, 38372.808135959145, 38374.23251534898, 38411.80794096012, 38629.03427414225, 38649.03377415587, 319939.0, 321409.0, 321437.0, 321798.0, 322967.3851630821, 34231.0, 34944.475832863034, 35024.94925152249, 35168.76909308162, 35173.0, 45424.869026829816, 45709.77145114253, 46244.306335404326, 46285.611431657104, 46344.0, 29902.70097298999, 29972.250693732833, 30990.0, 31696.20759480939, 31840.5223921646, 30667.846660766554, 30968.535471967487, 31010.712482566127, 31079.533806993364, 31295.530567041056, 30956.845215773777, 31181.68818311788, 37631.43552846655, 37849.432258516696, 37909.620903791714, 24349.513009739352, 28476.288092797844, 30949.535756963214, 31339.216519587193, 31617.683823162395, 23227.767722323235, 24374.26877193687, 24609.753902460747, 24634.260972170865, 24748.38129046788], "value": 17532.43442637252, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [409.3450479233227, 430.3759548654452, 443.04660266022705, 444.53990120225563, 466.91828929937253, 18002.729959050626, 21687.0, 22431.55136897261, 22520.662190067163, 22691.773082269174, 19892.701609475833, 22588.66117008246, 22605.886970565167, 22770.975306111224, 22961.0, 6085.665288409146, 6293.685315734195, 6311.305756366796, 6365.554411191195, 6371.904421433659, 6014.639121652693, 6148.292946311187, 6213.782517611885, 6224.626522408647, 6228.781992630259, 6110.3889611038985, 6124.816255512342, 6140.600860944047, 6191.4118158774845, 6199.907001394983, 6053.303870054934, 6241.531885108612, 6241.531885108635, 6248.094026366151, 6262.2798378186635, 5448.863778405532, 5471.069918113891, 5525.281713377275, 5528.834134975958, 5533.197686335499, 26146.73853261462, 26635.934562617473, 26708.931642734267, 26981.865090674422, 27088.32279193036, 2178.074318414683, 2227.9554408911895, 2245.0458555114174, 2249.8650080995194, 2250.3024062540503, 14349.56951291463, 17355.826441735673, 17519.386821461187, 17922.462326130106, 18083.54791130219, 2149.9032543535577, 2188.420068681801, 2216.5012872103807, 2222.9333120006427, 2228.4094714900566, 117869.41065294704, 124269.0, 150919.24540377338, 151362.24318878446, 151437.0, 12149.08881833866, 12289.815652765215, 12444.937775311066, 12460.688482787822, 12626.179298345578, 16154.030758154548, 16436.6712665746, 16448.506544803677, 16455.588610284838, 16592.751108733377, 8767.079456657088, 9041.63833446668, 9044.196299147285, 9075.818483630423, 9210.861837072449, 7312.268773122645, 8285.130061343592, 8675.00237472686, 8759.386842921062, 8774.29805615562, 6743.055972163901, 6831.6242606657115, 7683.039620047494, 7788.883166752503, 7915.366770658334, 2235.6087684655445, 2253.4929640830683, 2257.9774202257768, 2260.536589999046, 2434.4400787818545, 947.6020071569957, 956.784723437221, 960.1934375124929, 961.5480524662083, 1005.2460654509118, 18937.526561836065, 19484.051594840403, 19896.50258743543, 19979.800201998085, 20187.596248074955, 906.5376657904384, 916.0427353415697, 982.3712823792779, 1009.9697009089739, 1010.883748368947, 8914.643414263357, 10288.639897603547, 10339.793204135874, 10365.274430789772, 10369.325993810378, 688693.0, 696352.0, 697021.0, 704231.0, 718238.0, 143307.0, 145263.54736452713, 158801.0, 164001.17999409928, 166311.168444157, 1054.330500132406, 1157.785809625222, 1181.8522684664417, 1198.3888217009214, 1207.1248344950016, 16773.748393774345, 17429.564260893578, 17461.30154793794, 17496.387626433014, 17715.468535943943, 55456.722716387776, 56167.15749263683, 56857.431425685216, 60704.6964765191, 65048.674756627806, 75547.24452755402, 77120.61439692766, 77527.61236193783, 78516.0, 78929.0, 7453.0, 8688.087750786077, 8796.076411976906, 8848.1151884811, 8938.37431379797, 13568.0, 13835.654108647364, 13836.515721950087, 14122.929385353007, 14194.716105678035, 9872.420412733929, 11744.725780425098, 11806.291622502677, 11906.737719833203, 12037.578684745991, 10851.837222441512, 10989.945050274697, 11182.713987891171, 11253.212275140662, 11333.886661133283, 11303.434828258718, 11713.004394626212, 12128.514859405524, 12166.39168041612, 12252.387380630755, 6631.3700198481065, 7385.224551422023, 8804.647814087364, 8878.955605221932, 8910.198082172636, 11539.596114135966, 11784.58753943608, 12001.819972700241, 12011.939940300243, 12109.394530273627], "value": 10424.553538337183, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1356.5116558039103, 1410.3935307817642, 1411.0404924651239, 1416.3201663201658, 1435.2967046147392, 11548.769024619503, 11849.585264515743, 11881.049516038707, 11957.880421195785, 12254.326012069332, 11712.531498740062, 11881.742468930897, 11889.7622047559, 11905.797427475924, 11915.987141092995, 2370.8577485350847, 2400.195934361991, 2411.855288682676, 2413.5776239158076, 2421.116292553223, 2384.4396566806786, 2460.2004348586693, 2465.7287698353166, 2481.280428675682, 2484.813638977075, 2326.7673232676766, 2351.811855051592, 2358.5636657218383, 2442.4016116051594, 2460.1266550374626, 2296.471811483368, 2406.278116565032, 2416.540857237128, 2423.9151629692965, 2450.375154335633, 2059.783722709124, 2153.4723992621907, 2379.892904819287, 2460.3480077779404, 2463.0, 11953.22304050234, 12026.759464810742, 12106.394680265952, 12107.39463026854, 12127.09046821492, 6410.294867564564, 6572.507061970371, 6648.401643852028, 6655.733770649168, 6663.4669226461765, 3408.744344174172, 4173.833046678129, 4190.5180904195795, 4237.0, 4245.915081698348, 1249.8125281207801, 1259.055708218836, 1269.8603153653091, 1285.4408332375353, 1301.8633043530483, 14987.475438359714, 15383.615409614737, 16691.332346706116, 16825.83174168255, 16869.66260674792, 4722.1028004679, 5262.526372626406, 5470.835874923759, 5578.748956296977, 5611.859703507445, 12113.273203607812, 12384.380780960915, 12410.503579856886, 12415.068869834618, 12520.1235913487, 6474.902876456857, 6483.513736469784, 6492.772752953719, 6513.088167656532, 6513.739450422025, 5956.0, 6012.6392416455155, 6033.637981721111, 6077.513798896166, 6105.0, 4432.977835110868, 4506.481754598198, 4561.384213131185, 4597.448306203277, 4598.908021839611, 1289.2071376103816, 1307.378994977397, 1313.9211647301192, 1326.7545504081775, 1331.2877610478347, 687.7249100359896, 783.4280974888363, 797.2625321577517, 798.9480683755537, 804.3324041045918, 4586.334981427674, 6213.409726076015, 6378.712957916812, 6381.202349706286, 6413.749318882867, 542.3925203771801, 545.0380079160285, 552.6269767906647, 555.2310050579895, 566.3260719743492, 3527.7530572859655, 4315.07225946423, 4471.23988921884, 4571.885702857455, 4641.512641172696, 14972.17653029072, 15006.774898376532, 15453.768193477106, 15530.223488825513, 15569.377224911103, 15325.23373831304, 15400.0, 15489.922550387177, 15497.302621382065, 15503.767443488357, 10819.621313253998, 10905.509252083675, 11022.669319920415, 11024.779504409868, 11186.832197517206, 7028.297170282931, 7039.824004399931, 7128.108986376703, 7172.892406613801, 7190.604516751629, 13498.59504214875, 13637.113587616774, 13861.722765544431, 14018.018738688603, 14140.363683634056, 13527.526536571173, 13982.300884955916, 14040.578782636538, 14106.788398174242, 14196.006279560332, 7683.961580192287, 9544.713658590254, 9680.709578712649, 9689.273304502332, 9728.416295022322, 10839.945800270949, 10937.671869843918, 10954.068904143238, 10955.780884382428, 10958.178136639943, 9179.495127768037, 9317.72046838596, 9391.248700104112, 9401.20089792348, 9518.428894266366, 9210.585523651318, 9253.074692530694, 9287.164155226063, 9304.860427093734, 9325.487098209664, 8051.637676304697, 8336.708215212439, 8402.327813775006, 8460.407771456184, 8473.57632118404, 6078.635281883101, 6093.421124993119, 6136.171616831671, 6201.317855036033, 6321.083442900662, 6094.481969032682, 6151.784687535915, 6275.466585340115, 6329.90505142414, 6330.113784070326], "value": 5358.593592211887, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.96348401675795, 370.3666729891885, 389.69409013924076, 389.8927794856414, 394.5009562902927, 5518.503334699886, 5768.932747441721, 6184.381561843819, 6195.614688344986, 6399.64801935894, 4905.969746353261, 6180.1656776335185, 6191.845203869905, 6209.2924445777435, 6222.782202622909, 3580.427131658935, 3752.8123593820337, 4477.686561940665, 4514.480834704002, 4540.296254080615, 4328.891777705551, 4329.610335069843, 4473.910521789562, 4533.6146427553695, 4581.450225972888, 3509.9294715111882, 4262.254105531535, 4344.45694288214, 4414.492333381654, 4440.378347031418, 3547.9113022174392, 4150.709450338478, 4244.731556701338, 4296.6777491687935, 4433.578810013044, 3079.491883839164, 3819.236152769457, 3821.48409964654, 3825.2540754552874, 3828.55971563271, 4963.652544321899, 4971.4282857471135, 6013.338532761437, 6107.106796892977, 6121.694285086048, 5142.974285128588, 5322.441143679896, 5326.174442961347, 5363.0, 5365.624406291561, 6436.195475565554, 6611.4380277676455, 6615.636140012298, 6624.635645039569, 6691.397774200345, 3526.7531272810916, 3872.625218047581, 4320.4599425071865, 4334.241507736134, 4353.28170851809, 6231.813045608639, 6736.595804251711, 6835.282295359015, 6947.305269473063, 6964.303569643046, 4391.60475557195, 4393.045094932788, 4431.0694754102, 4471.306947423154, 4549.158405694957, 3642.4718415829557, 4151.813168407429, 4264.189803937304, 4532.342810292489, 4535.387722657465, 4541.091781643684, 5091.5672167865405, 5270.522854258493, 5378.78484860609, 5393.8112166074, 5488.368837583729, 6484.286728459866, 6694.397504224643, 6726.22648395431, 6764.5603035802515, 1316.8222289990729, 1535.7696345548034, 1544.1970175508673, 1550.3488534815406, 1554.401555401156, 850.8468475674438, 957.7270477913901, 1000.3047881722279, 1005.3565717940523, 1018.5467466977273, 5386.357161065913, 5609.156828669017, 5627.859303517363, 6331.430171284606, 6422.614643121427, 6674.599524028574, 7004.299570042955, 7021.297870212938, 7026.367626913602, 7070.292970702992, 5709.600327977002, 5742.306019724191, 5970.432808883236, 6048.334683184846, 6302.842428939313, 3361.378145043126, 3364.6467120951947, 3592.1558433768046, 3612.422012477991, 3678.3746763050344, 6131.570790044743, 6153.815385538441, 6601.73593056282, 7082.433405327562, 7162.033125527987, 7061.576305421691, 7128.6435678215885, 7143.678534465961, 7175.748848790267, 7176.461765367514, 5907.320658124285, 6932.3414275644745, 7179.317964793337, 7181.676824543013, 7223.8328501450405, 5643.435656434323, 6269.40440658155, 6555.2133743951035, 6984.476164287597, 6986.4979029508895, 5759.683217423082, 6430.549861509649, 6561.212654481493, 6830.521863469509, 6865.828354291183, 5889.764409423747, 7015.842870708099, 7221.566705997657, 7235.493515454078, 7244.275572442713, 4432.35730819023, 4438.9556104439835, 4492.685512014127, 4494.325851122358, 4495.303227999665, 6066.090086487062, 6794.199537122765, 7014.40377567892, 7026.367626913602, 7067.25793791665, 5666.886662266814, 6691.1636045494315, 6715.294894036251, 6717.462602991846, 6719.740925651153, 5582.581306401955, 6438.036398898381, 6656.633885136364, 6702.564333318319, 6762.0, 6632.104665870239, 6648.335166483506, 6659.500537459807, 6672.332766723289, 6689.665516724242, 6484.795169642344, 6666.83332916681, 6799.354061364163, 6822.624755638289, 6850.623215722983, 5621.297337832771, 6392.4246817786625, 6560.0, 6563.474922006323, 6591.824697849602], "value": 4749.1626325196, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [839.1482645115213, 853.7438768369492, 870.0, 874.923843672283, 888.9199972002518, 16235.83764162358, 16959.83040169598, 17019.574510637223, 18276.90338579686, 19059.714104288447, 18021.549461263476, 18242.726359104625, 18307.816921830778, 18446.631067378643, 18694.065296735178, 986.6349450703214, 990.3067852503259, 999.3953658036892, 1016.6645007147661, 1022.8823685276177, 824.9793755156109, 1029.474967766437, 1030.8969103089705, 1031.3193292426963, 1031.700806766037, 1059.4808543813554, 1062.978740425191, 1068.0, 1080.4975686305866, 1081.5295346524288, 1057.8254587992972, 1067.140951534015, 1070.3203465799195, 1072.7264547540406, 1074.312440038376, 763.2977660552306, 770.1989930472303, 781.4998401023349, 789.1556035042507, 789.9368050556, 16605.4188103417, 17249.22378492971, 17389.82610173895, 17420.216090275968, 17439.38962136332, 14342.856571434257, 17333.04668243246, 17421.912890435593, 17433.0, 17664.823351766445, 13666.863331366658, 13956.860431395658, 14206.786898196535, 14207.928960355131, 14304.785428218585, 3472.531208286874, 3519.5072689823446, 3520.2959408118477, 3549.2546565221332, 3553.982230088859, 122953.0, 123407.0, 123945.0, 125853.19027668067, 126488.47023059579, 13128.934355328352, 13354.933225334005, 13456.125351852099, 13471.797923031163, 13495.25776082325, 24825.5034899301, 25187.496250074895, 25321.366965826, 25448.363790905376, 25476.363090922874, 8768.07935166811, 8828.028916819145, 8868.423552469068, 8870.246029087471, 8884.200421962054, 4117.5882411758585, 4667.603253723403, 4771.856844294677, 4838.129136755418, 4838.830640927551, 4355.281378572563, 4452.8218871245435, 4453.0, 4457.9331310030375, 4465.776711164429, 950.1780959470009, 955.398099197515, 967.6468089147411, 972.5720682899502, 973.7955029443755, 644.3685188515282, 665.065582856088, 673.2560520624737, 679.7281087564915, 698.5354739098544, 11268.774624507463, 11943.940280298542, 12139.271643701406, 12196.57311994076, 12323.75352492963, 648.2628735689113, 664.7008846019311, 669.9062131301622, 694.5763084518439, 697.4037198195571, 5508.91736623951, 5557.694326811983, 5647.435256474319, 5709.857253568611, 5818.185454036438, 80145.0, 107711.0, 110260.89739102506, 111648.44175779069, 112486.0, 87473.0, 88814.0, 89784.0, 90433.09566904379, 90651.0, 74165.88751168629, 74482.0, 78601.0, 79984.0, 80226.79659805108, 11883.108766842348, 12365.876341236832, 12440.19138755978, 12499.250044997329, 12518.0, 40610.79694601508, 41151.38272925848, 41850.79074604608, 41917.95205119896, 42576.5742342585, 50313.748431259075, 50340.74148146326, 50710.746446267534, 50843.74578127086, 51499.742501287255, 13198.472061117447, 15902.920485397499, 16115.113668748332, 16223.432179873647, 16336.836631633532, 14614.780778288547, 17938.730919036487, 17950.640987179922, 18239.0880455974, 18301.176447059646, 16190.595235118744, 16342.918285408972, 16384.67230655404, 16505.17474126265, 16641.83358166403, 13462.663433414244, 16226.67546649084, 16538.255778489754, 16590.0, 16688.916555417632, 15726.842731572995, 15805.920970395075, 16299.266533006281, 16302.755458667893, 16351.59121021984, 11687.0, 11799.292042477478, 11919.76160476803, 12164.330961797186, 12261.69345766363, 12859.0, 13780.724385512032, 13868.375923083284, 14006.859931400963, 14072.859271407155], "value": 8497.5801987173, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1631.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 123.0, 123.0, 123.0, 124.0, 118.0, 123.0, 122.0, 121.0, 123.0], "value": 121.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 115.0, 133.0, 152.0, 115.0, 114.0, 115.0, 120.0, 137.0, 117.0], "value": 125.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [220.0, 213.0, 261.0, 231.0, 314.0, 305.0, 215.0, 206.0, 211.0, 211.0], "value": 238.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 59.0, 68.0, 119.0, 73.0, 65.0, 61.0, 77.0, 93.0, 49.0], "value": 75.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 71.0, 91.0, 71.0, 74.0, 70.0, 86.0, 73.0, 75.0, 122.0], "value": 81.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 90.0, 104.0, 139.0, 90.0, 92.0, 91.0, 92.0, 96.0, 90.0], "value": 97.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 100.0, 100.0, 99.0, 114.0, 110.0, 114.0, 113.0, 160.0, 140.0], "value": 114.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 101.0, 98.0, 103.0, 106.0, 120.0, 102.0, 103.0, 103.0, 143.0], "value": 107.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 52.0, 49.0, 53.0, 54.0, 54.0, 52.0, 53.0, 52.0], "value": 52.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 66.0, 62.0, 73.0, 73.0, 67.0, 62.0, 63.0, 62.0, 60.0], "value": 64.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 90.0, 88.0, 87.0, 92.0, 101.0, 92.0, 89.0, 90.0, 90.0], "value": 90.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 150.0, 147.0, 156.0, 165.0, 167.0, 164.0, 169.0, 212.0, 166.0], "value": 163.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 205.0, 202.0, 204.0, 239.0, 252.0, 190.0, 191.0, 203.0, 250.0], "value": 212.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 85.0, 82.0, 63.0, 97.0, 95.0, 95.0, 101.0, 94.0, 73.0], "value": 85.9, "unit": "score"}]}]} 09:27:52 INFO - Return code: 0 09:27:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:27:53 ERROR - # TBPL SUCCESS # 09:27:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:27:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:27:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:27:53 INFO - 2017-04-08 09:27:53.083 screenresolution[1664:12598] starting screenresolution argv=screenresolution get 09:27:53 INFO - 2017-04-08 09:27:53.086 screenresolution[1664:12598] Display 0: 1600x1200x32@60 09:27:53 INFO - 2017-04-08 09:27:53.092 screenresolution[1665:12601] starting screenresolution argv=screenresolution list 09:27:53 INFO - Available Modes on Display 0 09:27:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:27:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:27:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:27:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:27:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:27:53 INFO - Intel Iris: 09:27:53 INFO - Chipset Model: Intel Iris 09:27:53 INFO - Type: GPU 09:27:53 INFO - Bus: Built-In 09:27:53 INFO - VRAM (Dynamic, Max): 1536 MB 09:27:53 INFO - Vendor: Intel (0x8086) 09:27:53 INFO - Device ID: 0x0a2e 09:27:53 INFO - Revision ID: 0x0009 09:27:53 INFO - Displays: 09:27:53 INFO - Display: 09:27:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:27:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:27:53 INFO - Display Serial Number: 1600x1200 60 09:27:53 INFO - Main Display: Yes 09:27:53 INFO - Mirror: Off 09:27:53 INFO - Online: Yes 09:27:53 INFO - Rotation: Supported 09:27:53 INFO - Return code: 0 09:27:53 INFO - Running post-action listener: _resource_record_post_action 09:27:53 INFO - [mozharness: 2017-04-08 16:27:53.337819Z] Finished run-tests step (success) 09:27:53 INFO - Running post-run listener: _resource_record_post_run 09:27:53 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 33702400; Write bytes: 525179904; Read time: 203; Write time: 1698 09:27:53 INFO - TinderboxPrint: CPU usage
54.2% 09:27:53 INFO - TinderboxPrint: I/O read bytes / time
33,702,400 / 203 09:27:53 INFO - TinderboxPrint: I/O write bytes / time
525,179,904 / 1,698 09:27:53 INFO - TinderboxPrint: CPU idle
2,198.8 (45.8%) 09:27:53 INFO - TinderboxPrint: CPU system
964.3 (20.1%) 09:27:53 INFO - TinderboxPrint: CPU user
1,638.6 (34.1%) 09:27:53 INFO - TinderboxPrint: Swap in / out
251,936,768 / 0 09:27:53 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 196278784; Write bytes: 191725568; Read time: 14894; Write time: 411 09:27:53 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 32813568; Write bytes: 316562432; Read time: 193; Write time: 1235 09:27:53 INFO - Running post-run listener: _upload_blobber_files 09:27:53 INFO - Blob upload gear active. 09:27:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:27:53 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 09:27:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:27:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:27:54 INFO - (blobuploader) - INFO - Open directory for files ... 09:27:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:27:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:27:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:27:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:27:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:27:55 INFO - (blobuploader) - INFO - Done attempting. 09:27:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:27:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:27:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:27:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:27:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:27:56 INFO - (blobuploader) - INFO - Done attempting. 09:27:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:27:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:27:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:27:57 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:27:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:27:57 INFO - (blobuploader) - INFO - Done attempting. 09:27:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:27:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:27:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:27:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:27:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:27:59 INFO - (blobuploader) - INFO - Done attempting. 09:27:59 INFO - (blobuploader) - INFO - Iteration through files over. 09:27:59 INFO - Return code: 0 09:27:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:27:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:27:59 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc9a3e8907b708766463b10686ee571609d3c1f8dc212e277eebde733be81d46892cd1388751177aeb0c71f9ba959e92a0d325021aa887cfadfbb383d53d6db3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d92703e8334d62f65808710996b965263375a4cefb7a67a9778128b71a8428c1bca8d646100d6e4b04c4eff0798d1aae20c94d0e7a5ac4d45aa32a83877ed57c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f838e775022605c913eee546b8f8220b3f7166602dfa52b2fef586414d51eb34348101a5b64754bfaeb5e40345316b3413ead25d36d5469995ffa9e716e7f188", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7066d68592e261b43a5bc88f1aa94b933acdc9539805fc94ef7320a401c48ebdbca57576979e76f8b5e2251ea4ac9869617cf995e091e288cb9630f54ff04da3"} 09:27:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:27:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:27:59 INFO - Contents: 09:27:59 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc9a3e8907b708766463b10686ee571609d3c1f8dc212e277eebde733be81d46892cd1388751177aeb0c71f9ba959e92a0d325021aa887cfadfbb383d53d6db3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d92703e8334d62f65808710996b965263375a4cefb7a67a9778128b71a8428c1bca8d646100d6e4b04c4eff0798d1aae20c94d0e7a5ac4d45aa32a83877ed57c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f838e775022605c913eee546b8f8220b3f7166602dfa52b2fef586414d51eb34348101a5b64754bfaeb5e40345316b3413ead25d36d5469995ffa9e716e7f188", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7066d68592e261b43a5bc88f1aa94b933acdc9539805fc94ef7320a401c48ebdbca57576979e76f8b5e2251ea4ac9869617cf995e091e288cb9630f54ff04da3"} 09:27:59 INFO - Running post-run listener: copy_logs_to_upload_dir 09:27:59 INFO - Copying logs to upload dir... 09:27:59 INFO - mkdir: /builds/slave/test/build/upload/logs 09:27:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.716236 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-04-08 09:27:59.764636) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-08 09:27:59.767996) ========= 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.prrqYMnQLF/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.eYswjMDGlB/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc9a3e8907b708766463b10686ee571609d3c1f8dc212e277eebde733be81d46892cd1388751177aeb0c71f9ba959e92a0d325021aa887cfadfbb383d53d6db3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d92703e8334d62f65808710996b965263375a4cefb7a67a9778128b71a8428c1bca8d646100d6e4b04c4eff0798d1aae20c94d0e7a5ac4d45aa32a83877ed57c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f838e775022605c913eee546b8f8220b3f7166602dfa52b2fef586414d51eb34348101a5b64754bfaeb5e40345316b3413ead25d36d5469995ffa9e716e7f188", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7066d68592e261b43a5bc88f1aa94b933acdc9539805fc94ef7320a401c48ebdbca57576979e76f8b5e2251ea4ac9869617cf995e091e288cb9630f54ff04da3"} build_url:https://queue.taskcluster.net/v1/task/EcasZOetREOO4XVgNywWvg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011102 build_url: 'https://queue.taskcluster.net/v1/task/EcasZOetREOO4XVgNywWvg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc9a3e8907b708766463b10686ee571609d3c1f8dc212e277eebde733be81d46892cd1388751177aeb0c71f9ba959e92a0d325021aa887cfadfbb383d53d6db3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d92703e8334d62f65808710996b965263375a4cefb7a67a9778128b71a8428c1bca8d646100d6e4b04c4eff0798d1aae20c94d0e7a5ac4d45aa32a83877ed57c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f838e775022605c913eee546b8f8220b3f7166602dfa52b2fef586414d51eb34348101a5b64754bfaeb5e40345316b3413ead25d36d5469995ffa9e716e7f188", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7066d68592e261b43a5bc88f1aa94b933acdc9539805fc94ef7320a401c48ebdbca57576979e76f8b5e2251ea4ac9869617cf995e091e288cb9630f54ff04da3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-08 09:27:59.802931) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-08 09:27:59.803278) ========= 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.prrqYMnQLF/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.eYswjMDGlB/Listeners TMPDIR=/var/folders/cq/fm9x62sj2nq5lg90gjyc1tb000000w/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.005240 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-08 09:27:59.852694) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-08 09:27:59.853034) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-08 09:27:59.853373) ========= ========= Total master_lag: 0.18 =========