builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0065 starttime: 1487902174.13 results: success (0) buildid: 20170223164436 builduid: b81aeb30ae9a4ec5993093c15883be7d revision: 2e4452df31d638985001179030bacb1b4b064c75 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-23 18:09:34.132250) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-23 18:09:34.132772) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-23 18:09:34.133043) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-23 18:09:34.157880) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 18:09:34.158364) ========= 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.ATjBhOMtEP/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.cL0MlXKeUf/Listeners TMPDIR=/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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-02-23 18:09:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 157M=0s 2017-02-23 18:09:34 (157 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.105680 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 18:09:34.288098) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 18:09:34.288420) ========= 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.ATjBhOMtEP/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.cL0MlXKeUf/Listeners TMPDIR=/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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.021361 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 18:09:34.338295) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-23 18:09:34.338679) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2e4452df31d638985001179030bacb1b4b064c75 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2e4452df31d638985001179030bacb1b4b064c75 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ATjBhOMtEP/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.cL0MlXKeUf/Listeners TMPDIR=/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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-02-23 18:09:34,425 truncating revision to first 12 chars 2017-02-23 18:09:34,425 Setting DEBUG logging. 2017-02-23 18:09:34,425 attempt 1/10 2017-02-23 18:09:34,425 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/2e4452df31d6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-23 18:09:35,740 unpacking tar archive at: mozilla-aurora-2e4452df31d6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.584974 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-23 18:09:35.947333) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-23 18:09:35.947766) ========= script_repo_revision: 2e4452df31d638985001179030bacb1b4b064c75 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-23 18:09:35.948326) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-23 18:09:35.948606) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-23 18:09:35.967675) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-02-23 18:09:35.968032) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ATjBhOMtEP/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.cL0MlXKeUf/Listeners TMPDIR=/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 18:09:36 INFO - MultiFileLogger online at 20170223 18:09:36 in /builds/slave/test 18:09:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 18:09:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:09:36 INFO - {'append_to_log': False, 18:09:36 INFO - 'base_work_dir': '/builds/slave/test', 18:09:36 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 18:09:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:09:36 INFO - 'branch': 'Mozilla-Aurora', 18:09:36 INFO - 'buildbot_json_path': 'buildprops.json', 18:09:36 INFO - 'config_files': ('talos/mac_config.py',), 18:09:36 INFO - 'default_actions': ('clobber', 18:09:36 INFO - 'read-buildbot-config', 18:09:36 INFO - 'download-and-extract', 18:09:36 INFO - 'populate-webroot', 18:09:36 INFO - 'create-virtualenv', 18:09:36 INFO - 'install', 18:09:36 INFO - 'run-tests'), 18:09:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:09:36 INFO - 'download_minidump_stackwalk': True, 18:09:36 INFO - 'download_symbols': 'ondemand', 18:09:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:09:36 INFO - 'tooltool.py': '/tools/tooltool.py', 18:09:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:09:36 INFO - '/tools/misc-python/virtualenv.py')}, 18:09:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:09:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:09:36 INFO - 'installer_path': 'installer.exe', 18:09:36 INFO - 'log_level': 'info', 18:09:36 INFO - 'log_name': 'talos', 18:09:36 INFO - 'log_to_console': True, 18:09:36 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:09:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:09:36 INFO - 'opt_config_files': (), 18:09:36 INFO - 'pip_index': False, 18:09:36 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:09:36 INFO - 'cmd': ('bash', 18:09:36 INFO - '-c', 18:09:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:09:36 INFO - 'enabled': True, 18:09:36 INFO - 'halt_on_failure': False, 18:09:36 INFO - 'name': 'check_screen_resolution'},), 18:09:36 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:09:36 INFO - 'cmd': ('bash', 18:09:36 INFO - '-c', 18:09:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:09:36 INFO - 'enabled': True, 18:09:36 INFO - 'halt_on_failure': False, 18:09:36 INFO - 'name': 'check_screen_resolution'},), 18:09:36 INFO - 'run_cmd_checks_enabled': True, 18:09:36 INFO - 'sps_profile': False, 18:09:36 INFO - 'sps_profile_interval': 0, 18:09:36 INFO - 'suite': 'dromaeojs-e10s', 18:09:36 INFO - 'system_bits': '32', 18:09:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:09:36 INFO - 'title': 't-yosemite-r7-0065', 18:09:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:09:36 INFO - 'use_talos_json': True, 18:09:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:09:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:09:36 INFO - 'work_dir': 'build'} 18:09:36 INFO - [mozharness: 2017-02-24 02:09:36.181382Z] Running clobber step. 18:09:36 INFO - Running pre-action listener: _resource_record_pre_action 18:09:36 INFO - Running main action method: clobber 18:09:36 INFO - rmtree: /builds/slave/test/build 18:09:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:09:38 INFO - Running post-action listener: _resource_record_post_action 18:09:38 INFO - [mozharness: 2017-02-24 02:09:38.191842Z] Finished clobber step (success) 18:09:38 INFO - [mozharness: 2017-02-24 02:09:38.191968Z] Running read-buildbot-config step. 18:09:38 INFO - Running pre-action listener: _resource_record_pre_action 18:09:38 INFO - Running main action method: read_buildbot_config 18:09:38 INFO - Using buildbot properties: 18:09:38 INFO - { 18:09:38 INFO - "project": "", 18:09:38 INFO - "product": "firefox", 18:09:38 INFO - "script_repo_revision": "production", 18:09:38 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 18:09:38 INFO - "repository": "", 18:09:38 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 18:09:38 INFO - "buildid": "20170223164436", 18:09:38 INFO - "pgo_build": "False", 18:09:38 INFO - "basedir": "/builds/slave/test", 18:09:38 INFO - "buildnumber": 49, 18:09:38 INFO - "slavename": "t-yosemite-r7-0065", 18:09:38 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 18:09:38 INFO - "platform": "yosemite_r7", 18:09:38 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 18:09:38 INFO - "branch": "mozilla-aurora", 18:09:38 INFO - "repo_path": "releases/mozilla-aurora", 18:09:38 INFO - "revision": "2e4452df31d638985001179030bacb1b4b064c75", 18:09:38 INFO - "stage_platform": "macosx64", 18:09:38 INFO - "builduid": "b81aeb30ae9a4ec5993093c15883be7d", 18:09:38 INFO - "slavebuilddir": "test" 18:09:38 INFO - } 18:09:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/HLzyw1RaSM6d6Oqs3hbE1g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 18:09:38 INFO - Running post-action listener: _resource_record_post_action 18:09:38 INFO - [mozharness: 2017-02-24 02:09:38.195330Z] Finished read-buildbot-config step (success) 18:09:38 INFO - [mozharness: 2017-02-24 02:09:38.195438Z] Running download-and-extract step. 18:09:38 INFO - Running pre-action listener: _resource_record_pre_action 18:09:38 INFO - Running main action method: download_and_extract 18:09:38 INFO - mkdir: /builds/slave/test/build/tests 18:09:38 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')]} 18:09:38 INFO - trying https://queue.taskcluster.net/v1/task/HLzyw1RaSM6d6Oqs3hbE1g/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 18:09:38 INFO - Downloading https://queue.taskcluster.net/v1/task/HLzyw1RaSM6d6Oqs3hbE1g/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 18:09:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HLzyw1RaSM6d6Oqs3hbE1g/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 18:09:39 INFO - Downloaded 1199 bytes. 18:09:39 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 18:09:39 INFO - Using the following test package requirements: 18:09:39 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 18:09:39 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 18:09:39 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 18:09:39 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 18:09:39 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 18:09:39 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 18:09:39 INFO - u'jsshell-mac.zip'], 18:09:39 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 18:09:39 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 18:09:39 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 18:09:39 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 18:09:39 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 18:09:39 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 18:09:39 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 18:09:39 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 18:09:39 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 18:09:39 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 18:09:39 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 18:09:39 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 18:09:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HLzyw1RaSM6d6Oqs3hbE1g/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 18:09:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HLzyw1RaSM6d6Oqs3hbE1g/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 18:09:39 INFO - Fetch https://queue.taskcluster.net/v1/task/HLzyw1RaSM6d6Oqs3hbE1g/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 18:09:40 INFO - Expected file size: 16357485 18:09:40 INFO - Obtained file size: 16357485 18:09:47 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 18:09:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HLzyw1RaSM6d6Oqs3hbE1g/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 18:09:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HLzyw1RaSM6d6Oqs3hbE1g/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 18:09:47 INFO - Fetch https://queue.taskcluster.net/v1/task/HLzyw1RaSM6d6Oqs3hbE1g/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 18:09:48 INFO - Expected file size: 16357485 18:09:48 INFO - Obtained file size: 16357485 18:09:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HLzyw1RaSM6d6Oqs3hbE1g/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 18:09:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HLzyw1RaSM6d6Oqs3hbE1g/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 18:09:54 INFO - Fetch https://queue.taskcluster.net/v1/task/HLzyw1RaSM6d6Oqs3hbE1g/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 18:09:55 INFO - Expected file size: 14403472 18:09:55 INFO - Obtained file size: 14403472 18:09:56 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')]} 18:09:56 INFO - trying https://queue.taskcluster.net/v1/task/HLzyw1RaSM6d6Oqs3hbE1g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 18:09:56 INFO - Downloading https://queue.taskcluster.net/v1/task/HLzyw1RaSM6d6Oqs3hbE1g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 18:09:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HLzyw1RaSM6d6Oqs3hbE1g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 18:09:58 INFO - Downloaded 73936212 bytes. 18:09:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HLzyw1RaSM6d6Oqs3hbE1g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 18:09:58 INFO - mkdir: /builds/slave/test/properties 18:09:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:09:58 INFO - Writing to file /builds/slave/test/properties/build_url 18:09:58 INFO - Contents: 18:09:58 INFO - build_url:https://queue.taskcluster.net/v1/task/HLzyw1RaSM6d6Oqs3hbE1g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 18:09:58 INFO - Running post-action listener: _resource_record_post_action 18:09:58 INFO - Running post-action listener: set_extra_try_arguments 18:09:58 INFO - [mozharness: 2017-02-24 02:09:58.806981Z] Finished download-and-extract step (success) 18:09:58 INFO - [mozharness: 2017-02-24 02:09:58.807108Z] Running populate-webroot step. 18:09:58 INFO - Running pre-action listener: _resource_record_pre_action 18:09:58 INFO - Running main action method: populate_webroot 18:09:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:09:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:09:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:09:58 INFO - '--tppagecycles', 18:09:58 INFO - '7'], 18:09:58 INFO - 'tests': ['tsvgm']}}, 18:09:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:09:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:09:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:09:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:09:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:09:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:09:58 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 18:09:58 INFO - 'talos_options': ['--disable-e10s'], 18:09:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:09:58 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:09:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:09:58 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 18:09:58 INFO - 'talos_options': ['--disable-e10s'], 18:09:58 INFO - 'tests': ['damp', 'tps']}, 18:09:58 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:09:58 INFO - 'tests': ['damp', 'tps']}, 18:09:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:09:58 INFO - 'tests': ['dromaeo_dom']}, 18:09:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:09:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:09:58 INFO - 'tests': ['basic_compositor_video']}, 18:09:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:09:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:09:58 INFO - 'tests': ['a11yr', 18:09:58 INFO - 'ts_paint', 18:09:58 INFO - 'tpaint', 18:09:58 INFO - 'sessionrestore', 18:09:58 INFO - 'sessionrestore_no_auto_restore', 18:09:58 INFO - 'tabpaint']}, 18:09:58 INFO - 'other-e10s': {'tests': ['a11yr', 18:09:58 INFO - 'ts_paint', 18:09:58 INFO - 'tpaint', 18:09:58 INFO - 'sessionrestore', 18:09:58 INFO - 'sessionrestore_no_auto_restore', 18:09:58 INFO - 'tabpaint']}, 18:09:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:09:58 INFO - 'ts_paint', 18:09:58 INFO - 'tpaint', 18:09:58 INFO - 'sessionrestore', 18:09:58 INFO - 'sessionrestore_no_auto_restore', 18:09:58 INFO - 'tabpaint']}, 18:09:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:09:58 INFO - 'ts_paint', 18:09:58 INFO - 'tpaint', 18:09:58 INFO - 'sessionrestore', 18:09:58 INFO - 'sessionrestore_no_auto_restore', 18:09:58 INFO - 'tabpaint']}, 18:09:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:09:58 INFO - 'tests': ['a11yr', 18:09:58 INFO - 'ts_paint', 18:09:58 INFO - 'tpaint', 18:09:58 INFO - 'sessionrestore', 18:09:58 INFO - 'sessionrestore_no_auto_restore', 18:09:58 INFO - 'tabpaint']}, 18:09:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:09:58 INFO - 'tests': ['a11yr', 18:09:58 INFO - 'ts_paint', 18:09:58 INFO - 'tpaint', 18:09:58 INFO - 'sessionrestore', 18:09:58 INFO - 'sessionrestore_no_auto_restore', 18:09:58 INFO - 'tabpaint']}, 18:09:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:09:58 INFO - 'tests': ['tsvgx', 18:09:58 INFO - 'tsvgr_opacity', 18:09:58 INFO - 'tart', 18:09:58 INFO - 'tscrollx', 18:09:58 INFO - 'cart', 18:09:58 INFO - 'tsvg_static']}, 18:09:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:09:58 INFO - 'tsvgr_opacity', 18:09:58 INFO - 'tart', 18:09:58 INFO - 'tscrollx', 18:09:58 INFO - 'cart', 18:09:58 INFO - 'tsvg_static']}, 18:09:58 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 18:09:58 INFO - 'talos_options': ['--disable-e10s'], 18:09:58 INFO - 'tests': ['tp5o']}, 18:09:58 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:09:58 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 18:09:58 INFO - 'talos_options': ['--disable-e10s', 18:09:58 INFO - '--xperf_path', 18:09:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:09:58 INFO - 'tests': ['tp5n']}, 18:09:58 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:09:58 INFO - 'talos_options': ['--xperf_path', 18:09:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:09:58 INFO - 'tests': ['tp5n']}}, 18:09:58 INFO - 'talos.zip': {'path': '', 18:09:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:09:58 INFO - Running post-action listener: _resource_record_post_action 18:09:58 INFO - [mozharness: 2017-02-24 02:09:58.825991Z] Finished populate-webroot step (success) 18:09:58 INFO - [mozharness: 2017-02-24 02:09:58.826104Z] Running create-virtualenv step. 18:09:58 INFO - Running pre-action listener: _resource_record_pre_action 18:09:58 INFO - Running main action method: create_virtualenv 18:09:58 INFO - Creating virtualenv /builds/slave/test/build/venv 18:09:58 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 18:09:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:09:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:09:58 INFO - Using real prefix '/tools/python27' 18:09:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:09:59 INFO - Installing distribute.............................................................................................................................................................................................done. 18:10:02 INFO - Installing pip.................done. 18:10:02 INFO - Return code: 0 18:10:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:10:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:10:02 INFO - Reading from file tmpfile_stdout 18:10:02 INFO - Output received: 18:10:02 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) 18:10:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:10:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:10:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:10:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:10:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:10:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:02 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 0x107550b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107553768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1324c13e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10732ed30>, '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 0x107255db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107323be8>, '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.ATjBhOMtEP/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.cL0MlXKeUf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 18:10:02 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 18:10:02 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 18:10:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ATjBhOMtEP/Render', 18:10:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:10:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:10:02 INFO - 'HOME': '/Users/cltbld', 18:10:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:10:02 INFO - 'LOGNAME': 'cltbld', 18:10:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:10:02 INFO - 'MOZ_NO_REMOTE': '1', 18:10:02 INFO - 'NO_EM_RESTART': '1', 18:10:02 INFO - 'PAGER': '/bin/cat', 18:10:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:10:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:10:02 INFO - 'PWD': '/builds/slave/test', 18:10:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:10:02 INFO - 'SHELL': '/bin/bash', 18:10:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cL0MlXKeUf/Listeners', 18:10:02 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 18:10:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:10:02 INFO - 'USER': 'cltbld', 18:10:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:10:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:10:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:10:02 INFO - 'XPC_FLAGS': '0x0', 18:10:02 INFO - 'XPC_SERVICE_NAME': '0', 18:10:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:10:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:10:03 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 18:10:03 INFO - Cleaning up... 18:10:03 INFO - Return code: 0 18:10:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:10:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:10:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:10:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:10:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:10:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x107550b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107553768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1324c13e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10732ed30>, '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 0x107255db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107323be8>, '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.ATjBhOMtEP/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.cL0MlXKeUf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 18:10:03 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 18:10:03 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 18:10:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ATjBhOMtEP/Render', 18:10:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:10:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:10:03 INFO - 'HOME': '/Users/cltbld', 18:10:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:10:03 INFO - 'LOGNAME': 'cltbld', 18:10:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:10:03 INFO - 'MOZ_NO_REMOTE': '1', 18:10:03 INFO - 'NO_EM_RESTART': '1', 18:10:03 INFO - 'PAGER': '/bin/cat', 18:10:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:10:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:10:03 INFO - 'PWD': '/builds/slave/test', 18:10:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:10:03 INFO - 'SHELL': '/bin/bash', 18:10:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cL0MlXKeUf/Listeners', 18:10:03 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 18:10:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:10:03 INFO - 'USER': 'cltbld', 18:10:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:10:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:10:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:10:03 INFO - 'XPC_FLAGS': '0x0', 18:10:03 INFO - 'XPC_SERVICE_NAME': '0', 18:10:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:10:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:10:03 INFO - Downloading/unpacking psutil>=3.1.1 18:10:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:03 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 18:10:03 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 18:10:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:10:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:10:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:10:06 INFO - Installing collected packages: psutil 18:10:06 INFO - Running setup.py install for psutil 18:10:06 INFO - building 'psutil._psutil_osx' extension 18:10:06 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 18:10:07 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 18:10:07 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 18:10:07 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 18:10:07 INFO - building 'psutil._psutil_posix' extension 18:10:07 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 18:10:07 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:10:07 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:10:07 INFO - ^ 18:10:07 INFO - 1 warning generated. 18:10:07 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 18:10:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:10:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:10:07 INFO - Successfully installed psutil 18:10:07 INFO - Cleaning up... 18:10:07 INFO - Return code: 0 18:10:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:10:07 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')]} 18:10:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:10:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:07 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')]} 18:10:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:10:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:07 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 0x107550b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107553768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1324c13e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10732ed30>, '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 0x107255db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107323be8>, '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.ATjBhOMtEP/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.cL0MlXKeUf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 18:10:07 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 18:10:07 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 18:10:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ATjBhOMtEP/Render', 18:10:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:10:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:10:07 INFO - 'HOME': '/Users/cltbld', 18:10:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:10:07 INFO - 'LOGNAME': 'cltbld', 18:10:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:10:07 INFO - 'MOZ_NO_REMOTE': '1', 18:10:07 INFO - 'NO_EM_RESTART': '1', 18:10:07 INFO - 'PAGER': '/bin/cat', 18:10:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:10:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:10:07 INFO - 'PWD': '/builds/slave/test', 18:10:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:10:07 INFO - 'SHELL': '/bin/bash', 18:10:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cL0MlXKeUf/Listeners', 18:10:07 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 18:10:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:10:07 INFO - 'USER': 'cltbld', 18:10:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:10:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:10:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:10:07 INFO - 'XPC_FLAGS': '0x0', 18:10:07 INFO - 'XPC_SERVICE_NAME': '0', 18:10:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:10:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:10:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:10:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:08 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 18:10:08 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 18:10:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:10:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:10:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:10:10 INFO - Installing collected packages: mozsystemmonitor 18:10:10 INFO - Running setup.py install for mozsystemmonitor 18:10:10 INFO - Successfully installed mozsystemmonitor 18:10:10 INFO - Cleaning up... 18:10:10 INFO - Return code: 0 18:10:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:10:10 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')]} 18:10:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:10:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:10 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')]} 18:10:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:10:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x107550b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107553768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1324c13e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10732ed30>, '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 0x107255db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107323be8>, '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.ATjBhOMtEP/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.cL0MlXKeUf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 18:10:10 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 18:10:10 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 18:10:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ATjBhOMtEP/Render', 18:10:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:10:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:10:10 INFO - 'HOME': '/Users/cltbld', 18:10:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:10:10 INFO - 'LOGNAME': 'cltbld', 18:10:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:10:10 INFO - 'MOZ_NO_REMOTE': '1', 18:10:10 INFO - 'NO_EM_RESTART': '1', 18:10:10 INFO - 'PAGER': '/bin/cat', 18:10:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:10:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:10:10 INFO - 'PWD': '/builds/slave/test', 18:10:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:10:10 INFO - 'SHELL': '/bin/bash', 18:10:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cL0MlXKeUf/Listeners', 18:10:10 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 18:10:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:10:10 INFO - 'USER': 'cltbld', 18:10:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:10:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:10:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:10:10 INFO - 'XPC_FLAGS': '0x0', 18:10:10 INFO - 'XPC_SERVICE_NAME': '0', 18:10:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:10:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:10:11 INFO - Downloading/unpacking jsonschema==2.5.1 18:10:11 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 18:10:11 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 18:10:11 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 18:10:11 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 18:10:11 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 18:10:11 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 18:10:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:10:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:10:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:13 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 18:10:13 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 18:10:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:14 INFO - Downloading functools32-3.2.3-2.tar.gz 18:10:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:10:14 INFO - warning: no files found matching '*.txt' 18:10:14 INFO - no previously-included directories found matching 'build' 18:10:14 INFO - no previously-included directories found matching 'dist' 18:10:14 INFO - no previously-included directories found matching '.git*' 18:10:14 INFO - Installing collected packages: jsonschema, functools32 18:10:14 INFO - Running setup.py install for functools32 18:10:14 INFO - warning: no files found matching '*.txt' 18:10:14 INFO - no previously-included directories found matching 'build' 18:10:14 INFO - no previously-included directories found matching 'dist' 18:10:14 INFO - no previously-included directories found matching '.git*' 18:10:14 INFO - Successfully installed jsonschema functools32 18:10:14 INFO - Cleaning up... 18:10:14 INFO - Return code: 0 18:10:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:10:14 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')]} 18:10:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:10:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:14 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')]} 18:10:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:10:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:14 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 0x107550b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107553768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1324c13e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10732ed30>, '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 0x107255db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107323be8>, '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.ATjBhOMtEP/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.cL0MlXKeUf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 18:10:14 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 18:10:14 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 18:10:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ATjBhOMtEP/Render', 18:10:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:10:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:10:14 INFO - 'HOME': '/Users/cltbld', 18:10:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:10:14 INFO - 'LOGNAME': 'cltbld', 18:10:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:10:14 INFO - 'MOZ_NO_REMOTE': '1', 18:10:14 INFO - 'NO_EM_RESTART': '1', 18:10:14 INFO - 'PAGER': '/bin/cat', 18:10:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:10:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:10:14 INFO - 'PWD': '/builds/slave/test', 18:10:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:10:14 INFO - 'SHELL': '/bin/bash', 18:10:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cL0MlXKeUf/Listeners', 18:10:14 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 18:10:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:10:14 INFO - 'USER': 'cltbld', 18:10:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:10:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:10:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:10:14 INFO - 'XPC_FLAGS': '0x0', 18:10:14 INFO - 'XPC_SERVICE_NAME': '0', 18:10:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:10:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:10:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:10:15 INFO - Cleaning up... 18:10:15 INFO - Return code: 0 18:10:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:10:15 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')]} 18:10:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:10:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:15 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')]} 18:10:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:10:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:15 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 0x107550b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107553768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1324c13e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10732ed30>, '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 0x107255db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107323be8>, '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.ATjBhOMtEP/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.cL0MlXKeUf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 18:10:15 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 18:10:15 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 18:10:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ATjBhOMtEP/Render', 18:10:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:10:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:10:15 INFO - 'HOME': '/Users/cltbld', 18:10:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:10:15 INFO - 'LOGNAME': 'cltbld', 18:10:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:10:15 INFO - 'MOZ_NO_REMOTE': '1', 18:10:15 INFO - 'NO_EM_RESTART': '1', 18:10:15 INFO - 'PAGER': '/bin/cat', 18:10:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:10:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:10:15 INFO - 'PWD': '/builds/slave/test', 18:10:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:10:15 INFO - 'SHELL': '/bin/bash', 18:10:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cL0MlXKeUf/Listeners', 18:10:15 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 18:10:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:10:15 INFO - 'USER': 'cltbld', 18:10:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:10:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:10:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:10:15 INFO - 'XPC_FLAGS': '0x0', 18:10:15 INFO - 'XPC_SERVICE_NAME': '0', 18:10:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:10:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:10:15 INFO - Downloading/unpacking blobuploader==1.2.4 18:10:15 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 18:10:15 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 18:10:15 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 18:10:15 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 18:10:15 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 18:10:15 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 18:10:17 INFO - Downloading blobuploader-1.2.4.tar.gz 18:10:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:10:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:10:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:10:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:10:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:10:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:10:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:10:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:10:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:19 INFO - Downloading docopt-0.6.1.tar.gz 18:10:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:10:19 INFO - Installing collected packages: blobuploader, requests, docopt 18:10:19 INFO - Running setup.py install for blobuploader 18:10:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:10:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:10:19 INFO - Running setup.py install for requests 18:10:19 INFO - Running setup.py install for docopt 18:10:20 INFO - Successfully installed blobuploader requests docopt 18:10:20 INFO - Cleaning up... 18:10:20 INFO - Return code: 0 18:10:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:10:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:10:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:10:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:10:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:10:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:20 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 0x107550b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107553768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1324c13e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10732ed30>, '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 0x107255db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107323be8>, '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.ATjBhOMtEP/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.cL0MlXKeUf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 18:10:20 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 18:10:20 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 18:10:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ATjBhOMtEP/Render', 18:10:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:10:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:10:20 INFO - 'HOME': '/Users/cltbld', 18:10:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:10:20 INFO - 'LOGNAME': 'cltbld', 18:10:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:10:20 INFO - 'MOZ_NO_REMOTE': '1', 18:10:20 INFO - 'NO_EM_RESTART': '1', 18:10:20 INFO - 'PAGER': '/bin/cat', 18:10:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:10:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:10:20 INFO - 'PWD': '/builds/slave/test', 18:10:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:10:20 INFO - 'SHELL': '/bin/bash', 18:10:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cL0MlXKeUf/Listeners', 18:10:20 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 18:10:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:10:20 INFO - 'USER': 'cltbld', 18:10:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:10:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:10:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:10:20 INFO - 'XPC_FLAGS': '0x0', 18:10:20 INFO - 'XPC_SERVICE_NAME': '0', 18:10:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:10:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:10:20 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-J2U9z7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:10:20 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-ug96gl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:10:20 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-dkDnzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:10:20 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-uu9QGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:10:20 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-nI6WVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:10:20 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-a78ljZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:10:21 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-PBtiHo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:10:21 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-OvhcB2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:10:21 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-XkRnEW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:10:21 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-hhxpel-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:10:21 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-J_S6jh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:10:21 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-eoDnS2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:10:21 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-QVh13e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:10:21 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-PnVWRI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:10:21 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-3LUSuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:10:21 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-LtgeDd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:10:22 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-iJr1JK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:10:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:10:22 INFO - Running setup.py install for manifestparser 18:10:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:10:22 INFO - Running setup.py install for mozcrash 18:10:22 INFO - Running setup.py install for mozdebug 18:10:22 INFO - Running setup.py install for mozdevice 18:10:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:10:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:10:22 INFO - Running setup.py install for mozfile 18:10:22 INFO - Running setup.py install for mozhttpd 18:10:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:10:23 INFO - Running setup.py install for mozinfo 18:10:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:10:23 INFO - Running setup.py install for mozInstall 18:10:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:10:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:10:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:10:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:10:23 INFO - Running setup.py install for mozleak 18:10:23 INFO - Running setup.py install for mozlog 18:10:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:10:23 INFO - Running setup.py install for moznetwork 18:10:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:10:23 INFO - Running setup.py install for mozprocess 18:10:23 INFO - Running setup.py install for mozprofile 18:10:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:10:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:10:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:10:24 INFO - Running setup.py install for mozrunner 18:10:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:10:24 INFO - Running setup.py install for mozscreenshot 18:10:24 INFO - Running setup.py install for moztest 18:10:24 INFO - Running setup.py install for mozversion 18:10:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:10:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:10:24 INFO - Cleaning up... 18:10:24 INFO - Return code: 0 18:10:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:10: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')]} 18:10:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:10:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10: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')]} 18:10:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:10:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:24 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 0x107550b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107553768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1324c13e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10732ed30>, '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 0x107255db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107323be8>, '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.ATjBhOMtEP/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.cL0MlXKeUf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 18:10:24 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 18:10:24 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 18:10:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ATjBhOMtEP/Render', 18:10:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:10:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:10:24 INFO - 'HOME': '/Users/cltbld', 18:10:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:10:24 INFO - 'LOGNAME': 'cltbld', 18:10:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:10:24 INFO - 'MOZ_NO_REMOTE': '1', 18:10:24 INFO - 'NO_EM_RESTART': '1', 18:10:24 INFO - 'PAGER': '/bin/cat', 18:10:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:10:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:10:24 INFO - 'PWD': '/builds/slave/test', 18:10:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:10:24 INFO - 'SHELL': '/bin/bash', 18:10:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cL0MlXKeUf/Listeners', 18:10:24 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 18:10:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:10:24 INFO - 'USER': 'cltbld', 18:10:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:10:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:10:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:10:24 INFO - 'XPC_FLAGS': '0x0', 18:10:24 INFO - 'XPC_SERVICE_NAME': '0', 18:10:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:10:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:10:25 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-ueQfc1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:10:25 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)) 18:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:10:25 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-GQ5G2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:10:25 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)) 18:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:10:25 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-Wb2oVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:10:25 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)) 18:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:10:25 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-qw_xkG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:10:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:10:25 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-zafq4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:10:25 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)) 18:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:10:25 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-0zaG_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:10:25 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)) 18:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:10:25 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-FM5qcP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:10:25 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)) 18:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:10:25 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-odEMz_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:10:25 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)) 18:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:10:25 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-ZhSW17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:10:26 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)) 18:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:10:26 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-EoniNl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:10:26 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)) 18:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:10:26 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-dTizUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:10:26 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)) 18:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:10:26 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-UrVsvL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:10:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 18:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:10:26 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-JqRz25-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:10:26 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)) 18:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:10:26 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-EOiCpx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:10:26 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)) 18:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:10:26 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-VdJ73E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:10:26 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)) 18:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:10:26 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-upp_BM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:10:26 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)) 18:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:10:26 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-Gr1m5x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:10:26 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)) 18:10:26 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)) 18:10:26 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)) 18:10:26 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)) 18:10:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:10:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:10:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:10:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:10:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:10:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:29 INFO - Downloading blessings-1.6.tar.gz 18:10:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:10:29 INFO - Installing collected packages: blessings 18:10:29 INFO - Running setup.py install for blessings 18:10:29 INFO - Successfully installed blessings 18:10:29 INFO - Cleaning up... 18:10:29 INFO - Return code: 0 18:10:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:10:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:10:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:10:30 INFO - Reading from file tmpfile_stdout 18:10:30 INFO - Current package versions: 18:10:30 INFO - blessings == 1.6 18:10:30 INFO - blobuploader == 1.2.4 18:10:30 INFO - docopt == 0.6.1 18:10:30 INFO - functools32 == 3.2.3-2 18:10:30 INFO - jsonschema == 2.5.1 18:10:30 INFO - manifestparser == 1.1 18:10:30 INFO - mozInstall == 1.12 18:10:30 INFO - mozcrash == 1.0 18:10:30 INFO - mozdebug == 0.1 18:10:30 INFO - mozdevice == 0.49 18:10:30 INFO - mozfile == 1.2 18:10:30 INFO - mozhttpd == 0.7 18:10:30 INFO - mozinfo == 0.9 18:10:30 INFO - mozleak == 0.1 18:10:30 INFO - mozlog == 3.4 18:10:30 INFO - moznetwork == 0.27 18:10:30 INFO - mozprocess == 0.24 18:10:30 INFO - mozprofile == 0.28 18:10:30 INFO - mozrunner == 6.13 18:10:30 INFO - mozscreenshot == 0.1 18:10:30 INFO - mozsystemmonitor == 0.3 18:10:30 INFO - moztest == 0.8 18:10:30 INFO - mozversion == 1.4 18:10:30 INFO - psutil == 3.1.1 18:10:30 INFO - requests == 1.2.3 18:10:30 INFO - wsgiref == 0.1.2 18:10:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:10:30 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')]} 18:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:10:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:30 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')]} 18:10:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:10:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:30 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 0x107550b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107553768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1324c13e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10732ed30>, '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 0x107255db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107323be8>, '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.ATjBhOMtEP/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.cL0MlXKeUf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 18:10:30 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 18:10:30 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 18:10:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ATjBhOMtEP/Render', 18:10:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:10:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:10:30 INFO - 'HOME': '/Users/cltbld', 18:10:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:10:30 INFO - 'LOGNAME': 'cltbld', 18:10:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:10:30 INFO - 'MOZ_NO_REMOTE': '1', 18:10:30 INFO - 'NO_EM_RESTART': '1', 18:10:30 INFO - 'PAGER': '/bin/cat', 18:10:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:10:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:10:30 INFO - 'PWD': '/builds/slave/test', 18:10:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:10:30 INFO - 'SHELL': '/bin/bash', 18:10:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cL0MlXKeUf/Listeners', 18:10:30 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 18:10:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:10:30 INFO - 'USER': 'cltbld', 18:10:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:10:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:10:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:10:30 INFO - 'XPC_FLAGS': '0x0', 18:10:30 INFO - 'XPC_SERVICE_NAME': '0', 18:10:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:10:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:10:30 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)) 18:10:30 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)) 18:10:30 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)) 18:10:30 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)) 18:10:30 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)) 18:10:30 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)) 18:10:30 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)) 18:10:30 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)) 18:10:30 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)) 18:10:30 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)) 18:10:30 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)) 18:10:30 INFO - Cleaning up... 18:10:30 INFO - Return code: 0 18:10:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:10:30 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')]} 18:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:10:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:30 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')]} 18:10:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:10:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:31 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 0x107550b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107553768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1324c13e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10732ed30>, '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 0x107255db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107323be8>, '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.ATjBhOMtEP/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.cL0MlXKeUf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 18:10:31 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 18:10:31 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 18:10:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ATjBhOMtEP/Render', 18:10:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:10:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:10:31 INFO - 'HOME': '/Users/cltbld', 18:10:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:10:31 INFO - 'LOGNAME': 'cltbld', 18:10:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:10:31 INFO - 'MOZ_NO_REMOTE': '1', 18:10:31 INFO - 'NO_EM_RESTART': '1', 18:10:31 INFO - 'PAGER': '/bin/cat', 18:10:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:10:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:10:31 INFO - 'PWD': '/builds/slave/test', 18:10:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:10:31 INFO - 'SHELL': '/bin/bash', 18:10:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cL0MlXKeUf/Listeners', 18:10:31 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 18:10:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:10:31 INFO - 'USER': 'cltbld', 18:10:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:10:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:10:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:10:31 INFO - 'XPC_FLAGS': '0x0', 18:10:31 INFO - 'XPC_SERVICE_NAME': '0', 18:10:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:10:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:10:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:10:31 INFO - Cleaning up... 18:10:31 INFO - Return code: 0 18:10:31 INFO - Running post-action listener: _resource_record_post_action 18:10:31 INFO - Running post-action listener: _start_resource_monitoring 18:10:31 INFO - Starting resource monitoring. 18:10:31 INFO - [mozharness: 2017-02-24 02:10:31.430216Z] Finished create-virtualenv step (success) 18:10:31 INFO - [mozharness: 2017-02-24 02:10:31.431194Z] Running install step. 18:10:31 INFO - Running pre-action listener: _resource_record_pre_action 18:10:31 INFO - Running main action method: install 18:10:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:10:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:10:31 INFO - Reading from file tmpfile_stdout 18:10:31 INFO - Detecting whether we're running mozinstall >=1.0... 18:10:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:10:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:10:31 INFO - Reading from file tmpfile_stdout 18:10:31 INFO - Output received: 18:10:31 INFO - Usage: mozinstall [options] installer 18:10:31 INFO - Options: 18:10:31 INFO - -h, --help show this help message and exit 18:10:31 INFO - -d DEST, --destination=DEST 18:10:31 INFO - Directory to install application into. [default: 18:10:31 INFO - "/builds/slave/test"] 18:10:31 INFO - --app=APP Application being installed. [default: firefox] 18:10:31 INFO - mkdir: /builds/slave/test/build/application 18:10:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 18:10:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 18:10:51 INFO - Reading from file tmpfile_stdout 18:10:51 INFO - Output received: 18:10:51 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 18:10:51 INFO - Running post-action listener: _resource_record_post_action 18:10:51 INFO - [mozharness: 2017-02-24 02:10:51.585856Z] Finished install step (success) 18:10:51 INFO - [mozharness: 2017-02-24 02:10:51.586000Z] Running run-tests step. 18:10:51 INFO - Running pre-action listener: _resource_record_pre_action 18:10:51 INFO - Running main action method: run_tests 18:10:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:10:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:10:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:10:51 INFO - 2017-02-23 18:10:51.600 screenresolution[1900:58588] starting screenresolution argv=screenresolution get 18:10:51 INFO - 2017-02-23 18:10:51.603 screenresolution[1900:58588] Display 0: 1600x1200x32@60 18:10:51 INFO - 2017-02-23 18:10:51.609 screenresolution[1901:58590] starting screenresolution argv=screenresolution list 18:10:51 INFO - Available Modes on Display 0 18:10:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:10:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:10:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:10:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:10:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:10:51 INFO - Intel Iris: 18:10:51 INFO - Chipset Model: Intel Iris 18:10:51 INFO - Type: GPU 18:10:51 INFO - Bus: Built-In 18:10:51 INFO - VRAM (Dynamic, Max): 1536 MB 18:10:51 INFO - Vendor: Intel (0x8086) 18:10:51 INFO - Device ID: 0x0a2e 18:10:51 INFO - Revision ID: 0x0009 18:10:51 INFO - Displays: 18:10:51 INFO - Display: 18:10:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:10:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:10:51 INFO - Display Serial Number: 1600x1200 60 18:10:51 INFO - Main Display: Yes 18:10:51 INFO - Mirror: Off 18:10:51 INFO - Online: Yes 18:10:51 INFO - Rotation: Supported 18:10:51 INFO - Return code: 0 18:10:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:10:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:10:51 INFO - Python 2.7.3 18:10:51 INFO - Return code: 0 18:10:51 INFO - grabbing minidump binary from tooltool 18:10:51 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')]} 18:10:51 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 0x10732ed30>, '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 0x107255db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107323be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:10:51 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 18:10:51 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 18:10:51 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 18:10:51 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:10:51 INFO - Return code: 0 18:10:51 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:10:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:10:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:10:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:10:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:10:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HLzyw1RaSM6d6Oqs3hbE1g/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0065', '--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 18:10:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HLzyw1RaSM6d6Oqs3hbE1g/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0065 --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 18:10:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ATjBhOMtEP/Render', 18:10:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:10:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:10:51 INFO - 'HOME': '/Users/cltbld', 18:10:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:10:51 INFO - 'LOGNAME': 'cltbld', 18:10:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:10:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:10:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:10:51 INFO - 'MOZ_NO_REMOTE': '1', 18:10:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:10:51 INFO - 'NO_EM_RESTART': '1', 18:10:51 INFO - 'PAGER': '/bin/cat', 18:10:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:10:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:10:51 INFO - 'PWD': '/builds/slave/test', 18:10:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:10:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:10:51 INFO - 'SHELL': '/bin/bash', 18:10:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cL0MlXKeUf/Listeners', 18:10:51 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 18:10:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:10:51 INFO - 'USER': 'cltbld', 18:10:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:10:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:10:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:10:51 INFO - 'XPC_FLAGS': '0x0', 18:10:51 INFO - 'XPC_SERVICE_NAME': '0', 18:10:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:10:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HLzyw1RaSM6d6Oqs3hbE1g/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0065', '--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 18:10:52 INFO - mozversion application_buildid: 20170223164436 18:10:52 INFO - mozversion application_changeset: 2e4452df31d638985001179030bacb1b4b064c75 18:10:52 INFO - mozversion application_display_name: FirefoxDeveloperEdition 18:10:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:10:52 INFO - mozversion application_name: Firefox 18:10:52 INFO - mozversion application_remotingname: firefox-dev 18:10:52 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:10:52 INFO - mozversion application_vendor: Mozilla 18:10:52 INFO - mozversion application_version: 53.0a2 18:10:52 INFO - mozversion platform_buildid: 20170223164436 18:10:52 INFO - mozversion platform_changeset: 2e4452df31d638985001179030bacb1b4b064c75 18:10:52 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:10:52 INFO - mozversion platform_version: 53.0a2 18:10:52 INFO - using testdate: 1487902252 18:10:52 INFO - actual date: 1487902252 18:10:52 INFO - starting webserver on 'localhost:50662' 18:10:52 INFO - SUITE-START | Running 2 tests 18:10:52 INFO - TEST-START | dromaeo_css 18:10:52 INFO - operating with platform_type : mac_ 18:10:52 INFO - Initialising browser for dromaeo_css test... 18:10:52 INFO - TEST-INFO | started process 1911 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/tmpiBiLT4/profile http://localhost:50662/getInfo.html) 18:10:52 INFO - PROCESS | 1911 | 1487902252711 addons.xpi WARN Error loading bootstrap.js for disableSHA1rollout@mozilla.org: Error opening input stream (invalid filename?): jar:file:///builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/Resources/browser/features/disableSHA1rollout@mozilla.org.xpi!/bootstrap.js 18:10:52 INFO - PROCESS | 1911 | 1487902252712 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method install 18:10:52 INFO - PROCESS | 1911 | 1487902252748 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method startup 18:10:54 INFO - PROCESS | 1911 | 2017-02-23 18:10:54.828 plugin-container[1913:58763] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b37, name = 'com.apple.tsm.portname' 18:10:54 INFO - PROCESS | 1911 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:10:54 INFO - PROCESS | 1911 | 2017-02-23 18:10:54.831 plugin-container[1913:58763] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e4b, name = 'com.apple.CFPasteboardClient' 18:10:54 INFO - PROCESS | 1911 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:10:54 INFO - PROCESS | 1911 | 2017-02-23 18:10:54.831 plugin-container[1913:58763] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 18:10:54 INFO - PROCESS | 1911 | __metrics Screen width/height:1600/1200 18:10:54 INFO - PROCESS | 1911 | colorDepth:24 18:10:54 INFO - PROCESS | 1911 | Browser inner width/height: 1024/689 18:10:54 INFO - PROCESS | 1911 | __metrics 18:10:54 ERROR - PROCESS | 1911 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 18:10:55 INFO - PROCESS | 1911 | 1487902254996 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method shutdown 18:10:55 INFO - TEST-INFO | 1911: exit 0 18:10:55 INFO - Browser initialized. 18:10:55 INFO - Running cycle 1/1 for dromaeo_css test... 18:10:55 INFO - TEST-INFO | started process 1914 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/tmpiBiLT4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:10:55 INFO - PROCESS | 1914 | 1487902255925 addons.xpi WARN Error loading bootstrap.js for disableSHA1rollout@mozilla.org: Error opening input stream (invalid filename?): jar:file:///builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/Resources/browser/features/disableSHA1rollout@mozilla.org.xpi!/bootstrap.js 18:10:55 INFO - PROCESS | 1914 | 1487902255926 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method startup 18:10:58 INFO - PROCESS | 1914 | 2017-02-23 18:10:58.115 plugin-container[1915:58897] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 18:10:58 INFO - PROCESS | 1914 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:10:58 INFO - PROCESS | 1914 | 2017-02-23 18:10:58.116 plugin-container[1915:58897] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 18:10:58 INFO - PROCESS | 1914 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:10:58 INFO - PROCESS | 1914 | 2017-02-23 18:10:58.116 plugin-container[1915:58897] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 18:11:07 INFO - PROCESS | 1914 | RSS: Main: 218480640 18:11:07 INFO - PROCESS | 1914 | 18:14:10 INFO - PROCESS | 1914 | Cycle 1(1): loaded http://localhost:50662/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50662/tests/dromaeo/cssquery-ext.html) 18:14:12 INFO - PROCESS | 1914 | RSS: Main: 239034368 18:14:12 INFO - PROCESS | 1914 | 18:15:55 INFO - PROCESS | 1914 | ************************* 18:15:56 INFO - PROCESS | 1914 | A coding exception was thrown and uncaught in a Task. 18:15:56 INFO - PROCESS | 1914 | 18:15:56 ERROR - PROCESS | 1914 | Full message: TypeError: NetworkError when attempting to fetch resource. 18:15:56 INFO - PROCESS | 1914 | Full stack: 18:15:56 INFO - PROCESS | 1914 | ************************* 18:17:14 INFO - PROCESS | 1914 | Cycle 1(1): loaded http://localhost:50662/tests/dromaeo/cssquery-ext.html (next: http://localhost:50662/tests/dromaeo/cssquery-jquery.html) 18:17:15 INFO - PROCESS | 1914 | RSS: Main: 248545280 18:17:15 INFO - PROCESS | 1914 | 18:20:17 INFO - PROCESS | 1914 | Cycle 1(1): loaded http://localhost:50662/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50662/tests/dromaeo/cssquery-mootools.html) 18:20:17 INFO - PROCESS | 1914 | RSS: Main: 256167936 18:20:17 INFO - PROCESS | 1914 | 18:23:19 INFO - PROCESS | 1914 | Cycle 1(1): loaded http://localhost:50662/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50662/tests/dromaeo/cssquery-prototype.html) 18:23:20 INFO - PROCESS | 1914 | RSS: Main: 252813312 18:23:20 INFO - PROCESS | 1914 | 18:26:23 INFO - PROCESS | 1914 | Cycle 1(1): loaded http://localhost:50662/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50662/tests/dromaeo/cssquery-yui.html) 18:26:23 INFO - PROCESS | 1914 | RSS: Main: 256798720 18:26:23 INFO - PROCESS | 1914 | 18:29:26 INFO - PROCESS | 1914 | Cycle 1(1): loaded http://localhost:50662/tests/dromaeo/cssquery-yui.html (next: http://localhost:50662/tests/dromaeo/cssquery-dojo.html) 18:29:26 INFO - PROCESS | 1914 | RSS: Main: 258101248 18:29:26 INFO - PROCESS | 1914 | 18:29:26 INFO - PROCESS | 1914 | __start_tp_report 18:29:26 INFO - PROCESS | 1914 | _x_x_mozilla_page_load 18:29:26 INFO - PROCESS | 1914 | _x_x_mozilla_page_load_details 18:29:26 INFO - PROCESS | 1914 | |i|pagename|runs| 18:29:26 INFO - PROCESS | 1914 | |0;dojo.html;3366.5791776027995;3375;3399.2351720862807;3399.3201359728055;3406.625271220164;5777.220075289834;5825.067989121741;5826.300843898733;5843.941560584393;5855.47300742933;4775.6418268629905;4855.830045948393;5764.7982320618785;5810.448007439287;5847.064469684851;5288.788448462066;5296.894062118756;5317.8404647860625;5345.412004679482;5357.892842143155;4569.862904112865;5344.839654810362;5365.436629153941;5369.382521010075;5411.56707463402;4299.656027517791;5252.737363131847;5366.382865970424;5373.113436283009;5388.568914486832;5266.683998960075;5295.576353891679;5338.359396872362;5383.246345511631;5417.970585588726;5227.686338819683;5293.682379057231;5299;5318.601104917108;5337.439568845293;5643.266375371176;5837.211976383176;5854.356020837705;5924.881502369972;5953.664869183178;6149.723262453201;6165.475934545569;6169.198004259462;6222.502199824004;6228.781992630282;6232.220972378453;6252.812415627493;6255.562110652256;6264.467520260738;6286.591371560879;6009.699515024231;6024.8493787655225;6042.063480160582;6049.48579370754;6051.636901785863;6136.304638670889;6137.989923150242;6253.155823963798;6291.905621415683;6293.433590976834;5366.007288651612;6150.354212807681;6215.192025036717;6245.125682404467;6279.686015699197;5671.489565939085;6227.688615569204;6255.843603909848;6259.374062593704;6287.1826662534495;5871.383504731942;6119.326874043852;6124.045297608036;6128.014278093809;6156.353582873823;5692.7722891083895;5827.980103481874;6235;6249.562530622813;6262.937370626236;5033.6224783141415;5044.2937988681615;5048.62135339851;5053.5957123430035;5057.393112826484;4454.554544545519;4464.888377790581;4495.505494395614;4506.301523263899;4531.614812740888;5897.410258974069;5925;5977.252843394575;6001.699915004232;6016.488598469092;6173.84565385869;6236.438720515084;6238.906416403757;6249.562530622904;6257.749690012349;5772.826815195551;5862.501687356623;5909.438603332676;5945.375735547792;5969.850753731192;5451.073317536028;5577.274954256002;5582.7766889323975;5586.55307575393;5588.804391846266;5568.359638641527;6475.449586785176;6484.740610375532;6504.902426463702;6506.219253689587;6044.304904935812;6110.663913484801;6136.764169924236;6139.829471381233;6271.749130034747;6372.681365931592;6410.967945160244;6411.198600174978;6420.06908998202;6425.06836508713;6157.230346206724;6239.625622462667;6244.125822384779;6244.65654389013;6256.124142620128;4942.4316203637045;6170.642458659087;6224.06639004153;6236.6258024518675;6250.812475625738;6110.1638887921135;6206.782762603287;6223.657698826608;6233.158523599256;6234.220722409699;5221.321228240305;6074.544409169242;6194.721237544231;6217.533684973555;6229.190205273286;5165.199394093921;5766.654000759968;5914.704264786829;6035.78874739382;6073.726682299395;5109.974450127875;6135.814547850547;6150.201658245398;6175.475084617858;6203;5293.708846013506;5968.134620479919;6121.632702037892;6140.508759299156;6155.6614386209185 18:29:26 INFO - PROCESS | 1914 | |1;ext.html;433.3413211917885;492.83490030839664;512.3467578836984;521.2181727408887;535.5795700375206;31454.370912581733;40523.79738101309;40695.59304406955;40714.59285407145;40723;42143.78928105363;42657.36013959793;42669.573304266945;42716.14567708644;42830.357544636856;8302.792430189233;8537.487750734945;9095.135962083608;9348.766280842965;9352.7661808455;10996.395198264092;11271.830922536168;11326.377049262288;11405.828912566318;11438;11060.502277397496;11081.113510919147;11126.833097503504;11130.109591232682;11139.498722557504;11366.090712743002;11432.94283528577;11443.427828608577;11465.369404682739;11474.196806223568;11251.54993800247;11270.718232044183;11303.943480282629;11320.320780753182;11323.263987840764;41044.97387565305;41264.968375790544;41300.79349603263;41427.79286103581;41477.585224147675;3893.7079719020903;3975.840966361342;3983.5618082010956;4025.134596061861;4056.837726490937;29795.25511862199;31303.686963130305;31666.525002124985;31832.522512162337;31995.200119996953;3080.799748016394;3185.9362812743616;3262.9184270393193;3344.749143814199;3375.6455572164814;379958;469801;471616;472200.27799721906;472411;64095;64343.67828160829;64366;64400.71198576002;64610.03084953636;67116;67271.32728672748;67419.66290168518;67444;67449.66275168593;16607.086610236554;16834;16841.747373789403;16855.91572042132;16899.57751056209;11562.248453850472;11859.58491452795;12758.61724148277;12983.870161298455;13029.609111726664;17427.302907883543;17564;17620.91189544044;17681.381151659887;17815.73276400829;5553.888922221533;6537.411632953057;6576.8819300719;6647.833804154838;6694.698738556776;818.7257268814894;858.0047145311534;859.9742007739778;862.857628491292;873.0527377795037;29652.703472964993;29907.102786916428;30325.848370758005;30635;30938.690613093582;1009.9141572966233;1028.8919663435381;1078.3475997021847;1094.4199574225672;1197.4132674989194;11539.826902596467;11687.88312116885;14764.187969661773;14827.851721482863;16303.673926521404;521775;527094;614520;615897;619718;48764.51235487671;60384.396156038754;60761.69619151876;61001;61315.693421532604;1292.3215311961296;1357.927237482378;1435.8564143585559;1442.5816513211262;1446.406973141007;25591.23226303214;28078.43843123167;29120.41759164847;29837.254068648457;30340.54489182708;50930;51328.48671513237;51448.971020580124;51471.48528514817;51768.22347664713;502304;504458;504910;505059;505410;39349.80325098356;39740.60259397484;39835.80082099571;40206.798966004986;40225.19549608933;45037.549624503336;45118.77440612776;46801.29798052964;46948;47373.52626473691;37024.25951481009;38162.236755265294;38980.40575689244;39089.41365879457;39251.803740981115;35976;37177.25645487129;38482.6151738479;39760.80119599384;40186.9953251171;34610.134746631535;35506.64493355137;35933.46099808453;36042.27915441729;36237.912862613106;26803.463930721668;32439;33065.84269550554;33320.50019249762;33375;19441.90279048652;22556.32331030072;23288.189227109833;24561.385965350295;24968.37579060538 18:29:26 INFO - PROCESS | 1914 | |2;jquery.html;376.9509963704718;391.2370876790258;391.2585650192885;400.075824844609;425.3194888178914;14692.632684182901;17031.40390086347;19810.60378792425;21269.787302126973;21337.893310533444;21251.468713282175;21279.57440851186;21428.25001124961;21489.892550537264;21651.783482165174;5598.384177740456;5728.198052272664;5957.463828255456;6051.878962420749;6116.510679145657;5799.507041901444;5987.0121429964;6030.396960303979;6032.788852390167;6040.758369665208;5959.106134079901;6009.4591486766185;6015.75936962521;6018;6038.184845045928;5836.5564815184025;6005.249343832021;6012.458878700916;6466.612003279772;6587.11074005008;5825.9417405825825;5871.765129394819;5876.500497457721;5878.853028674274;5889.293284805808;14103.929480352635;24932.626010609856;25004.624930626054;25103;25587.23238302854;2904.5062339402352;2968.257935516121;2984.19426754775;2984.612000439929;2986.7759918006236;9961.501924903725;10397.32417392867;11430.657080287605;13069.607911762663;14527.346269417902;1720.5688897714042;1839.8712090153695;1853.8238867307584;1857.6470470610675;1860.5441666791723;140803;142298.99999999895;145711;151160;152869.47130528663;11847.111466639864;11897.583584574499;12036.39818009096;12092.697682558006;12261.632151035483;12140;15463.5360939172;15541.45604903823;15542.689146217012;15558.377664893504;6739.52823302374;8442.873356899652;8786.824263514694;8910.242629376575;8910.55447227636;7640.853871919257;7960.56216908064;8578.056413794478;8584.442011269248;8743.125687431206;4724.314974328703;4727.858164255078;4758.263233919594;4779.856604301876;4840.177169881129;1673.9330426783035;1829.5426143464133;1989.3435166395054;1991.531989982353;2015.4759762461865;874.7813046738315;968.8304546704298;999.980000399988;1019.6788011776267;1019.9796004080025;20316.492087697927;20643.4839129023;20819.06314215864;20973.475663108544;20975.475613109793;988.7083310423442;989.4656885282011;1019.4444028004755;1021.279997601689;1022.3712416863575;5999.790007349722;6306.747730090837;10478.790424191626;10818.945905270422;10883.619073332395;792529;806195;807406;815003;822592;165933;166057;167300;170934;173852;374.98875033749033;445.895214624563;454.9021960278556;460.0155666872895;462.4242817691995;11406.600768973047;11566.710832229262;11634.53461861516;11674.832516748258;11906.702332441411;49134.50865491299;51066.744666276434;51879.48120518746;64298;64419.35580644134;92061;92560.53719731358;93522.53238733763;94175.52912235395;95465.04534954562;8135.471194372347;8165.061017983008;8195.877061843958;8384.790380240298;8413.70552030676;10452.529636166239;12095.758084838079;12307.69230769238;12330.568430104904;12573.497060117494;9655.131424496067;10352.896471035194;10594.4702764863;10721.195910306602;10784.838227426751;10503.527341269813;10663.98692124247;10676.946615266874;10994.945025274823;11232.101431885267;10590.41752703578;10682.412467314061;10877.075448586642;10994.230403871972;11172.441377931233;8140.185981401813;8194.098649148707;8617.267532259828;8624.439411438236;8637.395382323177;10459.790804184026;10522.31604945676;10567.365958042543;10818.080463160719;10882.455877206266 18:29:26 INFO - PROCESS | 1914 | |3;mootools.html;1337.4819579776956;1348.8197826901462;1441.401818245428;1442.4446588063593;1451.9836114719699;7537.24627537246;7778.5721785301785;8088.474249173807;8515.872261916069;8522.232999030093;7997.800604833674;8202.343812495;8339.91660083399;8423.663053477854;8447.704330348439;2197.9120835166573;2233.4974630708043;2237.3847192022163;2243.2036626997424;2248.3592176229777;2107.2729908181727;2189.7481789594162;2282.7146606674164;2328.9650655240184;2329.9184528541505;2244.528648983707;2350.118705485443;2356.175338631482;2358.929232123039;2359.245041586693;2310.1336998625516;2335.8131349492087;2351.776581224781;2352.0826877517784;2357.257463898875;1906.818852209038;2191.1454532732246;2246.3934737620916;2253.087499562663;2384.332386931662;7046.823829404306;8406.873896891551;8419.284360829337;8451.915480845175;8461.11158328379;5113.769880355393;5228.058949389108;5261.657992230493;5261.657992230493;5289;3071.2782496113396;3140.434721750084;3509.6841284284283;3590.964090359089;3625.062676549294;1229.330015141741;1244.7946088895321;1266.4870727355435;1277.0294576122214;1290.5483080921601;10584.682459526226;10752.569897204103;10865.619703310345;10886.020258176723;10925.399103049329;4419.756913369732;4749.525047495292;4803.78382972767;4817.13291607514;4822.324874517571;9554.04459554039;9607.51962401891;9608.95195524018;9615.759606009906;9659.082387173208;5295.4969277918535;5301.893962120736;5302.072137376021;5308.124159513637;5310.150375939831;4533.659975501851;4650.232711602548;4756.453007904066;4838.540338667821;4845.345878306383;3922.646961773397;3989.162275922089;4000.6799456043445;4032.052467670095;4111.424400583921;1200.8318835363057;1238.937169612585;1276.2023735165521;1294.3657607772125;1322.65610941156;794.6344681446599;841.8063845315612;909.1136142261242;916.4043371808378;919.8160367926441;5499.367572729107;5509.559235261169;5565.526930210896;5760.8271751847515;5806.390329015392;976.7948730766476;988;994.6717583197527;1010.8786945566579;1029.0378496106164;3683.778973261613;3715.3126671565847;3736.7571107878443;3835.520559930009;3850.2492014057552;9717.46553939526;10021.79956400868;10026.147777438853;10063.5471403787;10159.542820573091;9872.753181170385;9968.451735154636;9984.051515106054;9986.850197247048;10011.749706257257;7396;7772.950651662067;7834.647440865175;7913.208679132041;7925.207479252144;4920.991196804574;4950.603951683928;5653.604247702621;5783.987802134694;5834.679092649945;7949.7217597383815;9037.231835294073;9071.954640226757;9245.445273283625;9247.306452015991;7280.635968201463;9337.766555836159;9360.251179905456;9473.952630236805;9520.143187113194;6193.411625895533;7214.74748383804;7259.419246460376;7275.490715650066;7322.462282920646;7531.133919599097;7591.278828511283;7620.771376858703;7622.8094297643;7636;6903.413209877217;6980.232174460703;7227.421806255592;7266.346028857428;7314.378277846443;6898.613699558401;7035.859282814417;7039.753608623673;7124.465665075244;7150.6424678764815;6346.809595712136;6359;6430.64631445275;6430.903536447051;6447.967760161169;4926.827561035347;4947.529984651453;4953.925691114564;4976.2286845539;5041.117804384145;4845.167251159986;4885.1450996076255;4932.506749325039;5088;5119.87200319995 18:29:26 INFO - PROCESS | 1914 | |4;prototype.html;304.3365463290028;351.58161787472903;373.5797228118367;377.11754494482904;380.2452132516952;4847.886959034605;5152.021115987969;5298.735063246837;5452.945470545294;5455.481729235721;5414;5424.620276580641;5436.619436639437;5464.508194262516;5469.386530973363;3841.615838416164;4039.3738970459626;4285.4214681017975;4331.718438301508;4339.349097635349;3415.436452985267;3990.6009399060154;4205.747655140686;4210.578942105795;4220.240356735786;3895.084655106062;4057.3711074783455;4227.907185942947;4272.572742725718;4297.97851010746;3344.715699165574;3882;4111.342185250375;4267.189234045537;4276.422682937795;3279.7048265656204;3607.152319204985;3706.9602925601016;3747.9437808432895;3768.9434658480145;5223.608229382811;5233.947660523422;5235.136202526579;5275.841724748264;5303.204519322094;4254.87235382939;4867.853964381075;4903.950960490385;4923.630727695401;4935.827246046407;4996.350474438336;5234.7644356004075;5453.672779633234;5730.624650083992;5751.223584816038;3539.681428671406;4065.2479291331197;4104.4048612950955;4128.690348223865;4133.379993001044;5351.411344752074;5637.844241930436;5980.431858973434;6065.575409721321;6070.180525629028;4075.694322925792;4168.6665066794585;4199.517055538591;4214.64175545076;4238.533761286256;3722.6091260417807;3959.762414255154;4056.918861622751;4177.4778152730905;4293.656507479394;3808.4858544096746;4737.360456338419;4846.733429661332;4866.902661946812;4940.481249468754;4625.806870316623;4755.976220118877;4881;5427.968685949657;5721.799737009268;1229.993850030762;1307.9803802942963;1404.5365029540228;1408.4577437686564;1420.3608376230738;774.573984308628;847.5169153582522;996.4569309726216;1003.3277703938232;1006.8791744990501;4171.93615628013;4345.761932604712;4917.950820491821;4973.50264973507;5047.293378926953;4937.604991600663;5605.5515558755205;5624.437556244343;5636.492715655529;5680.573956953245;4106.301928672133;4570.680052396367;5025.39695236574;5077.822276220315;5213.113770658997;2476.4428003699386;2618.738126187366;2720.9047683330987;2983.7911346205556;2990.7009299070355;5118.080719730101;5287.334489635752;5555.388907220203;5924.763009479659;5933.228680271537;4842.806287748451;4944.826931057396;5503.118401021492;5729.252577963761;5813.302403711497;5000.89998200034;5637.774489020475;5824.592278540462;5865.618734782225;5910.793122240787;4688.359074323959;4851.684640498356;5583.664980101207;5588.485181668184;5601.899287767087;4719.457262414729;5155.4783199253725;5801.912971305349;5827.184194212899;5842.853928651818;5454;5496.697681627549;5870.970645146747;6120;6146.323904370426;3908.8664287357487;3935.5670876204167;3935.74417662851;3951.510548354518;3959.8218080185884;5374.178556257996;5871.295444546682;5872.119182122716;5880.383564108129;5905.852353691193;4869.975650121727;4991.550760431579;5392.946070539245;5594.300712410949;5696.458836410535;5343.484755381696;5642.71786410686;5721.942780572141;5756.597038207286;5765.769369225184;4697.624190064855;5460.399356070909;5592.916106258328;5600.943990560042;5601.075822489243;4983.526564976321;5209;5560.277163968658;5653.293338332708;5672.688002159921;4664.883377915579;5612.074007788832;5624.775008999594;5630.3525094613005;5649.757053448235 18:29:26 INFO - PROCESS | 1914 | |5;yui.html;703.2440126863623;705.509670778809;762.980925476863;813.3795473279638;823.9782669489832;14822.629434264149;15247.542573722792;15314.693706125885;15516.534503964871;15824.683506329866;14303.427862885497;14554.27228638569;14589.416423343053;14647.560573182795;14754.704905901875;861.7457849934269;872.7948932000975;875.5753459572103;876.4522173641474;877.7805548612847;680.2483256002121;701.9052427922217;831.8211584509329;862.6851199312238;864.4381152251055;906.7823722306632;913.7304495173939;917.8990311065811;925.9120383563551;930.0234753508822;915.7756349694334;916.7708072981787;921.0145144695111;921.6543796076471;925.6575067225102;679.741698154698;685.5372623479182;686.1902954513672;689.8689249042666;690.1338819781142;14879.330430130562;15249.771253431207;15359;15530.922345388313;15535.844641553665;14347.42610295587;14770.26148692561;14784.778228326584;14867.256637168206;14927.701445971019;11494.252873563275;11597.014253788439;11636.650900472914;11665.708357291136;11732.120090993125;3634.3821550336506;3726.739128261023;3777.3578491656485;3889.047183440047;3892.785896775676;79447.20552794456;87116.56441717815;96319;107925.92074079237;114417;11190.216684831983;11232.438378081064;11291.774164516828;11735.823962640567;11802.52789888395;23484.178053768035;23586.0565577375;23887.761122388554;24258;24296.635550466755;7755.457118001798;7755.883661745078;7818.687252509836;7886.290233878978;7972.960135199287;3949.5458022327225;3955.782431966212;4007.939880901789;4029.697772667003;4033.515978082649;3577.58857731359;3674.989377921093;3724.7578907370935;3740.551133863954;3747.681447077029;653.3858173317067;655.6295692933477;657.6678777217475;658.7891874600177;678.1015154919751;567.2738894215411;644.9368975454711;675.8513127112027;682.8361193313569;701.8561194955022;10080.092791648787;10085.092341689284;10209.9489502552;10367.740806479898;10397.48012599367;623.3735096228262;668.1347654787062;681.325487767107;684.1448189762797;698.2807708060706;3849.615038496128;4610.4697959734385;4897.559219670246;4917.1149193145575;4932.358793356841;82025;85437;86832.69750953741;92457.0754292462;101119.49440252899;81131.7830232547;87195.56402218076;89120;91541;92605;80171.59914200509;81139;82440;82830;85445;9470.384425012353;9534.427934323963;9619.27855410861;9635;9666.56500457467;38334.80832595819;53132.203016954;53141.468585313654;53272.07003614838;54614.86012332787;64719.02921456088;70540;70879.64560177372;71819.92270115847;74113.62943185249;11749.236299640495;11760.76478470443;11857.288562686266;11941.522339106687;12135.75728485443;12453.315067671003;12560.811587826007;12578.748425031632;12914.418851151533;13320.800187996994;11753.529858805552;11891.28652280866;11936.820947685617;12294.631161065183;12304.938475307925;11490;11898.464569094238;11908.702282443008;11947.522099116286;12441.75116497647;11519.53921843117;11812.704682382666;11848.76302473963;11893.82159267629;12204.267743935392;8823.42658215843;9640.552258786289;10008.549615267184;10032.749181270527;10271;7807;7963.84072318562;9984.700458986243;10235.437050962268;11206.607768728056 18:29:26 INFO - PROCESS | 1914 | __end_tp_report 18:29:26 INFO - PROCESS | 1914 | __start_cc_report 18:29:26 INFO - PROCESS | 1914 | _x_x_mozilla_cycle_collect,375 18:29:26 INFO - PROCESS | 1914 | __end_cc_report 18:29:26 INFO - PROCESS | 1914 | __startTimestamp1487903366974__endTimestamp 18:29:26 INFO - PROCESS | 1914 | 18:29:26 INFO - PROCESS | 1914 | ------- Summary: start ------- 18:29:26 INFO - PROCESS | 1914 | Number of tests: 6 18:29:26 INFO - PROCESS | 1914 | 18:29:26 INFO - PROCESS | 1914 | [#0] dojo.html Cycles:165 Average:5754.71 Median:6001.70 stddev:648.69 (10.8%) stddev-sans-first:623.04 18:29:26 INFO - PROCESS | 1914 | Values: 3366.6 3375.0 3399.2 3399.3 3406.6 5777.2 5825.1 5826.3 5843.9 5855.5 4775.6 4855.8 5764.8 5810.4 5847.1 5288.8 5296.9 5317.8 5345.4 5357.9 4569.9 5344.8 5365.4 5369.4 5411.6 4299.7 5252.7 5366.4 5373.1 5388.6 5266.7 5295.6 5338.4 5383.2 5418.0 5227.7 5293.7 5299.0 5318.6 5337.4 5643.3 5837.2 5854.4 5924.9 5953.7 6149.7 6165.5 6169.2 6222.5 6228.8 6232.2 6252.8 6255.6 6264.5 6286.6 6009.7 6024.8 6042.1 6049.5 6051.6 6136.3 6138.0 6253.2 6291.9 6293.4 5366.0 6150.4 6215.2 6245.1 6279.7 5671.5 6227.7 6255.8 6259.4 6287.2 5871.4 6119.3 6124.0 6128.0 6156.4 5692.8 5828.0 6235.0 6249.6 6262.9 5033.6 5044.3 5048.6 5053.6 5057.4 4454.6 4464.9 4495.5 4506.3 4531.6 5897.4 5925.0 5977.3 6001.7 6016.5 6173.8 6236.4 6238.9 6249.6 6257.7 5772.8 5862.5 5909.4 5945.4 5969.9 5451.1 5577.3 5582.8 5586.6 5588.8 5568.4 6475.4 6484.7 6504.9 6506.2 6044.3 6110.7 6136.8 6139.8 6271.7 6372.7 6411.0 6411.2 6420.1 6425.1 6157.2 6239.6 6244.1 6244.7 6256.1 4942.4 6170.6 6224.1 6236.6 6250.8 6110.2 6206.8 6223.7 6233.2 6234.2 5221.3 6074.5 6194.7 6217.5 6229.2 5165.2 5766.7 5914.7 6035.8 6073.7 5110.0 6135.8 6150.2 6175.5 6203.0 5293.7 5968.1 6121.6 6140.5 6155.7 18:29:26 INFO - PROCESS | 1914 | 18:29:26 INFO - PROCESS | 1914 | [#1] ext.html Cycles:180 Average:66041.36 Median:38322.43 stddev:137415.55 (358.6%) stddev-sans-first:137712.74 18:29:26 INFO - PROCESS | 1914 | Values: 433.3 492.8 512.3 521.2 535.6 31454.4 40523.8 40695.6 40714.6 40723.0 42143.8 42657.4 42669.6 42716.1 42830.4 8302.8 8537.5 9095.1 9348.8 9352.8 10996.4 11271.8 11326.4 11405.8 11438.0 11060.5 11081.1 11126.8 11130.1 11139.5 11366.1 11432.9 11443.4 11465.4 11474.2 11251.5 11270.7 11303.9 11320.3 11323.3 41045.0 41265.0 41300.8 41427.8 41477.6 3893.7 3975.8 3983.6 4025.1 4056.8 29795.3 31303.7 31666.5 31832.5 31995.2 3080.8 3185.9 3262.9 3344.7 3375.6 379958.0 469801.0 471616.0 472200.3 472411.0 64095.0 64343.7 64366.0 64400.7 64610.0 67116.0 67271.3 67419.7 67444.0 67449.7 16607.1 16834.0 16841.7 16855.9 16899.6 11562.2 11859.6 12758.6 12983.9 13029.6 17427.3 17564.0 17620.9 17681.4 17815.7 5553.9 6537.4 6576.9 6647.8 6694.7 818.7 858.0 860.0 862.9 873.1 29652.7 29907.1 30325.8 30635.0 30938.7 1009.9 1028.9 1078.3 1094.4 1197.4 11539.8 11687.9 14764.2 14827.9 16303.7 521775.0 527094.0 614520.0 615897.0 619718.0 48764.5 60384.4 60761.7 61001.0 61315.7 1292.3 1357.9 1435.9 1442.6 1446.4 25591.2 28078.4 29120.4 29837.3 30340.5 50930.0 51328.5 51449.0 51471.5 51768.2 502304.0 504458.0 504910.0 505059.0 505410.0 39349.8 39740.6 39835.8 40206.8 40225.2 45037.5 45118.8 46801.3 46948.0 47373.5 37024.3 38162.2 38980.4 39089.4 39251.8 35976.0 37177.3 38482.6 39760.8 40187.0 34610.1 35506.6 35933.5 36042.3 36237.9 26803.5 32439.0 33065.8 33320.5 33375.0 19441.9 22556.3 23288.2 24561.4 24968.4 18:29:26 INFO - PROCESS | 1914 | 18:29:26 INFO - PROCESS | 1914 | [#2] jquery.html Cycles:180 Average:43037.33 Median:14245.87 stddev:135065.02 (948.1%) stddev-sans-first:135405.92 18:29:26 INFO - PROCESS | 1914 | Values: 377.0 391.2 391.3 400.1 425.3 14692.6 17031.4 19810.6 21269.8 21337.9 21251.5 21279.6 21428.3 21489.9 21651.8 5598.4 5728.2 5957.5 6051.9 6116.5 5799.5 5987.0 6030.4 6032.8 6040.8 5959.1 6009.5 6015.8 6018.0 6038.2 5836.6 6005.2 6012.5 6466.6 6587.1 5825.9 5871.8 5876.5 5878.9 5889.3 14103.9 24932.6 25004.6 25103.0 25587.2 2904.5 2968.3 2984.2 2984.6 2986.8 9961.5 10397.3 11430.7 13069.6 14527.3 1720.6 1839.9 1853.8 1857.6 1860.5 140803.0 142299.0 145711.0 151160.0 152869.5 11847.1 11897.6 12036.4 12092.7 12261.6 12140.0 15463.5 15541.5 15542.7 15558.4 6739.5 8442.9 8786.8 8910.2 8910.6 7640.9 7960.6 8578.1 8584.4 8743.1 4724.3 4727.9 4758.3 4779.9 4840.2 1673.9 1829.5 1989.3 1991.5 2015.5 874.8 968.8 1000.0 1019.7 1020.0 20316.5 20643.5 20819.1 20973.5 20975.5 988.7 989.5 1019.4 1021.3 1022.4 5999.8 6306.7 10478.8 10818.9 10883.6 792529.0 806195.0 807406.0 815003.0 822592.0 165933.0 166057.0 167300.0 170934.0 173852.0 375.0 445.9 454.9 460.0 462.4 11406.6 11566.7 11634.5 11674.8 11906.7 49134.5 51066.7 51879.5 64298.0 64419.4 92061.0 92560.5 93522.5 94175.5 95465.0 8135.5 8165.1 8195.9 8384.8 8413.7 10452.5 12095.8 12307.7 12330.6 12573.5 9655.1 10352.9 10594.5 10721.2 10784.8 10503.5 10664.0 10676.9 10994.9 11232.1 10590.4 10682.4 10877.1 10994.2 11172.4 8140.2 8194.1 8617.3 8624.4 8637.4 10459.8 10522.3 10567.4 10818.1 10882.5 18:29:26 INFO - PROCESS | 1914 | 18:29:26 INFO - PROCESS | 1914 | [#3] mootools.html Cycles:180 Average:5420.16 Median:5244.86 stddev:2934.65 (56.0%) stddev-sans-first:2926.84 18:29:26 INFO - PROCESS | 1914 | Values: 1337.5 1348.8 1441.4 1442.4 1452.0 7537.2 7778.6 8088.5 8515.9 8522.2 7997.8 8202.3 8339.9 8423.7 8447.7 2197.9 2233.5 2237.4 2243.2 2248.4 2107.3 2189.7 2282.7 2329.0 2329.9 2244.5 2350.1 2356.2 2358.9 2359.2 2310.1 2335.8 2351.8 2352.1 2357.3 1906.8 2191.1 2246.4 2253.1 2384.3 7046.8 8406.9 8419.3 8451.9 8461.1 5113.8 5228.1 5261.7 5261.7 5289.0 3071.3 3140.4 3509.7 3591.0 3625.1 1229.3 1244.8 1266.5 1277.0 1290.5 10584.7 10752.6 10865.6 10886.0 10925.4 4419.8 4749.5 4803.8 4817.1 4822.3 9554.0 9607.5 9609.0 9615.8 9659.1 5295.5 5301.9 5302.1 5308.1 5310.2 4533.7 4650.2 4756.5 4838.5 4845.3 3922.6 3989.2 4000.7 4032.1 4111.4 1200.8 1238.9 1276.2 1294.4 1322.7 794.6 841.8 909.1 916.4 919.8 5499.4 5509.6 5565.5 5760.8 5806.4 976.8 988.0 994.7 1010.9 1029.0 3683.8 3715.3 3736.8 3835.5 3850.2 9717.5 10021.8 10026.1 10063.5 10159.5 9872.8 9968.5 9984.1 9986.9 10011.7 7396.0 7773.0 7834.6 7913.2 7925.2 4921.0 4950.6 5653.6 5784.0 5834.7 7949.7 9037.2 9072.0 9245.4 9247.3 7280.6 9337.8 9360.3 9474.0 9520.1 6193.4 7214.7 7259.4 7275.5 7322.5 7531.1 7591.3 7620.8 7622.8 7636.0 6903.4 6980.2 7227.4 7266.3 7314.4 6898.6 7035.9 7039.8 7124.5 7150.6 6346.8 6359.0 6430.6 6430.9 6448.0 4926.8 4947.5 4953.9 4976.2 5041.1 4845.2 4885.1 4932.5 5088.0 5119.9 18:29:26 INFO - PROCESS | 1914 | 18:29:26 INFO - PROCESS | 1914 | [#4] prototype.html Cycles:180 Average:4562.77 Median:4978.51 stddev:1365.13 (27.4%) stddev-sans-first:1331.01 18:29:26 INFO - PROCESS | 1914 | Values: 304.3 351.6 373.6 377.1 380.2 4847.9 5152.0 5298.7 5452.9 5455.5 5414.0 5424.6 5436.6 5464.5 5469.4 3841.6 4039.4 4285.4 4331.7 4339.3 3415.4 3990.6 4205.7 4210.6 4220.2 3895.1 4057.4 4227.9 4272.6 4298.0 3344.7 3882.0 4111.3 4267.2 4276.4 3279.7 3607.2 3707.0 3747.9 3768.9 5223.6 5233.9 5235.1 5275.8 5303.2 4254.9 4867.9 4904.0 4923.6 4935.8 4996.4 5234.8 5453.7 5730.6 5751.2 3539.7 4065.2 4104.4 4128.7 4133.4 5351.4 5637.8 5980.4 6065.6 6070.2 4075.7 4168.7 4199.5 4214.6 4238.5 3722.6 3959.8 4056.9 4177.5 4293.7 3808.5 4737.4 4846.7 4866.9 4940.5 4625.8 4756.0 4881.0 5428.0 5721.8 1230.0 1308.0 1404.5 1408.5 1420.4 774.6 847.5 996.5 1003.3 1006.9 4171.9 4345.8 4918.0 4973.5 5047.3 4937.6 5605.6 5624.4 5636.5 5680.6 4106.3 4570.7 5025.4 5077.8 5213.1 2476.4 2618.7 2720.9 2983.8 2990.7 5118.1 5287.3 5555.4 5924.8 5933.2 4842.8 4944.8 5503.1 5729.3 5813.3 5000.9 5637.8 5824.6 5865.6 5910.8 4688.4 4851.7 5583.7 5588.5 5601.9 4719.5 5155.5 5801.9 5827.2 5842.9 5454.0 5496.7 5871.0 6120.0 6146.3 3908.9 3935.6 3935.7 3951.5 3959.8 5374.2 5871.3 5872.1 5880.4 5905.9 4870.0 4991.6 5392.9 5594.3 5696.5 5343.5 5642.7 5721.9 5756.6 5765.8 4697.6 5460.4 5592.9 5600.9 5601.1 4983.5 5209.0 5560.3 5653.3 5672.7 4664.9 5612.1 5624.8 5630.4 5649.8 18:29:26 INFO - PROCESS | 1914 | 18:29:26 INFO - PROCESS | 1914 | [#5] yui.html Cycles:180 Average:19877.19 Median:4754.01 stddev:28254.22 (594.3%) stddev-sans-first:28296.80 18:29:26 INFO - PROCESS | 1914 | Values: 703.2 705.5 763.0 813.4 824.0 14822.6 15247.5 15314.7 15516.5 15824.7 14303.4 14554.3 14589.4 14647.6 14754.7 861.7 872.8 875.6 876.5 877.8 680.2 701.9 831.8 862.7 864.4 906.8 913.7 917.9 925.9 930.0 915.8 916.8 921.0 921.7 925.7 679.7 685.5 686.2 689.9 690.1 14879.3 15249.8 15359.0 15530.9 15535.8 14347.4 14770.3 14784.8 14867.3 14927.7 11494.3 11597.0 11636.7 11665.7 11732.1 3634.4 3726.7 3777.4 3889.0 3892.8 79447.2 87116.6 96319.0 107925.9 114417.0 11190.2 11232.4 11291.8 11735.8 11802.5 23484.2 23586.1 23887.8 24258.0 24296.6 7755.5 7755.9 7818.7 7886.3 7973.0 3949.5 3955.8 4007.9 4029.7 4033.5 3577.6 3675.0 3724.8 3740.6 3747.7 653.4 655.6 657.7 658.8 678.1 567.3 644.9 675.9 682.8 701.9 10080.1 10085.1 10209.9 10367.7 10397.5 623.4 668.1 681.3 684.1 698.3 3849.6 4610.5 4897.6 4917.1 4932.4 82025.0 85437.0 86832.7 92457.1 101119.5 81131.8 87195.6 89120.0 91541.0 92605.0 80171.6 81139.0 82440.0 82830.0 85445.0 9470.4 9534.4 9619.3 9635.0 9666.6 38334.8 53132.2 53141.5 53272.1 54614.9 64719.0 70540.0 70879.6 71819.9 74113.6 11749.2 11760.8 11857.3 11941.5 12135.8 12453.3 12560.8 12578.7 12914.4 13320.8 11753.5 11891.3 11936.8 12294.6 12304.9 11490.0 11898.5 11908.7 11947.5 12441.8 11519.5 11812.7 11848.8 11893.8 12204.3 8823.4 9640.6 10008.5 10032.7 10271.0 7807.0 7963.8 9984.7 10235.4 11206.6 18:29:26 INFO - PROCESS | 1914 | -------- Summary: end -------- 18:29:26 INFO - PROCESS | 1914 | 18:29:26 INFO - PROCESS | 1914 | 1487903366998 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method shutdown 18:29:27 INFO - TEST-INFO | 1914: exit 0 18:29:27 INFO - TEST-OK | dromaeo_css | took 1115567ms 18:29:27 INFO - TEST-START | kraken 18:29:27 INFO - operating with platform_type : mac_ 18:29:27 INFO - Initialising browser for kraken test... 18:29:27 INFO - TEST-INFO | started process 1918 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/tmp1vCMdh/profile http://localhost:50662/getInfo.html) 18:29:28 INFO - PROCESS | 1918 | 1487903368246 addons.xpi WARN Error loading bootstrap.js for disableSHA1rollout@mozilla.org: Error opening input stream (invalid filename?): jar:file:///builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/Resources/browser/features/disableSHA1rollout@mozilla.org.xpi!/bootstrap.js 18:29:28 INFO - PROCESS | 1918 | 1487903368247 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method install 18:29:28 INFO - PROCESS | 1918 | 1487903368282 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method startup 18:29:30 INFO - PROCESS | 1918 | 2017-02-23 18:29:30.519 plugin-container[1919:60790] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b4b, name = 'com.apple.tsm.portname' 18:29:30 INFO - PROCESS | 1918 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:29:30 INFO - PROCESS | 1918 | 2017-02-23 18:29:30.522 plugin-container[1919:60790] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900f, name = 'com.apple.CFPasteboardClient' 18:29:30 INFO - PROCESS | 1918 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:29:30 INFO - PROCESS | 1918 | 2017-02-23 18:29:30.522 plugin-container[1919:60790] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 18:29:30 INFO - PROCESS | 1918 | __metrics Screen width/height:1600/1200 18:29:30 INFO - PROCESS | 1918 | colorDepth:24 18:29:30 INFO - PROCESS | 1918 | Browser inner width/height: 1024/689 18:29:30 INFO - PROCESS | 1918 | __metrics 18:29:30 ERROR - PROCESS | 1918 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 18:29:30 INFO - PROCESS | 1918 | 1487903370678 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method shutdown 18:29:31 INFO - TEST-INFO | 1918: exit 0 18:29:31 INFO - Browser initialized. 18:29:31 INFO - Running cycle 1/1 for kraken test... 18:29:31 INFO - TEST-INFO | started process 1920 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/tmp1vCMdh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:29:31 INFO - PROCESS | 1920 | 1487903371756 addons.xpi WARN Error loading bootstrap.js for disableSHA1rollout@mozilla.org: Error opening input stream (invalid filename?): jar:file:///builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/Resources/browser/features/disableSHA1rollout@mozilla.org.xpi!/bootstrap.js 18:29:31 INFO - PROCESS | 1920 | 1487903371757 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method startup 18:29:33 INFO - PROCESS | 1920 | 2017-02-23 18:29:33.793 plugin-container[1921:60910] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x453f, name = 'com.apple.tsm.portname' 18:29:33 INFO - PROCESS | 1920 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:29:33 INFO - PROCESS | 1920 | 2017-02-23 18:29:33.795 plugin-container[1921:60910] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 18:29:33 INFO - PROCESS | 1920 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:29:33 INFO - PROCESS | 1920 | 2017-02-23 18:29:33.795 plugin-container[1921:60910] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 18:29:43 INFO - PROCESS | 1920 | RSS: Main: 218693632 18:29:43 INFO - PROCESS | 1920 | 18:29:46 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:50662/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50662/tests/kraken/driver.html?testName=audio-beat-detection) 18:29:47 INFO - PROCESS | 1920 | RSS: Main: 233336832 18:29:47 INFO - PROCESS | 1920 | 18:29:50 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:50662/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50662/tests/kraken/driver.html?testName=audio-dft) 18:29:51 INFO - PROCESS | 1920 | RSS: Main: 242302976 18:29:51 INFO - PROCESS | 1920 | 18:29:54 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:50662/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50662/tests/kraken/driver.html?testName=audio-fft) 18:29:55 INFO - PROCESS | 1920 | RSS: Main: 243200000 18:29:55 INFO - PROCESS | 1920 | 18:29:57 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:50662/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50662/tests/kraken/driver.html?testName=audio-oscillator) 18:29:57 INFO - PROCESS | 1920 | RSS: Main: 245878784 18:29:57 INFO - PROCESS | 1920 | 18:29:59 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:50662/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50662/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:30:00 INFO - PROCESS | 1920 | RSS: Main: 246194176 18:30:00 INFO - PROCESS | 1920 | 18:30:03 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:50662/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50662/tests/kraken/driver.html?testName=imaging-darkroom) 18:30:03 INFO - PROCESS | 1920 | RSS: Main: 249987072 18:30:03 INFO - PROCESS | 1920 | 18:30:06 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:50662/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50662/tests/kraken/driver.html?testName=imaging-desaturate) 18:30:07 INFO - PROCESS | 1920 | RSS: Main: 249364480 18:30:07 INFO - PROCESS | 1920 | 18:30:10 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:50662/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50662/tests/kraken/driver.html?testName=json-parse-financial) 18:30:10 INFO - PROCESS | 1920 | RSS: Main: 249536512 18:30:10 INFO - PROCESS | 1920 | 18:30:12 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:50662/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50662/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:30:13 INFO - PROCESS | 1920 | RSS: Main: 248913920 18:30:13 INFO - PROCESS | 1920 | 18:30:15 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:50662/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50662/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:30:15 INFO - PROCESS | 1920 | RSS: Main: 249040896 18:30:15 INFO - PROCESS | 1920 | 18:30:17 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:50662/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50662/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:30:18 INFO - PROCESS | 1920 | RSS: Main: 249556992 18:30:18 INFO - PROCESS | 1920 | 18:30:21 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:50662/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50662/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:30:22 INFO - PROCESS | 1920 | RSS: Main: 249389056 18:30:22 INFO - PROCESS | 1920 | 18:30:25 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:50662/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50662/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:30:25 INFO - PROCESS | 1920 | RSS: Main: 249421824 18:30:25 INFO - PROCESS | 1920 | 18:30:27 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:50662/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50662/tests/kraken/driver.html?testName=ai-astar) 18:30:27 INFO - PROCESS | 1920 | RSS: Main: 251043840 18:30:27 INFO - PROCESS | 1920 | 18:30:27 INFO - PROCESS | 1920 | __start_tp_report 18:30:27 INFO - PROCESS | 1920 | _x_x_mozilla_page_load 18:30:27 INFO - PROCESS | 1920 | _x_x_mozilla_page_load_details 18:30:27 INFO - PROCESS | 1920 | |i|pagename|runs| 18:30:27 INFO - PROCESS | 1920 | |0;ai-astar;104;118;119;118;134;161;134;178;175;153 18:30:27 INFO - PROCESS | 1920 | |1;audio-beat-detection;139;100;125;185;135;116;118;106;151;137 18:30:27 INFO - PROCESS | 1920 | |2;audio-dft;196;200;198;259;221;271;276;232;195;234 18:30:27 INFO - PROCESS | 1920 | |3;audio-fft;84;61;59;86;60;59;60;51;81;85 18:30:27 INFO - PROCESS | 1920 | |4;audio-oscillator;82;69;89;60;88;88;66;56;73;113 18:30:27 INFO - PROCESS | 1920 | |5;imaging-gaussian-blur;88;86;88;86;89;84;88;86;88;85 18:30:27 INFO - PROCESS | 1920 | |6;imaging-darkroom;126;154;96;98;96;95;97;107;95;96 18:30:27 INFO - PROCESS | 1920 | |7;imaging-desaturate;93;95;91;93;96;92;94;106;91;92 18:30:27 INFO - PROCESS | 1920 | |8;json-parse-financial;61;58;58;62;62;61;63;62;64;71 18:30:27 INFO - PROCESS | 1920 | |9;json-stringify-tinderbox;66;74;70;76;74;70;76;104;106;84 18:30:27 INFO - PROCESS | 1920 | |10;stanford-crypto-aes;89;84;88;85;84;88;84;85;85;85 18:30:27 INFO - PROCESS | 1920 | |11;stanford-crypto-ccm;138;138;140;139;139;173;157;160;186;137 18:30:27 INFO - PROCESS | 1920 | |12;stanford-crypto-pbkdf2;172;172;172;167;168;169;168;172;168;173 18:30:27 INFO - PROCESS | 1920 | |13;stanford-crypto-sha256-iterative;70;69;69;67;66;66;67;65;68;66 18:30:27 INFO - PROCESS | 1920 | __end_tp_report 18:30:27 INFO - PROCESS | 1920 | __start_cc_report 18:30:27 INFO - PROCESS | 1920 | _x_x_mozilla_cycle_collect,959 18:30:27 INFO - PROCESS | 1920 | __end_cc_report 18:30:27 INFO - PROCESS | 1920 | __startTimestamp1487903427740__endTimestamp 18:30:27 INFO - PROCESS | 1920 | 18:30:27 INFO - PROCESS | 1920 | ------- Summary: start ------- 18:30:27 INFO - PROCESS | 1920 | Number of tests: 14 18:30:27 INFO - PROCESS | 1920 | 18:30:27 INFO - PROCESS | 1920 | [#0] ai-astar Cycles:10 Average:139.40 Median:143.50 stddev:25.93 (18.1%) stddev-sans-first:24.14 18:30:27 INFO - PROCESS | 1920 | Values: 104.0 118.0 119.0 118.0 134.0 161.0 134.0 178.0 175.0 153.0 18:30:27 INFO - PROCESS | 1920 | 18:30:27 INFO - PROCESS | 1920 | [#1] audio-beat-detection Cycles:10 Average:131.20 Median:136.00 stddev:24.60 (18.1%) stddev-sans-first:25.93 18:30:27 INFO - PROCESS | 1920 | Values: 139.0 100.0 125.0 185.0 135.0 116.0 118.0 106.0 151.0 137.0 18:30:27 INFO - PROCESS | 1920 | 18:30:27 INFO - PROCESS | 1920 | [#2] audio-dft Cycles:10 Average:228.20 Median:233.00 stddev:31.64 (13.6%) stddev-sans-first:31.34 18:30:27 INFO - PROCESS | 1920 | Values: 196.0 200.0 198.0 259.0 221.0 271.0 276.0 232.0 195.0 234.0 18:30:27 INFO - PROCESS | 1920 | 18:30:27 INFO - PROCESS | 1920 | [#3] audio-fft Cycles:10 Average:68.60 Median:71.00 stddev:13.59 (19.1%) stddev-sans-first:13.22 18:30:27 INFO - PROCESS | 1920 | Values: 84.0 61.0 59.0 86.0 60.0 59.0 60.0 51.0 81.0 85.0 18:30:27 INFO - PROCESS | 1920 | 18:30:27 INFO - PROCESS | 1920 | [#4] audio-oscillator Cycles:10 Average:78.40 Median:77.50 stddev:17.06 (22.0%) stddev-sans-first:18.04 18:30:27 INFO - PROCESS | 1920 | Values: 82.0 69.0 89.0 60.0 88.0 88.0 66.0 56.0 73.0 113.0 18:30:27 INFO - PROCESS | 1920 | 18:30:27 INFO - PROCESS | 1920 | [#5] imaging-gaussian-blur Cycles:10 Average:86.80 Median:88.00 stddev:1.62 (1.8%) stddev-sans-first:1.66 18:30:27 INFO - PROCESS | 1920 | Values: 88.0 86.0 88.0 86.0 89.0 84.0 88.0 86.0 88.0 85.0 18:30:27 INFO - PROCESS | 1920 | 18:30:27 INFO - PROCESS | 1920 | [#6] imaging-darkroom Cycles:10 Average:106.00 Median:96.00 stddev:19.41 (20.2%) stddev-sans-first:19.19 18:30:27 INFO - PROCESS | 1920 | Values: 126.0 154.0 96.0 98.0 96.0 95.0 97.0 107.0 95.0 96.0 18:30:27 INFO - PROCESS | 1920 | 18:30:27 INFO - PROCESS | 1920 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:93.00 stddev:4.42 (4.8%) stddev-sans-first:4.67 18:30:27 INFO - PROCESS | 1920 | Values: 93.0 95.0 91.0 93.0 96.0 92.0 94.0 106.0 91.0 92.0 18:30:27 INFO - PROCESS | 1920 | 18:30:27 INFO - PROCESS | 1920 | [#8] json-parse-financial Cycles:10 Average:62.20 Median:62.00 stddev:3.65 (5.9%) stddev-sans-first:3.84 18:30:27 INFO - PROCESS | 1920 | Values: 61.0 58.0 58.0 62.0 62.0 61.0 63.0 62.0 64.0 71.0 18:30:27 INFO - PROCESS | 1920 | 18:30:27 INFO - PROCESS | 1920 | [#9] json-stringify-tinderbox Cycles:10 Average:80.00 Median:74.00 stddev:14.02 (18.9%) stddev-sans-first:13.92 18:30:27 INFO - PROCESS | 1920 | Values: 66.0 74.0 70.0 76.0 74.0 70.0 76.0 104.0 106.0 84.0 18:30:27 INFO - PROCESS | 1920 | 18:30:27 INFO - PROCESS | 1920 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:85.00 stddev:1.89 (2.2%) stddev-sans-first:1.58 18:30:27 INFO - PROCESS | 1920 | Values: 89.0 84.0 88.0 85.0 84.0 88.0 84.0 85.0 85.0 85.0 18:30:27 INFO - PROCESS | 1920 | 18:30:27 INFO - PROCESS | 1920 | [#11] stanford-crypto-ccm Cycles:10 Average:150.70 Median:148.50 stddev:17.54 (11.8%) stddev-sans-first:17.99 18:30:27 INFO - PROCESS | 1920 | Values: 138.0 138.0 140.0 139.0 139.0 173.0 157.0 160.0 186.0 137.0 18:30:27 INFO - PROCESS | 1920 | 18:30:27 INFO - PROCESS | 1920 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.10 Median:172.00 stddev:2.28 (1.3%) stddev-sans-first:2.32 18:30:27 INFO - PROCESS | 1920 | Values: 172.0 172.0 172.0 167.0 168.0 169.0 168.0 172.0 168.0 173.0 18:30:27 INFO - PROCESS | 1920 | 18:30:27 INFO - PROCESS | 1920 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.50 stddev:1.64 (2.4%) stddev-sans-first:1.41 18:30:27 INFO - PROCESS | 1920 | Values: 70.0 69.0 69.0 67.0 66.0 66.0 67.0 65.0 68.0 66.0 18:30:27 INFO - PROCESS | 1920 | -------- Summary: end -------- 18:30:27 INFO - PROCESS | 1920 | 18:30:27 INFO - PROCESS | 1920 | 1487903427763 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method shutdown 18:30:28 INFO - TEST-INFO | 1920: exit 0 18:30:28 INFO - TEST-OK | kraken | took 61027ms 18:30:28 INFO - SUITE-END | took 1176s 18:30:28 INFO - Completed test suite (00:19:36) 18:30:28 INFO - javascript benchmark 18:30:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7278.117837124048, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3366.5791776027995, 3375.0, 3399.2351720862807, 3399.3201359728055, 3406.625271220164, 5777.220075289834, 5825.067989121741, 5826.300843898733, 5843.941560584393, 5855.47300742933, 4775.6418268629905, 4855.830045948393, 5764.7982320618785, 5810.448007439287, 5847.064469684851, 5288.788448462066, 5296.894062118756, 5317.8404647860625, 5345.412004679482, 5357.892842143155, 4569.862904112865, 5344.839654810362, 5365.436629153941, 5369.382521010075, 5411.56707463402, 4299.656027517791, 5252.737363131847, 5366.382865970424, 5373.113436283009, 5388.568914486832, 5266.683998960075, 5295.576353891679, 5338.359396872362, 5383.246345511631, 5417.970585588726, 5227.686338819683, 5293.682379057231, 5299.0, 5318.601104917108, 5337.439568845293, 5643.266375371176, 5837.211976383176, 5854.356020837705, 5924.881502369972, 5953.664869183178, 6149.723262453201, 6165.475934545569, 6169.198004259462, 6222.502199824004, 6228.781992630282, 6232.220972378453, 6252.812415627493, 6255.562110652256, 6264.467520260738, 6286.591371560879, 6009.699515024231, 6024.8493787655225, 6042.063480160582, 6049.48579370754, 6051.636901785863, 6136.304638670889, 6137.989923150242, 6253.155823963798, 6291.905621415683, 6293.433590976834, 5366.007288651612, 6150.354212807681, 6215.192025036717, 6245.125682404467, 6279.686015699197, 5671.489565939085, 6227.688615569204, 6255.843603909848, 6259.374062593704, 6287.1826662534495, 5871.383504731942, 6119.326874043852, 6124.045297608036, 6128.014278093809, 6156.353582873823, 5692.7722891083895, 5827.980103481874, 6235.0, 6249.562530622813, 6262.937370626236, 5033.6224783141415, 5044.2937988681615, 5048.62135339851, 5053.5957123430035, 5057.393112826484, 4454.554544545519, 4464.888377790581, 4495.505494395614, 4506.301523263899, 4531.614812740888, 5897.410258974069, 5925.0, 5977.252843394575, 6001.699915004232, 6016.488598469092, 6173.84565385869, 6236.438720515084, 6238.906416403757, 6249.562530622904, 6257.749690012349, 5772.826815195551, 5862.501687356623, 5909.438603332676, 5945.375735547792, 5969.850753731192, 5451.073317536028, 5577.274954256002, 5582.7766889323975, 5586.55307575393, 5588.804391846266, 5568.359638641527, 6475.449586785176, 6484.740610375532, 6504.902426463702, 6506.219253689587, 6044.304904935812, 6110.663913484801, 6136.764169924236, 6139.829471381233, 6271.749130034747, 6372.681365931592, 6410.967945160244, 6411.198600174978, 6420.06908998202, 6425.06836508713, 6157.230346206724, 6239.625622462667, 6244.125822384779, 6244.65654389013, 6256.124142620128, 4942.4316203637045, 6170.642458659087, 6224.06639004153, 6236.6258024518675, 6250.812475625738, 6110.1638887921135, 6206.782762603287, 6223.657698826608, 6233.158523599256, 6234.220722409699, 5221.321228240305, 6074.544409169242, 6194.721237544231, 6217.533684973555, 6229.190205273286, 5165.199394093921, 5766.654000759968, 5914.704264786829, 6035.78874739382, 6073.726682299395, 5109.974450127875, 6135.814547850547, 6150.201658245398, 6175.475084617858, 6203.0, 5293.708846013506, 5968.134620479919, 6121.632702037892, 6140.508759299156, 6155.6614386209185], "value": 5716.515927999418, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [433.3413211917885, 492.83490030839664, 512.3467578836984, 521.2181727408887, 535.5795700375206, 31454.370912581733, 40523.79738101309, 40695.59304406955, 40714.59285407145, 40723.0, 42143.78928105363, 42657.36013959793, 42669.573304266945, 42716.14567708644, 42830.357544636856, 8302.792430189233, 8537.487750734945, 9095.135962083608, 9348.766280842965, 9352.7661808455, 10996.395198264092, 11271.830922536168, 11326.377049262288, 11405.828912566318, 11438.0, 11060.502277397496, 11081.113510919147, 11126.833097503504, 11130.109591232682, 11139.498722557504, 11366.090712743002, 11432.94283528577, 11443.427828608577, 11465.369404682739, 11474.196806223568, 11251.54993800247, 11270.718232044183, 11303.943480282629, 11320.320780753182, 11323.263987840764, 41044.97387565305, 41264.968375790544, 41300.79349603263, 41427.79286103581, 41477.585224147675, 3893.7079719020903, 3975.840966361342, 3983.5618082010956, 4025.134596061861, 4056.837726490937, 29795.25511862199, 31303.686963130305, 31666.525002124985, 31832.522512162337, 31995.200119996953, 3080.799748016394, 3185.9362812743616, 3262.9184270393193, 3344.749143814199, 3375.6455572164814, 379958.0, 469801.0, 471616.0, 472200.27799721906, 472411.0, 64095.0, 64343.67828160829, 64366.0, 64400.71198576002, 64610.03084953636, 67116.0, 67271.32728672748, 67419.66290168518, 67444.0, 67449.66275168593, 16607.086610236554, 16834.0, 16841.747373789403, 16855.91572042132, 16899.57751056209, 11562.248453850472, 11859.58491452795, 12758.61724148277, 12983.870161298455, 13029.609111726664, 17427.302907883543, 17564.0, 17620.91189544044, 17681.381151659887, 17815.73276400829, 5553.888922221533, 6537.411632953057, 6576.8819300719, 6647.833804154838, 6694.698738556776, 818.7257268814894, 858.0047145311534, 859.9742007739778, 862.857628491292, 873.0527377795037, 29652.703472964993, 29907.102786916428, 30325.848370758005, 30635.0, 30938.690613093582, 1009.9141572966233, 1028.8919663435381, 1078.3475997021847, 1094.4199574225672, 1197.4132674989194, 11539.826902596467, 11687.88312116885, 14764.187969661773, 14827.851721482863, 16303.673926521404, 521775.0, 527094.0, 614520.0, 615897.0, 619718.0, 48764.51235487671, 60384.396156038754, 60761.69619151876, 61001.0, 61315.693421532604, 1292.3215311961296, 1357.927237482378, 1435.8564143585559, 1442.5816513211262, 1446.406973141007, 25591.23226303214, 28078.43843123167, 29120.41759164847, 29837.254068648457, 30340.54489182708, 50930.0, 51328.48671513237, 51448.971020580124, 51471.48528514817, 51768.22347664713, 502304.0, 504458.0, 504910.0, 505059.0, 505410.0, 39349.80325098356, 39740.60259397484, 39835.80082099571, 40206.798966004986, 40225.19549608933, 45037.549624503336, 45118.77440612776, 46801.29798052964, 46948.0, 47373.52626473691, 37024.25951481009, 38162.236755265294, 38980.40575689244, 39089.41365879457, 39251.803740981115, 35976.0, 37177.25645487129, 38482.6151738479, 39760.80119599384, 40186.9953251171, 34610.134746631535, 35506.64493355137, 35933.46099808453, 36042.27915441729, 36237.912862613106, 26803.463930721668, 32439.0, 33065.84269550554, 33320.50019249762, 33375.0, 19441.90279048652, 22556.32331030072, 23288.189227109833, 24561.385965350295, 24968.37579060538], "value": 20147.4366477084, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.9509963704718, 391.2370876790258, 391.2585650192885, 400.075824844609, 425.3194888178914, 14692.632684182901, 17031.40390086347, 19810.60378792425, 21269.787302126973, 21337.893310533444, 21251.468713282175, 21279.57440851186, 21428.25001124961, 21489.892550537264, 21651.783482165174, 5598.384177740456, 5728.198052272664, 5957.463828255456, 6051.878962420749, 6116.510679145657, 5799.507041901444, 5987.0121429964, 6030.396960303979, 6032.788852390167, 6040.758369665208, 5959.106134079901, 6009.4591486766185, 6015.75936962521, 6018.0, 6038.184845045928, 5836.5564815184025, 6005.249343832021, 6012.458878700916, 6466.612003279772, 6587.11074005008, 5825.9417405825825, 5871.765129394819, 5876.500497457721, 5878.853028674274, 5889.293284805808, 14103.929480352635, 24932.626010609856, 25004.624930626054, 25103.0, 25587.23238302854, 2904.5062339402352, 2968.257935516121, 2984.19426754775, 2984.612000439929, 2986.7759918006236, 9961.501924903725, 10397.32417392867, 11430.657080287605, 13069.607911762663, 14527.346269417902, 1720.5688897714042, 1839.8712090153695, 1853.8238867307584, 1857.6470470610675, 1860.5441666791723, 140803.0, 142298.99999999895, 145711.0, 151160.0, 152869.47130528663, 11847.111466639864, 11897.583584574499, 12036.39818009096, 12092.697682558006, 12261.632151035483, 12140.0, 15463.5360939172, 15541.45604903823, 15542.689146217012, 15558.377664893504, 6739.52823302374, 8442.873356899652, 8786.824263514694, 8910.242629376575, 8910.55447227636, 7640.853871919257, 7960.56216908064, 8578.056413794478, 8584.442011269248, 8743.125687431206, 4724.314974328703, 4727.858164255078, 4758.263233919594, 4779.856604301876, 4840.177169881129, 1673.9330426783035, 1829.5426143464133, 1989.3435166395054, 1991.531989982353, 2015.4759762461865, 874.7813046738315, 968.8304546704298, 999.980000399988, 1019.6788011776267, 1019.9796004080025, 20316.492087697927, 20643.4839129023, 20819.06314215864, 20973.475663108544, 20975.475613109793, 988.7083310423442, 989.4656885282011, 1019.4444028004755, 1021.279997601689, 1022.3712416863575, 5999.790007349722, 6306.747730090837, 10478.790424191626, 10818.945905270422, 10883.619073332395, 792529.0, 806195.0, 807406.0, 815003.0, 822592.0, 165933.0, 166057.0, 167300.0, 170934.0, 173852.0, 374.98875033749033, 445.895214624563, 454.9021960278556, 460.0155666872895, 462.4242817691995, 11406.600768973047, 11566.710832229262, 11634.53461861516, 11674.832516748258, 11906.702332441411, 49134.50865491299, 51066.744666276434, 51879.48120518746, 64298.0, 64419.35580644134, 92061.0, 92560.53719731358, 93522.53238733763, 94175.52912235395, 95465.04534954562, 8135.471194372347, 8165.061017983008, 8195.877061843958, 8384.790380240298, 8413.70552030676, 10452.529636166239, 12095.758084838079, 12307.69230769238, 12330.568430104904, 12573.497060117494, 9655.131424496067, 10352.896471035194, 10594.4702764863, 10721.195910306602, 10784.838227426751, 10503.527341269813, 10663.98692124247, 10676.946615266874, 10994.945025274823, 11232.101431885267, 10590.41752703578, 10682.412467314061, 10877.075448586642, 10994.230403871972, 11172.441377931233, 8140.185981401813, 8194.098649148707, 8617.267532259828, 8624.439411438236, 8637.395382323177, 10459.790804184026, 10522.31604945676, 10567.365958042543, 10818.080463160719, 10882.455877206266], "value": 9585.479194718278, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1337.4819579776956, 1348.8197826901462, 1441.401818245428, 1442.4446588063593, 1451.9836114719699, 7537.24627537246, 7778.5721785301785, 8088.474249173807, 8515.872261916069, 8522.232999030093, 7997.800604833674, 8202.343812495, 8339.91660083399, 8423.663053477854, 8447.704330348439, 2197.9120835166573, 2233.4974630708043, 2237.3847192022163, 2243.2036626997424, 2248.3592176229777, 2107.2729908181727, 2189.7481789594162, 2282.7146606674164, 2328.9650655240184, 2329.9184528541505, 2244.528648983707, 2350.118705485443, 2356.175338631482, 2358.929232123039, 2359.245041586693, 2310.1336998625516, 2335.8131349492087, 2351.776581224781, 2352.0826877517784, 2357.257463898875, 1906.818852209038, 2191.1454532732246, 2246.3934737620916, 2253.087499562663, 2384.332386931662, 7046.823829404306, 8406.873896891551, 8419.284360829337, 8451.915480845175, 8461.11158328379, 5113.769880355393, 5228.058949389108, 5261.657992230493, 5261.657992230493, 5289.0, 3071.2782496113396, 3140.434721750084, 3509.6841284284283, 3590.964090359089, 3625.062676549294, 1229.330015141741, 1244.7946088895321, 1266.4870727355435, 1277.0294576122214, 1290.5483080921601, 10584.682459526226, 10752.569897204103, 10865.619703310345, 10886.020258176723, 10925.399103049329, 4419.756913369732, 4749.525047495292, 4803.78382972767, 4817.13291607514, 4822.324874517571, 9554.04459554039, 9607.51962401891, 9608.95195524018, 9615.759606009906, 9659.082387173208, 5295.4969277918535, 5301.893962120736, 5302.072137376021, 5308.124159513637, 5310.150375939831, 4533.659975501851, 4650.232711602548, 4756.453007904066, 4838.540338667821, 4845.345878306383, 3922.646961773397, 3989.162275922089, 4000.6799456043445, 4032.052467670095, 4111.424400583921, 1200.8318835363057, 1238.937169612585, 1276.2023735165521, 1294.3657607772125, 1322.65610941156, 794.6344681446599, 841.8063845315612, 909.1136142261242, 916.4043371808378, 919.8160367926441, 5499.367572729107, 5509.559235261169, 5565.526930210896, 5760.8271751847515, 5806.390329015392, 976.7948730766476, 988.0, 994.6717583197527, 1010.8786945566579, 1029.0378496106164, 3683.778973261613, 3715.3126671565847, 3736.7571107878443, 3835.520559930009, 3850.2492014057552, 9717.46553939526, 10021.79956400868, 10026.147777438853, 10063.5471403787, 10159.542820573091, 9872.753181170385, 9968.451735154636, 9984.051515106054, 9986.850197247048, 10011.749706257257, 7396.0, 7772.950651662067, 7834.647440865175, 7913.208679132041, 7925.207479252144, 4920.991196804574, 4950.603951683928, 5653.604247702621, 5783.987802134694, 5834.679092649945, 7949.7217597383815, 9037.231835294073, 9071.954640226757, 9245.445273283625, 9247.306452015991, 7280.635968201463, 9337.766555836159, 9360.251179905456, 9473.952630236805, 9520.143187113194, 6193.411625895533, 7214.74748383804, 7259.419246460376, 7275.490715650066, 7322.462282920646, 7531.133919599097, 7591.278828511283, 7620.771376858703, 7622.8094297643, 7636.0, 6903.413209877217, 6980.232174460703, 7227.421806255592, 7266.346028857428, 7314.378277846443, 6898.613699558401, 7035.859282814417, 7039.753608623673, 7124.465665075244, 7150.6424678764815, 6346.809595712136, 6359.0, 6430.64631445275, 6430.903536447051, 6447.967760161169, 4926.827561035347, 4947.529984651453, 4953.925691114564, 4976.2286845539, 5041.117804384145, 4845.167251159986, 4885.1450996076255, 4932.506749325039, 5088.0, 5119.87200319995], "value": 4420.484557064641, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.3365463290028, 351.58161787472903, 373.5797228118367, 377.11754494482904, 380.2452132516952, 4847.886959034605, 5152.021115987969, 5298.735063246837, 5452.945470545294, 5455.481729235721, 5414.0, 5424.620276580641, 5436.619436639437, 5464.508194262516, 5469.386530973363, 3841.615838416164, 4039.3738970459626, 4285.4214681017975, 4331.718438301508, 4339.349097635349, 3415.436452985267, 3990.6009399060154, 4205.747655140686, 4210.578942105795, 4220.240356735786, 3895.084655106062, 4057.3711074783455, 4227.907185942947, 4272.572742725718, 4297.97851010746, 3344.715699165574, 3882.0, 4111.342185250375, 4267.189234045537, 4276.422682937795, 3279.7048265656204, 3607.152319204985, 3706.9602925601016, 3747.9437808432895, 3768.9434658480145, 5223.608229382811, 5233.947660523422, 5235.136202526579, 5275.841724748264, 5303.204519322094, 4254.87235382939, 4867.853964381075, 4903.950960490385, 4923.630727695401, 4935.827246046407, 4996.350474438336, 5234.7644356004075, 5453.672779633234, 5730.624650083992, 5751.223584816038, 3539.681428671406, 4065.2479291331197, 4104.4048612950955, 4128.690348223865, 4133.379993001044, 5351.411344752074, 5637.844241930436, 5980.431858973434, 6065.575409721321, 6070.180525629028, 4075.694322925792, 4168.6665066794585, 4199.517055538591, 4214.64175545076, 4238.533761286256, 3722.6091260417807, 3959.762414255154, 4056.918861622751, 4177.4778152730905, 4293.656507479394, 3808.4858544096746, 4737.360456338419, 4846.733429661332, 4866.902661946812, 4940.481249468754, 4625.806870316623, 4755.976220118877, 4881.0, 5427.968685949657, 5721.799737009268, 1229.993850030762, 1307.9803802942963, 1404.5365029540228, 1408.4577437686564, 1420.3608376230738, 774.573984308628, 847.5169153582522, 996.4569309726216, 1003.3277703938232, 1006.8791744990501, 4171.93615628013, 4345.761932604712, 4917.950820491821, 4973.50264973507, 5047.293378926953, 4937.604991600663, 5605.5515558755205, 5624.437556244343, 5636.492715655529, 5680.573956953245, 4106.301928672133, 4570.680052396367, 5025.39695236574, 5077.822276220315, 5213.113770658997, 2476.4428003699386, 2618.738126187366, 2720.9047683330987, 2983.7911346205556, 2990.7009299070355, 5118.080719730101, 5287.334489635752, 5555.388907220203, 5924.763009479659, 5933.228680271537, 4842.806287748451, 4944.826931057396, 5503.118401021492, 5729.252577963761, 5813.302403711497, 5000.89998200034, 5637.774489020475, 5824.592278540462, 5865.618734782225, 5910.793122240787, 4688.359074323959, 4851.684640498356, 5583.664980101207, 5588.485181668184, 5601.899287767087, 4719.457262414729, 5155.4783199253725, 5801.912971305349, 5827.184194212899, 5842.853928651818, 5454.0, 5496.697681627549, 5870.970645146747, 6120.0, 6146.323904370426, 3908.8664287357487, 3935.5670876204167, 3935.74417662851, 3951.510548354518, 3959.8218080185884, 5374.178556257996, 5871.295444546682, 5872.119182122716, 5880.383564108129, 5905.852353691193, 4869.975650121727, 4991.550760431579, 5392.946070539245, 5594.300712410949, 5696.458836410535, 5343.484755381696, 5642.71786410686, 5721.942780572141, 5756.597038207286, 5765.769369225184, 4697.624190064855, 5460.399356070909, 5592.916106258328, 5600.943990560042, 5601.075822489243, 4983.526564976321, 5209.0, 5560.277163968658, 5653.293338332708, 5672.688002159921, 4664.883377915579, 5612.074007788832, 5624.775008999594, 5630.3525094613005, 5649.757053448235], "value": 4144.055740078784, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [703.2440126863623, 705.509670778809, 762.980925476863, 813.3795473279638, 823.9782669489832, 14822.629434264149, 15247.542573722792, 15314.693706125885, 15516.534503964871, 15824.683506329866, 14303.427862885497, 14554.27228638569, 14589.416423343053, 14647.560573182795, 14754.704905901875, 861.7457849934269, 872.7948932000975, 875.5753459572103, 876.4522173641474, 877.7805548612847, 680.2483256002121, 701.9052427922217, 831.8211584509329, 862.6851199312238, 864.4381152251055, 906.7823722306632, 913.7304495173939, 917.8990311065811, 925.9120383563551, 930.0234753508822, 915.7756349694334, 916.7708072981787, 921.0145144695111, 921.6543796076471, 925.6575067225102, 679.741698154698, 685.5372623479182, 686.1902954513672, 689.8689249042666, 690.1338819781142, 14879.330430130562, 15249.771253431207, 15359.0, 15530.922345388313, 15535.844641553665, 14347.42610295587, 14770.26148692561, 14784.778228326584, 14867.256637168206, 14927.701445971019, 11494.252873563275, 11597.014253788439, 11636.650900472914, 11665.708357291136, 11732.120090993125, 3634.3821550336506, 3726.739128261023, 3777.3578491656485, 3889.047183440047, 3892.785896775676, 79447.20552794456, 87116.56441717815, 96319.0, 107925.92074079237, 114417.0, 11190.216684831983, 11232.438378081064, 11291.774164516828, 11735.823962640567, 11802.52789888395, 23484.178053768035, 23586.0565577375, 23887.761122388554, 24258.0, 24296.635550466755, 7755.457118001798, 7755.883661745078, 7818.687252509836, 7886.290233878978, 7972.960135199287, 3949.5458022327225, 3955.782431966212, 4007.939880901789, 4029.697772667003, 4033.515978082649, 3577.58857731359, 3674.989377921093, 3724.7578907370935, 3740.551133863954, 3747.681447077029, 653.3858173317067, 655.6295692933477, 657.6678777217475, 658.7891874600177, 678.1015154919751, 567.2738894215411, 644.9368975454711, 675.8513127112027, 682.8361193313569, 701.8561194955022, 10080.092791648787, 10085.092341689284, 10209.9489502552, 10367.740806479898, 10397.48012599367, 623.3735096228262, 668.1347654787062, 681.325487767107, 684.1448189762797, 698.2807708060706, 3849.615038496128, 4610.4697959734385, 4897.559219670246, 4917.1149193145575, 4932.358793356841, 82025.0, 85437.0, 86832.69750953741, 92457.0754292462, 101119.49440252899, 81131.7830232547, 87195.56402218076, 89120.0, 91541.0, 92605.0, 80171.59914200509, 81139.0, 82440.0, 82830.0, 85445.0, 9470.384425012353, 9534.427934323963, 9619.27855410861, 9635.0, 9666.56500457467, 38334.80832595819, 53132.203016954, 53141.468585313654, 53272.07003614838, 54614.86012332787, 64719.02921456088, 70540.0, 70879.64560177372, 71819.92270115847, 74113.62943185249, 11749.236299640495, 11760.76478470443, 11857.288562686266, 11941.522339106687, 12135.75728485443, 12453.315067671003, 12560.811587826007, 12578.748425031632, 12914.418851151533, 13320.800187996994, 11753.529858805552, 11891.28652280866, 11936.820947685617, 12294.631161065183, 12304.938475307925, 11490.0, 11898.464569094238, 11908.702282443008, 11947.522099116286, 12441.75116497647, 11519.53921843117, 11812.704682382666, 11848.76302473963, 11893.82159267629, 12204.267743935392, 8823.42658215843, 9640.552258786289, 10008.549615267184, 10032.749181270527, 10271.0, 7807.0, 7963.84072318562, 9984.700458986243, 10235.437050962268, 11206.607768728056], "value": 7348.641250608578, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1548.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 118.0, 119.0, 118.0, 134.0, 161.0, 134.0, 178.0, 175.0, 153.0], "value": 139.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 100.0, 125.0, 185.0, 135.0, 116.0, 118.0, 106.0, 151.0, 137.0], "value": 131.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 200.0, 198.0, 259.0, 221.0, 271.0, 276.0, 232.0, 195.0, 234.0], "value": 228.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 61.0, 59.0, 86.0, 60.0, 59.0, 60.0, 51.0, 81.0, 85.0], "value": 68.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 69.0, 89.0, 60.0, 88.0, 88.0, 66.0, 56.0, 73.0, 113.0], "value": 78.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 88.0, 86.0, 89.0, 84.0, 88.0, 86.0, 88.0, 85.0], "value": 86.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 154.0, 96.0, 98.0, 96.0, 95.0, 97.0, 107.0, 95.0, 96.0], "value": 106.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 95.0, 91.0, 93.0, 96.0, 92.0, 94.0, 106.0, 91.0, 92.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 58.0, 58.0, 62.0, 62.0, 61.0, 63.0, 62.0, 64.0, 71.0], "value": 62.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 74.0, 70.0, 76.0, 74.0, 70.0, 76.0, 104.0, 106.0, 84.0], "value": 80.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 84.0, 88.0, 85.0, 84.0, 88.0, 84.0, 85.0, 85.0, 85.0], "value": 85.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 138.0, 140.0, 139.0, 139.0, 173.0, 157.0, 160.0, 186.0, 137.0], "value": 150.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 172.0, 172.0, 167.0, 168.0, 169.0, 168.0, 172.0, 168.0, 173.0], "value": 170.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 69.0, 67.0, 66.0, 66.0, 67.0, 65.0, 68.0, 66.0], "value": 67.3, "unit": "score"}]}]} 18:30:29 INFO - Return code: 0 18:30:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:30:29 ERROR - # TBPL SUCCESS # 18:30:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:30:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:30:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:30:29 INFO - 2017-02-23 18:30:29.099 screenresolution[1926:61305] starting screenresolution argv=screenresolution get 18:30:29 INFO - 2017-02-23 18:30:29.102 screenresolution[1926:61305] Display 0: 1600x1200x32@60 18:30:29 INFO - 2017-02-23 18:30:29.108 screenresolution[1927:61308] starting screenresolution argv=screenresolution list 18:30:29 INFO - Available Modes on Display 0 18:30:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:30:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:30:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:30:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:30:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:30:29 INFO - Intel Iris: 18:30:29 INFO - Chipset Model: Intel Iris 18:30:29 INFO - Type: GPU 18:30:29 INFO - Bus: Built-In 18:30:29 INFO - VRAM (Dynamic, Max): 1536 MB 18:30:29 INFO - Vendor: Intel (0x8086) 18:30:29 INFO - Device ID: 0x0a2e 18:30:29 INFO - Revision ID: 0x0009 18:30:29 INFO - Displays: 18:30:29 INFO - Display: 18:30:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:30:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:30:29 INFO - Display Serial Number: 1600x1200 60 18:30:29 INFO - Main Display: Yes 18:30:29 INFO - Mirror: Off 18:30:29 INFO - Online: Yes 18:30:29 INFO - Rotation: Supported 18:30:29 INFO - Return code: 0 18:30:29 INFO - Running post-action listener: _resource_record_post_action 18:30:29 INFO - [mozharness: 2017-02-24 02:30:29.347368Z] Finished run-tests step (success) 18:30:29 INFO - Running post-run listener: _resource_record_post_run 18:30:29 INFO - Total resource usage - Wall time: 1197s; CPU: 54.0%; Read bytes: 1046016; Write bytes: 510134784; Read time: 11; Write time: 1841 18:30:29 INFO - TinderboxPrint: CPU usage
54.4% 18:30:29 INFO - TinderboxPrint: I/O read bytes / time
1,046,016 / 11 18:30:29 INFO - TinderboxPrint: I/O write bytes / time
510,134,784 / 1,841 18:30:29 INFO - TinderboxPrint: CPU idle
2,185.3 (45.6%) 18:30:29 INFO - TinderboxPrint: CPU system
966.9 (20.2%) 18:30:29 INFO - TinderboxPrint: CPU user
1,637.5 (34.2%) 18:30:29 INFO - TinderboxPrint: Swap in / out
208,699,392 / 0 18:30:29 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 208710144; Write bytes: 207331328; Read time: 15869; Write time: 411 18:30:29 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 943616; Write bytes: 300120576; Read time: 9; Write time: 1417 18:30:29 INFO - Running post-run listener: _upload_blobber_files 18:30:29 INFO - Blob upload gear active. 18:30:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:30:29 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 18:30:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:30:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:30:30 INFO - (blobuploader) - INFO - Open directory for files ... 18:30:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:30:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:30:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:30:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:30:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:30:31 INFO - (blobuploader) - INFO - Done attempting. 18:30:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:30:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:30:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:30:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:30:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:30:32 INFO - (blobuploader) - INFO - Done attempting. 18:30:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:30:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:30:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:30:33 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:30:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:30:33 INFO - (blobuploader) - INFO - Done attempting. 18:30:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:30:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:30:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:30:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:30:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:30:35 INFO - (blobuploader) - INFO - Done attempting. 18:30:35 INFO - (blobuploader) - INFO - Iteration through files over. 18:30:35 INFO - Return code: 0 18:30:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:30:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:30:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2e33eed91e0745541ba042fa4a1f930563127d322503748aab31c8d7601d7225b580ac34367750458cd893ec8bc023650b62fdfd43eeea93a68dc7949c6b784b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/020823711c4f2176d953f61e9057d35a60a936e006d0a571fdfbcf94a5206b28ff60625591e95083418054bc9394fae92fa0b18ddf2410dd06663ca5a017040b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e9ae101429496c1acd736dc2d34e0d9659b4a6883bba44242f41fbaf2d994185d5ba1f5cf82350d60554984ce478e1807b63a7f70eb248e36d9dd572c0235d91", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e8e27f94a4483122cd73dd19e8765f96b7e3764573bda63c94123ff7a94ac97f2693299f203ddfba39da6c2519bd69fe4a9f4f544f4060edade7879884d65fe0"} 18:30:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:30:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:30:35 INFO - Contents: 18:30:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2e33eed91e0745541ba042fa4a1f930563127d322503748aab31c8d7601d7225b580ac34367750458cd893ec8bc023650b62fdfd43eeea93a68dc7949c6b784b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/020823711c4f2176d953f61e9057d35a60a936e006d0a571fdfbcf94a5206b28ff60625591e95083418054bc9394fae92fa0b18ddf2410dd06663ca5a017040b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e9ae101429496c1acd736dc2d34e0d9659b4a6883bba44242f41fbaf2d994185d5ba1f5cf82350d60554984ce478e1807b63a7f70eb248e36d9dd572c0235d91", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e8e27f94a4483122cd73dd19e8765f96b7e3764573bda63c94123ff7a94ac97f2693299f203ddfba39da6c2519bd69fe4a9f4f544f4060edade7879884d65fe0"} 18:30:35 INFO - Running post-run listener: copy_logs_to_upload_dir 18:30:35 INFO - Copying logs to upload dir... 18:30:35 INFO - mkdir: /builds/slave/test/build/upload/logs 18:30:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.026036 ========= master_lag: 0.77 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-02-23 18:30:36.768012) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-23 18:30:36.775904) ========= 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.ATjBhOMtEP/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.cL0MlXKeUf/Listeners TMPDIR=/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2e33eed91e0745541ba042fa4a1f930563127d322503748aab31c8d7601d7225b580ac34367750458cd893ec8bc023650b62fdfd43eeea93a68dc7949c6b784b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/020823711c4f2176d953f61e9057d35a60a936e006d0a571fdfbcf94a5206b28ff60625591e95083418054bc9394fae92fa0b18ddf2410dd06663ca5a017040b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e9ae101429496c1acd736dc2d34e0d9659b4a6883bba44242f41fbaf2d994185d5ba1f5cf82350d60554984ce478e1807b63a7f70eb248e36d9dd572c0235d91", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e8e27f94a4483122cd73dd19e8765f96b7e3764573bda63c94123ff7a94ac97f2693299f203ddfba39da6c2519bd69fe4a9f4f544f4060edade7879884d65fe0"} build_url:https://queue.taskcluster.net/v1/task/HLzyw1RaSM6d6Oqs3hbE1g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011449 build_url: 'https://queue.taskcluster.net/v1/task/HLzyw1RaSM6d6Oqs3hbE1g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2e33eed91e0745541ba042fa4a1f930563127d322503748aab31c8d7601d7225b580ac34367750458cd893ec8bc023650b62fdfd43eeea93a68dc7949c6b784b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/020823711c4f2176d953f61e9057d35a60a936e006d0a571fdfbcf94a5206b28ff60625591e95083418054bc9394fae92fa0b18ddf2410dd06663ca5a017040b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e9ae101429496c1acd736dc2d34e0d9659b4a6883bba44242f41fbaf2d994185d5ba1f5cf82350d60554984ce478e1807b63a7f70eb248e36d9dd572c0235d91", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e8e27f94a4483122cd73dd19e8765f96b7e3764573bda63c94123ff7a94ac97f2693299f203ddfba39da6c2519bd69fe4a9f4f544f4060edade7879884d65fe0"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-23 18:30:36.815445) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 18:30:36.815850) ========= 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.ATjBhOMtEP/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.cL0MlXKeUf/Listeners TMPDIR=/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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.005265 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 18:30:36.864088) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-23 18:30:36.866438) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-23 18:30:36.866799) ========= ========= Total master_lag: 0.92 =========