builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0205 starttime: 1475330384.99 results: success (0) buildid: 20161001055157 builduid: 4324b635eb2641f3aa55a491c5ddd022 revision: cd209acf4fb537c08788b69bf1c93370becee0d2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-01 06:59:44.987539) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-01 06:59:44.988265) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-01 06:59:44.988543) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-01 06:59:45.271000) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 06:59:45.271251) ========= 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.p1ITL7tb8G/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.bJSzzM3CiN/Listeners TMPDIR=/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/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-10-01 06:59:45-- 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: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 28.2M=0s 2016-10-01 06:59:45 (28.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.594005 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 06:59:45.916895) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 06:59:45.917193) ========= 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.p1ITL7tb8G/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.bJSzzM3CiN/Listeners TMPDIR=/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/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.027773 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 06:59:45.965609) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-01 06:59:45.965980) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev cd209acf4fb537c08788b69bf1c93370becee0d2 --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 cd209acf4fb537c08788b69bf1c93370becee0d2 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.p1ITL7tb8G/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.bJSzzM3CiN/Listeners TMPDIR=/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/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-10-01 06:59:46,047 truncating revision to first 12 chars 2016-10-01 06:59:46,047 Setting DEBUG logging. 2016-10-01 06:59:46,047 attempt 1/10 2016-10-01 06:59:46,047 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/cd209acf4fb5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-01 06:59:47,302 unpacking tar archive at: mozilla-aurora-cd209acf4fb5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.521996 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-01 06:59:47.509580) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-01 06:59:47.509895) ========= script_repo_revision: cd209acf4fb537c08788b69bf1c93370becee0d2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-01 06:59:47.510300) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-01 06:59:47.510631) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-01 06:59:47.528606) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-10-01 06:59:47.528995) ========= /tools/buildbot/bin/python 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', '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.p1ITL7tb8G/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.bJSzzM3CiN/Listeners TMPDIR=/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 06:59:47 INFO - MultiFileLogger online at 20161001 06:59:47 in /builds/slave/test 06:59:47 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 06:59:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:59:47 INFO - {'append_to_log': False, 06:59:47 INFO - 'base_work_dir': '/builds/slave/test', 06:59:47 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 06:59:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:59:47 INFO - 'branch': 'Mozilla-Aurora', 06:59:47 INFO - 'buildbot_json_path': 'buildprops.json', 06:59:47 INFO - 'config_files': ('talos/mac_config.py',), 06:59:47 INFO - 'default_actions': ('clobber', 06:59:47 INFO - 'read-buildbot-config', 06:59:47 INFO - 'download-and-extract', 06:59:47 INFO - 'populate-webroot', 06:59:47 INFO - 'create-virtualenv', 06:59:47 INFO - 'install', 06:59:47 INFO - 'run-tests'), 06:59:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:59:47 INFO - 'download_minidump_stackwalk': True, 06:59:47 INFO - 'download_symbols': 'ondemand', 06:59:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:59:47 INFO - 'tooltool.py': '/tools/tooltool.py', 06:59:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:59:47 INFO - '/tools/misc-python/virtualenv.py')}, 06:59:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:59:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:59:47 INFO - 'installer_path': 'installer.exe', 06:59:47 INFO - 'log_level': 'info', 06:59:47 INFO - 'log_name': 'talos', 06:59:47 INFO - 'log_to_console': True, 06:59:47 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:59:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:59:47 INFO - 'opt_config_files': (), 06:59:47 INFO - 'pip_index': False, 06:59:47 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:59:47 INFO - 'cmd': ('bash', 06:59:47 INFO - '-c', 06:59:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:59:47 INFO - 'enabled': True, 06:59:47 INFO - 'halt_on_failure': False, 06:59:47 INFO - 'name': 'check_screen_resolution'},), 06:59:47 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:59:47 INFO - 'cmd': ('bash', 06:59:47 INFO - '-c', 06:59:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:59:47 INFO - 'enabled': True, 06:59:47 INFO - 'halt_on_failure': False, 06:59:47 INFO - 'name': 'check_screen_resolution'},), 06:59:47 INFO - 'run_cmd_checks_enabled': True, 06:59:47 INFO - 'sps_profile': False, 06:59:47 INFO - 'sps_profile_interval': 0, 06:59:47 INFO - 'suite': 'dromaeojs', 06:59:47 INFO - 'system_bits': '32', 06:59:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:59:47 INFO - 'title': 't-yosemite-r7-0205', 06:59:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:59:47 INFO - 'use_talos_json': True, 06:59:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:59:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:59:47 INFO - 'work_dir': 'build'} 06:59:47 INFO - [mozharness: 2016-10-01 13:59:47.735459Z] Running clobber step. 06:59:47 INFO - Running pre-action listener: _resource_record_pre_action 06:59:47 INFO - Running main action method: clobber 06:59:47 INFO - rmtree: /builds/slave/test/build 06:59:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:59:49 INFO - Running post-action listener: _resource_record_post_action 06:59:49 INFO - [mozharness: 2016-10-01 13:59:49.872142Z] Finished clobber step (success) 06:59:49 INFO - [mozharness: 2016-10-01 13:59:49.872258Z] Running read-buildbot-config step. 06:59:49 INFO - Running pre-action listener: _resource_record_pre_action 06:59:49 INFO - Running main action method: read_buildbot_config 06:59:49 INFO - Using buildbot properties: 06:59:49 INFO - { 06:59:49 INFO - "project": "", 06:59:49 INFO - "product": "firefox", 06:59:49 INFO - "script_repo_revision": "production", 06:59:49 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 06:59:49 INFO - "repository": "", 06:59:49 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 06:59:49 INFO - "buildid": "20161001055157", 06:59:49 INFO - "pgo_build": "False", 06:59:49 INFO - "basedir": "/builds/slave/test", 06:59:49 INFO - "buildnumber": 30, 06:59:49 INFO - "slavename": "t-yosemite-r7-0205", 06:59:49 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 06:59:49 INFO - "platform": "yosemite_r7", 06:59:49 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 06:59:49 INFO - "branch": "mozilla-aurora", 06:59:49 INFO - "repo_path": "releases/mozilla-aurora", 06:59:49 INFO - "revision": "cd209acf4fb537c08788b69bf1c93370becee0d2", 06:59:49 INFO - "stage_platform": "macosx64", 06:59:49 INFO - "builduid": "4324b635eb2641f3aa55a491c5ddd022", 06:59:49 INFO - "slavebuilddir": "test" 06:59:49 INFO - } 06:59:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/OAF5oyzCT1Gs9vtrdH1V0w/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 06:59:49 INFO - Running post-action listener: _resource_record_post_action 06:59:49 INFO - [mozharness: 2016-10-01 13:59:49.875241Z] Finished read-buildbot-config step (success) 06:59:49 INFO - [mozharness: 2016-10-01 13:59:49.875337Z] Running download-and-extract step. 06:59:49 INFO - Running pre-action listener: _resource_record_pre_action 06:59:49 INFO - Running main action method: download_and_extract 06:59:49 INFO - mkdir: /builds/slave/test/build/tests 06:59:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:49 INFO - trying https://queue.taskcluster.net/v1/task/OAF5oyzCT1Gs9vtrdH1V0w/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 06:59:49 INFO - Downloading https://queue.taskcluster.net/v1/task/OAF5oyzCT1Gs9vtrdH1V0w/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 06:59:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OAF5oyzCT1Gs9vtrdH1V0w/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 06:59:51 INFO - Downloaded 1199 bytes. 06:59:51 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 06:59:51 INFO - Using the following test package requirements: 06:59:51 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 06:59:51 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 06:59:51 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 06:59:51 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 06:59:51 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 06:59:51 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 06:59:51 INFO - u'jsshell-mac.zip'], 06:59:51 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 06:59:51 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 06:59:51 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 06:59:51 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 06:59:51 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 06:59:51 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 06:59:51 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 06:59:51 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 06:59:51 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 06:59:51 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 06:59:51 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 06:59:51 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 06:59:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OAF5oyzCT1Gs9vtrdH1V0w/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 06:59:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OAF5oyzCT1Gs9vtrdH1V0w/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 06:59:51 INFO - Fetch https://queue.taskcluster.net/v1/task/OAF5oyzCT1Gs9vtrdH1V0w/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 06:59:51 INFO - Expected file size: 16433741 06:59:58 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 06:59:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OAF5oyzCT1Gs9vtrdH1V0w/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 06:59:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OAF5oyzCT1Gs9vtrdH1V0w/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 06:59:58 INFO - Fetch https://queue.taskcluster.net/v1/task/OAF5oyzCT1Gs9vtrdH1V0w/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 06:59:59 INFO - Expected file size: 16433741 07:00:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OAF5oyzCT1Gs9vtrdH1V0w/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 07:00:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OAF5oyzCT1Gs9vtrdH1V0w/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 07:00:06 INFO - Fetch https://queue.taskcluster.net/v1/task/OAF5oyzCT1Gs9vtrdH1V0w/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 07:00:06 INFO - Expected file size: 14414059 07:00:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:00:07 INFO - trying https://queue.taskcluster.net/v1/task/OAF5oyzCT1Gs9vtrdH1V0w/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 07:00:07 INFO - Downloading https://queue.taskcluster.net/v1/task/OAF5oyzCT1Gs9vtrdH1V0w/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 07:00:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OAF5oyzCT1Gs9vtrdH1V0w/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 07:00:10 INFO - Downloaded 115275146 bytes. 07:00:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OAF5oyzCT1Gs9vtrdH1V0w/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 07:00:10 INFO - mkdir: /builds/slave/test/properties 07:00:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:00:10 INFO - Writing to file /builds/slave/test/properties/build_url 07:00:10 INFO - Contents: 07:00:10 INFO - build_url:https://queue.taskcluster.net/v1/task/OAF5oyzCT1Gs9vtrdH1V0w/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 07:00:11 INFO - Running post-action listener: _resource_record_post_action 07:00:11 INFO - Running post-action listener: set_extra_try_arguments 07:00:11 INFO - [mozharness: 2016-10-01 14:00:11.491187Z] Finished download-and-extract step (success) 07:00:11 INFO - [mozharness: 2016-10-01 14:00:11.491292Z] Running populate-webroot step. 07:00:11 INFO - Running pre-action listener: _resource_record_pre_action 07:00:11 INFO - Running main action method: populate_webroot 07:00:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:00:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:00:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:00:11 INFO - '--tppagecycles', 07:00:11 INFO - '7'], 07:00:11 INFO - 'tests': ['tsvgm']}}, 07:00:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:00:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:00:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:00:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:00:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:00:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:00:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:11 INFO - 'talos_options': ['--disable-e10s'], 07:00:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:00:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:00:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:11 INFO - 'talos_options': ['--disable-e10s'], 07:00:11 INFO - 'tests': ['damp', 'tps']}, 07:00:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:11 INFO - 'tests': ['damp', 'tps']}, 07:00:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:00:11 INFO - 'tests': ['dromaeo_dom']}, 07:00:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:00:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:00:11 INFO - 'tests': ['basic_compositor_video']}, 07:00:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:00:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:00:11 INFO - 'tests': ['a11yr', 07:00:11 INFO - 'ts_paint', 07:00:11 INFO - 'tpaint', 07:00:11 INFO - 'sessionrestore', 07:00:11 INFO - 'sessionrestore_no_auto_restore', 07:00:11 INFO - 'tabpaint']}, 07:00:11 INFO - 'other-e10s': {'tests': ['a11yr', 07:00:11 INFO - 'ts_paint', 07:00:11 INFO - 'tpaint', 07:00:11 INFO - 'sessionrestore', 07:00:11 INFO - 'sessionrestore_no_auto_restore', 07:00:11 INFO - 'tabpaint']}, 07:00:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:00:11 INFO - 'ts_paint', 07:00:11 INFO - 'tpaint', 07:00:11 INFO - 'sessionrestore', 07:00:11 INFO - 'sessionrestore_no_auto_restore', 07:00:11 INFO - 'tabpaint']}, 07:00:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:00:11 INFO - 'ts_paint', 07:00:11 INFO - 'tpaint', 07:00:11 INFO - 'sessionrestore', 07:00:11 INFO - 'sessionrestore_no_auto_restore', 07:00:11 INFO - 'tabpaint']}, 07:00:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:00:11 INFO - 'tests': ['a11yr', 07:00:11 INFO - 'ts_paint', 07:00:11 INFO - 'tpaint', 07:00:11 INFO - 'sessionrestore', 07:00:11 INFO - 'sessionrestore_no_auto_restore', 07:00:11 INFO - 'tabpaint']}, 07:00:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:00:11 INFO - 'tests': ['a11yr', 07:00:11 INFO - 'ts_paint', 07:00:11 INFO - 'tpaint', 07:00:11 INFO - 'sessionrestore', 07:00:11 INFO - 'sessionrestore_no_auto_restore', 07:00:11 INFO - 'tabpaint']}, 07:00:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:00:11 INFO - 'tests': ['tsvgx', 07:00:11 INFO - 'tsvgr_opacity', 07:00:11 INFO - 'tart', 07:00:11 INFO - 'tscrollx', 07:00:11 INFO - 'cart']}, 07:00:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:00:11 INFO - 'tsvgr_opacity', 07:00:11 INFO - 'tart', 07:00:11 INFO - 'tscrollx', 07:00:11 INFO - 'cart']}, 07:00:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:11 INFO - 'talos_options': ['--disable-e10s'], 07:00:11 INFO - 'tests': ['tp5o']}, 07:00:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:11 INFO - 'tests': ['tp5o']}, 07:00:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:11 INFO - 'talos_options': ['--disable-e10s', 07:00:11 INFO - '--xperf_path', 07:00:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:00:11 INFO - 'tests': ['tp5n']}, 07:00:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:11 INFO - 'talos_options': ['--xperf_path', 07:00:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:00:11 INFO - 'tests': ['tp5n']}}, 07:00:11 INFO - 'talos.zip': {'path': '', 07:00:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:00:11 INFO - Running post-action listener: _resource_record_post_action 07:00:11 INFO - [mozharness: 2016-10-01 14:00:11.509974Z] Finished populate-webroot step (success) 07:00:11 INFO - [mozharness: 2016-10-01 14:00:11.510081Z] Running create-virtualenv step. 07:00:11 INFO - Running pre-action listener: _resource_record_pre_action 07:00:11 INFO - Running main action method: create_virtualenv 07:00:11 INFO - Creating virtualenv /builds/slave/test/build/venv 07:00:11 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 07:00:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:00:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:00:11 INFO - Using real prefix '/tools/python27' 07:00:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:00:12 INFO - Installing distribute.............................................................................................................................................................................................done. 07:00:15 INFO - Installing pip.................done. 07:00:15 INFO - Return code: 0 07:00:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:00:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:00:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b09e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b014570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6c2d945e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aeb2d30>, '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 0x10ad18db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aeaab20>, '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.p1ITL7tb8G/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.bJSzzM3CiN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/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 07:00:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:00:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:00:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p1ITL7tb8G/Render', 07:00:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:00:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:00:15 INFO - 'HOME': '/Users/cltbld', 07:00:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:00:15 INFO - 'LOGNAME': 'cltbld', 07:00:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:15 INFO - 'MOZ_NO_REMOTE': '1', 07:00:15 INFO - 'NO_EM_RESTART': '1', 07:00:15 INFO - 'PAGER': '/bin/cat', 07:00:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:00:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:15 INFO - 'PWD': '/builds/slave/test', 07:00:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:00:15 INFO - 'SHELL': '/bin/bash', 07:00:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bJSzzM3CiN/Listeners', 07:00:15 INFO - 'TMPDIR': '/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/', 07:00:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:00:15 INFO - 'USER': 'cltbld', 07:00:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:00:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:00:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:15 INFO - 'XPC_FLAGS': '0x0', 07:00:15 INFO - 'XPC_SERVICE_NAME': '0', 07:00:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:00:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:15 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 07:00:15 INFO - Cleaning up... 07:00:15 INFO - Return code: 0 07:00:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:00:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:00:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b09e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b014570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6c2d945e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aeb2d30>, '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 0x10ad18db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aeaab20>, '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.p1ITL7tb8G/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.bJSzzM3CiN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/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 07:00:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:00:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:00:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p1ITL7tb8G/Render', 07:00:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:00:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:00:15 INFO - 'HOME': '/Users/cltbld', 07:00:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:00:15 INFO - 'LOGNAME': 'cltbld', 07:00:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:15 INFO - 'MOZ_NO_REMOTE': '1', 07:00:15 INFO - 'NO_EM_RESTART': '1', 07:00:15 INFO - 'PAGER': '/bin/cat', 07:00:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:00:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:15 INFO - 'PWD': '/builds/slave/test', 07:00:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:00:15 INFO - 'SHELL': '/bin/bash', 07:00:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bJSzzM3CiN/Listeners', 07:00:15 INFO - 'TMPDIR': '/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/', 07:00:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:00:15 INFO - 'USER': 'cltbld', 07:00:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:00:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:00:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:15 INFO - 'XPC_FLAGS': '0x0', 07:00:15 INFO - 'XPC_SERVICE_NAME': '0', 07:00:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:00:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:15 INFO - Downloading/unpacking psutil>=3.1.1 07:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:00:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:00:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:00:19 INFO - Installing collected packages: psutil 07:00:19 INFO - Running setup.py install for psutil 07:00:19 INFO - building 'psutil._psutil_osx' extension 07:00:19 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 07:00:20 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 07:00:20 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 07:00:20 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 07:00:20 INFO - building 'psutil._psutil_posix' extension 07:00:20 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 07:00:20 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:00:20 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:00:20 INFO - ^ 07:00:20 INFO - 1 warning generated. 07:00:20 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 07:00:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:00:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:00:20 INFO - Successfully installed psutil 07:00:20 INFO - Cleaning up... 07:00:20 INFO - Return code: 0 07:00:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:00: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')]} 07:00:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00: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')]} 07:00:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:20 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 0x10b09e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b014570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6c2d945e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aeb2d30>, '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 0x10ad18db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aeaab20>, '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.p1ITL7tb8G/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.bJSzzM3CiN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/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 07:00:20 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 07:00:20 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 07:00:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p1ITL7tb8G/Render', 07:00:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:00:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:00:20 INFO - 'HOME': '/Users/cltbld', 07:00:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:00:20 INFO - 'LOGNAME': 'cltbld', 07:00:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:20 INFO - 'MOZ_NO_REMOTE': '1', 07:00:20 INFO - 'NO_EM_RESTART': '1', 07:00:20 INFO - 'PAGER': '/bin/cat', 07:00:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:00:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:20 INFO - 'PWD': '/builds/slave/test', 07:00:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:00:20 INFO - 'SHELL': '/bin/bash', 07:00:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bJSzzM3CiN/Listeners', 07:00:20 INFO - 'TMPDIR': '/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/', 07:00:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:00:20 INFO - 'USER': 'cltbld', 07:00:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:00:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:00:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:20 INFO - 'XPC_FLAGS': '0x0', 07:00:20 INFO - 'XPC_SERVICE_NAME': '0', 07:00:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:00:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:00:20 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 07:00:20 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 07:00:20 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 07:00:20 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 07:00:20 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 07:00:20 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 07:00:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:00:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:00:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:00:23 INFO - Installing collected packages: mozsystemmonitor 07:00:23 INFO - Running setup.py install for mozsystemmonitor 07:00:23 INFO - Successfully installed mozsystemmonitor 07:00:23 INFO - Cleaning up... 07:00:23 INFO - Return code: 0 07:00:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:00:23 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')]} 07:00:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:23 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')]} 07:00:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:23 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 0x10b09e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b014570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6c2d945e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aeb2d30>, '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 0x10ad18db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aeaab20>, '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.p1ITL7tb8G/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.bJSzzM3CiN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/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 07:00:23 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 07:00:23 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 07:00:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p1ITL7tb8G/Render', 07:00:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:00:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:00:23 INFO - 'HOME': '/Users/cltbld', 07:00:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:00:23 INFO - 'LOGNAME': 'cltbld', 07:00:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:23 INFO - 'MOZ_NO_REMOTE': '1', 07:00:23 INFO - 'NO_EM_RESTART': '1', 07:00:23 INFO - 'PAGER': '/bin/cat', 07:00:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:00:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:23 INFO - 'PWD': '/builds/slave/test', 07:00:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:00:23 INFO - 'SHELL': '/bin/bash', 07:00:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bJSzzM3CiN/Listeners', 07:00:23 INFO - 'TMPDIR': '/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/', 07:00:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:00:23 INFO - 'USER': 'cltbld', 07:00:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:00:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:00:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:23 INFO - 'XPC_FLAGS': '0x0', 07:00:23 INFO - 'XPC_SERVICE_NAME': '0', 07:00:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:00:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:23 INFO - Downloading/unpacking jsonschema==2.5.1 07:00:23 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 07:00:23 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 07:00:23 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 07:00:23 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 07:00:23 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 07:00:23 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 07:00:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:00:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:00:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:26 INFO - Downloading functools32-3.2.3-2.tar.gz 07:00:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:00:26 INFO - warning: no files found matching '*.txt' 07:00:26 INFO - no previously-included directories found matching 'build' 07:00:26 INFO - no previously-included directories found matching 'dist' 07:00:26 INFO - no previously-included directories found matching '.git*' 07:00:26 INFO - Installing collected packages: jsonschema, functools32 07:00:27 INFO - Running setup.py install for functools32 07:00:27 INFO - warning: no files found matching '*.txt' 07:00:27 INFO - no previously-included directories found matching 'build' 07:00:27 INFO - no previously-included directories found matching 'dist' 07:00:27 INFO - no previously-included directories found matching '.git*' 07:00:27 INFO - Successfully installed jsonschema functools32 07:00:27 INFO - Cleaning up... 07:00:27 INFO - Return code: 0 07:00:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:00:27 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')]} 07:00:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:27 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')]} 07:00:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:27 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 0x10b09e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b014570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6c2d945e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aeb2d30>, '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 0x10ad18db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aeaab20>, '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.p1ITL7tb8G/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.bJSzzM3CiN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/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 07:00:27 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 07:00:27 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 07:00:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p1ITL7tb8G/Render', 07:00:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:00:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:00:27 INFO - 'HOME': '/Users/cltbld', 07:00:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:00:27 INFO - 'LOGNAME': 'cltbld', 07:00:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:27 INFO - 'MOZ_NO_REMOTE': '1', 07:00:27 INFO - 'NO_EM_RESTART': '1', 07:00:27 INFO - 'PAGER': '/bin/cat', 07:00:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:00:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:27 INFO - 'PWD': '/builds/slave/test', 07:00:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:00:27 INFO - 'SHELL': '/bin/bash', 07:00:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bJSzzM3CiN/Listeners', 07:00:27 INFO - 'TMPDIR': '/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/', 07:00:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:00:27 INFO - 'USER': 'cltbld', 07:00:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:00:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:00:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:27 INFO - 'XPC_FLAGS': '0x0', 07:00:27 INFO - 'XPC_SERVICE_NAME': '0', 07:00:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:00:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:00:27 INFO - Cleaning up... 07:00:27 INFO - Return code: 0 07:00:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:00:27 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')]} 07:00:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:27 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')]} 07:00:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:27 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 0x10b09e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b014570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6c2d945e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aeb2d30>, '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 0x10ad18db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aeaab20>, '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.p1ITL7tb8G/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.bJSzzM3CiN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/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 07:00:27 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 07:00:27 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 07:00:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p1ITL7tb8G/Render', 07:00:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:00:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:00:27 INFO - 'HOME': '/Users/cltbld', 07:00:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:00:27 INFO - 'LOGNAME': 'cltbld', 07:00:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:27 INFO - 'MOZ_NO_REMOTE': '1', 07:00:27 INFO - 'NO_EM_RESTART': '1', 07:00:27 INFO - 'PAGER': '/bin/cat', 07:00:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:00:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:27 INFO - 'PWD': '/builds/slave/test', 07:00:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:00:27 INFO - 'SHELL': '/bin/bash', 07:00:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bJSzzM3CiN/Listeners', 07:00:27 INFO - 'TMPDIR': '/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/', 07:00:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:00:27 INFO - 'USER': 'cltbld', 07:00:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:00:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:00:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:27 INFO - 'XPC_FLAGS': '0x0', 07:00:27 INFO - 'XPC_SERVICE_NAME': '0', 07:00:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:00:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:27 INFO - Downloading/unpacking blobuploader==1.2.4 07:00:27 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 07:00:27 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 07:00:27 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 07:00:27 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 07:00:27 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 07:00:27 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 07:00:30 INFO - Downloading blobuploader-1.2.4.tar.gz 07:00:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:00:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:00:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:00:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:00:31 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 07:00:31 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 07:00:31 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 07:00:31 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 07:00:31 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 07:00:31 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 07:00:31 INFO - Downloading docopt-0.6.1.tar.gz 07:00:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:00:31 INFO - Installing collected packages: blobuploader, requests, docopt 07:00:31 INFO - Running setup.py install for blobuploader 07:00:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:00:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:00:31 INFO - Running setup.py install for requests 07:00:32 INFO - Running setup.py install for docopt 07:00:32 INFO - Successfully installed blobuploader requests docopt 07:00:32 INFO - Cleaning up... 07:00:32 INFO - Return code: 0 07:00:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:00:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:00:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:00:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:32 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 0x10b09e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b014570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6c2d945e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aeb2d30>, '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 0x10ad18db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aeaab20>, '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.p1ITL7tb8G/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.bJSzzM3CiN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/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 07:00:32 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 07:00:32 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 07:00:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p1ITL7tb8G/Render', 07:00:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:00:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:00:32 INFO - 'HOME': '/Users/cltbld', 07:00:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:00:32 INFO - 'LOGNAME': 'cltbld', 07:00:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:32 INFO - 'MOZ_NO_REMOTE': '1', 07:00:32 INFO - 'NO_EM_RESTART': '1', 07:00:32 INFO - 'PAGER': '/bin/cat', 07:00:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:00:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:32 INFO - 'PWD': '/builds/slave/test', 07:00:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:00:32 INFO - 'SHELL': '/bin/bash', 07:00:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bJSzzM3CiN/Listeners', 07:00:32 INFO - 'TMPDIR': '/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/', 07:00:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:00:32 INFO - 'USER': 'cltbld', 07:00:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:00:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:00:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:32 INFO - 'XPC_FLAGS': '0x0', 07:00:32 INFO - 'XPC_SERVICE_NAME': '0', 07:00:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:00:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:00:32 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-ZZWheK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:00:32 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-wT7i0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:00:32 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-oJEMw0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:00:32 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-qpG_hn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:00:33 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-5K1ezL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:00:33 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-jLPaiB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:00:33 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-2_zWF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:00:33 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-L78dOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:00:33 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-4PflcP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:00:33 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-Y897qI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:00:33 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-LulzB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:00:33 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-ddh9Ux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:00:33 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-R8tMqL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:00:33 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-5PRR03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:00:34 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-HU56ef-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:00:34 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-iK7A9e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:00:34 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-T4jIyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:00:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:00:34 INFO - Running setup.py install for manifestparser 07:00:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:00:34 INFO - Running setup.py install for mozcrash 07:00:34 INFO - Running setup.py install for mozdebug 07:00:34 INFO - Running setup.py install for mozdevice 07:00:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:00:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:00:34 INFO - Running setup.py install for mozfile 07:00:35 INFO - Running setup.py install for mozhttpd 07:00:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:00:35 INFO - Running setup.py install for mozinfo 07:00:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:00:35 INFO - Running setup.py install for mozInstall 07:00:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:00:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:00:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:00:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:00:35 INFO - Running setup.py install for mozleak 07:00:35 INFO - Running setup.py install for mozlog 07:00:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:00:35 INFO - Running setup.py install for moznetwork 07:00:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:00:36 INFO - Running setup.py install for mozprocess 07:00:36 INFO - Running setup.py install for mozprofile 07:00:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:00:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:00:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:00:36 INFO - Running setup.py install for mozrunner 07:00:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:00:36 INFO - Running setup.py install for mozscreenshot 07:00:36 INFO - Running setup.py install for moztest 07:00:36 INFO - Running setup.py install for mozversion 07:00:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:00:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:00:36 INFO - Cleaning up... 07:00:36 INFO - Return code: 0 07:00:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:00:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:00:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:00:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:36 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 0x10b09e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b014570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6c2d945e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aeb2d30>, '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 0x10ad18db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aeaab20>, '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.p1ITL7tb8G/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.bJSzzM3CiN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/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 07:00:36 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 07:00:36 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 07:00:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p1ITL7tb8G/Render', 07:00:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:00:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:00:36 INFO - 'HOME': '/Users/cltbld', 07:00:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:00:36 INFO - 'LOGNAME': 'cltbld', 07:00:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:36 INFO - 'MOZ_NO_REMOTE': '1', 07:00:36 INFO - 'NO_EM_RESTART': '1', 07:00:36 INFO - 'PAGER': '/bin/cat', 07:00:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:00:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:36 INFO - 'PWD': '/builds/slave/test', 07:00:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:00:36 INFO - 'SHELL': '/bin/bash', 07:00:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bJSzzM3CiN/Listeners', 07:00:36 INFO - 'TMPDIR': '/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/', 07:00:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:00:36 INFO - 'USER': 'cltbld', 07:00:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:00:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:00:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:36 INFO - 'XPC_FLAGS': '0x0', 07:00:36 INFO - 'XPC_SERVICE_NAME': '0', 07:00:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:00:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:00:37 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-x_f4yz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:00:37 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)) 07:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:00:37 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-6zU_Op-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:00:37 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)) 07:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:00:37 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-OVavBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:00:37 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)) 07:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:00:37 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-jEGxKl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:00:37 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)) 07:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:00:37 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-IV_gsj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:00:37 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)) 07:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:00:37 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-yeZk8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:00:37 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)) 07:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:00:37 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-BoqYD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:00:37 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)) 07:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:00:37 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-smZ1Xy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:00:38 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)) 07:00:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:00:38 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-GI74Ca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:00:38 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)) 07:00:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:00:38 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-fuCQc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:00:38 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)) 07:00:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:00:38 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-j0fb_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:00:38 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)) 07:00:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:00:38 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-oPoxwJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:00:38 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)) 07:00:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:00:38 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-akDTqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:00:38 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)) 07:00:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:00:38 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-Ljg9CB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:00:38 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)) 07:00:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:00:38 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-Tvb4kV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:00:38 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)) 07:00:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:00:38 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-iXaVBE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:00:38 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)) 07:00:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:00:38 INFO - Running setup.py (path:/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/pip-mKtTqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:00:39 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)) 07:00:39 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)) 07:00:39 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)) 07:00:39 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)) 07:00:39 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)) 07:00:39 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)) 07:00:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:00:39 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 07:00:39 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 07:00:39 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 07:00:39 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 07:00:39 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 07:00:39 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 07:00:41 INFO - Downloading blessings-1.6.tar.gz 07:00:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:00:41 INFO - Installing collected packages: blessings 07:00:41 INFO - Running setup.py install for blessings 07:00:41 INFO - Successfully installed blessings 07:00:41 INFO - Cleaning up... 07:00:41 INFO - Return code: 0 07:00:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:00:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:00:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:00:42 INFO - Reading from file tmpfile_stdout 07:00:42 INFO - Current package versions: 07:00:42 INFO - blessings == 1.6 07:00:42 INFO - blobuploader == 1.2.4 07:00:42 INFO - docopt == 0.6.1 07:00:42 INFO - functools32 == 3.2.3-2 07:00:42 INFO - jsonschema == 2.5.1 07:00:42 INFO - manifestparser == 1.1 07:00:42 INFO - mozInstall == 1.12 07:00:42 INFO - mozcrash == 0.17 07:00:42 INFO - mozdebug == 0.1 07:00:42 INFO - mozdevice == 0.48 07:00:42 INFO - mozfile == 1.2 07:00:42 INFO - mozhttpd == 0.7 07:00:42 INFO - mozinfo == 0.9 07:00:42 INFO - mozleak == 0.1 07:00:42 INFO - mozlog == 3.4 07:00:42 INFO - moznetwork == 0.27 07:00:42 INFO - mozprocess == 0.23 07:00:42 INFO - mozprofile == 0.28 07:00:42 INFO - mozrunner == 6.12 07:00:42 INFO - mozscreenshot == 0.1 07:00:42 INFO - mozsystemmonitor == 0.3 07:00:42 INFO - moztest == 0.7 07:00:42 INFO - mozversion == 1.4 07:00:42 INFO - psutil == 3.1.1 07:00:42 INFO - requests == 1.2.3 07:00:42 INFO - wsgiref == 0.1.2 07:00:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:00:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:00:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:00:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:42 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 0x10b09e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b014570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6c2d945e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aeb2d30>, '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 0x10ad18db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aeaab20>, '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.p1ITL7tb8G/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.bJSzzM3CiN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/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 07:00:42 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 07:00:42 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 07:00:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p1ITL7tb8G/Render', 07:00:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:00:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:00:42 INFO - 'HOME': '/Users/cltbld', 07:00:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:00:42 INFO - 'LOGNAME': 'cltbld', 07:00:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:42 INFO - 'MOZ_NO_REMOTE': '1', 07:00:42 INFO - 'NO_EM_RESTART': '1', 07:00:42 INFO - 'PAGER': '/bin/cat', 07:00:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:00:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:42 INFO - 'PWD': '/builds/slave/test', 07:00:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:00:42 INFO - 'SHELL': '/bin/bash', 07:00:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bJSzzM3CiN/Listeners', 07:00:42 INFO - 'TMPDIR': '/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/', 07:00:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:00:42 INFO - 'USER': 'cltbld', 07:00:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:00:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:00:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:42 INFO - 'XPC_FLAGS': '0x0', 07:00:42 INFO - 'XPC_SERVICE_NAME': '0', 07:00:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:00:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:42 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)) 07:00:42 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)) 07:00:42 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)) 07:00:42 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)) 07:00:42 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)) 07:00:42 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)) 07:00:42 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)) 07:00:42 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)) 07:00:42 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)) 07:00:42 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)) 07:00:42 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)) 07:00:42 INFO - Cleaning up... 07:00:42 INFO - Return code: 0 07:00:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:00:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:00:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:00:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b09e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b014570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6c2d945e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aeb2d30>, '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 0x10ad18db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aeaab20>, '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.p1ITL7tb8G/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.bJSzzM3CiN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/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 07:00:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:00:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:00:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p1ITL7tb8G/Render', 07:00:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:00:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:00:42 INFO - 'HOME': '/Users/cltbld', 07:00:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:00:42 INFO - 'LOGNAME': 'cltbld', 07:00:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:42 INFO - 'MOZ_NO_REMOTE': '1', 07:00:42 INFO - 'NO_EM_RESTART': '1', 07:00:42 INFO - 'PAGER': '/bin/cat', 07:00:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:00:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:42 INFO - 'PWD': '/builds/slave/test', 07:00:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:00:42 INFO - 'SHELL': '/bin/bash', 07:00:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bJSzzM3CiN/Listeners', 07:00:42 INFO - 'TMPDIR': '/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/', 07:00:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:00:42 INFO - 'USER': 'cltbld', 07:00:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:00:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:00:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:42 INFO - 'XPC_FLAGS': '0x0', 07:00:42 INFO - 'XPC_SERVICE_NAME': '0', 07:00:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:00:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:00:42 INFO - Cleaning up... 07:00:42 INFO - Return code: 0 07:00:42 INFO - Running post-action listener: _resource_record_post_action 07:00:42 INFO - Running post-action listener: _start_resource_monitoring 07:00:42 INFO - Starting resource monitoring. 07:00:42 INFO - [mozharness: 2016-10-01 14:00:42.647323Z] Finished create-virtualenv step (success) 07:00:42 INFO - [mozharness: 2016-10-01 14:00:42.648331Z] Running install step. 07:00:42 INFO - Running pre-action listener: _resource_record_pre_action 07:00:42 INFO - Running main action method: install 07:00:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:00:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:00:42 INFO - Reading from file tmpfile_stdout 07:00:42 INFO - Detecting whether we're running mozinstall >=1.0... 07:00:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:00:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:00:43 INFO - Reading from file tmpfile_stdout 07:00:43 INFO - Output received: 07:00:43 INFO - Usage: mozinstall [options] installer 07:00:43 INFO - Options: 07:00:43 INFO - -h, --help show this help message and exit 07:00:43 INFO - -d DEST, --destination=DEST 07:00:43 INFO - Directory to install application into. [default: 07:00:43 INFO - "/builds/slave/test"] 07:00:43 INFO - --app=APP Application being installed. [default: firefox] 07:00:43 INFO - mkdir: /builds/slave/test/build/application 07:00:43 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'] 07:00:43 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 07:01:14 INFO - Reading from file tmpfile_stdout 07:01:14 INFO - Output received: 07:01:14 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 07:01:14 INFO - Running post-action listener: _resource_record_post_action 07:01:14 INFO - [mozharness: 2016-10-01 14:01:14.870533Z] Finished install step (success) 07:01:14 INFO - [mozharness: 2016-10-01 14:01:14.870667Z] Running run-tests step. 07:01:14 INFO - Running pre-action listener: _resource_record_pre_action 07:01:14 INFO - Running main action method: run_tests 07:01:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:01:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:01:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:01:14 INFO - 2016-10-01 07:01:14.885 screenresolution[1645:8629] starting screenresolution argv=screenresolution get 07:01:14 INFO - 2016-10-01 07:01:14.887 screenresolution[1645:8629] Display 0: 1600x1200x32@60 07:01:14 INFO - 2016-10-01 07:01:14.893 screenresolution[1646:8632] starting screenresolution argv=screenresolution list 07:01:14 INFO - Available Modes on Display 0 07:01:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:01:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:01:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:01:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:01:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:01:15 INFO - Intel Iris: 07:01:15 INFO - Chipset Model: Intel Iris 07:01:15 INFO - Type: GPU 07:01:15 INFO - Bus: Built-In 07:01:15 INFO - VRAM (Dynamic, Max): 1536 MB 07:01:15 INFO - Vendor: Intel (0x8086) 07:01:15 INFO - Device ID: 0x0a2e 07:01:15 INFO - Revision ID: 0x0009 07:01:15 INFO - Displays: 07:01:15 INFO - Display: 07:01:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:01:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:01:15 INFO - Display Serial Number: 1600x1200 60 07:01:15 INFO - Main Display: Yes 07:01:15 INFO - Mirror: Off 07:01:15 INFO - Online: Yes 07:01:15 INFO - Rotation: Supported 07:01:15 INFO - Return code: 0 07:01:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:01:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:01:15 INFO - Python 2.7.3 07:01:15 INFO - Return code: 0 07:01:15 INFO - grabbing minidump binary from tooltool 07:01:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:01:15 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 0x10aeb2d30>, '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 0x10ad18db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aeaab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:01:15 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 07:01:15 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 07:01:15 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 07:01:15 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:01:15 INFO - Return code: 0 07:01:15 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:01:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:01:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:01:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:01:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:01:15 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/OAF5oyzCT1Gs9vtrdH1V0w/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0205', '--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 07:01:15 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/OAF5oyzCT1Gs9vtrdH1V0w/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0205 --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 07:01:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p1ITL7tb8G/Render', 07:01:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:01:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:01:15 INFO - 'HOME': '/Users/cltbld', 07:01:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:01:15 INFO - 'LOGNAME': 'cltbld', 07:01:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:01:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:01:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:01:15 INFO - 'MOZ_NO_REMOTE': '1', 07:01:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:01:15 INFO - 'NO_EM_RESTART': '1', 07:01:15 INFO - 'PAGER': '/bin/cat', 07:01:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:01:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:01:15 INFO - 'PWD': '/builds/slave/test', 07:01:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:01:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:01:15 INFO - 'SHELL': '/bin/bash', 07:01:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bJSzzM3CiN/Listeners', 07:01:15 INFO - 'TMPDIR': '/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/', 07:01:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:01:15 INFO - 'USER': 'cltbld', 07:01:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:01:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:01:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:01:15 INFO - 'XPC_FLAGS': '0x0', 07:01:15 INFO - 'XPC_SERVICE_NAME': '0', 07:01:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:01:15 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/OAF5oyzCT1Gs9vtrdH1V0w/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0205', '--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 07:01:15 INFO - mozversion application_buildid: 20161001055157 07:01:15 INFO - mozversion application_changeset: cd209acf4fb537c08788b69bf1c93370becee0d2 07:01:15 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:01:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:01:15 INFO - mozversion application_name: Firefox 07:01:15 INFO - mozversion application_remotingname: firefox-dev 07:01:15 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:01:15 INFO - mozversion application_vendor: Mozilla 07:01:15 INFO - mozversion application_version: 51.0a2 07:01:15 INFO - mozversion platform_buildid: 20161001055157 07:01:15 INFO - mozversion platform_changeset: cd209acf4fb537c08788b69bf1c93370becee0d2 07:01:15 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:01:15 INFO - mozversion platform_version: 51.0a2 07:01:15 INFO - using testdate: 1475330475 07:01:15 INFO - actual date: 1475330475 07:01:15 INFO - starting webserver on 'localhost:49272' 07:01:15 INFO - SUITE-START | Running 2 tests 07:01:15 INFO - TEST-START | dromaeo_css 07:01:15 INFO - operating with platform_type : mac_ 07:01:15 INFO - Initialising browser for dromaeo_css test... 07:01:15 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/tmpDBX57U/profile http://localhost:49272/getInfo.html) 07:01:17 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 07:01:17 INFO - PROCESS | 1656 | colorDepth:24 07:01:17 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 07:01:17 INFO - PROCESS | 1656 | __metrics 07:01:18 INFO - PROCESS | 1656 | 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" 07:01:18 INFO - PROCESS | 1656 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:01:18 INFO - TEST-INFO | 1656: exit 0 07:01:18 INFO - Browser initialized. 07:01:18 INFO - Running cycle 1/1 for dromaeo_css test... 07:01:18 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/tmpDBX57U/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:01:30 INFO - PROCESS | 1659 | RSS: Main: 219631616 07:01:30 INFO - PROCESS | 1659 | 07:02:21 INFO - PROCESS | 1659 | 1475330541935 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] 07:04:33 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 07:04:35 INFO - PROCESS | 1659 | RSS: Main: 373317632 07:04:35 INFO - PROCESS | 1659 | 07:07:38 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 07:07:39 INFO - PROCESS | 1659 | RSS: Main: 351887360 07:07:39 INFO - PROCESS | 1659 | 07:10:41 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 07:10:42 INFO - PROCESS | 1659 | RSS: Main: 325660672 07:10:42 INFO - PROCESS | 1659 | 07:13:44 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 07:13:45 INFO - PROCESS | 1659 | RSS: Main: 321789952 07:13:45 INFO - PROCESS | 1659 | 07:16:48 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 07:16:49 INFO - PROCESS | 1659 | RSS: Main: 311975936 07:16:49 INFO - PROCESS | 1659 | 07:19:52 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 07:19:52 INFO - PROCESS | 1659 | RSS: Main: 499970048 07:19:52 INFO - PROCESS | 1659 | 07:19:52 INFO - PROCESS | 1659 | __start_tp_report 07:19:52 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 07:19:52 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 07:19:52 INFO - PROCESS | 1659 | |i|pagename|runs| 07:19:52 INFO - PROCESS | 1659 | |0;dojo.html;3386.5936087669475;3387.102417859268;3415.7438192135596;3420.811855347955;3461.5326930864326;5764.394738552454;5781.566382521307;5813;5859;5863.091220860768;5755.913661295084;5781.595288329819;5831.562632802546;5871.735771890265;5877.735501902414;5259.9474005259935;5281.70950597717;5323.201519772027;5332.3601167859915;5361.276227709248;4716.551927566876;5070.467600901908;5194.454582268864;5374.328208973879;5393.1101368274185;5229.241759944805;5242.685438873661;5278.47215278473;5287.550558202557;5297.973510132463;4539.84110556129;5015.473375295578;5274.05067087924;5329.973350133225;5385.946140538623;5261.184516399964;5273.393559740641;5315.521603055705;5331.253624492535;5377.327834020747;5663.688497132656;5686.829395118153;5709.286339207599;5716.571257155689;5744.569157313176;6160.8767824643255;6192.504599632019;6212.502999760053;6215.316315205324;6215.937840621581;6202.782902598387;6249.843753906189;6255.311915689271;6258.311585725566;6265.216847894013;5738.397468265855;5795.797147099831;5851.005329094064;5887.234659494324;5930.406959304079;6333.873322533524;6338.58799178052;6342.651154186564;6351.714172862232;6353.872922541524;6219.564630475914;6225.6264624121795;6231.9688401557705;6236.875262494725;6243.96878015607;6143.32423433422;6158.322584515699;6200.162977998003;6240.875182496325;6244.562880598314;6206.751729930752;6227.221597300338;6237.594556353823;6262.780802671885;6273;6162.661053642003;6201;6211.9689401552705;6233.906491402633;6234.314225435199;4923.483034281349;4968.90062198754;5035.244713293036;5035.546800787946;5052.671576347526;4442.955570444319;4491.618212451913;4497.910041799211;4504.076664283814;4555.544445555418;5935.673537955454;5945.346011938684;5951.3751056139345;5970.552208584373;5976.342602313742;6217.067439884054;6226.128342032119;6227.719752611143;6237.625742455467;6241.18864547615;5737.053386191315;5769.942300577024;5807.82576522705;5919.644821310735;5919.911201331984;5430.484104010113;5462.2079798429;5521.69630670317;5524;5530.972345138249;6463.870722585616;6472.352764723679;6479;6480.675966201671;6494.058361537551;6166.383361663798;6174.598651087665;6193.411625895533;6204.751809927552;6227.906581401373;6275.246970363585;6367.235931688227;6391.265004524539;6400.039994000937;6485.77299794505;6206.565540412128;6230.59501132425;6232.844178895564;6235.906461402992;6238.438540531374;6174.8147555573405;6188.566800323934;6216.689165541795;6244.313125556276;6260.029695397221;4894.412670479565;6069.089636554552;6120.050983828623;6131.264248290234;6135.477655820289;6190.50475961931;6210.627362358273;6218.098375735402;6219.813405597839;6233.812985610439;6087.817365479043;6097.847553811191;6106.69466526663;6110.052941794029;6126;6041.395860413923;6116.761878222105;6119.877602448015;6131.570790044832;6145.784897528744;6066.605670631395;6068.969655151696;6077.665728384981;6083.6045657032155;6125.969370153299 07:19:52 INFO - PROCESS | 1659 | |1;ext.html;471.91269615121206;492.1805194351405;521.8825764203054;525.7555236814883;532.5632980955615;29895;40166.799166004166;41664.58335416645;41710.791446042764;41956.58043419565;40634.79682601583;42422.57577424225;42754.93112672185;42810.785946070224;42824;9917.652882149127;10067.697969060904;10106.494675266244;10122.240831937597;10140.847887281696;8132.146124656914;8806.603702833356;8833.73498795034;9185.586648600796;9201.17189452949;12066.396680166;12349.753004939896;12365.69085772854;12503;12563;12269.325187114706;12336.88967992876;12341.197822141532;12351.38243087842;12360.567380141696;8857.291416686714;9125.45247285165;12164;12227.572034978733;12249.081318901119;39535.40696889549;40187;40415.39376909348;42440.15119697589;42577.93555161115;3403.3363494118657;3414.214730611948;3957.228340473609;3972.344563147077;3977.105151340925;30136.397272054655;30238.54642180369;31486;31744.36511269762;32443.18892027718;3211.5831496156725;3231.3052693670975;3286.342731453695;3298.818564978925;3365.9158521036925;523373;526882;527206;527797.3610131925;531732;48936.510634893195;50177.24734128991;56019;56848.715756420956;57449;53868.730656346466;60786.088208676905;60903;60944.695276523336;60990.69504652448;16192.514224573282;16267.18664066792;16277.267522961494;16280.75578866318;16312.51062468128;12644.114911956258;12719.491220351267;12771.744565108645;12950.02874784395;12974.221546707227;11457.541698331974;13861.653458663412;15126.773098403533;15320.616984575252;15401.46094886696;5889.646621202742;6020.909686354708;7075.610841403773;7206.423486121203;7217.675204615805;844.4890841041082;915.8946721127022;953.3040880157386;998.6554638649654;999.980000399988;22503.66244506334;29017.274568135545;29586.556201656993;30132;30752.69247307543;992.7369247149511;1031.664708969588;1031.6698656429871;1034.1209971524145;1039.594558122333;13023.609291721263;15537.067775933254;15597.986130901456;15615.531534053996;15921.283542240628;565574;651365.4863451305;658069;658821;659563;49197.01605967861;50088.24867626988;50141.74929125331;56670.14994775082;58063.70968145132;1383.3014327764415;1404.4241860837212;1420.020186071628;1431.541906589902;1432.8137342145455;28777.56833647455;29962.850185748932;30854.53718194184;31460.966245400625;31770.36459270848;49643.50356496534;49802.501974981235;50091.74954125206;50313;50360.244596330354;653438.7328063329;657502;669123;848717;848975;25086.99652013899;25220.62169067429;25419.237422877344;25630.487390252463;25640.102596409037;45558.772206138754;45881;45910;45951.54048459473;46358;37299.81350093232;38203.80898095492;38224.808875955445;38292.61707382891;38343;37396.62603373932;37889.81055094707;38128.61871381251;39210.215795683354;39242.80378598089;36721.81639091788;36950;37539.81230093941;37614.24771504609;37670.81164594269;31079.689203108584;33218;33304.00087997364;33338.83314083995;33378.998630040165;24969;25333.493330132926;25436.745632543436;25964.480710386066;26593.601095983187 07:19:52 INFO - PROCESS | 1659 | |2;jquery.html;351.97360197985125;374.2477619983832;377.2153919846717;384.86144987804397;409.63133180137874;14889.478868239614;15003.774943375844;16946.74579881301;20298.18807247712;21069.157233710634;19840.503987400323;20357.287494937682;20603;20792.792072079275;20842.791572084276;4146.585341465844;5389.78440862365;5606.439356064402;5614.9438505615035;5617.213590097369;3942.5071866016747;4158.12679337338;5480.725963701819;5510.311211098613;5568.52667523259;4065.796710164495;5890.499307558841;6165.815025549218;6181.59819611726;6241.188645476104;5934.643921364689;6136.631802091844;6173.59871608344;6211.0372892201785;6245.594036387621;6032.4570788629235;6032.638041717467;6036.577439579231;6046.304674962347;6047.848803779897;19885.602287954305;20756.58486830255;24401.26796196117;24511.264662060166;25444.872775636188;2065.700473431344;2145.6589631480324;2284.0084695754913;2342.1685301717816;2940.323725543116;8377.916220837775;10319.89680103197;10320.38077715332;10436.217283703676;10598.947005265001;1816.6911625023777;1857.349927525369;1867.1131212673872;1907.7424547686023;1909.2744756992392;132093.3395333017;135289.3235533816;137754.31122844422;138130.3093484526;139977.60022399746;10288.662473878348;10858.457077146111;11377.544898204145;11596.478158482889;11665.88334116648;14940.925295373454;14971;14993.850061499463;15020.948533602543;15039.624009399853;7534.945107684928;7938.483998540077;7963.8805417918775;8582.055973842873;8606.741797746077;7239;8768.473891566526;8947;9006.414583052081;9019.143181397756;3880.3791393376923;4543.204939135704;4602.539746025371;4627.814887404466;4632.2356811126465;1463.370750577262;1535.485612319863;1727.0328615975095;1907.1131923655566;1910.2072639854305;746.7237122264797;776.239285500213;845.564534264854;931.1526510875071;951.5480146930291;20264.392068237976;21698.891505542688;21734.891325543587;21848.672269915965;21863.453413664785;413.66493140556247;416.1552049339845;429.5125033087406;441.8210624697003;800;4892.706437613754;5817;5883.823485295448;5932.614380065282;6138.539609529304;493411;566419;622623;640644;645307;139597;140816;144492;145545;147271;423.36706623597917;440.1922472263432;454.07368967306985;454.3752340531769;454.7703409778041;10361.792764144826;11279.605213817476;11298.49156787963;11460.369679667698;11684.649460515859;50664.49335506598;51746.33991718959;52911;53818.116365927;55923.16115258193;80244.59877700574;81280.59359703163;82290.76563851428;83081;84130;7487.3261406473675;8204.138565450781;8240.052393974769;8289.253967142746;8424.873626895478;9873.308868379145;10474;12183.329916854304;12320.075994300285;12558.937205313914;9993.700188994342;10541.420221887563;11498.54005839757;11639.47622356979;11728.179027467995;9063.773405664648;10734.14126869833;10799.730006749895;10853;11476.770464590829;11071.058959988492;11277.7744445109;11300;11389.658310250707;11717.941410292893;7316.829307310804;7888.3689304856625;7891.289783919475;8199.95900020496;8424.241818236389;10828.187885908746;10832.89680460968;11079.279846810254;11161.944190278997;11306.265092768943 07:19:52 INFO - PROCESS | 1659 | |3;mootools.html;1456.6212784675984;1530.013141523717;1723.3451288510364;1852.129499135406;1900.363378268281;8480.618372173252;9013.05362936892;9024.187823095928;9031.412958157714;9051.185393314609;7794.181610930856;8058.5970701464985;8512.872306915386;8736.825263494742;8752.387332886685;2036.7963203679662;2374.3114496795906;2374.465745207332;2379.3456799380224;2382.273406610983;2033.176563491788;2262.230841513885;2367.550165468564;2412.216029790325;2414.7343792182846;2380.7143142822797;2396.8561886286793;2405.518896220754;2409.4578719788083;2411.577973854577;2363.7518060603734;2380.238323736405;2386.2721869829693;2391.1511413448147;2401;2360.079568968104;2386.5107652931106;2388.617821148608;2391.7249516305674;2393.054743376357;8873.822523549557;8904.421212621224;8949.06034866336;9015.684451044248;9020.548972551413;5190.870228244286;5355.928814237129;5360.517553420172;5372.274742909735;5372.409035006146;3091.041777049122;3414.760966732305;3519.1729943463265;3560.9109772255642;3595.982020089883;1052.300220353464;1055.8099542082423;1062.7927554126948;1066.7599790047254;1078.6063086973197;11838.881611183864;11962.222455540363;11985.700357491045;12011.699707507294;12030.69923251917;4568.6116680081905;4641.443026836801;4815.927761083586;4819.734914579732;4835;8338.416310858303;8511.74464766058;9999.000099989942;10027.799444011225;10070.144037756872;5323.494268044529;5323.6273460857365;5324.361076670824;5324.92012619811;5328.626996110235;3871.670907972854;4303.591158839905;4476.35092911526;4819.903601927942;4851.757412129379;3894.4547763313158;3909.92180156401;4007.6393124618926;4016.9397459038137;4031.637152656275;1257.2330878164312;1267.765463389276;1268.0679700420185;1287.22766340197;1289.432649634158;826.8300354997612;858.4849090545747;919.6321471411355;924.7919218175991;972.0619602084023;5759.539236861041;5899.233099697098;5919.319278283053;6175.84560385994;6206.875862482725;441.7791104447776;455.92705167173756;457.858064000161;459.0428955627554;459.64607252415453;3932.508436445444;3958.485396898385;3971.920561588752;4038.071243613985;4065.7435123506148;10367.688969330931;10533.104686101615;10890.455477226107;10916.345019298868;10919.290246133976;10745.78508429827;10900.836487452694;10904.78190436187;10907.618233361794;10919.617813376493;8184.304334131546;8292.543910084883;8325.459789938881;8413.453125546943;8417.116202798741;5618.101103823368;5911.674857882857;5917.881642367042;5986.880262394815;5997.970010149921;9915.553800079158;10185.592576297162;10278.023587759151;10280.07479326864;10283.640072597722;8925.285977121945;9780.430142997897;10221.182305415401;10403.531841067019;10473.109785668303;6911.550749201286;7129.287071293037;7142.928570714226;7547.924520754722;7658.6170691464085;7889.842203156019;7976.601169941596;7993;8218.137095605114;8451.408401411842;7300.342969132804;7521.360684341674;7534.246575342422;7645.732399365996;7647.388208943383;7327.560346379234;7341.522801017917;7392.4825262231125;7404.703811847466;7471.589062601609;7004.964975175091;7131.037309963089;7140.714371425085;7140.7143714252925;7142.892856607259;4985.52637499437;5065.265536497113;5074.06129865976;5118.744062796771;5180.9740951295;5054.3176671150395;5060.721660308718;5156.767945442389;5176.1200595898035;5221.973890130525 07:19:52 INFO - PROCESS | 1659 | |4;prototype.html;282.7766064808801;305.2886773817008;313.0889112682094;316.10699773140885;319.7250364686371;4886.853394398165;5200.257913598939;5330.653507522014;5445.591580631459;5484.588655850807;4691.812327506896;5160.56135228506;5245.659032162916;5337.866553336168;5416.756245968931;4140.855070072548;4156.792160391983;4171.89444797129;4172.457580514529;4177.248095342837;3514.9297014059703;3852.8266228019666;4084.1627466369323;4195.307774217251;4198.97900510497;3578.177019285566;3902.556054259928;4061.4110953911663;4086.366613174963;4088.608164223918;4059.391091336294;4082.632563069338;4099.344104943225;4102.548719640867;4107.753534787922;3176.888808891678;3345.5149003394613;3538.876139335111;3538.9211386094007;3550.55618047744;4954.479779623124;5286.867828304285;5288.038698328948;5301.946980530184;5309.65487243328;4689.460712018094;4691.906161876744;4699.389079419688;4702.60167314672;4717.811287548494;4803.879903002453;5039.823606173803;5122.410922743895;5180.186934572907;5777.537796976232;3763.0404246917133;3803.668912605119;3815.5802861685193;3869.2261547690573;3907.960920390788;5989.730462129215;6001.509373609991;6045.939540604581;6047.334793172748;6072.05883088122;3382.3911695894485;3820.968338548632;3933.6853051755793;3958.5051868516434;3971.185906889081;3735.869244576427;3970.5830887756947;3994.7403418777685;4027.7986100694848;4042.4542686737504;4639.605633521121;4648.093621743795;4654.4414670239785;4655.604273636779;4660.254359302496;4824.589909857631;4854.466008739107;5757.913631295534;5766.279215098113;5773.769049238067;1280.3342262023696;1288.7229245712217;1295.7978277788466;1332.4004198110888;1338.6519504928788;704.7744721689113;786.9409794265453;828.5815663090101;835.1106072033265;835.7910522369408;3922.0783115967724;4180.665546756313;4548.795304211252;4576.794044268016;4582.977085114553;4358.76026818528;4421.491528474202;4661.790219440133;4931.506849315111;4959.380077490314;3759.9248015039548;3954.689388566419;4529.932051019237;4547.613452856478;4552.905663394809;2268.7844654757773;2516.9496610067695;2563.6923569171445;2564.5176322850643;2571.7428257174133;4515.590728999584;4545.272796337371;4641.210994130938;4772.737499437495;5144.742762861842;4563.475200352002;4829.44461386945;5066.544011039025;5108.489151084862;5160.612954028388;4619.5611416915335;4627.375304333939;4926.226558438959;5077.31456253401;5098.532997561693;5610.298712660918;5923.519120219945;5959.8544523972205;5998.820035398945;6009.9699501503965;5356.812511562077;5815.447532484407;5861.9413805863105;5893.557983151367;5902.586818922806;5817.738201780845;6186.938130618636;6201.472874805692;6228.532860035606;6259.123722678738;3951.881443556698;3956.327424337927;3964.7819369933777;3967.3850553164307;4021.7586944783407;4601.631869450503;5730.596003979052;6049.425304596057;6073.817785466443;6082.574219804571;4950.554450099508;5093.4651861554;5203.505666961632;5362.731863406892;5476.014317422902;5741.224934633771;5764.538836893123;5794.246747922743;5808.128780682931;5822.563307752021;4992.550670439678;5205.687658740488;5368.9463105370005;5667.40492248308;5667.886642267049;5215.6609820361555;5685.578605348663;5725.2843394575675;5775.451332123442;5801.912971305349;5637.562421582635;5644.266245388073;5653.349864765604;5702.771889124555;5705.372409035086 07:19:52 INFO - PROCESS | 1659 | |5;yui.html;595.2470125291505;725.8403151306713;757.4508481351018;773.9032620922385;796.2276591706045;14876.702465950688;16046.43837465689;16162.595935101614;16218.189090545484;16269.511914642564;12348.506059757621;12634.936825315883;14541.909356798229;14749.262536873168;14769.261536923164;672.5897202706345;693.535331328009;694.3473135252872;828.5732847583484;830.5224495914842;702.9472789540805;840.4789030800881;855.995720021399;856.9742907712779;859.2653281444369;910.4628269321099;911.2345629671075;912.5118061836919;915;915.6062892956027;699.4614147106699;721.2571051816637;905.4567259644226;907.6006557114848;908.42315129893;539.1535289595337;540.3893600231752;540.7620646915344;646.0857886091176;663.4625952978055;15039.548813535612;15059.623509412242;15071.321790519452;15083.622909427242;15094.698106037928;13817.861821381859;14191.290435478288;14196.645083872883;14224.786628200585;14438.783418248735;12587.118901676886;12694.860819052328;13087.541936032289;13207.339633018311;13679.863201367958;4434.600885920283;4447.73313601185;4635.2120139576355;4669.322948172496;4677.812887484497;117894;119731;120160.39919800345;121148;122380;10782.56869725218;11121;11224.94387528057;11286.492107855167;11323.207375483802;22068.11727530913;22082.44793880166;22256.332310030724;22335;22756.43108922257;7856.646450909609;7881.802954926058;7951.920480795234;7973.960130199428;7996.280334769898;4179.226843034048;4221.2190744712325;4278.837760319242;4412.84555040572;4415.955840441555;3520.2431477232008;3623.5108260385036;3634.909127271839;3638.326909521747;3653.634636536325;635.4662083849496;648.2674577727138;650.5056157320375;653.4870126950416;661.4939571228015;543.6330476928058;563.1974436428155;626.2891618013497;634.014108061968;639.5906619763263;8659.956700216584;8772.956135219283;9145.451272923647;9233.953830230941;9287.349885507949;525.9076629419068;591.3111225422335;596.9106380854957;611.6207951070276;626.8056902360283;4282.186384586918;4475.060237350193;4483.596476317147;4553.567411095941;4578.557754307449;158089.20955395378;162302.56546151818;163198;165614;168320;125120;128391.35804320918;131923;132231;133053;96355.51822240844;115845.84154158519;121794;121863.39068304602;123103.3844830788;9416.764580885532;9710.902890971;10185.74535636615;10199.949000255248;10203.94898025505;44362.334564980905;47378.81552961204;58920.705396472746;59705.104423432815;61777.691111544154;70052.64973675099;93427.53286233525;96353.554696681;97122;98937;12353.135280530636;12459.377031148226;12972;13263.86736132665;13346.933265333611;14101.717965640835;14507.92746036263;15009.774853377427;15633.374665013273;15683.215839207765;13325.842808350324;13402;13888.236147011607;13933.372998214902;14247.715045699235;9896.010398960047;13205.735885282433;13324.933375333061;13373.264470454218;14060.296985150906;13055.281959492318;13704.65738356549;13874;13971.650708732363;14049.22729249901;10622.8406573903;11447.542098316308;11464.713382165513;11543.134264929995;11694.88305116938;9655;11233.887661123284;11616.593419230625;11731.354775487089;11766.882331176921 07:19:52 INFO - PROCESS | 1659 | __end_tp_report 07:19:52 INFO - PROCESS | 1659 | __start_cc_report 07:19:52 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,1515 07:19:52 INFO - PROCESS | 1659 | __end_cc_report 07:19:52 INFO - PROCESS | 1659 | __startTimestamp1475331592435__endTimestamp 07:19:52 INFO - PROCESS | 1659 | 07:19:52 INFO - PROCESS | 1659 | ------- Summary: start ------- 07:19:52 INFO - PROCESS | 1659 | Number of tests: 6 07:19:52 INFO - PROCESS | 1659 | 07:19:52 INFO - PROCESS | 1659 | [#0] dojo.html Cycles:165 Average:5797.48 Median:6087.82 stddev:642.81 (10.6%) stddev-sans-first:616.33 07:19:52 INFO - PROCESS | 1659 | Values: 3386.6 3387.1 3415.7 3420.8 3461.5 5764.4 5781.6 5813.0 5859.0 5863.1 5755.9 5781.6 5831.6 5871.7 5877.7 5259.9 5281.7 5323.2 5332.4 5361.3 4716.6 5070.5 5194.5 5374.3 5393.1 5229.2 5242.7 5278.5 5287.6 5298.0 4539.8 5015.5 5274.1 5330.0 5385.9 5261.2 5273.4 5315.5 5331.3 5377.3 5663.7 5686.8 5709.3 5716.6 5744.6 6160.9 6192.5 6212.5 6215.3 6215.9 6202.8 6249.8 6255.3 6258.3 6265.2 5738.4 5795.8 5851.0 5887.2 5930.4 6333.9 6338.6 6342.7 6351.7 6353.9 6219.6 6225.6 6232.0 6236.9 6244.0 6143.3 6158.3 6200.2 6240.9 6244.6 6206.8 6227.2 6237.6 6262.8 6273.0 6162.7 6201.0 6212.0 6233.9 6234.3 4923.5 4968.9 5035.2 5035.5 5052.7 4443.0 4491.6 4497.9 4504.1 4555.5 5935.7 5945.3 5951.4 5970.6 5976.3 6217.1 6226.1 6227.7 6237.6 6241.2 5737.1 5769.9 5807.8 5919.6 5919.9 5430.5 5462.2 5521.7 5524.0 5531.0 6463.9 6472.4 6479.0 6480.7 6494.1 6166.4 6174.6 6193.4 6204.8 6227.9 6275.2 6367.2 6391.3 6400.0 6485.8 6206.6 6230.6 6232.8 6235.9 6238.4 6174.8 6188.6 6216.7 6244.3 6260.0 4894.4 6069.1 6120.1 6131.3 6135.5 6190.5 6210.6 6218.1 6219.8 6233.8 6087.8 6097.8 6106.7 6110.1 6126.0 6041.4 6116.8 6119.9 6131.6 6145.8 6066.6 6069.0 6077.7 6083.6 6126.0 07:19:52 INFO - PROCESS | 1659 | 07:19:52 INFO - PROCESS | 1659 | [#1] ext.html Cycles:180 Average:75128.81 Median:37780.31 stddev:172373.31 (456.3%) stddev-sans-first:172765.72 07:19:52 INFO - PROCESS | 1659 | Values: 471.9 492.2 521.9 525.8 532.6 29895.0 40166.8 41664.6 41710.8 41956.6 40634.8 42422.6 42754.9 42810.8 42824.0 9917.7 10067.7 10106.5 10122.2 10140.8 8132.1 8806.6 8833.7 9185.6 9201.2 12066.4 12349.8 12365.7 12503.0 12563.0 12269.3 12336.9 12341.2 12351.4 12360.6 8857.3 9125.5 12164.0 12227.6 12249.1 39535.4 40187.0 40415.4 42440.2 42577.9 3403.3 3414.2 3957.2 3972.3 3977.1 30136.4 30238.5 31486.0 31744.4 32443.2 3211.6 3231.3 3286.3 3298.8 3365.9 523373.0 526882.0 527206.0 527797.4 531732.0 48936.5 50177.2 56019.0 56848.7 57449.0 53868.7 60786.1 60903.0 60944.7 60990.7 16192.5 16267.2 16277.3 16280.8 16312.5 12644.1 12719.5 12771.7 12950.0 12974.2 11457.5 13861.7 15126.8 15320.6 15401.5 5889.6 6020.9 7075.6 7206.4 7217.7 844.5 915.9 953.3 998.7 1000.0 22503.7 29017.3 29586.6 30132.0 30752.7 992.7 1031.7 1031.7 1034.1 1039.6 13023.6 15537.1 15598.0 15615.5 15921.3 565574.0 651365.5 658069.0 658821.0 659563.0 49197.0 50088.2 50141.7 56670.1 58063.7 1383.3 1404.4 1420.0 1431.5 1432.8 28777.6 29962.9 30854.5 31461.0 31770.4 49643.5 49802.5 50091.7 50313.0 50360.2 653438.7 657502.0 669123.0 848717.0 848975.0 25087.0 25220.6 25419.2 25630.5 25640.1 45558.8 45881.0 45910.0 45951.5 46358.0 37299.8 38203.8 38224.8 38292.6 38343.0 37396.6 37889.8 38128.6 39210.2 39242.8 36721.8 36950.0 37539.8 37614.2 37670.8 31079.7 33218.0 33304.0 33338.8 33379.0 24969.0 25333.5 25436.7 25964.5 26593.6 07:19:52 INFO - PROCESS | 1659 | 07:19:52 INFO - PROCESS | 1659 | [#2] jquery.html Cycles:180 Average:35383.70 Median:3911.44 stddev:100693.06 (2574.3%) stddev-sans-first:100941.18 07:19:52 INFO - PROCESS | 1659 | Values: 352.0 374.2 377.2 384.9 409.6 14889.5 15003.8 16946.7 20298.2 21069.2 19840.5 20357.3 20603.0 20792.8 20842.8 4146.6 5389.8 5606.4 5614.9 5617.2 3942.5 4158.1 5480.7 5510.3 5568.5 4065.8 5890.5 6165.8 6181.6 6241.2 5934.6 6136.6 6173.6 6211.0 6245.6 6032.5 6032.6 6036.6 6046.3 6047.8 19885.6 20756.6 24401.3 24511.3 25444.9 2065.7 2145.7 2284.0 2342.2 2940.3 8377.9 10319.9 10320.4 10436.2 10598.9 1816.7 1857.3 1867.1 1907.7 1909.3 132093.3 135289.3 137754.3 138130.3 139977.6 10288.7 10858.5 11377.5 11596.5 11665.9 14940.9 14971.0 14993.9 15020.9 15039.6 7534.9 7938.5 7963.9 8582.1 8606.7 7239.0 8768.5 8947.0 9006.4 9019.1 3880.4 4543.2 4602.5 4627.8 4632.2 1463.4 1535.5 1727.0 1907.1 1910.2 746.7 776.2 845.6 931.2 951.5 20264.4 21698.9 21734.9 21848.7 21863.5 413.7 416.2 429.5 441.8 800.0 4892.7 5817.0 5883.8 5932.6 6138.5 493411.0 566419.0 622623.0 640644.0 645307.0 139597.0 140816.0 144492.0 145545.0 147271.0 423.4 440.2 454.1 454.4 454.8 10361.8 11279.6 11298.5 11460.4 11684.6 50664.5 51746.3 52911.0 53818.1 55923.2 80244.6 81280.6 82290.8 83081.0 84130.0 7487.3 8204.1 8240.1 8289.3 8424.9 9873.3 10474.0 12183.3 12320.1 12558.9 9993.7 10541.4 11498.5 11639.5 11728.2 9063.8 10734.1 10799.7 10853.0 11476.8 11071.1 11277.8 11300.0 11389.7 11717.9 7316.8 7888.4 7891.3 8200.0 8424.2 10828.2 10832.9 11079.3 11161.9 11306.3 07:19:52 INFO - PROCESS | 1659 | 07:19:52 INFO - PROCESS | 1659 | [#3] mootools.html Cycles:180 Average:5711.29 Median:4819.82 stddev:3234.64 (67.1%) stddev-sans-first:3227.91 07:19:52 INFO - PROCESS | 1659 | Values: 1456.6 1530.0 1723.3 1852.1 1900.4 8480.6 9013.1 9024.2 9031.4 9051.2 7794.2 8058.6 8512.9 8736.8 8752.4 2036.8 2374.3 2374.5 2379.3 2382.3 2033.2 2262.2 2367.6 2412.2 2414.7 2380.7 2396.9 2405.5 2409.5 2411.6 2363.8 2380.2 2386.3 2391.2 2401.0 2360.1 2386.5 2388.6 2391.7 2393.1 8873.8 8904.4 8949.1 9015.7 9020.5 5190.9 5355.9 5360.5 5372.3 5372.4 3091.0 3414.8 3519.2 3560.9 3596.0 1052.3 1055.8 1062.8 1066.8 1078.6 11838.9 11962.2 11985.7 12011.7 12030.7 4568.6 4641.4 4815.9 4819.7 4835.0 8338.4 8511.7 9999.0 10027.8 10070.1 5323.5 5323.6 5324.4 5324.9 5328.6 3871.7 4303.6 4476.4 4819.9 4851.8 3894.5 3909.9 4007.6 4016.9 4031.6 1257.2 1267.8 1268.1 1287.2 1289.4 826.8 858.5 919.6 924.8 972.1 5759.5 5899.2 5919.3 6175.8 6206.9 441.8 455.9 457.9 459.0 459.6 3932.5 3958.5 3971.9 4038.1 4065.7 10367.7 10533.1 10890.5 10916.3 10919.3 10745.8 10900.8 10904.8 10907.6 10919.6 8184.3 8292.5 8325.5 8413.5 8417.1 5618.1 5911.7 5917.9 5986.9 5998.0 9915.6 10185.6 10278.0 10280.1 10283.6 8925.3 9780.4 10221.2 10403.5 10473.1 6911.6 7129.3 7142.9 7547.9 7658.6 7889.8 7976.6 7993.0 8218.1 8451.4 7300.3 7521.4 7534.2 7645.7 7647.4 7327.6 7341.5 7392.5 7404.7 7471.6 7005.0 7131.0 7140.7 7140.7 7142.9 4985.5 5065.3 5074.1 5118.7 5181.0 5054.3 5060.7 5156.8 5176.1 5222.0 07:19:52 INFO - PROCESS | 1659 | 07:19:52 INFO - PROCESS | 1659 | [#4] prototype.html Cycles:180 Average:4465.39 Median:4745.27 stddev:1394.56 (29.4%) stddev-sans-first:1362.68 07:19:52 INFO - PROCESS | 1659 | Values: 282.8 305.3 313.1 316.1 319.7 4886.9 5200.3 5330.7 5445.6 5484.6 4691.8 5160.6 5245.7 5337.9 5416.8 4140.9 4156.8 4171.9 4172.5 4177.2 3514.9 3852.8 4084.2 4195.3 4199.0 3578.2 3902.6 4061.4 4086.4 4088.6 4059.4 4082.6 4099.3 4102.5 4107.8 3176.9 3345.5 3538.9 3538.9 3550.6 4954.5 5286.9 5288.0 5301.9 5309.7 4689.5 4691.9 4699.4 4702.6 4717.8 4803.9 5039.8 5122.4 5180.2 5777.5 3763.0 3803.7 3815.6 3869.2 3908.0 5989.7 6001.5 6045.9 6047.3 6072.1 3382.4 3821.0 3933.7 3958.5 3971.2 3735.9 3970.6 3994.7 4027.8 4042.5 4639.6 4648.1 4654.4 4655.6 4660.3 4824.6 4854.5 5757.9 5766.3 5773.8 1280.3 1288.7 1295.8 1332.4 1338.7 704.8 786.9 828.6 835.1 835.8 3922.1 4180.7 4548.8 4576.8 4583.0 4358.8 4421.5 4661.8 4931.5 4959.4 3759.9 3954.7 4529.9 4547.6 4552.9 2268.8 2516.9 2563.7 2564.5 2571.7 4515.6 4545.3 4641.2 4772.7 5144.7 4563.5 4829.4 5066.5 5108.5 5160.6 4619.6 4627.4 4926.2 5077.3 5098.5 5610.3 5923.5 5959.9 5998.8 6010.0 5356.8 5815.4 5861.9 5893.6 5902.6 5817.7 6186.9 6201.5 6228.5 6259.1 3951.9 3956.3 3964.8 3967.4 4021.8 4601.6 5730.6 6049.4 6073.8 6082.6 4950.6 5093.5 5203.5 5362.7 5476.0 5741.2 5764.5 5794.2 5808.1 5822.6 4992.6 5205.7 5368.9 5667.4 5667.9 5215.7 5685.6 5725.3 5775.5 5801.9 5637.6 5644.3 5653.3 5702.8 5705.4 07:19:52 INFO - PROCESS | 1659 | 07:19:52 INFO - PROCESS | 1659 | [#5] yui.html Cycles:180 Average:25605.15 Median:3571.88 stddev:41843.19 (1171.5%) stddev-sans-first:41918.44 07:19:52 INFO - PROCESS | 1659 | Values: 595.2 725.8 757.5 773.9 796.2 14876.7 16046.4 16162.6 16218.2 16269.5 12348.5 12634.9 14541.9 14749.3 14769.3 672.6 693.5 694.3 828.6 830.5 702.9 840.5 856.0 857.0 859.3 910.5 911.2 912.5 915.0 915.6 699.5 721.3 905.5 907.6 908.4 539.2 540.4 540.8 646.1 663.5 15039.5 15059.6 15071.3 15083.6 15094.7 13817.9 14191.3 14196.6 14224.8 14438.8 12587.1 12694.9 13087.5 13207.3 13679.9 4434.6 4447.7 4635.2 4669.3 4677.8 117894.0 119731.0 120160.4 121148.0 122380.0 10782.6 11121.0 11224.9 11286.5 11323.2 22068.1 22082.4 22256.3 22335.0 22756.4 7856.6 7881.8 7951.9 7974.0 7996.3 4179.2 4221.2 4278.8 4412.8 4416.0 3520.2 3623.5 3634.9 3638.3 3653.6 635.5 648.3 650.5 653.5 661.5 543.6 563.2 626.3 634.0 639.6 8660.0 8773.0 9145.5 9234.0 9287.3 525.9 591.3 596.9 611.6 626.8 4282.2 4475.1 4483.6 4553.6 4578.6 158089.2 162302.6 163198.0 165614.0 168320.0 125120.0 128391.4 131923.0 132231.0 133053.0 96355.5 115845.8 121794.0 121863.4 123103.4 9416.8 9710.9 10185.7 10199.9 10203.9 44362.3 47378.8 58920.7 59705.1 61777.7 70052.6 93427.5 96353.6 97122.0 98937.0 12353.1 12459.4 12972.0 13263.9 13346.9 14101.7 14507.9 15009.8 15633.4 15683.2 13325.8 13402.0 13888.2 13933.4 14247.7 9896.0 13205.7 13324.9 13373.3 14060.3 13055.3 13704.7 13874.0 13971.7 14049.2 10622.8 11447.5 11464.7 11543.1 11694.9 9655.0 11233.9 11616.6 11731.4 11766.9 07:19:52 INFO - PROCESS | 1659 | -------- Summary: end -------- 07:19:52 INFO - PROCESS | 1659 | 07:19:53 INFO - TEST-INFO | 1659: exit 0 07:19:53 INFO - TEST-OK | dromaeo_css | took 1117582ms 07:19:53 INFO - TEST-START | kraken 07:19:53 INFO - operating with platform_type : mac_ 07:19:53 INFO - Initialising browser for kraken test... 07:19:53 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/tmp3qT5Rq/profile http://localhost:49272/getInfo.html) 07:19:55 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 07:19:55 INFO - PROCESS | 1665 | colorDepth:24 07:19:55 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 07:19:55 INFO - PROCESS | 1665 | __metrics 07:19:55 INFO - PROCESS | 1665 | 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" 07:19:55 INFO - PROCESS | 1665 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:19:56 INFO - TEST-INFO | 1665: exit 0 07:19:56 INFO - Browser initialized. 07:19:56 INFO - Running cycle 1/1 for kraken test... 07:19:56 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/00/7tdhxz016pgck4583ks_0xj800000w/T/tmp3qT5Rq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:20:08 INFO - PROCESS | 1666 | RSS: Main: 219525120 07:20:08 INFO - PROCESS | 1666 | 07:20:11 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 07:20:11 INFO - PROCESS | 1666 | RSS: Main: 269393920 07:20:11 INFO - PROCESS | 1666 | 07:20:14 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 07:20:15 INFO - PROCESS | 1666 | RSS: Main: 280551424 07:20:15 INFO - PROCESS | 1666 | 07:20:18 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 07:20:18 INFO - PROCESS | 1666 | RSS: Main: 378224640 07:20:18 INFO - PROCESS | 1666 | 07:20:20 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 07:20:21 INFO - PROCESS | 1666 | RSS: Main: 279482368 07:20:21 INFO - PROCESS | 1666 | 07:20:23 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:20:23 INFO - PROCESS | 1666 | RSS: Main: 280174592 07:20:23 INFO - PROCESS | 1666 | 07:20:26 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 07:20:27 INFO - PROCESS | 1666 | RSS: Main: 318173184 07:20:27 INFO - PROCESS | 1666 | 07:20:30 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 07:20:30 INFO - PROCESS | 1666 | RSS: Main: 319373312 07:20:30 INFO - PROCESS | 1666 | 07:20:33 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 07:20:34 INFO - PROCESS | 1666 | RSS: Main: 317861888 07:20:34 INFO - PROCESS | 1666 | 07:20:35 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:20:36 INFO - PROCESS | 1666 | RSS: Main: 290041856 07:20:36 INFO - PROCESS | 1666 | 07:20:38 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:20:38 INFO - PROCESS | 1666 | RSS: Main: 296030208 07:20:38 INFO - PROCESS | 1666 | 07:20:40 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:20:41 INFO - PROCESS | 1666 | RSS: Main: 299835392 07:20:41 INFO - PROCESS | 1666 | 07:20:44 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:20:45 INFO - PROCESS | 1666 | RSS: Main: 313540608 07:20:45 INFO - PROCESS | 1666 | 07:20:48 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:20:48 INFO - PROCESS | 1666 | RSS: Main: 309833728 07:20:48 INFO - PROCESS | 1666 | 07:20:50 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 07:20:50 INFO - PROCESS | 1666 | RSS: Main: 353009664 07:20:50 INFO - PROCESS | 1666 | 07:20:50 INFO - PROCESS | 1666 | __start_tp_report 07:20:50 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 07:20:50 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 07:20:50 INFO - PROCESS | 1666 | |i|pagename|runs| 07:20:50 INFO - PROCESS | 1666 | |0;ai-astar;115;115;114;112;113;114;113;113;114;113 07:20:50 INFO - PROCESS | 1666 | |1;audio-beat-detection;143;122;108;142;110;109;106;108;141;106 07:20:50 INFO - PROCESS | 1666 | |2;audio-dft;182;186;181;184;182;185;179;183;183;182 07:20:50 INFO - PROCESS | 1666 | |3;audio-fft;80;60;60;89;62;58;59;58;91;58 07:20:50 INFO - PROCESS | 1666 | |4;audio-oscillator;85;71;95;68;67;69;93;68;68;89 07:20:50 INFO - PROCESS | 1666 | |5;imaging-gaussian-blur;88;83;86;84;87;83;88;84;87;84 07:20:50 INFO - PROCESS | 1666 | |6;imaging-darkroom;100;95;95;95;94;95;95;95;94;95 07:20:50 INFO - PROCESS | 1666 | |7;imaging-desaturate;84;83;83;85;86;85;85;83;84;84 07:20:50 INFO - PROCESS | 1666 | |8;json-parse-financial;57;55;54;53;55;56;56;56;57;58 07:20:50 INFO - PROCESS | 1666 | |9;json-stringify-tinderbox;66;68;69;79;74;70;69;68;67;68 07:20:50 INFO - PROCESS | 1666 | |10;stanford-crypto-aes;81;92;92;100;84;81;82;84;90;89 07:20:50 INFO - PROCESS | 1666 | |11;stanford-crypto-ccm;164;146;147;140;136;135;139;142;184;127 07:20:50 INFO - PROCESS | 1666 | |12;stanford-crypto-pbkdf2;163;163;163;162;163;165;162;163;176;162 07:20:50 INFO - PROCESS | 1666 | |13;stanford-crypto-sha256-iterative;69;81;84;83;84;73;65;65;67;68 07:20:50 INFO - PROCESS | 1666 | __end_tp_report 07:20:50 INFO - PROCESS | 1666 | __start_cc_report 07:20:50 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,1973 07:20:50 INFO - PROCESS | 1666 | __end_cc_report 07:20:50 INFO - PROCESS | 1666 | __startTimestamp1475331650785__endTimestamp 07:20:50 INFO - PROCESS | 1666 | 07:20:50 INFO - PROCESS | 1666 | ------- Summary: start ------- 07:20:50 INFO - PROCESS | 1666 | Number of tests: 14 07:20:50 INFO - PROCESS | 1666 | 07:20:50 INFO - PROCESS | 1666 | [#0] ai-astar Cycles:10 Average:113.60 Median:114.00 stddev:0.97 (0.8%) stddev-sans-first:0.88 07:20:50 INFO - PROCESS | 1666 | Values: 115.0 115.0 114.0 112.0 113.0 114.0 113.0 113.0 114.0 113.0 07:20:50 INFO - PROCESS | 1666 | 07:20:50 INFO - PROCESS | 1666 | [#1] audio-beat-detection Cycles:10 Average:119.50 Median:116.00 stddev:16.18 (13.9%) stddev-sans-first:14.76 07:20:50 INFO - PROCESS | 1666 | Values: 143.0 122.0 108.0 142.0 110.0 109.0 106.0 108.0 141.0 106.0 07:20:50 INFO - PROCESS | 1666 | 07:20:50 INFO - PROCESS | 1666 | [#2] audio-dft Cycles:10 Average:182.70 Median:183.00 stddev:2.00 (1.1%) stddev-sans-first:2.11 07:20:50 INFO - PROCESS | 1666 | Values: 182.0 186.0 181.0 184.0 182.0 185.0 179.0 183.0 183.0 182.0 07:20:50 INFO - PROCESS | 1666 | 07:20:50 INFO - PROCESS | 1666 | [#3] audio-fft Cycles:10 Average:67.50 Median:61.00 stddev:13.57 (22.2%) stddev-sans-first:13.61 07:20:50 INFO - PROCESS | 1666 | Values: 80.0 60.0 60.0 89.0 62.0 58.0 59.0 58.0 91.0 58.0 07:20:50 INFO - PROCESS | 1666 | 07:20:50 INFO - PROCESS | 1666 | [#4] audio-oscillator Cycles:10 Average:77.30 Median:78.00 stddev:11.69 (15.0%) stddev-sans-first:12.06 07:20:50 INFO - PROCESS | 1666 | Values: 85.0 71.0 95.0 68.0 67.0 69.0 93.0 68.0 68.0 89.0 07:20:50 INFO - PROCESS | 1666 | 07:20:50 INFO - PROCESS | 1666 | [#5] imaging-gaussian-blur Cycles:10 Average:85.40 Median:86.50 stddev:2.01 (2.3%) stddev-sans-first:1.90 07:20:50 INFO - PROCESS | 1666 | Values: 88.0 83.0 86.0 84.0 87.0 83.0 88.0 84.0 87.0 84.0 07:20:50 INFO - PROCESS | 1666 | 07:20:50 INFO - PROCESS | 1666 | [#6] imaging-darkroom Cycles:10 Average:95.30 Median:95.00 stddev:1.70 (1.8%) stddev-sans-first:0.44 07:20:50 INFO - PROCESS | 1666 | Values: 100.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 94.0 95.0 07:20:50 INFO - PROCESS | 1666 | 07:20:50 INFO - PROCESS | 1666 | [#7] imaging-desaturate Cycles:10 Average:84.20 Median:84.50 stddev:1.03 (1.2%) stddev-sans-first:1.09 07:20:50 INFO - PROCESS | 1666 | Values: 84.0 83.0 83.0 85.0 86.0 85.0 85.0 83.0 84.0 84.0 07:20:50 INFO - PROCESS | 1666 | 07:20:50 INFO - PROCESS | 1666 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:56.00 stddev:1.49 (2.7%) stddev-sans-first:1.51 07:20:50 INFO - PROCESS | 1666 | Values: 57.0 55.0 54.0 53.0 55.0 56.0 56.0 56.0 57.0 58.0 07:20:50 INFO - PROCESS | 1666 | 07:20:50 INFO - PROCESS | 1666 | [#9] json-stringify-tinderbox Cycles:10 Average:69.80 Median:69.00 stddev:3.88 (5.6%) stddev-sans-first:3.87 07:20:50 INFO - PROCESS | 1666 | Values: 66.0 68.0 69.0 79.0 74.0 70.0 69.0 68.0 67.0 68.0 07:20:50 INFO - PROCESS | 1666 | 07:20:50 INFO - PROCESS | 1666 | [#10] stanford-crypto-aes Cycles:10 Average:87.50 Median:86.50 stddev:6.19 (7.2%) stddev-sans-first:6.10 07:20:50 INFO - PROCESS | 1666 | Values: 81.0 92.0 92.0 100.0 84.0 81.0 82.0 84.0 90.0 89.0 07:20:50 INFO - PROCESS | 1666 | 07:20:50 INFO - PROCESS | 1666 | [#11] stanford-crypto-ccm Cycles:10 Average:146.00 Median:144.00 stddev:16.51 (11.5%) stddev-sans-first:16.17 07:20:50 INFO - PROCESS | 1666 | Values: 164.0 146.0 147.0 140.0 136.0 135.0 139.0 142.0 184.0 127.0 07:20:50 INFO - PROCESS | 1666 | 07:20:50 INFO - PROCESS | 1666 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.20 Median:163.00 stddev:4.24 (2.6%) stddev-sans-first:4.47 07:20:50 INFO - PROCESS | 1666 | Values: 163.0 163.0 163.0 162.0 163.0 165.0 162.0 163.0 176.0 162.0 07:20:50 INFO - PROCESS | 1666 | 07:20:50 INFO - PROCESS | 1666 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.90 Median:77.00 stddev:8.18 (10.6%) stddev-sans-first:8.49 07:20:50 INFO - PROCESS | 1666 | Values: 69.0 81.0 84.0 83.0 84.0 73.0 65.0 65.0 67.0 68.0 07:20:50 INFO - PROCESS | 1666 | -------- Summary: end -------- 07:20:50 INFO - PROCESS | 1666 | 07:20:51 INFO - TEST-INFO | 1666: exit 0 07:20:51 INFO - TEST-OK | kraken | took 58557ms 07:20:51 INFO - SUITE-END | took 1176s 07:20:51 INFO - Completed test suite (00:19:36) 07:20:51 INFO - javascript benchmark 07:20:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3386.5936087669475, 3387.102417859268, 3415.7438192135596, 3420.811855347955, 3461.5326930864326, 5764.394738552454, 5781.566382521307, 5813.0, 5859.0, 5863.091220860768, 5755.913661295084, 5781.595288329819, 5831.562632802546, 5871.735771890265, 5877.735501902414, 5259.9474005259935, 5281.70950597717, 5323.201519772027, 5332.3601167859915, 5361.276227709248, 4716.551927566876, 5070.467600901908, 5194.454582268864, 5374.328208973879, 5393.1101368274185, 5229.241759944805, 5242.685438873661, 5278.47215278473, 5287.550558202557, 5297.973510132463, 4539.84110556129, 5015.473375295578, 5274.05067087924, 5329.973350133225, 5385.946140538623, 5261.184516399964, 5273.393559740641, 5315.521603055705, 5331.253624492535, 5377.327834020747, 5663.688497132656, 5686.829395118153, 5709.286339207599, 5716.571257155689, 5744.569157313176, 6160.8767824643255, 6192.504599632019, 6212.502999760053, 6215.316315205324, 6215.937840621581, 6202.782902598387, 6249.843753906189, 6255.311915689271, 6258.311585725566, 6265.216847894013, 5738.397468265855, 5795.797147099831, 5851.005329094064, 5887.234659494324, 5930.406959304079, 6333.873322533524, 6338.58799178052, 6342.651154186564, 6351.714172862232, 6353.872922541524, 6219.564630475914, 6225.6264624121795, 6231.9688401557705, 6236.875262494725, 6243.96878015607, 6143.32423433422, 6158.322584515699, 6200.162977998003, 6240.875182496325, 6244.562880598314, 6206.751729930752, 6227.221597300338, 6237.594556353823, 6262.780802671885, 6273.0, 6162.661053642003, 6201.0, 6211.9689401552705, 6233.906491402633, 6234.314225435199, 4923.483034281349, 4968.90062198754, 5035.244713293036, 5035.546800787946, 5052.671576347526, 4442.955570444319, 4491.618212451913, 4497.910041799211, 4504.076664283814, 4555.544445555418, 5935.673537955454, 5945.346011938684, 5951.3751056139345, 5970.552208584373, 5976.342602313742, 6217.067439884054, 6226.128342032119, 6227.719752611143, 6237.625742455467, 6241.18864547615, 5737.053386191315, 5769.942300577024, 5807.82576522705, 5919.644821310735, 5919.911201331984, 5430.484104010113, 5462.2079798429, 5521.69630670317, 5524.0, 5530.972345138249, 6463.870722585616, 6472.352764723679, 6479.0, 6480.675966201671, 6494.058361537551, 6166.383361663798, 6174.598651087665, 6193.411625895533, 6204.751809927552, 6227.906581401373, 6275.246970363585, 6367.235931688227, 6391.265004524539, 6400.039994000937, 6485.77299794505, 6206.565540412128, 6230.59501132425, 6232.844178895564, 6235.906461402992, 6238.438540531374, 6174.8147555573405, 6188.566800323934, 6216.689165541795, 6244.313125556276, 6260.029695397221, 4894.412670479565, 6069.089636554552, 6120.050983828623, 6131.264248290234, 6135.477655820289, 6190.50475961931, 6210.627362358273, 6218.098375735402, 6219.813405597839, 6233.812985610439, 6087.817365479043, 6097.847553811191, 6106.69466526663, 6110.052941794029, 6126.0, 6041.395860413923, 6116.761878222105, 6119.877602448015, 6131.570790044832, 6145.784897528744, 6066.605670631395, 6068.969655151696, 6077.665728384981, 6083.6045657032155, 6125.969370153299], "value": 5756.555783113162, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [471.91269615121206, 492.1805194351405, 521.8825764203054, 525.7555236814883, 532.5632980955615, 29895.0, 40166.799166004166, 41664.58335416645, 41710.791446042764, 41956.58043419565, 40634.79682601583, 42422.57577424225, 42754.93112672185, 42810.785946070224, 42824.0, 9917.652882149127, 10067.697969060904, 10106.494675266244, 10122.240831937597, 10140.847887281696, 8132.146124656914, 8806.603702833356, 8833.73498795034, 9185.586648600796, 9201.17189452949, 12066.396680166, 12349.753004939896, 12365.69085772854, 12503.0, 12563.0, 12269.325187114706, 12336.88967992876, 12341.197822141532, 12351.38243087842, 12360.567380141696, 8857.291416686714, 9125.45247285165, 12164.0, 12227.572034978733, 12249.081318901119, 39535.40696889549, 40187.0, 40415.39376909348, 42440.15119697589, 42577.93555161115, 3403.3363494118657, 3414.214730611948, 3957.228340473609, 3972.344563147077, 3977.105151340925, 30136.397272054655, 30238.54642180369, 31486.0, 31744.36511269762, 32443.18892027718, 3211.5831496156725, 3231.3052693670975, 3286.342731453695, 3298.818564978925, 3365.9158521036925, 523373.0, 526882.0, 527206.0, 527797.3610131925, 531732.0, 48936.510634893195, 50177.24734128991, 56019.0, 56848.715756420956, 57449.0, 53868.730656346466, 60786.088208676905, 60903.0, 60944.695276523336, 60990.69504652448, 16192.514224573282, 16267.18664066792, 16277.267522961494, 16280.75578866318, 16312.51062468128, 12644.114911956258, 12719.491220351267, 12771.744565108645, 12950.02874784395, 12974.221546707227, 11457.541698331974, 13861.653458663412, 15126.773098403533, 15320.616984575252, 15401.46094886696, 5889.646621202742, 6020.909686354708, 7075.610841403773, 7206.423486121203, 7217.675204615805, 844.4890841041082, 915.8946721127022, 953.3040880157386, 998.6554638649654, 999.980000399988, 22503.66244506334, 29017.274568135545, 29586.556201656993, 30132.0, 30752.69247307543, 992.7369247149511, 1031.664708969588, 1031.6698656429871, 1034.1209971524145, 1039.594558122333, 13023.609291721263, 15537.067775933254, 15597.986130901456, 15615.531534053996, 15921.283542240628, 565574.0, 651365.4863451305, 658069.0, 658821.0, 659563.0, 49197.01605967861, 50088.24867626988, 50141.74929125331, 56670.14994775082, 58063.70968145132, 1383.3014327764415, 1404.4241860837212, 1420.020186071628, 1431.541906589902, 1432.8137342145455, 28777.56833647455, 29962.850185748932, 30854.53718194184, 31460.966245400625, 31770.36459270848, 49643.50356496534, 49802.501974981235, 50091.74954125206, 50313.0, 50360.244596330354, 653438.7328063329, 657502.0, 669123.0, 848717.0, 848975.0, 25086.99652013899, 25220.62169067429, 25419.237422877344, 25630.487390252463, 25640.102596409037, 45558.772206138754, 45881.0, 45910.0, 45951.54048459473, 46358.0, 37299.81350093232, 38203.80898095492, 38224.808875955445, 38292.61707382891, 38343.0, 37396.62603373932, 37889.81055094707, 38128.61871381251, 39210.215795683354, 39242.80378598089, 36721.81639091788, 36950.0, 37539.81230093941, 37614.24771504609, 37670.81164594269, 31079.689203108584, 33218.0, 33304.00087997364, 33338.83314083995, 33378.998630040165, 24969.0, 25333.493330132926, 25436.745632543436, 25964.480710386066, 26593.601095983187], "value": 20077.5188315367, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.97360197985125, 374.2477619983832, 377.2153919846717, 384.86144987804397, 409.63133180137874, 14889.478868239614, 15003.774943375844, 16946.74579881301, 20298.18807247712, 21069.157233710634, 19840.503987400323, 20357.287494937682, 20603.0, 20792.792072079275, 20842.791572084276, 4146.585341465844, 5389.78440862365, 5606.439356064402, 5614.9438505615035, 5617.213590097369, 3942.5071866016747, 4158.12679337338, 5480.725963701819, 5510.311211098613, 5568.52667523259, 4065.796710164495, 5890.499307558841, 6165.815025549218, 6181.59819611726, 6241.188645476104, 5934.643921364689, 6136.631802091844, 6173.59871608344, 6211.0372892201785, 6245.594036387621, 6032.4570788629235, 6032.638041717467, 6036.577439579231, 6046.304674962347, 6047.848803779897, 19885.602287954305, 20756.58486830255, 24401.26796196117, 24511.264662060166, 25444.872775636188, 2065.700473431344, 2145.6589631480324, 2284.0084695754913, 2342.1685301717816, 2940.323725543116, 8377.916220837775, 10319.89680103197, 10320.38077715332, 10436.217283703676, 10598.947005265001, 1816.6911625023777, 1857.349927525369, 1867.1131212673872, 1907.7424547686023, 1909.2744756992392, 132093.3395333017, 135289.3235533816, 137754.31122844422, 138130.3093484526, 139977.60022399746, 10288.662473878348, 10858.457077146111, 11377.544898204145, 11596.478158482889, 11665.88334116648, 14940.925295373454, 14971.0, 14993.850061499463, 15020.948533602543, 15039.624009399853, 7534.945107684928, 7938.483998540077, 7963.8805417918775, 8582.055973842873, 8606.741797746077, 7239.0, 8768.473891566526, 8947.0, 9006.414583052081, 9019.143181397756, 3880.3791393376923, 4543.204939135704, 4602.539746025371, 4627.814887404466, 4632.2356811126465, 1463.370750577262, 1535.485612319863, 1727.0328615975095, 1907.1131923655566, 1910.2072639854305, 746.7237122264797, 776.239285500213, 845.564534264854, 931.1526510875071, 951.5480146930291, 20264.392068237976, 21698.891505542688, 21734.891325543587, 21848.672269915965, 21863.453413664785, 413.66493140556247, 416.1552049339845, 429.5125033087406, 441.8210624697003, 800.0, 4892.706437613754, 5817.0, 5883.823485295448, 5932.614380065282, 6138.539609529304, 493411.0, 566419.0, 622623.0, 640644.0, 645307.0, 139597.0, 140816.0, 144492.0, 145545.0, 147271.0, 423.36706623597917, 440.1922472263432, 454.07368967306985, 454.3752340531769, 454.7703409778041, 10361.792764144826, 11279.605213817476, 11298.49156787963, 11460.369679667698, 11684.649460515859, 50664.49335506598, 51746.33991718959, 52911.0, 53818.116365927, 55923.16115258193, 80244.59877700574, 81280.59359703163, 82290.76563851428, 83081.0, 84130.0, 7487.3261406473675, 8204.138565450781, 8240.052393974769, 8289.253967142746, 8424.873626895478, 9873.308868379145, 10474.0, 12183.329916854304, 12320.075994300285, 12558.937205313914, 9993.700188994342, 10541.420221887563, 11498.54005839757, 11639.47622356979, 11728.179027467995, 9063.773405664648, 10734.14126869833, 10799.730006749895, 10853.0, 11476.770464590829, 11071.058959988492, 11277.7744445109, 11300.0, 11389.658310250707, 11717.941410292893, 7316.829307310804, 7888.3689304856625, 7891.289783919475, 8199.95900020496, 8424.241818236389, 10828.187885908746, 10832.89680460968, 11079.279846810254, 11161.944190278997, 11306.265092768943], "value": 8798.299303012649, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1456.6212784675984, 1530.013141523717, 1723.3451288510364, 1852.129499135406, 1900.363378268281, 8480.618372173252, 9013.05362936892, 9024.187823095928, 9031.412958157714, 9051.185393314609, 7794.181610930856, 8058.5970701464985, 8512.872306915386, 8736.825263494742, 8752.387332886685, 2036.7963203679662, 2374.3114496795906, 2374.465745207332, 2379.3456799380224, 2382.273406610983, 2033.176563491788, 2262.230841513885, 2367.550165468564, 2412.216029790325, 2414.7343792182846, 2380.7143142822797, 2396.8561886286793, 2405.518896220754, 2409.4578719788083, 2411.577973854577, 2363.7518060603734, 2380.238323736405, 2386.2721869829693, 2391.1511413448147, 2401.0, 2360.079568968104, 2386.5107652931106, 2388.617821148608, 2391.7249516305674, 2393.054743376357, 8873.822523549557, 8904.421212621224, 8949.06034866336, 9015.684451044248, 9020.548972551413, 5190.870228244286, 5355.928814237129, 5360.517553420172, 5372.274742909735, 5372.409035006146, 3091.041777049122, 3414.760966732305, 3519.1729943463265, 3560.9109772255642, 3595.982020089883, 1052.300220353464, 1055.8099542082423, 1062.7927554126948, 1066.7599790047254, 1078.6063086973197, 11838.881611183864, 11962.222455540363, 11985.700357491045, 12011.699707507294, 12030.69923251917, 4568.6116680081905, 4641.443026836801, 4815.927761083586, 4819.734914579732, 4835.0, 8338.416310858303, 8511.74464766058, 9999.000099989942, 10027.799444011225, 10070.144037756872, 5323.494268044529, 5323.6273460857365, 5324.361076670824, 5324.92012619811, 5328.626996110235, 3871.670907972854, 4303.591158839905, 4476.35092911526, 4819.903601927942, 4851.757412129379, 3894.4547763313158, 3909.92180156401, 4007.6393124618926, 4016.9397459038137, 4031.637152656275, 1257.2330878164312, 1267.765463389276, 1268.0679700420185, 1287.22766340197, 1289.432649634158, 826.8300354997612, 858.4849090545747, 919.6321471411355, 924.7919218175991, 972.0619602084023, 5759.539236861041, 5899.233099697098, 5919.319278283053, 6175.84560385994, 6206.875862482725, 441.7791104447776, 455.92705167173756, 457.858064000161, 459.0428955627554, 459.64607252415453, 3932.508436445444, 3958.485396898385, 3971.920561588752, 4038.071243613985, 4065.7435123506148, 10367.688969330931, 10533.104686101615, 10890.455477226107, 10916.345019298868, 10919.290246133976, 10745.78508429827, 10900.836487452694, 10904.78190436187, 10907.618233361794, 10919.617813376493, 8184.304334131546, 8292.543910084883, 8325.459789938881, 8413.453125546943, 8417.116202798741, 5618.101103823368, 5911.674857882857, 5917.881642367042, 5986.880262394815, 5997.970010149921, 9915.553800079158, 10185.592576297162, 10278.023587759151, 10280.07479326864, 10283.640072597722, 8925.285977121945, 9780.430142997897, 10221.182305415401, 10403.531841067019, 10473.109785668303, 6911.550749201286, 7129.287071293037, 7142.928570714226, 7547.924520754722, 7658.6170691464085, 7889.842203156019, 7976.601169941596, 7993.0, 8218.137095605114, 8451.408401411842, 7300.342969132804, 7521.360684341674, 7534.246575342422, 7645.732399365996, 7647.388208943383, 7327.560346379234, 7341.522801017917, 7392.4825262231125, 7404.703811847466, 7471.589062601609, 7004.964975175091, 7131.037309963089, 7140.714371425085, 7140.7143714252925, 7142.892856607259, 4985.52637499437, 5065.265536497113, 5074.06129865976, 5118.744062796771, 5180.9740951295, 5054.3176671150395, 5060.721660308718, 5156.767945442389, 5176.1200595898035, 5221.973890130525], "value": 4510.07379555729, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [282.7766064808801, 305.2886773817008, 313.0889112682094, 316.10699773140885, 319.7250364686371, 4886.853394398165, 5200.257913598939, 5330.653507522014, 5445.591580631459, 5484.588655850807, 4691.812327506896, 5160.56135228506, 5245.659032162916, 5337.866553336168, 5416.756245968931, 4140.855070072548, 4156.792160391983, 4171.89444797129, 4172.457580514529, 4177.248095342837, 3514.9297014059703, 3852.8266228019666, 4084.1627466369323, 4195.307774217251, 4198.97900510497, 3578.177019285566, 3902.556054259928, 4061.4110953911663, 4086.366613174963, 4088.608164223918, 4059.391091336294, 4082.632563069338, 4099.344104943225, 4102.548719640867, 4107.753534787922, 3176.888808891678, 3345.5149003394613, 3538.876139335111, 3538.9211386094007, 3550.55618047744, 4954.479779623124, 5286.867828304285, 5288.038698328948, 5301.946980530184, 5309.65487243328, 4689.460712018094, 4691.906161876744, 4699.389079419688, 4702.60167314672, 4717.811287548494, 4803.879903002453, 5039.823606173803, 5122.410922743895, 5180.186934572907, 5777.537796976232, 3763.0404246917133, 3803.668912605119, 3815.5802861685193, 3869.2261547690573, 3907.960920390788, 5989.730462129215, 6001.509373609991, 6045.939540604581, 6047.334793172748, 6072.05883088122, 3382.3911695894485, 3820.968338548632, 3933.6853051755793, 3958.5051868516434, 3971.185906889081, 3735.869244576427, 3970.5830887756947, 3994.7403418777685, 4027.7986100694848, 4042.4542686737504, 4639.605633521121, 4648.093621743795, 4654.4414670239785, 4655.604273636779, 4660.254359302496, 4824.589909857631, 4854.466008739107, 5757.913631295534, 5766.279215098113, 5773.769049238067, 1280.3342262023696, 1288.7229245712217, 1295.7978277788466, 1332.4004198110888, 1338.6519504928788, 704.7744721689113, 786.9409794265453, 828.5815663090101, 835.1106072033265, 835.7910522369408, 3922.0783115967724, 4180.665546756313, 4548.795304211252, 4576.794044268016, 4582.977085114553, 4358.76026818528, 4421.491528474202, 4661.790219440133, 4931.506849315111, 4959.380077490314, 3759.9248015039548, 3954.689388566419, 4529.932051019237, 4547.613452856478, 4552.905663394809, 2268.7844654757773, 2516.9496610067695, 2563.6923569171445, 2564.5176322850643, 2571.7428257174133, 4515.590728999584, 4545.272796337371, 4641.210994130938, 4772.737499437495, 5144.742762861842, 4563.475200352002, 4829.44461386945, 5066.544011039025, 5108.489151084862, 5160.612954028388, 4619.5611416915335, 4627.375304333939, 4926.226558438959, 5077.31456253401, 5098.532997561693, 5610.298712660918, 5923.519120219945, 5959.8544523972205, 5998.820035398945, 6009.9699501503965, 5356.812511562077, 5815.447532484407, 5861.9413805863105, 5893.557983151367, 5902.586818922806, 5817.738201780845, 6186.938130618636, 6201.472874805692, 6228.532860035606, 6259.123722678738, 3951.881443556698, 3956.327424337927, 3964.7819369933777, 3967.3850553164307, 4021.7586944783407, 4601.631869450503, 5730.596003979052, 6049.425304596057, 6073.817785466443, 6082.574219804571, 4950.554450099508, 5093.4651861554, 5203.505666961632, 5362.731863406892, 5476.014317422902, 5741.224934633771, 5764.538836893123, 5794.246747922743, 5808.128780682931, 5822.563307752021, 4992.550670439678, 5205.687658740488, 5368.9463105370005, 5667.40492248308, 5667.886642267049, 5215.6609820361555, 5685.578605348663, 5725.2843394575675, 5775.451332123442, 5801.912971305349, 5637.562421582635, 5644.266245388073, 5653.349864765604, 5702.771889124555, 5705.372409035086], "value": 4015.4685877644483, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.2470125291505, 725.8403151306713, 757.4508481351018, 773.9032620922385, 796.2276591706045, 14876.702465950688, 16046.43837465689, 16162.595935101614, 16218.189090545484, 16269.511914642564, 12348.506059757621, 12634.936825315883, 14541.909356798229, 14749.262536873168, 14769.261536923164, 672.5897202706345, 693.535331328009, 694.3473135252872, 828.5732847583484, 830.5224495914842, 702.9472789540805, 840.4789030800881, 855.995720021399, 856.9742907712779, 859.2653281444369, 910.4628269321099, 911.2345629671075, 912.5118061836919, 915.0, 915.6062892956027, 699.4614147106699, 721.2571051816637, 905.4567259644226, 907.6006557114848, 908.42315129893, 539.1535289595337, 540.3893600231752, 540.7620646915344, 646.0857886091176, 663.4625952978055, 15039.548813535612, 15059.623509412242, 15071.321790519452, 15083.622909427242, 15094.698106037928, 13817.861821381859, 14191.290435478288, 14196.645083872883, 14224.786628200585, 14438.783418248735, 12587.118901676886, 12694.860819052328, 13087.541936032289, 13207.339633018311, 13679.863201367958, 4434.600885920283, 4447.73313601185, 4635.2120139576355, 4669.322948172496, 4677.812887484497, 117894.0, 119731.0, 120160.39919800345, 121148.0, 122380.0, 10782.56869725218, 11121.0, 11224.94387528057, 11286.492107855167, 11323.207375483802, 22068.11727530913, 22082.44793880166, 22256.332310030724, 22335.0, 22756.43108922257, 7856.646450909609, 7881.802954926058, 7951.920480795234, 7973.960130199428, 7996.280334769898, 4179.226843034048, 4221.2190744712325, 4278.837760319242, 4412.84555040572, 4415.955840441555, 3520.2431477232008, 3623.5108260385036, 3634.909127271839, 3638.326909521747, 3653.634636536325, 635.4662083849496, 648.2674577727138, 650.5056157320375, 653.4870126950416, 661.4939571228015, 543.6330476928058, 563.1974436428155, 626.2891618013497, 634.014108061968, 639.5906619763263, 8659.956700216584, 8772.956135219283, 9145.451272923647, 9233.953830230941, 9287.349885507949, 525.9076629419068, 591.3111225422335, 596.9106380854957, 611.6207951070276, 626.8056902360283, 4282.186384586918, 4475.060237350193, 4483.596476317147, 4553.567411095941, 4578.557754307449, 158089.20955395378, 162302.56546151818, 163198.0, 165614.0, 168320.0, 125120.0, 128391.35804320918, 131923.0, 132231.0, 133053.0, 96355.51822240844, 115845.84154158519, 121794.0, 121863.39068304602, 123103.3844830788, 9416.764580885532, 9710.902890971, 10185.74535636615, 10199.949000255248, 10203.94898025505, 44362.334564980905, 47378.81552961204, 58920.705396472746, 59705.104423432815, 61777.691111544154, 70052.64973675099, 93427.53286233525, 96353.554696681, 97122.0, 98937.0, 12353.135280530636, 12459.377031148226, 12972.0, 13263.86736132665, 13346.933265333611, 14101.717965640835, 14507.92746036263, 15009.774853377427, 15633.374665013273, 15683.215839207765, 13325.842808350324, 13402.0, 13888.236147011607, 13933.372998214902, 14247.715045699235, 9896.010398960047, 13205.735885282433, 13324.933375333061, 13373.264470454218, 14060.296985150906, 13055.281959492318, 13704.65738356549, 13874.0, 13971.650708732363, 14049.22729249901, 10622.8406573903, 11447.542098316308, 11464.713382165513, 11543.134264929995, 11694.88305116938, 9655.0, 11233.887661123284, 11616.593419230625, 11731.354775487089, 11766.882331176921], "value": 7813.269595042901, "unit": "score"}], "name": "dromaeo_css", "value": 7238.997823344252, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 114.0, 112.0, 113.0, 114.0, 113.0, 113.0, 114.0, 113.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 122.0, 108.0, 142.0, 110.0, 109.0, 106.0, 108.0, 141.0, 106.0], "value": 119.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 186.0, 181.0, 184.0, 182.0, 185.0, 179.0, 183.0, 183.0, 182.0], "value": 182.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 60.0, 60.0, 89.0, 62.0, 58.0, 59.0, 58.0, 91.0, 58.0], "value": 67.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 71.0, 95.0, 68.0, 67.0, 69.0, 93.0, 68.0, 68.0, 89.0], "value": 77.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 83.0, 86.0, 84.0, 87.0, 83.0, 88.0, 84.0, 87.0, 84.0], "value": 85.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 83.0, 85.0, 86.0, 85.0, 85.0, 83.0, 84.0, 84.0], "value": 84.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 54.0, 53.0, 55.0, 56.0, 56.0, 56.0, 57.0, 58.0], "value": 55.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 69.0, 79.0, 74.0, 70.0, 69.0, 68.0, 67.0, 68.0], "value": 69.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 92.0, 92.0, 100.0, 84.0, 81.0, 82.0, 84.0, 90.0, 89.0], "value": 87.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 146.0, 147.0, 140.0, 136.0, 135.0, 139.0, 142.0, 184.0, 127.0], "value": 146.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 162.0, 163.0, 165.0, 162.0, 163.0, 176.0, 162.0], "value": 164.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 81.0, 84.0, 83.0, 84.0, 73.0, 65.0, 65.0, 67.0, 68.0], "value": 73.9, "unit": "score"}], "name": "kraken", "value": 1422.6000000000001, "alertThreshold": 2.0}]} 07:20:52 INFO - Return code: 0 07:20:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:20:52 INFO - # TBPL SUCCESS # 07:20:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:20:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:20:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:20:52 INFO - 2016-10-01 07:20:52.101 screenresolution[1670:10926] starting screenresolution argv=screenresolution get 07:20:52 INFO - 2016-10-01 07:20:52.103 screenresolution[1670:10926] Display 0: 1600x1200x32@60 07:20:52 INFO - 2016-10-01 07:20:52.109 screenresolution[1671:10929] starting screenresolution argv=screenresolution list 07:20:52 INFO - Available Modes on Display 0 07:20:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:20:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:20:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:20:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:20:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:20:52 INFO - Intel Iris: 07:20:52 INFO - Chipset Model: Intel Iris 07:20:52 INFO - Type: GPU 07:20:52 INFO - Bus: Built-In 07:20:52 INFO - VRAM (Dynamic, Max): 1536 MB 07:20:52 INFO - Vendor: Intel (0x8086) 07:20:52 INFO - Device ID: 0x0a2e 07:20:52 INFO - Revision ID: 0x0009 07:20:52 INFO - Displays: 07:20:52 INFO - Display: 07:20:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:20:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:20:52 INFO - Display Serial Number: 1600x1200 60 07:20:52 INFO - Main Display: Yes 07:20:52 INFO - Mirror: Off 07:20:52 INFO - Online: Yes 07:20:52 INFO - Rotation: Supported 07:20:52 INFO - Return code: 0 07:20:52 INFO - Running post-action listener: _resource_record_post_action 07:20:52 INFO - [mozharness: 2016-10-01 14:20:52.343283Z] Finished run-tests step (success) 07:20:52 INFO - Running post-run listener: _resource_record_post_run 07:20:52 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 31771648; Write bytes: 663345152; Read time: 193; Write time: 1904 07:20:52 INFO - TinderboxPrint: CPU usage
53.5% 07:20:52 INFO - TinderboxPrint: I/O read bytes / time
31,771,648 / 193 07:20:52 INFO - TinderboxPrint: I/O write bytes / time
663,345,152 / 1,904 07:20:52 INFO - TinderboxPrint: CPU idle
2,249.2 (46.5%) 07:20:52 INFO - TinderboxPrint: CPU system
968.9 (20.0%) 07:20:52 INFO - TinderboxPrint: CPU user
1,619.6 (33.5%) 07:20:52 INFO - TinderboxPrint: Swap in / out
391,577,600 / 0 07:20:52 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 362326528; Write bytes: 363542528; Read time: 27651; Write time: 773 07:20:52 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 28797952; Write bytes: 295422464; Read time: 171; Write time: 1109 07:20:52 INFO - Running post-run listener: _upload_blobber_files 07:20:52 INFO - Blob upload gear active. 07:20:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:20:52 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:20:52 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'] 07:20:52 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 07:20:53 INFO - (blobuploader) - INFO - Open directory for files ... 07:20:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:20:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:20:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:20:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:20:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:20:54 INFO - (blobuploader) - INFO - Done attempting. 07:20:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:20:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:20:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:20:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:20:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:20:55 INFO - (blobuploader) - INFO - Done attempting. 07:20:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:20:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:20:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:20:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:20:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:20:57 INFO - (blobuploader) - INFO - Done attempting. 07:20:57 INFO - (blobuploader) - INFO - Iteration through files over. 07:20:57 INFO - Return code: 0 07:20:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:20:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:20:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8376e8b0d5c40979e6b2bec7b052b0ba8e10266a9a684c6ccda122ba41e38ed90e780570cecf8ce9435874c47027285dbe2fef6e23b28cab7e8782d704d95e79", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/45a6b08571b0f1a2ace0d17339fcb56cebb06b0153aee3fc5ea673544f1abe7483b363e57eaf4e57ba90b492e15756f80e7532292f9c33dc14b279d3090a4b84", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a8eab63c931619c60e67f9274bdefef87dba10191a1bc9580af183f7b42381c198dd866bfdee9d6581ca82aba69d53b295be5f5a6fad8fbd4674ed92312965a6"} 07:20:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:20:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:20:57 INFO - Contents: 07:20:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8376e8b0d5c40979e6b2bec7b052b0ba8e10266a9a684c6ccda122ba41e38ed90e780570cecf8ce9435874c47027285dbe2fef6e23b28cab7e8782d704d95e79", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/45a6b08571b0f1a2ace0d17339fcb56cebb06b0153aee3fc5ea673544f1abe7483b363e57eaf4e57ba90b492e15756f80e7532292f9c33dc14b279d3090a4b84", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a8eab63c931619c60e67f9274bdefef87dba10191a1bc9580af183f7b42381c198dd866bfdee9d6581ca82aba69d53b295be5f5a6fad8fbd4674ed92312965a6"} 07:20:57 INFO - Running post-run listener: copy_logs_to_upload_dir 07:20:57 INFO - Copying logs to upload dir... 07:20:57 INFO - mkdir: /builds/slave/test/build/upload/logs 07:20:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.214573 ========= master_lag: 1.70 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-10-01 07:20:59.448505) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-01 07:20:59.457253) ========= 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.p1ITL7tb8G/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.bJSzzM3CiN/Listeners TMPDIR=/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/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/8376e8b0d5c40979e6b2bec7b052b0ba8e10266a9a684c6ccda122ba41e38ed90e780570cecf8ce9435874c47027285dbe2fef6e23b28cab7e8782d704d95e79", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/45a6b08571b0f1a2ace0d17339fcb56cebb06b0153aee3fc5ea673544f1abe7483b363e57eaf4e57ba90b492e15756f80e7532292f9c33dc14b279d3090a4b84", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a8eab63c931619c60e67f9274bdefef87dba10191a1bc9580af183f7b42381c198dd866bfdee9d6581ca82aba69d53b295be5f5a6fad8fbd4674ed92312965a6"} build_url:https://queue.taskcluster.net/v1/task/OAF5oyzCT1Gs9vtrdH1V0w/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011079 build_url: 'https://queue.taskcluster.net/v1/task/OAF5oyzCT1Gs9vtrdH1V0w/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/8376e8b0d5c40979e6b2bec7b052b0ba8e10266a9a684c6ccda122ba41e38ed90e780570cecf8ce9435874c47027285dbe2fef6e23b28cab7e8782d704d95e79", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/45a6b08571b0f1a2ace0d17339fcb56cebb06b0153aee3fc5ea673544f1abe7483b363e57eaf4e57ba90b492e15756f80e7532292f9c33dc14b279d3090a4b84", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a8eab63c931619c60e67f9274bdefef87dba10191a1bc9580af183f7b42381c198dd866bfdee9d6581ca82aba69d53b295be5f5a6fad8fbd4674ed92312965a6"}' ========= master_lag: 0.73 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-01 07:21:00.195717) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 07:21:00.196109) ========= 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.p1ITL7tb8G/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.bJSzzM3CiN/Listeners TMPDIR=/var/folders/00/7tdhxz016pgck4583ks_0xj800000w/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.005379 ========= master_lag: 0.27 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 07:21:00.475938) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-01 07:21:00.476340) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-01 07:21:00.477282) ========= ========= Total master_lag: 2.80 =========