builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0373 starttime: 1478027296.69 results: success (0) buildid: 20161101094904 builduid: 1e92f5052cd24cecb1cd8f5952467f0e revision: 45118388b658d19e06fe553cc41654eca677c64c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-01 12:08:16.691867) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-01 12:08:16.692441) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-01 12:08:16.692715) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-01 12:08:16.723598) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-01 12:08:16.724026) ========= 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.EUEufmH5Lh/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.cE8CpGiQpR/Listeners TMPDIR=/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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 --2016-11-01 12:08:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.5M=0.001s 2016-11-01 12:08:16 (18.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.125041 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-01 12:08:16.872161) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-01 12:08:16.872510) ========= 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.EUEufmH5Lh/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.cE8CpGiQpR/Listeners TMPDIR=/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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.025183 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-01 12:08:16.922454) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-01 12:08:16.922964) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 45118388b658d19e06fe553cc41654eca677c64c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 45118388b658d19e06fe553cc41654eca677c64c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.EUEufmH5Lh/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.cE8CpGiQpR/Listeners TMPDIR=/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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 2016-11-01 12:08:17,011 truncating revision to first 12 chars 2016-11-01 12:08:17,011 Setting DEBUG logging. 2016-11-01 12:08:17,011 attempt 1/10 2016-11-01 12:08:17,011 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/45118388b658?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-01 12:08:17,653 unpacking tar archive at: mozilla-aurora-45118388b658/testing/mozharness/ program finished with exit code 0 elapsedTime=0.928160 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-01 12:08:17.874658) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-01 12:08:17.875045) ========= script_repo_revision: 45118388b658d19e06fe553cc41654eca677c64c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-01 12:08:17.875578) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-01 12:08:17.875938) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-01 12:08:17.894649) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-11-01 12:08:17.894977) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.EUEufmH5Lh/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.cE8CpGiQpR/Listeners TMPDIR=/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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 12:08:18 INFO - MultiFileLogger online at 20161101 12:08:18 in /builds/slave/test 12:08:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 12:08:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:08:18 INFO - {'append_to_log': False, 12:08:18 INFO - 'base_work_dir': '/builds/slave/test', 12:08:18 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 12:08:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:08:18 INFO - 'branch': 'Mozilla-Aurora', 12:08:18 INFO - 'buildbot_json_path': 'buildprops.json', 12:08:18 INFO - 'config_files': ('talos/mac_config.py',), 12:08:18 INFO - 'default_actions': ('clobber', 12:08:18 INFO - 'read-buildbot-config', 12:08:18 INFO - 'download-and-extract', 12:08:18 INFO - 'populate-webroot', 12:08:18 INFO - 'create-virtualenv', 12:08:18 INFO - 'install', 12:08:18 INFO - 'run-tests'), 12:08:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:08:18 INFO - 'download_minidump_stackwalk': True, 12:08:18 INFO - 'download_symbols': 'ondemand', 12:08:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:08:18 INFO - 'tooltool.py': '/tools/tooltool.py', 12:08:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:08:18 INFO - '/tools/misc-python/virtualenv.py')}, 12:08:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:08:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:08:18 INFO - 'installer_path': 'installer.exe', 12:08:18 INFO - 'log_level': 'info', 12:08:18 INFO - 'log_name': 'talos', 12:08:18 INFO - 'log_to_console': True, 12:08:18 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:08:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:08:18 INFO - 'opt_config_files': (), 12:08:18 INFO - 'pip_index': False, 12:08:18 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:08:18 INFO - 'cmd': ('bash', 12:08:18 INFO - '-c', 12:08:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:08:18 INFO - 'enabled': True, 12:08:18 INFO - 'halt_on_failure': False, 12:08:18 INFO - 'name': 'check_screen_resolution'},), 12:08:18 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:08:18 INFO - 'cmd': ('bash', 12:08:18 INFO - '-c', 12:08:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:08:18 INFO - 'enabled': True, 12:08:18 INFO - 'halt_on_failure': False, 12:08:18 INFO - 'name': 'check_screen_resolution'},), 12:08:18 INFO - 'run_cmd_checks_enabled': True, 12:08:18 INFO - 'sps_profile': False, 12:08:18 INFO - 'sps_profile_interval': 0, 12:08:18 INFO - 'suite': 'dromaeojs', 12:08:18 INFO - 'system_bits': '32', 12:08:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:08:18 INFO - 'title': 't-yosemite-r7-0373', 12:08:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:08:18 INFO - 'use_talos_json': True, 12:08:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:08:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:08:18 INFO - 'work_dir': 'build'} 12:08:18 INFO - [mozharness: 2016-11-01 19:08:18.096860Z] Running clobber step. 12:08:18 INFO - Running pre-action listener: _resource_record_pre_action 12:08:18 INFO - Running main action method: clobber 12:08:18 INFO - rmtree: /builds/slave/test/build 12:08:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:08:20 INFO - Running post-action listener: _resource_record_post_action 12:08:20 INFO - [mozharness: 2016-11-01 19:08:20.224377Z] Finished clobber step (success) 12:08:20 INFO - [mozharness: 2016-11-01 19:08:20.224550Z] Running read-buildbot-config step. 12:08:20 INFO - Running pre-action listener: _resource_record_pre_action 12:08:20 INFO - Running main action method: read_buildbot_config 12:08:20 INFO - Using buildbot properties: 12:08:20 INFO - { 12:08:20 INFO - "project": "", 12:08:20 INFO - "product": "firefox", 12:08:20 INFO - "script_repo_revision": "production", 12:08:20 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 12:08:20 INFO - "repository": "", 12:08:20 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 12:08:20 INFO - "buildid": "20161101094904", 12:08:20 INFO - "pgo_build": "False", 12:08:20 INFO - "basedir": "/builds/slave/test", 12:08:20 INFO - "buildnumber": 9, 12:08:20 INFO - "slavename": "t-yosemite-r7-0373", 12:08:20 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 12:08:20 INFO - "platform": "yosemite_r7", 12:08:20 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 12:08:20 INFO - "branch": "mozilla-aurora", 12:08:20 INFO - "repo_path": "releases/mozilla-aurora", 12:08:20 INFO - "revision": "45118388b658d19e06fe553cc41654eca677c64c", 12:08:20 INFO - "stage_platform": "macosx64", 12:08:20 INFO - "builduid": "1e92f5052cd24cecb1cd8f5952467f0e", 12:08:20 INFO - "slavebuilddir": "test" 12:08:20 INFO - } 12:08:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/VpfapbcAR6Ghm5-DC40MgQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 12:08:20 INFO - Running post-action listener: _resource_record_post_action 12:08:20 INFO - [mozharness: 2016-11-01 19:08:20.227872Z] Finished read-buildbot-config step (success) 12:08:20 INFO - [mozharness: 2016-11-01 19:08:20.227976Z] Running download-and-extract step. 12:08:20 INFO - Running pre-action listener: _resource_record_pre_action 12:08:20 INFO - Running main action method: download_and_extract 12:08:20 INFO - mkdir: /builds/slave/test/build/tests 12:08:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:08:20 INFO - trying https://queue.taskcluster.net/v1/task/VpfapbcAR6Ghm5-DC40MgQ/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 12:08:20 INFO - Downloading https://queue.taskcluster.net/v1/task/VpfapbcAR6Ghm5-DC40MgQ/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 12:08:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VpfapbcAR6Ghm5-DC40MgQ/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 12:08:21 INFO - Downloaded 1199 bytes. 12:08:21 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 12:08:21 INFO - Using the following test package requirements: 12:08:21 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 12:08:21 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:08:21 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 12:08:21 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:08:21 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 12:08:21 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:08:21 INFO - u'jsshell-mac.zip'], 12:08:21 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:08:21 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 12:08:21 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 12:08:21 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:08:21 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 12:08:21 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:08:21 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 12:08:21 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:08:21 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 12:08:21 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:08:21 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 12:08:21 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 12:08:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VpfapbcAR6Ghm5-DC40MgQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 12:08:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VpfapbcAR6Ghm5-DC40MgQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 12:08:21 INFO - Fetch https://queue.taskcluster.net/v1/task/VpfapbcAR6Ghm5-DC40MgQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 12:08:21 INFO - Expected file size: 16421563 12:08:28 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 12:08:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VpfapbcAR6Ghm5-DC40MgQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 12:08:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VpfapbcAR6Ghm5-DC40MgQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 12:08:28 INFO - Fetch https://queue.taskcluster.net/v1/task/VpfapbcAR6Ghm5-DC40MgQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 12:08:29 INFO - Expected file size: 16421563 12:08:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VpfapbcAR6Ghm5-DC40MgQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 12:08:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VpfapbcAR6Ghm5-DC40MgQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 12:08:36 INFO - Fetch https://queue.taskcluster.net/v1/task/VpfapbcAR6Ghm5-DC40MgQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 12:08:36 INFO - Expected file size: 14414089 12:08:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:08:37 INFO - trying https://queue.taskcluster.net/v1/task/VpfapbcAR6Ghm5-DC40MgQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 12:08:37 INFO - Downloading https://queue.taskcluster.net/v1/task/VpfapbcAR6Ghm5-DC40MgQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 12:08:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VpfapbcAR6Ghm5-DC40MgQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 12:08:40 INFO - Downloaded 115424269 bytes. 12:08:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VpfapbcAR6Ghm5-DC40MgQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 12:08:40 INFO - mkdir: /builds/slave/test/properties 12:08:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:08:40 INFO - Writing to file /builds/slave/test/properties/build_url 12:08:40 INFO - Contents: 12:08:40 INFO - build_url:https://queue.taskcluster.net/v1/task/VpfapbcAR6Ghm5-DC40MgQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 12:08:40 INFO - Running post-action listener: _resource_record_post_action 12:08:40 INFO - Running post-action listener: set_extra_try_arguments 12:08:40 INFO - [mozharness: 2016-11-01 19:08:40.775499Z] Finished download-and-extract step (success) 12:08:40 INFO - [mozharness: 2016-11-01 19:08:40.775618Z] Running populate-webroot step. 12:08:40 INFO - Running pre-action listener: _resource_record_pre_action 12:08:40 INFO - Running main action method: populate_webroot 12:08:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:08:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:08:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:08:40 INFO - '--tppagecycles', 12:08:40 INFO - '7'], 12:08:40 INFO - 'tests': ['tsvgm']}}, 12:08:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:08:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:08:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:08:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:08:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:08:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:08:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:08:40 INFO - 'talos_options': ['--disable-e10s'], 12:08:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:08:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:08:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:08:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:08:40 INFO - 'talos_options': ['--disable-e10s'], 12:08:40 INFO - 'tests': ['damp', 'tps']}, 12:08:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:08:40 INFO - 'tests': ['damp', 'tps']}, 12:08:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:08:40 INFO - 'tests': ['dromaeo_dom']}, 12:08:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:08:40 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:08:40 INFO - 'tests': ['basic_compositor_video']}, 12:08:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:08:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:08:40 INFO - 'tests': ['a11yr', 12:08:40 INFO - 'ts_paint', 12:08:40 INFO - 'tpaint', 12:08:40 INFO - 'sessionrestore', 12:08:40 INFO - 'sessionrestore_no_auto_restore', 12:08:40 INFO - 'tabpaint']}, 12:08:40 INFO - 'other-e10s': {'tests': ['a11yr', 12:08:40 INFO - 'ts_paint', 12:08:40 INFO - 'tpaint', 12:08:40 INFO - 'sessionrestore', 12:08:40 INFO - 'sessionrestore_no_auto_restore', 12:08:40 INFO - 'tabpaint']}, 12:08:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:08:40 INFO - 'ts_paint', 12:08:40 INFO - 'tpaint', 12:08:40 INFO - 'sessionrestore', 12:08:40 INFO - 'sessionrestore_no_auto_restore', 12:08:40 INFO - 'tabpaint']}, 12:08:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:08:40 INFO - 'ts_paint', 12:08:40 INFO - 'tpaint', 12:08:40 INFO - 'sessionrestore', 12:08:40 INFO - 'sessionrestore_no_auto_restore', 12:08:40 INFO - 'tabpaint']}, 12:08:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:08:40 INFO - 'tests': ['a11yr', 12:08:40 INFO - 'ts_paint', 12:08:40 INFO - 'tpaint', 12:08:40 INFO - 'sessionrestore', 12:08:40 INFO - 'sessionrestore_no_auto_restore', 12:08:40 INFO - 'tabpaint']}, 12:08:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:08:40 INFO - 'tests': ['a11yr', 12:08:40 INFO - 'ts_paint', 12:08:40 INFO - 'tpaint', 12:08:40 INFO - 'sessionrestore', 12:08:40 INFO - 'sessionrestore_no_auto_restore', 12:08:40 INFO - 'tabpaint']}, 12:08:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:08:40 INFO - 'tests': ['tsvgx', 12:08:40 INFO - 'tsvgr_opacity', 12:08:40 INFO - 'tart', 12:08:40 INFO - 'tscrollx', 12:08:40 INFO - 'cart']}, 12:08:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:08:40 INFO - 'tsvgr_opacity', 12:08:40 INFO - 'tart', 12:08:40 INFO - 'tscrollx', 12:08:40 INFO - 'cart']}, 12:08:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:08:40 INFO - 'talos_options': ['--disable-e10s'], 12:08:40 INFO - 'tests': ['tp5o']}, 12:08:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:08:40 INFO - 'tests': ['tp5o']}, 12:08:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:08:40 INFO - 'talos_options': ['--disable-e10s', 12:08:40 INFO - '--xperf_path', 12:08:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:08:40 INFO - 'tests': ['tp5n']}, 12:08:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:08:40 INFO - 'talos_options': ['--xperf_path', 12:08:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:08:40 INFO - 'tests': ['tp5n']}}, 12:08:40 INFO - 'talos.zip': {'path': '', 12:08:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:08:40 INFO - Running post-action listener: _resource_record_post_action 12:08:40 INFO - [mozharness: 2016-11-01 19:08:40.793937Z] Finished populate-webroot step (success) 12:08:40 INFO - [mozharness: 2016-11-01 19:08:40.794022Z] Running create-virtualenv step. 12:08:40 INFO - Running pre-action listener: _resource_record_pre_action 12:08:40 INFO - Running main action method: create_virtualenv 12:08:40 INFO - Creating virtualenv /builds/slave/test/build/venv 12:08:40 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 12:08:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:08:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:08:40 INFO - Using real prefix '/tools/python27' 12:08:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:08:41 INFO - Installing distribute.............................................................................................................................................................................................done. 12:08:44 INFO - Installing pip.................done. 12:08:44 INFO - Return code: 0 12:08:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:08:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:08:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:08:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:08:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:08:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:08:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:08:44 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 0x103a02490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103978570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b625813c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103816d30>, '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 0x10367cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10380eb20>, '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.EUEufmH5Lh/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.cE8CpGiQpR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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 12:08:44 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 12:08:44 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 12:08:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EUEufmH5Lh/Render', 12:08:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:08:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:08:44 INFO - 'HOME': '/Users/cltbld', 12:08:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:08:44 INFO - 'LOGNAME': 'cltbld', 12:08:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:08:44 INFO - 'MOZ_NO_REMOTE': '1', 12:08:44 INFO - 'NO_EM_RESTART': '1', 12:08:44 INFO - 'PAGER': '/bin/cat', 12:08:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:08:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:08:44 INFO - 'PWD': '/builds/slave/test', 12:08:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:08:44 INFO - 'SHELL': '/bin/bash', 12:08:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cE8CpGiQpR/Listeners', 12:08:44 INFO - 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', 12:08:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:08:44 INFO - 'USER': 'cltbld', 12:08:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:08:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:08:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:08:44 INFO - 'XPC_FLAGS': '0x0', 12:08:44 INFO - 'XPC_SERVICE_NAME': '0', 12:08:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:08:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:08:44 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 12:08:44 INFO - Cleaning up... 12:08:44 INFO - Return code: 0 12:08:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:08:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:08:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:08:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:08:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:08:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:08:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:08:44 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 0x103a02490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103978570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b625813c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103816d30>, '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 0x10367cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10380eb20>, '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.EUEufmH5Lh/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.cE8CpGiQpR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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 12:08:44 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 12:08:44 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 12:08:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EUEufmH5Lh/Render', 12:08:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:08:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:08:44 INFO - 'HOME': '/Users/cltbld', 12:08:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:08:44 INFO - 'LOGNAME': 'cltbld', 12:08:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:08:44 INFO - 'MOZ_NO_REMOTE': '1', 12:08:44 INFO - 'NO_EM_RESTART': '1', 12:08:44 INFO - 'PAGER': '/bin/cat', 12:08:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:08:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:08:44 INFO - 'PWD': '/builds/slave/test', 12:08:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:08:44 INFO - 'SHELL': '/bin/bash', 12:08:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cE8CpGiQpR/Listeners', 12:08:44 INFO - 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', 12:08:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:08:44 INFO - 'USER': 'cltbld', 12:08:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:08:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:08:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:08:44 INFO - 'XPC_FLAGS': '0x0', 12:08:44 INFO - 'XPC_SERVICE_NAME': '0', 12:08:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:08:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:08:45 INFO - Downloading/unpacking psutil>=3.1.1 12:08:45 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 12:08:45 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 12:08:45 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 12:08:45 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 12:08:45 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 12:08:45 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 12:08:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:08:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:08:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:08:48 INFO - Installing collected packages: psutil 12:08:48 INFO - Running setup.py install for psutil 12:08:49 INFO - building 'psutil._psutil_osx' extension 12:08:49 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 12:08:49 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 12:08:49 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 12:08:49 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 12:08:49 INFO - building 'psutil._psutil_posix' extension 12:08:49 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 12:08:49 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:08:49 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:08:49 INFO - ^ 12:08:49 INFO - 1 warning generated. 12:08:49 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 12:08:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:08:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:08:50 INFO - Successfully installed psutil 12:08:50 INFO - Cleaning up... 12:08:50 INFO - Return code: 0 12:08:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:08:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:08:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:08:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:08:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:08:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:08:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103a02490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103978570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b625813c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103816d30>, '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 0x10367cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10380eb20>, '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.EUEufmH5Lh/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.cE8CpGiQpR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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 12:08:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:08:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:08:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EUEufmH5Lh/Render', 12:08:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:08:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:08:50 INFO - 'HOME': '/Users/cltbld', 12:08:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:08:50 INFO - 'LOGNAME': 'cltbld', 12:08:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:08:50 INFO - 'MOZ_NO_REMOTE': '1', 12:08:50 INFO - 'NO_EM_RESTART': '1', 12:08:50 INFO - 'PAGER': '/bin/cat', 12:08:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:08:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:08:50 INFO - 'PWD': '/builds/slave/test', 12:08:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:08:50 INFO - 'SHELL': '/bin/bash', 12:08:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cE8CpGiQpR/Listeners', 12:08:50 INFO - 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', 12:08:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:08:50 INFO - 'USER': 'cltbld', 12:08:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:08:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:08:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:08:50 INFO - 'XPC_FLAGS': '0x0', 12:08:50 INFO - 'XPC_SERVICE_NAME': '0', 12:08:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:08:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:08:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:08:50 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 12:08:50 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 12:08:50 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 12:08:50 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 12:08:50 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 12:08:50 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 12:08:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:08:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:08:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:08:53 INFO - Installing collected packages: mozsystemmonitor 12:08:53 INFO - Running setup.py install for mozsystemmonitor 12:08:53 INFO - Successfully installed mozsystemmonitor 12:08:53 INFO - Cleaning up... 12:08:53 INFO - Return code: 0 12:08:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:08:53 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')]} 12:08:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:08:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:08:53 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')]} 12:08:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:08:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:08:53 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 0x103a02490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103978570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b625813c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103816d30>, '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 0x10367cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10380eb20>, '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.EUEufmH5Lh/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.cE8CpGiQpR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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 12:08:53 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 12:08:53 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 12:08:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EUEufmH5Lh/Render', 12:08:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:08:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:08:53 INFO - 'HOME': '/Users/cltbld', 12:08:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:08:53 INFO - 'LOGNAME': 'cltbld', 12:08:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:08:53 INFO - 'MOZ_NO_REMOTE': '1', 12:08:53 INFO - 'NO_EM_RESTART': '1', 12:08:53 INFO - 'PAGER': '/bin/cat', 12:08:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:08:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:08:53 INFO - 'PWD': '/builds/slave/test', 12:08:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:08:53 INFO - 'SHELL': '/bin/bash', 12:08:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cE8CpGiQpR/Listeners', 12:08:53 INFO - 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', 12:08:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:08:53 INFO - 'USER': 'cltbld', 12:08:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:08:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:08:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:08:53 INFO - 'XPC_FLAGS': '0x0', 12:08:53 INFO - 'XPC_SERVICE_NAME': '0', 12:08:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:08:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:08:53 INFO - Downloading/unpacking jsonschema==2.5.1 12:08:53 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 12:08:53 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 12:08:53 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 12:08:53 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 12:08:53 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 12:08:53 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 12:08:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:08:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:08:56 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 12:08:56 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 12:08:56 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 12:08:56 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 12:08:56 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 12:08:56 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 12:08:56 INFO - Downloading functools32-3.2.3-2.tar.gz 12:08:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:08:56 INFO - warning: no files found matching '*.txt' 12:08:56 INFO - no previously-included directories found matching 'build' 12:08:56 INFO - no previously-included directories found matching 'dist' 12:08:56 INFO - no previously-included directories found matching '.git*' 12:08:56 INFO - Installing collected packages: jsonschema, functools32 12:08:56 INFO - Running setup.py install for functools32 12:08:56 INFO - warning: no files found matching '*.txt' 12:08:56 INFO - no previously-included directories found matching 'build' 12:08:56 INFO - no previously-included directories found matching 'dist' 12:08:56 INFO - no previously-included directories found matching '.git*' 12:08:56 INFO - Successfully installed jsonschema functools32 12:08:56 INFO - Cleaning up... 12:08:56 INFO - Return code: 0 12:08:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:08:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:08:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:08:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:08:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:08:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:08:56 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 0x103a02490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103978570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b625813c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103816d30>, '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 0x10367cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10380eb20>, '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.EUEufmH5Lh/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.cE8CpGiQpR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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 12:08:56 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 12:08:56 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 12:08:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EUEufmH5Lh/Render', 12:08:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:08:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:08:56 INFO - 'HOME': '/Users/cltbld', 12:08:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:08:56 INFO - 'LOGNAME': 'cltbld', 12:08:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:08:56 INFO - 'MOZ_NO_REMOTE': '1', 12:08:56 INFO - 'NO_EM_RESTART': '1', 12:08:56 INFO - 'PAGER': '/bin/cat', 12:08:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:08:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:08:56 INFO - 'PWD': '/builds/slave/test', 12:08:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:08:56 INFO - 'SHELL': '/bin/bash', 12:08:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cE8CpGiQpR/Listeners', 12:08:56 INFO - 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', 12:08:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:08:56 INFO - 'USER': 'cltbld', 12:08:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:08:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:08:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:08:56 INFO - 'XPC_FLAGS': '0x0', 12:08:56 INFO - 'XPC_SERVICE_NAME': '0', 12:08:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:08:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:08:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:08:57 INFO - Cleaning up... 12:08:57 INFO - Return code: 0 12:08:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:08: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')]} 12:08:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:08:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:08: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')]} 12:08:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:08:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:08:57 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 0x103a02490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103978570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b625813c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103816d30>, '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 0x10367cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10380eb20>, '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.EUEufmH5Lh/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.cE8CpGiQpR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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 12:08:57 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 12:08:57 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 12:08:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EUEufmH5Lh/Render', 12:08:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:08:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:08:57 INFO - 'HOME': '/Users/cltbld', 12:08:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:08:57 INFO - 'LOGNAME': 'cltbld', 12:08:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:08:57 INFO - 'MOZ_NO_REMOTE': '1', 12:08:57 INFO - 'NO_EM_RESTART': '1', 12:08:57 INFO - 'PAGER': '/bin/cat', 12:08:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:08:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:08:57 INFO - 'PWD': '/builds/slave/test', 12:08:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:08:57 INFO - 'SHELL': '/bin/bash', 12:08:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cE8CpGiQpR/Listeners', 12:08:57 INFO - 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', 12:08:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:08:57 INFO - 'USER': 'cltbld', 12:08:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:08:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:08:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:08:57 INFO - 'XPC_FLAGS': '0x0', 12:08:57 INFO - 'XPC_SERVICE_NAME': '0', 12:08:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:08:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:08:57 INFO - Downloading/unpacking blobuploader==1.2.4 12:08:57 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 12:08:57 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 12:08:57 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 12:08:57 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 12:08:57 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 12:08:57 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 12:08:59 INFO - Downloading blobuploader-1.2.4.tar.gz 12:08:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:08:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:08: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 12:08: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 12:08: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 12:08: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 12:08: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 12:08: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 12:09:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:09:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:09:00 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 12:09:00 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 12:09:00 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 12:09:00 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 12:09:00 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 12:09:00 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 12:09:00 INFO - Downloading docopt-0.6.1.tar.gz 12:09:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:09:01 INFO - Installing collected packages: blobuploader, requests, docopt 12:09:01 INFO - Running setup.py install for blobuploader 12:09:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:09:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:09:01 INFO - Running setup.py install for requests 12:09:01 INFO - Running setup.py install for docopt 12:09:01 INFO - Successfully installed blobuploader requests docopt 12:09:01 INFO - Cleaning up... 12:09:02 INFO - Return code: 0 12:09:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:09:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:09:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:09:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:09:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:02 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 0x103a02490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103978570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b625813c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103816d30>, '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 0x10367cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10380eb20>, '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.EUEufmH5Lh/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.cE8CpGiQpR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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 12:09:02 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 12:09:02 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 12:09:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EUEufmH5Lh/Render', 12:09:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:09:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:09:02 INFO - 'HOME': '/Users/cltbld', 12:09:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:09:02 INFO - 'LOGNAME': 'cltbld', 12:09:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:09:02 INFO - 'MOZ_NO_REMOTE': '1', 12:09:02 INFO - 'NO_EM_RESTART': '1', 12:09:02 INFO - 'PAGER': '/bin/cat', 12:09:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:09:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:09:02 INFO - 'PWD': '/builds/slave/test', 12:09:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:09:02 INFO - 'SHELL': '/bin/bash', 12:09:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cE8CpGiQpR/Listeners', 12:09:02 INFO - 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', 12:09:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:09:02 INFO - 'USER': 'cltbld', 12:09:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:09:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:09:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:09:02 INFO - 'XPC_FLAGS': '0x0', 12:09:02 INFO - 'XPC_SERVICE_NAME': '0', 12:09:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:09:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:09:02 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-6IXnNz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:09:02 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-rBRyB6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:09:02 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-79H8Bg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:09:02 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-l5NnVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:09:02 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-NkpR5p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:09:02 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-KPf0mo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:09:02 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-foQkw3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:09:02 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-Z_62XN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:09:03 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-ElcHEV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:09:03 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-g6oaLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:09:03 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-s0k7N1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:09:03 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-NBUgWs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:09:03 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-REd22t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:09:03 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-cnTvT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:09:03 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-y7VHYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:09:03 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-ySn3Vl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:09:03 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-8WQ5UX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:09:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:09:04 INFO - Running setup.py install for manifestparser 12:09:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:09:04 INFO - Running setup.py install for mozcrash 12:09:04 INFO - Running setup.py install for mozdebug 12:09:04 INFO - Running setup.py install for mozdevice 12:09:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:09:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:09:04 INFO - Running setup.py install for mozfile 12:09:04 INFO - Running setup.py install for mozhttpd 12:09:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:09:04 INFO - Running setup.py install for mozinfo 12:09:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:09:05 INFO - Running setup.py install for mozInstall 12:09:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:09:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:09:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:09:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:09:05 INFO - Running setup.py install for mozleak 12:09:05 INFO - Running setup.py install for mozlog 12:09:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:09:05 INFO - Running setup.py install for moznetwork 12:09:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:09:05 INFO - Running setup.py install for mozprocess 12:09:05 INFO - Running setup.py install for mozprofile 12:09:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:09:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:09:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:09:05 INFO - Running setup.py install for mozrunner 12:09:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:09:06 INFO - Running setup.py install for mozscreenshot 12:09:06 INFO - Running setup.py install for moztest 12:09:06 INFO - Running setup.py install for mozversion 12:09:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:09:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:09:06 INFO - Cleaning up... 12:09:06 INFO - Return code: 0 12:09:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:09:06 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')]} 12:09:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:09:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:06 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')]} 12:09:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:09:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:06 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 0x103a02490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103978570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b625813c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103816d30>, '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 0x10367cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10380eb20>, '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.EUEufmH5Lh/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.cE8CpGiQpR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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 12:09:06 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 12:09:06 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 12:09:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EUEufmH5Lh/Render', 12:09:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:09:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:09:06 INFO - 'HOME': '/Users/cltbld', 12:09:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:09:06 INFO - 'LOGNAME': 'cltbld', 12:09:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:09:06 INFO - 'MOZ_NO_REMOTE': '1', 12:09:06 INFO - 'NO_EM_RESTART': '1', 12:09:06 INFO - 'PAGER': '/bin/cat', 12:09:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:09:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:09:06 INFO - 'PWD': '/builds/slave/test', 12:09:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:09:06 INFO - 'SHELL': '/bin/bash', 12:09:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cE8CpGiQpR/Listeners', 12:09:06 INFO - 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', 12:09:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:09:06 INFO - 'USER': 'cltbld', 12:09:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:09:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:09:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:09:06 INFO - 'XPC_FLAGS': '0x0', 12:09:06 INFO - 'XPC_SERVICE_NAME': '0', 12:09:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:09:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:09:06 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-ZDuAl8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:09:07 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)) 12:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:09:07 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-mBPoZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:09:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 12:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:09:07 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-fpc_71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:09:07 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)) 12:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:09:07 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-L3i3Tl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:09:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 12:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:09:07 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-29xQUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:09:07 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)) 12:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:09:07 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-mQHsSL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:09:07 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)) 12:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:09:07 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-wAKLH7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:09:07 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)) 12:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:09:07 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-yqoDkS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:09:07 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)) 12:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:09:07 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-meqt8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:09:07 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)) 12:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:09:07 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-BWzGmU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:09:07 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)) 12:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:09:07 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-rdIs2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:09:08 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)) 12:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:09:08 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-53rw7Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:09:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 12:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:09:08 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-WAYlC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:09:08 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)) 12:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:09:08 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-Lm_dzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:09:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 12:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:09:08 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-Zi7v6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:09:08 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)) 12:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:09:08 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-YxZq4C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:09:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 12:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:09:08 INFO - Running setup.py (path:/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/pip-bI4zzS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:09:08 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)) 12:09:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:09:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:09:08 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)) 12:09:08 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:09:08 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:09:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:09:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:09:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:09:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:09:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:09:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:09:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:09:12 INFO - Downloading blessings-1.6.tar.gz 12:09:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:09:12 INFO - Installing collected packages: blessings 12:09:12 INFO - Running setup.py install for blessings 12:09:12 INFO - Successfully installed blessings 12:09:12 INFO - Cleaning up... 12:09:12 INFO - Return code: 0 12:09:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:09:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:09:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:09:12 INFO - Reading from file tmpfile_stdout 12:09:12 INFO - Current package versions: 12:09:12 INFO - blessings == 1.6 12:09:12 INFO - blobuploader == 1.2.4 12:09:12 INFO - docopt == 0.6.1 12:09:12 INFO - functools32 == 3.2.3-2 12:09:12 INFO - jsonschema == 2.5.1 12:09:12 INFO - manifestparser == 1.1 12:09:12 INFO - mozInstall == 1.12 12:09:12 INFO - mozcrash == 0.17 12:09:12 INFO - mozdebug == 0.1 12:09:12 INFO - mozdevice == 0.48 12:09:12 INFO - mozfile == 1.2 12:09:12 INFO - mozhttpd == 0.7 12:09:12 INFO - mozinfo == 0.9 12:09:12 INFO - mozleak == 0.1 12:09:12 INFO - mozlog == 3.4 12:09:12 INFO - moznetwork == 0.27 12:09:12 INFO - mozprocess == 0.23 12:09:12 INFO - mozprofile == 0.28 12:09:12 INFO - mozrunner == 6.12 12:09:12 INFO - mozscreenshot == 0.1 12:09:12 INFO - mozsystemmonitor == 0.3 12:09:12 INFO - moztest == 0.7 12:09:12 INFO - mozversion == 1.4 12:09:12 INFO - psutil == 3.1.1 12:09:12 INFO - requests == 1.2.3 12:09:12 INFO - wsgiref == 0.1.2 12:09:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:09:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:09:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:09:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:09:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:12 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 0x103a02490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103978570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b625813c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103816d30>, '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 0x10367cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10380eb20>, '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.EUEufmH5Lh/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.cE8CpGiQpR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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 12:09:12 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 12:09:12 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 12:09:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EUEufmH5Lh/Render', 12:09:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:09:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:09:12 INFO - 'HOME': '/Users/cltbld', 12:09:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:09:12 INFO - 'LOGNAME': 'cltbld', 12:09:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:09:12 INFO - 'MOZ_NO_REMOTE': '1', 12:09:12 INFO - 'NO_EM_RESTART': '1', 12:09:12 INFO - 'PAGER': '/bin/cat', 12:09:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:09:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:09:12 INFO - 'PWD': '/builds/slave/test', 12:09:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:09:12 INFO - 'SHELL': '/bin/bash', 12:09:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cE8CpGiQpR/Listeners', 12:09:12 INFO - 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', 12:09:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:09:12 INFO - 'USER': 'cltbld', 12:09:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:09:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:09:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:09:12 INFO - 'XPC_FLAGS': '0x0', 12:09:12 INFO - 'XPC_SERVICE_NAME': '0', 12:09:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:09:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:09:13 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)) 12:09:13 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)) 12:09:13 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)) 12:09:13 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)) 12:09:13 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)) 12:09:13 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)) 12:09:13 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)) 12:09:13 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)) 12:09:13 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)) 12:09:13 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)) 12:09:13 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)) 12:09:13 INFO - Cleaning up... 12:09:13 INFO - Return code: 0 12:09:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:09:13 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')]} 12:09:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:09:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:13 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')]} 12:09:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:09:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:13 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 0x103a02490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103978570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b625813c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103816d30>, '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 0x10367cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10380eb20>, '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.EUEufmH5Lh/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.cE8CpGiQpR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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 12:09:13 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 12:09:13 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 12:09:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EUEufmH5Lh/Render', 12:09:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:09:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:09:13 INFO - 'HOME': '/Users/cltbld', 12:09:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:09:13 INFO - 'LOGNAME': 'cltbld', 12:09:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:09:13 INFO - 'MOZ_NO_REMOTE': '1', 12:09:13 INFO - 'NO_EM_RESTART': '1', 12:09:13 INFO - 'PAGER': '/bin/cat', 12:09:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:09:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:09:13 INFO - 'PWD': '/builds/slave/test', 12:09:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:09:13 INFO - 'SHELL': '/bin/bash', 12:09:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cE8CpGiQpR/Listeners', 12:09:13 INFO - 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', 12:09:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:09:13 INFO - 'USER': 'cltbld', 12:09:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:09:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:09:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:09:13 INFO - 'XPC_FLAGS': '0x0', 12:09:13 INFO - 'XPC_SERVICE_NAME': '0', 12:09:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:09:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:09:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:09:13 INFO - Cleaning up... 12:09:13 INFO - Return code: 0 12:09:13 INFO - Running post-action listener: _resource_record_post_action 12:09:13 INFO - Running post-action listener: _start_resource_monitoring 12:09:13 INFO - Starting resource monitoring. 12:09:13 INFO - [mozharness: 2016-11-01 19:09:13.445950Z] Finished create-virtualenv step (success) 12:09:13 INFO - [mozharness: 2016-11-01 19:09:13.446917Z] Running install step. 12:09:13 INFO - Running pre-action listener: _resource_record_pre_action 12:09:13 INFO - Running main action method: install 12:09:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:09:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:09:13 INFO - Reading from file tmpfile_stdout 12:09:13 INFO - Detecting whether we're running mozinstall >=1.0... 12:09:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:09:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:09:13 INFO - Reading from file tmpfile_stdout 12:09:13 INFO - Output received: 12:09:13 INFO - Usage: mozinstall [options] installer 12:09:13 INFO - Options: 12:09:13 INFO - -h, --help show this help message and exit 12:09:13 INFO - -d DEST, --destination=DEST 12:09:13 INFO - Directory to install application into. [default: 12:09:13 INFO - "/builds/slave/test"] 12:09:13 INFO - --app=APP Application being installed. [default: firefox] 12:09:13 INFO - mkdir: /builds/slave/test/build/application 12:09:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 12:09:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 12:09:45 INFO - Reading from file tmpfile_stdout 12:09:45 INFO - Output received: 12:09:45 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 12:09:45 INFO - Running post-action listener: _resource_record_post_action 12:09:45 INFO - [mozharness: 2016-11-01 19:09:45.723124Z] Finished install step (success) 12:09:45 INFO - [mozharness: 2016-11-01 19:09:45.723296Z] Running run-tests step. 12:09:45 INFO - Running pre-action listener: _resource_record_pre_action 12:09:45 INFO - Running main action method: run_tests 12:09:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:09:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:09:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:09:45 INFO - 2016-11-01 12:09:45.737 screenresolution[1747:8643] starting screenresolution argv=screenresolution get 12:09:45 INFO - 2016-11-01 12:09:45.740 screenresolution[1747:8643] Display 0: 1600x1200x32@60 12:09:45 INFO - 2016-11-01 12:09:45.745 screenresolution[1748:8645] starting screenresolution argv=screenresolution list 12:09:45 INFO - Available Modes on Display 0 12:09:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:09:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:09:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:09:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:09:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:09:45 INFO - Intel Iris: 12:09:45 INFO - Chipset Model: Intel Iris 12:09:45 INFO - Type: GPU 12:09:45 INFO - Bus: Built-In 12:09:45 INFO - VRAM (Dynamic, Max): 1536 MB 12:09:45 INFO - Vendor: Intel (0x8086) 12:09:45 INFO - Device ID: 0x0a2e 12:09:45 INFO - Revision ID: 0x0009 12:09:45 INFO - Displays: 12:09:45 INFO - Display: 12:09:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:09:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:09:45 INFO - Display Serial Number: 1600x1200 60 12:09:45 INFO - Main Display: Yes 12:09:45 INFO - Mirror: Off 12:09:45 INFO - Online: Yes 12:09:45 INFO - Rotation: Supported 12:09:45 INFO - Return code: 0 12:09:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:09:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:09:45 INFO - Python 2.7.3 12:09:45 INFO - Return code: 0 12:09:45 INFO - grabbing minidump binary from tooltool 12:09:45 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')]} 12:09:45 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 0x103816d30>, '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 0x10367cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10380eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:09:45 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 12:09:45 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 12:09:45 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 12:09:46 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:09:46 INFO - Return code: 0 12:09:46 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:09:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:09:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:09:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:09:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:09:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VpfapbcAR6Ghm5-DC40MgQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0373', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 12:09:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VpfapbcAR6Ghm5-DC40MgQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0373 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 12:09:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EUEufmH5Lh/Render', 12:09:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:09:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:09:46 INFO - 'HOME': '/Users/cltbld', 12:09:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:09:46 INFO - 'LOGNAME': 'cltbld', 12:09:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:09:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:09:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:09:46 INFO - 'MOZ_NO_REMOTE': '1', 12:09:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:09:46 INFO - 'NO_EM_RESTART': '1', 12:09:46 INFO - 'PAGER': '/bin/cat', 12:09:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:09:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:09:46 INFO - 'PWD': '/builds/slave/test', 12:09:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:09:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:09:46 INFO - 'SHELL': '/bin/bash', 12:09:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cE8CpGiQpR/Listeners', 12:09:46 INFO - 'TMPDIR': '/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/', 12:09:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:09:46 INFO - 'USER': 'cltbld', 12:09:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:09:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:09:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:09:46 INFO - 'XPC_FLAGS': '0x0', 12:09:46 INFO - 'XPC_SERVICE_NAME': '0', 12:09:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:09:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VpfapbcAR6Ghm5-DC40MgQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0373', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 12:09:46 INFO - mozversion application_buildid: 20161101094904 12:09:46 INFO - mozversion application_changeset: 45118388b658d19e06fe553cc41654eca677c64c 12:09:46 INFO - mozversion application_display_name: FirefoxDeveloperEdition 12:09:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:09:46 INFO - mozversion application_name: Firefox 12:09:46 INFO - mozversion application_remotingname: firefox-dev 12:09:46 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:09:46 INFO - mozversion application_vendor: Mozilla 12:09:46 INFO - mozversion application_version: 51.0a2 12:09:46 INFO - mozversion platform_buildid: 20161101094904 12:09:46 INFO - mozversion platform_changeset: 45118388b658d19e06fe553cc41654eca677c64c 12:09:46 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:09:46 INFO - mozversion platform_version: 51.0a2 12:09:46 INFO - using testdate: 1478027386 12:09:46 INFO - actual date: 1478027386 12:09:46 INFO - starting webserver on 'localhost:49273' 12:09:46 INFO - SUITE-START | Running 2 tests 12:09:46 INFO - TEST-START | dromaeo_css 12:09:46 INFO - operating with platform_type : mac_ 12:09:46 INFO - Initialising browser for dromaeo_css test... 12:09:46 INFO - TEST-INFO | started process 1758 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/tmpmEpJ1f/profile http://localhost:49273/getInfo.html) 12:09:48 INFO - PROCESS | 1758 | __metrics Screen width/height:1600/1200 12:09:48 INFO - PROCESS | 1758 | colorDepth:24 12:09:48 INFO - PROCESS | 1758 | Browser inner width/height: 1024/689 12:09:48 INFO - PROCESS | 1758 | __metrics 12:09:48 INFO - PROCESS | 1758 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:09:48 INFO - PROCESS | 1758 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:09:49 INFO - TEST-INFO | 1758: exit 0 12:09:49 INFO - Browser initialized. 12:09:49 INFO - Running cycle 1/1 for dromaeo_css test... 12:09:49 INFO - TEST-INFO | started process 1762 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/tmpmEpJ1f/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:10:01 INFO - PROCESS | 1762 | RSS: Main: 219582464 12:10:01 INFO - PROCESS | 1762 | 12:10:59 INFO - PROCESS | 1762 | 1478027459661 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 12:13:05 INFO - PROCESS | 1762 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 12:13:07 INFO - PROCESS | 1762 | RSS: Main: 393412608 12:13:07 INFO - PROCESS | 1762 | 12:16:10 INFO - PROCESS | 1762 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 12:16:10 INFO - PROCESS | 1762 | RSS: Main: 352690176 12:16:10 INFO - PROCESS | 1762 | 12:19:13 INFO - PROCESS | 1762 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 12:19:13 INFO - PROCESS | 1762 | RSS: Main: 329437184 12:19:13 INFO - PROCESS | 1762 | 12:22:16 INFO - PROCESS | 1762 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 12:22:16 INFO - PROCESS | 1762 | RSS: Main: 320700416 12:22:16 INFO - PROCESS | 1762 | 12:25:19 INFO - PROCESS | 1762 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 12:25:20 INFO - PROCESS | 1762 | RSS: Main: 310906880 12:25:20 INFO - PROCESS | 1762 | 12:28:23 INFO - PROCESS | 1762 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 12:28:23 INFO - PROCESS | 1762 | RSS: Main: 362033152 12:28:23 INFO - PROCESS | 1762 | 12:28:23 INFO - PROCESS | 1762 | __start_tp_report 12:28:23 INFO - PROCESS | 1762 | _x_x_mozilla_page_load 12:28:23 INFO - PROCESS | 1762 | _x_x_mozilla_page_load_details 12:28:23 INFO - PROCESS | 1762 | |i|pagename|runs| 12:28:23 INFO - PROCESS | 1762 | |0;dojo.html;2753.091479811662;3345.41455245332;3369.511420843979;3373.645767194446;3415.2998635279755;5656.519195868351;5746.454086861752;5768.134779783035;5789.71051447427;5803.390643982384;5689.914651280224;5757.424257574251;5758.049921762904;5765.6540607563575;5793.681347525884;5239.711815850127;5244.580433565325;5245.344331958505;5275.36695596529;5292.867678308035;5214.165733482643;5215.791368345281;5249.4750524947585;5335.519803217729;5363.249145119687;5309.203619457093;5326.440723724011;5343.679379237239;5344.759485823128;5352.330958630171;5311.9468805311835;5315.840524784263;5317.042932272189;5326.97336513315;5327.866803329948;5121.692698438068;5199.818006369796;5233.790648374061;5241.842744717665;5251.369835619712;5771.394003629601;5782.3639399666;5801.535877129862;5855.414458554111;5878.970605146947;6288.842778930563;6293.716782744787;6317;6319.58922670025;6335.239771227436;6116.579253789288;6167.167432396614;6209.161763162006;6237.376262373727;6242.15730876335;5795.1017592273265;5795.1017592273265;5804.071348584291;5813.88372232553;5817.94182058174;6293.402126797947;6308.52686048539;6313.368663133741;6313.9368606314265;6317.14718513004;6031.457168854737;6075.027995520695;6117.480014198754;6143.389059649631;6194.845128871724;6260;6265.65538895356;6271.122042913996;6271.96864015677;6295.276043254993;6223.844403889939;6226.283977342573;6239.06414037898;6253.906191407133;6274.121622972787;6087.969560152171;6103.6948152592195;6106.877817708206;6207.099970504251;6272.905906411407;4908.9754551227015;4914.238293064581;4935.358403407534;4952.306677065214;4955.380577427822;3753.6997040236715;4433.623142032899;4438.933415998763;4446.4886538047895;4470.977645111819;5741;5767.567432442584;5811.564132690065;5817;5817.040188368872;6143.631382117087;6192.225971753531;6226.25284965798;6238.001919692827;6266.279377871512;5772.9711351442975;5782.421757824184;5785.987452195849;5795.420457954255;5819.301683797887;5397.892042159135;5398.676079435247;5400.513953744182;5404.243405923174;5404.3784964728775;6229.906551401823;6234.937650623436;6250.562460627712;6276.623402595859;6311.463525600376;6151.292601350902;6193.38066193377;6250.374962503895;6253.437190652863;6253.687315634291;6284.591501552384;6285.748570057147;6298.08677741734;6302.905456418249;6309.305976342507;6071.666058366833;6102.664353460602;6112.786052488142;6125.295591007091;6131.294901086432;5081.263216833465;6000.759969601167;6159.9528080227365;6231.626102433868;6232.220972378453;6046.365131661112;6094.7257373417415;6114;6130.5402094842175;6136.478399336106;6031.69841507914;6112.388761123852;6116.663583502772;6120.785772497941;6127.632342059491;4959.404871415453;5833.4749872511675;5860.150278209721;5860.355360910211;5897.7935772247765;6080.817575472743;6129.233845769279;6133.028644417115;6162.352952939877;6170.290416602148;5835.766569337179;5901.350851406428;5912.615679980788;5964.970175149097;5997.670128142994 12:28:23 INFO - PROCESS | 1762 | |1;ext.html;460.38768437977495;482.22361997184527;490.41640447867036;513.0739016075983;514.6268955007617;30947.381052378965;32672.509912351303;41113;42151.57848421515;42212.36681449773;43287;43807;43826.561734382645;44012;44224.99999999992;9706.02939706029;9868.654597089104;9903;9915.90084099157;9930.45382503962;8807.559622018873;8950.283977281835;11858.881411185906;12135.211211271284;12156.51373945041;12030.69923251917;12116.636500904942;12121.393930303493;12125.514979400858;12131.090168237417;8804.823903521958;12145.45345459452;12242.693932651666;12254.877451225508;12258.693532661666;8690.652373905035;11661.358625275607;12006.759864802654;12011.819822702666;12245.510179592806;41182;41776;41866.58133418688;41901.1619767603;41942.161156777;3283.8522266498067;3285.6200395833807;3354.8490317935753;3355.580552430946;3443.896683099511;29938.101856944326;30400;30756.2310942226;32747.6725232747;32759.344813103606;3208.983955080233;3226.935461290761;3269.3134441767256;3311.122552523583;3399.6940275375337;474370.6281468605;519168.80831191584;526981;526981;528294;33830.323393531995;34186.82906585451;59593.70203148956;60142.39857601455;60144.398556014756;35086;35589.46615800765;35592.82203588966;35656.10859728476;35695.92912212638;15127.621809454851;15257.923710381378;15301.846981530041;15306.770398444032;15311.923440382727;11683.532658693726;11932.880671193177;12908.806367904488;13018.804717929239;13202.943764498817;7624.656890439944;7796.181400952932;7807.219278072147;7852.371810255166;7919.604019798987;3024.6370435547874;3171.4608516552244;3223.8065716057113;3225.5645487859306;3274.0341599228286;934.4113208678489;1016.4714348538719;1023.4524529376748;1056.6143357674548;1106.5076041161767;30189;30240.546391804142;30367.544486832714;30401.37146046593;30451.847740761154;1028.4035259549444;1029.5572903651503;1062.8352605346029;1071.4000159910474;1138.413716935762;12565.874341256653;15705.842941570667;15837;15918.061354688467;16065.11641859709;701017;762239;764153;766777;1023643;60493;61123.694381528694;61246;61247.77504449975;61340;1225.3689349984943;1242.7700875338091;1314.6581888709004;1355.3697530648296;1379.951701690436;26512.602310965736;31115.688843112184;31134.688653114084;31745.20636984094;32411.837940810146;54666;55368.169477457064;55409;55544.44455555554;55798.721006394706;680702;687414;689520;690196;690443;35639.10902227362;35926.640733593376;43113.78443107764;43384.13231735284;43848.34227486527;39428;46539.9126290715;50041.74979125081;50931.65217652242;51039.46881593558;38395.80802095972;39676;39949.80025099856;40049.1990160201;41311;39504.03719720975;40075.79962100171;40497;40917.59082409138;41260.1747965045;38331.616683832806;38795.6120438792;39335.40996884992;39461.21077578375;39665.60334396619;29910.401791964476;33479.49780753242;34446.82776586101;35383.469247960784;35494;23615.29154125379;24864.967402481627;25888.8705556471;26003.479930400907;26482.205533834014 12:28:23 INFO - PROCESS | 1762 | |2;jquery.html;331.50440092062365;357.0965457392794;382.11159055196674;384.4751913637883;410.17145366359955;14898.77651835222;15070;15997.520074397773;20490;20946.685799713017;15177.468788592401;19971;20603.587928241424;21257.25599604014;21416.35750927471;5930.851728706784;6188.907166392508;6194.101855230989;6205.81382558524;6205.968970155143;4918.852434426955;5748.5975981681295;6832.760853370133;6904.13698287714;6909.309069093076;5855.61938474;6148.815535533941;6852;6867.381935625793;6895.551789133715;6164.29110652274;6202.224721909762;6205.689715514206;6214.223222097238;6220.315765265795;5753.510951569122;5974.074018527135;6039.305479869783;6041.335453100155;6048;13207.471701131943;13428.127171733904;14019;24856;25161.119360822468;2318.675385446039;2348.6829278047417;2387.928362149138;2397.7841994220603;2958.8224706517462;9487.90512094884;9759.90240097597;9875.506224688737;10070.888774864574;10208.948955255251;1804.738312944629;1866.925322987079;1897.8197071278344;1938.1278424708937;1956.344624550777;112564.43717781441;119280;119596.80403195944;122125;123016;11296.71758206035;11468.254563453349;11541.249818761753;11553.191276610725;11806.232594881305;14555.563333100024;14586.781198282035;14593.78109328361;14616.488422905148;14645.267736613127;7474.327310542078;8306.792330191794;8372.748817535483;8483.872741908875;8628.654853805778;8414.705485307984;8419.768761278267;8425.452345597516;8556.828863422697;8608.48349099056;4444.400005999213;4563.794629241625;4571.954280457219;4600.907981840344;4626.930596041062;1731.4113201511545;1839.8868684445717;1867.570458794485;1926;1930.7007413850877;701.4797457631329;709.2694524639629;797.6450479536551;938.7840796616816;984.1978787288338;20016.29942952019;21472.57054858894;21489.982804814677;21689.292905129078;21748.45628859291;930.5021813329836;931.5994122527378;968.78149038702;999.1257649556638;1016.8271393863062;10048.246381521416;11422.371769552754;11449;11462.369569673749;11483.540658373571;537238;541677;541883;647739;651464;93698;104078;105544.78208716575;114095.42952285186;122562.38718806527;953.9523023848918;969.8836139663285;1016.4155610523978;1018.3940555369543;1019.6074511313197;18472.445826625222;18595.44213673592;19336.806631934065;19447.12487938018;19585.150983654683;38082.047948801504;47762.76118619385;54510.45489545054;56259;58633.4136658628;78869.60565197367;80990.19009809826;86828;87504;89717;6259.530535209969;7772.018135375443;8075.192480751878;8137.104918458846;8143.470674406145;12152.57465988686;12779.74440511166;12904.935475322563;12958.935205323913;13277.468901243841;11050.226484146033;11281.664566444555;11504.82742758876;11569.942150289531;11659.53361865516;11065.83401248998;11185.161112916401;11480.425978701198;11507.309561426342;11587;10806.621768238074;11326.660200194008;11461;11855.466504007169;11911.166218364631;7239.8914016290855;8003.19848072161;8183.222593853575;8199.754007379788;8308.6676532938;10208.846867296848;10409.791804163722;10453.68638940833;10796;11257.49341279628 12:28:23 INFO - PROCESS | 1762 | |3;mootools.html;1511.1386509689478;1536.554399224225;1732.6015016546194;1831.166819097311;1896.848252139828;8443.62003709833;9045.050269721683;9045.954770226139;9050.140236677506;9054.773630659236;6771.424428923535;7882.645280962356;8088.433809633328;8505.872411913826;8836.77908052299;2343.379004563792;2401.5917294059964;2405.9879700601473;2406.3984003999;2407.205622144688;2375.6317770745477;2384.6423036544484;2398.304491697406;2414.770596793302;2419.370963549481;2238.0488292475634;2383.380321116505;2386.9880650596724;2394.0543485323287;2400.459896523277;2003.1887085730302;2177.17267438374;2195.2536137713096;2195.835312351564;2205.790449907256;2374.0385144016527;2381.9761802381927;2384.7257565380028;2386.176769014687;2390.5935990881594;8632.309415246766;8793.692220772242;8819.29445644347;9015.27877769777;9015.684451044182;5242;5429.4299098594865;5437.673739575598;5442.836714898559;5447.346318441772;3482.8084455354947;3500.387432199355;3589;3627.0957747182674;3637.145270861372;1087.7552550676114;1091.1925175370247;1104.4422566603894;1116.8548088748491;1117.8155604325277;11612.954834064974;11731.237469564536;11750.882491175063;11758.3532905691;11772.411379430994;4630.305454181832;4656.534346565384;4865.416150062015;4879;4895.167821470359;9191.402558833654;9469.81627296588;10037;10044.899551004397;10045.246606504541;5359.732013399314;5370.4361042090795;5371.62398632092;5375.3280839895015;5382.838514844482;4410.29435290352;4476.6418686505;4887.169181239198;4906.435759887588;4942.579880710108;3946.2896678597554;3999.1801680655394;4058.776767277769;4063.715539912237;4115.218108559364;1208.5588760102498;1210.4613447015993;1212.3332167308122;1224.4612370556927;1228.2753175626424;753.8567672142275;853.8164294676675;910.2808781062886;915.5651065743718;918.8392031394613;5797.246357973437;5826.096954971986;5826.970865145647;5863.501602363847;6159.599626024294;909.5134103254727;913.3743385780762;918.8254231695956;924.9630014799333;971.6064993677572;3456.4469684850806;3947.2894878921497;4077.062275676611;4191.97904010478;4343.370211319404;10528.684139475828;10530.684079477627;10762.3542587445;10832.350058996328;10882.183836212158;10516.894831051744;10764.300320479144;10777.83833242502;10781.514831832586;10782.921707829311;8060.113387527367;8376.874346884802;8414.11651776567;8426.368022398223;8446.662133514714;6033.577649564664;6056.121862330026;6107.603005804608;6176.722047507783;6261.092141639528;9729.659461919082;9956.103950644478;10131.986801319808;10269.486525673836;10278.434686092336;10267.332623379756;10284.177265818866;10295.53670084833;10303.845442318221;10310.690679279634;6853.965730171317;6906;7473.402127829652;7536.8492630148185;7721.575313357819;8307.501549907025;8483.066862645228;8504.064552899052;8505.95747021261;8514.020887598006;7485.5508669480005;7569.962150189213;7596.468247222641;7710;7755.844883102419;7320.377767889576;7457.216992215739;7500.737474188595;7505.324520792937;7532.774016779286;6927.411170050602;6993.825154371181;7065.752698655522;7075.327843854826;7090.893636595559;4927.753612319298;4979.427365852828;5033.421156566895;5099.2860999460845;5133.56364708989;4503.256962601135;4874.731889746098;5056.292119103255;5107.361579802525;5249.868753281045 12:28:23 INFO - PROCESS | 1762 | |4;prototype.html;256.4358411494712;307.73534760106304;310.96579376268613;315.4574132492114;320.6873298533931;5443.740847548268;5488.670679759217;5503.3120859892515;5509.972450137754;5528.364238112623;4869.5373939475785;5084.313617661614;5214.634975551713;5307.840764777054;5437.564994800407;4073.5111786585653;4108.712390132692;4110.486189226347;4126.876193714186;4131.132462182945;4101.856435024774;4117.4441450404265;4132.793360331972;4144.97927510362;4188.832446702128;3160.6207255129416;3846.4807251021175;3974.741641793274;4111.280525907954;4158.960259935016;4091.468109145822;4104.240715467648;4108.6918481114035;4116.361963895601;4124.608162224599;2957.5064592380927;3578.284343131384;3587.170543023051;3592.1378869071496;3598.1904071583685;4554.63562914966;4619.030003699228;5000.2499625056535;5263.684178949237;5352.545033672142;4451.77741112943;4734.786934587952;4743.573078422924;4763.76181190939;4788.521147885219;5451.863703407407;5609.691466969315;5668.631538949955;5680.869673872298;5688.691600931809;3364.9495257571157;3757.0982964088694;3763.41667041609;3954.2684603348184;3964.5044369453817;5949.144410682897;5953.583249172603;6002.3697511761075;6003.889280483125;6030.246219222598;4006.3990401439432;4011.498562679665;4025.074232926385;4029.03303207234;4063.715539912178;3473.4616134498688;4099.426080348753;4113.239050775616;4126.257273690764;4134.91730165401;3961.980190099031;4578.40480737502;4644.698094623838;4665.556772106713;4794.304825800239;5078.7206703631655;5386.784528618811;5395.678058875601;5717.828465146053;5717.885642287131;1173.9941300293444;1377.1805775563523;1392.997042129665;1396.9441222350993;1403.3544569497942;887.4364778365784;908.6547112097361;954.0650162840456;966.5891995901854;975.5707488705089;4681.782736488538;4865.764266762563;5158.819441319536;5286.995470860601;5393.568514518829;4927.9590735597185;5122.487751224922;5825.38833422493;5837.88324233513;5861.9706901465215;4191.706580539333;4472.718913354212;4576.794044268016;4809.350737650442;5282.31329927107;2892.611546457712;3007.879684812583;3013.8493075346146;3048.2227032107116;3100.3024319528377;5669.6314739541795;5990.221271234712;5990.880182396328;5993;6009.639421634716;5439.265699130646;5454.263674403984;5661.027960320865;5930.22907022093;5979.056806537893;5038.974805126024;5944.613600115978;6037.486813620892;6077.361877003028;6131.294901086343;4395.648348132206;5886.411358864079;5932.8813423732145;5967.91048134287;6010.549208809444;4941.33292005589;5160.5424365674335;5893.499052580579;5900.232969713909;5917.112433135064;5190.560436594795;5992.670403127696;6184.206580091903;6195.597286176384;6266.310705822265;3896.519322657372;3951.78265195417;3963.821628026688;3975;3982.6415622594104;5981;6001.849953751192;6008.579399442172;6018.729157188025;6026.76451327468;4412;4787.699796678606;5556.72216389187;5864.9413505864395;5871.4715675589405;5085.974570127126;5669.149627555899;5717.713514459213;5746.367899530965;5785.30576330843;4798.640101992295;5254.65844720092;5446.918296225639;5608.859778505407;5620.353659329229;5206.609504287269;5655.519280861173;5699.487046165865;5729.799457018984;5792.594518383841;4926.433460152129;5144.819931302386;5636.267285252891;5645.633033852787;5658.349289831557 12:28:23 INFO - PROCESS | 1762 | |5;yui.html;709.9467539934504;797.882963850609;799.6841247707156;800.9399295052873;807.919208079192;15279.923600381997;16098.034117952902;16105.67788644228;16115.91942040288;16173.94869333494;11258;13485.865141348584;13557.932210338959;13561.864381356183;13591.184528928272;673.0442771264791;693.594247365292;831.9251267385933;832.2883934236231;853.3940901959617;847.8389106069827;854.133054949227;854.940154189207;855.4567849415604;857.5240741388527;902.0168016861652;906.5512571277227;907.4645958884257;909.2680392284209;911.2800887299059;715.3347386930127;737.6975440069546;875.5315905990265;889.9288056955428;903.4985583001431;637.3690046853628;638.6583177999748;655.3610230025687;670.5875886329871;671.2850813883199;15217.467388641344;15266.236688165658;15282.847171528254;15293.541193764093;15295.15876626785;13891.235982020984;14055.929720351434;14075.507357242448;14089.084209526349;14279.500217492337;12408.131430799847;12752;12754.872451275462;12771.042171837149;13186.142900711424;4485.865424037252;4514.6388288936805;4542.3640690303055;4548.545145485458;4671.906561868744;127928;132651;133019;133351.33324333414;135222;10699.94650026745;10952.42617984773;11195.944020280009;11223.831642525369;11224.66326010221;22624;22914.312570622908;22936.770632293796;22950;23315.766842331697;6802.387785099365;6927.896081558781;7612.048493938258;7802;7817.257360550739;4207;4320.891977700583;4368.366586844953;4373.409589705413;4539.704919180309;3405.7956522608724;3554.147004718849;3561.4301711726;3563.6080031196548;3572.1069732566857;615.4061330815695;635.2250254689365;647.6826355085974;648.3063122458924;656.5437021270267;622.2874808344511;622.4429135923414;628.669948277149;628.7864421666137;649.5388274325187;7224.927750722531;8138.186181381814;8139.860419541269;8176.959115204505;9041.68354107603;582.7494276568151;594.1635090364437;628.4877824572958;645.6352161029004;658.121407920422;4484.372187893698;4535.4103966484145;4558.407407037064;4609.976950115295;4618.689045813118;110243;121265;169361;170912;179372;105450;108574;117205.41397292959;125427.49145017231;150143;104404;106535;107474.70101195865;111324;112772;9534.570944307385;9947.21641270784;9981.700548983543;10118.696439106838;10134.594616215269;54424.72787636037;62583.37416625775;62666.110067488524;64387;65850.01224981724;91350;93469;95808;97984.51007744916;99839.50080249552;12300.446479908247;12767.297798620793;12858.614241572768;13297.734045318846;13371.732565348833;14687.265636718335;14700.70598588001;14974.101553906801;15161.696766064837;15237.31432085581;13028.41372138275;13691.794623080463;13793.034487586174;13920.164790112625;14484.493042743454;13020.544280950122;13404.664883377993;13681.605718998937;13752.449902003807;13785.51750688721;11434.313941163557;13449.260290683715;13557.661058473617;13841.4463421462;13957.93021034929;10101.939296373776;10988.725281868017;11415.714607134889;11418.429078546205;11451;11492.885071149516;11550.364729939934;11757.706057348634;11824.40877956116;11870.228435151688 12:28:23 INFO - PROCESS | 1762 | __end_tp_report 12:28:23 INFO - PROCESS | 1762 | __start_cc_report 12:28:23 INFO - PROCESS | 1762 | _x_x_mozilla_cycle_collect,1849 12:28:23 INFO - PROCESS | 1762 | __end_cc_report 12:28:23 INFO - PROCESS | 1762 | __startTimestamp1478028503799__endTimestamp 12:28:23 INFO - PROCESS | 1762 | 12:28:23 INFO - PROCESS | 1762 | ------- Summary: start ------- 12:28:23 INFO - PROCESS | 1762 | Number of tests: 6 12:28:23 INFO - PROCESS | 1762 | 12:28:23 INFO - PROCESS | 1762 | [#0] dojo.html Cycles:165 Average:5745.19 Median:5901.35 stddev:652.47 (11.1%) stddev-sans-first:610.79 12:28:23 INFO - PROCESS | 1762 | Values: 2753.1 3345.4 3369.5 3373.6 3415.3 5656.5 5746.5 5768.1 5789.7 5803.4 5689.9 5757.4 5758.0 5765.7 5793.7 5239.7 5244.6 5245.3 5275.4 5292.9 5214.2 5215.8 5249.5 5335.5 5363.2 5309.2 5326.4 5343.7 5344.8 5352.3 5311.9 5315.8 5317.0 5327.0 5327.9 5121.7 5199.8 5233.8 5241.8 5251.4 5771.4 5782.4 5801.5 5855.4 5879.0 6288.8 6293.7 6317.0 6319.6 6335.2 6116.6 6167.2 6209.2 6237.4 6242.2 5795.1 5795.1 5804.1 5813.9 5817.9 6293.4 6308.5 6313.4 6313.9 6317.1 6031.5 6075.0 6117.5 6143.4 6194.8 6260.0 6265.7 6271.1 6272.0 6295.3 6223.8 6226.3 6239.1 6253.9 6274.1 6088.0 6103.7 6106.9 6207.1 6272.9 4909.0 4914.2 4935.4 4952.3 4955.4 3753.7 4433.6 4438.9 4446.5 4471.0 5741.0 5767.6 5811.6 5817.0 5817.0 6143.6 6192.2 6226.3 6238.0 6266.3 5773.0 5782.4 5786.0 5795.4 5819.3 5397.9 5398.7 5400.5 5404.2 5404.4 6229.9 6234.9 6250.6 6276.6 6311.5 6151.3 6193.4 6250.4 6253.4 6253.7 6284.6 6285.7 6298.1 6302.9 6309.3 6071.7 6102.7 6112.8 6125.3 6131.3 5081.3 6000.8 6160.0 6231.6 6232.2 6046.4 6094.7 6114.0 6130.5 6136.5 6031.7 6112.4 6116.7 6120.8 6127.6 4959.4 5833.5 5860.2 5860.4 5897.8 6080.8 6129.2 6133.0 6162.4 6170.3 5835.8 5901.4 5912.6 5965.0 5997.7 12:28:23 INFO - PROCESS | 1762 | 12:28:23 INFO - PROCESS | 1762 | [#1] ext.html Cycles:180 Average:78062.04 Median:35541.73 stddev:183709.36 (516.9%) stddev-sans-first:184132.32 12:28:23 INFO - PROCESS | 1762 | Values: 460.4 482.2 490.4 513.1 514.6 30947.4 32672.5 41113.0 42151.6 42212.4 43287.0 43807.0 43826.6 44012.0 44225.0 9706.0 9868.7 9903.0 9915.9 9930.5 8807.6 8950.3 11858.9 12135.2 12156.5 12030.7 12116.6 12121.4 12125.5 12131.1 8804.8 12145.5 12242.7 12254.9 12258.7 8690.7 11661.4 12006.8 12011.8 12245.5 41182.0 41776.0 41866.6 41901.2 41942.2 3283.9 3285.6 3354.8 3355.6 3443.9 29938.1 30400.0 30756.2 32747.7 32759.3 3209.0 3226.9 3269.3 3311.1 3399.7 474370.6 519168.8 526981.0 526981.0 528294.0 33830.3 34186.8 59593.7 60142.4 60144.4 35086.0 35589.5 35592.8 35656.1 35695.9 15127.6 15257.9 15301.8 15306.8 15311.9 11683.5 11932.9 12908.8 13018.8 13202.9 7624.7 7796.2 7807.2 7852.4 7919.6 3024.6 3171.5 3223.8 3225.6 3274.0 934.4 1016.5 1023.5 1056.6 1106.5 30189.0 30240.5 30367.5 30401.4 30451.8 1028.4 1029.6 1062.8 1071.4 1138.4 12565.9 15705.8 15837.0 15918.1 16065.1 701017.0 762239.0 764153.0 766777.0 1023643.0 60493.0 61123.7 61246.0 61247.8 61340.0 1225.4 1242.8 1314.7 1355.4 1380.0 26512.6 31115.7 31134.7 31745.2 32411.8 54666.0 55368.2 55409.0 55544.4 55798.7 680702.0 687414.0 689520.0 690196.0 690443.0 35639.1 35926.6 43113.8 43384.1 43848.3 39428.0 46539.9 50041.7 50931.7 51039.5 38395.8 39676.0 39949.8 40049.2 41311.0 39504.0 40075.8 40497.0 40917.6 41260.2 38331.6 38795.6 39335.4 39461.2 39665.6 29910.4 33479.5 34446.8 35383.5 35494.0 23615.3 24865.0 25888.9 26003.5 26482.2 12:28:23 INFO - PROCESS | 1762 | 12:28:23 INFO - PROCESS | 1762 | [#2] jquery.html Cycles:180 Average:34032.19 Median:2392.86 stddev:97700.58 (4083.0%) stddev-sans-first:97941.88 12:28:23 INFO - PROCESS | 1762 | Values: 331.5 357.1 382.1 384.5 410.2 14898.8 15070.0 15997.5 20490.0 20946.7 15177.5 19971.0 20603.6 21257.3 21416.4 5930.9 6188.9 6194.1 6205.8 6206.0 4918.9 5748.6 6832.8 6904.1 6909.3 5855.6 6148.8 6852.0 6867.4 6895.6 6164.3 6202.2 6205.7 6214.2 6220.3 5753.5 5974.1 6039.3 6041.3 6048.0 13207.5 13428.1 14019.0 24856.0 25161.1 2318.7 2348.7 2387.9 2397.8 2958.8 9487.9 9759.9 9875.5 10070.9 10208.9 1804.7 1866.9 1897.8 1938.1 1956.3 112564.4 119280.0 119596.8 122125.0 123016.0 11296.7 11468.3 11541.2 11553.2 11806.2 14555.6 14586.8 14593.8 14616.5 14645.3 7474.3 8306.8 8372.7 8483.9 8628.7 8414.7 8419.8 8425.5 8556.8 8608.5 4444.4 4563.8 4572.0 4600.9 4626.9 1731.4 1839.9 1867.6 1926.0 1930.7 701.5 709.3 797.6 938.8 984.2 20016.3 21472.6 21490.0 21689.3 21748.5 930.5 931.6 968.8 999.1 1016.8 10048.2 11422.4 11449.0 11462.4 11483.5 537238.0 541677.0 541883.0 647739.0 651464.0 93698.0 104078.0 105544.8 114095.4 122562.4 954.0 969.9 1016.4 1018.4 1019.6 18472.4 18595.4 19336.8 19447.1 19585.2 38082.0 47762.8 54510.5 56259.0 58633.4 78869.6 80990.2 86828.0 87504.0 89717.0 6259.5 7772.0 8075.2 8137.1 8143.5 12152.6 12779.7 12904.9 12958.9 13277.5 11050.2 11281.7 11504.8 11569.9 11659.5 11065.8 11185.2 11480.4 11507.3 11587.0 10806.6 11326.7 11461.0 11855.5 11911.2 7239.9 8003.2 8183.2 8199.8 8308.7 10208.8 10409.8 10453.7 10796.0 11257.5 12:28:23 INFO - PROCESS | 1762 | 12:28:23 INFO - PROCESS | 1762 | [#3] mootools.html Cycles:180 Average:5742.19 Median:4900.80 stddev:3211.64 (65.5%) stddev-sans-first:3204.91 12:28:23 INFO - PROCESS | 1762 | Values: 1511.1 1536.6 1732.6 1831.2 1896.8 8443.6 9045.1 9046.0 9050.1 9054.8 6771.4 7882.6 8088.4 8505.9 8836.8 2343.4 2401.6 2406.0 2406.4 2407.2 2375.6 2384.6 2398.3 2414.8 2419.4 2238.0 2383.4 2387.0 2394.1 2400.5 2003.2 2177.2 2195.3 2195.8 2205.8 2374.0 2382.0 2384.7 2386.2 2390.6 8632.3 8793.7 8819.3 9015.3 9015.7 5242.0 5429.4 5437.7 5442.8 5447.3 3482.8 3500.4 3589.0 3627.1 3637.1 1087.8 1091.2 1104.4 1116.9 1117.8 11613.0 11731.2 11750.9 11758.4 11772.4 4630.3 4656.5 4865.4 4879.0 4895.2 9191.4 9469.8 10037.0 10044.9 10045.2 5359.7 5370.4 5371.6 5375.3 5382.8 4410.3 4476.6 4887.2 4906.4 4942.6 3946.3 3999.2 4058.8 4063.7 4115.2 1208.6 1210.5 1212.3 1224.5 1228.3 753.9 853.8 910.3 915.6 918.8 5797.2 5826.1 5827.0 5863.5 6159.6 909.5 913.4 918.8 925.0 971.6 3456.4 3947.3 4077.1 4192.0 4343.4 10528.7 10530.7 10762.4 10832.4 10882.2 10516.9 10764.3 10777.8 10781.5 10782.9 8060.1 8376.9 8414.1 8426.4 8446.7 6033.6 6056.1 6107.6 6176.7 6261.1 9729.7 9956.1 10132.0 10269.5 10278.4 10267.3 10284.2 10295.5 10303.8 10310.7 6854.0 6906.0 7473.4 7536.8 7721.6 8307.5 8483.1 8504.1 8506.0 8514.0 7485.6 7570.0 7596.5 7710.0 7755.8 7320.4 7457.2 7500.7 7505.3 7532.8 6927.4 6993.8 7065.8 7075.3 7090.9 4927.8 4979.4 5033.4 5099.3 5133.6 4503.3 4874.7 5056.3 5107.4 5249.9 12:28:23 INFO - PROCESS | 1762 | 12:28:23 INFO - PROCESS | 1762 | [#4] prototype.html Cycles:180 Average:4613.85 Median:5104.23 stddev:1419.16 (27.8%) stddev-sans-first:1384.94 12:28:23 INFO - PROCESS | 1762 | Values: 256.4 307.7 311.0 315.5 320.7 5443.7 5488.7 5503.3 5510.0 5528.4 4869.5 5084.3 5214.6 5307.8 5437.6 4073.5 4108.7 4110.5 4126.9 4131.1 4101.9 4117.4 4132.8 4145.0 4188.8 3160.6 3846.5 3974.7 4111.3 4159.0 4091.5 4104.2 4108.7 4116.4 4124.6 2957.5 3578.3 3587.2 3592.1 3598.2 4554.6 4619.0 5000.2 5263.7 5352.5 4451.8 4734.8 4743.6 4763.8 4788.5 5451.9 5609.7 5668.6 5680.9 5688.7 3364.9 3757.1 3763.4 3954.3 3964.5 5949.1 5953.6 6002.4 6003.9 6030.2 4006.4 4011.5 4025.1 4029.0 4063.7 3473.5 4099.4 4113.2 4126.3 4134.9 3962.0 4578.4 4644.7 4665.6 4794.3 5078.7 5386.8 5395.7 5717.8 5717.9 1174.0 1377.2 1393.0 1396.9 1403.4 887.4 908.7 954.1 966.6 975.6 4681.8 4865.8 5158.8 5287.0 5393.6 4928.0 5122.5 5825.4 5837.9 5862.0 4191.7 4472.7 4576.8 4809.4 5282.3 2892.6 3007.9 3013.8 3048.2 3100.3 5669.6 5990.2 5990.9 5993.0 6009.6 5439.3 5454.3 5661.0 5930.2 5979.1 5039.0 5944.6 6037.5 6077.4 6131.3 4395.6 5886.4 5932.9 5967.9 6010.5 4941.3 5160.5 5893.5 5900.2 5917.1 5190.6 5992.7 6184.2 6195.6 6266.3 3896.5 3951.8 3963.8 3975.0 3982.6 5981.0 6001.8 6008.6 6018.7 6026.8 4412.0 4787.7 5556.7 5864.9 5871.5 5086.0 5669.1 5717.7 5746.4 5785.3 4798.6 5254.7 5446.9 5608.9 5620.4 5206.6 5655.5 5699.5 5729.8 5792.6 4926.4 5144.8 5636.3 5645.6 5658.3 12:28:23 INFO - PROCESS | 1762 | 12:28:23 INFO - PROCESS | 1762 | [#5] yui.html Cycles:180 Average:25437.86 Median:23132.88 stddev:41140.87 (177.8%) stddev-sans-first:41214.38 12:28:23 INFO - PROCESS | 1762 | Values: 709.9 797.9 799.7 800.9 807.9 15279.9 16098.0 16105.7 16115.9 16173.9 11258.0 13485.9 13557.9 13561.9 13591.2 673.0 693.6 831.9 832.3 853.4 847.8 854.1 854.9 855.5 857.5 902.0 906.6 907.5 909.3 911.3 715.3 737.7 875.5 889.9 903.5 637.4 638.7 655.4 670.6 671.3 15217.5 15266.2 15282.8 15293.5 15295.2 13891.2 14055.9 14075.5 14089.1 14279.5 12408.1 12752.0 12754.9 12771.0 13186.1 4485.9 4514.6 4542.4 4548.5 4671.9 127928.0 132651.0 133019.0 133351.3 135222.0 10699.9 10952.4 11195.9 11223.8 11224.7 22624.0 22914.3 22936.8 22950.0 23315.8 6802.4 6927.9 7612.0 7802.0 7817.3 4207.0 4320.9 4368.4 4373.4 4539.7 3405.8 3554.1 3561.4 3563.6 3572.1 615.4 635.2 647.7 648.3 656.5 622.3 622.4 628.7 628.8 649.5 7224.9 8138.2 8139.9 8177.0 9041.7 582.7 594.2 628.5 645.6 658.1 4484.4 4535.4 4558.4 4610.0 4618.7 110243.0 121265.0 169361.0 170912.0 179372.0 105450.0 108574.0 117205.4 125427.5 150143.0 104404.0 106535.0 107474.7 111324.0 112772.0 9534.6 9947.2 9981.7 10118.7 10134.6 54424.7 62583.4 62666.1 64387.0 65850.0 91350.0 93469.0 95808.0 97984.5 99839.5 12300.4 12767.3 12858.6 13297.7 13371.7 14687.3 14700.7 14974.1 15161.7 15237.3 13028.4 13691.8 13793.0 13920.2 14484.5 13020.5 13404.7 13681.6 13752.4 13785.5 11434.3 13449.3 13557.7 13841.4 13957.9 10101.9 10988.7 11415.7 11418.4 11451.0 11492.9 11550.4 11757.7 11824.4 11870.2 12:28:23 INFO - PROCESS | 1762 | -------- Summary: end -------- 12:28:23 INFO - PROCESS | 1762 | 12:28:24 INFO - TEST-INFO | 1762: exit 0 12:28:24 INFO - TEST-OK | dromaeo_css | took 1118082ms 12:28:24 INFO - TEST-START | kraken 12:28:24 INFO - operating with platform_type : mac_ 12:28:24 INFO - Initialising browser for kraken test... 12:28:24 INFO - TEST-INFO | started process 1879 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/tmpqv4DBx/profile http://localhost:49273/getInfo.html) 12:28:26 INFO - PROCESS | 1879 | __metrics Screen width/height:1600/1200 12:28:26 INFO - PROCESS | 1879 | colorDepth:24 12:28:26 INFO - PROCESS | 1879 | Browser inner width/height: 1024/689 12:28:26 INFO - PROCESS | 1879 | __metrics 12:28:26 INFO - PROCESS | 1879 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:28:26 INFO - PROCESS | 1879 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:28:27 INFO - TEST-INFO | 1879: exit 0 12:28:27 INFO - Browser initialized. 12:28:27 INFO - Running cycle 1/1 for kraken test... 12:28:27 INFO - TEST-INFO | started process 1880 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/T/tmpqv4DBx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:28:39 INFO - PROCESS | 1880 | RSS: Main: 219512832 12:28:39 INFO - PROCESS | 1880 | 12:28:41 INFO - PROCESS | 1880 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 12:28:42 INFO - PROCESS | 1880 | RSS: Main: 270708736 12:28:42 INFO - PROCESS | 1880 | 12:28:45 INFO - PROCESS | 1880 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 12:28:46 INFO - PROCESS | 1880 | RSS: Main: 282189824 12:28:46 INFO - PROCESS | 1880 | 12:28:49 INFO - PROCESS | 1880 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 12:28:49 INFO - PROCESS | 1880 | RSS: Main: 378400768 12:28:49 INFO - PROCESS | 1880 | 12:28:51 INFO - PROCESS | 1880 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 12:28:52 INFO - PROCESS | 1880 | RSS: Main: 279412736 12:28:52 INFO - PROCESS | 1880 | 12:28:54 INFO - PROCESS | 1880 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:28:54 INFO - PROCESS | 1880 | RSS: Main: 279920640 12:28:54 INFO - PROCESS | 1880 | 12:28:57 INFO - PROCESS | 1880 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 12:28:58 INFO - PROCESS | 1880 | RSS: Main: 316936192 12:28:58 INFO - PROCESS | 1880 | 12:29:01 INFO - PROCESS | 1880 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 12:29:02 INFO - PROCESS | 1880 | RSS: Main: 321224704 12:29:02 INFO - PROCESS | 1880 | 12:29:04 INFO - PROCESS | 1880 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 12:29:05 INFO - PROCESS | 1880 | RSS: Main: 317583360 12:29:05 INFO - PROCESS | 1880 | 12:29:06 INFO - PROCESS | 1880 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:29:07 INFO - PROCESS | 1880 | RSS: Main: 291246080 12:29:07 INFO - PROCESS | 1880 | 12:29:09 INFO - PROCESS | 1880 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:29:10 INFO - PROCESS | 1880 | RSS: Main: 295993344 12:29:10 INFO - PROCESS | 1880 | 12:29:12 INFO - PROCESS | 1880 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:29:12 INFO - PROCESS | 1880 | RSS: Main: 302444544 12:29:12 INFO - PROCESS | 1880 | 12:29:15 INFO - PROCESS | 1880 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:29:16 INFO - PROCESS | 1880 | RSS: Main: 311791616 12:29:16 INFO - PROCESS | 1880 | 12:29:19 INFO - PROCESS | 1880 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:29:20 INFO - PROCESS | 1880 | RSS: Main: 311595008 12:29:20 INFO - PROCESS | 1880 | 12:29:21 INFO - PROCESS | 1880 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 12:29:22 INFO - PROCESS | 1880 | RSS: Main: 355762176 12:29:22 INFO - PROCESS | 1880 | 12:29:22 INFO - PROCESS | 1880 | __start_tp_report 12:29:22 INFO - PROCESS | 1880 | _x_x_mozilla_page_load 12:29:22 INFO - PROCESS | 1880 | _x_x_mozilla_page_load_details 12:29:22 INFO - PROCESS | 1880 | |i|pagename|runs| 12:29:22 INFO - PROCESS | 1880 | |0;ai-astar;116;113;113;113;113;114;113;111;112;113 12:29:22 INFO - PROCESS | 1880 | |1;audio-beat-detection;142;109;107;142;109;109;110;109;139;109 12:29:22 INFO - PROCESS | 1880 | |2;audio-dft;184;185;185;186;184;183;183;182;184;184 12:29:22 INFO - PROCESS | 1880 | |3;audio-fft;77;59;59;88;61;59;59;57;83;58 12:29:22 INFO - PROCESS | 1880 | |4;audio-oscillator;87;71;96;72;68;66;89;70;69;90 12:29:22 INFO - PROCESS | 1880 | |5;imaging-gaussian-blur;87;86;105;131;92;83;88;84;85;83 12:29:22 INFO - PROCESS | 1880 | |6;imaging-darkroom;96;95;96;97;119;159;159;160;96;96 12:29:22 INFO - PROCESS | 1880 | |7;imaging-desaturate;82;85;85;87;85;85;86;87;85;84 12:29:22 INFO - PROCESS | 1880 | |8;json-parse-financial;57;55;53;54;58;58;58;58;58;57 12:29:22 INFO - PROCESS | 1880 | |9;json-stringify-tinderbox;61;74;66;78;72;69;69;69;69;70 12:29:22 INFO - PROCESS | 1880 | |10;stanford-crypto-aes;84;82;81;85;82;82;84;84;88;90 12:29:22 INFO - PROCESS | 1880 | |11;stanford-crypto-ccm;154;146;154;140;141;151;159;144;173;146 12:29:22 INFO - PROCESS | 1880 | |12;stanford-crypto-pbkdf2;166;166;165;225;217;166;168;166;164;166 12:29:22 INFO - PROCESS | 1880 | |13;stanford-crypto-sha256-iterative;68;68;68;66;68;68;67;68;70;85 12:29:22 INFO - PROCESS | 1880 | __end_tp_report 12:29:22 INFO - PROCESS | 1880 | __start_cc_report 12:29:22 INFO - PROCESS | 1880 | _x_x_mozilla_cycle_collect,1956 12:29:22 INFO - PROCESS | 1880 | __end_cc_report 12:29:22 INFO - PROCESS | 1880 | __startTimestamp1478028562216__endTimestamp 12:29:22 INFO - PROCESS | 1880 | 12:29:22 INFO - PROCESS | 1880 | ------- Summary: start ------- 12:29:22 INFO - PROCESS | 1880 | Number of tests: 14 12:29:22 INFO - PROCESS | 1880 | 12:29:22 INFO - PROCESS | 1880 | [#0] ai-astar Cycles:10 Average:113.10 Median:113.00 stddev:1.29 (1.1%) stddev-sans-first:0.83 12:29:22 INFO - PROCESS | 1880 | Values: 116.0 113.0 113.0 113.0 113.0 114.0 113.0 111.0 112.0 113.0 12:29:22 INFO - PROCESS | 1880 | 12:29:22 INFO - PROCESS | 1880 | [#1] audio-beat-detection Cycles:10 Average:118.50 Median:109.50 stddev:15.57 (14.2%) stddev-sans-first:14.00 12:29:22 INFO - PROCESS | 1880 | Values: 142.0 109.0 107.0 142.0 109.0 109.0 110.0 109.0 139.0 109.0 12:29:22 INFO - PROCESS | 1880 | 12:29:22 INFO - PROCESS | 1880 | [#2] audio-dft Cycles:10 Average:184.00 Median:184.00 stddev:1.15 (0.6%) stddev-sans-first:1.22 12:29:22 INFO - PROCESS | 1880 | Values: 184.0 185.0 185.0 186.0 184.0 183.0 183.0 182.0 184.0 184.0 12:29:22 INFO - PROCESS | 1880 | 12:29:22 INFO - PROCESS | 1880 | [#3] audio-fft Cycles:10 Average:66.00 Median:60.00 stddev:11.83 (19.7%) stddev-sans-first:11.86 12:29:22 INFO - PROCESS | 1880 | Values: 77.0 59.0 59.0 88.0 61.0 59.0 59.0 57.0 83.0 58.0 12:29:22 INFO - PROCESS | 1880 | 12:29:22 INFO - PROCESS | 1880 | [#4] audio-oscillator Cycles:10 Average:77.80 Median:79.50 stddev:11.27 (14.2%) stddev-sans-first:11.45 12:29:22 INFO - PROCESS | 1880 | Values: 87.0 71.0 96.0 72.0 68.0 66.0 89.0 70.0 69.0 90.0 12:29:22 INFO - PROCESS | 1880 | 12:29:22 INFO - PROCESS | 1880 | [#5] imaging-gaussian-blur Cycles:10 Average:92.40 Median:85.50 stddev:15.06 (17.6%) stddev-sans-first:15.84 12:29:22 INFO - PROCESS | 1880 | Values: 87.0 86.0 105.0 131.0 92.0 83.0 88.0 84.0 85.0 83.0 12:29:22 INFO - PROCESS | 1880 | 12:29:22 INFO - PROCESS | 1880 | [#6] imaging-darkroom Cycles:10 Average:117.30 Median:96.00 stddev:29.87 (31.1%) stddev-sans-first:30.67 12:29:22 INFO - PROCESS | 1880 | Values: 96.0 95.0 96.0 97.0 119.0 159.0 159.0 160.0 96.0 96.0 12:29:22 INFO - PROCESS | 1880 | 12:29:22 INFO - PROCESS | 1880 | [#7] imaging-desaturate Cycles:10 Average:85.10 Median:85.00 stddev:1.45 (1.7%) stddev-sans-first:1.01 12:29:22 INFO - PROCESS | 1880 | Values: 82.0 85.0 85.0 87.0 85.0 85.0 86.0 87.0 85.0 84.0 12:29:22 INFO - PROCESS | 1880 | 12:29:22 INFO - PROCESS | 1880 | [#8] json-parse-financial Cycles:10 Average:56.60 Median:58.00 stddev:1.90 (3.3%) stddev-sans-first:2.01 12:29:22 INFO - PROCESS | 1880 | Values: 57.0 55.0 53.0 54.0 58.0 58.0 58.0 58.0 58.0 57.0 12:29:22 INFO - PROCESS | 1880 | 12:29:22 INFO - PROCESS | 1880 | [#9] json-stringify-tinderbox Cycles:10 Average:69.70 Median:69.50 stddev:4.52 (6.5%) stddev-sans-first:3.54 12:29:22 INFO - PROCESS | 1880 | Values: 61.0 74.0 66.0 78.0 72.0 69.0 69.0 69.0 69.0 70.0 12:29:22 INFO - PROCESS | 1880 | 12:29:22 INFO - PROCESS | 1880 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:84.00 stddev:2.86 (3.4%) stddev-sans-first:3.03 12:29:22 INFO - PROCESS | 1880 | Values: 84.0 82.0 81.0 85.0 82.0 82.0 84.0 84.0 88.0 90.0 12:29:22 INFO - PROCESS | 1880 | 12:29:22 INFO - PROCESS | 1880 | [#11] stanford-crypto-ccm Cycles:10 Average:150.80 Median:152.50 stddev:9.92 (6.5%) stddev-sans-first:10.45 12:29:22 INFO - PROCESS | 1880 | Values: 154.0 146.0 154.0 140.0 141.0 151.0 159.0 144.0 173.0 146.0 12:29:22 INFO - PROCESS | 1880 | 12:29:22 INFO - PROCESS | 1880 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.90 Median:166.00 stddev:23.34 (14.1%) stddev-sans-first:24.42 12:29:22 INFO - PROCESS | 1880 | Values: 166.0 166.0 165.0 225.0 217.0 166.0 168.0 166.0 164.0 166.0 12:29:22 INFO - PROCESS | 1880 | 12:29:22 INFO - PROCESS | 1880 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:68.00 stddev:5.50 (8.1%) stddev-sans-first:5.80 12:29:22 INFO - PROCESS | 1880 | Values: 68.0 68.0 68.0 66.0 68.0 68.0 67.0 68.0 70.0 85.0 12:29:22 INFO - PROCESS | 1880 | -------- Summary: end -------- 12:29:22 INFO - PROCESS | 1880 | 12:29:23 INFO - TEST-INFO | 1880: exit 0 12:29:23 INFO - TEST-OK | kraken | took 58871ms 12:29:23 INFO - SUITE-END | took 1176s 12:29:23 INFO - Completed test suite (00:19:37) 12:29:23 INFO - javascript benchmark 12:29:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2753.091479811662, 3345.41455245332, 3369.511420843979, 3373.645767194446, 3415.2998635279755, 5656.519195868351, 5746.454086861752, 5768.134779783035, 5789.71051447427, 5803.390643982384, 5689.914651280224, 5757.424257574251, 5758.049921762904, 5765.6540607563575, 5793.681347525884, 5239.711815850127, 5244.580433565325, 5245.344331958505, 5275.36695596529, 5292.867678308035, 5214.165733482643, 5215.791368345281, 5249.4750524947585, 5335.519803217729, 5363.249145119687, 5309.203619457093, 5326.440723724011, 5343.679379237239, 5344.759485823128, 5352.330958630171, 5311.9468805311835, 5315.840524784263, 5317.042932272189, 5326.97336513315, 5327.866803329948, 5121.692698438068, 5199.818006369796, 5233.790648374061, 5241.842744717665, 5251.369835619712, 5771.394003629601, 5782.3639399666, 5801.535877129862, 5855.414458554111, 5878.970605146947, 6288.842778930563, 6293.716782744787, 6317.0, 6319.58922670025, 6335.239771227436, 6116.579253789288, 6167.167432396614, 6209.161763162006, 6237.376262373727, 6242.15730876335, 5795.1017592273265, 5795.1017592273265, 5804.071348584291, 5813.88372232553, 5817.94182058174, 6293.402126797947, 6308.52686048539, 6313.368663133741, 6313.9368606314265, 6317.14718513004, 6031.457168854737, 6075.027995520695, 6117.480014198754, 6143.389059649631, 6194.845128871724, 6260.0, 6265.65538895356, 6271.122042913996, 6271.96864015677, 6295.276043254993, 6223.844403889939, 6226.283977342573, 6239.06414037898, 6253.906191407133, 6274.121622972787, 6087.969560152171, 6103.6948152592195, 6106.877817708206, 6207.099970504251, 6272.905906411407, 4908.9754551227015, 4914.238293064581, 4935.358403407534, 4952.306677065214, 4955.380577427822, 3753.6997040236715, 4433.623142032899, 4438.933415998763, 4446.4886538047895, 4470.977645111819, 5741.0, 5767.567432442584, 5811.564132690065, 5817.0, 5817.040188368872, 6143.631382117087, 6192.225971753531, 6226.25284965798, 6238.001919692827, 6266.279377871512, 5772.9711351442975, 5782.421757824184, 5785.987452195849, 5795.420457954255, 5819.301683797887, 5397.892042159135, 5398.676079435247, 5400.513953744182, 5404.243405923174, 5404.3784964728775, 6229.906551401823, 6234.937650623436, 6250.562460627712, 6276.623402595859, 6311.463525600376, 6151.292601350902, 6193.38066193377, 6250.374962503895, 6253.437190652863, 6253.687315634291, 6284.591501552384, 6285.748570057147, 6298.08677741734, 6302.905456418249, 6309.305976342507, 6071.666058366833, 6102.664353460602, 6112.786052488142, 6125.295591007091, 6131.294901086432, 5081.263216833465, 6000.759969601167, 6159.9528080227365, 6231.626102433868, 6232.220972378453, 6046.365131661112, 6094.7257373417415, 6114.0, 6130.5402094842175, 6136.478399336106, 6031.69841507914, 6112.388761123852, 6116.663583502772, 6120.785772497941, 6127.632342059491, 4959.404871415453, 5833.4749872511675, 5860.150278209721, 5860.355360910211, 5897.7935772247765, 6080.817575472743, 6129.233845769279, 6133.028644417115, 6162.352952939877, 6170.290416602148, 5835.766569337179, 5901.350851406428, 5912.615679980788, 5964.970175149097, 5997.670128142994], "value": 5701.6840543069975, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [460.38768437977495, 482.22361997184527, 490.41640447867036, 513.0739016075983, 514.6268955007617, 30947.381052378965, 32672.509912351303, 41113.0, 42151.57848421515, 42212.36681449773, 43287.0, 43807.0, 43826.561734382645, 44012.0, 44224.99999999992, 9706.02939706029, 9868.654597089104, 9903.0, 9915.90084099157, 9930.45382503962, 8807.559622018873, 8950.283977281835, 11858.881411185906, 12135.211211271284, 12156.51373945041, 12030.69923251917, 12116.636500904942, 12121.393930303493, 12125.514979400858, 12131.090168237417, 8804.823903521958, 12145.45345459452, 12242.693932651666, 12254.877451225508, 12258.693532661666, 8690.652373905035, 11661.358625275607, 12006.759864802654, 12011.819822702666, 12245.510179592806, 41182.0, 41776.0, 41866.58133418688, 41901.1619767603, 41942.161156777, 3283.8522266498067, 3285.6200395833807, 3354.8490317935753, 3355.580552430946, 3443.896683099511, 29938.101856944326, 30400.0, 30756.2310942226, 32747.6725232747, 32759.344813103606, 3208.983955080233, 3226.935461290761, 3269.3134441767256, 3311.122552523583, 3399.6940275375337, 474370.6281468605, 519168.80831191584, 526981.0, 526981.0, 528294.0, 33830.323393531995, 34186.82906585451, 59593.70203148956, 60142.39857601455, 60144.398556014756, 35086.0, 35589.46615800765, 35592.82203588966, 35656.10859728476, 35695.92912212638, 15127.621809454851, 15257.923710381378, 15301.846981530041, 15306.770398444032, 15311.923440382727, 11683.532658693726, 11932.880671193177, 12908.806367904488, 13018.804717929239, 13202.943764498817, 7624.656890439944, 7796.181400952932, 7807.219278072147, 7852.371810255166, 7919.604019798987, 3024.6370435547874, 3171.4608516552244, 3223.8065716057113, 3225.5645487859306, 3274.0341599228286, 934.4113208678489, 1016.4714348538719, 1023.4524529376748, 1056.6143357674548, 1106.5076041161767, 30189.0, 30240.546391804142, 30367.544486832714, 30401.37146046593, 30451.847740761154, 1028.4035259549444, 1029.5572903651503, 1062.8352605346029, 1071.4000159910474, 1138.413716935762, 12565.874341256653, 15705.842941570667, 15837.0, 15918.061354688467, 16065.11641859709, 701017.0, 762239.0, 764153.0, 766777.0, 1023643.0, 60493.0, 61123.694381528694, 61246.0, 61247.77504449975, 61340.0, 1225.3689349984943, 1242.7700875338091, 1314.6581888709004, 1355.3697530648296, 1379.951701690436, 26512.602310965736, 31115.688843112184, 31134.688653114084, 31745.20636984094, 32411.837940810146, 54666.0, 55368.169477457064, 55409.0, 55544.44455555554, 55798.721006394706, 680702.0, 687414.0, 689520.0, 690196.0, 690443.0, 35639.10902227362, 35926.640733593376, 43113.78443107764, 43384.13231735284, 43848.34227486527, 39428.0, 46539.9126290715, 50041.74979125081, 50931.65217652242, 51039.46881593558, 38395.80802095972, 39676.0, 39949.80025099856, 40049.1990160201, 41311.0, 39504.03719720975, 40075.79962100171, 40497.0, 40917.59082409138, 41260.1747965045, 38331.616683832806, 38795.6120438792, 39335.40996884992, 39461.21077578375, 39665.60334396619, 29910.401791964476, 33479.49780753242, 34446.82776586101, 35383.469247960784, 35494.0, 23615.29154125379, 24864.967402481627, 25888.8705556471, 26003.479930400907, 26482.205533834014], "value": 19603.569686689494, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.50440092062365, 357.0965457392794, 382.11159055196674, 384.4751913637883, 410.17145366359955, 14898.77651835222, 15070.0, 15997.520074397773, 20490.0, 20946.685799713017, 15177.468788592401, 19971.0, 20603.587928241424, 21257.25599604014, 21416.35750927471, 5930.851728706784, 6188.907166392508, 6194.101855230989, 6205.81382558524, 6205.968970155143, 4918.852434426955, 5748.5975981681295, 6832.760853370133, 6904.13698287714, 6909.309069093076, 5855.61938474, 6148.815535533941, 6852.0, 6867.381935625793, 6895.551789133715, 6164.29110652274, 6202.224721909762, 6205.689715514206, 6214.223222097238, 6220.315765265795, 5753.510951569122, 5974.074018527135, 6039.305479869783, 6041.335453100155, 6048.0, 13207.471701131943, 13428.127171733904, 14019.0, 24856.0, 25161.119360822468, 2318.675385446039, 2348.6829278047417, 2387.928362149138, 2397.7841994220603, 2958.8224706517462, 9487.90512094884, 9759.90240097597, 9875.506224688737, 10070.888774864574, 10208.948955255251, 1804.738312944629, 1866.925322987079, 1897.8197071278344, 1938.1278424708937, 1956.344624550777, 112564.43717781441, 119280.0, 119596.80403195944, 122125.0, 123016.0, 11296.71758206035, 11468.254563453349, 11541.249818761753, 11553.191276610725, 11806.232594881305, 14555.563333100024, 14586.781198282035, 14593.78109328361, 14616.488422905148, 14645.267736613127, 7474.327310542078, 8306.792330191794, 8372.748817535483, 8483.872741908875, 8628.654853805778, 8414.705485307984, 8419.768761278267, 8425.452345597516, 8556.828863422697, 8608.48349099056, 4444.400005999213, 4563.794629241625, 4571.954280457219, 4600.907981840344, 4626.930596041062, 1731.4113201511545, 1839.8868684445717, 1867.570458794485, 1926.0, 1930.7007413850877, 701.4797457631329, 709.2694524639629, 797.6450479536551, 938.7840796616816, 984.1978787288338, 20016.29942952019, 21472.57054858894, 21489.982804814677, 21689.292905129078, 21748.45628859291, 930.5021813329836, 931.5994122527378, 968.78149038702, 999.1257649556638, 1016.8271393863062, 10048.246381521416, 11422.371769552754, 11449.0, 11462.369569673749, 11483.540658373571, 537238.0, 541677.0, 541883.0, 647739.0, 651464.0, 93698.0, 104078.0, 105544.78208716575, 114095.42952285186, 122562.38718806527, 953.9523023848918, 969.8836139663285, 1016.4155610523978, 1018.3940555369543, 1019.6074511313197, 18472.445826625222, 18595.44213673592, 19336.806631934065, 19447.12487938018, 19585.150983654683, 38082.047948801504, 47762.76118619385, 54510.45489545054, 56259.0, 58633.4136658628, 78869.60565197367, 80990.19009809826, 86828.0, 87504.0, 89717.0, 6259.530535209969, 7772.018135375443, 8075.192480751878, 8137.104918458846, 8143.470674406145, 12152.57465988686, 12779.74440511166, 12904.935475322563, 12958.935205323913, 13277.468901243841, 11050.226484146033, 11281.664566444555, 11504.82742758876, 11569.942150289531, 11659.53361865516, 11065.83401248998, 11185.161112916401, 11480.425978701198, 11507.309561426342, 11587.0, 10806.621768238074, 11326.660200194008, 11461.0, 11855.466504007169, 11911.166218364631, 7239.8914016290855, 8003.19848072161, 8183.222593853575, 8199.754007379788, 8308.6676532938, 10208.846867296848, 10409.791804163722, 10453.68638940833, 10796.0, 11257.49341279628], "value": 9483.30500629405, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1511.1386509689478, 1536.554399224225, 1732.6015016546194, 1831.166819097311, 1896.848252139828, 8443.62003709833, 9045.050269721683, 9045.954770226139, 9050.140236677506, 9054.773630659236, 6771.424428923535, 7882.645280962356, 8088.433809633328, 8505.872411913826, 8836.77908052299, 2343.379004563792, 2401.5917294059964, 2405.9879700601473, 2406.3984003999, 2407.205622144688, 2375.6317770745477, 2384.6423036544484, 2398.304491697406, 2414.770596793302, 2419.370963549481, 2238.0488292475634, 2383.380321116505, 2386.9880650596724, 2394.0543485323287, 2400.459896523277, 2003.1887085730302, 2177.17267438374, 2195.2536137713096, 2195.835312351564, 2205.790449907256, 2374.0385144016527, 2381.9761802381927, 2384.7257565380028, 2386.176769014687, 2390.5935990881594, 8632.309415246766, 8793.692220772242, 8819.29445644347, 9015.27877769777, 9015.684451044182, 5242.0, 5429.4299098594865, 5437.673739575598, 5442.836714898559, 5447.346318441772, 3482.8084455354947, 3500.387432199355, 3589.0, 3627.0957747182674, 3637.145270861372, 1087.7552550676114, 1091.1925175370247, 1104.4422566603894, 1116.8548088748491, 1117.8155604325277, 11612.954834064974, 11731.237469564536, 11750.882491175063, 11758.3532905691, 11772.411379430994, 4630.305454181832, 4656.534346565384, 4865.416150062015, 4879.0, 4895.167821470359, 9191.402558833654, 9469.81627296588, 10037.0, 10044.899551004397, 10045.246606504541, 5359.732013399314, 5370.4361042090795, 5371.62398632092, 5375.3280839895015, 5382.838514844482, 4410.29435290352, 4476.6418686505, 4887.169181239198, 4906.435759887588, 4942.579880710108, 3946.2896678597554, 3999.1801680655394, 4058.776767277769, 4063.715539912237, 4115.218108559364, 1208.5588760102498, 1210.4613447015993, 1212.3332167308122, 1224.4612370556927, 1228.2753175626424, 753.8567672142275, 853.8164294676675, 910.2808781062886, 915.5651065743718, 918.8392031394613, 5797.246357973437, 5826.096954971986, 5826.970865145647, 5863.501602363847, 6159.599626024294, 909.5134103254727, 913.3743385780762, 918.8254231695956, 924.9630014799333, 971.6064993677572, 3456.4469684850806, 3947.2894878921497, 4077.062275676611, 4191.97904010478, 4343.370211319404, 10528.684139475828, 10530.684079477627, 10762.3542587445, 10832.350058996328, 10882.183836212158, 10516.894831051744, 10764.300320479144, 10777.83833242502, 10781.514831832586, 10782.921707829311, 8060.113387527367, 8376.874346884802, 8414.11651776567, 8426.368022398223, 8446.662133514714, 6033.577649564664, 6056.121862330026, 6107.603005804608, 6176.722047507783, 6261.092141639528, 9729.659461919082, 9956.103950644478, 10131.986801319808, 10269.486525673836, 10278.434686092336, 10267.332623379756, 10284.177265818866, 10295.53670084833, 10303.845442318221, 10310.690679279634, 6853.965730171317, 6906.0, 7473.402127829652, 7536.8492630148185, 7721.575313357819, 8307.501549907025, 8483.066862645228, 8504.064552899052, 8505.95747021261, 8514.020887598006, 7485.5508669480005, 7569.962150189213, 7596.468247222641, 7710.0, 7755.844883102419, 7320.377767889576, 7457.216992215739, 7500.737474188595, 7505.324520792937, 7532.774016779286, 6927.411170050602, 6993.825154371181, 7065.752698655522, 7075.327843854826, 7090.893636595559, 4927.753612319298, 4979.427365852828, 5033.421156566895, 5099.2860999460845, 5133.56364708989, 4503.256962601135, 4874.731889746098, 5056.292119103255, 5107.361579802525, 5249.868753281045], "value": 4609.91584016519, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [256.4358411494712, 307.73534760106304, 310.96579376268613, 315.4574132492114, 320.6873298533931, 5443.740847548268, 5488.670679759217, 5503.3120859892515, 5509.972450137754, 5528.364238112623, 4869.5373939475785, 5084.313617661614, 5214.634975551713, 5307.840764777054, 5437.564994800407, 4073.5111786585653, 4108.712390132692, 4110.486189226347, 4126.876193714186, 4131.132462182945, 4101.856435024774, 4117.4441450404265, 4132.793360331972, 4144.97927510362, 4188.832446702128, 3160.6207255129416, 3846.4807251021175, 3974.741641793274, 4111.280525907954, 4158.960259935016, 4091.468109145822, 4104.240715467648, 4108.6918481114035, 4116.361963895601, 4124.608162224599, 2957.5064592380927, 3578.284343131384, 3587.170543023051, 3592.1378869071496, 3598.1904071583685, 4554.63562914966, 4619.030003699228, 5000.2499625056535, 5263.684178949237, 5352.545033672142, 4451.77741112943, 4734.786934587952, 4743.573078422924, 4763.76181190939, 4788.521147885219, 5451.863703407407, 5609.691466969315, 5668.631538949955, 5680.869673872298, 5688.691600931809, 3364.9495257571157, 3757.0982964088694, 3763.41667041609, 3954.2684603348184, 3964.5044369453817, 5949.144410682897, 5953.583249172603, 6002.3697511761075, 6003.889280483125, 6030.246219222598, 4006.3990401439432, 4011.498562679665, 4025.074232926385, 4029.03303207234, 4063.715539912178, 3473.4616134498688, 4099.426080348753, 4113.239050775616, 4126.257273690764, 4134.91730165401, 3961.980190099031, 4578.40480737502, 4644.698094623838, 4665.556772106713, 4794.304825800239, 5078.7206703631655, 5386.784528618811, 5395.678058875601, 5717.828465146053, 5717.885642287131, 1173.9941300293444, 1377.1805775563523, 1392.997042129665, 1396.9441222350993, 1403.3544569497942, 887.4364778365784, 908.6547112097361, 954.0650162840456, 966.5891995901854, 975.5707488705089, 4681.782736488538, 4865.764266762563, 5158.819441319536, 5286.995470860601, 5393.568514518829, 4927.9590735597185, 5122.487751224922, 5825.38833422493, 5837.88324233513, 5861.9706901465215, 4191.706580539333, 4472.718913354212, 4576.794044268016, 4809.350737650442, 5282.31329927107, 2892.611546457712, 3007.879684812583, 3013.8493075346146, 3048.2227032107116, 3100.3024319528377, 5669.6314739541795, 5990.221271234712, 5990.880182396328, 5993.0, 6009.639421634716, 5439.265699130646, 5454.263674403984, 5661.027960320865, 5930.22907022093, 5979.056806537893, 5038.974805126024, 5944.613600115978, 6037.486813620892, 6077.361877003028, 6131.294901086343, 4395.648348132206, 5886.411358864079, 5932.8813423732145, 5967.91048134287, 6010.549208809444, 4941.33292005589, 5160.5424365674335, 5893.499052580579, 5900.232969713909, 5917.112433135064, 5190.560436594795, 5992.670403127696, 6184.206580091903, 6195.597286176384, 6266.310705822265, 3896.519322657372, 3951.78265195417, 3963.821628026688, 3975.0, 3982.6415622594104, 5981.0, 6001.849953751192, 6008.579399442172, 6018.729157188025, 6026.76451327468, 4412.0, 4787.699796678606, 5556.72216389187, 5864.9413505864395, 5871.4715675589405, 5085.974570127126, 5669.149627555899, 5717.713514459213, 5746.367899530965, 5785.30576330843, 4798.640101992295, 5254.65844720092, 5446.918296225639, 5608.859778505407, 5620.353659329229, 5206.609504287269, 5655.519280861173, 5699.487046165865, 5729.799457018984, 5792.594518383841, 4926.433460152129, 5144.819931302386, 5636.267285252891, 5645.633033852787, 5658.349289831557], "value": 4162.605111220094, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [709.9467539934504, 797.882963850609, 799.6841247707156, 800.9399295052873, 807.919208079192, 15279.923600381997, 16098.034117952902, 16105.67788644228, 16115.91942040288, 16173.94869333494, 11258.0, 13485.865141348584, 13557.932210338959, 13561.864381356183, 13591.184528928272, 673.0442771264791, 693.594247365292, 831.9251267385933, 832.2883934236231, 853.3940901959617, 847.8389106069827, 854.133054949227, 854.940154189207, 855.4567849415604, 857.5240741388527, 902.0168016861652, 906.5512571277227, 907.4645958884257, 909.2680392284209, 911.2800887299059, 715.3347386930127, 737.6975440069546, 875.5315905990265, 889.9288056955428, 903.4985583001431, 637.3690046853628, 638.6583177999748, 655.3610230025687, 670.5875886329871, 671.2850813883199, 15217.467388641344, 15266.236688165658, 15282.847171528254, 15293.541193764093, 15295.15876626785, 13891.235982020984, 14055.929720351434, 14075.507357242448, 14089.084209526349, 14279.500217492337, 12408.131430799847, 12752.0, 12754.872451275462, 12771.042171837149, 13186.142900711424, 4485.865424037252, 4514.6388288936805, 4542.3640690303055, 4548.545145485458, 4671.906561868744, 127928.0, 132651.0, 133019.0, 133351.33324333414, 135222.0, 10699.94650026745, 10952.42617984773, 11195.944020280009, 11223.831642525369, 11224.66326010221, 22624.0, 22914.312570622908, 22936.770632293796, 22950.0, 23315.766842331697, 6802.387785099365, 6927.896081558781, 7612.048493938258, 7802.0, 7817.257360550739, 4207.0, 4320.891977700583, 4368.366586844953, 4373.409589705413, 4539.704919180309, 3405.7956522608724, 3554.147004718849, 3561.4301711726, 3563.6080031196548, 3572.1069732566857, 615.4061330815695, 635.2250254689365, 647.6826355085974, 648.3063122458924, 656.5437021270267, 622.2874808344511, 622.4429135923414, 628.669948277149, 628.7864421666137, 649.5388274325187, 7224.927750722531, 8138.186181381814, 8139.860419541269, 8176.959115204505, 9041.68354107603, 582.7494276568151, 594.1635090364437, 628.4877824572958, 645.6352161029004, 658.121407920422, 4484.372187893698, 4535.4103966484145, 4558.407407037064, 4609.976950115295, 4618.689045813118, 110243.0, 121265.0, 169361.0, 170912.0, 179372.0, 105450.0, 108574.0, 117205.41397292959, 125427.49145017231, 150143.0, 104404.0, 106535.0, 107474.70101195865, 111324.0, 112772.0, 9534.570944307385, 9947.21641270784, 9981.700548983543, 10118.696439106838, 10134.594616215269, 54424.72787636037, 62583.37416625775, 62666.110067488524, 64387.0, 65850.01224981724, 91350.0, 93469.0, 95808.0, 97984.51007744916, 99839.50080249552, 12300.446479908247, 12767.297798620793, 12858.614241572768, 13297.734045318846, 13371.732565348833, 14687.265636718335, 14700.70598588001, 14974.101553906801, 15161.696766064837, 15237.31432085581, 13028.41372138275, 13691.794623080463, 13793.034487586174, 13920.164790112625, 14484.493042743454, 13020.544280950122, 13404.664883377993, 13681.605718998937, 13752.449902003807, 13785.51750688721, 11434.313941163557, 13449.260290683715, 13557.661058473617, 13841.4463421462, 13957.93021034929, 10101.939296373776, 10988.725281868017, 11415.714607134889, 11418.429078546205, 11451.0, 11492.885071149516, 11550.364729939934, 11757.706057348634, 11824.40877956116, 11870.228435151688], "value": 7861.276167262667, "unit": "score"}], "name": "dromaeo_css", "value": 7367.4226132150325, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 113.0, 113.0, 113.0, 113.0, 114.0, 113.0, 111.0, 112.0, 113.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 109.0, 107.0, 142.0, 109.0, 109.0, 110.0, 109.0, 139.0, 109.0], "value": 118.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 185.0, 185.0, 186.0, 184.0, 183.0, 183.0, 182.0, 184.0, 184.0], "value": 184.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 59.0, 59.0, 88.0, 61.0, 59.0, 59.0, 57.0, 83.0, 58.0], "value": 66.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 71.0, 96.0, 72.0, 68.0, 66.0, 89.0, 70.0, 69.0, 90.0], "value": 77.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 105.0, 131.0, 92.0, 83.0, 88.0, 84.0, 85.0, 83.0], "value": 92.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 97.0, 119.0, 159.0, 159.0, 160.0, 96.0, 96.0], "value": 117.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 85.0, 85.0, 87.0, 85.0, 85.0, 86.0, 87.0, 85.0, 84.0], "value": 85.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 53.0, 54.0, 58.0, 58.0, 58.0, 58.0, 58.0, 57.0], "value": 56.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 74.0, 66.0, 78.0, 72.0, 69.0, 69.0, 69.0, 69.0, 70.0], "value": 69.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 81.0, 85.0, 82.0, 82.0, 84.0, 84.0, 88.0, 90.0], "value": 84.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 146.0, 154.0, 140.0, 141.0, 151.0, 159.0, 144.0, 173.0, 146.0], "value": 150.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 166.0, 165.0, 225.0, 217.0, 166.0, 168.0, 166.0, 164.0, 166.0], "value": 176.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 68.0, 66.0, 68.0, 68.0, 67.0, 68.0, 70.0, 85.0], "value": 69.6, "unit": "score"}], "name": "kraken", "value": 1462.0, "alertThreshold": 2.0}]} 12:29:23 INFO - Return code: 0 12:29:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:29:23 INFO - # TBPL SUCCESS # 12:29:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:29:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:29:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:29:23 INFO - 2016-11-01 12:29:23.482 screenresolution[1890:10987] starting screenresolution argv=screenresolution get 12:29:23 INFO - 2016-11-01 12:29:23.487 screenresolution[1890:10987] Display 0: 1600x1200x32@60 12:29:23 INFO - 2016-11-01 12:29:23.492 screenresolution[1891:10990] starting screenresolution argv=screenresolution list 12:29:23 INFO - Available Modes on Display 0 12:29:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:29:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:29:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:29:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:29:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:29:23 INFO - Intel Iris: 12:29:23 INFO - Chipset Model: Intel Iris 12:29:23 INFO - Type: GPU 12:29:23 INFO - Bus: Built-In 12:29:23 INFO - VRAM (Dynamic, Max): 1536 MB 12:29:23 INFO - Vendor: Intel (0x8086) 12:29:23 INFO - Device ID: 0x0a2e 12:29:23 INFO - Revision ID: 0x0009 12:29:23 INFO - Displays: 12:29:23 INFO - Display: 12:29:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:29:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:29:23 INFO - Display Serial Number: 1600x1200 60 12:29:23 INFO - Main Display: Yes 12:29:23 INFO - Mirror: Off 12:29:23 INFO - Online: Yes 12:29:23 INFO - Rotation: Supported 12:29:23 INFO - Return code: 0 12:29:23 INFO - Running post-action listener: _resource_record_post_action 12:29:23 INFO - [mozharness: 2016-11-01 19:29:23.747813Z] Finished run-tests step (success) 12:29:23 INFO - Running post-run listener: _resource_record_post_run 12:29:23 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 32181248; Write bytes: 665768448; Read time: 199; Write time: 1946 12:29:23 INFO - TinderboxPrint: CPU usage
53.3% 12:29:23 INFO - TinderboxPrint: I/O read bytes / time
32,181,248 / 199 12:29:23 INFO - TinderboxPrint: I/O write bytes / time
665,768,448 / 1,946 12:29:23 INFO - TinderboxPrint: CPU idle
2,258.8 (46.7%) 12:29:23 INFO - TinderboxPrint: CPU system
963.6 (19.9%) 12:29:23 INFO - TinderboxPrint: CPU user
1,615.0 (33.4%) 12:29:23 INFO - TinderboxPrint: Swap in / out
392,192,000 / 0 12:29:23 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 360708608; Write bytes: 356575232; Read time: 27544; Write time: 737 12:29:23 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 30096384; Write bytes: 297794048; Read time: 180; Write time: 1167 12:29:24 INFO - Running post-run listener: _upload_blobber_files 12:29:24 INFO - Blob upload gear active. 12:29:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:29:24 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 12:29:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:29:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:29:24 INFO - (blobuploader) - INFO - Open directory for files ... 12:29:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:29:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:29:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:29:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:29:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:29:25 INFO - (blobuploader) - INFO - Done attempting. 12:29:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:29:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:29:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:29:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:29:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:29:26 INFO - (blobuploader) - INFO - Done attempting. 12:29:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:29:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:29:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:29:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:29:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:29:29 INFO - (blobuploader) - INFO - Done attempting. 12:29:29 INFO - (blobuploader) - INFO - Iteration through files over. 12:29:29 INFO - Return code: 0 12:29:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:29:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:29:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1b11cdc9b86e173ff4a4f353825ec5ac27b3c0683632d5009ac3c2575dee14f9b3f454460b9bf15720d14f118709f7fba2918d638734134daab46a610bc79dde", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dba3ff9881718fcf661ef39917a2af9b9e4969ae00148f3775e5a34321adecd26bbbe999eed1f5b397560521752fa79ec79833413d6ddc6e777aac6552f4bac0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/df2824b7743dbeb993e5feef5352d5dd049638088c85493e90bba93b690c7dd29958419664c383f14f7a0e20b329430f6141646a7edfe1972fd899af53d8ab17"} 12:29:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:29:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:29:29 INFO - Contents: 12:29:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1b11cdc9b86e173ff4a4f353825ec5ac27b3c0683632d5009ac3c2575dee14f9b3f454460b9bf15720d14f118709f7fba2918d638734134daab46a610bc79dde", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dba3ff9881718fcf661ef39917a2af9b9e4969ae00148f3775e5a34321adecd26bbbe999eed1f5b397560521752fa79ec79833413d6ddc6e777aac6552f4bac0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/df2824b7743dbeb993e5feef5352d5dd049638088c85493e90bba93b690c7dd29958419664c383f14f7a0e20b329430f6141646a7edfe1972fd899af53d8ab17"} 12:29:29 INFO - Running post-run listener: copy_logs_to_upload_dir 12:29:29 INFO - Copying logs to upload dir... 12:29:29 INFO - mkdir: /builds/slave/test/build/upload/logs 12:29:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.290192 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-11-01 12:29:29.228359) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-01 12:29:29.231729) ========= 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.EUEufmH5Lh/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.cE8CpGiQpR/Listeners TMPDIR=/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1b11cdc9b86e173ff4a4f353825ec5ac27b3c0683632d5009ac3c2575dee14f9b3f454460b9bf15720d14f118709f7fba2918d638734134daab46a610bc79dde", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dba3ff9881718fcf661ef39917a2af9b9e4969ae00148f3775e5a34321adecd26bbbe999eed1f5b397560521752fa79ec79833413d6ddc6e777aac6552f4bac0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/df2824b7743dbeb993e5feef5352d5dd049638088c85493e90bba93b690c7dd29958419664c383f14f7a0e20b329430f6141646a7edfe1972fd899af53d8ab17"} build_url:https://queue.taskcluster.net/v1/task/VpfapbcAR6Ghm5-DC40MgQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010553 build_url: 'https://queue.taskcluster.net/v1/task/VpfapbcAR6Ghm5-DC40MgQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1b11cdc9b86e173ff4a4f353825ec5ac27b3c0683632d5009ac3c2575dee14f9b3f454460b9bf15720d14f118709f7fba2918d638734134daab46a610bc79dde", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dba3ff9881718fcf661ef39917a2af9b9e4969ae00148f3775e5a34321adecd26bbbe999eed1f5b397560521752fa79ec79833413d6ddc6e777aac6552f4bac0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/df2824b7743dbeb993e5feef5352d5dd049638088c85493e90bba93b690c7dd29958419664c383f14f7a0e20b329430f6141646a7edfe1972fd899af53d8ab17"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-01 12:29:29.264092) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-01 12:29:29.264470) ========= 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.EUEufmH5Lh/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.cE8CpGiQpR/Listeners TMPDIR=/var/folders/w3/rmzpg_rj3zjdrsx94grbz4kr00000w/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.005106 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-01 12:29:29.313073) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-01 12:29:29.313427) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-01 12:29:29.313750) ========= ========= Total master_lag: 0.18 =========