builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0010 starttime: 1490017853.23 results: success (0) buildid: 20170320050941 builduid: a0f9e0d752ee4c17a64295da920709a7 revision: cb4e80abb488f37ec67c4760a128ae177697667b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-20 06:50:53.229087) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-20 06:50:53.229528) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-20 06:50:53.229825) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-20 06:50:53.256542) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 06:50:53.256916) ========= 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.59bVaWKRG9/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.UX6SjBjEhC/Listeners TMPDIR=/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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-03-20 06:50:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.25M=0.001s 2017-03-20 06:50:53 (9.25 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.103111 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 06:50:53.385120) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 06:50:53.385430) ========= 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.59bVaWKRG9/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.UX6SjBjEhC/Listeners TMPDIR=/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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.031127 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 06:50:53.440309) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-20 06:50:53.440996) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev cb4e80abb488f37ec67c4760a128ae177697667b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev cb4e80abb488f37ec67c4760a128ae177697667b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.59bVaWKRG9/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.UX6SjBjEhC/Listeners TMPDIR=/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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-03-20 06:50:53,545 truncating revision to first 12 chars 2017-03-20 06:50:53,545 Setting DEBUG logging. 2017-03-20 06:50:53,545 attempt 1/10 2017-03-20 06:50:53,545 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/cb4e80abb488?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-20 06:50:54,874 unpacking tar archive at: mozilla-central-cb4e80abb488/testing/mozharness/ program finished with exit code 0 elapsedTime=1.600981 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-20 06:50:55.065974) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-20 06:50:55.066295) ========= script_repo_revision: cb4e80abb488f37ec67c4760a128ae177697667b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-20 06:50:55.066704) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-20 06:50:55.066986) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-20 06:50:55.086397) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-03-20 06:50:55.086897) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.59bVaWKRG9/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.UX6SjBjEhC/Listeners TMPDIR=/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 06:50:55 INFO - MultiFileLogger online at 20170320 06:50:55 in /builds/slave/test 06:50:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:50:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:50:55 INFO - {'append_to_log': False, 06:50:55 INFO - 'base_work_dir': '/builds/slave/test', 06:50:55 INFO - 'blob_upload_branch': 'Firefox', 06:50:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:50:55 INFO - 'branch': 'Firefox', 06:50:55 INFO - 'buildbot_json_path': 'buildprops.json', 06:50:55 INFO - 'config_files': ('talos/mac_config.py',), 06:50:55 INFO - 'default_actions': ('clobber', 06:50:55 INFO - 'read-buildbot-config', 06:50:55 INFO - 'download-and-extract', 06:50:55 INFO - 'populate-webroot', 06:50:55 INFO - 'create-virtualenv', 06:50:55 INFO - 'install', 06:50:55 INFO - 'run-tests'), 06:50:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:50:55 INFO - 'download_minidump_stackwalk': True, 06:50:55 INFO - 'download_symbols': 'ondemand', 06:50:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:50:55 INFO - 'tooltool.py': '/tools/tooltool.py', 06:50:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:50:55 INFO - '/tools/misc-python/virtualenv.py')}, 06:50:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:50:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:50:55 INFO - 'gecko_profile': False, 06:50:55 INFO - 'gecko_profile_interval': 0, 06:50:55 INFO - 'installer_path': 'installer.exe', 06:50:55 INFO - 'log_level': 'info', 06:50:55 INFO - 'log_name': 'talos', 06:50:55 INFO - 'log_to_console': True, 06:50:55 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:50:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:50:55 INFO - 'opt_config_files': (), 06:50:55 INFO - 'pip_index': False, 06:50:55 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:50:55 INFO - 'cmd': ('bash', 06:50:55 INFO - '-c', 06:50:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:50:55 INFO - 'enabled': True, 06:50:55 INFO - 'halt_on_failure': False, 06:50:55 INFO - 'name': 'check_screen_resolution'},), 06:50:55 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:50:55 INFO - 'cmd': ('bash', 06:50:55 INFO - '-c', 06:50:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:50:55 INFO - 'enabled': True, 06:50:55 INFO - 'halt_on_failure': False, 06:50:55 INFO - 'name': 'check_screen_resolution'},), 06:50:55 INFO - 'run_cmd_checks_enabled': True, 06:50:55 INFO - 'suite': 'dromaeojs-e10s', 06:50:55 INFO - 'system_bits': '32', 06:50:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:50:55 INFO - 'title': 't-yosemite-r7-0010', 06:50:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:50:55 INFO - 'use_talos_json': True, 06:50:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:50:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:50:55 INFO - 'work_dir': 'build'} 06:50:55 INFO - [mozharness: 2017-03-20 13:50:55.304622Z] Running clobber step. 06:50:55 INFO - Running pre-action listener: _resource_record_pre_action 06:50:55 INFO - Running main action method: clobber 06:50:55 INFO - rmtree: /builds/slave/test/build 06:50:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:50:57 INFO - Running post-action listener: _resource_record_post_action 06:50:57 INFO - [mozharness: 2017-03-20 13:50:57.804655Z] Finished clobber step (success) 06:50:57 INFO - [mozharness: 2017-03-20 13:50:57.804897Z] Running read-buildbot-config step. 06:50:57 INFO - Running pre-action listener: _resource_record_pre_action 06:50:57 INFO - Running main action method: read_buildbot_config 06:50:57 INFO - Using buildbot properties: 06:50:57 INFO - { 06:50:57 INFO - "project": "", 06:50:57 INFO - "product": "firefox", 06:50:57 INFO - "script_repo_revision": "production", 06:50:57 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 06:50:57 INFO - "repository": "", 06:50:57 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 06:50:57 INFO - "buildid": "20170320050941", 06:50:57 INFO - "pgo_build": "False", 06:50:57 INFO - "basedir": "/builds/slave/test", 06:50:57 INFO - "buildnumber": 178, 06:50:57 INFO - "slavename": "t-yosemite-r7-0010", 06:50:57 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 06:50:57 INFO - "platform": "yosemite_r7", 06:50:57 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 06:50:57 INFO - "branch": "mozilla-central", 06:50:57 INFO - "repo_path": "mozilla-central", 06:50:57 INFO - "revision": "cb4e80abb488f37ec67c4760a128ae177697667b", 06:50:57 INFO - "stage_platform": "macosx64", 06:50:57 INFO - "builduid": "a0f9e0d752ee4c17a64295da920709a7", 06:50:57 INFO - "slavebuilddir": "test" 06:50:57 INFO - } 06:50:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/XtmM43fGSC6xnOXI8chh7Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 06:50:57 INFO - Running post-action listener: _resource_record_post_action 06:50:57 INFO - [mozharness: 2017-03-20 13:50:57.810680Z] Finished read-buildbot-config step (success) 06:50:57 INFO - [mozharness: 2017-03-20 13:50:57.810915Z] Running download-and-extract step. 06:50:57 INFO - Running pre-action listener: _resource_record_pre_action 06:50:57 INFO - Running main action method: download_and_extract 06:50:57 INFO - mkdir: /builds/slave/test/build/tests 06:50:57 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')]} 06:50:57 INFO - trying https://queue.taskcluster.net/v1/task/XtmM43fGSC6xnOXI8chh7Q/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 06:50:57 INFO - Downloading https://queue.taskcluster.net/v1/task/XtmM43fGSC6xnOXI8chh7Q/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 06:50:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XtmM43fGSC6xnOXI8chh7Q/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 06:50:59 INFO - Downloaded 1325 bytes. 06:50:59 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 06:50:59 INFO - Using the following test package requirements: 06:50:59 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 06:50:59 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 06:50:59 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 06:50:59 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 06:50:59 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 06:50:59 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 06:50:59 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 06:50:59 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 06:50:59 INFO - u'jsshell-mac.zip'], 06:50:59 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 06:50:59 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 06:50:59 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 06:50:59 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 06:50:59 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 06:50:59 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 06:50:59 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 06:50:59 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 06:50:59 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 06:50:59 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 06:50:59 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 06:50:59 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:50:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XtmM43fGSC6xnOXI8chh7Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 06:50:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XtmM43fGSC6xnOXI8chh7Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:50:59 INFO - Fetch https://queue.taskcluster.net/v1/task/XtmM43fGSC6xnOXI8chh7Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 06:51:00 INFO - Expected file size: 52476109 06:51:00 INFO - Obtained file size: 52476109 06:51:16 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 06:51:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XtmM43fGSC6xnOXI8chh7Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 06:51:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XtmM43fGSC6xnOXI8chh7Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:51:16 INFO - Fetch https://queue.taskcluster.net/v1/task/XtmM43fGSC6xnOXI8chh7Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 06:51:18 INFO - Expected file size: 52476109 06:51:18 INFO - Obtained file size: 52476109 06:51:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XtmM43fGSC6xnOXI8chh7Q/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 06:51:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XtmM43fGSC6xnOXI8chh7Q/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 06:51:34 INFO - Fetch https://queue.taskcluster.net/v1/task/XtmM43fGSC6xnOXI8chh7Q/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 06:51:35 INFO - Expected file size: 14404171 06:51:35 INFO - Obtained file size: 14404171 06:51:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:51:35 INFO - trying https://queue.taskcluster.net/v1/task/XtmM43fGSC6xnOXI8chh7Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 06:51:35 INFO - Downloading https://queue.taskcluster.net/v1/task/XtmM43fGSC6xnOXI8chh7Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 06:51:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XtmM43fGSC6xnOXI8chh7Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 06:51:37 INFO - Downloaded 75188003 bytes. 06:51:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XtmM43fGSC6xnOXI8chh7Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 06:51:37 INFO - mkdir: /builds/slave/test/properties 06:51:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:51:37 INFO - Writing to file /builds/slave/test/properties/build_url 06:51:37 INFO - Contents: 06:51:37 INFO - build_url:https://queue.taskcluster.net/v1/task/XtmM43fGSC6xnOXI8chh7Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 06:51:38 INFO - Running post-action listener: _resource_record_post_action 06:51:38 INFO - Running post-action listener: set_extra_try_arguments 06:51:38 INFO - [mozharness: 2017-03-20 13:51:38.455900Z] Finished download-and-extract step (success) 06:51:38 INFO - [mozharness: 2017-03-20 13:51:38.456053Z] Running populate-webroot step. 06:51:38 INFO - Running pre-action listener: _resource_record_pre_action 06:51:38 INFO - Running main action method: populate_webroot 06:51:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:51:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:51:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:51:38 INFO - '--tppagecycles', 06:51:38 INFO - '7'], 06:51:38 INFO - 'tests': ['tsvgm']}}, 06:51:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:51:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:51:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:51:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:51:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:51:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:51:38 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 06:51:38 INFO - 'talos_options': ['--disable-e10s'], 06:51:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:51:38 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:51:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:51:38 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 06:51:38 INFO - 'talos_options': ['--disable-e10s'], 06:51:38 INFO - 'tests': ['damp', 'tps']}, 06:51:38 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:51:38 INFO - 'tests': ['damp', 'tps']}, 06:51:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:51:38 INFO - 'tests': ['dromaeo_dom']}, 06:51:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:51:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:51:38 INFO - 'tests': ['basic_compositor_video']}, 06:51:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:51:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:51:38 INFO - 'tests': ['a11yr', 06:51:38 INFO - 'ts_paint', 06:51:38 INFO - 'tpaint', 06:51:38 INFO - 'sessionrestore', 06:51:38 INFO - 'sessionrestore_no_auto_restore', 06:51:38 INFO - 'tabpaint']}, 06:51:38 INFO - 'other-e10s': {'tests': ['a11yr', 06:51:38 INFO - 'ts_paint', 06:51:38 INFO - 'tpaint', 06:51:38 INFO - 'sessionrestore', 06:51:38 INFO - 'sessionrestore_no_auto_restore', 06:51:38 INFO - 'tabpaint']}, 06:51:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:51:38 INFO - 'ts_paint', 06:51:38 INFO - 'tpaint', 06:51:38 INFO - 'sessionrestore', 06:51:38 INFO - 'sessionrestore_no_auto_restore', 06:51:38 INFO - 'tabpaint']}, 06:51:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:51:38 INFO - 'ts_paint', 06:51:38 INFO - 'tpaint', 06:51:38 INFO - 'sessionrestore', 06:51:38 INFO - 'sessionrestore_no_auto_restore', 06:51:38 INFO - 'tabpaint']}, 06:51:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:51:38 INFO - 'tests': ['a11yr', 06:51:38 INFO - 'ts_paint', 06:51:38 INFO - 'tpaint', 06:51:38 INFO - 'sessionrestore', 06:51:38 INFO - 'sessionrestore_no_auto_restore', 06:51:38 INFO - 'tabpaint']}, 06:51:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:51:38 INFO - 'tests': ['a11yr', 06:51:38 INFO - 'ts_paint', 06:51:38 INFO - 'tpaint', 06:51:38 INFO - 'sessionrestore', 06:51:38 INFO - 'sessionrestore_no_auto_restore', 06:51:38 INFO - 'tabpaint']}, 06:51:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:51:38 INFO - 'tests': ['tsvgx', 06:51:38 INFO - 'tsvgr_opacity', 06:51:38 INFO - 'tart', 06:51:38 INFO - 'tscrollx', 06:51:38 INFO - 'cart', 06:51:38 INFO - 'tsvg_static']}, 06:51:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:51:38 INFO - 'tsvgr_opacity', 06:51:38 INFO - 'tart', 06:51:38 INFO - 'tscrollx', 06:51:38 INFO - 'cart', 06:51:38 INFO - 'tsvg_static']}, 06:51:38 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 06:51:38 INFO - 'talos_options': ['--disable-e10s'], 06:51:38 INFO - 'tests': ['tp5o']}, 06:51:38 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:51:38 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 06:51:38 INFO - 'talos_options': ['--disable-e10s', 06:51:38 INFO - '--xperf_path', 06:51:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:51:38 INFO - 'tests': ['tp5n']}, 06:51:38 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:51:38 INFO - 'talos_options': ['--xperf_path', 06:51:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:51:38 INFO - 'tests': ['tp5n']}}, 06:51:38 INFO - 'talos.zip': {'path': '', 06:51:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:51:38 INFO - Running post-action listener: _resource_record_post_action 06:51:38 INFO - [mozharness: 2017-03-20 13:51:38.474684Z] Finished populate-webroot step (success) 06:51:38 INFO - [mozharness: 2017-03-20 13:51:38.474812Z] Running create-virtualenv step. 06:51:38 INFO - Running pre-action listener: _resource_record_pre_action 06:51:38 INFO - Running main action method: create_virtualenv 06:51:38 INFO - Creating virtualenv /builds/slave/test/build/venv 06:51:38 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 06:51:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:51:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:51:38 INFO - Using real prefix '/tools/python27' 06:51:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:51:39 INFO - Installing distribute.............................................................................................................................................................................................done. 06:51:42 INFO - Installing pip.................done. 06:51:42 INFO - Return code: 0 06:51:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:51:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:51:42 INFO - Reading from file tmpfile_stdout 06:51:42 INFO - Output received: 06:51:42 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) 06:51:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:51:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:51:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:51:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:42 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 0x10beb9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bebc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff368cd6290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc97d30>, '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 0x10bbbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc8cbe8>, '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.59bVaWKRG9/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.UX6SjBjEhC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 06:51:42 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 06:51:42 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 06:51:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.59bVaWKRG9/Render', 06:51:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:51:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:51:42 INFO - 'HOME': '/Users/cltbld', 06:51:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:51:42 INFO - 'LOGNAME': 'cltbld', 06:51:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:42 INFO - 'MOZ_NO_REMOTE': '1', 06:51:42 INFO - 'NO_EM_RESTART': '1', 06:51:42 INFO - 'PAGER': '/bin/cat', 06:51:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:51:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:42 INFO - 'PWD': '/builds/slave/test', 06:51:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:51:42 INFO - 'SHELL': '/bin/bash', 06:51:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UX6SjBjEhC/Listeners', 06:51:42 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 06:51:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:51:42 INFO - 'USER': 'cltbld', 06:51:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:51:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:51:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:42 INFO - 'XPC_FLAGS': '0x0', 06:51:42 INFO - 'XPC_SERVICE_NAME': '0', 06:51:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:51:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:42 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 06:51:42 INFO - Cleaning up... 06:51:42 INFO - Return code: 0 06:51:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:51:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:51:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:51:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:42 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 0x10beb9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bebc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff368cd6290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc97d30>, '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 0x10bbbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc8cbe8>, '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.59bVaWKRG9/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.UX6SjBjEhC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 06:51:42 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 06:51:42 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 06:51:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.59bVaWKRG9/Render', 06:51:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:51:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:51:42 INFO - 'HOME': '/Users/cltbld', 06:51:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:51:42 INFO - 'LOGNAME': 'cltbld', 06:51:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:42 INFO - 'MOZ_NO_REMOTE': '1', 06:51:42 INFO - 'NO_EM_RESTART': '1', 06:51:42 INFO - 'PAGER': '/bin/cat', 06:51:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:51:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:42 INFO - 'PWD': '/builds/slave/test', 06:51:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:51:42 INFO - 'SHELL': '/bin/bash', 06:51:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UX6SjBjEhC/Listeners', 06:51:42 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 06:51:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:51:42 INFO - 'USER': 'cltbld', 06:51:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:51:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:51:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:42 INFO - 'XPC_FLAGS': '0x0', 06:51:42 INFO - 'XPC_SERVICE_NAME': '0', 06:51:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:51:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:43 INFO - Downloading/unpacking psutil>=3.1.1 06:51:43 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 06:51:43 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 06:51:43 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 06:51:43 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 06:51:43 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 06:51:43 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 06:51:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:51:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:51:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:51:46 INFO - Installing collected packages: psutil 06:51:46 INFO - Running setup.py install for psutil 06:51:46 INFO - building 'psutil._psutil_osx' extension 06:51:46 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 06:51:47 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 06:51:47 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 06:51:47 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 06:51:47 INFO - building 'psutil._psutil_posix' extension 06:51:47 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 06:51:47 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:51:47 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:51:47 INFO - ^ 06:51:47 INFO - 1 warning generated. 06:51:47 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 06:51:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:51:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:51:47 INFO - Successfully installed psutil 06:51:47 INFO - Cleaning up... 06:51:47 INFO - Return code: 0 06:51:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:51:47 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')]} 06:51:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:47 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')]} 06:51:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:47 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 0x10beb9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bebc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff368cd6290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc97d30>, '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 0x10bbbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc8cbe8>, '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.59bVaWKRG9/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.UX6SjBjEhC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 06:51:47 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 06:51:47 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 06:51:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.59bVaWKRG9/Render', 06:51:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:51:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:51:47 INFO - 'HOME': '/Users/cltbld', 06:51:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:51:47 INFO - 'LOGNAME': 'cltbld', 06:51:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:47 INFO - 'MOZ_NO_REMOTE': '1', 06:51:47 INFO - 'NO_EM_RESTART': '1', 06:51:47 INFO - 'PAGER': '/bin/cat', 06:51:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:51:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:47 INFO - 'PWD': '/builds/slave/test', 06:51:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:51:47 INFO - 'SHELL': '/bin/bash', 06:51:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UX6SjBjEhC/Listeners', 06:51:47 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 06:51:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:51:47 INFO - 'USER': 'cltbld', 06:51:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:51:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:51:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:47 INFO - 'XPC_FLAGS': '0x0', 06:51:47 INFO - 'XPC_SERVICE_NAME': '0', 06:51:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:51:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:51:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:51:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:51:51 INFO - Installing collected packages: mozsystemmonitor 06:51:51 INFO - Running setup.py install for mozsystemmonitor 06:51:51 INFO - Successfully installed mozsystemmonitor 06:51:51 INFO - Cleaning up... 06:51:51 INFO - Return code: 0 06:51:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:51:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:51:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:51 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 0x10beb9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bebc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff368cd6290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc97d30>, '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 0x10bbbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc8cbe8>, '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.59bVaWKRG9/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.UX6SjBjEhC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 06:51:51 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 06:51:51 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 06:51:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.59bVaWKRG9/Render', 06:51:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:51:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:51:51 INFO - 'HOME': '/Users/cltbld', 06:51:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:51:51 INFO - 'LOGNAME': 'cltbld', 06:51:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:51 INFO - 'MOZ_NO_REMOTE': '1', 06:51:51 INFO - 'NO_EM_RESTART': '1', 06:51:51 INFO - 'PAGER': '/bin/cat', 06:51:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:51:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:51 INFO - 'PWD': '/builds/slave/test', 06:51:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:51:51 INFO - 'SHELL': '/bin/bash', 06:51:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UX6SjBjEhC/Listeners', 06:51:51 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 06:51:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:51:51 INFO - 'USER': 'cltbld', 06:51:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:51:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:51:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:51 INFO - 'XPC_FLAGS': '0x0', 06:51:51 INFO - 'XPC_SERVICE_NAME': '0', 06:51:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:51:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:52 INFO - Downloading/unpacking jsonschema==2.5.1 06:51:52 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 06:51:52 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 06:51:52 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 06:51:52 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 06:51:52 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 06:51:52 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 06:51:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:51:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:51:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:54 INFO - Downloading functools32-3.2.3-2.tar.gz 06:51:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:51:55 INFO - warning: no files found matching '*.txt' 06:51:55 INFO - no previously-included directories found matching 'build' 06:51:55 INFO - no previously-included directories found matching 'dist' 06:51:55 INFO - no previously-included directories found matching '.git*' 06:51:55 INFO - Installing collected packages: jsonschema, functools32 06:51:55 INFO - Running setup.py install for functools32 06:51:55 INFO - warning: no files found matching '*.txt' 06:51:55 INFO - no previously-included directories found matching 'build' 06:51:55 INFO - no previously-included directories found matching 'dist' 06:51:55 INFO - no previously-included directories found matching '.git*' 06:51:55 INFO - Successfully installed jsonschema functools32 06:51:55 INFO - Cleaning up... 06:51:55 INFO - Return code: 0 06:51:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:51:55 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')]} 06:51:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:55 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')]} 06:51:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:55 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 0x10beb9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bebc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff368cd6290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc97d30>, '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 0x10bbbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc8cbe8>, '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.59bVaWKRG9/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.UX6SjBjEhC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 06:51:55 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 06:51:55 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 06:51:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.59bVaWKRG9/Render', 06:51:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:51:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:51:55 INFO - 'HOME': '/Users/cltbld', 06:51:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:51:55 INFO - 'LOGNAME': 'cltbld', 06:51:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:55 INFO - 'MOZ_NO_REMOTE': '1', 06:51:55 INFO - 'NO_EM_RESTART': '1', 06:51:55 INFO - 'PAGER': '/bin/cat', 06:51:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:51:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:55 INFO - 'PWD': '/builds/slave/test', 06:51:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:51:55 INFO - 'SHELL': '/bin/bash', 06:51:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UX6SjBjEhC/Listeners', 06:51:55 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 06:51:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:51:55 INFO - 'USER': 'cltbld', 06:51:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:51:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:51:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:55 INFO - 'XPC_FLAGS': '0x0', 06:51:55 INFO - 'XPC_SERVICE_NAME': '0', 06:51:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:51:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:51:55 INFO - Cleaning up... 06:51:55 INFO - Return code: 0 06:51:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:51:55 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')]} 06:51:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:55 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')]} 06:51:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:55 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 0x10beb9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bebc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff368cd6290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc97d30>, '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 0x10bbbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc8cbe8>, '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.59bVaWKRG9/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.UX6SjBjEhC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 06:51:55 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 06:51:55 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 06:51:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.59bVaWKRG9/Render', 06:51:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:51:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:51:55 INFO - 'HOME': '/Users/cltbld', 06:51:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:51:55 INFO - 'LOGNAME': 'cltbld', 06:51:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:55 INFO - 'MOZ_NO_REMOTE': '1', 06:51:55 INFO - 'NO_EM_RESTART': '1', 06:51:55 INFO - 'PAGER': '/bin/cat', 06:51:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:51:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:55 INFO - 'PWD': '/builds/slave/test', 06:51:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:51:55 INFO - 'SHELL': '/bin/bash', 06:51:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UX6SjBjEhC/Listeners', 06:51:55 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 06:51:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:51:55 INFO - 'USER': 'cltbld', 06:51:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:51:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:51:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:55 INFO - 'XPC_FLAGS': '0x0', 06:51:55 INFO - 'XPC_SERVICE_NAME': '0', 06:51:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:51:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:55 INFO - Downloading/unpacking blobuploader==1.2.4 06:51:55 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 06:51:55 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 06:51:55 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 06:51:55 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 06:51:55 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 06:51:55 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 06:51:58 INFO - Downloading blobuploader-1.2.4.tar.gz 06:51:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:51:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:51:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:51:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:51:59 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 06:51:59 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 06:51:59 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 06:51:59 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 06:51:59 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 06:51:59 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 06:51:59 INFO - Downloading docopt-0.6.1.tar.gz 06:51:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:51:59 INFO - Installing collected packages: blobuploader, requests, docopt 06:51:59 INFO - Running setup.py install for blobuploader 06:51:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:51:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:51:59 INFO - Running setup.py install for requests 06:52:00 INFO - Running setup.py install for docopt 06:52:00 INFO - Successfully installed blobuploader requests docopt 06:52:00 INFO - Cleaning up... 06:52:00 INFO - Return code: 0 06:52:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:52:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:52:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:52:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:00 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 0x10beb9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bebc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff368cd6290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc97d30>, '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 0x10bbbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc8cbe8>, '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.59bVaWKRG9/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.UX6SjBjEhC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 06:52:00 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 06:52:00 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 06:52:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.59bVaWKRG9/Render', 06:52:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:52:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:52:00 INFO - 'HOME': '/Users/cltbld', 06:52:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:52:00 INFO - 'LOGNAME': 'cltbld', 06:52:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:00 INFO - 'MOZ_NO_REMOTE': '1', 06:52:00 INFO - 'NO_EM_RESTART': '1', 06:52:00 INFO - 'PAGER': '/bin/cat', 06:52:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:52:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:52:00 INFO - 'PWD': '/builds/slave/test', 06:52:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:52:00 INFO - 'SHELL': '/bin/bash', 06:52:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UX6SjBjEhC/Listeners', 06:52:00 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 06:52:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:52:00 INFO - 'USER': 'cltbld', 06:52:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:52:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:52:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:00 INFO - 'XPC_FLAGS': '0x0', 06:52:00 INFO - 'XPC_SERVICE_NAME': '0', 06:52:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:52:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:52:00 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-lXEPKB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:52:01 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-fM7J2C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:52:01 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-b52riX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:52:01 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-HcsACC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:52:01 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-6NkVMC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:52:01 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-9Dne8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:52:01 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-MlIkJ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:52:01 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-Pdxgnn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:52:01 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-bB8Ih5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:52:01 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-nclKrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:52:02 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-Kd0136-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:52:02 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-gjN1Nw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:52:02 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-sh2EM2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:52:02 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-ITK8LV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:52:02 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-3tcMOR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:52:02 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-r_ZA8Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:52:02 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-zttvkf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:52:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:52:02 INFO - Running setup.py install for manifestparser 06:52:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:52:02 INFO - Running setup.py install for mozcrash 06:52:03 INFO - Running setup.py install for mozdebug 06:52:03 INFO - Running setup.py install for mozdevice 06:52:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:52:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:52:03 INFO - Running setup.py install for mozfile 06:52:03 INFO - Running setup.py install for mozhttpd 06:52:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:52:03 INFO - Running setup.py install for mozinfo 06:52:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:52:03 INFO - Running setup.py install for mozInstall 06:52:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:52:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:52:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:52:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:52:03 INFO - Running setup.py install for mozleak 06:52:04 INFO - Running setup.py install for mozlog 06:52:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:52:04 INFO - Running setup.py install for moznetwork 06:52:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:52:04 INFO - Running setup.py install for mozprocess 06:52:04 INFO - Running setup.py install for mozprofile 06:52:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:52:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:52:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:52:04 INFO - Running setup.py install for mozrunner 06:52:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:52:04 INFO - Running setup.py install for mozscreenshot 06:52:05 INFO - Running setup.py install for moztest 06:52:05 INFO - Running setup.py install for mozversion 06:52:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:52:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:52:05 INFO - Cleaning up... 06:52:05 INFO - Return code: 0 06:52:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:52:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:52:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:52:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:05 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 0x10beb9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bebc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff368cd6290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc97d30>, '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 0x10bbbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc8cbe8>, '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.59bVaWKRG9/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.UX6SjBjEhC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 06:52:05 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 06:52:05 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 06:52:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.59bVaWKRG9/Render', 06:52:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:52:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:52:05 INFO - 'HOME': '/Users/cltbld', 06:52:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:52:05 INFO - 'LOGNAME': 'cltbld', 06:52:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:05 INFO - 'MOZ_NO_REMOTE': '1', 06:52:05 INFO - 'NO_EM_RESTART': '1', 06:52:05 INFO - 'PAGER': '/bin/cat', 06:52:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:52:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:52:05 INFO - 'PWD': '/builds/slave/test', 06:52:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:52:05 INFO - 'SHELL': '/bin/bash', 06:52:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UX6SjBjEhC/Listeners', 06:52:05 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 06:52:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:52:05 INFO - 'USER': 'cltbld', 06:52:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:52:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:52:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:05 INFO - 'XPC_FLAGS': '0x0', 06:52:05 INFO - 'XPC_SERVICE_NAME': '0', 06:52:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:52:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:52:05 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-rswUB9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:52:05 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)) 06:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:52:05 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-cQmOeJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:52:05 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)) 06:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:52:05 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-Zn0gPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:52:05 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)) 06:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:52:05 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-GIP2bN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:52:06 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)) 06:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:52:06 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-wjq5hQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:52:06 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)) 06:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:52:06 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-CJD3as-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:52:06 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)) 06:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:52:06 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-KDa1OM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:52:06 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)) 06:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:52:06 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-2MxAWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:52:06 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)) 06:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:52:06 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-ULIWNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:52:06 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)) 06:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:52:06 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-p8QmfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:52:06 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)) 06:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:52:06 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-1HsDoj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:52:06 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)) 06:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:52:06 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-Mcxmtv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:52:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:52:06 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-Rzwq4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:52:06 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)) 06:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:52:07 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-DcVmod-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:52:07 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)) 06:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:52:07 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-ea5byK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:52:07 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)) 06:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:52:07 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-5IT8aB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:52:07 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)) 06:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:52:07 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-bZ3IvI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:52:07 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)) 06:52:07 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)) 06:52:07 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)) 06:52:07 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)) 06:52:07 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)) 06:52:07 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)) 06:52:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:52:07 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 06:52:07 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 06:52:07 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 06:52:07 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 06:52:07 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 06:52:07 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 06:52:10 INFO - Downloading blessings-1.6.tar.gz 06:52:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:52:10 INFO - Installing collected packages: blessings 06:52:10 INFO - Running setup.py install for blessings 06:52:10 INFO - Successfully installed blessings 06:52:10 INFO - Cleaning up... 06:52:10 INFO - Return code: 0 06:52:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:52:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:52:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:52:10 INFO - Reading from file tmpfile_stdout 06:52:10 INFO - Current package versions: 06:52:10 INFO - blessings == 1.6 06:52:10 INFO - blobuploader == 1.2.4 06:52:10 INFO - docopt == 0.6.1 06:52:10 INFO - functools32 == 3.2.3-2 06:52:10 INFO - jsonschema == 2.5.1 06:52:10 INFO - manifestparser == 1.1 06:52:10 INFO - mozInstall == 1.12 06:52:10 INFO - mozcrash == 1.0 06:52:10 INFO - mozdebug == 0.1 06:52:10 INFO - mozdevice == 0.49 06:52:10 INFO - mozfile == 1.2 06:52:10 INFO - mozhttpd == 0.7 06:52:10 INFO - mozinfo == 0.9 06:52:10 INFO - mozleak == 0.1 06:52:10 INFO - mozlog == 3.4 06:52:10 INFO - moznetwork == 0.27 06:52:10 INFO - mozprocess == 0.25 06:52:10 INFO - mozprofile == 0.28 06:52:10 INFO - mozrunner == 6.13 06:52:10 INFO - mozscreenshot == 0.1 06:52:10 INFO - mozsystemmonitor == 0.3 06:52:10 INFO - moztest == 0.8 06:52:10 INFO - mozversion == 1.4 06:52:10 INFO - psutil == 3.1.1 06:52:10 INFO - requests == 1.2.3 06:52:10 INFO - wsgiref == 0.1.2 06:52:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:52:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:52:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:52:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:10 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 0x10beb9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bebc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff368cd6290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc97d30>, '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 0x10bbbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc8cbe8>, '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.59bVaWKRG9/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.UX6SjBjEhC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 06:52:10 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 06:52:10 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 06:52:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.59bVaWKRG9/Render', 06:52:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:52:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:52:10 INFO - 'HOME': '/Users/cltbld', 06:52:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:52:10 INFO - 'LOGNAME': 'cltbld', 06:52:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:10 INFO - 'MOZ_NO_REMOTE': '1', 06:52:10 INFO - 'NO_EM_RESTART': '1', 06:52:10 INFO - 'PAGER': '/bin/cat', 06:52:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:52:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:52:10 INFO - 'PWD': '/builds/slave/test', 06:52:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:52:10 INFO - 'SHELL': '/bin/bash', 06:52:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UX6SjBjEhC/Listeners', 06:52:10 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 06:52:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:52:10 INFO - 'USER': 'cltbld', 06:52:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:52:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:52:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:10 INFO - 'XPC_FLAGS': '0x0', 06:52:10 INFO - 'XPC_SERVICE_NAME': '0', 06:52:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:52:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:11 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)) 06:52:11 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)) 06:52:11 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)) 06:52:11 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)) 06:52:11 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)) 06:52:11 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)) 06:52:11 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)) 06:52:11 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)) 06:52:11 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)) 06:52:11 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)) 06:52:11 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)) 06:52:11 INFO - Cleaning up... 06:52:11 INFO - Return code: 0 06:52:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:52: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')]} 06:52:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52: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')]} 06:52:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:11 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 0x10beb9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bebc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff368cd6290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc97d30>, '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 0x10bbbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc8cbe8>, '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.59bVaWKRG9/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.UX6SjBjEhC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 06:52:11 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 06:52:11 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 06:52:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.59bVaWKRG9/Render', 06:52:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:52:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:52:11 INFO - 'HOME': '/Users/cltbld', 06:52:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:52:11 INFO - 'LOGNAME': 'cltbld', 06:52:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:11 INFO - 'MOZ_NO_REMOTE': '1', 06:52:11 INFO - 'NO_EM_RESTART': '1', 06:52:11 INFO - 'PAGER': '/bin/cat', 06:52:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:52:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:52:11 INFO - 'PWD': '/builds/slave/test', 06:52:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:52:11 INFO - 'SHELL': '/bin/bash', 06:52:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UX6SjBjEhC/Listeners', 06:52:11 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 06:52:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:52:11 INFO - 'USER': 'cltbld', 06:52:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:52:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:52:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:11 INFO - 'XPC_FLAGS': '0x0', 06:52:11 INFO - 'XPC_SERVICE_NAME': '0', 06:52:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:52:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:52:11 INFO - Cleaning up... 06:52:11 INFO - Return code: 0 06:52:11 INFO - Running post-action listener: _resource_record_post_action 06:52:11 INFO - Running post-action listener: _start_resource_monitoring 06:52:11 INFO - Starting resource monitoring. 06:52:11 INFO - [mozharness: 2017-03-20 13:52:11.323500Z] Finished create-virtualenv step (success) 06:52:11 INFO - [mozharness: 2017-03-20 13:52:11.324459Z] Running install step. 06:52:11 INFO - Running pre-action listener: _resource_record_pre_action 06:52:11 INFO - Running main action method: install 06:52:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:52:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:52:11 INFO - Reading from file tmpfile_stdout 06:52:11 INFO - Detecting whether we're running mozinstall >=1.0... 06:52:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:52:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:52:11 INFO - Reading from file tmpfile_stdout 06:52:11 INFO - Output received: 06:52:11 INFO - Usage: mozinstall [options] installer 06:52:11 INFO - Options: 06:52:11 INFO - -h, --help show this help message and exit 06:52:11 INFO - -d DEST, --destination=DEST 06:52:11 INFO - Directory to install application into. [default: 06:52:11 INFO - "/builds/slave/test"] 06:52:11 INFO - --app=APP Application being installed. [default: firefox] 06:52:11 INFO - mkdir: /builds/slave/test/build/application 06:52:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:52:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 06:52:32 INFO - Reading from file tmpfile_stdout 06:52:32 INFO - Output received: 06:52:32 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:52:32 INFO - Running post-action listener: _resource_record_post_action 06:52:32 INFO - [mozharness: 2017-03-20 13:52:32.033120Z] Finished install step (success) 06:52:32 INFO - [mozharness: 2017-03-20 13:52:32.033283Z] Running run-tests step. 06:52:32 INFO - Running pre-action listener: _resource_record_pre_action 06:52:32 INFO - Running main action method: run_tests 06:52:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:52:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:52:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:52:32 INFO - 2017-03-20 06:52:32.047 screenresolution[1620:7385] starting screenresolution argv=screenresolution get 06:52:32 INFO - 2017-03-20 06:52:32.050 screenresolution[1620:7385] Display 0: 1600x1200x32@60 06:52:32 INFO - 2017-03-20 06:52:32.056 screenresolution[1621:7388] starting screenresolution argv=screenresolution list 06:52:32 INFO - Available Modes on Display 0 06:52:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:52:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:52:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:52:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:52:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:52:32 INFO - Intel Iris: 06:52:32 INFO - Chipset Model: Intel Iris 06:52:32 INFO - Type: GPU 06:52:32 INFO - Bus: Built-In 06:52:32 INFO - VRAM (Dynamic, Max): 1536 MB 06:52:32 INFO - Vendor: Intel (0x8086) 06:52:32 INFO - Device ID: 0x0a2e 06:52:32 INFO - Revision ID: 0x0009 06:52:32 INFO - Displays: 06:52:32 INFO - Display: 06:52:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:52:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:52:32 INFO - Display Serial Number: 1600x1200 60 06:52:32 INFO - Main Display: Yes 06:52:32 INFO - Mirror: Off 06:52:32 INFO - Online: Yes 06:52:32 INFO - Rotation: Supported 06:52:32 INFO - Return code: 0 06:52:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:52:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:52:32 INFO - Python 2.7.3 06:52:32 INFO - Return code: 0 06:52:32 INFO - grabbing minidump binary from tooltool 06:52:32 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')]} 06:52:32 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 0x10bc97d30>, '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 0x10bbbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc8cbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:52:32 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 06:52:32 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 06:52:32 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 06:52:32 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:52:32 INFO - Return code: 0 06:52:32 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:52:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:52:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:52:32 INFO - ENV: RUST_BACKTRACE is now 1 06:52:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:52:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:52:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XtmM43fGSC6xnOXI8chh7Q/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0010', '--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 06:52:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XtmM43fGSC6xnOXI8chh7Q/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0010 --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 06:52:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.59bVaWKRG9/Render', 06:52:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:52:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:52:32 INFO - 'HOME': '/Users/cltbld', 06:52:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:52:32 INFO - 'LOGNAME': 'cltbld', 06:52:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:52:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:52:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:32 INFO - 'MOZ_NO_REMOTE': '1', 06:52:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:52:32 INFO - 'NO_EM_RESTART': '1', 06:52:32 INFO - 'PAGER': '/bin/cat', 06:52:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:52:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:52:32 INFO - 'PWD': '/builds/slave/test', 06:52:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:52:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:52:32 INFO - 'RUST_BACKTRACE': '1', 06:52:32 INFO - 'SHELL': '/bin/bash', 06:52:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UX6SjBjEhC/Listeners', 06:52:32 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 06:52:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:52:32 INFO - 'USER': 'cltbld', 06:52:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:52:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:52:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:32 INFO - 'XPC_FLAGS': '0x0', 06:52:32 INFO - 'XPC_SERVICE_NAME': '0', 06:52:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:52:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XtmM43fGSC6xnOXI8chh7Q/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0010', '--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 06:52:32 INFO - mozversion application_buildid: 20170320050941 06:52:32 INFO - mozversion application_changeset: cb4e80abb488f37ec67c4760a128ae177697667b 06:52:32 INFO - mozversion application_display_name: Nightly 06:52:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:52:32 INFO - mozversion application_name: Firefox 06:52:32 INFO - mozversion application_remotingname: firefox 06:52:32 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:52:32 INFO - mozversion application_vendor: Mozilla 06:52:32 INFO - mozversion application_version: 55.0a1 06:52:32 INFO - mozversion platform_buildid: 20170320050941 06:52:32 INFO - mozversion platform_changeset: cb4e80abb488f37ec67c4760a128ae177697667b 06:52:32 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:52:32 INFO - mozversion platform_version: 55.0a1 06:52:32 INFO - using testdate: 1490017952 06:52:32 INFO - actual date: 1490017952 06:52:32 INFO - starting webserver on 'localhost:49241' 06:52:32 INFO - SUITE-START | Running 2 tests 06:52:32 INFO - TEST-START | dromaeo_css 06:52:32 INFO - operating with platform_type : mac_ 06:52:32 INFO - Initialising browser for dromaeo_css test... 06:52:32 INFO - TEST-INFO | started process 1631 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/tmpVcfT1Q/profile http://localhost:49241/getInfo.html) 06:52:35 INFO - PID 1631 | 2017-03-20 06:52:35.562 plugin-container[1633:7569] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d3f, name = 'com.apple.tsm.portname' 06:52:35 INFO - PID 1631 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:52:35 INFO - PID 1631 | 2017-03-20 06:52:35.565 plugin-container[1633:7569] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x930b, name = 'com.apple.CFPasteboardClient' 06:52:35 INFO - PID 1631 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:52:35 INFO - PID 1631 | 2017-03-20 06:52:35.565 plugin-container[1633:7569] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:52:35 INFO - PID 1631 | __metrics Screen width/height:1600/1200 06:52:35 INFO - PID 1631 | colorDepth:24 06:52:35 INFO - PID 1631 | Browser inner width/height: 1024/689 06:52:35 INFO - PID 1631 | __metrics 06:52:35 ERROR - PID 1631 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 06:52:36 INFO - TEST-INFO | 1631: exit 0 06:52:36 INFO - Browser initialized. 06:52:36 INFO - Running cycle 1/1 for dromaeo_css test... 06:52:36 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/tmpVcfT1Q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:52:39 INFO - PID 1634 | 2017-03-20 06:52:39.162 plugin-container[1635:7711] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 06:52:39 INFO - PID 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:52:39 INFO - PID 1634 | 2017-03-20 06:52:39.163 plugin-container[1635:7711] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 06:52:39 INFO - PID 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:52:39 INFO - PID 1634 | 2017-03-20 06:52:39.163 plugin-container[1635:7711] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:52:48 INFO - PID 1634 | RSS: Main: 227008512 06:52:48 INFO - PID 1634 | 06:55:52 INFO - PID 1634 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 06:55:53 INFO - PID 1634 | RSS: Main: 250425344 06:55:53 INFO - PID 1634 | 06:57:36 INFO - PID 1634 | ************************* 06:57:36 INFO - PID 1634 | A coding exception was thrown and uncaught in a Task. 06:57:36 INFO - PID 1634 | 06:57:36 ERROR - PID 1634 | Full message: TypeError: NetworkError when attempting to fetch resource. 06:57:36 INFO - PID 1634 | Full stack: 06:57:36 INFO - PID 1634 | ************************* 06:58:56 INFO - PID 1634 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 06:58:56 INFO - PID 1634 | RSS: Main: 259203072 06:58:56 INFO - PID 1634 | 07:01:58 INFO - PID 1634 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 07:01:59 INFO - PID 1634 | RSS: Main: 270671872 07:01:59 INFO - PID 1634 | 07:05:01 INFO - PID 1634 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 07:05:02 INFO - PID 1634 | RSS: Main: 263475200 07:05:02 INFO - PID 1634 | 07:08:05 INFO - PID 1634 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 07:08:05 INFO - PID 1634 | RSS: Main: 273170432 07:08:05 INFO - PID 1634 | 07:11:08 INFO - PID 1634 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 07:11:08 INFO - PID 1634 | RSS: Main: 266948608 07:11:08 INFO - PID 1634 | 07:11:08 INFO - PID 1634 | __start_tp_report 07:11:08 INFO - PID 1634 | _x_x_mozilla_page_load 07:11:08 INFO - PID 1634 | _x_x_mozilla_page_load_details 07:11:08 INFO - PID 1634 | |i|pagename|runs| 07:11:08 INFO - PID 1634 | |0;dojo.html;3425.725941924646;3430.4511278195478;3479.6520347965193;3507.0355652195644;3511.3855075361807;4269.295566231568;5701.600887937846;5708.9438453886005;5874.089516125002;5875.236219291492;5734.885302293952;5833.445822646852;5882.264716910387;5940.910886336708;5997.820065398045;5288.15389537674;5290.761915713802;5292.708901010462;5340.25236466895;5414.269073675063;5232.659877107995;5340.279062326595;5394.32570928634;5457.754401051962;5462.317210348707;5269.367675878881;5330;5351.384590772072;5353.946460535403;5361.571074314084;5306.177542480922;5306.893862122736;5315.6013299002725;5324.8136315228785;5345.224942383333;5237.711925844077;5261.86845328866;5274.472552744734;5290.497402746733;5308.973455132699;5670.716464176775;5703.74333155009;5731.197632331477;5810.360860305363;5828.941710582924;6301.684915754194;6316.494680425555;6321.24145102586;6326.08271800591;6339.175907132089;5935.347111817697;5976.970115149396;6311.93688063118;6324.241091069055;6332.778352757631;5021.799128034874;5842.59101862874;5916.171735956969;6038.486728628028;6067.302260240041;5496.560275178056;6365.745370185234;6420.133282006869;6465.321141280192;6468.611883287018;5629.127485239795;5647.519960803295;6107.4197951194565;6208.875822483525;6223.533235007392;5213.348331458567;5335.759890804923;6215.751369945152;6260.154879091356;6268.404501572343;6263.6241825490615;6287.96856015717;6290.308066112724;6291.307956124822;6305.243370795442;6142.959235178615;6148.739508400767;6217.906731399033;6236.158118654014;6248.28144763349;5134.178531435027;5148.227765835155;5151.6136289778415;5167.689938603696;5178.482151784867;3879.612038796154;4580.152671755736;4589.862304130881;4608.792604332813;4625.098105869323;5952.583319167703;6017.308009578867;6035.034394496859;6048.334683184846;6192.566520343533;6256;6336;6337.936620633827;6343.873122537523;6388.488920886318;6086.756529738761;6175.62946223219;6180.134781130645;6197;6208.72060757267;5535.944640553543;5678.0915053591225;5692.857678557986;5711.857203569944;5726.255586773693;6402.359764023654;6579.243387010363;6661.433778128913;6666.500012498985;6667.299933506912;6321.209848768904;6329.715162817776;6334.588251763621;6347.174867267226;6371.585846919936;6528.967355163194;6600.471962242913;6617.702203400762;6640.335966403321;6651.600903945779;5020.47285035066;5336.546393556436;6198.6280823150755;6267.4986001120715;6278.623282603058;6304.527160463075;6340.30256671775;6344.619322840645;6354.618722876642;6363.427291543598;6109.222480666275;6111.174991376108;6145.938540614537;6297.96851015742;6312.968435157794;4917.508249175054;5162.251473536241;6012.518998480024;6118.040554665315;6302.968485157545;5172.948270517247;5904.350521442552;6043.848903777441;6086.817395478142;6099.4815440688035;6086.421789929949;6136.1821086261625;6145.187169785014;6185.567010309235;6198.0702894566175;6073.180120683651;6104.913929256043;6142.928535732134;6147.0022242772175;6194.5354098443695 07:11:08 INFO - PID 1634 | |1;ext.html;646.6508085633758;687.5565260407037;781.7146741439376;912.197266405563;917.6696389299851;29246;38413.80793096034;38430.423543646866;38447.423288650694;38482;36976;37378.8131059345;37399.25201495968;37429.06427339318;37553.62446375542;7512.173660897297;8867.24628406583;10608.522616482238;10778;10824.621138260163;10782.353058816496;10854.45727713615;10920.453977301142;10921.563137474532;10945.671629851078;10930.180236482256;11007.834882476769;11014.339139651647;11021.283616564937;11029.889701103006;9068.909310906905;10915.672529824118;10949.233553651247;10965.287256328313;10987.340759554372;8850.159234872677;10686;10765.354078755221;10780.137588992862;10796.298240614335;37759.81120094382;38205;38255.42616860749;38276;38324;3759.642833930772;3800.3539398302078;3807.676347510465;3832.8658496952753;3833.6358045985585;26843.92624295026;27773.583396249072;27824.30439239015;27948;27953.580696289573;3065.7700672449655;3092.304231547906;3103.1156120505775;3138.168385377877;3172.1752344390625;292923;310640;310657;311791;312703;49619;49757.253641194686;49819.750901245265;49830;49888;51906.70233244199;51937.220941685904;52273.47726522762;52282.215766763526;52353.120578367794;10453.797813251422;14314.642133946734;14587.854121458862;14615;14854.777178342334;11717.472713727902;11820.822687659693;11840;11866.288022718492;11879.465424055938;13486.39311230997;13671.043026988016;13692.931535342259;13773.38019789112;13861.584152475441;6009.639421634716;6058.969705151534;6078.969605151946;6086.452219300284;6097.664628445389;864.394923553515;1043.4730461117088;1066.514735795227;1084.5878566144816;1108.539955918285;21626;23806;25903.611445828326;26308.21075367742;26398.604020939318;1147.2313549921405;1197.161986609377;1199.5381778015353;1236.8515778106685;1247.9313637749829;11164.385958772345;13207.471701131846;13292.867071329356;13446.93276533611;13943.745062944383;424149;424246;428161;428371;428429;51607.48392516102;54899.72550137304;55393.67637941736;55661.721691391285;55721.885562288524;1368.0765483298733;1401.2853444743255;1401.3483730065363;1407.507372419645;1409.2953523238382;28042.2989425266;28191;28292.717072829008;28531.714682853737;28854;43429.56570434382;43774.78112609417;43965.78017110022;44033;44068.77965610279;294885;321470.57058858225;339362;365174;365560;27702.44595108127;28167.295817604725;29002.7099729;31073.53389699111;31097.689023110383;40166.397504036875;41677.79161104175;41698.374524382765;41780.58219417888;42149.52476663302;24016.799160041577;34128.39266699063;34855;35825.82087089548;36136.81931590325;34816.78141265044;34955.82522087373;35726;35818.64181358153;35975.841449513115;34376.82811586026;35234.82382588173;35302.82348588241;35886;35897.28205435824;30545.847270763505;31448.528272076393;31479.842600787764;31579.052628421185;31776.523352149274;20851;23229.41926451852;24079.879600601886;24080.686712354767;24166.637500437155 07:11:08 INFO - PID 1634 | |2;jquery.html;399.22351027252006;409.102021063765;410.2922458758642;421.6036925290227;424.63057140287935;20203.898980505095;20835.583288334245;21142;21528.246511372105;21684.674729879065;21025.158993640274;21105.366838994854;21335.359939201848;21459.785402145975;22399.776002239974;5944.464998150165;6333.334999825021;6340.904886426707;6353.459955903731;6353.777617783378;5403.459654034585;6567.441767449749;6757.560758550679;6769.221539522969;6824.112865327501;6763.66181690916;6801.387875091241;6807.965960170217;6816.556923799937;6827.69275382609;7309.159446663649;7628.351590114847;7688.231176882267;7717.189695082048;7729.995100636909;7258.129024517092;7383.2985866342615;7438.144613369478;7450.403967682572;7461.589612571306;27572.862135689193;27576;27757;27877.86061069682;28053.438931221466;2954.8965786197596;3328.866845326184;3347.41420251455;3354.3626710924846;3495.5106285120105;17068;17239.827601723948;17300.307987680477;17385.913070434566;18141.909290453594;1819.1177279019664;2043.1520918818671;2067.3694523170425;2119.088791819517;2119.4065661614773;138524;139176;158541;159388;170618.99999999875;23758.524829503658;24015;25442;26324.60513092305;26331.605025924626;41815.23662870295;41901.2288894001;42023;42087;42290.788546057076;9566.521673916277;10255.435951022617;10439.739006524898;10654.840177397346;10669.78660426787;8383.215715057935;8396.496210227406;8420.915790842135;8579.099194584478;8669.393142479967;9128.543572821332;10407.58369665205;10696.983786540422;10756.892431075588;10943;3810.1998580298446;3854.479645247912;3919.333713268751;4558.521355257716;4583.518730533313;964.5418426247477;990.5790039233441;1007.2445665750687;1037.8339465685453;1099.5589790664712;18848.05759712009;21030.738155710707;22505.774942250697;22922.65616015761;23115.53768924612;982.3221976835961;1051.0225490293947;1057.8201705710048;1089.7493576477455;1094.4527736131934;10947.4526273686;11080.279781814157;11767.23512971654;11857.051435885109;11859.288442693465;497102;504666;506721;558251;642661;129599;136546.317268415;140438.2978085103;154907;163140;1310.2007775257086;1334.9132306400054;1368.0765483298933;1369.4659082957655;1374.1274290825397;19136.808631913504;19550;21308.254211102536;21670.45823854416;21711.565768684854;56718.59688418708;61618.69190654018;61779.38220617736;63078.68460657667;63697.363026371;85764;86426.56786716027;86637;88202.11797881938;89256.553717231;11870;12325.411663550754;12392.566260181211;12632.2420654761;12745.10784245131;13961.511347102803;14001.43994240219;14162.78755818643;14414.495492657707;14429.062110962754;11718.531258749554;11745;11857.940710296394;11916.046716262505;12095.939520302694;9448.385854919408;9677.70966870995;11405.315681059163;11861.881381186078;12047.939760301142;10154.187664986932;11646.88353116458;12124.27254364741;12135.635930922086;12161.635150945485;10458.843117353397;12025.895468293189;12037.699057523281;12200.694982625506;12371.566995155126;11463.541458341573;11756.82364764512;11770.3526306054;11974.760504790029;12087 07:11:08 INFO - PID 1634 | |3;mootools.html;1517.4537166620007;1549.171193411525;1555.300114948273;1582.438234426778;1657.8093519245288;9815.754606134842;9974.501274936261;10988.120950323975;11035.172362072837;11407.973282404582;11075.778484430326;11257.774844503105;11296.15278854085;11299.03958163555;11345.546178152865;2304.285671441854;2344.566255242777;2345.2846881701075;2352.694149760529;2371.1345358944036;2261.0842608743487;2296.8392212545127;2296.9310920672406;2312.7918487336137;2314.0628045641456;2284.9200277990276;2320.1995311617466;2335.0893151670775;2335.100986120339;2343.285297984114;2283.9657405138937;2288.324944141474;2298.816109703496;2309.364924645719;2316.4324740438533;1915.2626238898124;2363.444590521226;2364.5270945810735;2364.787169154767;2371.537550177716;9769.364991275615;11110.666679999613;11298.491567879466;11301.830472542837;11373.886261137366;5744;5933.732982015819;6010;6017.638941663514;6023.066424704178;3235.207374193314;3410.9796455856153;3477.565304336958;3554.0937061049526;3555.1112221944513;1100.057622065918;1102.3716481605488;1123.8819923908036;1153.5674122204173;1174.5830230268302;14146;14326.785098223534;14989.775153372708;15018.699626007528;15130.243487825675;4523.592876641118;4632.536746325341;4761.2382018876815;4762.880927976759;4809.567138957511;11683.707907302385;11705.531778728926;11709.824352634718;11724.179307448567;11937.403129843473;5341.359036915595;5360.472265404341;5752.741126649311;5782.537397008229;5806.65160090396;5070.569001634829;5115.923261151086;5124.180131178993;5300.09898317287;5322.946770532322;3284.950725739116;3801.7834293025967;3823.8279277432584;3901.941470877939;3922.646961773397;1027.075631931268;1030.7320096774893;1034.984475232857;1044.7910417916296;1047.0942634621;915.9587818548181;936.7330310861372;943.5140902435252;943.919766819828;979.4857699707568;6455.741130479511;6500.3499650035565;6615.702293396808;6720.361565651256;6740.730370785212;949.9810003799886;964;992.7766252593253;994.2592768387598;1023.923205759571;4190.727602705814;4234.6823988201;4235.512916014636;4358.585934336233;4411.691181617256;12112;12344.197627154386;12454.003679705602;12470.314132722606;12478.81281780774;10582.671812201303;12653.36733163338;12663;12674.873251267554;12679.683007924876;8403.411761176782;9890.357126786736;10109.191264698806;10109.848352274721;10130.493475326204;5747.1379293106365;6736.865262694817;6839.179298484214;6939.201991771011;6946.270641582561;11292.548298067984;11859.703507412383;12006.159568830099;12024.098192635762;12098.03215742756;10096.495175241356;10222.795544089226;12311;12351.567695130627;12443.688907777016;8360.704090865926;8842.734717958472;9073.500957447404;9119.772005699646;9405.43567385959;8831.896012998375;8863.556822158995;10418.166546676097;10422;10428.061474467335;8949.284057275272;9290.95354523223;9329.253659707072;9334.906650933675;9408.529573521433;9004.189622933967;9026.638934442548;9035.367524273237;9054.366194366332;9085.454872707658;6643.335666433318;7906.327962123284;7985.321247694011;8086.1913808618665;8096.149904260204;5889.528837692888;5948.167256584168;5979.880402392015;6007.3992600739575;6112.113743507078;5864.67744274052;5994.70026498682;6134.877302453837;6160.907586386118;6228 07:11:08 INFO - PID 1634 | |4;prototype.html;300.2733385207797;368.78794693051486;374.3505018792393;387.7553054694429;393.80113042913314;5724.742386592603;5847.853803654911;6050.909236361458;6105.778844231149;6117.235345581802;5095.898082038357;5780.624259423134;5841.53267738581;5849.151872978416;5862.50168735658;4828.951710482894;4830.71015739055;4850.539198776129;4852.636052296092;4861.440934292566;3968.503937007874;4162.334026555752;4257.6806739494505;4723.811047558111;4780.091782561302;4453.3097369907555;4626.450139203371;4768;4768.499307572707;4810.518948105197;3488.354654388946;4802.687825291345;4818.614510839125;4823.2282834746275;4839.27410888366;3905;4083.734557253769;4105.7331273467125;4426.424564806587;4447.621952134073;4428.114377124556;4668.976655116737;5371.44856193309;5660.745266463019;5698.145278208261;5366.168243922199;5610.635308704921;5613.186088017214;5623.465770751772;5660.943390566083;5931.199288096095;5994.97002514989;6177.474914632262;6251.562390632657;6286.654234017173;4149.7095203335775;4904.632152588534;4919.606431485473;4919.827806026772;4938.185199442088;6048.667323297217;6331.493480521547;6560.179977502812;6657.167854018247;6706.731730730765;3963.841446342114;4403.772378516596;4948.208286674187;5146.794128234904;5158.174692049254;4527.61515271199;4923.8276660316715;5265.499777521206;5296;5315.521603055744;5456.863578410572;5591.161325801162;5637.238972738628;5653.660780353192;5683.346415162227;4652.092242516303;5535.944640553543;6315.684215789192;6385.659011607521;6478.514111441661;1643.926023328953;1691.112166112776;1782.4741701198177;1802.4052062819237;1803.801581825998;1062.7130674717782;1225.7364666596545;1307.5881097454271;1319.1425573377383;1343.7111021130504;4773.76131193439;5578.967890940189;5966.910496342558;5968.820935371859;6001.399860013964;6053.4854537363935;6578.868422631521;6581.734612310132;6590.80227593173;6686.933130668728;4732.219183834629;4887.266909963463;5607.859803504945;5968.641881487125;6021.638701677914;3012.894548690785;3038.3619439917425;3216.5818443602648;3443.863525036732;3462.2036931505895;6504.317046710122;6533.836654083686;6696.966515167393;6866.588004719732;6890.345417185359;6060.575759696779;6126.9387306127255;6157.538184636171;6402.711877965503;6693.431058360094;4932.67937584063;6158.7228574714245;6361.332060133805;6849.4177994871;7009.824754381181;6029.57792954489;6100.871338802336;6638.966805165944;6644.169478815148;6662;6284.937150628435;6465.450436712932;6473.838154046187;6503.642299673564;6528.738850445929;5899.321578018583;5992.760289588367;6958.652067396712;6973.3375329343635;6983.847665135196;5124.385073791169;5133.255677926754;5332.600054995968;5666.121751128581;5737.254156959735;5479.53423958952;6586.473082153512;6618.238902526078;6620.3710647488415;6643.3356664335115;5374.516293533601;6036.551227705407;6393.808185754435;6405.391487808651;6416.647084410216;5256.868578285574;6269.332440522346;6290.6529449967165;6352.36476352361;6364.331745166691;5424.9041973309895;6264.49884009269;6282.937170628235;6302.747890084345;6315.242170939517;6171.506279497719;6318.241810982711;6327.114204011534;6372.872542549216;6415.679216039272;5211.4527974562125;6207.937920620917;6236.220472440945;6266;6274.33730061525 07:11:08 INFO - PID 1634 | |5;yui.html;694.2536772969056;704.3379223529878;730.2806735365664;757.9734709285176;822.831319579486;12029.057617673405;15859.36562537497;15867.12730799807;15908.76136857948;15996.280167392466;14117.78823317651;15041.473548425807;15231.238438078079;15438.382464701399;15513.689726205497;919.2094798473324;942.6936245720134;944.1361154543584;946.6497395963469;949.2595775295281;840.3907167303717;863.9438436501607;925.5557332480413;933.5705575435308;941.1200527506803;965.4255717847869;982.1553464020936;982.8574856645782;984.6406061787468;987.5654711926729;957.129012598532;977.6529332087114;978.7944531648362;980.5244456438621;980.8871979722352;733.2960358056272;736.190190790132;736.6132780290337;736.6316841579211;738.9039424874732;16013.599660008476;16579.917100414543;16591.25339359732;16750.329986800512;17028.38230368113;14295.714085718331;14568.854311456962;14717.852821471755;14762.335694893756;14779.33492992818;11595.768084638345;11622.651320460314;11625.6512304631;11744.177907546475;11895.286282822972;3621.4748861414946;3634.509341238925;3686.1706116123923;3698.9445158322646;3810.69514438847;108784;111739;112442;113914.86085139125;114802;11212.887871121347;11275.774484510428;11524.366159861289;11565.884341156649;11941.283522988648;21759.782402176093;23710.051597936235;24366.26901192967;24775.752242477705;24898.875505622356;7808.5314881107315;7864.252895974873;7969.282764551218;8027.317677997436;8059.476134051268;4176.394422808676;4212.30496968003;4215.768132752667;4225.619694227535;4250.298700714347;3391.406503861814;3473.930521389558;3501.6148223695373;3630.2013557017412;3812.2947254757405;678.5623272988993;680.2075581947075;684.2746688510196;697.4176562570209;698.2075344484048;621.580433207583;633.94294513494;667.6728403082454;680.2857000149822;693.2686016252801;9094.954525227464;9900.356476828983;10013;10665.146788256921;10916.074858189239;524.3419508516863;564.2101058518025;569.3879079989028;584.8888711144868;623.3672822085587;4900.950990490121;4967.044608457962;4997.700137991732;4999.350084488993;5027.673201241908;91857.16285674383;94426.52786736023;94526;95956;96077;65982;84307.15692843116;84538;84892.57553712191;85049;69369.95945060728;70744;72873;74702;74764.62617686986;10038.749031274276;10251.948740256252;10748.785024299626;10781.676549703521;10875.347479151276;44517.10965780731;46604.53395466002;49370;49659.006819864124;49935.75032124816;57130.714346428;68182.31817681958;69354;69386.30613693799;70619;13102.148360356547;13364.933175334061;13458.730825383633;13781.862181378057;13822.792658109935;14493.85506144925;14508.274586270856;14557.636059098608;14592.927035364755;14993.625159371102;13304.014288059574;13355.332233388486;13493.257870817199;13495.730085398434;13554.728905422033;13306;13370.072485354296;13440.663983400493;13545.187288762705;13670;10500.789984200426;12958.219106257608;13128.934355328161;13285;13939.954503412488;10701;10839.037260124078;11024.889751102386;11737.061035117342;11902.523899043941;9337.533123343941;9529.761755956157;9620.615175392906;11010.669679909615;11342.829857552308 07:11:08 INFO - PID 1634 | __end_tp_report 07:11:08 INFO - PID 1634 | __start_cc_report 07:11:08 INFO - PID 1634 | _x_x_mozilla_cycle_collect,432 07:11:08 INFO - PID 1634 | __end_cc_report 07:11:08 INFO - PID 1634 | __startTimestamp1490019068802__endTimestamp 07:11:08 INFO - PID 1634 | 07:11:08 INFO - PID 1634 | ------- Summary: start ------- 07:11:08 INFO - PID 1634 | Number of tests: 6 07:11:08 INFO - PID 1634 | 07:11:08 INFO - PID 1634 | [#0] dojo.html Cycles:165 Average:5806.71 Median:6048.33 stddev:666.14 (11.0%) stddev-sans-first:641.46 07:11:08 INFO - PID 1634 | Values: 3425.7 3430.5 3479.7 3507.0 3511.4 4269.3 5701.6 5708.9 5874.1 5875.2 5734.9 5833.4 5882.3 5940.9 5997.8 5288.2 5290.8 5292.7 5340.3 5414.3 5232.7 5340.3 5394.3 5457.8 5462.3 5269.4 5330.0 5351.4 5353.9 5361.6 5306.2 5306.9 5315.6 5324.8 5345.2 5237.7 5261.9 5274.5 5290.5 5309.0 5670.7 5703.7 5731.2 5810.4 5828.9 6301.7 6316.5 6321.2 6326.1 6339.2 5935.3 5977.0 6311.9 6324.2 6332.8 5021.8 5842.6 5916.2 6038.5 6067.3 5496.6 6365.7 6420.1 6465.3 6468.6 5629.1 5647.5 6107.4 6208.9 6223.5 5213.3 5335.8 6215.8 6260.2 6268.4 6263.6 6288.0 6290.3 6291.3 6305.2 6143.0 6148.7 6217.9 6236.2 6248.3 5134.2 5148.2 5151.6 5167.7 5178.5 3879.6 4580.2 4589.9 4608.8 4625.1 5952.6 6017.3 6035.0 6048.3 6192.6 6256.0 6336.0 6337.9 6343.9 6388.5 6086.8 6175.6 6180.1 6197.0 6208.7 5535.9 5678.1 5692.9 5711.9 5726.3 6402.4 6579.2 6661.4 6666.5 6667.3 6321.2 6329.7 6334.6 6347.2 6371.6 6529.0 6600.5 6617.7 6640.3 6651.6 5020.5 5336.5 6198.6 6267.5 6278.6 6304.5 6340.3 6344.6 6354.6 6363.4 6109.2 6111.2 6145.9 6298.0 6313.0 4917.5 5162.3 6012.5 6118.0 6303.0 5172.9 5904.4 6043.8 6086.8 6099.5 6086.4 6136.2 6145.2 6185.6 6198.1 6073.2 6104.9 6142.9 6147.0 6194.5 07:11:08 INFO - PID 1634 | 07:11:08 INFO - PID 1634 | [#1] ext.html Cycles:180 Average:50464.82 Median:312247.00 stddev:95305.20 (30.5%) stddev-sans-first:95499.16 07:11:08 INFO - PID 1634 | Values: 646.7 687.6 781.7 912.2 917.7 29246.0 38413.8 38430.4 38447.4 38482.0 36976.0 37378.8 37399.3 37429.1 37553.6 7512.2 8867.2 10608.5 10778.0 10824.6 10782.4 10854.5 10920.5 10921.6 10945.7 10930.2 11007.8 11014.3 11021.3 11029.9 9068.9 10915.7 10949.2 10965.3 10987.3 8850.2 10686.0 10765.4 10780.1 10796.3 37759.8 38205.0 38255.4 38276.0 38324.0 3759.6 3800.4 3807.7 3832.9 3833.6 26843.9 27773.6 27824.3 27948.0 27953.6 3065.8 3092.3 3103.1 3138.2 3172.2 292923.0 310640.0 310657.0 311791.0 312703.0 49619.0 49757.3 49819.8 49830.0 49888.0 51906.7 51937.2 52273.5 52282.2 52353.1 10453.8 14314.6 14587.9 14615.0 14854.8 11717.5 11820.8 11840.0 11866.3 11879.5 13486.4 13671.0 13692.9 13773.4 13861.6 6009.6 6059.0 6079.0 6086.5 6097.7 864.4 1043.5 1066.5 1084.6 1108.5 21626.0 23806.0 25903.6 26308.2 26398.6 1147.2 1197.2 1199.5 1236.9 1247.9 11164.4 13207.5 13292.9 13446.9 13943.7 424149.0 424246.0 428161.0 428371.0 428429.0 51607.5 54899.7 55393.7 55661.7 55721.9 1368.1 1401.3 1401.3 1407.5 1409.3 28042.3 28191.0 28292.7 28531.7 28854.0 43429.6 43774.8 43965.8 44033.0 44068.8 294885.0 321470.6 339362.0 365174.0 365560.0 27702.4 28167.3 29002.7 31073.5 31097.7 40166.4 41677.8 41698.4 41780.6 42149.5 24016.8 34128.4 34855.0 35825.8 36136.8 34816.8 34955.8 35726.0 35818.6 35975.8 34376.8 35234.8 35302.8 35886.0 35897.3 30545.8 31448.5 31479.8 31579.1 31776.5 20851.0 23229.4 24079.9 24080.7 24166.6 07:11:08 INFO - PID 1634 | 07:11:08 INFO - PID 1634 | [#2] jquery.html Cycles:180 Average:37754.45 Median:21599.35 stddev:92833.51 (429.8%) stddev-sans-first:93051.57 07:11:08 INFO - PID 1634 | Values: 399.2 409.1 410.3 421.6 424.6 20203.9 20835.6 21142.0 21528.2 21684.7 21025.2 21105.4 21335.4 21459.8 22399.8 5944.5 6333.3 6340.9 6353.5 6353.8 5403.5 6567.4 6757.6 6769.2 6824.1 6763.7 6801.4 6808.0 6816.6 6827.7 7309.2 7628.4 7688.2 7717.2 7730.0 7258.1 7383.3 7438.1 7450.4 7461.6 27572.9 27576.0 27757.0 27877.9 28053.4 2954.9 3328.9 3347.4 3354.4 3495.5 17068.0 17239.8 17300.3 17385.9 18141.9 1819.1 2043.2 2067.4 2119.1 2119.4 138524.0 139176.0 158541.0 159388.0 170619.0 23758.5 24015.0 25442.0 26324.6 26331.6 41815.2 41901.2 42023.0 42087.0 42290.8 9566.5 10255.4 10439.7 10654.8 10669.8 8383.2 8396.5 8420.9 8579.1 8669.4 9128.5 10407.6 10697.0 10756.9 10943.0 3810.2 3854.5 3919.3 4558.5 4583.5 964.5 990.6 1007.2 1037.8 1099.6 18848.1 21030.7 22505.8 22922.7 23115.5 982.3 1051.0 1057.8 1089.7 1094.5 10947.5 11080.3 11767.2 11857.1 11859.3 497102.0 504666.0 506721.0 558251.0 642661.0 129599.0 136546.3 140438.3 154907.0 163140.0 1310.2 1334.9 1368.1 1369.5 1374.1 19136.8 19550.0 21308.3 21670.5 21711.6 56718.6 61618.7 61779.4 63078.7 63697.4 85764.0 86426.6 86637.0 88202.1 89256.6 11870.0 12325.4 12392.6 12632.2 12745.1 13961.5 14001.4 14162.8 14414.5 14429.1 11718.5 11745.0 11857.9 11916.0 12095.9 9448.4 9677.7 11405.3 11861.9 12047.9 10154.2 11646.9 12124.3 12135.6 12161.6 10458.8 12025.9 12037.7 12200.7 12371.6 11463.5 11756.8 11770.4 11974.8 12087.0 07:11:08 INFO - PID 1634 | 07:11:08 INFO - PID 1634 | [#3] mootools.html Cycles:180 Average:6591.02 Median:3347.97 stddev:4039.01 (120.6%) stddev-sans-first:4032.35 07:11:08 INFO - PID 1634 | Values: 1517.5 1549.2 1555.3 1582.4 1657.8 9815.8 9974.5 10988.1 11035.2 11408.0 11075.8 11257.8 11296.2 11299.0 11345.5 2304.3 2344.6 2345.3 2352.7 2371.1 2261.1 2296.8 2296.9 2312.8 2314.1 2284.9 2320.2 2335.1 2335.1 2343.3 2284.0 2288.3 2298.8 2309.4 2316.4 1915.3 2363.4 2364.5 2364.8 2371.5 9769.4 11110.7 11298.5 11301.8 11373.9 5744.0 5933.7 6010.0 6017.6 6023.1 3235.2 3411.0 3477.6 3554.1 3555.1 1100.1 1102.4 1123.9 1153.6 1174.6 14146.0 14326.8 14989.8 15018.7 15130.2 4523.6 4632.5 4761.2 4762.9 4809.6 11683.7 11705.5 11709.8 11724.2 11937.4 5341.4 5360.5 5752.7 5782.5 5806.7 5070.6 5115.9 5124.2 5300.1 5322.9 3285.0 3801.8 3823.8 3901.9 3922.6 1027.1 1030.7 1035.0 1044.8 1047.1 916.0 936.7 943.5 943.9 979.5 6455.7 6500.3 6615.7 6720.4 6740.7 950.0 964.0 992.8 994.3 1023.9 4190.7 4234.7 4235.5 4358.6 4411.7 12112.0 12344.2 12454.0 12470.3 12478.8 10582.7 12653.4 12663.0 12674.9 12679.7 8403.4 9890.4 10109.2 10109.8 10130.5 5747.1 6736.9 6839.2 6939.2 6946.3 11292.5 11859.7 12006.2 12024.1 12098.0 10096.5 10222.8 12311.0 12351.6 12443.7 8360.7 8842.7 9073.5 9119.8 9405.4 8831.9 8863.6 10418.2 10422.0 10428.1 8949.3 9291.0 9329.3 9334.9 9408.5 9004.2 9026.6 9035.4 9054.4 9085.5 6643.3 7906.3 7985.3 8086.2 8096.1 5889.5 5948.2 5979.9 6007.4 6112.1 5864.7 5994.7 6134.9 6160.9 6228.0 07:11:08 INFO - PID 1634 | 07:11:08 INFO - PID 1634 | [#4] prototype.html Cycles:180 Average:5251.33 Median:5674.73 stddev:1525.39 (26.9%) stddev-sans-first:1483.71 07:11:08 INFO - PID 1634 | Values: 300.3 368.8 374.4 387.8 393.8 5724.7 5847.9 6050.9 6105.8 6117.2 5095.9 5780.6 5841.5 5849.2 5862.5 4829.0 4830.7 4850.5 4852.6 4861.4 3968.5 4162.3 4257.7 4723.8 4780.1 4453.3 4626.5 4768.0 4768.5 4810.5 3488.4 4802.7 4818.6 4823.2 4839.3 3905.0 4083.7 4105.7 4426.4 4447.6 4428.1 4669.0 5371.4 5660.7 5698.1 5366.2 5610.6 5613.2 5623.5 5660.9 5931.2 5995.0 6177.5 6251.6 6286.7 4149.7 4904.6 4919.6 4919.8 4938.2 6048.7 6331.5 6560.2 6657.2 6706.7 3963.8 4403.8 4948.2 5146.8 5158.2 4527.6 4923.8 5265.5 5296.0 5315.5 5456.9 5591.2 5637.2 5653.7 5683.3 4652.1 5535.9 6315.7 6385.7 6478.5 1643.9 1691.1 1782.5 1802.4 1803.8 1062.7 1225.7 1307.6 1319.1 1343.7 4773.8 5579.0 5966.9 5968.8 6001.4 6053.5 6578.9 6581.7 6590.8 6686.9 4732.2 4887.3 5607.9 5968.6 6021.6 3012.9 3038.4 3216.6 3443.9 3462.2 6504.3 6533.8 6697.0 6866.6 6890.3 6060.6 6126.9 6157.5 6402.7 6693.4 4932.7 6158.7 6361.3 6849.4 7009.8 6029.6 6100.9 6639.0 6644.2 6662.0 6284.9 6465.5 6473.8 6503.6 6528.7 5899.3 5992.8 6958.7 6973.3 6983.8 5124.4 5133.3 5332.6 5666.1 5737.3 5479.5 6586.5 6618.2 6620.4 6643.3 5374.5 6036.6 6393.8 6405.4 6416.6 5256.9 6269.3 6290.7 6352.4 6364.3 5424.9 6264.5 6282.9 6302.7 6315.2 6171.5 6318.2 6327.1 6372.9 6415.7 5211.5 6207.9 6236.2 6266.0 6274.3 07:11:08 INFO - PID 1634 | 07:11:08 INFO - PID 1634 | [#5] yui.html Cycles:180 Average:20146.71 Median:4194.35 stddev:28430.43 (677.8%) stddev-sans-first:28472.66 07:11:08 INFO - PID 1634 | Values: 694.3 704.3 730.3 758.0 822.8 12029.1 15859.4 15867.1 15908.8 15996.3 14117.8 15041.5 15231.2 15438.4 15513.7 919.2 942.7 944.1 946.6 949.3 840.4 863.9 925.6 933.6 941.1 965.4 982.2 982.9 984.6 987.6 957.1 977.7 978.8 980.5 980.9 733.3 736.2 736.6 736.6 738.9 16013.6 16579.9 16591.3 16750.3 17028.4 14295.7 14568.9 14717.9 14762.3 14779.3 11595.8 11622.7 11625.7 11744.2 11895.3 3621.5 3634.5 3686.2 3698.9 3810.7 108784.0 111739.0 112442.0 113914.9 114802.0 11212.9 11275.8 11524.4 11565.9 11941.3 21759.8 23710.1 24366.3 24775.8 24898.9 7808.5 7864.3 7969.3 8027.3 8059.5 4176.4 4212.3 4215.8 4225.6 4250.3 3391.4 3473.9 3501.6 3630.2 3812.3 678.6 680.2 684.3 697.4 698.2 621.6 633.9 667.7 680.3 693.3 9095.0 9900.4 10013.0 10665.1 10916.1 524.3 564.2 569.4 584.9 623.4 4901.0 4967.0 4997.7 4999.4 5027.7 91857.2 94426.5 94526.0 95956.0 96077.0 65982.0 84307.2 84538.0 84892.6 85049.0 69370.0 70744.0 72873.0 74702.0 74764.6 10038.7 10251.9 10748.8 10781.7 10875.3 44517.1 46604.5 49370.0 49659.0 49935.8 57130.7 68182.3 69354.0 69386.3 70619.0 13102.1 13364.9 13458.7 13781.9 13822.8 14493.9 14508.3 14557.6 14592.9 14993.6 13304.0 13355.3 13493.3 13495.7 13554.7 13306.0 13370.1 13440.7 13545.2 13670.0 10500.8 12958.2 13128.9 13285.0 13940.0 10701.0 10839.0 11024.9 11737.1 11902.5 9337.5 9529.8 9620.6 11010.7 11342.8 07:11:08 INFO - PID 1634 | -------- Summary: end -------- 07:11:08 INFO - PID 1634 | 07:11:09 INFO - TEST-INFO | 1634: exit 0 07:11:09 INFO - TEST-OK | dromaeo_css | took 1116830ms 07:11:09 INFO - TEST-START | kraken 07:11:09 INFO - operating with platform_type : mac_ 07:11:09 INFO - Initialising browser for kraken test... 07:11:09 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/tmp2J46rN/profile http://localhost:49241/getInfo.html) 07:11:12 INFO - PID 1646 | 2017-03-20 07:11:12.327 plugin-container[1647:10149] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a43, name = 'com.apple.tsm.portname' 07:11:12 INFO - PID 1646 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:11:12 INFO - PID 1646 | 2017-03-20 07:11:12.330 plugin-container[1647:10149] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c1b, name = 'com.apple.CFPasteboardClient' 07:11:12 INFO - PID 1646 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:11:12 INFO - PID 1646 | 2017-03-20 07:11:12.330 plugin-container[1647:10149] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:11:12 INFO - PID 1646 | __metrics Screen width/height:1600/1200 07:11:12 INFO - PID 1646 | colorDepth:24 07:11:12 INFO - PID 1646 | Browser inner width/height: 1024/689 07:11:12 INFO - PID 1646 | __metrics 07:11:12 ERROR - PID 1646 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 07:11:13 INFO - TEST-INFO | 1646: exit 0 07:11:13 INFO - Browser initialized. 07:11:13 INFO - Running cycle 1/1 for kraken test... 07:11:13 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/tmp2J46rN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:11:15 INFO - PID 1648 | 2017-03-20 07:11:15.548 plugin-container[1649:10274] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b47, name = 'com.apple.tsm.portname' 07:11:15 INFO - PID 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:11:15 INFO - PID 1648 | 2017-03-20 07:11:15.549 plugin-container[1649:10274] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900f, name = 'com.apple.CFPasteboardClient' 07:11:15 INFO - PID 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:11:15 INFO - PID 1648 | 2017-03-20 07:11:15.549 plugin-container[1649:10274] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:11:25 INFO - PID 1648 | RSS: Main: 227704832 07:11:25 INFO - PID 1648 | 07:11:28 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 07:11:29 INFO - PID 1648 | RSS: Main: 241688576 07:11:29 INFO - PID 1648 | 07:11:31 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 07:11:32 INFO - PID 1648 | RSS: Main: 249913344 07:11:32 INFO - PID 1648 | 07:11:35 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 07:11:36 INFO - PID 1648 | RSS: Main: 252522496 07:11:36 INFO - PID 1648 | 07:11:38 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 07:11:38 INFO - PID 1648 | RSS: Main: 253849600 07:11:38 INFO - PID 1648 | 07:11:41 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:11:41 INFO - PID 1648 | RSS: Main: 255565824 07:11:41 INFO - PID 1648 | 07:11:44 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 07:11:45 INFO - PID 1648 | RSS: Main: 260980736 07:11:45 INFO - PID 1648 | 07:11:48 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 07:11:48 INFO - PID 1648 | RSS: Main: 261865472 07:11:48 INFO - PID 1648 | 07:11:52 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 07:11:52 INFO - PID 1648 | RSS: Main: 261955584 07:11:52 INFO - PID 1648 | 07:11:54 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:11:55 INFO - PID 1648 | RSS: Main: 260870144 07:11:55 INFO - PID 1648 | 07:11:57 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:11:57 INFO - PID 1648 | RSS: Main: 260919296 07:11:57 INFO - PID 1648 | 07:12:00 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:12:00 INFO - PID 1648 | RSS: Main: 261210112 07:12:00 INFO - PID 1648 | 07:12:03 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:12:04 INFO - PID 1648 | RSS: Main: 261783552 07:12:04 INFO - PID 1648 | 07:12:07 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:12:08 INFO - PID 1648 | RSS: Main: 261533696 07:12:08 INFO - PID 1648 | 07:12:10 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 07:12:10 INFO - PID 1648 | RSS: Main: 263159808 07:12:10 INFO - PID 1648 | 07:12:10 INFO - PID 1648 | __start_tp_report 07:12:10 INFO - PID 1648 | _x_x_mozilla_page_load 07:12:10 INFO - PID 1648 | _x_x_mozilla_page_load_details 07:12:10 INFO - PID 1648 | |i|pagename|runs| 07:12:10 INFO - PID 1648 | |0;ai-astar;124;123;120;121;122;120;119;120;120;127 07:12:10 INFO - PID 1648 | |1;audio-beat-detection;147;120;116;176;100;140;153;101;171;153 07:12:10 INFO - PID 1648 | |2;audio-dft;196;230;266;208;204;205;204;200;199;194 07:12:10 INFO - PID 1648 | |3;audio-fft;87;60;61;87;60;60;59;72;74;58 07:12:10 INFO - PID 1648 | |4;audio-oscillator;106;102;121;81;71;68;84;71;77;119 07:12:10 INFO - PID 1648 | |5;imaging-gaussian-blur;91;97;90;91;91;104;90;123;90;90 07:12:10 INFO - PID 1648 | |6;imaging-darkroom;97;98;98;98;97;98;97;103;97;98 07:12:10 INFO - PID 1648 | |7;imaging-desaturate;92;92;146;145;104;75;135;147;143;102 07:12:10 INFO - PID 1648 | |8;json-parse-financial;69;62;78;103;102;67;99;67;66;66 07:12:10 INFO - PID 1648 | |9;json-stringify-tinderbox;58;57;63;62;64;62;60;59;52;78 07:12:10 INFO - PID 1648 | |10;stanford-crypto-aes;85;83;87;86;100;98;104;110;77;101 07:12:10 INFO - PID 1648 | |11;stanford-crypto-ccm;158;150;151;150;162;143;147;179;198;196 07:12:10 INFO - PID 1648 | |12;stanford-crypto-pbkdf2;189;188;188;190;191;185;192;191;183;190 07:12:10 INFO - PID 1648 | |13;stanford-crypto-sha256-iterative;70;70;69;89;99;98;72;67;70;91 07:12:10 INFO - PID 1648 | __end_tp_report 07:12:10 INFO - PID 1648 | __start_cc_report 07:12:10 INFO - PID 1648 | _x_x_mozilla_cycle_collect,1003 07:12:10 INFO - PID 1648 | __end_cc_report 07:12:10 INFO - PID 1648 | __startTimestamp1490019130417__endTimestamp 07:12:10 INFO - PID 1648 | 07:12:10 INFO - PID 1648 | ------- Summary: start ------- 07:12:10 INFO - PID 1648 | Number of tests: 14 07:12:10 INFO - PID 1648 | 07:12:10 INFO - PID 1648 | [#0] ai-astar Cycles:10 Average:121.60 Median:121.50 stddev:2.46 (2.0%) stddev-sans-first:2.45 07:12:10 INFO - PID 1648 | Values: 124.0 123.0 120.0 121.0 122.0 120.0 119.0 120.0 120.0 127.0 07:12:10 INFO - PID 1648 | 07:12:10 INFO - PID 1648 | [#1] audio-beat-detection Cycles:10 Average:137.70 Median:150.00 stddev:27.26 (18.2%) stddev-sans-first:28.71 07:12:10 INFO - PID 1648 | Values: 147.0 120.0 116.0 176.0 100.0 140.0 153.0 101.0 171.0 153.0 07:12:10 INFO - PID 1648 | 07:12:10 INFO - PID 1648 | [#2] audio-dft Cycles:10 Average:210.60 Median:204.50 stddev:21.87 (10.7%) stddev-sans-first:22.55 07:12:10 INFO - PID 1648 | Values: 196.0 230.0 266.0 208.0 204.0 205.0 204.0 200.0 199.0 194.0 07:12:10 INFO - PID 1648 | 07:12:10 INFO - PID 1648 | [#3] audio-fft Cycles:10 Average:67.80 Median:66.50 stddev:11.53 (17.3%) stddev-sans-first:9.91 07:12:10 INFO - PID 1648 | Values: 87.0 60.0 61.0 87.0 60.0 60.0 59.0 72.0 74.0 58.0 07:12:10 INFO - PID 1648 | 07:12:10 INFO - PID 1648 | [#4] audio-oscillator Cycles:10 Average:90.00 Median:71.00 stddev:20.26 (28.5%) stddev-sans-first:20.64 07:12:10 INFO - PID 1648 | Values: 106.0 102.0 121.0 81.0 71.0 68.0 84.0 71.0 77.0 119.0 07:12:10 INFO - PID 1648 | 07:12:10 INFO - PID 1648 | [#5] imaging-gaussian-blur Cycles:10 Average:95.70 Median:90.50 stddev:10.60 (11.7%) stddev-sans-first:11.11 07:12:10 INFO - PID 1648 | Values: 91.0 97.0 90.0 91.0 91.0 104.0 90.0 123.0 90.0 90.0 07:12:10 INFO - PID 1648 | 07:12:10 INFO - PID 1648 | [#6] imaging-darkroom Cycles:10 Average:98.10 Median:98.00 stddev:1.79 (1.8%) stddev-sans-first:1.86 07:12:10 INFO - PID 1648 | Values: 97.0 98.0 98.0 98.0 97.0 98.0 97.0 103.0 97.0 98.0 07:12:10 INFO - PID 1648 | 07:12:10 INFO - PID 1648 | [#7] imaging-desaturate Cycles:10 Average:118.10 Median:146.50 stddev:27.73 (18.9%) stddev-sans-first:27.76 07:12:10 INFO - PID 1648 | Values: 92.0 92.0 146.0 145.0 104.0 75.0 135.0 147.0 143.0 102.0 07:12:10 INFO - PID 1648 | 07:12:10 INFO - PID 1648 | [#8] json-parse-financial Cycles:10 Average:77.90 Median:67.00 stddev:16.70 (24.9%) stddev-sans-first:17.40 07:12:10 INFO - PID 1648 | Values: 69.0 62.0 78.0 103.0 102.0 67.0 99.0 67.0 66.0 66.0 07:12:10 INFO - PID 1648 | 07:12:10 INFO - PID 1648 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:62.00 stddev:6.77 (10.9%) stddev-sans-first:7.06 07:12:10 INFO - PID 1648 | Values: 58.0 57.0 63.0 62.0 64.0 62.0 60.0 59.0 52.0 78.0 07:12:10 INFO - PID 1648 | 07:12:10 INFO - PID 1648 | [#10] stanford-crypto-aes Cycles:10 Average:93.10 Median:84.00 stddev:10.82 (12.9%) stddev-sans-first:11.07 07:12:10 INFO - PID 1648 | Values: 85.0 83.0 87.0 86.0 100.0 98.0 104.0 110.0 77.0 101.0 07:12:10 INFO - PID 1648 | 07:12:10 INFO - PID 1648 | [#11] stanford-crypto-ccm Cycles:10 Average:163.40 Median:160.00 stddev:20.36 (12.7%) stddev-sans-first:21.51 07:12:10 INFO - PID 1648 | Values: 158.0 150.0 151.0 150.0 162.0 143.0 147.0 179.0 198.0 196.0 07:12:10 INFO - PID 1648 | 07:12:10 INFO - PID 1648 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:188.70 Median:190.00 stddev:2.83 (1.5%) stddev-sans-first:3.00 07:12:10 INFO - PID 1648 | Values: 189.0 188.0 188.0 190.0 191.0 185.0 192.0 191.0 183.0 190.0 07:12:10 INFO - PID 1648 | 07:12:10 INFO - PID 1648 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:79.50 Median:80.50 stddev:13.07 (16.2%) stddev-sans-first:13.41 07:12:10 INFO - PID 1648 | Values: 70.0 70.0 69.0 89.0 99.0 98.0 72.0 67.0 70.0 91.0 07:12:10 INFO - PID 1648 | -------- Summary: end -------- 07:12:10 INFO - PID 1648 | 07:12:11 INFO - TEST-INFO | 1648: exit 0 07:12:11 INFO - TEST-OK | kraken | took 61874ms 07:12:11 INFO - SUITE-END | took 1178s 07:12:11 INFO - Completed test suite (00:19:38) 07:12:11 INFO - javascript benchmark 07:12:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7852.263821741193, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3425.725941924646, 3430.4511278195478, 3479.6520347965193, 3507.0355652195644, 3511.3855075361807, 4269.295566231568, 5701.600887937846, 5708.9438453886005, 5874.089516125002, 5875.236219291492, 5734.885302293952, 5833.445822646852, 5882.264716910387, 5940.910886336708, 5997.820065398045, 5288.15389537674, 5290.761915713802, 5292.708901010462, 5340.25236466895, 5414.269073675063, 5232.659877107995, 5340.279062326595, 5394.32570928634, 5457.754401051962, 5462.317210348707, 5269.367675878881, 5330.0, 5351.384590772072, 5353.946460535403, 5361.571074314084, 5306.177542480922, 5306.893862122736, 5315.6013299002725, 5324.8136315228785, 5345.224942383333, 5237.711925844077, 5261.86845328866, 5274.472552744734, 5290.497402746733, 5308.973455132699, 5670.716464176775, 5703.74333155009, 5731.197632331477, 5810.360860305363, 5828.941710582924, 6301.684915754194, 6316.494680425555, 6321.24145102586, 6326.08271800591, 6339.175907132089, 5935.347111817697, 5976.970115149396, 6311.93688063118, 6324.241091069055, 6332.778352757631, 5021.799128034874, 5842.59101862874, 5916.171735956969, 6038.486728628028, 6067.302260240041, 5496.560275178056, 6365.745370185234, 6420.133282006869, 6465.321141280192, 6468.611883287018, 5629.127485239795, 5647.519960803295, 6107.4197951194565, 6208.875822483525, 6223.533235007392, 5213.348331458567, 5335.759890804923, 6215.751369945152, 6260.154879091356, 6268.404501572343, 6263.6241825490615, 6287.96856015717, 6290.308066112724, 6291.307956124822, 6305.243370795442, 6142.959235178615, 6148.739508400767, 6217.906731399033, 6236.158118654014, 6248.28144763349, 5134.178531435027, 5148.227765835155, 5151.6136289778415, 5167.689938603696, 5178.482151784867, 3879.612038796154, 4580.152671755736, 4589.862304130881, 4608.792604332813, 4625.098105869323, 5952.583319167703, 6017.308009578867, 6035.034394496859, 6048.334683184846, 6192.566520343533, 6256.0, 6336.0, 6337.936620633827, 6343.873122537523, 6388.488920886318, 6086.756529738761, 6175.62946223219, 6180.134781130645, 6197.0, 6208.72060757267, 5535.944640553543, 5678.0915053591225, 5692.857678557986, 5711.857203569944, 5726.255586773693, 6402.359764023654, 6579.243387010363, 6661.433778128913, 6666.500012498985, 6667.299933506912, 6321.209848768904, 6329.715162817776, 6334.588251763621, 6347.174867267226, 6371.585846919936, 6528.967355163194, 6600.471962242913, 6617.702203400762, 6640.335966403321, 6651.600903945779, 5020.47285035066, 5336.546393556436, 6198.6280823150755, 6267.4986001120715, 6278.623282603058, 6304.527160463075, 6340.30256671775, 6344.619322840645, 6354.618722876642, 6363.427291543598, 6109.222480666275, 6111.174991376108, 6145.938540614537, 6297.96851015742, 6312.968435157794, 4917.508249175054, 5162.251473536241, 6012.518998480024, 6118.040554665315, 6302.968485157545, 5172.948270517247, 5904.350521442552, 6043.848903777441, 6086.817395478142, 6099.4815440688035, 6086.421789929949, 6136.1821086261625, 6145.187169785014, 6185.567010309235, 6198.0702894566175, 6073.180120683651, 6104.913929256043, 6142.928535732134, 6147.0022242772175, 6194.5354098443695], "value": 5767.615416370111, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [646.6508085633758, 687.5565260407037, 781.7146741439376, 912.197266405563, 917.6696389299851, 29246.0, 38413.80793096034, 38430.423543646866, 38447.423288650694, 38482.0, 36976.0, 37378.8131059345, 37399.25201495968, 37429.06427339318, 37553.62446375542, 7512.173660897297, 8867.24628406583, 10608.522616482238, 10778.0, 10824.621138260163, 10782.353058816496, 10854.45727713615, 10920.453977301142, 10921.563137474532, 10945.671629851078, 10930.180236482256, 11007.834882476769, 11014.339139651647, 11021.283616564937, 11029.889701103006, 9068.909310906905, 10915.672529824118, 10949.233553651247, 10965.287256328313, 10987.340759554372, 8850.159234872677, 10686.0, 10765.354078755221, 10780.137588992862, 10796.298240614335, 37759.81120094382, 38205.0, 38255.42616860749, 38276.0, 38324.0, 3759.642833930772, 3800.3539398302078, 3807.676347510465, 3832.8658496952753, 3833.6358045985585, 26843.92624295026, 27773.583396249072, 27824.30439239015, 27948.0, 27953.580696289573, 3065.7700672449655, 3092.304231547906, 3103.1156120505775, 3138.168385377877, 3172.1752344390625, 292923.0, 310640.0, 310657.0, 311791.0, 312703.0, 49619.0, 49757.253641194686, 49819.750901245265, 49830.0, 49888.0, 51906.70233244199, 51937.220941685904, 52273.47726522762, 52282.215766763526, 52353.120578367794, 10453.797813251422, 14314.642133946734, 14587.854121458862, 14615.0, 14854.777178342334, 11717.472713727902, 11820.822687659693, 11840.0, 11866.288022718492, 11879.465424055938, 13486.39311230997, 13671.043026988016, 13692.931535342259, 13773.38019789112, 13861.584152475441, 6009.639421634716, 6058.969705151534, 6078.969605151946, 6086.452219300284, 6097.664628445389, 864.394923553515, 1043.4730461117088, 1066.514735795227, 1084.5878566144816, 1108.539955918285, 21626.0, 23806.0, 25903.611445828326, 26308.21075367742, 26398.604020939318, 1147.2313549921405, 1197.161986609377, 1199.5381778015353, 1236.8515778106685, 1247.9313637749829, 11164.385958772345, 13207.471701131846, 13292.867071329356, 13446.93276533611, 13943.745062944383, 424149.0, 424246.0, 428161.0, 428371.0, 428429.0, 51607.48392516102, 54899.72550137304, 55393.67637941736, 55661.721691391285, 55721.885562288524, 1368.0765483298733, 1401.2853444743255, 1401.3483730065363, 1407.507372419645, 1409.2953523238382, 28042.2989425266, 28191.0, 28292.717072829008, 28531.714682853737, 28854.0, 43429.56570434382, 43774.78112609417, 43965.78017110022, 44033.0, 44068.77965610279, 294885.0, 321470.57058858225, 339362.0, 365174.0, 365560.0, 27702.44595108127, 28167.295817604725, 29002.7099729, 31073.53389699111, 31097.689023110383, 40166.397504036875, 41677.79161104175, 41698.374524382765, 41780.58219417888, 42149.52476663302, 24016.799160041577, 34128.39266699063, 34855.0, 35825.82087089548, 36136.81931590325, 34816.78141265044, 34955.82522087373, 35726.0, 35818.64181358153, 35975.841449513115, 34376.82811586026, 35234.82382588173, 35302.82348588241, 35886.0, 35897.28205435824, 30545.847270763505, 31448.528272076393, 31479.842600787764, 31579.052628421185, 31776.523352149274, 20851.0, 23229.41926451852, 24079.879600601886, 24080.686712354767, 24166.637500437155], "value": 18453.741343089016, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [399.22351027252006, 409.102021063765, 410.2922458758642, 421.6036925290227, 424.63057140287935, 20203.898980505095, 20835.583288334245, 21142.0, 21528.246511372105, 21684.674729879065, 21025.158993640274, 21105.366838994854, 21335.359939201848, 21459.785402145975, 22399.776002239974, 5944.464998150165, 6333.334999825021, 6340.904886426707, 6353.459955903731, 6353.777617783378, 5403.459654034585, 6567.441767449749, 6757.560758550679, 6769.221539522969, 6824.112865327501, 6763.66181690916, 6801.387875091241, 6807.965960170217, 6816.556923799937, 6827.69275382609, 7309.159446663649, 7628.351590114847, 7688.231176882267, 7717.189695082048, 7729.995100636909, 7258.129024517092, 7383.2985866342615, 7438.144613369478, 7450.403967682572, 7461.589612571306, 27572.862135689193, 27576.0, 27757.0, 27877.86061069682, 28053.438931221466, 2954.8965786197596, 3328.866845326184, 3347.41420251455, 3354.3626710924846, 3495.5106285120105, 17068.0, 17239.827601723948, 17300.307987680477, 17385.913070434566, 18141.909290453594, 1819.1177279019664, 2043.1520918818671, 2067.3694523170425, 2119.088791819517, 2119.4065661614773, 138524.0, 139176.0, 158541.0, 159388.0, 170618.99999999875, 23758.524829503658, 24015.0, 25442.0, 26324.60513092305, 26331.605025924626, 41815.23662870295, 41901.2288894001, 42023.0, 42087.0, 42290.788546057076, 9566.521673916277, 10255.435951022617, 10439.739006524898, 10654.840177397346, 10669.78660426787, 8383.215715057935, 8396.496210227406, 8420.915790842135, 8579.099194584478, 8669.393142479967, 9128.543572821332, 10407.58369665205, 10696.983786540422, 10756.892431075588, 10943.0, 3810.1998580298446, 3854.479645247912, 3919.333713268751, 4558.521355257716, 4583.518730533313, 964.5418426247477, 990.5790039233441, 1007.2445665750687, 1037.8339465685453, 1099.5589790664712, 18848.05759712009, 21030.738155710707, 22505.774942250697, 22922.65616015761, 23115.53768924612, 982.3221976835961, 1051.0225490293947, 1057.8201705710048, 1089.7493576477455, 1094.4527736131934, 10947.4526273686, 11080.279781814157, 11767.23512971654, 11857.051435885109, 11859.288442693465, 497102.0, 504666.0, 506721.0, 558251.0, 642661.0, 129599.0, 136546.317268415, 140438.2978085103, 154907.0, 163140.0, 1310.2007775257086, 1334.9132306400054, 1368.0765483298933, 1369.4659082957655, 1374.1274290825397, 19136.808631913504, 19550.0, 21308.254211102536, 21670.45823854416, 21711.565768684854, 56718.59688418708, 61618.69190654018, 61779.38220617736, 63078.68460657667, 63697.363026371, 85764.0, 86426.56786716027, 86637.0, 88202.11797881938, 89256.553717231, 11870.0, 12325.411663550754, 12392.566260181211, 12632.2420654761, 12745.10784245131, 13961.511347102803, 14001.43994240219, 14162.78755818643, 14414.495492657707, 14429.062110962754, 11718.531258749554, 11745.0, 11857.940710296394, 11916.046716262505, 12095.939520302694, 9448.385854919408, 9677.70966870995, 11405.315681059163, 11861.881381186078, 12047.939760301142, 10154.187664986932, 11646.88353116458, 12124.27254364741, 12135.635930922086, 12161.635150945485, 10458.843117353397, 12025.895468293189, 12037.699057523281, 12200.694982625506, 12371.566995155126, 11463.541458341573, 11756.82364764512, 11770.3526306054, 11974.760504790029, 12087.0], "value": 11983.135600587313, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1517.4537166620007, 1549.171193411525, 1555.300114948273, 1582.438234426778, 1657.8093519245288, 9815.754606134842, 9974.501274936261, 10988.120950323975, 11035.172362072837, 11407.973282404582, 11075.778484430326, 11257.774844503105, 11296.15278854085, 11299.03958163555, 11345.546178152865, 2304.285671441854, 2344.566255242777, 2345.2846881701075, 2352.694149760529, 2371.1345358944036, 2261.0842608743487, 2296.8392212545127, 2296.9310920672406, 2312.7918487336137, 2314.0628045641456, 2284.9200277990276, 2320.1995311617466, 2335.0893151670775, 2335.100986120339, 2343.285297984114, 2283.9657405138937, 2288.324944141474, 2298.816109703496, 2309.364924645719, 2316.4324740438533, 1915.2626238898124, 2363.444590521226, 2364.5270945810735, 2364.787169154767, 2371.537550177716, 9769.364991275615, 11110.666679999613, 11298.491567879466, 11301.830472542837, 11373.886261137366, 5744.0, 5933.732982015819, 6010.0, 6017.638941663514, 6023.066424704178, 3235.207374193314, 3410.9796455856153, 3477.565304336958, 3554.0937061049526, 3555.1112221944513, 1100.057622065918, 1102.3716481605488, 1123.8819923908036, 1153.5674122204173, 1174.5830230268302, 14146.0, 14326.785098223534, 14989.775153372708, 15018.699626007528, 15130.243487825675, 4523.592876641118, 4632.536746325341, 4761.2382018876815, 4762.880927976759, 4809.567138957511, 11683.707907302385, 11705.531778728926, 11709.824352634718, 11724.179307448567, 11937.403129843473, 5341.359036915595, 5360.472265404341, 5752.741126649311, 5782.537397008229, 5806.65160090396, 5070.569001634829, 5115.923261151086, 5124.180131178993, 5300.09898317287, 5322.946770532322, 3284.950725739116, 3801.7834293025967, 3823.8279277432584, 3901.941470877939, 3922.646961773397, 1027.075631931268, 1030.7320096774893, 1034.984475232857, 1044.7910417916296, 1047.0942634621, 915.9587818548181, 936.7330310861372, 943.5140902435252, 943.919766819828, 979.4857699707568, 6455.741130479511, 6500.3499650035565, 6615.702293396808, 6720.361565651256, 6740.730370785212, 949.9810003799886, 964.0, 992.7766252593253, 994.2592768387598, 1023.923205759571, 4190.727602705814, 4234.6823988201, 4235.512916014636, 4358.585934336233, 4411.691181617256, 12112.0, 12344.197627154386, 12454.003679705602, 12470.314132722606, 12478.81281780774, 10582.671812201303, 12653.36733163338, 12663.0, 12674.873251267554, 12679.683007924876, 8403.411761176782, 9890.357126786736, 10109.191264698806, 10109.848352274721, 10130.493475326204, 5747.1379293106365, 6736.865262694817, 6839.179298484214, 6939.201991771011, 6946.270641582561, 11292.548298067984, 11859.703507412383, 12006.159568830099, 12024.098192635762, 12098.03215742756, 10096.495175241356, 10222.795544089226, 12311.0, 12351.567695130627, 12443.688907777016, 8360.704090865926, 8842.734717958472, 9073.500957447404, 9119.772005699646, 9405.43567385959, 8831.896012998375, 8863.556822158995, 10418.166546676097, 10422.0, 10428.061474467335, 8949.284057275272, 9290.95354523223, 9329.253659707072, 9334.906650933675, 9408.529573521433, 9004.189622933967, 9026.638934442548, 9035.367524273237, 9054.366194366332, 9085.454872707658, 6643.335666433318, 7906.327962123284, 7985.321247694011, 8086.1913808618665, 8096.149904260204, 5889.528837692888, 5948.167256584168, 5979.880402392015, 6007.3992600739575, 6112.113743507078, 5864.67744274052, 5994.70026498682, 6134.877302453837, 6160.907586386118, 6228.0], "value": 5051.1987324696975, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.2733385207797, 368.78794693051486, 374.3505018792393, 387.7553054694429, 393.80113042913314, 5724.742386592603, 5847.853803654911, 6050.909236361458, 6105.778844231149, 6117.235345581802, 5095.898082038357, 5780.624259423134, 5841.53267738581, 5849.151872978416, 5862.50168735658, 4828.951710482894, 4830.71015739055, 4850.539198776129, 4852.636052296092, 4861.440934292566, 3968.503937007874, 4162.334026555752, 4257.6806739494505, 4723.811047558111, 4780.091782561302, 4453.3097369907555, 4626.450139203371, 4768.0, 4768.499307572707, 4810.518948105197, 3488.354654388946, 4802.687825291345, 4818.614510839125, 4823.2282834746275, 4839.27410888366, 3905.0, 4083.734557253769, 4105.7331273467125, 4426.424564806587, 4447.621952134073, 4428.114377124556, 4668.976655116737, 5371.44856193309, 5660.745266463019, 5698.145278208261, 5366.168243922199, 5610.635308704921, 5613.186088017214, 5623.465770751772, 5660.943390566083, 5931.199288096095, 5994.97002514989, 6177.474914632262, 6251.562390632657, 6286.654234017173, 4149.7095203335775, 4904.632152588534, 4919.606431485473, 4919.827806026772, 4938.185199442088, 6048.667323297217, 6331.493480521547, 6560.179977502812, 6657.167854018247, 6706.731730730765, 3963.841446342114, 4403.772378516596, 4948.208286674187, 5146.794128234904, 5158.174692049254, 4527.61515271199, 4923.8276660316715, 5265.499777521206, 5296.0, 5315.521603055744, 5456.863578410572, 5591.161325801162, 5637.238972738628, 5653.660780353192, 5683.346415162227, 4652.092242516303, 5535.944640553543, 6315.684215789192, 6385.659011607521, 6478.514111441661, 1643.926023328953, 1691.112166112776, 1782.4741701198177, 1802.4052062819237, 1803.801581825998, 1062.7130674717782, 1225.7364666596545, 1307.5881097454271, 1319.1425573377383, 1343.7111021130504, 4773.76131193439, 5578.967890940189, 5966.910496342558, 5968.820935371859, 6001.399860013964, 6053.4854537363935, 6578.868422631521, 6581.734612310132, 6590.80227593173, 6686.933130668728, 4732.219183834629, 4887.266909963463, 5607.859803504945, 5968.641881487125, 6021.638701677914, 3012.894548690785, 3038.3619439917425, 3216.5818443602648, 3443.863525036732, 3462.2036931505895, 6504.317046710122, 6533.836654083686, 6696.966515167393, 6866.588004719732, 6890.345417185359, 6060.575759696779, 6126.9387306127255, 6157.538184636171, 6402.711877965503, 6693.431058360094, 4932.67937584063, 6158.7228574714245, 6361.332060133805, 6849.4177994871, 7009.824754381181, 6029.57792954489, 6100.871338802336, 6638.966805165944, 6644.169478815148, 6662.0, 6284.937150628435, 6465.450436712932, 6473.838154046187, 6503.642299673564, 6528.738850445929, 5899.321578018583, 5992.760289588367, 6958.652067396712, 6973.3375329343635, 6983.847665135196, 5124.385073791169, 5133.255677926754, 5332.600054995968, 5666.121751128581, 5737.254156959735, 5479.53423958952, 6586.473082153512, 6618.238902526078, 6620.3710647488415, 6643.3356664335115, 5374.516293533601, 6036.551227705407, 6393.808185754435, 6405.391487808651, 6416.647084410216, 5256.868578285574, 6269.332440522346, 6290.6529449967165, 6352.36476352361, 6364.331745166691, 5424.9041973309895, 6264.49884009269, 6282.937170628235, 6302.747890084345, 6315.242170939517, 6171.506279497719, 6318.241810982711, 6327.114204011534, 6372.872542549216, 6415.679216039272, 5211.4527974562125, 6207.937920620917, 6236.220472440945, 6266.0, 6274.33730061525], "value": 4788.975933449136, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [694.2536772969056, 704.3379223529878, 730.2806735365664, 757.9734709285176, 822.831319579486, 12029.057617673405, 15859.36562537497, 15867.12730799807, 15908.76136857948, 15996.280167392466, 14117.78823317651, 15041.473548425807, 15231.238438078079, 15438.382464701399, 15513.689726205497, 919.2094798473324, 942.6936245720134, 944.1361154543584, 946.6497395963469, 949.2595775295281, 840.3907167303717, 863.9438436501607, 925.5557332480413, 933.5705575435308, 941.1200527506803, 965.4255717847869, 982.1553464020936, 982.8574856645782, 984.6406061787468, 987.5654711926729, 957.129012598532, 977.6529332087114, 978.7944531648362, 980.5244456438621, 980.8871979722352, 733.2960358056272, 736.190190790132, 736.6132780290337, 736.6316841579211, 738.9039424874732, 16013.599660008476, 16579.917100414543, 16591.25339359732, 16750.329986800512, 17028.38230368113, 14295.714085718331, 14568.854311456962, 14717.852821471755, 14762.335694893756, 14779.33492992818, 11595.768084638345, 11622.651320460314, 11625.6512304631, 11744.177907546475, 11895.286282822972, 3621.4748861414946, 3634.509341238925, 3686.1706116123923, 3698.9445158322646, 3810.69514438847, 108784.0, 111739.0, 112442.0, 113914.86085139125, 114802.0, 11212.887871121347, 11275.774484510428, 11524.366159861289, 11565.884341156649, 11941.283522988648, 21759.782402176093, 23710.051597936235, 24366.26901192967, 24775.752242477705, 24898.875505622356, 7808.5314881107315, 7864.252895974873, 7969.282764551218, 8027.317677997436, 8059.476134051268, 4176.394422808676, 4212.30496968003, 4215.768132752667, 4225.619694227535, 4250.298700714347, 3391.406503861814, 3473.930521389558, 3501.6148223695373, 3630.2013557017412, 3812.2947254757405, 678.5623272988993, 680.2075581947075, 684.2746688510196, 697.4176562570209, 698.2075344484048, 621.580433207583, 633.94294513494, 667.6728403082454, 680.2857000149822, 693.2686016252801, 9094.954525227464, 9900.356476828983, 10013.0, 10665.146788256921, 10916.074858189239, 524.3419508516863, 564.2101058518025, 569.3879079989028, 584.8888711144868, 623.3672822085587, 4900.950990490121, 4967.044608457962, 4997.700137991732, 4999.350084488993, 5027.673201241908, 91857.16285674383, 94426.52786736023, 94526.0, 95956.0, 96077.0, 65982.0, 84307.15692843116, 84538.0, 84892.57553712191, 85049.0, 69369.95945060728, 70744.0, 72873.0, 74702.0, 74764.62617686986, 10038.749031274276, 10251.948740256252, 10748.785024299626, 10781.676549703521, 10875.347479151276, 44517.10965780731, 46604.53395466002, 49370.0, 49659.006819864124, 49935.75032124816, 57130.714346428, 68182.31817681958, 69354.0, 69386.30613693799, 70619.0, 13102.148360356547, 13364.933175334061, 13458.730825383633, 13781.862181378057, 13822.792658109935, 14493.85506144925, 14508.274586270856, 14557.636059098608, 14592.927035364755, 14993.625159371102, 13304.014288059574, 13355.332233388486, 13493.257870817199, 13495.730085398434, 13554.728905422033, 13306.0, 13370.072485354296, 13440.663983400493, 13545.187288762705, 13670.0, 10500.789984200426, 12958.219106257608, 13128.934355328161, 13285.0, 13939.954503412488, 10701.0, 10839.037260124078, 11024.889751102386, 11737.061035117342, 11902.523899043941, 9337.533123343941, 9529.761755956157, 9620.615175392906, 11010.669679909615, 11342.829857552308], "value": 7597.031746619094, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1603.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 123.0, 120.0, 121.0, 122.0, 120.0, 119.0, 120.0, 120.0, 127.0], "value": 121.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 120.0, 116.0, 176.0, 100.0, 140.0, 153.0, 101.0, 171.0, 153.0], "value": 137.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 230.0, 266.0, 208.0, 204.0, 205.0, 204.0, 200.0, 199.0, 194.0], "value": 210.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 60.0, 61.0, 87.0, 60.0, 60.0, 59.0, 72.0, 74.0, 58.0], "value": 67.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 102.0, 121.0, 81.0, 71.0, 68.0, 84.0, 71.0, 77.0, 119.0], "value": 90.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 97.0, 90.0, 91.0, 91.0, 104.0, 90.0, 123.0, 90.0, 90.0], "value": 95.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 98.0, 98.0, 98.0, 97.0, 98.0, 97.0, 103.0, 97.0, 98.0], "value": 98.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 146.0, 145.0, 104.0, 75.0, 135.0, 147.0, 143.0, 102.0], "value": 118.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 62.0, 78.0, 103.0, 102.0, 67.0, 99.0, 67.0, 66.0, 66.0], "value": 77.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 63.0, 62.0, 64.0, 62.0, 60.0, 59.0, 52.0, 78.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 87.0, 86.0, 100.0, 98.0, 104.0, 110.0, 77.0, 101.0], "value": 93.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 150.0, 151.0, 150.0, 162.0, 143.0, 147.0, 179.0, 198.0, 196.0], "value": 163.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 188.0, 188.0, 190.0, 191.0, 185.0, 192.0, 191.0, 183.0, 190.0], "value": 188.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 69.0, 89.0, 99.0, 98.0, 72.0, 67.0, 70.0, 91.0], "value": 79.5, "unit": "score"}]}]} 07:12:11 INFO - Return code: 0 07:12:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:12:11 ERROR - # TBPL SUCCESS # 07:12:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:12:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:12:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:12:11 INFO - 2017-03-20 07:12:11.726 screenresolution[1653:10665] starting screenresolution argv=screenresolution get 07:12:11 INFO - 2017-03-20 07:12:11.728 screenresolution[1653:10665] Display 0: 1600x1200x32@60 07:12:11 INFO - 2017-03-20 07:12:11.734 screenresolution[1654:10668] starting screenresolution argv=screenresolution list 07:12:11 INFO - Available Modes on Display 0 07:12:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:12:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:12:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:12:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:12:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:12:11 INFO - Intel Iris: 07:12:11 INFO - Chipset Model: Intel Iris 07:12:11 INFO - Type: GPU 07:12:11 INFO - Bus: Built-In 07:12:11 INFO - VRAM (Dynamic, Max): 1536 MB 07:12:11 INFO - Vendor: Intel (0x8086) 07:12:11 INFO - Device ID: 0x0a2e 07:12:11 INFO - Revision ID: 0x0009 07:12:11 INFO - Displays: 07:12:11 INFO - Display: 07:12:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:12:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:12:11 INFO - Display Serial Number: 1600x1200 60 07:12:11 INFO - Main Display: Yes 07:12:11 INFO - Mirror: Off 07:12:11 INFO - Online: Yes 07:12:11 INFO - Rotation: Supported 07:12:11 INFO - Return code: 0 07:12:11 INFO - Running post-action listener: _resource_record_post_action 07:12:11 INFO - [mozharness: 2017-03-20 14:12:11.975122Z] Finished run-tests step (success) 07:12:11 INFO - Running post-run listener: _resource_record_post_run 07:12:12 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 40372736; Write bytes: 515320832; Read time: 387; Write time: 1719 07:12:12 INFO - TinderboxPrint: CPU usage
54.2% 07:12:12 INFO - TinderboxPrint: I/O read bytes / time
40,372,736 / 387 07:12:12 INFO - TinderboxPrint: I/O write bytes / time
515,320,832 / 1,719 07:12:12 INFO - TinderboxPrint: CPU idle
2,199.8 (45.8%) 07:12:12 INFO - TinderboxPrint: CPU system
966.1 (20.1%) 07:12:12 INFO - TinderboxPrint: CPU user
1,635.8 (34.1%) 07:12:12 INFO - TinderboxPrint: Swap in / out
250,875,904 / 0 07:12:12 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 203872768; Write bytes: 202975232; Read time: 15679; Write time: 449 07:12:12 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 39410176; Write bytes: 302396416; Read time: 371; Write time: 1235 07:12:12 INFO - Running post-run listener: _upload_blobber_files 07:12:12 INFO - Blob upload gear active. 07:12:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:12:12 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 07:12:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:12:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:12:12 INFO - (blobuploader) - INFO - Open directory for files ... 07:12:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:12:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:12:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:12:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:12:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:12:13 INFO - (blobuploader) - INFO - Done attempting. 07:12:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:12:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:12:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:12:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:12:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:12:14 INFO - (blobuploader) - INFO - Done attempting. 07:12:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:12:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:12:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:12:15 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:12:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:12:15 INFO - (blobuploader) - INFO - Done attempting. 07:12:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:12:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:12:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:12:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:12:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:12:18 INFO - (blobuploader) - INFO - Done attempting. 07:12:18 INFO - (blobuploader) - INFO - Iteration through files over. 07:12:18 INFO - Return code: 0 07:12:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:12:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:12:18 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33c97ed8c20591626ace50166e017529f9d790c8ea170e6d9b398cb26b2f1daa636d7968a81afd6dd7fda77df121cf3409f180bf3fadc9002b06b5ec8cd6a204", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8115bd92c0b69221ef4a2d1025f9cbf69b43e538e6ff7d4dae6c200d87a35358a7c9636bc1e91ba5cf50f8c56434edabc0d665f92917228cd096c0a22819f234", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7eed5b2b65bde05a15ec96a9af1db331c3676147ed8fb2ee6138df188b88d6be2a502711516eb1e78558b637dc20d63d2986467bbb8edbe91588fb5128c20b0e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eee31338303f5f1552bfe10ee8905443f0aff93abfd702643fb26ddabc48a6862a9157a563d8ed56576865b99a1dba1157c8acdc449b48b8aed6a757c3b98343"} 07:12:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:12:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:12:18 INFO - Contents: 07:12:18 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33c97ed8c20591626ace50166e017529f9d790c8ea170e6d9b398cb26b2f1daa636d7968a81afd6dd7fda77df121cf3409f180bf3fadc9002b06b5ec8cd6a204", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8115bd92c0b69221ef4a2d1025f9cbf69b43e538e6ff7d4dae6c200d87a35358a7c9636bc1e91ba5cf50f8c56434edabc0d665f92917228cd096c0a22819f234", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7eed5b2b65bde05a15ec96a9af1db331c3676147ed8fb2ee6138df188b88d6be2a502711516eb1e78558b637dc20d63d2986467bbb8edbe91588fb5128c20b0e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eee31338303f5f1552bfe10ee8905443f0aff93abfd702643fb26ddabc48a6862a9157a563d8ed56576865b99a1dba1157c8acdc449b48b8aed6a757c3b98343"} 07:12:18 INFO - Running post-run listener: copy_logs_to_upload_dir 07:12:18 INFO - Copying logs to upload dir... 07:12:18 INFO - mkdir: /builds/slave/test/build/upload/logs 07:12:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.938173 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-03-20 07:12:18.078260) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-20 07:12:18.083134) ========= 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.59bVaWKRG9/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.UX6SjBjEhC/Listeners TMPDIR=/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33c97ed8c20591626ace50166e017529f9d790c8ea170e6d9b398cb26b2f1daa636d7968a81afd6dd7fda77df121cf3409f180bf3fadc9002b06b5ec8cd6a204", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8115bd92c0b69221ef4a2d1025f9cbf69b43e538e6ff7d4dae6c200d87a35358a7c9636bc1e91ba5cf50f8c56434edabc0d665f92917228cd096c0a22819f234", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7eed5b2b65bde05a15ec96a9af1db331c3676147ed8fb2ee6138df188b88d6be2a502711516eb1e78558b637dc20d63d2986467bbb8edbe91588fb5128c20b0e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eee31338303f5f1552bfe10ee8905443f0aff93abfd702643fb26ddabc48a6862a9157a563d8ed56576865b99a1dba1157c8acdc449b48b8aed6a757c3b98343"} build_url:https://queue.taskcluster.net/v1/task/XtmM43fGSC6xnOXI8chh7Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011225 build_url: 'https://queue.taskcluster.net/v1/task/XtmM43fGSC6xnOXI8chh7Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33c97ed8c20591626ace50166e017529f9d790c8ea170e6d9b398cb26b2f1daa636d7968a81afd6dd7fda77df121cf3409f180bf3fadc9002b06b5ec8cd6a204", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8115bd92c0b69221ef4a2d1025f9cbf69b43e538e6ff7d4dae6c200d87a35358a7c9636bc1e91ba5cf50f8c56434edabc0d665f92917228cd096c0a22819f234", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7eed5b2b65bde05a15ec96a9af1db331c3676147ed8fb2ee6138df188b88d6be2a502711516eb1e78558b637dc20d63d2986467bbb8edbe91588fb5128c20b0e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eee31338303f5f1552bfe10ee8905443f0aff93abfd702643fb26ddabc48a6862a9157a563d8ed56576865b99a1dba1157c8acdc449b48b8aed6a757c3b98343"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-20 07:12:18.120178) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 07:12:18.120715) ========= 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.59bVaWKRG9/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.UX6SjBjEhC/Listeners TMPDIR=/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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.005295 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 07:12:18.171126) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-20 07:12:18.171638) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-20 07:12:18.172171) ========= ========= Total master_lag: 0.20 =========