builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0101 starttime: 1486375191.73 results: success (0) buildid: 20170206004003 builduid: 88237725478d492189fc0c031a7cb528 revision: c3d208c04d8b68ed20a0b62c2f9a5bcc83aa9349 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-06 01:59:51.730932) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-06 01:59:51.731379) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-06 01:59:51.731656) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-06 01:59:51.760591) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 01:59:51.760960) ========= 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.UJxtuTxpOK/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.2OKelfAuNh/Listeners TMPDIR=/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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-06 01:59:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.3M=0.001s 2017-02-06 01:59:51 (14.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.139229 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 01:59:51.924026) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 01:59:51.924354) ========= 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.UJxtuTxpOK/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.2OKelfAuNh/Listeners TMPDIR=/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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.026339 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 01:59:51.974913) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-06 01:59:51.977290) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c3d208c04d8b68ed20a0b62c2f9a5bcc83aa9349 --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 c3d208c04d8b68ed20a0b62c2f9a5bcc83aa9349 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.UJxtuTxpOK/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.2OKelfAuNh/Listeners TMPDIR=/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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-06 01:59:52,090 truncating revision to first 12 chars 2017-02-06 01:59:52,090 Setting DEBUG logging. 2017-02-06 01:59:52,090 attempt 1/10 2017-02-06 01:59:52,090 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/c3d208c04d8b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-06 01:59:53,782 unpacking tar archive at: mozilla-aurora-c3d208c04d8b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.968489 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-06 01:59:53.968781) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-06 01:59:53.969114) ========= script_repo_revision: c3d208c04d8b68ed20a0b62c2f9a5bcc83aa9349 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-06 01:59:53.972532) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-06 01:59:53.972808) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-06 01:59:53.992244) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-02-06 01:59:53.992620) ========= /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.UJxtuTxpOK/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.2OKelfAuNh/Listeners TMPDIR=/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 01:59:54 INFO - MultiFileLogger online at 20170206 01:59:54 in /builds/slave/test 01:59:54 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 01:59:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:59:54 INFO - {'append_to_log': False, 01:59:54 INFO - 'base_work_dir': '/builds/slave/test', 01:59:54 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 01:59:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:59:54 INFO - 'branch': 'Mozilla-Aurora', 01:59:54 INFO - 'buildbot_json_path': 'buildprops.json', 01:59:54 INFO - 'config_files': ('talos/mac_config.py',), 01:59:54 INFO - 'default_actions': ('clobber', 01:59:54 INFO - 'read-buildbot-config', 01:59:54 INFO - 'download-and-extract', 01:59:54 INFO - 'populate-webroot', 01:59:54 INFO - 'create-virtualenv', 01:59:54 INFO - 'install', 01:59:54 INFO - 'run-tests'), 01:59:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:59:54 INFO - 'download_minidump_stackwalk': True, 01:59:54 INFO - 'download_symbols': 'ondemand', 01:59:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:59:54 INFO - 'tooltool.py': '/tools/tooltool.py', 01:59:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:59:54 INFO - '/tools/misc-python/virtualenv.py')}, 01:59:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:59:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:59:54 INFO - 'installer_path': 'installer.exe', 01:59:54 INFO - 'log_level': 'info', 01:59:54 INFO - 'log_name': 'talos', 01:59:54 INFO - 'log_to_console': True, 01:59:54 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:59:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:59:54 INFO - 'opt_config_files': (), 01:59:54 INFO - 'pip_index': False, 01:59:54 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:59:54 INFO - 'cmd': ('bash', 01:59:54 INFO - '-c', 01:59:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:59:54 INFO - 'enabled': True, 01:59:54 INFO - 'halt_on_failure': False, 01:59:54 INFO - 'name': 'check_screen_resolution'},), 01:59:54 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:59:54 INFO - 'cmd': ('bash', 01:59:54 INFO - '-c', 01:59:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:59:54 INFO - 'enabled': True, 01:59:54 INFO - 'halt_on_failure': False, 01:59:54 INFO - 'name': 'check_screen_resolution'},), 01:59:54 INFO - 'run_cmd_checks_enabled': True, 01:59:54 INFO - 'sps_profile': False, 01:59:54 INFO - 'sps_profile_interval': 0, 01:59:54 INFO - 'suite': 'dromaeojs-e10s', 01:59:54 INFO - 'system_bits': '32', 01:59:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:59:54 INFO - 'title': 't-yosemite-r7-0101', 01:59:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:59:54 INFO - 'use_talos_json': True, 01:59:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:59:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:59:54 INFO - 'work_dir': 'build'} 01:59:54 INFO - [mozharness: 2017-02-06 09:59:54.206963Z] Running clobber step. 01:59:54 INFO - Running pre-action listener: _resource_record_pre_action 01:59:54 INFO - Running main action method: clobber 01:59:54 INFO - rmtree: /builds/slave/test/build 01:59:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:59:56 INFO - Running post-action listener: _resource_record_post_action 01:59:56 INFO - [mozharness: 2017-02-06 09:59:56.642558Z] Finished clobber step (success) 01:59:56 INFO - [mozharness: 2017-02-06 09:59:56.642685Z] Running read-buildbot-config step. 01:59:56 INFO - Running pre-action listener: _resource_record_pre_action 01:59:56 INFO - Running main action method: read_buildbot_config 01:59:56 INFO - Using buildbot properties: 01:59:56 INFO - { 01:59:56 INFO - "project": "", 01:59:56 INFO - "product": "firefox", 01:59:56 INFO - "script_repo_revision": "production", 01:59:56 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 01:59:56 INFO - "repository": "", 01:59:56 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 01:59:56 INFO - "buildid": "20170206004003", 01:59:56 INFO - "stage_platform": "macosx64", 01:59:56 INFO - "basedir": "/builds/slave/test", 01:59:56 INFO - "nightly_build": "True", 01:59:56 INFO - "buildnumber": 54, 01:59:56 INFO - "slavename": "t-yosemite-r7-0101", 01:59:56 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 01:59:56 INFO - "platform": "yosemite_r7", 01:59:56 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 01:59:56 INFO - "branch": "mozilla-aurora", 01:59:56 INFO - "repo_path": "releases/mozilla-aurora", 01:59:56 INFO - "revision": "c3d208c04d8b68ed20a0b62c2f9a5bcc83aa9349", 01:59:56 INFO - "pgo_build": "False", 01:59:56 INFO - "builduid": "88237725478d492189fc0c031a7cb528", 01:59:56 INFO - "slavebuilddir": "test" 01:59:56 INFO - } 01:59:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/fjX77gP1TreQsEMRyxbSMQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 01:59:56 INFO - Running post-action listener: _resource_record_post_action 01:59:56 INFO - [mozharness: 2017-02-06 09:59:56.646081Z] Finished read-buildbot-config step (success) 01:59:56 INFO - [mozharness: 2017-02-06 09:59:56.646213Z] Running download-and-extract step. 01:59:56 INFO - Running pre-action listener: _resource_record_pre_action 01:59:56 INFO - Running main action method: download_and_extract 01:59:56 INFO - mkdir: /builds/slave/test/build/tests 01:59: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')]} 01:59:56 INFO - trying https://queue.taskcluster.net/v1/task/fjX77gP1TreQsEMRyxbSMQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 01:59:56 INFO - Downloading https://queue.taskcluster.net/v1/task/fjX77gP1TreQsEMRyxbSMQ/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 01:59:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fjX77gP1TreQsEMRyxbSMQ/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 01:59:57 INFO - Downloaded 1199 bytes. 01:59:57 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 01:59:57 INFO - Using the following test package requirements: 01:59:57 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 01:59:57 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 01:59:57 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 01:59:57 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 01:59:57 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 01:59:57 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 01:59:57 INFO - u'jsshell-mac.zip'], 01:59:57 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 01:59:57 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 01:59:57 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 01:59:57 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 01:59:57 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 01:59:57 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 01:59:57 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 01:59:57 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 01:59:57 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 01:59:57 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 01:59:57 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 01:59:57 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 01:59:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fjX77gP1TreQsEMRyxbSMQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 01:59:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fjX77gP1TreQsEMRyxbSMQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 01:59:57 INFO - Fetch https://queue.taskcluster.net/v1/task/fjX77gP1TreQsEMRyxbSMQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 01:59:58 INFO - Expected file size: 16356057 01:59:58 INFO - Obtained file size: 16356057 02:00:05 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 02:00:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fjX77gP1TreQsEMRyxbSMQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 02:00:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fjX77gP1TreQsEMRyxbSMQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:00:05 INFO - Fetch https://queue.taskcluster.net/v1/task/fjX77gP1TreQsEMRyxbSMQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 02:00:06 INFO - Expected file size: 16356057 02:00:06 INFO - Obtained file size: 16356057 02:00:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fjX77gP1TreQsEMRyxbSMQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 02:00:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fjX77gP1TreQsEMRyxbSMQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:00:13 INFO - Fetch https://queue.taskcluster.net/v1/task/fjX77gP1TreQsEMRyxbSMQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 02:00:14 INFO - Expected file size: 14403485 02:00:14 INFO - Obtained file size: 14403485 02:00: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')]} 02:00:14 INFO - trying https://queue.taskcluster.net/v1/task/fjX77gP1TreQsEMRyxbSMQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 02:00:14 INFO - Downloading https://queue.taskcluster.net/v1/task/fjX77gP1TreQsEMRyxbSMQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 02:00:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fjX77gP1TreQsEMRyxbSMQ/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 02:00:16 INFO - Downloaded 73962161 bytes. 02:00:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fjX77gP1TreQsEMRyxbSMQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 02:00:16 INFO - mkdir: /builds/slave/test/properties 02:00:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:00:16 INFO - Writing to file /builds/slave/test/properties/build_url 02:00:16 INFO - Contents: 02:00:16 INFO - build_url:https://queue.taskcluster.net/v1/task/fjX77gP1TreQsEMRyxbSMQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 02:00:17 INFO - Running post-action listener: _resource_record_post_action 02:00:17 INFO - Running post-action listener: set_extra_try_arguments 02:00:17 INFO - [mozharness: 2017-02-06 10:00:17.191796Z] Finished download-and-extract step (success) 02:00:17 INFO - [mozharness: 2017-02-06 10:00:17.191940Z] Running populate-webroot step. 02:00:17 INFO - Running pre-action listener: _resource_record_pre_action 02:00:17 INFO - Running main action method: populate_webroot 02:00:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:00:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:00:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:00:17 INFO - '--tppagecycles', 02:00:17 INFO - '7'], 02:00:17 INFO - 'tests': ['tsvgm']}}, 02:00:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:00:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:00:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:00:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:00:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:00:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:00:17 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:00:17 INFO - 'talos_options': ['--disable-e10s'], 02:00:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:00:17 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:00:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:00:17 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:00:17 INFO - 'talos_options': ['--disable-e10s'], 02:00:17 INFO - 'tests': ['damp', 'tps']}, 02:00:17 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:00:17 INFO - 'tests': ['damp', 'tps']}, 02:00:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:00:17 INFO - 'tests': ['dromaeo_dom']}, 02:00:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:00:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:00:17 INFO - 'tests': ['basic_compositor_video']}, 02:00:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:00:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:00:17 INFO - 'tests': ['a11yr', 02:00:17 INFO - 'ts_paint', 02:00:17 INFO - 'tpaint', 02:00:17 INFO - 'sessionrestore', 02:00:17 INFO - 'sessionrestore_no_auto_restore', 02:00:17 INFO - 'tabpaint']}, 02:00:17 INFO - 'other-e10s': {'tests': ['a11yr', 02:00:17 INFO - 'ts_paint', 02:00:17 INFO - 'tpaint', 02:00:17 INFO - 'sessionrestore', 02:00:17 INFO - 'sessionrestore_no_auto_restore', 02:00:17 INFO - 'tabpaint']}, 02:00:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:00:17 INFO - 'ts_paint', 02:00:17 INFO - 'tpaint', 02:00:17 INFO - 'sessionrestore', 02:00:17 INFO - 'sessionrestore_no_auto_restore', 02:00:17 INFO - 'tabpaint']}, 02:00:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:00:17 INFO - 'ts_paint', 02:00:17 INFO - 'tpaint', 02:00:17 INFO - 'sessionrestore', 02:00:17 INFO - 'sessionrestore_no_auto_restore', 02:00:17 INFO - 'tabpaint']}, 02:00:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:00:17 INFO - 'tests': ['a11yr', 02:00:17 INFO - 'ts_paint', 02:00:17 INFO - 'tpaint', 02:00:17 INFO - 'sessionrestore', 02:00:17 INFO - 'sessionrestore_no_auto_restore', 02:00:17 INFO - 'tabpaint']}, 02:00:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:00:17 INFO - 'tests': ['a11yr', 02:00:17 INFO - 'ts_paint', 02:00:17 INFO - 'tpaint', 02:00:17 INFO - 'sessionrestore', 02:00:17 INFO - 'sessionrestore_no_auto_restore', 02:00:17 INFO - 'tabpaint']}, 02:00:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:00:17 INFO - 'tests': ['tsvgx', 02:00:17 INFO - 'tsvgr_opacity', 02:00:17 INFO - 'tart', 02:00:17 INFO - 'tscrollx', 02:00:17 INFO - 'cart', 02:00:17 INFO - 'tsvg_static']}, 02:00:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:00:17 INFO - 'tsvgr_opacity', 02:00:17 INFO - 'tart', 02:00:17 INFO - 'tscrollx', 02:00:17 INFO - 'cart', 02:00:17 INFO - 'tsvg_static']}, 02:00:17 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:00:17 INFO - 'talos_options': ['--disable-e10s'], 02:00:17 INFO - 'tests': ['tp5o']}, 02:00:17 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:00:17 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:00:17 INFO - 'talos_options': ['--disable-e10s', 02:00:17 INFO - '--xperf_path', 02:00:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:00:17 INFO - 'tests': ['tp5n']}, 02:00:17 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:00:17 INFO - 'talos_options': ['--xperf_path', 02:00:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:00:17 INFO - 'tests': ['tp5n']}}, 02:00:17 INFO - 'talos.zip': {'path': '', 02:00:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:00:17 INFO - Running post-action listener: _resource_record_post_action 02:00:17 INFO - [mozharness: 2017-02-06 10:00:17.210514Z] Finished populate-webroot step (success) 02:00:17 INFO - [mozharness: 2017-02-06 10:00:17.210606Z] Running create-virtualenv step. 02:00:17 INFO - Running pre-action listener: _resource_record_pre_action 02:00:17 INFO - Running main action method: create_virtualenv 02:00:17 INFO - Creating virtualenv /builds/slave/test/build/venv 02:00:17 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:00:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:00:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:00:17 INFO - Using real prefix '/tools/python27' 02:00:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:00:18 INFO - Installing distribute.............................................................................................................................................................................................done. 02:00:20 INFO - Installing pip.................done. 02:00:20 INFO - Return code: 0 02:00:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:00:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:00:21 INFO - Reading from file tmpfile_stdout 02:00:21 INFO - Output received: 02:00:21 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 02:00:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:00:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:00:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:00:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105050b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105053768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8818d85d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e2ed30>, '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 0x104d55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104e23be8>, '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.UJxtuTxpOK/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.2OKelfAuNh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:00:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:00:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:00:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UJxtuTxpOK/Render', 02:00:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:00:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:00:21 INFO - 'HOME': '/Users/cltbld', 02:00:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:00:21 INFO - 'LOGNAME': 'cltbld', 02:00:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:21 INFO - 'MOZ_NO_REMOTE': '1', 02:00:21 INFO - 'NO_EM_RESTART': '1', 02:00:21 INFO - 'PAGER': '/bin/cat', 02:00:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:00:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:00:21 INFO - 'PWD': '/builds/slave/test', 02:00:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:00:21 INFO - 'SHELL': '/bin/bash', 02:00:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2OKelfAuNh/Listeners', 02:00:21 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 02:00:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:00:21 INFO - 'USER': 'cltbld', 02:00:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:00:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:00:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:21 INFO - 'XPC_FLAGS': '0x0', 02:00:21 INFO - 'XPC_SERVICE_NAME': '0', 02:00:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:00:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:21 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:00:21 INFO - Cleaning up... 02:00:21 INFO - Return code: 0 02:00:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:00:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:00:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:00:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105050b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105053768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8818d85d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e2ed30>, '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 0x104d55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104e23be8>, '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.UJxtuTxpOK/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.2OKelfAuNh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:00:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:00:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:00:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UJxtuTxpOK/Render', 02:00:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:00:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:00:21 INFO - 'HOME': '/Users/cltbld', 02:00:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:00:21 INFO - 'LOGNAME': 'cltbld', 02:00:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:21 INFO - 'MOZ_NO_REMOTE': '1', 02:00:21 INFO - 'NO_EM_RESTART': '1', 02:00:21 INFO - 'PAGER': '/bin/cat', 02:00:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:00:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:00:21 INFO - 'PWD': '/builds/slave/test', 02:00:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:00:21 INFO - 'SHELL': '/bin/bash', 02:00:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2OKelfAuNh/Listeners', 02:00:21 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 02:00:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:00:21 INFO - 'USER': 'cltbld', 02:00:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:00:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:00:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:21 INFO - 'XPC_FLAGS': '0x0', 02:00:21 INFO - 'XPC_SERVICE_NAME': '0', 02:00:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:00:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:21 INFO - Downloading/unpacking psutil>=3.1.1 02:00:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:00:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:00:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:00:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:00:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:00:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:00:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:00:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:00:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:00:25 INFO - Installing collected packages: psutil 02:00:25 INFO - Running setup.py install for psutil 02:00:25 INFO - building 'psutil._psutil_osx' extension 02:00:25 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 02:00:25 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 02:00:25 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 02:00:26 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 02:00:26 INFO - building 'psutil._psutil_posix' extension 02:00:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 02:00:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:00:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:00:26 INFO - ^ 02:00:26 INFO - 1 warning generated. 02:00:26 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 02:00:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:00:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:00:26 INFO - Successfully installed psutil 02:00:26 INFO - Cleaning up... 02:00:26 INFO - Return code: 0 02:00:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:00:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:00:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:00:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105050b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105053768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8818d85d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e2ed30>, '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 0x104d55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104e23be8>, '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.UJxtuTxpOK/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.2OKelfAuNh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:00:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:00:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:00:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UJxtuTxpOK/Render', 02:00:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:00:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:00:26 INFO - 'HOME': '/Users/cltbld', 02:00:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:00:26 INFO - 'LOGNAME': 'cltbld', 02:00:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:26 INFO - 'MOZ_NO_REMOTE': '1', 02:00:26 INFO - 'NO_EM_RESTART': '1', 02:00:26 INFO - 'PAGER': '/bin/cat', 02:00:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:00:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:00:26 INFO - 'PWD': '/builds/slave/test', 02:00:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:00:26 INFO - 'SHELL': '/bin/bash', 02:00:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2OKelfAuNh/Listeners', 02:00:26 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 02:00:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:00:26 INFO - 'USER': 'cltbld', 02:00:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:00:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:00:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:26 INFO - 'XPC_FLAGS': '0x0', 02:00:26 INFO - 'XPC_SERVICE_NAME': '0', 02:00:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:00:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:00: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 02:00: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 02:00: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 02:00: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 02:00: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 02:00: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 02:00:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:00:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:00:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:00:29 INFO - Installing collected packages: mozsystemmonitor 02:00:29 INFO - Running setup.py install for mozsystemmonitor 02:00:29 INFO - Successfully installed mozsystemmonitor 02:00:29 INFO - Cleaning up... 02:00:29 INFO - Return code: 0 02:00:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:00:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:00:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:00:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105050b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105053768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8818d85d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e2ed30>, '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 0x104d55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104e23be8>, '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.UJxtuTxpOK/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.2OKelfAuNh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:00:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:00:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:00:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UJxtuTxpOK/Render', 02:00:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:00:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:00:29 INFO - 'HOME': '/Users/cltbld', 02:00:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:00:29 INFO - 'LOGNAME': 'cltbld', 02:00:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:29 INFO - 'MOZ_NO_REMOTE': '1', 02:00:29 INFO - 'NO_EM_RESTART': '1', 02:00:29 INFO - 'PAGER': '/bin/cat', 02:00:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:00:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:00:29 INFO - 'PWD': '/builds/slave/test', 02:00:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:00:29 INFO - 'SHELL': '/bin/bash', 02:00:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2OKelfAuNh/Listeners', 02:00:29 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 02:00:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:00:29 INFO - 'USER': 'cltbld', 02:00:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:00:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:00:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:29 INFO - 'XPC_FLAGS': '0x0', 02:00:29 INFO - 'XPC_SERVICE_NAME': '0', 02:00:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:00:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:29 INFO - Downloading/unpacking jsonschema==2.5.1 02:00:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:00:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:00:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:00:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:00:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:00:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:00:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:00:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:00:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:00:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:00:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:00:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:00:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:00:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:00:33 INFO - Downloading functools32-3.2.3-2.tar.gz 02:00:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:00:33 INFO - warning: no files found matching '*.txt' 02:00:33 INFO - no previously-included directories found matching 'build' 02:00:33 INFO - no previously-included directories found matching 'dist' 02:00:33 INFO - no previously-included directories found matching '.git*' 02:00:33 INFO - Installing collected packages: jsonschema, functools32 02:00:33 INFO - Running setup.py install for functools32 02:00:33 INFO - warning: no files found matching '*.txt' 02:00:33 INFO - no previously-included directories found matching 'build' 02:00:33 INFO - no previously-included directories found matching 'dist' 02:00:33 INFO - no previously-included directories found matching '.git*' 02:00:33 INFO - Successfully installed jsonschema functools32 02:00:33 INFO - Cleaning up... 02:00:33 INFO - Return code: 0 02:00:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:00:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:00:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:00:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105050b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105053768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8818d85d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e2ed30>, '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 0x104d55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104e23be8>, '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.UJxtuTxpOK/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.2OKelfAuNh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:00:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:00:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:00:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UJxtuTxpOK/Render', 02:00:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:00:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:00:33 INFO - 'HOME': '/Users/cltbld', 02:00:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:00:33 INFO - 'LOGNAME': 'cltbld', 02:00:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:33 INFO - 'MOZ_NO_REMOTE': '1', 02:00:33 INFO - 'NO_EM_RESTART': '1', 02:00:33 INFO - 'PAGER': '/bin/cat', 02:00:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:00:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:00:33 INFO - 'PWD': '/builds/slave/test', 02:00:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:00:33 INFO - 'SHELL': '/bin/bash', 02:00:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2OKelfAuNh/Listeners', 02:00:33 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 02:00:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:00:33 INFO - 'USER': 'cltbld', 02:00:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:00:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:00:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:33 INFO - 'XPC_FLAGS': '0x0', 02:00:33 INFO - 'XPC_SERVICE_NAME': '0', 02:00:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:00:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:00:33 INFO - Cleaning up... 02:00:33 INFO - Return code: 0 02:00:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:00:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:00:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:00:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105050b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105053768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8818d85d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e2ed30>, '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 0x104d55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104e23be8>, '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.UJxtuTxpOK/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.2OKelfAuNh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:00:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:00:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:00:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UJxtuTxpOK/Render', 02:00:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:00:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:00:33 INFO - 'HOME': '/Users/cltbld', 02:00:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:00:33 INFO - 'LOGNAME': 'cltbld', 02:00:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:33 INFO - 'MOZ_NO_REMOTE': '1', 02:00:33 INFO - 'NO_EM_RESTART': '1', 02:00:33 INFO - 'PAGER': '/bin/cat', 02:00:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:00:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:00:33 INFO - 'PWD': '/builds/slave/test', 02:00:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:00:33 INFO - 'SHELL': '/bin/bash', 02:00:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2OKelfAuNh/Listeners', 02:00:33 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 02:00:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:00:33 INFO - 'USER': 'cltbld', 02:00:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:00:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:00:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:33 INFO - 'XPC_FLAGS': '0x0', 02:00:33 INFO - 'XPC_SERVICE_NAME': '0', 02:00:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:00:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:33 INFO - Downloading/unpacking blobuploader==1.2.4 02:00:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:00:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:00:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:00:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:00:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:00:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:00:36 INFO - Downloading blobuploader-1.2.4.tar.gz 02:00:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:00:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:00:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:00:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:00:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:00:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:00:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:00:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:00:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:00:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:00:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:00:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:00:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:00:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:00:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:00:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:00:37 INFO - Downloading docopt-0.6.1.tar.gz 02:00:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:00:38 INFO - Installing collected packages: blobuploader, requests, docopt 02:00:38 INFO - Running setup.py install for blobuploader 02:00:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:00:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:00:38 INFO - Running setup.py install for requests 02:00:38 INFO - Running setup.py install for docopt 02:00:38 INFO - Successfully installed blobuploader requests docopt 02:00:38 INFO - Cleaning up... 02:00:38 INFO - Return code: 0 02:00:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:00: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')]} 02:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:00:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:39 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 0x105050b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105053768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8818d85d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e2ed30>, '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 0x104d55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104e23be8>, '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.UJxtuTxpOK/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.2OKelfAuNh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:00:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:00:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:00:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UJxtuTxpOK/Render', 02:00:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:00:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:00:39 INFO - 'HOME': '/Users/cltbld', 02:00:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:00:39 INFO - 'LOGNAME': 'cltbld', 02:00:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:39 INFO - 'MOZ_NO_REMOTE': '1', 02:00:39 INFO - 'NO_EM_RESTART': '1', 02:00:39 INFO - 'PAGER': '/bin/cat', 02:00:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:00:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:00:39 INFO - 'PWD': '/builds/slave/test', 02:00:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:00:39 INFO - 'SHELL': '/bin/bash', 02:00:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2OKelfAuNh/Listeners', 02:00:39 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 02:00:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:00:39 INFO - 'USER': 'cltbld', 02:00:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:00:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:00:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:39 INFO - 'XPC_FLAGS': '0x0', 02:00:39 INFO - 'XPC_SERVICE_NAME': '0', 02:00:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:00:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:00:40 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-t0cgu0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:00:40 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-VBmXMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:00:40 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-IXz1gP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:00:40 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-Q16cI_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:00:40 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-BGQF1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:00:40 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-PmBgrP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:00:40 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-BJHOeb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:00:40 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-vaqC5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:00:40 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-lDpnS2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:00:40 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-iv7XMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:00:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:00:41 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-AebjI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:00:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:00:41 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-WosTNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:00:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:00:41 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-gJdk1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:00:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:00:41 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-fKdUjN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:00:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:00:41 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-KOoktv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:00:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:00:41 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-b7S1uM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:00:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:00:41 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-egriTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:00:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:00:41 INFO - Running setup.py install for manifestparser 02:00:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:00:41 INFO - Running setup.py install for mozcrash 02:00:42 INFO - Running setup.py install for mozdebug 02:00:42 INFO - Running setup.py install for mozdevice 02:00:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:00:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:00:42 INFO - Running setup.py install for mozfile 02:00:42 INFO - Running setup.py install for mozhttpd 02:00:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:00:42 INFO - Running setup.py install for mozinfo 02:00:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:00:42 INFO - Running setup.py install for mozInstall 02:00:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:00:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:00:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:00:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:00:42 INFO - Running setup.py install for mozleak 02:00:43 INFO - Running setup.py install for mozlog 02:00:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:00:43 INFO - Running setup.py install for moznetwork 02:00:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:00:43 INFO - Running setup.py install for mozprocess 02:00:43 INFO - Running setup.py install for mozprofile 02:00:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:00:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:00:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:00:43 INFO - Running setup.py install for mozrunner 02:00:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:00:43 INFO - Running setup.py install for mozscreenshot 02:00:44 INFO - Running setup.py install for moztest 02:00:44 INFO - Running setup.py install for mozversion 02:00:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:00:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:00:44 INFO - Cleaning up... 02:00:44 INFO - Return code: 0 02:00:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:00:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:00:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:00:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:44 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 0x105050b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105053768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8818d85d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e2ed30>, '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 0x104d55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104e23be8>, '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.UJxtuTxpOK/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.2OKelfAuNh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:00:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:00:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:00:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UJxtuTxpOK/Render', 02:00:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:00:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:00:44 INFO - 'HOME': '/Users/cltbld', 02:00:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:00:44 INFO - 'LOGNAME': 'cltbld', 02:00:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:44 INFO - 'MOZ_NO_REMOTE': '1', 02:00:44 INFO - 'NO_EM_RESTART': '1', 02:00:44 INFO - 'PAGER': '/bin/cat', 02:00:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:00:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:00:44 INFO - 'PWD': '/builds/slave/test', 02:00:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:00:44 INFO - 'SHELL': '/bin/bash', 02:00:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2OKelfAuNh/Listeners', 02:00:44 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 02:00:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:00:44 INFO - 'USER': 'cltbld', 02:00:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:00:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:00:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:44 INFO - 'XPC_FLAGS': '0x0', 02:00:44 INFO - 'XPC_SERVICE_NAME': '0', 02:00:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:00:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:00:45 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-aJL4ss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:00:45 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:00:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:00:45 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-EDyCsN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:00:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:00:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:00:45 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-esMlUV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:00:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:00:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:00:45 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-ZHhcnz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:00:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:00:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:00:45 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-dTwPom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:00:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:00:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:00:45 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-MJ57AS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:00:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:00:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:00:45 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-IFPUmR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:00:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:00:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:00:45 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-eRfVwB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:00:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:00:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:00:45 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-VW_MnN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:00:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:00:46 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-OwQb5D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:00:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:00:46 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-ImNCII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:00:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:00:46 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-qVEtPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:00:46 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)) 02:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:00:46 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-xpmkRj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:00:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:00:46 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-Y2ja8m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:00:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:00:46 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-c5DJba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:00:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:00:46 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-eLma70-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:00:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:00:46 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-0JCs_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:00:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:00:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:00:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:00:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:00:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:00:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:00:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:00:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:00:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:00:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:00:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:00:49 INFO - Downloading blessings-1.6.tar.gz 02:00:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:00:50 INFO - Installing collected packages: blessings 02:00:50 INFO - Running setup.py install for blessings 02:00:50 INFO - Successfully installed blessings 02:00:50 INFO - Cleaning up... 02:00:50 INFO - Return code: 0 02:00:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:00:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:00:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:00:50 INFO - Reading from file tmpfile_stdout 02:00:50 INFO - Current package versions: 02:00:50 INFO - blessings == 1.6 02:00:50 INFO - blobuploader == 1.2.4 02:00:50 INFO - docopt == 0.6.1 02:00:50 INFO - functools32 == 3.2.3-2 02:00:50 INFO - jsonschema == 2.5.1 02:00:50 INFO - manifestparser == 1.1 02:00:50 INFO - mozInstall == 1.12 02:00:50 INFO - mozcrash == 1.0 02:00:50 INFO - mozdebug == 0.1 02:00:50 INFO - mozdevice == 0.49 02:00:50 INFO - mozfile == 1.2 02:00:50 INFO - mozhttpd == 0.7 02:00:50 INFO - mozinfo == 0.9 02:00:50 INFO - mozleak == 0.1 02:00:50 INFO - mozlog == 3.4 02:00:50 INFO - moznetwork == 0.27 02:00:50 INFO - mozprocess == 0.24 02:00:50 INFO - mozprofile == 0.28 02:00:50 INFO - mozrunner == 6.13 02:00:50 INFO - mozscreenshot == 0.1 02:00:50 INFO - mozsystemmonitor == 0.3 02:00:50 INFO - moztest == 0.8 02:00:50 INFO - mozversion == 1.4 02:00:50 INFO - psutil == 3.1.1 02:00:50 INFO - requests == 1.2.3 02:00:50 INFO - wsgiref == 0.1.2 02:00:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:00:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:00:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:00:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:50 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 0x105050b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105053768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8818d85d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e2ed30>, '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 0x104d55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104e23be8>, '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.UJxtuTxpOK/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.2OKelfAuNh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:00:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:00:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:00:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UJxtuTxpOK/Render', 02:00:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:00:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:00:50 INFO - 'HOME': '/Users/cltbld', 02:00:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:00:50 INFO - 'LOGNAME': 'cltbld', 02:00:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:50 INFO - 'MOZ_NO_REMOTE': '1', 02:00:50 INFO - 'NO_EM_RESTART': '1', 02:00:50 INFO - 'PAGER': '/bin/cat', 02:00:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:00:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:00:50 INFO - 'PWD': '/builds/slave/test', 02:00:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:00:50 INFO - 'SHELL': '/bin/bash', 02:00:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2OKelfAuNh/Listeners', 02:00:50 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 02:00:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:00:50 INFO - 'USER': 'cltbld', 02:00:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:00:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:00:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:50 INFO - 'XPC_FLAGS': '0x0', 02:00:50 INFO - 'XPC_SERVICE_NAME': '0', 02:00:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:00:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:00:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:00:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:00:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:00:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:00:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:00:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:00:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:00:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:00:50 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:00:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:00:50 INFO - Cleaning up... 02:00:50 INFO - Return code: 0 02:00:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:00:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:00:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:00:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105050b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105053768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8818d85d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e2ed30>, '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 0x104d55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104e23be8>, '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.UJxtuTxpOK/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.2OKelfAuNh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:00:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:00:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:00:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UJxtuTxpOK/Render', 02:00:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:00:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:00:50 INFO - 'HOME': '/Users/cltbld', 02:00:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:00:50 INFO - 'LOGNAME': 'cltbld', 02:00:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:50 INFO - 'MOZ_NO_REMOTE': '1', 02:00:50 INFO - 'NO_EM_RESTART': '1', 02:00:50 INFO - 'PAGER': '/bin/cat', 02:00:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:00:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:00:50 INFO - 'PWD': '/builds/slave/test', 02:00:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:00:50 INFO - 'SHELL': '/bin/bash', 02:00:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2OKelfAuNh/Listeners', 02:00:50 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 02:00:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:00:50 INFO - 'USER': 'cltbld', 02:00:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:00:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:00:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:50 INFO - 'XPC_FLAGS': '0x0', 02:00:50 INFO - 'XPC_SERVICE_NAME': '0', 02:00:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:00:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:00:51 INFO - Cleaning up... 02:00:51 INFO - Return code: 0 02:00:51 INFO - Running post-action listener: _resource_record_post_action 02:00:51 INFO - Running post-action listener: _start_resource_monitoring 02:00:51 INFO - Starting resource monitoring. 02:00:51 INFO - [mozharness: 2017-02-06 10:00:51.166478Z] Finished create-virtualenv step (success) 02:00:51 INFO - [mozharness: 2017-02-06 10:00:51.167250Z] Running install step. 02:00:51 INFO - Running pre-action listener: _resource_record_pre_action 02:00:51 INFO - Running main action method: install 02:00:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:00:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:00:51 INFO - Reading from file tmpfile_stdout 02:00:51 INFO - Detecting whether we're running mozinstall >=1.0... 02:00:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:00:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:00:51 INFO - Reading from file tmpfile_stdout 02:00:51 INFO - Output received: 02:00:51 INFO - Usage: mozinstall [options] installer 02:00:51 INFO - Options: 02:00:51 INFO - -h, --help show this help message and exit 02:00:51 INFO - -d DEST, --destination=DEST 02:00:51 INFO - Directory to install application into. [default: 02:00:51 INFO - "/builds/slave/test"] 02:00:51 INFO - --app=APP Application being installed. [default: firefox] 02:00:51 INFO - mkdir: /builds/slave/test/build/application 02:00:51 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'] 02:00:51 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 02:01:11 INFO - Reading from file tmpfile_stdout 02:01:11 INFO - Output received: 02:01:11 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:01:11 INFO - Running post-action listener: _resource_record_post_action 02:01:11 INFO - [mozharness: 2017-02-06 10:01:11.604922Z] Finished install step (success) 02:01:11 INFO - [mozharness: 2017-02-06 10:01:11.605108Z] Running run-tests step. 02:01:11 INFO - Running pre-action listener: _resource_record_pre_action 02:01:11 INFO - Running main action method: run_tests 02:01:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:01:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:01:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:01:11 INFO - 2017-02-06 02:01:11.619 screenresolution[1622:7305] starting screenresolution argv=screenresolution get 02:01:11 INFO - 2017-02-06 02:01:11.622 screenresolution[1622:7305] Display 0: 1600x1200x32@60 02:01:11 INFO - 2017-02-06 02:01:11.628 screenresolution[1623:7307] starting screenresolution argv=screenresolution list 02:01:11 INFO - Available Modes on Display 0 02:01:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:01:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:01:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:01:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:01:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:01:11 INFO - Intel Iris: 02:01:11 INFO - Chipset Model: Intel Iris 02:01:11 INFO - Type: GPU 02:01:11 INFO - Bus: Built-In 02:01:11 INFO - VRAM (Dynamic, Max): 1536 MB 02:01:11 INFO - Vendor: Intel (0x8086) 02:01:11 INFO - Device ID: 0x0a2e 02:01:11 INFO - Revision ID: 0x0009 02:01:11 INFO - Displays: 02:01:11 INFO - Display: 02:01:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:01:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:01:11 INFO - Display Serial Number: 1600x1200 60 02:01:11 INFO - Main Display: Yes 02:01:11 INFO - Mirror: Off 02:01:11 INFO - Online: Yes 02:01:11 INFO - Rotation: Supported 02:01:11 INFO - Return code: 0 02:01:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:01:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:01:11 INFO - Python 2.7.3 02:01:11 INFO - Return code: 0 02:01:11 INFO - grabbing minidump binary from tooltool 02:01:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:01:11 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 0x104e2ed30>, '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 0x104d55db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104e23be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:01:11 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:01:11 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 02:01:11 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:01:11 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:01:11 INFO - Return code: 0 02:01:11 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:01:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:01:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:01:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:01:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:01:11 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/fjX77gP1TreQsEMRyxbSMQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0101', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 02:01:11 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/fjX77gP1TreQsEMRyxbSMQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0101 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 02:01:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UJxtuTxpOK/Render', 02:01:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:01:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:01:11 INFO - 'HOME': '/Users/cltbld', 02:01:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:01:11 INFO - 'LOGNAME': 'cltbld', 02:01:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:01:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:01:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:11 INFO - 'MOZ_NO_REMOTE': '1', 02:01:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:01:11 INFO - 'NO_EM_RESTART': '1', 02:01:11 INFO - 'PAGER': '/bin/cat', 02:01:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:01:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:11 INFO - 'PWD': '/builds/slave/test', 02:01:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:01:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:01:11 INFO - 'SHELL': '/bin/bash', 02:01:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2OKelfAuNh/Listeners', 02:01:11 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 02:01:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:01:11 INFO - 'USER': 'cltbld', 02:01:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:01:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:01:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:11 INFO - 'XPC_FLAGS': '0x0', 02:01:11 INFO - 'XPC_SERVICE_NAME': '0', 02:01:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:01:11 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/fjX77gP1TreQsEMRyxbSMQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0101', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 02:01:12 INFO - mozversion application_buildid: 20170206004003 02:01:12 INFO - mozversion application_changeset: c3d208c04d8b68ed20a0b62c2f9a5bcc83aa9349 02:01:12 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:01:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:01:12 INFO - mozversion application_name: Firefox 02:01:12 INFO - mozversion application_remotingname: firefox-dev 02:01:12 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:01:12 INFO - mozversion application_vendor: Mozilla 02:01:12 INFO - mozversion application_version: 53.0a2 02:01:12 INFO - mozversion platform_buildid: 20170206004003 02:01:12 INFO - mozversion platform_changeset: c3d208c04d8b68ed20a0b62c2f9a5bcc83aa9349 02:01:12 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:01:12 INFO - mozversion platform_version: 53.0a2 02:01:12 INFO - using testdate: 1486375272 02:01:12 INFO - actual date: 1486375272 02:01:12 INFO - starting webserver on 'localhost:49236' 02:01:12 INFO - SUITE-START | Running 2 tests 02:01:12 INFO - TEST-START | dromaeo_css 02:01:12 INFO - operating with platform_type : mac_ 02:01:12 INFO - Initialising browser for dromaeo_css test... 02:01:12 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/tmpbYoo7I/profile http://localhost:49236/getInfo.html) 02:01:15 INFO - PROCESS | 1633 | 2017-02-06 02:01:15.479 plugin-container[1636:7485] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4e47, name = 'com.apple.tsm.portname' 02:01:15 INFO - PROCESS | 1633 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:01:15 INFO - PROCESS | 1633 | 2017-02-06 02:01:15.480 plugin-container[1636:7485] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x970b, name = 'com.apple.CFPasteboardClient' 02:01:15 INFO - PROCESS | 1633 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:01:15 INFO - PROCESS | 1633 | 2017-02-06 02:01:15.480 plugin-container[1636:7485] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:01:15 INFO - PROCESS | 1633 | __metrics Screen width/height:1600/1200 02:01:15 INFO - PROCESS | 1633 | colorDepth:24 02:01:15 INFO - PROCESS | 1633 | Browser inner width/height: 1024/689 02:01:15 INFO - PROCESS | 1633 | __metrics 02:01:15 ERROR - PROCESS | 1633 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 02:01:15 INFO - PROCESS | 1633 | 1486375275680 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/Resources/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < forceQuit@jar:file:///var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/tmpbYoo7I/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/tmpbYoo7I/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/tmpbYoo7I/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/tmpbYoo7I/profile/extensions/talos-powers@TalosPowersService.js:55:9 02:01:16 INFO - TEST-INFO | 1633: exit 0 02:01:16 INFO - Browser initialized. 02:01:16 INFO - Running cycle 1/1 for dromaeo_css test... 02:01:16 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/tmpbYoo7I/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:01:18 INFO - PROCESS | 1637 | 2017-02-06 02:01:18.839 plugin-container[1638:7740] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4447, name = 'com.apple.tsm.portname' 02:01:18 INFO - PROCESS | 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:01:18 INFO - PROCESS | 1637 | 2017-02-06 02:01:18.840 plugin-container[1638:7740] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 02:01:18 INFO - PROCESS | 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:01:18 INFO - PROCESS | 1637 | 2017-02-06 02:01:18.840 plugin-container[1638:7740] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:01:28 INFO - PROCESS | 1637 | RSS: Main: 218750976 02:01:28 INFO - PROCESS | 1637 | 02:04:29 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 02:04:31 INFO - PROCESS | 1637 | RSS: Main: 239808512 02:04:31 INFO - PROCESS | 1637 | 02:06:16 INFO - PROCESS | 1637 | ************************* 02:06:16 INFO - PROCESS | 1637 | A coding exception was thrown and uncaught in a Task. 02:06:16 INFO - PROCESS | 1637 | 02:06:16 ERROR - PROCESS | 1637 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:06:16 INFO - PROCESS | 1637 | Full stack: 02:06:16 INFO - PROCESS | 1637 | ************************* 02:07:33 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 02:07:34 INFO - PROCESS | 1637 | RSS: Main: 245927936 02:07:34 INFO - PROCESS | 1637 | 02:10:36 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 02:10:36 INFO - PROCESS | 1637 | RSS: Main: 252469248 02:10:36 INFO - PROCESS | 1637 | 02:13:38 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 02:13:39 INFO - PROCESS | 1637 | RSS: Main: 250433536 02:13:39 INFO - PROCESS | 1637 | 02:16:42 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 02:16:42 INFO - PROCESS | 1637 | RSS: Main: 254369792 02:16:42 INFO - PROCESS | 1637 | 02:19:45 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 02:19:45 INFO - PROCESS | 1637 | RSS: Main: 255537152 02:19:45 INFO - PROCESS | 1637 | 02:19:45 INFO - PROCESS | 1637 | __start_tp_report 02:19:45 INFO - PROCESS | 1637 | _x_x_mozilla_page_load 02:19:45 INFO - PROCESS | 1637 | _x_x_mozilla_page_load_details 02:19:45 INFO - PROCESS | 1637 | |i|pagename|runs| 02:19:45 INFO - PROCESS | 1637 | |0;dojo.html;2794.4969905417015;2946.852657367132;3326.0520751585805;3346.7155291800195;3374.8481318340673;4835.516448355167;5570.415106413824;5650.802221922234;5658.264425624663;5694.6867922264255;5531.612787104904;5556.416576259495;5559.9444005559935;5577.9163312550345;5591.9720401397935;4770.952290477103;5075.416327122382;5113.923291150636;5143.331366922295;5185.870353241162;5120.615953803461;5157.922631160535;5160.535551800337;5184.066867963784;5226.973865130688;5097.413797413308;5149.639525233235;5165.3026841376495;5166;5184.766685499143;5159.045576568328;5187.118189907725;5207.453217412155;5244.318238628954;5273;5122.33409656746;5150.768215430315;5165.896682066337;5166.664166829144;5180.585553155738;5451.073317536028;5588.21764952907;5656.91514627281;5789.652620842763;5835.124731290341;6069.696515174268;6103.572749907508;6103.786367477117;6125.663088530129;6194.287656919467;6228.096925945712;6254.6872656366995;6262.2798378186635;6273.592216505913;6286.748530058838;5717.914231286534;5743.971280143656;5750.856228594235;5757.481826635623;5779.075347944351;6176.320604733476;6194.845128871814;6197.380261973857;6230.7819226327765;6234.501239900797;6081.756729730761;6102.9694851525455;6116.457510225689;6134.447899689049;6140.4473597376455;6178.907316390258;6242.687865606701;6257.155284036688;6257.186565746424;6271.216097987752;6021.42796434338;6074.54440916933;6102.9694851525455;6121.117656725397;6226.657533835682;6211.937880621226;6227;6228.813135605939;6230.127782110508;6244.812655620339;4934.7285899275885;4936.90126197474;4947.060058588857;4953.7523123844385;4960.677555958851;4300.741955482681;4323.935140972888;4327.783610819446;4340.65274778017;4432.180046691373;5698.629589076697;5762.250907382014;5800.071988481907;5821.970890145607;5841.7371218295275;6230.626162430269;6237.033259844731;6240.906386404207;6251.437370636664;6275.246970363585;5648.406917273709;5699.829005129853;5748.281464816898;5788.88422231553;5789.363170051291;5431.429699881455;5435.619506634576;5449.291592093003;5453.809116680976;5469.726513674301;5770.596058276048;6273.215848018997;6279.843003924847;6285.434310911948;6286.057091436138;5011.523905228997;6113.628337950474;6119.816405507842;6144.003198960267;6241.906371404523;5207.817726379559;6201.3178550358525;6231.688415579112;6238.906416403848;6249.343818899132;6011.7595296187665;6075.362086980804;6077.696115194134;6083.939160608337;6120.7551697931585;6029.336772954884;6062.42406971337;6108.847278818065;6120.693965301806;6137.662428566472;5882.382349853204;5959.880802384015;5965.224520812267;5974.581779275582;6001.939980600138;5301.549368303583;5567.747256867173;5864.736086876186;5923.992921203319;5924.674142922181;5628.493435590816;5744.712764361849;5753.482186603226;5817.389174136824;5828.417158284137;4743.573078422821;5320.361556613231;5915.58590898633;6037.9094313584455;6064.878702426015;5085.7711402986215;5954;5954.523638109027;5959.255093113361;5975.014122669711 02:19:45 INFO - PROCESS | 1637 | |1;ext.html;431.3981995116812;479.522874739634;484.94665586785453;530.6948504609848;536.5278554871712;31115.533267001014;41617.167656646925;41739.582604173986;41751.747447576585;41958.58041419585;41603;41925.371119433235;41963.37054944178;41979.790101049526;42007;9154.542272886363;9424.481653509054;9437.15065644092;10836.241463097585;11246.437678116103;10998.450077496133;11086.445677716123;11089.72275693106;11112.833307500394;11142.331460112418;9621.374610650286;11121.888781112206;11126.721831954184;11129.554817807279;11134.33194008358;11015.504302306415;11086.16853735973;11092.889071109266;11111.666650000512;11126.998570128728;10969.780604387948;11034.889651103547;11038.282511636718;11044.558217671283;11095.44522773866;37358.62641373579;37494.43758343627;37671.05822354436;37679.4348084779;37710.62289377126;3929.6463318301203;3946.904150163241;4030.6372426481757;4033.757974521538;4068.328725760246;27709.58435623467;28239.435211295866;28524.286892827844;29296.853515732284;29631.259218519495;3271.4602090655253;3276.7378609711404;3322.8172450515212;3340.8496617652263;3358;481676;486287;488426;490555.99999999645;490732;58176.54558636068;58408.41591584115;58526.70736646375;58532;58667.70666146642;59658.40341596615;59984.700076499335;60155.796884062074;60217.698911506035;60465.395346045974;15853.920730396274;16176.352945882269;16333.509994700178;16351.34594616202;16390.83609163917;9454.716358509255;11700.06399488039;12413.006959443223;12710.42803073864;12744.299063551409;17856.375026873997;18046.63906721858;18069.45791626227;18088.82422642524;18124.640651951155;6936.410405115622;6954.547954382949;8118.878216826753;8234.958825205955;8315.916840831635;882.885224920769;884.4869975414244;894.561664784251;905.7871400220943;928.5218112671979;29462.705372946424;30593.38813223723;30614.54078188829;31242.750289988602;31480.37039259202;954.2461455450256;1012.7417508535424;1044.2637940252255;1095.8411030400548;1226.8345072181285;15495.302711378015;15520.844791552166;15592.610184745472;15695.843041569666;15847.52457426279;584359;593733;598649;598790;600914;57919.71040144772;58383.41616583865;58414.7079264601;58519.70740146357;58672;1425.4512012874911;1450.311102226434;1450.6953539756769;1452.7966084748143;1459.7007613439218;21825.781742182375;28767;29113.27216819512;29808.254793630334;30336.241593960327;50636.98726025532;50693.23960140675;50993.74503127461;51053.23420148775;51145.48854511407;456981.43018570717;462287;462600;464776;467061.32938671537;21549.676754849002;24560.385990350384;25362.619560706236;26226.688665566264;26843.463130737666;41891.58108418999;42942;43208;43740;43753;35454;35540;35569.82215088908;35606.821965890005;35945.82027089952;32244.032679019667;33198;34213.486797698555;34796.956091317305;35333.82333088421;33780.83109584436;34041;34481.48277775886;34947.47578786371;34972;25243.49513009693;31858.20354491156;31943;32014.199645009063;32039.839800800848;19684.409467715992;23933.042678292673;23973.041078357368;24089.75910240945;24222.75777242205 02:19:45 INFO - PROCESS | 1637 | |2;jquery.html;394.9506311711036;395.92477429288414;401.5643027315363;404.71265401564887;420.54581052463345;17263.39578114766;19627.901860490696;20380.38858834237;20915.267965621206;20944.685829712547;20615.69076463854;20847.061882215297;21598.568028639416;21810;22055.22806701766;5737.540996720273;5943.940560594382;5967.671778052206;5977.342492325841;5979.581429299951;5582.944170558303;5668.943310566903;5736.799212027579;5807.448292412214;5859.326177489601;5119.59043276537;5731;5735.111057786029;5741.799037033705;5743;4991.675541089818;5426.131818908955;5726;5752.65484070955;5778.768849246025;5107.7956881724685;5118.872028199325;5128.051310507568;5128.153854613985;5129.281900533928;22395.888020559956;22537.436564085867;25904.481910361876;26047.869760651076;26519.204423867315;2800.7899407544514;2845.573164025392;2854.6859845417193;2874.985625071882;2876.0077773168223;15422.768658470131;15899.841001590068;15983.280752366056;16129.435469758619;16525.173741312887;1535.8387369326283;1832.2945665918585;1838.035031608403;1842.3828017614114;1871.0270659257246;128063;134367.32816335955;137189;138514;138629;11573.247738896946;11716.414179291001;11745.765084698429;11765.05870533381;11957.52169913211;13102.672433189056;13755.79366309506;14716.33776480061;14745.631359216106;14775.778363324558;8449.915500845036;8622.568871556397;8870.86693699595;8882;8996.415233009833;8880.73357799267;8897.822043559223;8921.687740929166;9056.818863622691;9077.954610226907;6097.451229389288;6756.695948682321;6804.285550017177;7210.603416812126;7280.381167600707;1856.8765896632613;1909.7039958806408;1943.805619438045;1950.2978927586057;1958.657234983872;752.1951511882343;844.2444012608681;883.4522595990527;888.3470649072926;895.4492986813063;19432.611347772967;21027.474313142295;21780.23769168103;23228.838558072028;23325.88337058304;855.5636625321131;905.9275257979345;914.2229105260475;915.1854849184232;928.535732133933;9876.35803672759;12136.635900922987;12198.695032624255;12225.633231003085;12265.632031039084;749719;753795;762787;766018;772724;142992;144045;149991;165373;168560;1041.4272150317295;1049.3913530152493;1081.361996422099;1089.8964598363143;1095.950682219302;19893.701594475806;20253;20331.780093194455;20432.080556375295;20500.89749551243;52840.207396888305;60467.39532604794;60880.695596521735;61100.77798444095;62110.40742033467;75630;79084.20915790768;89581.65627515723;96899;97241.51379243059;7576.674082035512;8175.915141638844;8230.382721296046;8359.205875441823;8715.869261960948;11465.541378344773;12031.939840300742;13231.66920826987;13271.601851944457;13462.73074538484;10270.691879243635;11121.27711698737;11215.214934954474;11446.626404831473;11479.655610331703;11248.98759111651;11328.32030078198;11481.885181148416;11529.538818447503;11647;11464.426778660867;11487.081033517466;11583.305001699588;11954.641360759191;12061.216020958609;8262.462939908886;8472.872906906525;8554.828903422022;8657.177568131017;8703.738887833375;9729.70810875675;11089.556417743523;11235.157363197957;11272.830907536558;11422.200445968703 02:19:45 INFO - PROCESS | 1637 | |3;mootools.html;1419.474794326099;1428.9285535723218;1447.0738727214577;1458.7811828225765;1473.2118316700567;7571.432142589314;7794.727184548542;8106.22990815873;8521.318294536437;8548.829023419528;8085.595720213995;8266.669333226664;8378.413511054228;8433.198846109624;8444.40889137759;2327.290176496168;2366.1127077345996;2367.1951536477595;2369.1589485732575;2374.726906405768;2093.4557015176088;2342.2856028911174;2372.3001714494267;2384.8092152627746;2384.821138414617;2017.6166528359638;2289.8511596746243;2364;2368.692070030894;2370.2533701883935;2299.1837897546466;2308.9191878284178;2321.454458202321;2322.84901481404;2324.151684635113;2299.356180269527;2311.202635090891;2351.259353303721;2363.7636236376397;2372.893219805113;8439.873401898976;8516;8517.977842658858;8531.189536993976;8535.701250456266;5134.229865520202;5245.632805703564;5273.446288139767;5281.207818827168;5293.470652934714;3459.290845376692;3503.667151620592;3525.347810655037;3547.1486843157713;3576.4277715565386;1070.0904231403322;1077.5797438998798;1208.0577149823152;1232.5131573028602;1243.4509256025112;10774.515146818412;10851.67444976644;10855.457227138611;10864.456777161111;10871.67384978452;4480.193565158238;4698.8355407560575;4759.571638552547;4798.352222449925;4800.231962885921;8966.327525435618;9023.458592484472;9468.526573671288;9546.18857397115;9561;5213.296205012275;5275.076861549213;5289.576833853283;5290.973545132327;5296.867578310496;4663.603593694574;4790.185668436374;4822.107910036654;4827.710337379768;4836.7339796310835;3918.8628398005935;3927.6857851371824;3969.0672691917375;4007.779572123561;4011.859584914514;1177.8292147638715;1224.4612370556927;1286.6654669785735;1295.1710905020793;1298.805179223124;711.8113699869539;753.7701001194688;755.0788038592908;779.3453499060817;839.2279103225047;5625.54995600351;5675.148727690879;5756.798512052058;5829.912551311733;5966.164736936832;986.3933680786265;1006.8439391894268;1016.3596933931576;1019.3985548526405;1056.630179437191;3878.825452854628;3940.330143875548;3956.9802150989062;3981.462502562175;4051.7568945862754;9344.205742511962;9793.510324483746;9832.115109640166;9835.114839664464;9866.703998880044;9446.102620251066;9748.756281092888;9860.852087218698;9913.702588922344;10010.04904534068;7794.142644309121;7919.881201781978;7966.960165199137;7979.8404031919035;7987.2012798720825;4606.539346065367;5032.672876263031;5749.655020698771;5775.191473193672;5850.297964244318;7502;7954.721584744738;9400.388974716621;9412.247020238228;9441.905580944103;9190.494522801042;9393.154616084585;9442.763930901783;9532.904670953201;9561.043895610383;7230.89153662706;7286.927130728624;7322.853542929218;7396.9260307396235;7447;7854.371650268079;7975.72084977023;7978.680852766057;7995.240452157036;8025.518468891885;6036.590506702652;7188.568685878864;7209.170945341353;7227.8554428912175;7301.4158867289425;5952.434518720715;7054.4003759681;7092.113485814273;7137.321954414322;7203.063601731741;6378.681065946591;6437.25971513282;6510.804675859732;6518.837029074121;6525.3800888915475;5086.237064440364;5107.106256405188;5116.795328186831;5130.846074617767;5143.974280128576;5077.720725360141;5116.8720781979255;5144.871378215425;5177.948220517746;5203.375594928481 02:19:45 INFO - PROCESS | 1637 | |4;prototype.html;326.1959270398467;361.5552869969937;361.7034032093683;372.7781969728012;374.50191245643316;4763.999999999995;4903.730294833783;5023.5981121510285;5387.164989426636;5532.917006244905;5280.5247527722495;5431.185322201672;5442.156465747806;5455.399906010336;5464.644798088121;3511.4908338290934;3856.804390638897;4205.642520385771;4283.550227226143;4315.223259813232;4071.796410179494;4164.521080075785;4216.894577635553;4271.9359209611885;4310.504292006428;3579.3736096183193;4198.181354635847;4203.117345357478;4239.6396306314;4251.404803327521;3616.5479315085613;3877.7673339599432;4190;4211.252330282944;4224.366345048236;3471.6528347165336;3624.981875090634;3750.5499340079364;3769.4534292527705;3781.9810900945595;4999.075171093359;5321.137601839364;5363.034653762321;5387.515123638852;5407.242985981966;4001.5398229203724;4294.312909934395;4759.762011899391;4763.285507173917;4802.231642937113;5157.30376399185;5831.446012628793;5833.737481813286;5854.97072514639;5877.794277200277;3278.5574347287356;3529.8058606776617;3660.158163622355;3694.649008344203;3952.565217826037;5509.449055094498;5624.850083953;5628.04323265046;6084.330723620398;6190.41191086846;3946.210757848442;4008.07814202735;4017.9196416071513;4023.4970628671417;4037.374206997861;3389.57630296213;3784.1674831537016;3986.6611338036014;4077.7145599808323;4086.9182616347507;4023.637872591481;4187.43469631602;4619.653525985565;4704.811807527729;4724.67709041469;5238;5821.459261775822;5828.795992140254;5858.150568167592;5872.706364681749;1125.6679279612533;1140.3578846461069;1242.8751979458605;1310.3251825309974;1316.5254914495636;876.3733930239781;990.9851352229722;1004.5579944824254;1004.6835246897203;1006.8924183398203;4702.155196106375;5160.48395160481;5187.974060129675;5191.8182863599595;5197.272381866466;5185.351831021122;5286.9471305287225;5359.517643412111;5609.4757359188525;5701.828945131652;4701.213538855213;4799;4964.585093248407;5148.275327765241;5180.533751962266;2445.461998360358;2699.4061306512535;2770.141256210581;2924.7806414518573;2956.0688383159236;5160.432352441228;5842.941570584325;5917.792877249276;5929.495992840657;5934.317553481319;5031.647784655039;5410.377806552218;5685.516731077904;5743.684097374601;5850.572012614717;4962.652614317035;5091.625261179535;5391;5825.980453420634;5882.3529411764675;4889.633277504273;5155.226715992631;5562.13308442423;5620.932022915633;5652.576056795839;5195.9740201298755;5404.297441332759;5415.83752487426;5564.443555644403;5631;5434.701091440009;5583.525400340854;5614.354349249726;5904.996150654313;5909.6158749681135;3191;3970.0273433009097;4075.3275709507598;4090.5091389033505;4119.876403707894;5454.945450545444;5961.433663801932;6019.819405417845;6022.668753218615;6048.334683184934;5654.529822246328;5714.457096583982;5814.622049566765;5817.538564554084;5833.387494313206;5799.333076696065;5816.778476519809;5824.825255242349;5848.239728835224;5873.853153671193;4855.562999330077;5516.0071187186695;5557.666540007613;5720.570957178312;5746.626469279484;4884.095202870954;5172.172452407597;5543.334799824047;5553.861458400937;5782.739776710142;4801.759912004316;5653.180288858175;5667.489925906688;5675.7445914933105;5676.375598684224 02:19:45 INFO - PROCESS | 1637 | |5;yui.html;721.6499997501211;730.7252572451158;776.9223077692232;831.4263158420689;855.9771073567086;14682.339294731735;15299.005564638319;15331.616709582266;15370.615734606627;15504.069755814646;12802.975761939046;13784.58646240612;14091.647708807284;14233.78649320261;14257.857421425808;872.5898827551073;896.6906417286059;903.9638414463446;913.2055112052524;914.2868562521244;902.4089221559889;904.1049361132465;906.727981605519;907.9092090790901;907.9909200908005;949;955.1594596754846;957.1720461800562;959.4003747657714;960.6877764726457;948.3882895532342;950.1923365139611;952.4285428742699;952.6903756279203;953.8044700836311;694.5589550635333;711.7615598774416;712.8289210589421;713.6752777486231;714.153727832515;14832.961692681516;15455.613609659737;15538.300776465087;15557.92221038899;15620.531384058497;13617.727645447134;13835.446582136703;14189.07770994882;14196.787048194285;14243.430262789476;11455.770884582345;11660.475278612483;11706.239094458833;11813.527458901634;12336.691582710415;3658.7804731716183;3670.229251857113;3693.4829123922673;3750.906227344311;3823.598522155189;91103;95252;108791.91208087897;113931;115222;10676.733081673021;10960.451977401257;10977;11012.17408694335;11018.834717479243;21955.890220548794;22439.21462748796;22467.32598022062;22479;22491.775082249296;7590.316871481593;7630.313271805453;7866;7913.920860791433;7973.681052757941;3703.6481534254203;4365.694401391936;4390.560943905648;4398.120375924827;4438;3497.45789402643;3595.119195796994;3605.0807044204084;3613.4941108244866;3619.113317237294;634.6477704873839;634.8730253949228;640.4300172846171;641.6631268584031;645.296626676915;685.5543896467336;698.8427603789107;704.3997741165314;709.1348554763284;717.8600172966221;8887.733627924837;9666.671661846352;10475;10523.421211833269;10636.521356538975;568.4161362608792;636.277824669004;643.0482885329739;643.7811144210991;656.167327631987;4419.248727716296;4878.82908102053;4962.106820772224;5033.647644664911;5055.6713813602;101313.98686013193;103121;103360;103374.44938325931;104265.95734042562;65401.34598654048;70470.64764676246;76247.47505049867;76943.46113077707;80196.39607207823;63180.05229921647;69889;70387;72470.27529724741;75112.62443687746;10704.250702451065;11209.607663732057;11242.55029798799;11429.199956003;11442.94278528602;45742.771286143354;46339.536604633526;46832.53167468282;47408.525914740414;48098;56671.716641416526;62089.37910620836;65059;65093.37266568374;67177.66411167913;11712.70718232051;12243.449044793184;13430.731385372434;13582.25297608641;13861.861381386057;14564.49024284145;14736.77894831557;15161;15238.466653667068;15247.3901043957;13589.728205436033;13662;13741.519046833313;13844.10013349129;13907.30463476802;13571.59285221445;13714.86285137136;13934.790978135134;14117.6470588232;14236.715265694422;13826.239556824472;13880.517726728842;13979.860201397856;14030.579082627537;14473.710525789214;11104.222704410613;11157.330560166416;11251.606193783178;11763.117766167401;11825;10987.285826421257;11164.609238676932;11229.49467273991;11322.60370887015;11325.886741132483 02:19:45 INFO - PROCESS | 1637 | __end_tp_report 02:19:45 INFO - PROCESS | 1637 | __start_cc_report 02:19:45 INFO - PROCESS | 1637 | _x_x_mozilla_cycle_collect,381 02:19:45 INFO - PROCESS | 1637 | __end_cc_report 02:19:45 INFO - PROCESS | 1637 | __startTimestamp1486376385732__endTimestamp 02:19:45 INFO - PROCESS | 1637 | 02:19:45 INFO - PROCESS | 1637 | ------- Summary: start ------- 02:19:45 INFO - PROCESS | 1637 | Number of tests: 6 02:19:45 INFO - PROCESS | 1637 | 02:19:45 INFO - PROCESS | 1637 | [#0] dojo.html Cycles:165 Average:5644.98 Median:5800.07 stddev:659.31 (11.4%) stddev-sans-first:622.26 02:19:45 INFO - PROCESS | 1637 | Values: 2794.5 2946.9 3326.1 3346.7 3374.8 4835.5 5570.4 5650.8 5658.3 5694.7 5531.6 5556.4 5559.9 5577.9 5592.0 4771.0 5075.4 5113.9 5143.3 5185.9 5120.6 5157.9 5160.5 5184.1 5227.0 5097.4 5149.6 5165.3 5166.0 5184.8 5159.0 5187.1 5207.5 5244.3 5273.0 5122.3 5150.8 5165.9 5166.7 5180.6 5451.1 5588.2 5656.9 5789.7 5835.1 6069.7 6103.6 6103.8 6125.7 6194.3 6228.1 6254.7 6262.3 6273.6 6286.7 5717.9 5744.0 5750.9 5757.5 5779.1 6176.3 6194.8 6197.4 6230.8 6234.5 6081.8 6103.0 6116.5 6134.4 6140.4 6178.9 6242.7 6257.2 6257.2 6271.2 6021.4 6074.5 6103.0 6121.1 6226.7 6211.9 6227.0 6228.8 6230.1 6244.8 4934.7 4936.9 4947.1 4953.8 4960.7 4300.7 4323.9 4327.8 4340.7 4432.2 5698.6 5762.3 5800.1 5822.0 5841.7 6230.6 6237.0 6240.9 6251.4 6275.2 5648.4 5699.8 5748.3 5788.9 5789.4 5431.4 5435.6 5449.3 5453.8 5469.7 5770.6 6273.2 6279.8 6285.4 6286.1 5011.5 6113.6 6119.8 6144.0 6241.9 5207.8 6201.3 6231.7 6238.9 6249.3 6011.8 6075.4 6077.7 6083.9 6120.8 6029.3 6062.4 6108.8 6120.7 6137.7 5882.4 5959.9 5965.2 5974.6 6001.9 5301.5 5567.7 5864.7 5924.0 5924.7 5628.5 5744.7 5753.5 5817.4 5828.4 4743.6 5320.4 5915.6 6037.9 6064.9 5085.8 5954.0 5954.5 5959.3 5975.0 02:19:45 INFO - PROCESS | 1637 | 02:19:45 INFO - PROCESS | 1637 | [#1] ext.html Cycles:180 Average:65010.54 Median:34639.22 stddev:138191.61 (398.9%) stddev-sans-first:138494.21 02:19:45 INFO - PROCESS | 1637 | Values: 431.4 479.5 484.9 530.7 536.5 31115.5 41617.2 41739.6 41751.7 41958.6 41603.0 41925.4 41963.4 41979.8 42007.0 9154.5 9424.5 9437.2 10836.2 11246.4 10998.5 11086.4 11089.7 11112.8 11142.3 9621.4 11121.9 11126.7 11129.6 11134.3 11015.5 11086.2 11092.9 11111.7 11127.0 10969.8 11034.9 11038.3 11044.6 11095.4 37358.6 37494.4 37671.1 37679.4 37710.6 3929.6 3946.9 4030.6 4033.8 4068.3 27709.6 28239.4 28524.3 29296.9 29631.3 3271.5 3276.7 3322.8 3340.8 3358.0 481676.0 486287.0 488426.0 490556.0 490732.0 58176.5 58408.4 58526.7 58532.0 58667.7 59658.4 59984.7 60155.8 60217.7 60465.4 15853.9 16176.4 16333.5 16351.3 16390.8 9454.7 11700.1 12413.0 12710.4 12744.3 17856.4 18046.6 18069.5 18088.8 18124.6 6936.4 6954.5 8118.9 8235.0 8315.9 882.9 884.5 894.6 905.8 928.5 29462.7 30593.4 30614.5 31242.8 31480.4 954.2 1012.7 1044.3 1095.8 1226.8 15495.3 15520.8 15592.6 15695.8 15847.5 584359.0 593733.0 598649.0 598790.0 600914.0 57919.7 58383.4 58414.7 58519.7 58672.0 1425.5 1450.3 1450.7 1452.8 1459.7 21825.8 28767.0 29113.3 29808.3 30336.2 50637.0 50693.2 50993.7 51053.2 51145.5 456981.4 462287.0 462600.0 464776.0 467061.3 21549.7 24560.4 25362.6 26226.7 26843.5 41891.6 42942.0 43208.0 43740.0 43753.0 35454.0 35540.0 35569.8 35606.8 35945.8 32244.0 33198.0 34213.5 34797.0 35333.8 33780.8 34041.0 34481.5 34947.5 34972.0 25243.5 31858.2 31943.0 32014.2 32039.8 19684.4 23933.0 23973.0 24089.8 24222.8 02:19:45 INFO - PROCESS | 1637 | 02:19:45 INFO - PROCESS | 1637 | [#2] jquery.html Cycles:180 Average:41563.37 Median:25976.18 stddev:126715.86 (487.8%) stddev-sans-first:127033.62 02:19:45 INFO - PROCESS | 1637 | Values: 395.0 395.9 401.6 404.7 420.5 17263.4 19627.9 20380.4 20915.3 20944.7 20615.7 20847.1 21598.6 21810.0 22055.2 5737.5 5943.9 5967.7 5977.3 5979.6 5582.9 5668.9 5736.8 5807.4 5859.3 5119.6 5731.0 5735.1 5741.8 5743.0 4991.7 5426.1 5726.0 5752.7 5778.8 5107.8 5118.9 5128.1 5128.2 5129.3 22395.9 22537.4 25904.5 26047.9 26519.2 2800.8 2845.6 2854.7 2875.0 2876.0 15422.8 15899.8 15983.3 16129.4 16525.2 1535.8 1832.3 1838.0 1842.4 1871.0 128063.0 134367.3 137189.0 138514.0 138629.0 11573.2 11716.4 11745.8 11765.1 11957.5 13102.7 13755.8 14716.3 14745.6 14775.8 8449.9 8622.6 8870.9 8882.0 8996.4 8880.7 8897.8 8921.7 9056.8 9078.0 6097.5 6756.7 6804.3 7210.6 7280.4 1856.9 1909.7 1943.8 1950.3 1958.7 752.2 844.2 883.5 888.3 895.4 19432.6 21027.5 21780.2 23228.8 23325.9 855.6 905.9 914.2 915.2 928.5 9876.4 12136.6 12198.7 12225.6 12265.6 749719.0 753795.0 762787.0 766018.0 772724.0 142992.0 144045.0 149991.0 165373.0 168560.0 1041.4 1049.4 1081.4 1089.9 1096.0 19893.7 20253.0 20331.8 20432.1 20500.9 52840.2 60467.4 60880.7 61100.8 62110.4 75630.0 79084.2 89581.7 96899.0 97241.5 7576.7 8175.9 8230.4 8359.2 8715.9 11465.5 12031.9 13231.7 13271.6 13462.7 10270.7 11121.3 11215.2 11446.6 11479.7 11249.0 11328.3 11481.9 11529.5 11647.0 11464.4 11487.1 11583.3 11954.6 12061.2 8262.5 8472.9 8554.8 8657.2 8703.7 9729.7 11089.6 11235.2 11272.8 11422.2 02:19:45 INFO - PROCESS | 1637 | 02:19:45 INFO - PROCESS | 1637 | [#3] mootools.html Cycles:180 Average:5459.61 Median:5274.26 stddev:2932.56 (55.6%) stddev-sans-first:2925.07 02:19:45 INFO - PROCESS | 1637 | Values: 1419.5 1428.9 1447.1 1458.8 1473.2 7571.4 7794.7 8106.2 8521.3 8548.8 8085.6 8266.7 8378.4 8433.2 8444.4 2327.3 2366.1 2367.2 2369.2 2374.7 2093.5 2342.3 2372.3 2384.8 2384.8 2017.6 2289.9 2364.0 2368.7 2370.3 2299.2 2308.9 2321.5 2322.8 2324.2 2299.4 2311.2 2351.3 2363.8 2372.9 8439.9 8516.0 8518.0 8531.2 8535.7 5134.2 5245.6 5273.4 5281.2 5293.5 3459.3 3503.7 3525.3 3547.1 3576.4 1070.1 1077.6 1208.1 1232.5 1243.5 10774.5 10851.7 10855.5 10864.5 10871.7 4480.2 4698.8 4759.6 4798.4 4800.2 8966.3 9023.5 9468.5 9546.2 9561.0 5213.3 5275.1 5289.6 5291.0 5296.9 4663.6 4790.2 4822.1 4827.7 4836.7 3918.9 3927.7 3969.1 4007.8 4011.9 1177.8 1224.5 1286.7 1295.2 1298.8 711.8 753.8 755.1 779.3 839.2 5625.5 5675.1 5756.8 5829.9 5966.2 986.4 1006.8 1016.4 1019.4 1056.6 3878.8 3940.3 3957.0 3981.5 4051.8 9344.2 9793.5 9832.1 9835.1 9866.7 9446.1 9748.8 9860.9 9913.7 10010.0 7794.1 7919.9 7967.0 7979.8 7987.2 4606.5 5032.7 5749.7 5775.2 5850.3 7502.0 7954.7 9400.4 9412.2 9441.9 9190.5 9393.2 9442.8 9532.9 9561.0 7230.9 7286.9 7322.9 7396.9 7447.0 7854.4 7975.7 7978.7 7995.2 8025.5 6036.6 7188.6 7209.2 7227.9 7301.4 5952.4 7054.4 7092.1 7137.3 7203.1 6378.7 6437.3 6510.8 6518.8 6525.4 5086.2 5107.1 5116.8 5130.8 5144.0 5077.7 5116.9 5144.9 5177.9 5203.4 02:19:45 INFO - PROCESS | 1637 | 02:19:45 INFO - PROCESS | 1637 | [#4] prototype.html Cycles:180 Average:4593.75 Median:5158.87 stddev:1406.06 (27.3%) stddev-sans-first:1373.03 02:19:45 INFO - PROCESS | 1637 | Values: 326.2 361.6 361.7 372.8 374.5 4764.0 4903.7 5023.6 5387.2 5532.9 5280.5 5431.2 5442.2 5455.4 5464.6 3511.5 3856.8 4205.6 4283.6 4315.2 4071.8 4164.5 4216.9 4271.9 4310.5 3579.4 4198.2 4203.1 4239.6 4251.4 3616.5 3877.8 4190.0 4211.3 4224.4 3471.7 3625.0 3750.5 3769.5 3782.0 4999.1 5321.1 5363.0 5387.5 5407.2 4001.5 4294.3 4759.8 4763.3 4802.2 5157.3 5831.4 5833.7 5855.0 5877.8 3278.6 3529.8 3660.2 3694.6 3952.6 5509.4 5624.9 5628.0 6084.3 6190.4 3946.2 4008.1 4017.9 4023.5 4037.4 3389.6 3784.2 3986.7 4077.7 4086.9 4023.6 4187.4 4619.7 4704.8 4724.7 5238.0 5821.5 5828.8 5858.2 5872.7 1125.7 1140.4 1242.9 1310.3 1316.5 876.4 991.0 1004.6 1004.7 1006.9 4702.2 5160.5 5188.0 5191.8 5197.3 5185.4 5286.9 5359.5 5609.5 5701.8 4701.2 4799.0 4964.6 5148.3 5180.5 2445.5 2699.4 2770.1 2924.8 2956.1 5160.4 5842.9 5917.8 5929.5 5934.3 5031.6 5410.4 5685.5 5743.7 5850.6 4962.7 5091.6 5391.0 5826.0 5882.4 4889.6 5155.2 5562.1 5620.9 5652.6 5196.0 5404.3 5415.8 5564.4 5631.0 5434.7 5583.5 5614.4 5905.0 5909.6 3191.0 3970.0 4075.3 4090.5 4119.9 5454.9 5961.4 6019.8 6022.7 6048.3 5654.5 5714.5 5814.6 5817.5 5833.4 5799.3 5816.8 5824.8 5848.2 5873.9 4855.6 5516.0 5557.7 5720.6 5746.6 4884.1 5172.2 5543.3 5553.9 5782.7 4801.8 5653.2 5667.5 5675.7 5676.4 02:19:45 INFO - PROCESS | 1637 | 02:19:45 INFO - PROCESS | 1637 | [#5] yui.html Cycles:180 Average:19739.57 Median:3638.95 stddev:27734.38 (762.2%) stddev-sans-first:27775.42 02:19:45 INFO - PROCESS | 1637 | Values: 721.6 730.7 776.9 831.4 856.0 14682.3 15299.0 15331.6 15370.6 15504.1 12803.0 13784.6 14091.6 14233.8 14257.9 872.6 896.7 904.0 913.2 914.3 902.4 904.1 906.7 907.9 908.0 949.0 955.2 957.2 959.4 960.7 948.4 950.2 952.4 952.7 953.8 694.6 711.8 712.8 713.7 714.2 14833.0 15455.6 15538.3 15557.9 15620.5 13617.7 13835.4 14189.1 14196.8 14243.4 11455.8 11660.5 11706.2 11813.5 12336.7 3658.8 3670.2 3693.5 3750.9 3823.6 91103.0 95252.0 108791.9 113931.0 115222.0 10676.7 10960.5 10977.0 11012.2 11018.8 21955.9 22439.2 22467.3 22479.0 22491.8 7590.3 7630.3 7866.0 7913.9 7973.7 3703.6 4365.7 4390.6 4398.1 4438.0 3497.5 3595.1 3605.1 3613.5 3619.1 634.6 634.9 640.4 641.7 645.3 685.6 698.8 704.4 709.1 717.9 8887.7 9666.7 10475.0 10523.4 10636.5 568.4 636.3 643.0 643.8 656.2 4419.2 4878.8 4962.1 5033.6 5055.7 101314.0 103121.0 103360.0 103374.4 104266.0 65401.3 70470.6 76247.5 76943.5 80196.4 63180.1 69889.0 70387.0 72470.3 75112.6 10704.3 11209.6 11242.6 11429.2 11442.9 45742.8 46339.5 46832.5 47408.5 48098.0 56671.7 62089.4 65059.0 65093.4 67177.7 11712.7 12243.4 13430.7 13582.3 13861.9 14564.5 14736.8 15161.0 15238.5 15247.4 13589.7 13662.0 13741.5 13844.1 13907.3 13571.6 13714.9 13934.8 14117.6 14236.7 13826.2 13880.5 13979.9 14030.6 14473.7 11104.2 11157.3 11251.6 11763.1 11825.0 10987.3 11164.6 11229.5 11322.6 11325.9 02:19:45 INFO - PROCESS | 1637 | -------- Summary: end -------- 02:19:45 INFO - PROCESS | 1637 | 02:19:46 INFO - TEST-INFO | 1637: exit 0 02:19:46 INFO - TEST-OK | dromaeo_css | took 1114132ms 02:19:46 INFO - TEST-START | kraken 02:19:46 INFO - operating with platform_type : mac_ 02:19:46 INFO - Initialising browser for kraken test... 02:19:46 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/tmpwDT2mq/profile http://localhost:49236/getInfo.html) 02:19:49 INFO - PROCESS | 1648 | 2017-02-06 02:19:49.292 plugin-container[1650:10115] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 02:19:49 INFO - PROCESS | 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:19:49 INFO - PROCESS | 1648 | 2017-02-06 02:19:49.292 plugin-container[1650:10115] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 02:19:49 INFO - PROCESS | 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:19:49 INFO - PROCESS | 1648 | 2017-02-06 02:19:49.292 plugin-container[1650:10115] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:19:49 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 02:19:49 INFO - PROCESS | 1648 | colorDepth:24 02:19:49 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 02:19:49 INFO - PROCESS | 1648 | __metrics 02:19:49 ERROR - PROCESS | 1648 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 02:19:49 INFO - PROCESS | 1648 | 1486376389444 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/Resources/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < forceQuit@jar:file:///var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/tmpwDT2mq/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/tmpwDT2mq/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/tmpwDT2mq/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/tmpwDT2mq/profile/extensions/talos-powers@TalosPowersService.js:55:9 02:19:50 INFO - TEST-INFO | 1648: exit 0 02:19:50 INFO - Browser initialized. 02:19:50 INFO - Running cycle 1/1 for kraken test... 02:19:50 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/tmpwDT2mq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:19:52 INFO - PROCESS | 1651 | 2017-02-06 02:19:52.636 plugin-container[1652:10243] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x863f, name = 'com.apple.tsm.portname' 02:19:52 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:19:52 INFO - PROCESS | 1651 | 2017-02-06 02:19:52.637 plugin-container[1652:10243] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c0b, name = 'com.apple.CFPasteboardClient' 02:19:52 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:19:52 INFO - PROCESS | 1651 | 2017-02-06 02:19:52.637 plugin-container[1652:10243] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:20:02 INFO - PROCESS | 1651 | RSS: Main: 219111424 02:20:02 INFO - PROCESS | 1651 | 02:20:05 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 02:20:06 INFO - PROCESS | 1651 | RSS: Main: 233320448 02:20:06 INFO - PROCESS | 1651 | 02:20:08 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 02:20:09 INFO - PROCESS | 1651 | RSS: Main: 241192960 02:20:09 INFO - PROCESS | 1651 | 02:20:12 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 02:20:13 INFO - PROCESS | 1651 | RSS: Main: 244793344 02:20:13 INFO - PROCESS | 1651 | 02:20:15 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 02:20:15 INFO - PROCESS | 1651 | RSS: Main: 246288384 02:20:15 INFO - PROCESS | 1651 | 02:20:17 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:20:18 INFO - PROCESS | 1651 | RSS: Main: 246226944 02:20:18 INFO - PROCESS | 1651 | 02:20:21 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 02:20:21 INFO - PROCESS | 1651 | RSS: Main: 250863616 02:20:21 INFO - PROCESS | 1651 | 02:20:24 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 02:20:25 INFO - PROCESS | 1651 | RSS: Main: 250671104 02:20:25 INFO - PROCESS | 1651 | 02:20:28 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 02:20:28 INFO - PROCESS | 1651 | RSS: Main: 249782272 02:20:28 INFO - PROCESS | 1651 | 02:20:30 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:20:30 INFO - PROCESS | 1651 | RSS: Main: 249147392 02:20:30 INFO - PROCESS | 1651 | 02:20:32 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:20:33 INFO - PROCESS | 1651 | RSS: Main: 249262080 02:20:33 INFO - PROCESS | 1651 | 02:20:35 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:20:36 INFO - PROCESS | 1651 | RSS: Main: 249819136 02:20:36 INFO - PROCESS | 1651 | 02:20:39 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:20:39 INFO - PROCESS | 1651 | RSS: Main: 249339904 02:20:39 INFO - PROCESS | 1651 | 02:20:43 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:20:43 INFO - PROCESS | 1651 | RSS: Main: 249647104 02:20:43 INFO - PROCESS | 1651 | 02:20:45 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 02:20:45 INFO - PROCESS | 1651 | RSS: Main: 251756544 02:20:45 INFO - PROCESS | 1651 | 02:20:45 INFO - PROCESS | 1651 | __start_tp_report 02:20:45 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 02:20:45 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 02:20:45 INFO - PROCESS | 1651 | |i|pagename|runs| 02:20:45 INFO - PROCESS | 1651 | |0;ai-astar;115;122;120;120;122;128;169;168;125;99 02:20:45 INFO - PROCESS | 1651 | |1;audio-beat-detection;142;114;98;168;144;147;135;110;130;117 02:20:45 INFO - PROCESS | 1651 | |2;audio-dft;198;202;197;201;196;193;198;193;192;200 02:20:45 INFO - PROCESS | 1651 | |3;audio-fft;84;58;59;85;60;60;63;61;72;60 02:20:45 INFO - PROCESS | 1651 | |4;audio-oscillator;77;70;83;76;68;70;82;72;70;82 02:20:45 INFO - PROCESS | 1651 | |5;imaging-gaussian-blur;90;88;88;86;89;86;90;87;89;86 02:20:45 INFO - PROCESS | 1651 | |6;imaging-darkroom;107;96;96;105;95;95;95;95;105;96 02:20:45 INFO - PROCESS | 1651 | |7;imaging-desaturate;92;94;93;92;93;110;120;94;91;91 02:20:45 INFO - PROCESS | 1651 | |8;json-parse-financial;55;57;57;59;59;62;61;61;59;60 02:20:45 INFO - PROCESS | 1651 | |9;json-stringify-tinderbox;69;73;69;84;76;75;69;70;70;73 02:20:45 INFO - PROCESS | 1651 | |10;stanford-crypto-aes;107;83;84;84;85;82;89;84;84;85 02:20:45 INFO - PROCESS | 1651 | |11;stanford-crypto-ccm;146;153;151;139;153;152;154;164;189;164 02:20:45 INFO - PROCESS | 1651 | |12;stanford-crypto-pbkdf2;219;172;173;168;185;162;208;218;226;167 02:20:45 INFO - PROCESS | 1651 | |13;stanford-crypto-sha256-iterative;70;66;67;66;66;66;67;67;66;68 02:20:45 INFO - PROCESS | 1651 | __end_tp_report 02:20:45 INFO - PROCESS | 1651 | __start_cc_report 02:20:45 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,934 02:20:45 INFO - PROCESS | 1651 | __end_cc_report 02:20:45 INFO - PROCESS | 1651 | __startTimestamp1486376445591__endTimestamp 02:20:45 INFO - PROCESS | 1651 | 02:20:45 INFO - PROCESS | 1651 | ------- Summary: start ------- 02:20:45 INFO - PROCESS | 1651 | Number of tests: 14 02:20:45 INFO - PROCESS | 1651 | 02:20:45 INFO - PROCESS | 1651 | [#0] ai-astar Cycles:10 Average:128.80 Median:126.50 stddev:22.34 (17.7%) stddev-sans-first:23.14 02:20:45 INFO - PROCESS | 1651 | Values: 115.0 122.0 120.0 120.0 122.0 128.0 169.0 168.0 125.0 99.0 02:20:45 INFO - PROCESS | 1651 | 02:20:45 INFO - PROCESS | 1651 | [#1] audio-beat-detection Cycles:10 Average:130.50 Median:143.00 stddev:20.94 (14.6%) stddev-sans-first:21.79 02:20:45 INFO - PROCESS | 1651 | Values: 142.0 114.0 98.0 168.0 144.0 147.0 135.0 110.0 130.0 117.0 02:20:45 INFO - PROCESS | 1651 | 02:20:45 INFO - PROCESS | 1651 | [#2] audio-dft Cycles:10 Average:197.00 Median:198.00 stddev:3.50 (1.8%) stddev-sans-first:3.69 02:20:45 INFO - PROCESS | 1651 | Values: 198.0 202.0 197.0 201.0 196.0 193.0 198.0 193.0 192.0 200.0 02:20:45 INFO - PROCESS | 1651 | 02:20:45 INFO - PROCESS | 1651 | [#3] audio-fft Cycles:10 Average:66.20 Median:62.00 stddev:10.41 (16.8%) stddev-sans-first:8.83 02:20:45 INFO - PROCESS | 1651 | Values: 84.0 58.0 59.0 85.0 60.0 60.0 63.0 61.0 72.0 60.0 02:20:45 INFO - PROCESS | 1651 | 02:20:45 INFO - PROCESS | 1651 | [#4] audio-oscillator Cycles:10 Average:75.00 Median:76.50 stddev:5.77 (7.5%) stddev-sans-first:6.08 02:20:45 INFO - PROCESS | 1651 | Values: 77.0 70.0 83.0 76.0 68.0 70.0 82.0 72.0 70.0 82.0 02:20:45 INFO - PROCESS | 1651 | 02:20:45 INFO - PROCESS | 1651 | [#5] imaging-gaussian-blur Cycles:10 Average:87.90 Median:88.50 stddev:1.60 (1.8%) stddev-sans-first:1.50 02:20:45 INFO - PROCESS | 1651 | Values: 90.0 88.0 88.0 86.0 89.0 86.0 90.0 87.0 89.0 86.0 02:20:45 INFO - PROCESS | 1651 | 02:20:45 INFO - PROCESS | 1651 | [#6] imaging-darkroom Cycles:10 Average:98.50 Median:95.00 stddev:4.99 (5.3%) stddev-sans-first:4.25 02:20:45 INFO - PROCESS | 1651 | Values: 107.0 96.0 96.0 105.0 95.0 95.0 95.0 95.0 105.0 96.0 02:20:45 INFO - PROCESS | 1651 | 02:20:45 INFO - PROCESS | 1651 | [#7] imaging-desaturate Cycles:10 Average:97.00 Median:92.50 stddev:9.83 (10.6%) stddev-sans-first:10.26 02:20:45 INFO - PROCESS | 1651 | Values: 92.0 94.0 93.0 92.0 93.0 110.0 120.0 94.0 91.0 91.0 02:20:45 INFO - PROCESS | 1651 | 02:20:45 INFO - PROCESS | 1651 | [#8] json-parse-financial Cycles:10 Average:59.00 Median:59.50 stddev:2.16 (3.6%) stddev-sans-first:1.74 02:20:45 INFO - PROCESS | 1651 | Values: 55.0 57.0 57.0 59.0 59.0 62.0 61.0 61.0 59.0 60.0 02:20:45 INFO - PROCESS | 1651 | 02:20:45 INFO - PROCESS | 1651 | [#9] json-stringify-tinderbox Cycles:10 Average:72.80 Median:73.00 stddev:4.71 (6.5%) stddev-sans-first:4.79 02:20:45 INFO - PROCESS | 1651 | Values: 69.0 73.0 69.0 84.0 76.0 75.0 69.0 70.0 70.0 73.0 02:20:45 INFO - PROCESS | 1651 | 02:20:45 INFO - PROCESS | 1651 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:84.00 stddev:7.36 (8.8%) stddev-sans-first:1.94 02:20:45 INFO - PROCESS | 1651 | Values: 107.0 83.0 84.0 84.0 85.0 82.0 89.0 84.0 84.0 85.0 02:20:45 INFO - PROCESS | 1651 | 02:20:45 INFO - PROCESS | 1651 | [#11] stanford-crypto-ccm Cycles:10 Average:156.50 Median:153.50 stddev:13.61 (8.9%) stddev-sans-first:13.89 02:20:45 INFO - PROCESS | 1651 | Values: 146.0 153.0 151.0 139.0 153.0 152.0 154.0 164.0 189.0 164.0 02:20:45 INFO - PROCESS | 1651 | 02:20:45 INFO - PROCESS | 1651 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:189.80 Median:196.50 stddev:25.12 (12.8%) stddev-sans-first:24.32 02:20:45 INFO - PROCESS | 1651 | Values: 219.0 172.0 173.0 168.0 185.0 162.0 208.0 218.0 226.0 167.0 02:20:45 INFO - PROCESS | 1651 | 02:20:45 INFO - PROCESS | 1651 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:1.29 (1.9%) stddev-sans-first:0.73 02:20:45 INFO - PROCESS | 1651 | Values: 70.0 66.0 67.0 66.0 66.0 66.0 67.0 67.0 66.0 68.0 02:20:45 INFO - PROCESS | 1651 | -------- Summary: end -------- 02:20:45 INFO - PROCESS | 1651 | 02:20:46 INFO - TEST-INFO | 1651: exit 0 02:20:46 INFO - TEST-OK | kraken | took 60140ms 02:20:46 INFO - SUITE-END | took 1174s 02:20:46 INFO - Completed test suite (00:19:34) 02:20:46 INFO - javascript benchmark 02:20:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7337.881920973185, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2794.4969905417015, 2946.852657367132, 3326.0520751585805, 3346.7155291800195, 3374.8481318340673, 4835.516448355167, 5570.415106413824, 5650.802221922234, 5658.264425624663, 5694.6867922264255, 5531.612787104904, 5556.416576259495, 5559.9444005559935, 5577.9163312550345, 5591.9720401397935, 4770.952290477103, 5075.416327122382, 5113.923291150636, 5143.331366922295, 5185.870353241162, 5120.615953803461, 5157.922631160535, 5160.535551800337, 5184.066867963784, 5226.973865130688, 5097.413797413308, 5149.639525233235, 5165.3026841376495, 5166.0, 5184.766685499143, 5159.045576568328, 5187.118189907725, 5207.453217412155, 5244.318238628954, 5273.0, 5122.33409656746, 5150.768215430315, 5165.896682066337, 5166.664166829144, 5180.585553155738, 5451.073317536028, 5588.21764952907, 5656.91514627281, 5789.652620842763, 5835.124731290341, 6069.696515174268, 6103.572749907508, 6103.786367477117, 6125.663088530129, 6194.287656919467, 6228.096925945712, 6254.6872656366995, 6262.2798378186635, 6273.592216505913, 6286.748530058838, 5717.914231286534, 5743.971280143656, 5750.856228594235, 5757.481826635623, 5779.075347944351, 6176.320604733476, 6194.845128871814, 6197.380261973857, 6230.7819226327765, 6234.501239900797, 6081.756729730761, 6102.9694851525455, 6116.457510225689, 6134.447899689049, 6140.4473597376455, 6178.907316390258, 6242.687865606701, 6257.155284036688, 6257.186565746424, 6271.216097987752, 6021.42796434338, 6074.54440916933, 6102.9694851525455, 6121.117656725397, 6226.657533835682, 6211.937880621226, 6227.0, 6228.813135605939, 6230.127782110508, 6244.812655620339, 4934.7285899275885, 4936.90126197474, 4947.060058588857, 4953.7523123844385, 4960.677555958851, 4300.741955482681, 4323.935140972888, 4327.783610819446, 4340.65274778017, 4432.180046691373, 5698.629589076697, 5762.250907382014, 5800.071988481907, 5821.970890145607, 5841.7371218295275, 6230.626162430269, 6237.033259844731, 6240.906386404207, 6251.437370636664, 6275.246970363585, 5648.406917273709, 5699.829005129853, 5748.281464816898, 5788.88422231553, 5789.363170051291, 5431.429699881455, 5435.619506634576, 5449.291592093003, 5453.809116680976, 5469.726513674301, 5770.596058276048, 6273.215848018997, 6279.843003924847, 6285.434310911948, 6286.057091436138, 5011.523905228997, 6113.628337950474, 6119.816405507842, 6144.003198960267, 6241.906371404523, 5207.817726379559, 6201.3178550358525, 6231.688415579112, 6238.906416403848, 6249.343818899132, 6011.7595296187665, 6075.362086980804, 6077.696115194134, 6083.939160608337, 6120.7551697931585, 6029.336772954884, 6062.42406971337, 6108.847278818065, 6120.693965301806, 6137.662428566472, 5882.382349853204, 5959.880802384015, 5965.224520812267, 5974.581779275582, 6001.939980600138, 5301.549368303583, 5567.747256867173, 5864.736086876186, 5923.992921203319, 5924.674142922181, 5628.493435590816, 5744.712764361849, 5753.482186603226, 5817.389174136824, 5828.417158284137, 4743.573078422821, 5320.361556613231, 5915.58590898633, 6037.9094313584455, 6064.878702426015, 5085.7711402986215, 5954.0, 5954.523638109027, 5959.255093113361, 5975.014122669711], "value": 5601.806704216899, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [431.3981995116812, 479.522874739634, 484.94665586785453, 530.6948504609848, 536.5278554871712, 31115.533267001014, 41617.167656646925, 41739.582604173986, 41751.747447576585, 41958.58041419585, 41603.0, 41925.371119433235, 41963.37054944178, 41979.790101049526, 42007.0, 9154.542272886363, 9424.481653509054, 9437.15065644092, 10836.241463097585, 11246.437678116103, 10998.450077496133, 11086.445677716123, 11089.72275693106, 11112.833307500394, 11142.331460112418, 9621.374610650286, 11121.888781112206, 11126.721831954184, 11129.554817807279, 11134.33194008358, 11015.504302306415, 11086.16853735973, 11092.889071109266, 11111.666650000512, 11126.998570128728, 10969.780604387948, 11034.889651103547, 11038.282511636718, 11044.558217671283, 11095.44522773866, 37358.62641373579, 37494.43758343627, 37671.05822354436, 37679.4348084779, 37710.62289377126, 3929.6463318301203, 3946.904150163241, 4030.6372426481757, 4033.757974521538, 4068.328725760246, 27709.58435623467, 28239.435211295866, 28524.286892827844, 29296.853515732284, 29631.259218519495, 3271.4602090655253, 3276.7378609711404, 3322.8172450515212, 3340.8496617652263, 3358.0, 481676.0, 486287.0, 488426.0, 490555.99999999645, 490732.0, 58176.54558636068, 58408.41591584115, 58526.70736646375, 58532.0, 58667.70666146642, 59658.40341596615, 59984.700076499335, 60155.796884062074, 60217.698911506035, 60465.395346045974, 15853.920730396274, 16176.352945882269, 16333.509994700178, 16351.34594616202, 16390.83609163917, 9454.716358509255, 11700.06399488039, 12413.006959443223, 12710.42803073864, 12744.299063551409, 17856.375026873997, 18046.63906721858, 18069.45791626227, 18088.82422642524, 18124.640651951155, 6936.410405115622, 6954.547954382949, 8118.878216826753, 8234.958825205955, 8315.916840831635, 882.885224920769, 884.4869975414244, 894.561664784251, 905.7871400220943, 928.5218112671979, 29462.705372946424, 30593.38813223723, 30614.54078188829, 31242.750289988602, 31480.37039259202, 954.2461455450256, 1012.7417508535424, 1044.2637940252255, 1095.8411030400548, 1226.8345072181285, 15495.302711378015, 15520.844791552166, 15592.610184745472, 15695.843041569666, 15847.52457426279, 584359.0, 593733.0, 598649.0, 598790.0, 600914.0, 57919.71040144772, 58383.41616583865, 58414.7079264601, 58519.70740146357, 58672.0, 1425.4512012874911, 1450.311102226434, 1450.6953539756769, 1452.7966084748143, 1459.7007613439218, 21825.781742182375, 28767.0, 29113.27216819512, 29808.254793630334, 30336.241593960327, 50636.98726025532, 50693.23960140675, 50993.74503127461, 51053.23420148775, 51145.48854511407, 456981.43018570717, 462287.0, 462600.0, 464776.0, 467061.32938671537, 21549.676754849002, 24560.385990350384, 25362.619560706236, 26226.688665566264, 26843.463130737666, 41891.58108418999, 42942.0, 43208.0, 43740.0, 43753.0, 35454.0, 35540.0, 35569.82215088908, 35606.821965890005, 35945.82027089952, 32244.032679019667, 33198.0, 34213.486797698555, 34796.956091317305, 35333.82333088421, 33780.83109584436, 34041.0, 34481.48277775886, 34947.47578786371, 34972.0, 25243.49513009693, 31858.20354491156, 31943.0, 32014.199645009063, 32039.839800800848, 19684.409467715992, 23933.042678292673, 23973.041078357368, 24089.75910240945, 24222.75777242205], "value": 19676.472746176445, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.9506311711036, 395.92477429288414, 401.5643027315363, 404.71265401564887, 420.54581052463345, 17263.39578114766, 19627.901860490696, 20380.38858834237, 20915.267965621206, 20944.685829712547, 20615.69076463854, 20847.061882215297, 21598.568028639416, 21810.0, 22055.22806701766, 5737.540996720273, 5943.940560594382, 5967.671778052206, 5977.342492325841, 5979.581429299951, 5582.944170558303, 5668.943310566903, 5736.799212027579, 5807.448292412214, 5859.326177489601, 5119.59043276537, 5731.0, 5735.111057786029, 5741.799037033705, 5743.0, 4991.675541089818, 5426.131818908955, 5726.0, 5752.65484070955, 5778.768849246025, 5107.7956881724685, 5118.872028199325, 5128.051310507568, 5128.153854613985, 5129.281900533928, 22395.888020559956, 22537.436564085867, 25904.481910361876, 26047.869760651076, 26519.204423867315, 2800.7899407544514, 2845.573164025392, 2854.6859845417193, 2874.985625071882, 2876.0077773168223, 15422.768658470131, 15899.841001590068, 15983.280752366056, 16129.435469758619, 16525.173741312887, 1535.8387369326283, 1832.2945665918585, 1838.035031608403, 1842.3828017614114, 1871.0270659257246, 128063.0, 134367.32816335955, 137189.0, 138514.0, 138629.0, 11573.247738896946, 11716.414179291001, 11745.765084698429, 11765.05870533381, 11957.52169913211, 13102.672433189056, 13755.79366309506, 14716.33776480061, 14745.631359216106, 14775.778363324558, 8449.915500845036, 8622.568871556397, 8870.86693699595, 8882.0, 8996.415233009833, 8880.73357799267, 8897.822043559223, 8921.687740929166, 9056.818863622691, 9077.954610226907, 6097.451229389288, 6756.695948682321, 6804.285550017177, 7210.603416812126, 7280.381167600707, 1856.8765896632613, 1909.7039958806408, 1943.805619438045, 1950.2978927586057, 1958.657234983872, 752.1951511882343, 844.2444012608681, 883.4522595990527, 888.3470649072926, 895.4492986813063, 19432.611347772967, 21027.474313142295, 21780.23769168103, 23228.838558072028, 23325.88337058304, 855.5636625321131, 905.9275257979345, 914.2229105260475, 915.1854849184232, 928.535732133933, 9876.35803672759, 12136.635900922987, 12198.695032624255, 12225.633231003085, 12265.632031039084, 749719.0, 753795.0, 762787.0, 766018.0, 772724.0, 142992.0, 144045.0, 149991.0, 165373.0, 168560.0, 1041.4272150317295, 1049.3913530152493, 1081.361996422099, 1089.8964598363143, 1095.950682219302, 19893.701594475806, 20253.0, 20331.780093194455, 20432.080556375295, 20500.89749551243, 52840.207396888305, 60467.39532604794, 60880.695596521735, 61100.77798444095, 62110.40742033467, 75630.0, 79084.20915790768, 89581.65627515723, 96899.0, 97241.51379243059, 7576.674082035512, 8175.915141638844, 8230.382721296046, 8359.205875441823, 8715.869261960948, 11465.541378344773, 12031.939840300742, 13231.66920826987, 13271.601851944457, 13462.73074538484, 10270.691879243635, 11121.27711698737, 11215.214934954474, 11446.626404831473, 11479.655610331703, 11248.98759111651, 11328.32030078198, 11481.885181148416, 11529.538818447503, 11647.0, 11464.426778660867, 11487.081033517466, 11583.305001699588, 11954.641360759191, 12061.216020958609, 8262.462939908886, 8472.872906906525, 8554.828903422022, 8657.177568131017, 8703.738887833375, 9729.70810875675, 11089.556417743523, 11235.157363197957, 11272.830907536558, 11422.200445968703], "value": 10140.880206428797, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1419.474794326099, 1428.9285535723218, 1447.0738727214577, 1458.7811828225765, 1473.2118316700567, 7571.432142589314, 7794.727184548542, 8106.22990815873, 8521.318294536437, 8548.829023419528, 8085.595720213995, 8266.669333226664, 8378.413511054228, 8433.198846109624, 8444.40889137759, 2327.290176496168, 2366.1127077345996, 2367.1951536477595, 2369.1589485732575, 2374.726906405768, 2093.4557015176088, 2342.2856028911174, 2372.3001714494267, 2384.8092152627746, 2384.821138414617, 2017.6166528359638, 2289.8511596746243, 2364.0, 2368.692070030894, 2370.2533701883935, 2299.1837897546466, 2308.9191878284178, 2321.454458202321, 2322.84901481404, 2324.151684635113, 2299.356180269527, 2311.202635090891, 2351.259353303721, 2363.7636236376397, 2372.893219805113, 8439.873401898976, 8516.0, 8517.977842658858, 8531.189536993976, 8535.701250456266, 5134.229865520202, 5245.632805703564, 5273.446288139767, 5281.207818827168, 5293.470652934714, 3459.290845376692, 3503.667151620592, 3525.347810655037, 3547.1486843157713, 3576.4277715565386, 1070.0904231403322, 1077.5797438998798, 1208.0577149823152, 1232.5131573028602, 1243.4509256025112, 10774.515146818412, 10851.67444976644, 10855.457227138611, 10864.456777161111, 10871.67384978452, 4480.193565158238, 4698.8355407560575, 4759.571638552547, 4798.352222449925, 4800.231962885921, 8966.327525435618, 9023.458592484472, 9468.526573671288, 9546.18857397115, 9561.0, 5213.296205012275, 5275.076861549213, 5289.576833853283, 5290.973545132327, 5296.867578310496, 4663.603593694574, 4790.185668436374, 4822.107910036654, 4827.710337379768, 4836.7339796310835, 3918.8628398005935, 3927.6857851371824, 3969.0672691917375, 4007.779572123561, 4011.859584914514, 1177.8292147638715, 1224.4612370556927, 1286.6654669785735, 1295.1710905020793, 1298.805179223124, 711.8113699869539, 753.7701001194688, 755.0788038592908, 779.3453499060817, 839.2279103225047, 5625.54995600351, 5675.148727690879, 5756.798512052058, 5829.912551311733, 5966.164736936832, 986.3933680786265, 1006.8439391894268, 1016.3596933931576, 1019.3985548526405, 1056.630179437191, 3878.825452854628, 3940.330143875548, 3956.9802150989062, 3981.462502562175, 4051.7568945862754, 9344.205742511962, 9793.510324483746, 9832.115109640166, 9835.114839664464, 9866.703998880044, 9446.102620251066, 9748.756281092888, 9860.852087218698, 9913.702588922344, 10010.04904534068, 7794.142644309121, 7919.881201781978, 7966.960165199137, 7979.8404031919035, 7987.2012798720825, 4606.539346065367, 5032.672876263031, 5749.655020698771, 5775.191473193672, 5850.297964244318, 7502.0, 7954.721584744738, 9400.388974716621, 9412.247020238228, 9441.905580944103, 9190.494522801042, 9393.154616084585, 9442.763930901783, 9532.904670953201, 9561.043895610383, 7230.89153662706, 7286.927130728624, 7322.853542929218, 7396.9260307396235, 7447.0, 7854.371650268079, 7975.72084977023, 7978.680852766057, 7995.240452157036, 8025.518468891885, 6036.590506702652, 7188.568685878864, 7209.170945341353, 7227.8554428912175, 7301.4158867289425, 5952.434518720715, 7054.4003759681, 7092.113485814273, 7137.321954414322, 7203.063601731741, 6378.681065946591, 6437.25971513282, 6510.804675859732, 6518.837029074121, 6525.3800888915475, 5086.237064440364, 5107.106256405188, 5116.795328186831, 5130.846074617767, 5143.974280128576, 5077.720725360141, 5116.8720781979255, 5144.871378215425, 5177.948220517746, 5203.375594928481], "value": 4444.129224724758, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.1959270398467, 361.5552869969937, 361.7034032093683, 372.7781969728012, 374.50191245643316, 4763.999999999995, 4903.730294833783, 5023.5981121510285, 5387.164989426636, 5532.917006244905, 5280.5247527722495, 5431.185322201672, 5442.156465747806, 5455.399906010336, 5464.644798088121, 3511.4908338290934, 3856.804390638897, 4205.642520385771, 4283.550227226143, 4315.223259813232, 4071.796410179494, 4164.521080075785, 4216.894577635553, 4271.9359209611885, 4310.504292006428, 3579.3736096183193, 4198.181354635847, 4203.117345357478, 4239.6396306314, 4251.404803327521, 3616.5479315085613, 3877.7673339599432, 4190.0, 4211.252330282944, 4224.366345048236, 3471.6528347165336, 3624.981875090634, 3750.5499340079364, 3769.4534292527705, 3781.9810900945595, 4999.075171093359, 5321.137601839364, 5363.034653762321, 5387.515123638852, 5407.242985981966, 4001.5398229203724, 4294.312909934395, 4759.762011899391, 4763.285507173917, 4802.231642937113, 5157.30376399185, 5831.446012628793, 5833.737481813286, 5854.97072514639, 5877.794277200277, 3278.5574347287356, 3529.8058606776617, 3660.158163622355, 3694.649008344203, 3952.565217826037, 5509.449055094498, 5624.850083953, 5628.04323265046, 6084.330723620398, 6190.41191086846, 3946.210757848442, 4008.07814202735, 4017.9196416071513, 4023.4970628671417, 4037.374206997861, 3389.57630296213, 3784.1674831537016, 3986.6611338036014, 4077.7145599808323, 4086.9182616347507, 4023.637872591481, 4187.43469631602, 4619.653525985565, 4704.811807527729, 4724.67709041469, 5238.0, 5821.459261775822, 5828.795992140254, 5858.150568167592, 5872.706364681749, 1125.6679279612533, 1140.3578846461069, 1242.8751979458605, 1310.3251825309974, 1316.5254914495636, 876.3733930239781, 990.9851352229722, 1004.5579944824254, 1004.6835246897203, 1006.8924183398203, 4702.155196106375, 5160.48395160481, 5187.974060129675, 5191.8182863599595, 5197.272381866466, 5185.351831021122, 5286.9471305287225, 5359.517643412111, 5609.4757359188525, 5701.828945131652, 4701.213538855213, 4799.0, 4964.585093248407, 5148.275327765241, 5180.533751962266, 2445.461998360358, 2699.4061306512535, 2770.141256210581, 2924.7806414518573, 2956.0688383159236, 5160.432352441228, 5842.941570584325, 5917.792877249276, 5929.495992840657, 5934.317553481319, 5031.647784655039, 5410.377806552218, 5685.516731077904, 5743.684097374601, 5850.572012614717, 4962.652614317035, 5091.625261179535, 5391.0, 5825.980453420634, 5882.3529411764675, 4889.633277504273, 5155.226715992631, 5562.13308442423, 5620.932022915633, 5652.576056795839, 5195.9740201298755, 5404.297441332759, 5415.83752487426, 5564.443555644403, 5631.0, 5434.701091440009, 5583.525400340854, 5614.354349249726, 5904.996150654313, 5909.6158749681135, 3191.0, 3970.0273433009097, 4075.3275709507598, 4090.5091389033505, 4119.876403707894, 5454.945450545444, 5961.433663801932, 6019.819405417845, 6022.668753218615, 6048.334683184934, 5654.529822246328, 5714.457096583982, 5814.622049566765, 5817.538564554084, 5833.387494313206, 5799.333076696065, 5816.778476519809, 5824.825255242349, 5848.239728835224, 5873.853153671193, 4855.562999330077, 5516.0071187186695, 5557.666540007613, 5720.570957178312, 5746.626469279484, 4884.095202870954, 5172.172452407597, 5543.334799824047, 5553.861458400937, 5782.739776710142, 4801.759912004316, 5653.180288858175, 5667.489925906688, 5675.7445914933105, 5676.375598684224], "value": 4158.472780771529, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [721.6499997501211, 730.7252572451158, 776.9223077692232, 831.4263158420689, 855.9771073567086, 14682.339294731735, 15299.005564638319, 15331.616709582266, 15370.615734606627, 15504.069755814646, 12802.975761939046, 13784.58646240612, 14091.647708807284, 14233.78649320261, 14257.857421425808, 872.5898827551073, 896.6906417286059, 903.9638414463446, 913.2055112052524, 914.2868562521244, 902.4089221559889, 904.1049361132465, 906.727981605519, 907.9092090790901, 907.9909200908005, 949.0, 955.1594596754846, 957.1720461800562, 959.4003747657714, 960.6877764726457, 948.3882895532342, 950.1923365139611, 952.4285428742699, 952.6903756279203, 953.8044700836311, 694.5589550635333, 711.7615598774416, 712.8289210589421, 713.6752777486231, 714.153727832515, 14832.961692681516, 15455.613609659737, 15538.300776465087, 15557.92221038899, 15620.531384058497, 13617.727645447134, 13835.446582136703, 14189.07770994882, 14196.787048194285, 14243.430262789476, 11455.770884582345, 11660.475278612483, 11706.239094458833, 11813.527458901634, 12336.691582710415, 3658.7804731716183, 3670.229251857113, 3693.4829123922673, 3750.906227344311, 3823.598522155189, 91103.0, 95252.0, 108791.91208087897, 113931.0, 115222.0, 10676.733081673021, 10960.451977401257, 10977.0, 11012.17408694335, 11018.834717479243, 21955.890220548794, 22439.21462748796, 22467.32598022062, 22479.0, 22491.775082249296, 7590.316871481593, 7630.313271805453, 7866.0, 7913.920860791433, 7973.681052757941, 3703.6481534254203, 4365.694401391936, 4390.560943905648, 4398.120375924827, 4438.0, 3497.45789402643, 3595.119195796994, 3605.0807044204084, 3613.4941108244866, 3619.113317237294, 634.6477704873839, 634.8730253949228, 640.4300172846171, 641.6631268584031, 645.296626676915, 685.5543896467336, 698.8427603789107, 704.3997741165314, 709.1348554763284, 717.8600172966221, 8887.733627924837, 9666.671661846352, 10475.0, 10523.421211833269, 10636.521356538975, 568.4161362608792, 636.277824669004, 643.0482885329739, 643.7811144210991, 656.167327631987, 4419.248727716296, 4878.82908102053, 4962.106820772224, 5033.647644664911, 5055.6713813602, 101313.98686013193, 103121.0, 103360.0, 103374.44938325931, 104265.95734042562, 65401.34598654048, 70470.64764676246, 76247.47505049867, 76943.46113077707, 80196.39607207823, 63180.05229921647, 69889.0, 70387.0, 72470.27529724741, 75112.62443687746, 10704.250702451065, 11209.607663732057, 11242.55029798799, 11429.199956003, 11442.94278528602, 45742.771286143354, 46339.536604633526, 46832.53167468282, 47408.525914740414, 48098.0, 56671.716641416526, 62089.37910620836, 65059.0, 65093.37266568374, 67177.66411167913, 11712.70718232051, 12243.449044793184, 13430.731385372434, 13582.25297608641, 13861.861381386057, 14564.49024284145, 14736.77894831557, 15161.0, 15238.466653667068, 15247.3901043957, 13589.728205436033, 13662.0, 13741.519046833313, 13844.10013349129, 13907.30463476802, 13571.59285221445, 13714.86285137136, 13934.790978135134, 14117.6470588232, 14236.715265694422, 13826.239556824472, 13880.517726728842, 13979.860201397856, 14030.579082627537, 14473.710525789214, 11104.222704410613, 11157.330560166416, 11251.606193783178, 11763.117766167401, 11825.0, 10987.285826421257, 11164.609238676932, 11229.49467273991, 11322.60370887015, 11325.886741132483], "value": 7556.241273752709, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1512.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 122.0, 120.0, 120.0, 122.0, 128.0, 169.0, 168.0, 125.0, 99.0], "value": 128.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 114.0, 98.0, 168.0, 144.0, 147.0, 135.0, 110.0, 130.0, 117.0], "value": 130.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 202.0, 197.0, 201.0, 196.0, 193.0, 198.0, 193.0, 192.0, 200.0], "value": 197.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 58.0, 59.0, 85.0, 60.0, 60.0, 63.0, 61.0, 72.0, 60.0], "value": 66.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 70.0, 83.0, 76.0, 68.0, 70.0, 82.0, 72.0, 70.0, 82.0], "value": 75.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 88.0, 88.0, 86.0, 89.0, 86.0, 90.0, 87.0, 89.0, 86.0], "value": 87.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 96.0, 96.0, 105.0, 95.0, 95.0, 95.0, 95.0, 105.0, 96.0], "value": 98.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 94.0, 93.0, 92.0, 93.0, 110.0, 120.0, 94.0, 91.0, 91.0], "value": 97.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 57.0, 57.0, 59.0, 59.0, 62.0, 61.0, 61.0, 59.0, 60.0], "value": 59.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 73.0, 69.0, 84.0, 76.0, 75.0, 69.0, 70.0, 70.0, 73.0], "value": 72.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 83.0, 84.0, 84.0, 85.0, 82.0, 89.0, 84.0, 84.0, 85.0], "value": 86.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 153.0, 151.0, 139.0, 153.0, 152.0, 154.0, 164.0, 189.0, 164.0], "value": 156.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [219.0, 172.0, 173.0, 168.0, 185.0, 162.0, 208.0, 218.0, 226.0, 167.0], "value": 189.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 66.0, 67.0, 66.0, 66.0, 66.0, 67.0, 67.0, 66.0, 68.0], "value": 66.9, "unit": "score"}]}]} 02:20:46 INFO - Return code: 0 02:20:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:20:46 ERROR - # TBPL SUCCESS # 02:20:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:20:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:20:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:20:46 INFO - 2017-02-06 02:20:46.899 screenresolution[1656:10635] starting screenresolution argv=screenresolution get 02:20:46 INFO - 2017-02-06 02:20:46.902 screenresolution[1656:10635] Display 0: 1600x1200x32@60 02:20:46 INFO - 2017-02-06 02:20:46.908 screenresolution[1657:10639] starting screenresolution argv=screenresolution list 02:20:46 INFO - Available Modes on Display 0 02:20:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:20:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:20:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:20:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:20:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:20:47 INFO - Intel Iris: 02:20:47 INFO - Chipset Model: Intel Iris 02:20:47 INFO - Type: GPU 02:20:47 INFO - Bus: Built-In 02:20:47 INFO - VRAM (Dynamic, Max): 1536 MB 02:20:47 INFO - Vendor: Intel (0x8086) 02:20:47 INFO - Device ID: 0x0a2e 02:20:47 INFO - Revision ID: 0x0009 02:20:47 INFO - Displays: 02:20:47 INFO - Display: 02:20:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:20:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:20:47 INFO - Display Serial Number: 1600x1200 60 02:20:47 INFO - Main Display: Yes 02:20:47 INFO - Mirror: Off 02:20:47 INFO - Online: Yes 02:20:47 INFO - Rotation: Supported 02:20:47 INFO - Return code: 0 02:20:47 INFO - Running post-action listener: _resource_record_post_action 02:20:47 INFO - [mozharness: 2017-02-06 10:20:47.146597Z] Finished run-tests step (success) 02:20:47 INFO - Running post-run listener: _resource_record_post_run 02:20:47 INFO - Total resource usage - Wall time: 1195s; CPU: 55.0%; Read bytes: 39110656; Write bytes: 510880768; Read time: 386; Write time: 1688 02:20:47 INFO - TinderboxPrint: CPU usage
54.6% 02:20:47 INFO - TinderboxPrint: I/O read bytes / time
39,110,656 / 386 02:20:47 INFO - TinderboxPrint: I/O write bytes / time
510,880,768 / 1,688 02:20:47 INFO - TinderboxPrint: CPU idle
2,170.0 (45.4%) 02:20:47 INFO - TinderboxPrint: CPU system
964.8 (20.2%) 02:20:47 INFO - TinderboxPrint: CPU user
1,646.8 (34.4%) 02:20:47 INFO - TinderboxPrint: Swap in / out
246,665,216 / 0 02:20:47 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 203227648; Write bytes: 199939584; Read time: 15431; Write time: 390 02:20:47 INFO - run-tests - Wall time: 1176s; CPU: 55.0%; Read bytes: 37148672; Write bytes: 300140032; Read time: 365; Write time: 1263 02:20:47 INFO - Running post-run listener: _upload_blobber_files 02:20:47 INFO - Blob upload gear active. 02:20:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:20:47 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:20:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:20:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:20:48 INFO - (blobuploader) - INFO - Open directory for files ... 02:20:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:20:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:20:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:20:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:20:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:20:49 INFO - (blobuploader) - INFO - Done attempting. 02:20:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:20:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:20:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:20:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:20:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:20:50 INFO - (blobuploader) - INFO - Done attempting. 02:20:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:20:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:20:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:20:51 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:20:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:20:51 INFO - (blobuploader) - INFO - Done attempting. 02:20:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:20:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:20:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:20:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:20:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:20:53 INFO - (blobuploader) - INFO - Done attempting. 02:20:53 INFO - (blobuploader) - INFO - Iteration through files over. 02:20:53 INFO - Return code: 0 02:20:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:20:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:20:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6e16b5c1f932730ed4f8d949c2eac7314a9c375edae738f0205776b43e5ab1f72c1be5f421c1879e992cda23194b709b4cf78636e09346fd17165491681e9ac9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1306231a7f12df0a6e40867eb4db5b258d74a7eb825526802b8f63d8f8ac8e93f72fb4fe3638481ea2c6e16ff358feba1503cbde013d75ff950673593ec3575a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/429d0570c056b9fc0e0998a57f69220affa11e1fefee9a87b12ba0440ffe26a1e7bc1a4f5a3eafa30b8b00ccf19f1ae69e3ddb72f7de762e948f3385750ca773", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ddad0ceb51d7da06ffee11e64a81c385d8242e8cab637c4b3ac94aa9fbcf0490059b4f452f94891ac862774e9486f81890daa22fa09d6ed6bd28e54b9d3bf991"} 02:20:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:20:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:20:53 INFO - Contents: 02:20:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6e16b5c1f932730ed4f8d949c2eac7314a9c375edae738f0205776b43e5ab1f72c1be5f421c1879e992cda23194b709b4cf78636e09346fd17165491681e9ac9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1306231a7f12df0a6e40867eb4db5b258d74a7eb825526802b8f63d8f8ac8e93f72fb4fe3638481ea2c6e16ff358feba1503cbde013d75ff950673593ec3575a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/429d0570c056b9fc0e0998a57f69220affa11e1fefee9a87b12ba0440ffe26a1e7bc1a4f5a3eafa30b8b00ccf19f1ae69e3ddb72f7de762e948f3385750ca773", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ddad0ceb51d7da06ffee11e64a81c385d8242e8cab637c4b3ac94aa9fbcf0490059b4f452f94891ac862774e9486f81890daa22fa09d6ed6bd28e54b9d3bf991"} 02:20:53 INFO - Running post-run listener: copy_logs_to_upload_dir 02:20:53 INFO - Copying logs to upload dir... 02:20:53 INFO - mkdir: /builds/slave/test/build/upload/logs 02:20:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.385734 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-02-06 02:20:53.435038) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-06 02:20:53.438698) ========= 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.UJxtuTxpOK/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.2OKelfAuNh/Listeners TMPDIR=/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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/6e16b5c1f932730ed4f8d949c2eac7314a9c375edae738f0205776b43e5ab1f72c1be5f421c1879e992cda23194b709b4cf78636e09346fd17165491681e9ac9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1306231a7f12df0a6e40867eb4db5b258d74a7eb825526802b8f63d8f8ac8e93f72fb4fe3638481ea2c6e16ff358feba1503cbde013d75ff950673593ec3575a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/429d0570c056b9fc0e0998a57f69220affa11e1fefee9a87b12ba0440ffe26a1e7bc1a4f5a3eafa30b8b00ccf19f1ae69e3ddb72f7de762e948f3385750ca773", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ddad0ceb51d7da06ffee11e64a81c385d8242e8cab637c4b3ac94aa9fbcf0490059b4f452f94891ac862774e9486f81890daa22fa09d6ed6bd28e54b9d3bf991"} build_url:https://queue.taskcluster.net/v1/task/fjX77gP1TreQsEMRyxbSMQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010891 build_url: 'https://queue.taskcluster.net/v1/task/fjX77gP1TreQsEMRyxbSMQ/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/6e16b5c1f932730ed4f8d949c2eac7314a9c375edae738f0205776b43e5ab1f72c1be5f421c1879e992cda23194b709b4cf78636e09346fd17165491681e9ac9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1306231a7f12df0a6e40867eb4db5b258d74a7eb825526802b8f63d8f8ac8e93f72fb4fe3638481ea2c6e16ff358feba1503cbde013d75ff950673593ec3575a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/429d0570c056b9fc0e0998a57f69220affa11e1fefee9a87b12ba0440ffe26a1e7bc1a4f5a3eafa30b8b00ccf19f1ae69e3ddb72f7de762e948f3385750ca773", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ddad0ceb51d7da06ffee11e64a81c385d8242e8cab637c4b3ac94aa9fbcf0490059b4f452f94891ac862774e9486f81890daa22fa09d6ed6bd28e54b9d3bf991"}' ========= master_lag: 0.38 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-06 02:20:53.829735) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 02:20:53.830058) ========= 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.UJxtuTxpOK/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.2OKelfAuNh/Listeners TMPDIR=/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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.005198 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 02:20:53.878933) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-06 02:20:53.882276) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-06 02:20:53.882588) ========= ========= Total master_lag: 0.55 =========