builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0029 starttime: 1491324903.83 results: success (0) buildid: 20170404090927 builduid: 3eb75766a52c44578a7ede2cc79d454e revision: 17f121d897d225a7defa54445dd8bd3000604046 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-04 09:55:03.829684) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-04 09:55:03.830086) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-04 09:55:03.830381) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-04 09:55:03.870291) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 09:55:03.870757) ========= 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.gwr8oTWkoi/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.Rjfwxuyqbb/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-04 09:55:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.1M=0.001s 2017-04-04 09:55:03 (18.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.134137 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 09:55:04.029868) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 09:55:04.030243) ========= 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.gwr8oTWkoi/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.Rjfwxuyqbb/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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.028012 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 09:55:04.081892) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-04 09:55:04.082263) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 17f121d897d225a7defa54445dd8bd3000604046 --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 17f121d897d225a7defa54445dd8bd3000604046 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.gwr8oTWkoi/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.Rjfwxuyqbb/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-04 09:55:04,164 truncating revision to first 12 chars 2017-04-04 09:55:04,164 Setting DEBUG logging. 2017-04-04 09:55:04,164 attempt 1/10 2017-04-04 09:55:04,164 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/17f121d897d2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-04 09:55:06,185 unpacking tar archive at: mozilla-aurora-17f121d897d2/testing/mozharness/ program finished with exit code 0 elapsedTime=2.283507 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-04 09:55:06.389931) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-04 09:55:06.390338) ========= script_repo_revision: 17f121d897d225a7defa54445dd8bd3000604046 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-04 09:55:06.390736) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-04 09:55:06.391042) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-04 09:55:06.413047) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-04-04 09:55:06.413358) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.gwr8oTWkoi/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.Rjfwxuyqbb/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 09:55:06 INFO - MultiFileLogger online at 20170404 09:55:06 in /builds/slave/test 09:55:06 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 09:55:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:55:06 INFO - {'append_to_log': False, 09:55:06 INFO - 'base_work_dir': '/builds/slave/test', 09:55:06 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:55:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:55:06 INFO - 'branch': 'Mozilla-Aurora', 09:55:06 INFO - 'buildbot_json_path': 'buildprops.json', 09:55:06 INFO - 'config_files': ('talos/mac_config.py',), 09:55:06 INFO - 'default_actions': ('clobber', 09:55:06 INFO - 'read-buildbot-config', 09:55:06 INFO - 'download-and-extract', 09:55:06 INFO - 'populate-webroot', 09:55:06 INFO - 'create-virtualenv', 09:55:06 INFO - 'install', 09:55:06 INFO - 'run-tests'), 09:55:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:55:06 INFO - 'download_minidump_stackwalk': True, 09:55:06 INFO - 'download_symbols': 'ondemand', 09:55:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:55:06 INFO - 'tooltool.py': '/tools/tooltool.py', 09:55:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:55:06 INFO - '/tools/misc-python/virtualenv.py')}, 09:55:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:55:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:55:06 INFO - 'gecko_profile': False, 09:55:06 INFO - 'gecko_profile_interval': 0, 09:55:06 INFO - 'installer_path': 'installer.exe', 09:55:06 INFO - 'log_level': 'info', 09:55:06 INFO - 'log_name': 'talos', 09:55:06 INFO - 'log_to_console': True, 09:55:06 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:55:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:55:06 INFO - 'opt_config_files': (), 09:55:06 INFO - 'pip_index': False, 09:55:06 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:55:06 INFO - 'cmd': ('bash', 09:55:06 INFO - '-c', 09:55:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:55:06 INFO - 'enabled': True, 09:55:06 INFO - 'halt_on_failure': False, 09:55:06 INFO - 'name': 'check_screen_resolution'},), 09:55:06 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:55:06 INFO - 'cmd': ('bash', 09:55:06 INFO - '-c', 09:55:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:55:06 INFO - 'enabled': True, 09:55:06 INFO - 'halt_on_failure': False, 09:55:06 INFO - 'name': 'check_screen_resolution'},), 09:55:06 INFO - 'run_cmd_checks_enabled': True, 09:55:06 INFO - 'suite': 'dromaeojs', 09:55:06 INFO - 'system_bits': '32', 09:55:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:55:06 INFO - 'title': 't-yosemite-r7-0029', 09:55:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:55:06 INFO - 'use_talos_json': True, 09:55:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:55:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:55:06 INFO - 'work_dir': 'build'} 09:55:06 INFO - [mozharness: 2017-04-04 16:55:06.606509Z] Running clobber step. 09:55:06 INFO - Running pre-action listener: _resource_record_pre_action 09:55:06 INFO - Running main action method: clobber 09:55:06 INFO - rmtree: /builds/slave/test/build 09:55:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:55:09 INFO - Running post-action listener: _resource_record_post_action 09:55:09 INFO - [mozharness: 2017-04-04 16:55:09.068597Z] Finished clobber step (success) 09:55:09 INFO - [mozharness: 2017-04-04 16:55:09.068732Z] Running read-buildbot-config step. 09:55:09 INFO - Running pre-action listener: _resource_record_pre_action 09:55:09 INFO - Running main action method: read_buildbot_config 09:55:09 INFO - Using buildbot properties: 09:55:09 INFO - { 09:55:09 INFO - "project": "", 09:55:09 INFO - "product": "firefox", 09:55:09 INFO - "script_repo_revision": "production", 09:55:09 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 09:55:09 INFO - "repository": "", 09:55:09 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 09:55:09 INFO - "buildid": "20170404090927", 09:55:09 INFO - "pgo_build": "False", 09:55:09 INFO - "basedir": "/builds/slave/test", 09:55:09 INFO - "buildnumber": 41, 09:55:09 INFO - "slavename": "t-yosemite-r7-0029", 09:55:09 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 09:55:09 INFO - "platform": "yosemite_r7", 09:55:09 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 09:55:09 INFO - "branch": "mozilla-aurora", 09:55:09 INFO - "repo_path": "releases/mozilla-aurora", 09:55:09 INFO - "revision": "17f121d897d225a7defa54445dd8bd3000604046", 09:55:09 INFO - "stage_platform": "macosx64", 09:55:09 INFO - "builduid": "3eb75766a52c44578a7ede2cc79d454e", 09:55:09 INFO - "slavebuilddir": "test" 09:55:09 INFO - } 09:55:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/ey7VVxidSbSCracC4NkSug/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 09:55:09 INFO - Running post-action listener: _resource_record_post_action 09:55:09 INFO - [mozharness: 2017-04-04 16:55:09.072018Z] Finished read-buildbot-config step (success) 09:55:09 INFO - [mozharness: 2017-04-04 16:55:09.072143Z] Running download-and-extract step. 09:55:09 INFO - Running pre-action listener: _resource_record_pre_action 09:55:09 INFO - Running main action method: download_and_extract 09:55:09 INFO - mkdir: /builds/slave/test/build/tests 09:55:09 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')]} 09:55:09 INFO - trying https://queue.taskcluster.net/v1/task/ey7VVxidSbSCracC4NkSug/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 09:55:09 INFO - Downloading https://queue.taskcluster.net/v1/task/ey7VVxidSbSCracC4NkSug/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 09:55:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ey7VVxidSbSCracC4NkSug/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json'}, attempt #1 09:55:09 INFO - Downloaded 1199 bytes. 09:55:09 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 09:55:09 INFO - Using the following test package requirements: 09:55:09 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 09:55:09 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:55:09 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 09:55:09 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:55:09 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 09:55:09 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:55:09 INFO - u'jsshell-mac.zip'], 09:55:09 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:55:09 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 09:55:09 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 09:55:09 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:55:09 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 09:55:09 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:55:09 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 09:55:09 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:55:09 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 09:55:09 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:55:09 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 09:55:09 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 09:55:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ey7VVxidSbSCracC4NkSug/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 09:55:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ey7VVxidSbSCracC4NkSug/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:55:09 INFO - Fetch https://queue.taskcluster.net/v1/task/ey7VVxidSbSCracC4NkSug/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 09:55:11 INFO - Expected file size: 51790957 09:55:11 INFO - Obtained file size: 51790957 09:55:27 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip', u'firefox-54.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 09:55:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ey7VVxidSbSCracC4NkSug/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 09:55:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ey7VVxidSbSCracC4NkSug/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:55:27 INFO - Fetch https://queue.taskcluster.net/v1/task/ey7VVxidSbSCracC4NkSug/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 09:55:29 INFO - Expected file size: 51790957 09:55:29 INFO - Obtained file size: 51790957 09:55:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ey7VVxidSbSCracC4NkSug/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 09:55:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ey7VVxidSbSCracC4NkSug/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 09:55:44 INFO - Fetch https://queue.taskcluster.net/v1/task/ey7VVxidSbSCracC4NkSug/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 09:55:45 INFO - Expected file size: 14404438 09:55:45 INFO - Obtained file size: 14404438 09:55:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:55:45 INFO - trying https://queue.taskcluster.net/v1/task/ey7VVxidSbSCracC4NkSug/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 09:55:45 INFO - Downloading https://queue.taskcluster.net/v1/task/ey7VVxidSbSCracC4NkSug/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 09:55:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ey7VVxidSbSCracC4NkSug/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg'}, attempt #1 09:55:47 INFO - Downloaded 74679818 bytes. 09:55:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ey7VVxidSbSCracC4NkSug/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 09:55:47 INFO - mkdir: /builds/slave/test/properties 09:55:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:55:47 INFO - Writing to file /builds/slave/test/properties/build_url 09:55:47 INFO - Contents: 09:55:47 INFO - build_url:https://queue.taskcluster.net/v1/task/ey7VVxidSbSCracC4NkSug/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 09:55:48 INFO - Running post-action listener: _resource_record_post_action 09:55:48 INFO - Running post-action listener: set_extra_try_arguments 09:55:48 INFO - [mozharness: 2017-04-04 16:55:48.568098Z] Finished download-and-extract step (success) 09:55:48 INFO - [mozharness: 2017-04-04 16:55:48.568249Z] Running populate-webroot step. 09:55:48 INFO - Running pre-action listener: _resource_record_pre_action 09:55:48 INFO - Running main action method: populate_webroot 09:55:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:55:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:55:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:55:48 INFO - '--tppagecycles', 09:55:48 INFO - '7'], 09:55:48 INFO - 'tests': ['tsvgm']}}, 09:55:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:55:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:55:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:55:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:55:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:55:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:55:48 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:55:48 INFO - 'talos_options': ['--disable-e10s'], 09:55:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:55:48 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:55:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:55:48 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:55:48 INFO - 'talos_options': ['--disable-e10s'], 09:55:48 INFO - 'tests': ['damp', 'tps']}, 09:55:48 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:55:48 INFO - 'tests': ['damp', 'tps']}, 09:55:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:55:48 INFO - 'tests': ['dromaeo_dom']}, 09:55:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:55:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:55:48 INFO - 'tests': ['basic_compositor_video']}, 09:55:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:55:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:55:48 INFO - 'tests': ['a11yr', 09:55:48 INFO - 'ts_paint', 09:55:48 INFO - 'tpaint', 09:55:48 INFO - 'sessionrestore', 09:55:48 INFO - 'sessionrestore_no_auto_restore', 09:55:48 INFO - 'tabpaint']}, 09:55:48 INFO - 'other-e10s': {'tests': ['a11yr', 09:55:48 INFO - 'ts_paint', 09:55:48 INFO - 'tpaint', 09:55:48 INFO - 'sessionrestore', 09:55:48 INFO - 'sessionrestore_no_auto_restore', 09:55:48 INFO - 'tabpaint']}, 09:55:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:55:48 INFO - 'ts_paint', 09:55:48 INFO - 'tpaint', 09:55:48 INFO - 'sessionrestore', 09:55:48 INFO - 'sessionrestore_no_auto_restore', 09:55:48 INFO - 'tabpaint']}, 09:55:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:55:48 INFO - 'ts_paint', 09:55:48 INFO - 'tpaint', 09:55:48 INFO - 'sessionrestore', 09:55:48 INFO - 'sessionrestore_no_auto_restore', 09:55:48 INFO - 'tabpaint']}, 09:55:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:55:48 INFO - 'tests': ['a11yr', 09:55:48 INFO - 'ts_paint', 09:55:48 INFO - 'tpaint', 09:55:48 INFO - 'sessionrestore', 09:55:48 INFO - 'sessionrestore_no_auto_restore', 09:55:48 INFO - 'tabpaint']}, 09:55:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:55:48 INFO - 'tests': ['a11yr', 09:55:48 INFO - 'ts_paint', 09:55:48 INFO - 'tpaint', 09:55:48 INFO - 'sessionrestore', 09:55:48 INFO - 'sessionrestore_no_auto_restore', 09:55:48 INFO - 'tabpaint']}, 09:55:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:55:48 INFO - 'tests': ['tsvgx', 09:55:48 INFO - 'tsvgr_opacity', 09:55:48 INFO - 'tart', 09:55:48 INFO - 'tscrollx', 09:55:48 INFO - 'cart', 09:55:48 INFO - 'tsvg_static']}, 09:55:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:55:48 INFO - 'tsvgr_opacity', 09:55:48 INFO - 'tart', 09:55:48 INFO - 'tscrollx', 09:55:48 INFO - 'cart', 09:55:48 INFO - 'tsvg_static']}, 09:55:48 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:55:48 INFO - 'talos_options': ['--disable-e10s'], 09:55:48 INFO - 'tests': ['tp5o']}, 09:55:48 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:55:48 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:55:48 INFO - 'talos_options': ['--disable-e10s', 09:55:48 INFO - '--xperf_path', 09:55:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:55:48 INFO - 'tests': ['tp5n']}, 09:55:48 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:55:48 INFO - 'talos_options': ['--xperf_path', 09:55:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:55:48 INFO - 'tests': ['tp5n']}}, 09:55:48 INFO - 'talos.zip': {'path': '', 09:55:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:55:48 INFO - Running post-action listener: _resource_record_post_action 09:55:48 INFO - [mozharness: 2017-04-04 16:55:48.586450Z] Finished populate-webroot step (success) 09:55:48 INFO - [mozharness: 2017-04-04 16:55:48.586557Z] Running create-virtualenv step. 09:55:48 INFO - Running pre-action listener: _resource_record_pre_action 09:55:48 INFO - Running main action method: create_virtualenv 09:55:48 INFO - Creating virtualenv /builds/slave/test/build/venv 09:55:48 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 09:55:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:55:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:55:48 INFO - Using real prefix '/tools/python27' 09:55:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:55:49 INFO - Installing distribute.............................................................................................................................................................................................done. 09:55:52 INFO - Installing pip.................done. 09:55:52 INFO - Return code: 0 09:55:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:55:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:55:52 INFO - Reading from file tmpfile_stdout 09:55:52 INFO - Output received: 09:55:52 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:55:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:55:52 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')]} 09:55:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:55:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:52 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')]} 09:55:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:55:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:52 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 0x101af2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101af5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5fbd9b0a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1018d0d30>, '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 0x1017f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1018c5be8>, '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.gwr8oTWkoi/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.Rjfwxuyqbb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 09:55:52 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 09:55:52 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 09:55:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gwr8oTWkoi/Render', 09:55:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:55:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:55:52 INFO - 'HOME': '/Users/cltbld', 09:55:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:55:52 INFO - 'LOGNAME': 'cltbld', 09:55:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:55:52 INFO - 'MOZ_NO_REMOTE': '1', 09:55:52 INFO - 'NO_EM_RESTART': '1', 09:55:52 INFO - 'PAGER': '/bin/cat', 09:55:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:55:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:55:52 INFO - 'PWD': '/builds/slave/test', 09:55:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:55:52 INFO - 'SHELL': '/bin/bash', 09:55:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Rjfwxuyqbb/Listeners', 09:55:52 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 09:55:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:55:52 INFO - 'USER': 'cltbld', 09:55:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:55:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:55:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:55:52 INFO - 'XPC_FLAGS': '0x0', 09:55:52 INFO - 'XPC_SERVICE_NAME': '0', 09:55:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:55:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:55:52 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 09:55:52 INFO - Cleaning up... 09:55:52 INFO - Return code: 0 09:55:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:55:52 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')]} 09:55:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:55:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:52 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')]} 09:55:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:55:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:52 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 0x101af2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101af5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5fbd9b0a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1018d0d30>, '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 0x1017f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1018c5be8>, '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.gwr8oTWkoi/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.Rjfwxuyqbb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 09:55:52 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 09:55:52 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 09:55:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gwr8oTWkoi/Render', 09:55:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:55:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:55:52 INFO - 'HOME': '/Users/cltbld', 09:55:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:55:52 INFO - 'LOGNAME': 'cltbld', 09:55:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:55:52 INFO - 'MOZ_NO_REMOTE': '1', 09:55:52 INFO - 'NO_EM_RESTART': '1', 09:55:52 INFO - 'PAGER': '/bin/cat', 09:55:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:55:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:55:52 INFO - 'PWD': '/builds/slave/test', 09:55:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:55:52 INFO - 'SHELL': '/bin/bash', 09:55:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Rjfwxuyqbb/Listeners', 09:55:52 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 09:55:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:55:52 INFO - 'USER': 'cltbld', 09:55:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:55:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:55:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:55:52 INFO - 'XPC_FLAGS': '0x0', 09:55:52 INFO - 'XPC_SERVICE_NAME': '0', 09:55:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:55:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:55:53 INFO - Downloading/unpacking psutil>=3.1.1 09:55:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:55:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:55:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:55:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:55:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:55:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:55:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:55:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:55:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:55:56 INFO - Installing collected packages: psutil 09:55:56 INFO - Running setup.py install for psutil 09:55:56 INFO - building 'psutil._psutil_osx' extension 09:55:56 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 09:55:57 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 09:55:57 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 09:55:57 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 09:55:57 INFO - building 'psutil._psutil_posix' extension 09:55:57 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 09:55:57 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:55:57 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:55:57 INFO - ^ 09:55:57 INFO - 1 warning generated. 09:55:57 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 09:55:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:55:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:55:57 INFO - Successfully installed psutil 09:55:57 INFO - Cleaning up... 09:55:57 INFO - Return code: 0 09:55:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:55:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:55:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:58 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')]} 09:55:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:55:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:55:58 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 0x101af2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101af5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5fbd9b0a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1018d0d30>, '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 0x1017f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1018c5be8>, '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.gwr8oTWkoi/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.Rjfwxuyqbb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 09:55:58 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 09:55:58 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 09:55:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gwr8oTWkoi/Render', 09:55:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:55:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:55:58 INFO - 'HOME': '/Users/cltbld', 09:55:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:55:58 INFO - 'LOGNAME': 'cltbld', 09:55:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:55:58 INFO - 'MOZ_NO_REMOTE': '1', 09:55:58 INFO - 'NO_EM_RESTART': '1', 09:55:58 INFO - 'PAGER': '/bin/cat', 09:55:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:55:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:55:58 INFO - 'PWD': '/builds/slave/test', 09:55:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:55:58 INFO - 'SHELL': '/bin/bash', 09:55:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Rjfwxuyqbb/Listeners', 09:55:58 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 09:55:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:55:58 INFO - 'USER': 'cltbld', 09:55:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:55:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:55:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:55:58 INFO - 'XPC_FLAGS': '0x0', 09:55:58 INFO - 'XPC_SERVICE_NAME': '0', 09:55:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:55:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:55:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:55:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:55:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:55:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:55:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:55:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:55:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:56:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:56:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:56:02 INFO - Installing collected packages: mozsystemmonitor 09:56:02 INFO - Running setup.py install for mozsystemmonitor 09:56:02 INFO - Successfully installed mozsystemmonitor 09:56:02 INFO - Cleaning up... 09:56:02 INFO - Return code: 0 09:56:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:56:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101af2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101af5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5fbd9b0a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1018d0d30>, '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 0x1017f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1018c5be8>, '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.gwr8oTWkoi/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.Rjfwxuyqbb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 09:56:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:56:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:56:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gwr8oTWkoi/Render', 09:56:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:56:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:56:02 INFO - 'HOME': '/Users/cltbld', 09:56:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:56:02 INFO - 'LOGNAME': 'cltbld', 09:56:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:02 INFO - 'MOZ_NO_REMOTE': '1', 09:56:02 INFO - 'NO_EM_RESTART': '1', 09:56:02 INFO - 'PAGER': '/bin/cat', 09:56:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:56:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:02 INFO - 'PWD': '/builds/slave/test', 09:56:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:56:02 INFO - 'SHELL': '/bin/bash', 09:56:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Rjfwxuyqbb/Listeners', 09:56:02 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 09:56:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:56:02 INFO - 'USER': 'cltbld', 09:56:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:56:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:56:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:02 INFO - 'XPC_FLAGS': '0x0', 09:56:02 INFO - 'XPC_SERVICE_NAME': '0', 09:56:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:56:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:02 INFO - Downloading/unpacking jsonschema==2.5.1 09:56:02 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 09:56:02 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 09:56:02 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 09:56:02 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 09:56:02 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 09:56:02 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 09:56:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:56:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:56:05 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 09:56:05 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 09:56:05 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 09:56:05 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 09:56:05 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 09:56:05 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 09:56:05 INFO - Downloading functools32-3.2.3-2.tar.gz 09:56:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:56:05 INFO - warning: no files found matching '*.txt' 09:56:05 INFO - no previously-included directories found matching 'build' 09:56:05 INFO - no previously-included directories found matching 'dist' 09:56:05 INFO - no previously-included directories found matching '.git*' 09:56:05 INFO - Installing collected packages: jsonschema, functools32 09:56:06 INFO - Running setup.py install for functools32 09:56:06 INFO - warning: no files found matching '*.txt' 09:56:06 INFO - no previously-included directories found matching 'build' 09:56:06 INFO - no previously-included directories found matching 'dist' 09:56:06 INFO - no previously-included directories found matching '.git*' 09:56:06 INFO - Successfully installed jsonschema functools32 09:56:06 INFO - Cleaning up... 09:56:06 INFO - Return code: 0 09:56:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:56:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:06 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 0x101af2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101af5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5fbd9b0a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1018d0d30>, '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 0x1017f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1018c5be8>, '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.gwr8oTWkoi/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.Rjfwxuyqbb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 09:56:06 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 09:56:06 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 09:56:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gwr8oTWkoi/Render', 09:56:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:56:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:56:06 INFO - 'HOME': '/Users/cltbld', 09:56:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:56:06 INFO - 'LOGNAME': 'cltbld', 09:56:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:06 INFO - 'MOZ_NO_REMOTE': '1', 09:56:06 INFO - 'NO_EM_RESTART': '1', 09:56:06 INFO - 'PAGER': '/bin/cat', 09:56:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:56:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:06 INFO - 'PWD': '/builds/slave/test', 09:56:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:56:06 INFO - 'SHELL': '/bin/bash', 09:56:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Rjfwxuyqbb/Listeners', 09:56:06 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 09:56:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:56:06 INFO - 'USER': 'cltbld', 09:56:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:56:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:56:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:06 INFO - 'XPC_FLAGS': '0x0', 09:56:06 INFO - 'XPC_SERVICE_NAME': '0', 09:56:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:56:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:56:06 INFO - Cleaning up... 09:56:06 INFO - Return code: 0 09:56:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:56:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:06 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 0x101af2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101af5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5fbd9b0a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1018d0d30>, '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 0x1017f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1018c5be8>, '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.gwr8oTWkoi/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.Rjfwxuyqbb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 09:56:06 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 09:56:06 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 09:56:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gwr8oTWkoi/Render', 09:56:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:56:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:56:06 INFO - 'HOME': '/Users/cltbld', 09:56:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:56:06 INFO - 'LOGNAME': 'cltbld', 09:56:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:06 INFO - 'MOZ_NO_REMOTE': '1', 09:56:06 INFO - 'NO_EM_RESTART': '1', 09:56:06 INFO - 'PAGER': '/bin/cat', 09:56:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:56:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:06 INFO - 'PWD': '/builds/slave/test', 09:56:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:56:06 INFO - 'SHELL': '/bin/bash', 09:56:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Rjfwxuyqbb/Listeners', 09:56:06 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 09:56:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:56:06 INFO - 'USER': 'cltbld', 09:56:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:56:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:56:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:06 INFO - 'XPC_FLAGS': '0x0', 09:56:06 INFO - 'XPC_SERVICE_NAME': '0', 09:56:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:56:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:06 INFO - Downloading/unpacking blobuploader==1.2.4 09:56:06 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 09:56:06 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 09:56:06 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 09:56:06 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 09:56:06 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 09:56:06 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 09:56:09 INFO - Downloading blobuploader-1.2.4.tar.gz 09:56:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:56:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:56:09 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 09:56:09 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 09:56:09 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 09:56:09 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 09:56:09 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 09:56:09 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 09:56:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:56:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:56:10 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 09:56:10 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 09:56:10 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 09:56:10 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 09:56:10 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 09:56:10 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 09:56:10 INFO - Downloading docopt-0.6.1.tar.gz 09:56:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:56:10 INFO - Installing collected packages: blobuploader, requests, docopt 09:56:10 INFO - Running setup.py install for blobuploader 09:56:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:56:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:56:10 INFO - Running setup.py install for requests 09:56:11 INFO - Running setup.py install for docopt 09:56:11 INFO - Successfully installed blobuploader requests docopt 09:56:11 INFO - Cleaning up... 09:56:11 INFO - Return code: 0 09:56:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:56:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:11 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 0x101af2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101af5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5fbd9b0a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1018d0d30>, '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 0x1017f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1018c5be8>, '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.gwr8oTWkoi/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.Rjfwxuyqbb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 09:56:11 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 09:56:11 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 09:56:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gwr8oTWkoi/Render', 09:56:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:56:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:56:11 INFO - 'HOME': '/Users/cltbld', 09:56:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:56:11 INFO - 'LOGNAME': 'cltbld', 09:56:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:11 INFO - 'MOZ_NO_REMOTE': '1', 09:56:11 INFO - 'NO_EM_RESTART': '1', 09:56:11 INFO - 'PAGER': '/bin/cat', 09:56:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:56:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:11 INFO - 'PWD': '/builds/slave/test', 09:56:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:56:11 INFO - 'SHELL': '/bin/bash', 09:56:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Rjfwxuyqbb/Listeners', 09:56:11 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 09:56:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:56:11 INFO - 'USER': 'cltbld', 09:56:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:56:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:56:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:11 INFO - 'XPC_FLAGS': '0x0', 09:56:11 INFO - 'XPC_SERVICE_NAME': '0', 09:56:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:56:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:56:11 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-435Bsy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:56:11 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-eZpz6A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:56:12 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-5b1NL4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:56:12 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-SAaJMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:56:12 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-k3iwc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:56:12 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-AzfiLR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:56:12 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-0ob5bs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:56:12 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-jif9PO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:56:12 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-esLFsp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:56:12 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-Ho4yIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:56:12 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-ksUUPf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:56:13 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-GJyKDk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:56:13 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-Ppidzc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:56:13 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-VJZCuV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:56:13 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-bC9UDL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:56:13 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-4hwEwy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:56:13 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-rZB9yl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:56:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:56:13 INFO - Running setup.py install for manifestparser 09:56:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:56:13 INFO - Running setup.py install for mozcrash 09:56:13 INFO - Running setup.py install for mozdebug 09:56:14 INFO - Running setup.py install for mozdevice 09:56:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:56:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:56:14 INFO - Running setup.py install for mozfile 09:56:14 INFO - Running setup.py install for mozhttpd 09:56:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:56:14 INFO - Running setup.py install for mozinfo 09:56:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:56:14 INFO - Running setup.py install for mozInstall 09:56:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:56:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:56:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:56:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:56:14 INFO - Running setup.py install for mozleak 09:56:14 INFO - Running setup.py install for mozlog 09:56:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:56:15 INFO - Running setup.py install for moznetwork 09:56:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:56:15 INFO - Running setup.py install for mozprocess 09:56:15 INFO - Running setup.py install for mozprofile 09:56:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:56:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:56:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:56:15 INFO - Running setup.py install for mozrunner 09:56:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:56:15 INFO - Running setup.py install for mozscreenshot 09:56:15 INFO - Running setup.py install for moztest 09:56:16 INFO - Running setup.py install for mozversion 09:56:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:56:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:56:16 INFO - Cleaning up... 09:56:16 INFO - Return code: 0 09:56:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:56:16 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')]} 09:56:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:16 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')]} 09:56:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:16 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 0x101af2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101af5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5fbd9b0a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1018d0d30>, '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 0x1017f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1018c5be8>, '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.gwr8oTWkoi/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.Rjfwxuyqbb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 09:56:16 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 09:56:16 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 09:56:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gwr8oTWkoi/Render', 09:56:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:56:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:56:16 INFO - 'HOME': '/Users/cltbld', 09:56:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:56:16 INFO - 'LOGNAME': 'cltbld', 09:56:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:16 INFO - 'MOZ_NO_REMOTE': '1', 09:56:16 INFO - 'NO_EM_RESTART': '1', 09:56:16 INFO - 'PAGER': '/bin/cat', 09:56:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:56:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:16 INFO - 'PWD': '/builds/slave/test', 09:56:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:56:16 INFO - 'SHELL': '/bin/bash', 09:56:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Rjfwxuyqbb/Listeners', 09:56:16 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 09:56:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:56:16 INFO - 'USER': 'cltbld', 09:56:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:56:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:56:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:16 INFO - 'XPC_FLAGS': '0x0', 09:56:16 INFO - 'XPC_SERVICE_NAME': '0', 09:56:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:56:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:56:16 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-ak0l07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:56:16 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)) 09:56:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:56:16 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-XJVajW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:56:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:56:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:56:16 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-ywyUgj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:56:16 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)) 09:56:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:56:16 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-_v_Gj7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:56:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:56:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:56:16 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-DRq_iw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:56:17 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)) 09:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:56:17 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-flueoT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:56:17 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)) 09:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:56:17 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-lHGbsW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:56:17 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)) 09:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:56:17 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-jVUL6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:56:17 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)) 09:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:56:17 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-Cw2kFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:56:17 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)) 09:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:56:17 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-QThcCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:56:17 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)) 09:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:56:17 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-TpBBXm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:56:17 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)) 09:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:56:17 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-Rn4YQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:56:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:56:17 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-bTBgkf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:56:17 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)) 09:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:56:17 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-57yOYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:56:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:56:18 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-14aRrt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:56:18 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)) 09:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:56:18 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-Lpn_PW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:56:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:56:18 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-dFqXWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:56:18 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)) 09:56:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:56:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:56:18 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)) 09:56:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:56:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:56:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:56:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:20 INFO - Downloading blessings-1.6.tar.gz 09:56:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:56:21 INFO - Installing collected packages: blessings 09:56:21 INFO - Running setup.py install for blessings 09:56:21 INFO - Successfully installed blessings 09:56:21 INFO - Cleaning up... 09:56:21 INFO - Return code: 0 09:56:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:56:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:56:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:56:21 INFO - Reading from file tmpfile_stdout 09:56:21 INFO - Current package versions: 09:56:21 INFO - blessings == 1.6 09:56:21 INFO - blobuploader == 1.2.4 09:56:21 INFO - docopt == 0.6.1 09:56:21 INFO - functools32 == 3.2.3-2 09:56:21 INFO - jsonschema == 2.5.1 09:56:21 INFO - manifestparser == 1.1 09:56:21 INFO - mozInstall == 1.12 09:56:21 INFO - mozcrash == 1.0 09:56:21 INFO - mozdebug == 0.1 09:56:21 INFO - mozdevice == 0.49 09:56:21 INFO - mozfile == 1.2 09:56:21 INFO - mozhttpd == 0.7 09:56:21 INFO - mozinfo == 0.9 09:56:21 INFO - mozleak == 0.1 09:56:21 INFO - mozlog == 3.4 09:56:21 INFO - moznetwork == 0.27 09:56:21 INFO - mozprocess == 0.25 09:56:21 INFO - mozprofile == 0.28 09:56:21 INFO - mozrunner == 6.13 09:56:21 INFO - mozscreenshot == 0.1 09:56:21 INFO - mozsystemmonitor == 0.3 09:56:21 INFO - moztest == 0.8 09:56:21 INFO - mozversion == 1.4 09:56:21 INFO - psutil == 3.1.1 09:56:21 INFO - requests == 1.2.3 09:56:21 INFO - wsgiref == 0.1.2 09:56:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:56:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:21 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 0x101af2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101af5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5fbd9b0a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1018d0d30>, '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 0x1017f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1018c5be8>, '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.gwr8oTWkoi/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.Rjfwxuyqbb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 09:56:21 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 09:56:21 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 09:56:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gwr8oTWkoi/Render', 09:56:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:56:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:56:21 INFO - 'HOME': '/Users/cltbld', 09:56:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:56:21 INFO - 'LOGNAME': 'cltbld', 09:56:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:21 INFO - 'MOZ_NO_REMOTE': '1', 09:56:21 INFO - 'NO_EM_RESTART': '1', 09:56:21 INFO - 'PAGER': '/bin/cat', 09:56:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:56:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:21 INFO - 'PWD': '/builds/slave/test', 09:56:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:56:21 INFO - 'SHELL': '/bin/bash', 09:56:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Rjfwxuyqbb/Listeners', 09:56:21 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 09:56:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:56:21 INFO - 'USER': 'cltbld', 09:56:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:56:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:56:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:21 INFO - 'XPC_FLAGS': '0x0', 09:56:21 INFO - 'XPC_SERVICE_NAME': '0', 09:56:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:56:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:21 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)) 09:56:21 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)) 09:56:21 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)) 09:56:21 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)) 09:56:21 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)) 09:56:21 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)) 09:56:21 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)) 09:56:21 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)) 09:56:21 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)) 09:56:21 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)) 09:56:21 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)) 09:56:21 INFO - Cleaning up... 09:56:21 INFO - Return code: 0 09:56:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:56:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:56:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101af2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101af5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5fbd9b0a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1018d0d30>, '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 0x1017f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1018c5be8>, '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.gwr8oTWkoi/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.Rjfwxuyqbb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 09:56:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:56:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:56:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gwr8oTWkoi/Render', 09:56:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:56:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:56:21 INFO - 'HOME': '/Users/cltbld', 09:56:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:56:21 INFO - 'LOGNAME': 'cltbld', 09:56:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:21 INFO - 'MOZ_NO_REMOTE': '1', 09:56:21 INFO - 'NO_EM_RESTART': '1', 09:56:21 INFO - 'PAGER': '/bin/cat', 09:56:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:56:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:21 INFO - 'PWD': '/builds/slave/test', 09:56:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:56:21 INFO - 'SHELL': '/bin/bash', 09:56:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Rjfwxuyqbb/Listeners', 09:56:21 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 09:56:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:56:21 INFO - 'USER': 'cltbld', 09:56:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:56:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:56:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:21 INFO - 'XPC_FLAGS': '0x0', 09:56:21 INFO - 'XPC_SERVICE_NAME': '0', 09:56:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:56:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:56:22 INFO - Cleaning up... 09:56:22 INFO - Return code: 0 09:56:22 INFO - Running post-action listener: _resource_record_post_action 09:56:22 INFO - Running post-action listener: _start_resource_monitoring 09:56:22 INFO - Starting resource monitoring. 09:56:22 INFO - [mozharness: 2017-04-04 16:56:22.162032Z] Finished create-virtualenv step (success) 09:56:22 INFO - [mozharness: 2017-04-04 16:56:22.163070Z] Running install step. 09:56:22 INFO - Running pre-action listener: _resource_record_pre_action 09:56:22 INFO - Running main action method: install 09:56:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:56:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:56:22 INFO - Reading from file tmpfile_stdout 09:56:22 INFO - Detecting whether we're running mozinstall >=1.0... 09:56:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:56:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:56:22 INFO - Reading from file tmpfile_stdout 09:56:22 INFO - Output received: 09:56:22 INFO - Usage: mozinstall [options] installer 09:56:22 INFO - Options: 09:56:22 INFO - -h, --help show this help message and exit 09:56:22 INFO - -d DEST, --destination=DEST 09:56:22 INFO - Directory to install application into. [default: 09:56:22 INFO - "/builds/slave/test"] 09:56:22 INFO - --app=APP Application being installed. [default: firefox] 09:56:22 INFO - mkdir: /builds/slave/test/build/application 09:56:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:56:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 09:56:42 INFO - Reading from file tmpfile_stdout 09:56:42 INFO - Output received: 09:56:42 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 09:56:42 INFO - Running post-action listener: _resource_record_post_action 09:56:42 INFO - [mozharness: 2017-04-04 16:56:42.516254Z] Finished install step (success) 09:56:42 INFO - [mozharness: 2017-04-04 16:56:42.516386Z] Running run-tests step. 09:56:42 INFO - Running pre-action listener: _resource_record_pre_action 09:56:42 INFO - Running main action method: run_tests 09:56:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:56:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:56:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:56:42 INFO - 2017-04-04 09:56:42.531 screenresolution[1622:7354] starting screenresolution argv=screenresolution get 09:56:42 INFO - 2017-04-04 09:56:42.533 screenresolution[1622:7354] Display 0: 1600x1200x32@60 09:56:42 INFO - 2017-04-04 09:56:42.539 screenresolution[1623:7356] starting screenresolution argv=screenresolution list 09:56:42 INFO - Available Modes on Display 0 09:56:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:56:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:56:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:56:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:56:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:56:42 INFO - Intel Iris: 09:56:42 INFO - Chipset Model: Intel Iris 09:56:42 INFO - Type: GPU 09:56:42 INFO - Bus: Built-In 09:56:42 INFO - VRAM (Dynamic, Max): 1536 MB 09:56:42 INFO - Vendor: Intel (0x8086) 09:56:42 INFO - Device ID: 0x0a2e 09:56:42 INFO - Revision ID: 0x0009 09:56:42 INFO - Displays: 09:56:42 INFO - Display: 09:56:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:56:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:56:42 INFO - Display Serial Number: 1600x1200 60 09:56:42 INFO - Main Display: Yes 09:56:42 INFO - Mirror: Off 09:56:42 INFO - Online: Yes 09:56:42 INFO - Rotation: Supported 09:56:42 INFO - Return code: 0 09:56:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:56:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:56:42 INFO - Python 2.7.3 09:56:42 INFO - Return code: 0 09:56:42 INFO - grabbing minidump binary from tooltool 09:56: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')]} 09:56:42 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 0x1018d0d30>, '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 0x1017f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1018c5be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:56:42 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 09:56:42 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 09:56:42 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 09:56:42 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:56:42 INFO - Return code: 0 09:56:42 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:56:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:56:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:56:42 INFO - ENV: RUST_BACKTRACE is now 1 09:56:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:56:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:56:42 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/ey7VVxidSbSCracC4NkSug/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0029', '--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 09:56:42 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/ey7VVxidSbSCracC4NkSug/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0029 --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 09:56:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gwr8oTWkoi/Render', 09:56:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:56:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:56:42 INFO - 'HOME': '/Users/cltbld', 09:56:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:56:42 INFO - 'LOGNAME': 'cltbld', 09:56:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:56:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:56:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:42 INFO - 'MOZ_NO_REMOTE': '1', 09:56:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:56:42 INFO - 'NO_EM_RESTART': '1', 09:56:42 INFO - 'PAGER': '/bin/cat', 09:56:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:56:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:42 INFO - 'PWD': '/builds/slave/test', 09:56:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:56:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:56:42 INFO - 'RUST_BACKTRACE': '1', 09:56:42 INFO - 'SHELL': '/bin/bash', 09:56:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Rjfwxuyqbb/Listeners', 09:56:42 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 09:56:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:56:42 INFO - 'USER': 'cltbld', 09:56:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:56:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:56:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:42 INFO - 'XPC_FLAGS': '0x0', 09:56:42 INFO - 'XPC_SERVICE_NAME': '0', 09:56:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:56:42 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/ey7VVxidSbSCracC4NkSug/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0029', '--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 09:56:43 INFO - mozversion application_buildid: 20170404090927 09:56:43 INFO - mozversion application_changeset: 17f121d897d225a7defa54445dd8bd3000604046 09:56:43 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:56:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:56:43 INFO - mozversion application_name: Firefox 09:56:43 INFO - mozversion application_remotingname: firefox-dev 09:56:43 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:56:43 INFO - mozversion application_vendor: Mozilla 09:56:43 INFO - mozversion application_version: 54.0a2 09:56:43 INFO - mozversion platform_buildid: 20170404090927 09:56:43 INFO - mozversion platform_changeset: 17f121d897d225a7defa54445dd8bd3000604046 09:56:43 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:56:43 INFO - mozversion platform_version: 54.0a2 09:56:43 INFO - using testdate: 1491325003 09:56:43 INFO - actual date: 1491325003 09:56:43 INFO - starting webserver on 'localhost:49239' 09:56:43 INFO - SUITE-START | Running 2 tests 09:56:43 INFO - TEST-START | dromaeo_css 09:56:43 INFO - operating with platform_type : mac_ 09:56:43 INFO - Initialising browser for dromaeo_css test... 09:56:43 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/tmpHubbps/profile http://localhost:49239/getInfo.html) 09:56:45 INFO - PROCESS | 1633 | __metrics Screen width/height:1600/1200 09:56:45 INFO - PROCESS | 1633 | colorDepth:24 09:56:45 INFO - PROCESS | 1633 | Browser inner width/height: 1024/689 09:56:45 INFO - PROCESS | 1633 | __metrics 09:56:45 INFO - PROCESS | 1633 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:56:45 INFO - PROCESS | 1633 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:56:46 INFO - TEST-INFO | 1633: exit 0 09:56:46 INFO - Browser initialized. 09:56:46 INFO - Running cycle 1/1 for dromaeo_css test... 09:56:46 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/tmpHubbps/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:56:58 INFO - PROCESS | 1635 | RSS: Main: 214859776 09:56:58 INFO - PROCESS | 1635 | 10:00:02 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49239/tests/dromaeo/cssquery-ext.html) 10:00:05 INFO - PROCESS | 1635 | RSS: Main: 402198528 10:00:05 INFO - PROCESS | 1635 | 10:01:48 INFO - PROCESS | 1635 | ************************* 10:01:48 INFO - PROCESS | 1635 | A coding exception was thrown and uncaught in a Task. 10:01:48 INFO - PROCESS | 1635 | 10:01:48 ERROR - PROCESS | 1635 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:01:48 INFO - PROCESS | 1635 | Full stack: 10:01:48 INFO - PROCESS | 1635 | ************************* 10:03:08 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-ext.html (next: http://localhost:49239/tests/dromaeo/cssquery-jquery.html) 10:03:08 INFO - PROCESS | 1635 | RSS: Main: 350081024 10:03:08 INFO - PROCESS | 1635 | 10:06:11 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49239/tests/dromaeo/cssquery-mootools.html) 10:06:12 INFO - PROCESS | 1635 | RSS: Main: 332476416 10:06:12 INFO - PROCESS | 1635 | 10:09:14 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49239/tests/dromaeo/cssquery-prototype.html) 10:09:15 INFO - PROCESS | 1635 | RSS: Main: 332881920 10:09:15 INFO - PROCESS | 1635 | 10:12:18 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49239/tests/dromaeo/cssquery-yui.html) 10:12:19 INFO - PROCESS | 1635 | RSS: Main: 320405504 10:12:19 INFO - PROCESS | 1635 | 10:15:22 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-yui.html (next: http://localhost:49239/tests/dromaeo/cssquery-dojo.html) 10:15:22 INFO - PROCESS | 1635 | RSS: Main: 531361792 10:15:22 INFO - PROCESS | 1635 | 10:15:22 INFO - PROCESS | 1635 | __start_tp_report 10:15:22 INFO - PROCESS | 1635 | _x_x_mozilla_page_load 10:15:22 INFO - PROCESS | 1635 | _x_x_mozilla_page_load_details 10:15:22 INFO - PROCESS | 1635 | |i|pagename|runs| 10:15:22 INFO - PROCESS | 1635 | |0;dojo.html;2946.7642588592917;3400.880969166079;3430.416829139048;3452.5671846183836;3471.75697701161;5976.641401515912;5979.521638268939;6013.248343957;6020.006698894677;6034.668093254869;5515.200295957084;5925.229720136376;5992.760289588422;6000.639961602296;6008.579399442041;5338.893222135555;5357.571394288448;5407.188921661763;5424.728763561826;5456.563474921997;4339.631131353839;5291.761870715827;5350.384705758829;5471.987682278771;5530.253415788878;5368.731563421833;5385.569154467653;5385.892282154355;5399.082156033464;5403.2705584745945;4458.955410445887;5364.91952620711;5386.2997810284805;5391.730413479349;5393.19102134679;5219.686818790885;5341.813036543703;5349.331333583302;5353.0899747043095;5379.38137114233;5940.495057920082;5963;5979.312379076375;5983.850403739898;5986.341502434729;6255.87488250237;6298.212723409574;6305.968470157666;6318.4945204384;6323.494120470351;6380.904286435707;6390.6485143317095;6392.4886009119155;6394.264659564164;6399.26408463028;4728.40894888139;6058.3032951210735;6060.090986352038;6074.696265186767;6078.240219972504;6265.96867015662;6288.371162883675;6486.454141547104;6520.119783829217;6532.640704761284;6233.096201050913;6270.561060725797;6277.18396608438;6292.748290068437;6296.370362963758;5316.308879845673;6370.58591191571;6374.681265936777;6391.328910464427;6392.520560957947;6301.747930082745;6311.684415779193;6330.272018717815;6330.778422755181;6337.493000559944;5543.863507980855;5612.887742245132;6068.150458935753;6238.750449982041;6264.310925798159;5091.363579552556;5134.845954621367;5149.098907691139;5174.767135478913;5189.273501709764;4533.002739397327;4551.180787458289;4566.315052742115;4575.081911620248;4604.37840891482;5829.329627092939;5868.530517558585;6043.607165534227;6092.664903430354;6111.755529778848;6300.3699630037545;6346.048092786119;6380.106785050097;6398.104265402847;6398.9040164397575;6087.225302117827;6087.482563982111;6092.177556029879;6095.99416096348;6117.449429551361;5650.660960342392;5670.291213598301;5671.404502527258;5673.8297851064535;5684.403137670568;6219.595726277777;6356.555041147075;6401.93598064032;6412.39082287182;6422.165118534561;5258.342707161605;6268.498520118471;6270.341614130451;6271.43557079865;6271.62370257786;6480;6565.573237739532;6581.177352830896;6595.1096601958125;6621.172353455818;6292.119103325446;6315.242170939333;6316.526260530387;6327.588706734047;6331.715072821642;6223.066540019034;6342.841428964312;6380.87238255223;6391.648459334781;6394.26465956421;6132.601380910227;6185.969070154621;6210.4100110489435;6241.875162496815;6259.2488901332135;6240.968795155995;6297.905531416941;6299.842503937438;6309.211348581427;6309.432151106423;6247.656378899204;6248.5313601479165;6254.28075771274;6259.1550140730415;6267.843303917439;6133.877322453615;6170.660613666291;6197.597156184834;6235.875282494416;6274.749010039547;6195.16365290698;6195.690215489118;6240.563160578898;6241.500679945502;6254.687265636791 10:15:22 INFO - PROCESS | 1635 | |1;ext.html;715.8961950517174;805.8348038652077;856.17379229044;876.8553188723861;877.5831480046978;38042.61957380429;38962;40306;40489.98775030626;40534.39198412026;39421.01447463815;39601.00997475065;39655.801720991425;39696;39711.60288397115;7246.202917679051;9036.63853445863;9199.494027828467;9207.171354578086;9209.861852072225;7201.4238860891;10777.676669699922;11002.064824489928;11042.447877606128;11063.502142403611;10855.837162442569;10883.1837612179;10893.782124357507;10901.1279097672;10985.61550345738;7181.712731490734;10844.891551084467;10864.022237998579;10875.293105948089;10878.510467029002;6332.778352757631;7293.63531823412;7338.22948590401;7344.30229128232;10512;37216.62783372186;37248;37253.627463725286;37400.43899341512;37403.438948415795;3673.3571624965793;3729.776213427203;3732.4401339798974;3744.307303148926;3755.680767134797;26281.554514501695;26678.73321266782;26894;27599.172024839085;28561.857525698946;3007.7142671446177;3034.605501284841;3069.6623371429123;3216.115568218735;3218.1311046017445;347050;347276.79084814;347859;348058;350971;51259;51510.22734658983;51555;51564.48435515597;51696.741516292175;53149.7342513285;53265;53316.733416333445;53321.73339133357;53337.66655833635;14044.36800343987;14359;14362.066465679698;14370.640733981734;14386;12558.623241302776;12559.058070644738;12588.622341329774;12590.559330423392;12599.559015434415;9324.741159943322;9596.424214547149;11008.339499630049;11537.48081336342;11629.651110466699;4910.435299940481;5431.918521222185;5606.6916319602;5628.774849005994;5642.548596112301;932.1191474056951;945.7210123013728;948.6489998700387;966.5360626899128;970.2335155227432;25600.615990760154;26747.86626066896;28294;28977.42045159085;29072.854635726686;816.1267443835039;843.2115971566483;903.4353529044347;992.4045572656348;1057.9788404231872;12837.358132093357;12879.935600321938;12886.677833054062;13017.810140825619;13100.017498687446;408324;411012;412987;413767.9311603423;414198;44213.336799948025;44250.893727657065;44333.778331108784;44334;44422.111557768665;1223.431104536377;1246.4141853328922;1373.9931300343635;1418.2058047493438;1434.1610158057445;20740;25691.100811471508;26599.468010640066;27152.456950861266;27190.456190876466;42305.5769442314;42465.5753442474;42541;42568;42601.57398425976;457543;458096.7095164636;461103;461142;461903;27186.592201116604;27527;27765.44469110647;27790.86104569464;27884.30289242785;35861.38623761989;36233;36619.08452288714;36721;36853.63146368502;25080.37299067538;26221.606675899497;26725.19824405271;26951.595726063733;27137.321566960985;23081.422964426023;25885.46607419212;25967.961281549284;27039.72960270451;27101.457970840867;30155;30273.24316892095;30664.77340906428;30683.926062587703;30914.381712365175;27383.356998580148;27968.86015569909;28329.43341133207;28676.856615716788;29406.55890161692;18059.18733657015;21555;21990.90045497687;22065.889670551544;22492.100315987176 10:15:22 INFO - PROCESS | 1635 | |2;jquery.html;385.54890777789984;394.9763014219147;405.65316654260624;421.39319380092667;447.92385294499934;12321.38393080347;20991.950402479873;21002.684959725615;21743.347699569;21997.900104994766;21040.789592104073;21461.785382146172;22028.77971220287;22050.558988820216;22139.667904981437;5886.705664716768;6610.471162307016;6646.069550262967;6776.42400395967;6837.897431538531;6601.63690996995;6813.250542440328;6813.557118787263;6822.113125293729;6858.211305699833;6511.186101737283;6642.634655093968;6713.194416670007;6714.56355336904;6810.62541560214;6699;6753.358430949052;6759.4453275746855;6777.491688123361;7024.683889224997;7232.710691572331;7307.3423391894985;7312.5246858954;7315;7323.890141647879;25110.49779004428;25546.36134096644;25603.61594576083;25659.1019314325;25857.612135817977;2872.5978363029194;2887.4946884295164;2922.3072102808055;2926.634170728659;2932.8533573321247;15828.129452880086;15862.048277103295;16159.676806463922;16288.75566866486;16554.006759594464;1907.246637578149;1950.590376021023;1968.163530499532;1980.9108590113335;1984.9503762406055;160531;164313;168636.99999999878;171687;173090;14368.568942931728;19515.51211219731;19577.608447830964;19759.40721778349;20013.49831271091;20201.595968080557;27194.864025679744;27217.31956701059;29977;30876.91930782412;9800.31397802147;10119.494025298705;10337.793244135075;10355.275130740927;10456.006679365448;7068.3285087916565;7424.628768561551;7515.173330933702;8182.427230093956;8518.148185181431;9167;9222.631094756134;9227.231830450837;9346.53267336644;9392.436453812794;3881.941770873439;3962.484876965976;3969.4839670843185;3971.815501474178;3988.6011398860464;879.6877108626474;892.6563273139888;896.121800635381;928.972130836076;934.9719508414759;21138.260160894293;21510.13959441636;21565.892170539362;21684;21685;912.0879120879121;931.9068093190763;931.9813603728023;944.3578366710702;949.240607513986;8060.758177254692;11123.943225393736;11138.777224455465;11168.93895079966;11388.715282117848;705010;709146;720549;723517;737535;146730;149816.2509187447;153880;154813;162381.18809405877;1164.8991702840904;1167.626359564948;1194.689380760991;1215.8358621586149;1257.8050402187675;19019.524511887314;19593.8040619592;19598.314059007866;19692.21231150738;19707.901460492605;45282;57025;62126.68936655288;62729.05906411499;63863.68068159629;83513.58243208745;83519.16480835114;85378.57310713407;86414.56792715997;86575.1342486567;9339.626414943326;9900.405975641484;10373.740656483647;11213;11423;12487.31319777421;12601.621951341474;12642.873571264538;12706.618801435972;12759.106862519535;9349.345545812;10627.840582391116;11039.344098384985;11121.110311174925;11128.777424451628;8951.507667078113;9276.16514513697;9946;10036.799264014824;10215.336003159771;9743.9025609743;10333.449982502385;10624.512568240607;11043.116550675766;11273.210875238654;11075.390853503135;11211.495482703462;11227.887721122685;11499.54001839917;11539.249948753304;10638.946805265925;10843.728906777395;10844.511996959998;11004.724881878017;11241.943790281324 10:15:22 INFO - PROCESS | 1635 | |3;mootools.html;1541.3372249932531;1567.5062355358054;1572.8269890312072;1587.214328907191;1592.577966838788;9723.222142228613;10170.237232207586;10174.694759157219;10195.082442580166;10201.897981020187;9998.900010999887;10721.088707459856;11017.889821101786;11119.5552177913;11144.164187685916;2302.067662596651;2338.8830558472096;2342.1334106380577;2353.52929414117;2355.4817940053163;2199.4281486813384;2256.706628138348;2306.8269879759;2313.8033267172227;2316.6061769499142;2279.9886000569973;2287.1651847075864;2311.653252012195;2326.6510023496444;2332.137109269564;2253.5830871288863;2290.942726431836;2295.0360848443693;2297.6558713152826;2306.850054746436;2280.224723593986;2280.293109136173;2281.167373908528;2286.897089630954;2291.6104262275453;10978.945105274503;11048.502817373157;11052.944735276273;11065.889341106566;11066.336019838835;5388.488093631099;5498.230247765316;5537.750801213955;5547.611667183299;5549.139883318092;3130.8434578270994;3248.788828726149;3365.444701624229;3378.864845406181;3379;1041.578160844859;1062.4262898035129;1104.1553211792984;1150.5627861412693;1168.5617893290016;13565;13886.513972010931;14139.434422623082;15068.246587670683;15470.613234669223;4367.5632436756705;4483.7533935633855;4510.345999830006;4528.637708983273;4538.568835960578;11793.88206117945;11795.997340226006;11806;11814.291142531476;11817.350045747395;4400.4939431965095;4728.267118596623;4888.486708895586;5490.478404551562;5505.394406615269;5002.899942001212;5109.233614957711;5127.512886275797;5141.280220769096;5151.356080489939;3614.7469677122876;3641.5266015417824;3686.0416291764336;3694.371956767356;3707.6663100321102;941.3457646935451;963.2775418436173;970.7281961050917;975.7219192530094;977.4330888084894;887.245841035115;915.8351496730519;921.488573841511;922.928026580318;945.9621615135455;6510.18622672166;6574.112494813139;6577.769778057841;6631;6638.634875081917;958.726762872578;973.5083782689696;979.5062529642353;1002.8946960569181;1033.963811266617;3873.2640798248244;4039.6566291864933;4190.308599081118;4230.915381692349;4388.605025547652;13189;13717.382717777724;13742.519011834738;13744.725105498033;13838;13173.209607423585;13299.26854023038;13659.521916732867;13663.863361366459;13681.863181368259;10089.596416143271;10129.797404051878;10162.54268557902;10318.535665895202;10318.948405257926;6527.902081468686;6541.934580654323;6554.868902622016;6637.1703537057865;6674.232463266787;12181.69545761363;12548.309842958724;12698;12713.93643031779;12715.237085774883;11390;11426.885731142582;12586.874131258937;12591.748165036464;12638.936805315914;8446.95776521138;8688.39181257306;8713.085126061673;8717.346199034972;8727.432716873383;10147.289689721649;10332.17342612574;10451.216158788273;10465.895341046797;10478.266521343432;8769.298456123623;8837.160469755363;8903.955480222558;8915.598798054232;9092.954310254141;8651.394402391772;8651.95674021626;8689.261412779984;8759.824803504021;8788.42875213109;6626.83432914181;7747.72882949094;7913.604319783873;7922.009748781403;7925.454536365353;5793.536517078539;5830.650160990354;5879.176915231957;5998.070299103646;6079.635221886701;5503.669779813224;5805.535557155502;5884.264466941632;6030.7286172121485;6062.969685151546 10:15:22 INFO - PROCESS | 1635 | |4;prototype.html;366.14322485384196;370.2354637673205;380.8381437888896;383.2316206006956;384.4598339333237;4377.978110109449;4990.005996402166;5039.319691841601;5170.870728231796;5206.8698282542955;3682.871099511511;4247.214265360911;4294.613484786369;4570.931436028454;4767.043354016167;4329.242382583051;4338.739675619465;4339.349097635364;4343.2399330117105;4392.780360981954;3938.645521903028;4365.912681746363;4423.88940276494;4433.69206084206;4476.171908196994;3301.8679252829857;4112.97943510282;4114.526829414611;4116.814743336557;4209.284421648327;4084.836606535735;4126.66986641068;4131.628153466202;4155.096985557041;4192.748435093874;3863.285292220948;3877.1276462795927;3886;3895.5325360956585;3910.530736311632;4112.588741125864;4263.381809637616;4457.554244575549;4464.776761161929;4878.536539028786;4708.281477260809;4811.206150985084;4822.469528351879;4829.855104346875;4855.44162421319;4527.7736113194205;5333.893322133575;5337.733113344318;5359.651622644555;5394.6493477924205;3422.5379573757723;3465.324261768956;4186.769727664977;4268.9573104268875;4314.546972567867;5539.750711218005;5612.326520817528;5643.335216111257;5660.575456840754;5684.8010319638615;3783.319002579562;3793.7534060285993;3935.1736135411884;4083.1629515949157;4409.338599210144;3917.373220284741;4085.958080689405;4452.844150454718;4507.684462087623;4547;4072.6334629883454;4734.242521196592;4738.8341408050555;4846.843154796082;4847.5394837490385;4583.012778882327;5098.770555325019;5186.714730689849;5387.865303367369;5402.648827826179;1327.707904261061;1414.8893118901613;1423.8789702875165;1434.5266062199448;1438.3671184678917;1077.7413420779114;1123.6909849791373;1146.8245048825022;1153.6366044695894;1164.7828019719414;4530.388397566352;4613.400257966443;4956.677815941952;4994.750262486861;5027.271045698353;4771.475137734847;4893.437254715682;5255.816046438356;5370.677759334374;5573.893286060305;4698.248280275208;5054.9241761373605;5076.543111119943;5083.331251093132;5094.420729573844;2416.6979127609047;2417;2848.5442329227226;2891.8120322178993;2892.681805001448;5255.605829562798;5411.945880541144;5428.321459817523;5628.915566266509;5784.21913041734;4884.926726099111;5245.370555533361;5611.839441814931;5658.377578466366;5676.233708449389;4781.378420805412;5222.817201398009;5325.988062268234;5623.044082505984;5664.490195882308;4076.571959944163;5309;5421.5933804964;5449.945500545103;5540.806071787468;5235.188545775411;5470.753816078366;5519.420460851713;5530.626317945969;5544.556435485071;4740.771837236493;5403.945960540502;5596.804111856066;5724.971375143097;5855.707214639337;3482.164280572695;3993.181397813499;4177.968260628508;4273;4413.933790993074;4866.610671146371;5034.395872495324;5122.8975420492125;5490.478404551562;5502.504774570308;4508.977455112704;4606.493285738633;4980.825671101494;5284.762185701729;5320.600954928474;4688.648351373592;4740.6207503398955;5253.395859476209;5334.226537152169;5356.758945847524;4644.628429725546;4935.407751069894;4991.5258050485145;5145.4340022598235;5157.008934817872;4772.5227477252;4787.640926930424;5286.62993590445;5306.575473961997;5399.757010934439;4271.636910862611;4366.563343665608;4709.80993837867;4981.854173540034;5137.023965446553 10:15:22 INFO - PROCESS | 1635 | |5;yui.html;728.5191773429538;758.480440897985;758.7420277105783;826.5660528222684;839.9538025408602;14867.330970106344;15572.45496407626;16153.919230403832;16157.838421615796;16178.35286588538;14315.570532884005;14554.345054472547;14738.926305368484;14748.926255368735;15188.31652575634;919.6459363145203;942.0391200975001;943.481085403029;946.1579194516886;947.739371672792;929.2705226397279;937.6343226141776;937.7889974755659;944.4710961861346;956.7942892278159;999.3154689037996;1003.7691330993875;1004.3873237325263;1006.5722068121056;1007.8639383683219;1001.5743309093606;1002.669119190669;1003.759097816526;1004.8342023566103;1005.0150852164846;742.8997085393456;743.6765007221876;744.4714252880461;745.1095940351282;745.1579714922158;15388.846111538853;15723.056616602926;15765.211739412984;16099.758503622455;16407.097609631466;13946.721065578631;13952.908932353308;14033.578992630237;14047.508337208148;14229;9629.470379129145;10065;11580.073594112451;11766.411679415995;11840.28958262507;3283.96716032839;3569.1969306906;3640.1809592841664;3670.687991520724;3679.4480827875764;81311.68194862432;90888;108822.91177088207;113424.43287783508;114896;8829.69096081634;10392.792144157074;10425.530851111718;10465.84301235482;10972.957569031088;20815.479613009495;21374.465638358855;21414.892925535583;21468.926553672252;21472.818994955116;7647.57938313387;7695.115061767969;7711.768646940601;7783.066032076187;7845.254700803414;3391.6269210386836;4164.479440069991;4201.138766552849;4237.809298581571;4340.435743353344;3247.350529894031;3323.1692076980753;3339.19859233787;3341.498775183742;3348.4977253412185;581.354696287121;588.8969430349672;590.8818236352661;596.3976383852254;602.9487493563096;545.0402823487367;579.2874764040254;670.9329067093349;676.9390754832089;693.9375456208865;10066.396016239049;10121.392716437038;10391.37651740898;10426;10588.523516441779;511.7462217566976;548.8847342058133;558.9972050139804;604.9848753781191;693.4694958356861;4481.2381895077915;4916.434610019822;4985.775640096204;5044.0920634286185;5084.288199652052;86616.56691716627;89120;94433.97311228623;96819.51590242004;104471;82494.17505824864;84575;85565.57217213874;86687;88416.55791721;76130;78946.28956538759;80199;81687;81858.77211841827;10484.895151048391;10971.396573188551;11104.167187461135;11197.776044479227;11255.155863310121;48433;49241.26138108003;49255.753721231165;50312.4906252813;50391.49608503868;43340.39957602554;62606;64111.71776564536;64802;65440.672796635714;12276.263424194576;12280.631581052583;12303.630891073282;12505.687357816127;12763.48946042185;11600.593979210687;12167.878321216675;12214.26714397139;12588.181768185405;14591.854081459049;11538.653840384803;11680.123990700562;12052.276863388224;12170.330631815335;12326;11579.30524168519;11893.821592675944;11986.940065299617;12210;12437.875621243671;11396.430178491208;11909.940450297692;11916.52333906634;11968.640940771791;12201.20692155007;8414.579271036546;8500.659973600987;8873.334499912662;8880.689175878813;9036.683716069905;8248;9244.550194198408;9931.702048938254;9963.750906227402;9966.900330996597 10:15:22 INFO - PROCESS | 1635 | __end_tp_report 10:15:22 INFO - PROCESS | 1635 | __start_cc_report 10:15:22 INFO - PROCESS | 1635 | _x_x_mozilla_cycle_collect,2037 10:15:22 INFO - PROCESS | 1635 | __end_cc_report 10:15:22 INFO - PROCESS | 1635 | __startTimestamp1491326122791__endTimestamp 10:15:22 INFO - PROCESS | 1635 | 10:15:22 INFO - PROCESS | 1635 | ------- Summary: start ------- 10:15:22 INFO - PROCESS | 1635 | Number of tests: 6 10:15:22 INFO - PROCESS | 1635 | 10:15:22 INFO - PROCESS | 1635 | [#0] dojo.html Cycles:165 Average:5879.19 Median:6170.66 stddev:674.76 (10.9%) stddev-sans-first:636.41 10:15:22 INFO - PROCESS | 1635 | Values: 2946.8 3400.9 3430.4 3452.6 3471.8 5976.6 5979.5 6013.2 6020.0 6034.7 5515.2 5925.2 5992.8 6000.6 6008.6 5338.9 5357.6 5407.2 5424.7 5456.6 4339.6 5291.8 5350.4 5472.0 5530.3 5368.7 5385.6 5385.9 5399.1 5403.3 4459.0 5364.9 5386.3 5391.7 5393.2 5219.7 5341.8 5349.3 5353.1 5379.4 5940.5 5963.0 5979.3 5983.9 5986.3 6255.9 6298.2 6306.0 6318.5 6323.5 6380.9 6390.6 6392.5 6394.3 6399.3 4728.4 6058.3 6060.1 6074.7 6078.2 6266.0 6288.4 6486.5 6520.1 6532.6 6233.1 6270.6 6277.2 6292.7 6296.4 5316.3 6370.6 6374.7 6391.3 6392.5 6301.7 6311.7 6330.3 6330.8 6337.5 5543.9 5612.9 6068.2 6238.8 6264.3 5091.4 5134.8 5149.1 5174.8 5189.3 4533.0 4551.2 4566.3 4575.1 4604.4 5829.3 5868.5 6043.6 6092.7 6111.8 6300.4 6346.0 6380.1 6398.1 6398.9 6087.2 6087.5 6092.2 6096.0 6117.4 5650.7 5670.3 5671.4 5673.8 5684.4 6219.6 6356.6 6401.9 6412.4 6422.2 5258.3 6268.5 6270.3 6271.4 6271.6 6480.0 6565.6 6581.2 6595.1 6621.2 6292.1 6315.2 6316.5 6327.6 6331.7 6223.1 6342.8 6380.9 6391.6 6394.3 6132.6 6186.0 6210.4 6241.9 6259.2 6241.0 6297.9 6299.8 6309.2 6309.4 6247.7 6248.5 6254.3 6259.2 6267.8 6133.9 6170.7 6197.6 6235.9 6274.7 6195.2 6195.7 6240.6 6241.5 6254.7 10:15:22 INFO - PROCESS | 1635 | 10:15:22 INFO - PROCESS | 1635 | [#1] ext.html Cycles:180 Average:53329.98 Median:347958.50 stddev:108704.33 (31.2%) stddev-sans-first:108937.50 10:15:22 INFO - PROCESS | 1635 | Values: 715.9 805.8 856.2 876.9 877.6 38042.6 38962.0 40306.0 40490.0 40534.4 39421.0 39601.0 39655.8 39696.0 39711.6 7246.2 9036.6 9199.5 9207.2 9209.9 7201.4 10777.7 11002.1 11042.4 11063.5 10855.8 10883.2 10893.8 10901.1 10985.6 7181.7 10844.9 10864.0 10875.3 10878.5 6332.8 7293.6 7338.2 7344.3 10512.0 37216.6 37248.0 37253.6 37400.4 37403.4 3673.4 3729.8 3732.4 3744.3 3755.7 26281.6 26678.7 26894.0 27599.2 28561.9 3007.7 3034.6 3069.7 3216.1 3218.1 347050.0 347276.8 347859.0 348058.0 350971.0 51259.0 51510.2 51555.0 51564.5 51696.7 53149.7 53265.0 53316.7 53321.7 53337.7 14044.4 14359.0 14362.1 14370.6 14386.0 12558.6 12559.1 12588.6 12590.6 12599.6 9324.7 9596.4 11008.3 11537.5 11629.7 4910.4 5431.9 5606.7 5628.8 5642.5 932.1 945.7 948.6 966.5 970.2 25600.6 26747.9 28294.0 28977.4 29072.9 816.1 843.2 903.4 992.4 1058.0 12837.4 12879.9 12886.7 13017.8 13100.0 408324.0 411012.0 412987.0 413767.9 414198.0 44213.3 44250.9 44333.8 44334.0 44422.1 1223.4 1246.4 1374.0 1418.2 1434.2 20740.0 25691.1 26599.5 27152.5 27190.5 42305.6 42465.6 42541.0 42568.0 42601.6 457543.0 458096.7 461103.0 461142.0 461903.0 27186.6 27527.0 27765.4 27790.9 27884.3 35861.4 36233.0 36619.1 36721.0 36853.6 25080.4 26221.6 26725.2 26951.6 27137.3 23081.4 25885.5 25968.0 27039.7 27101.5 30155.0 30273.2 30664.8 30683.9 30914.4 27383.4 27968.9 28329.4 28676.9 29406.6 18059.2 21555.0 21990.9 22065.9 22492.1 10:15:22 INFO - PROCESS | 1635 | 10:15:22 INFO - PROCESS | 1635 | [#2] jquery.html Cycles:180 Average:42052.44 Median:25758.36 stddev:120664.49 (468.4%) stddev-sans-first:120962.42 10:15:22 INFO - PROCESS | 1635 | Values: 385.5 395.0 405.7 421.4 447.9 12321.4 20992.0 21002.7 21743.3 21997.9 21040.8 21461.8 22028.8 22050.6 22139.7 5886.7 6610.5 6646.1 6776.4 6837.9 6601.6 6813.3 6813.6 6822.1 6858.2 6511.2 6642.6 6713.2 6714.6 6810.6 6699.0 6753.4 6759.4 6777.5 7024.7 7232.7 7307.3 7312.5 7315.0 7323.9 25110.5 25546.4 25603.6 25659.1 25857.6 2872.6 2887.5 2922.3 2926.6 2932.9 15828.1 15862.0 16159.7 16288.8 16554.0 1907.2 1950.6 1968.2 1980.9 1985.0 160531.0 164313.0 168637.0 171687.0 173090.0 14368.6 19515.5 19577.6 19759.4 20013.5 20201.6 27194.9 27217.3 29977.0 30876.9 9800.3 10119.5 10337.8 10355.3 10456.0 7068.3 7424.6 7515.2 8182.4 8518.1 9167.0 9222.6 9227.2 9346.5 9392.4 3881.9 3962.5 3969.5 3971.8 3988.6 879.7 892.7 896.1 929.0 935.0 21138.3 21510.1 21565.9 21684.0 21685.0 912.1 931.9 932.0 944.4 949.2 8060.8 11123.9 11138.8 11168.9 11388.7 705010.0 709146.0 720549.0 723517.0 737535.0 146730.0 149816.3 153880.0 154813.0 162381.2 1164.9 1167.6 1194.7 1215.8 1257.8 19019.5 19593.8 19598.3 19692.2 19707.9 45282.0 57025.0 62126.7 62729.1 63863.7 83513.6 83519.2 85378.6 86414.6 86575.1 9339.6 9900.4 10373.7 11213.0 11423.0 12487.3 12601.6 12642.9 12706.6 12759.1 9349.3 10627.8 11039.3 11121.1 11128.8 8951.5 9276.2 9946.0 10036.8 10215.3 9743.9 10333.4 10624.5 11043.1 11273.2 11075.4 11211.5 11227.9 11499.5 11539.2 10638.9 10843.7 10844.5 11004.7 11241.9 10:15:22 INFO - PROCESS | 1635 | 10:15:22 INFO - PROCESS | 1635 | [#3] mootools.html Cycles:180 Average:6602.60 Median:3189.82 stddev:4181.19 (131.1%) stddev-sans-first:4175.63 10:15:22 INFO - PROCESS | 1635 | Values: 1541.3 1567.5 1572.8 1587.2 1592.6 9723.2 10170.2 10174.7 10195.1 10201.9 9998.9 10721.1 11017.9 11119.6 11144.2 2302.1 2338.9 2342.1 2353.5 2355.5 2199.4 2256.7 2306.8 2313.8 2316.6 2280.0 2287.2 2311.7 2326.7 2332.1 2253.6 2290.9 2295.0 2297.7 2306.9 2280.2 2280.3 2281.2 2286.9 2291.6 10978.9 11048.5 11052.9 11065.9 11066.3 5388.5 5498.2 5537.8 5547.6 5549.1 3130.8 3248.8 3365.4 3378.9 3379.0 1041.6 1062.4 1104.2 1150.6 1168.6 13565.0 13886.5 14139.4 15068.2 15470.6 4367.6 4483.8 4510.3 4528.6 4538.6 11793.9 11796.0 11806.0 11814.3 11817.4 4400.5 4728.3 4888.5 5490.5 5505.4 5002.9 5109.2 5127.5 5141.3 5151.4 3614.7 3641.5 3686.0 3694.4 3707.7 941.3 963.3 970.7 975.7 977.4 887.2 915.8 921.5 922.9 946.0 6510.2 6574.1 6577.8 6631.0 6638.6 958.7 973.5 979.5 1002.9 1034.0 3873.3 4039.7 4190.3 4230.9 4388.6 13189.0 13717.4 13742.5 13744.7 13838.0 13173.2 13299.3 13659.5 13663.9 13681.9 10089.6 10129.8 10162.5 10318.5 10318.9 6527.9 6541.9 6554.9 6637.2 6674.2 12181.7 12548.3 12698.0 12713.9 12715.2 11390.0 11426.9 12586.9 12591.7 12638.9 8447.0 8688.4 8713.1 8717.3 8727.4 10147.3 10332.2 10451.2 10465.9 10478.3 8769.3 8837.2 8904.0 8915.6 9093.0 8651.4 8652.0 8689.3 8759.8 8788.4 6626.8 7747.7 7913.6 7922.0 7925.5 5793.5 5830.7 5879.2 5998.1 6079.6 5503.7 5805.5 5884.3 6030.7 6063.0 10:15:22 INFO - PROCESS | 1635 | 10:15:22 INFO - PROCESS | 1635 | [#4] prototype.html Cycles:180 Average:4417.13 Median:4739.73 stddev:1237.71 (26.1%) stddev-sans-first:1203.26 10:15:22 INFO - PROCESS | 1635 | Values: 366.1 370.2 380.8 383.2 384.5 4378.0 4990.0 5039.3 5170.9 5206.9 3682.9 4247.2 4294.6 4570.9 4767.0 4329.2 4338.7 4339.3 4343.2 4392.8 3938.6 4365.9 4423.9 4433.7 4476.2 3301.9 4113.0 4114.5 4116.8 4209.3 4084.8 4126.7 4131.6 4155.1 4192.7 3863.3 3877.1 3886.0 3895.5 3910.5 4112.6 4263.4 4457.6 4464.8 4878.5 4708.3 4811.2 4822.5 4829.9 4855.4 4527.8 5333.9 5337.7 5359.7 5394.6 3422.5 3465.3 4186.8 4269.0 4314.5 5539.8 5612.3 5643.3 5660.6 5684.8 3783.3 3793.8 3935.2 4083.2 4409.3 3917.4 4086.0 4452.8 4507.7 4547.0 4072.6 4734.2 4738.8 4846.8 4847.5 4583.0 5098.8 5186.7 5387.9 5402.6 1327.7 1414.9 1423.9 1434.5 1438.4 1077.7 1123.7 1146.8 1153.6 1164.8 4530.4 4613.4 4956.7 4994.8 5027.3 4771.5 4893.4 5255.8 5370.7 5573.9 4698.2 5054.9 5076.5 5083.3 5094.4 2416.7 2417.0 2848.5 2891.8 2892.7 5255.6 5411.9 5428.3 5628.9 5784.2 4884.9 5245.4 5611.8 5658.4 5676.2 4781.4 5222.8 5326.0 5623.0 5664.5 4076.6 5309.0 5421.6 5449.9 5540.8 5235.2 5470.8 5519.4 5530.6 5544.6 4740.8 5403.9 5596.8 5725.0 5855.7 3482.2 3993.2 4178.0 4273.0 4413.9 4866.6 5034.4 5122.9 5490.5 5502.5 4509.0 4606.5 4980.8 5284.8 5320.6 4688.6 4740.6 5253.4 5334.2 5356.8 4644.6 4935.4 4991.5 5145.4 5157.0 4772.5 4787.6 5286.6 5306.6 5399.8 4271.6 4366.6 4709.8 4981.9 5137.0 10:15:22 INFO - PROCESS | 1635 | 10:15:22 INFO - PROCESS | 1635 | [#5] yui.html Cycles:180 Average:19590.04 Median:3675.07 stddev:28143.40 (765.8%) stddev-sans-first:28186.71 10:15:22 INFO - PROCESS | 1635 | Values: 728.5 758.5 758.7 826.6 840.0 14867.3 15572.5 16153.9 16157.8 16178.4 14315.6 14554.3 14738.9 14748.9 15188.3 919.6 942.0 943.5 946.2 947.7 929.3 937.6 937.8 944.5 956.8 999.3 1003.8 1004.4 1006.6 1007.9 1001.6 1002.7 1003.8 1004.8 1005.0 742.9 743.7 744.5 745.1 745.2 15388.8 15723.1 15765.2 16099.8 16407.1 13946.7 13952.9 14033.6 14047.5 14229.0 9629.5 10065.0 11580.1 11766.4 11840.3 3284.0 3569.2 3640.2 3670.7 3679.4 81311.7 90888.0 108822.9 113424.4 114896.0 8829.7 10392.8 10425.5 10465.8 10973.0 20815.5 21374.5 21414.9 21468.9 21472.8 7647.6 7695.1 7711.8 7783.1 7845.3 3391.6 4164.5 4201.1 4237.8 4340.4 3247.4 3323.2 3339.2 3341.5 3348.5 581.4 588.9 590.9 596.4 602.9 545.0 579.3 670.9 676.9 693.9 10066.4 10121.4 10391.4 10426.0 10588.5 511.7 548.9 559.0 605.0 693.5 4481.2 4916.4 4985.8 5044.1 5084.3 86616.6 89120.0 94434.0 96819.5 104471.0 82494.2 84575.0 85565.6 86687.0 88416.6 76130.0 78946.3 80199.0 81687.0 81858.8 10484.9 10971.4 11104.2 11197.8 11255.2 48433.0 49241.3 49255.8 50312.5 50391.5 43340.4 62606.0 64111.7 64802.0 65440.7 12276.3 12280.6 12303.6 12505.7 12763.5 11600.6 12167.9 12214.3 12588.2 14591.9 11538.7 11680.1 12052.3 12170.3 12326.0 11579.3 11893.8 11986.9 12210.0 12437.9 11396.4 11909.9 11916.5 11968.6 12201.2 8414.6 8500.7 8873.3 8880.7 9036.7 8248.0 9244.6 9931.7 9963.8 9966.9 10:15:22 INFO - PROCESS | 1635 | -------- Summary: end -------- 10:15:22 INFO - PROCESS | 1635 | 10:15:23 INFO - TEST-INFO | 1635: exit 0 10:15:23 INFO - TEST-OK | dromaeo_css | took 1120348ms 10:15:23 INFO - TEST-START | kraken 10:15:23 INFO - operating with platform_type : mac_ 10:15:23 INFO - Initialising browser for kraken test... 10:15:23 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/tmp5L1div/profile http://localhost:49239/getInfo.html) 10:15:25 INFO - PROCESS | 1644 | __metrics Screen width/height:1600/1200 10:15:25 INFO - PROCESS | 1644 | colorDepth:24 10:15:25 INFO - PROCESS | 1644 | Browser inner width/height: 1024/689 10:15:25 INFO - PROCESS | 1644 | __metrics 10:15:25 INFO - PROCESS | 1644 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:15:25 INFO - PROCESS | 1644 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:15:26 INFO - TEST-INFO | 1644: exit 0 10:15:26 INFO - Browser initialized. 10:15:26 INFO - Running cycle 1/1 for kraken test... 10:15:26 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/tmp5L1div/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:15:38 INFO - PROCESS | 1645 | RSS: Main: 215752704 10:15:38 INFO - PROCESS | 1645 | 10:15:41 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49239/tests/kraken/driver.html?testName=audio-beat-detection) 10:15:42 INFO - PROCESS | 1645 | RSS: Main: 266395648 10:15:42 INFO - PROCESS | 1645 | 10:15:45 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49239/tests/kraken/driver.html?testName=audio-dft) 10:15:45 INFO - PROCESS | 1645 | RSS: Main: 280723456 10:15:45 INFO - PROCESS | 1645 | 10:15:48 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49239/tests/kraken/driver.html?testName=audio-fft) 10:15:49 INFO - PROCESS | 1645 | RSS: Main: 377102336 10:15:49 INFO - PROCESS | 1645 | 10:15:51 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49239/tests/kraken/driver.html?testName=audio-oscillator) 10:15:52 INFO - PROCESS | 1645 | RSS: Main: 279310336 10:15:52 INFO - PROCESS | 1645 | 10:15:54 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49239/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:15:54 INFO - PROCESS | 1645 | RSS: Main: 282177536 10:15:54 INFO - PROCESS | 1645 | 10:15:57 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49239/tests/kraken/driver.html?testName=imaging-darkroom) 10:15:58 INFO - PROCESS | 1645 | RSS: Main: 323559424 10:15:58 INFO - PROCESS | 1645 | 10:16:01 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49239/tests/kraken/driver.html?testName=imaging-desaturate) 10:16:02 INFO - PROCESS | 1645 | RSS: Main: 323174400 10:16:02 INFO - PROCESS | 1645 | 10:16:04 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49239/tests/kraken/driver.html?testName=json-parse-financial) 10:16:05 INFO - PROCESS | 1645 | RSS: Main: 318586880 10:16:05 INFO - PROCESS | 1645 | 10:16:07 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49239/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:16:07 INFO - PROCESS | 1645 | RSS: Main: 295354368 10:16:07 INFO - PROCESS | 1645 | 10:16:09 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:16:10 INFO - PROCESS | 1645 | RSS: Main: 300150784 10:16:10 INFO - PROCESS | 1645 | 10:16:12 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:16:13 INFO - PROCESS | 1645 | RSS: Main: 303943680 10:16:13 INFO - PROCESS | 1645 | 10:16:16 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:16:17 INFO - PROCESS | 1645 | RSS: Main: 320892928 10:16:17 INFO - PROCESS | 1645 | 10:16:20 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:16:20 INFO - PROCESS | 1645 | RSS: Main: 314265600 10:16:20 INFO - PROCESS | 1645 | 10:16:22 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49239/tests/kraken/driver.html?testName=ai-astar) 10:16:22 INFO - PROCESS | 1645 | RSS: Main: 359276544 10:16:22 INFO - PROCESS | 1645 | 10:16:22 INFO - PROCESS | 1645 | __start_tp_report 10:16:22 INFO - PROCESS | 1645 | _x_x_mozilla_page_load 10:16:22 INFO - PROCESS | 1645 | _x_x_mozilla_page_load_details 10:16:22 INFO - PROCESS | 1645 | |i|pagename|runs| 10:16:22 INFO - PROCESS | 1645 | |0;ai-astar;114;116;115;115;116;116;115;115;112;116 10:16:22 INFO - PROCESS | 1645 | |1;audio-beat-detection;134;110;107;144;111;107;108;108;127;107 10:16:22 INFO - PROCESS | 1645 | |2;audio-dft;186;182;237;268;184;184;182;182;185;183 10:16:22 INFO - PROCESS | 1645 | |3;audio-fft;82;63;60;94;65;63;60;61;77;61 10:16:22 INFO - PROCESS | 1645 | |4;audio-oscillator;86;69;88;71;69;68;83;68;69;84 10:16:22 INFO - PROCESS | 1645 | |5;imaging-gaussian-blur;87;87;87;87;88;87;88;88;87;88 10:16:22 INFO - PROCESS | 1645 | |6;imaging-darkroom;94;95;103;149;108;96;94;94;94;95 10:16:22 INFO - PROCESS | 1645 | |7;imaging-desaturate;86;86;83;83;84;83;84;84;85;84 10:16:22 INFO - PROCESS | 1645 | |8;json-parse-financial;63;62;63;64;65;64;64;66;64;63 10:16:22 INFO - PROCESS | 1645 | |9;json-stringify-tinderbox;54;62;57;85;90;84;78;58;58;59 10:16:22 INFO - PROCESS | 1645 | |10;stanford-crypto-aes;95;99;102;79;85;82;84;83;86;84 10:16:22 INFO - PROCESS | 1645 | |11;stanford-crypto-ccm;144;130;141;127;144;154;142;136;206;176 10:16:22 INFO - PROCESS | 1645 | |12;stanford-crypto-pbkdf2;207;167;164;163;163;166;167;165;180;219 10:16:22 INFO - PROCESS | 1645 | |13;stanford-crypto-sha256-iterative;65;65;66;65;65;65;64;63;64;64 10:16:22 INFO - PROCESS | 1645 | __end_tp_report 10:16:22 INFO - PROCESS | 1645 | __start_cc_report 10:16:22 INFO - PROCESS | 1645 | _x_x_mozilla_cycle_collect,2156 10:16:22 INFO - PROCESS | 1645 | __end_cc_report 10:16:22 INFO - PROCESS | 1645 | __startTimestamp1491326182659__endTimestamp 10:16:22 INFO - PROCESS | 1645 | 10:16:22 INFO - PROCESS | 1645 | ------- Summary: start ------- 10:16:22 INFO - PROCESS | 1645 | Number of tests: 14 10:16:22 INFO - PROCESS | 1645 | 10:16:22 INFO - PROCESS | 1645 | [#0] ai-astar Cycles:10 Average:115.00 Median:115.50 stddev:1.25 (1.1%) stddev-sans-first:1.27 10:16:22 INFO - PROCESS | 1645 | Values: 114.0 116.0 115.0 115.0 116.0 116.0 115.0 115.0 112.0 116.0 10:16:22 INFO - PROCESS | 1645 | 10:16:22 INFO - PROCESS | 1645 | [#1] audio-beat-detection Cycles:10 Average:116.30 Median:110.50 stddev:13.58 (12.3%) stddev-sans-first:12.81 10:16:22 INFO - PROCESS | 1645 | Values: 134.0 110.0 107.0 144.0 111.0 107.0 108.0 108.0 127.0 107.0 10:16:22 INFO - PROCESS | 1645 | 10:16:22 INFO - PROCESS | 1645 | [#2] audio-dft Cycles:10 Average:197.30 Median:184.50 stddev:30.03 (16.3%) stddev-sans-first:31.57 10:16:22 INFO - PROCESS | 1645 | Values: 186.0 182.0 237.0 268.0 184.0 184.0 182.0 182.0 185.0 183.0 10:16:22 INFO - PROCESS | 1645 | 10:16:22 INFO - PROCESS | 1645 | [#3] audio-fft Cycles:10 Average:68.60 Median:64.00 stddev:11.71 (18.3%) stddev-sans-first:11.37 10:16:22 INFO - PROCESS | 1645 | Values: 82.0 63.0 60.0 94.0 65.0 63.0 60.0 61.0 77.0 61.0 10:16:22 INFO - PROCESS | 1645 | 10:16:22 INFO - PROCESS | 1645 | [#4] audio-oscillator Cycles:10 Average:75.50 Median:77.00 stddev:8.53 (11.1%) stddev-sans-first:8.15 10:16:22 INFO - PROCESS | 1645 | Values: 86.0 69.0 88.0 71.0 69.0 68.0 83.0 68.0 69.0 84.0 10:16:22 INFO - PROCESS | 1645 | 10:16:22 INFO - PROCESS | 1645 | [#5] imaging-gaussian-blur Cycles:10 Average:87.40 Median:87.50 stddev:0.52 (0.6%) stddev-sans-first:0.53 10:16:22 INFO - PROCESS | 1645 | Values: 87.0 87.0 87.0 87.0 88.0 87.0 88.0 88.0 87.0 88.0 10:16:22 INFO - PROCESS | 1645 | 10:16:22 INFO - PROCESS | 1645 | [#6] imaging-darkroom Cycles:10 Average:102.20 Median:94.00 stddev:17.11 (18.2%) stddev-sans-first:17.89 10:16:22 INFO - PROCESS | 1645 | Values: 94.0 95.0 103.0 149.0 108.0 96.0 94.0 94.0 94.0 95.0 10:16:22 INFO - PROCESS | 1645 | 10:16:22 INFO - PROCESS | 1645 | [#7] imaging-desaturate Cycles:10 Average:84.20 Median:84.00 stddev:1.14 (1.4%) stddev-sans-first:1.00 10:16:22 INFO - PROCESS | 1645 | Values: 86.0 86.0 83.0 83.0 84.0 83.0 84.0 84.0 85.0 84.0 10:16:22 INFO - PROCESS | 1645 | 10:16:22 INFO - PROCESS | 1645 | [#8] json-parse-financial Cycles:10 Average:63.80 Median:64.00 stddev:1.14 (1.8%) stddev-sans-first:1.17 10:16:22 INFO - PROCESS | 1645 | Values: 63.0 62.0 63.0 64.0 65.0 64.0 64.0 66.0 64.0 63.0 10:16:22 INFO - PROCESS | 1645 | 10:16:22 INFO - PROCESS | 1645 | [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:70.00 stddev:13.99 (20.0%) stddev-sans-first:13.82 10:16:22 INFO - PROCESS | 1645 | Values: 54.0 62.0 57.0 85.0 90.0 84.0 78.0 58.0 58.0 59.0 10:16:22 INFO - PROCESS | 1645 | 10:16:22 INFO - PROCESS | 1645 | [#10] stanford-crypto-aes Cycles:10 Average:87.90 Median:84.50 stddev:7.84 (9.3%) stddev-sans-first:7.88 10:16:22 INFO - PROCESS | 1645 | Values: 95.0 99.0 102.0 79.0 85.0 82.0 84.0 83.0 86.0 84.0 10:16:22 INFO - PROCESS | 1645 | 10:16:22 INFO - PROCESS | 1645 | [#11] stanford-crypto-ccm Cycles:10 Average:150.00 Median:144.00 stddev:23.97 (16.6%) stddev-sans-first:25.32 10:16:22 INFO - PROCESS | 1645 | Values: 144.0 130.0 141.0 127.0 144.0 154.0 142.0 136.0 206.0 176.0 10:16:22 INFO - PROCESS | 1645 | 10:16:22 INFO - PROCESS | 1645 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.10 Median:167.00 stddev:20.25 (12.1%) stddev-sans-first:18.13 10:16:22 INFO - PROCESS | 1645 | Values: 207.0 167.0 164.0 163.0 163.0 166.0 167.0 165.0 180.0 219.0 10:16:22 INFO - PROCESS | 1645 | 10:16:22 INFO - PROCESS | 1645 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.60 Median:65.00 stddev:0.84 (1.3%) stddev-sans-first:0.88 10:16:22 INFO - PROCESS | 1645 | Values: 65.0 65.0 66.0 65.0 65.0 65.0 64.0 63.0 64.0 64.0 10:16:22 INFO - PROCESS | 1645 | -------- Summary: end -------- 10:16:22 INFO - PROCESS | 1645 | 10:16:23 INFO - TEST-INFO | 1645: exit 0 10:16:23 INFO - TEST-OK | kraken | took 60076ms 10:16:23 INFO - SUITE-END | took 1180s 10:16:23 INFO - Completed test suite (00:19:40) 10:16:23 INFO - javascript benchmark 10:16:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7445.90372351664, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2946.7642588592917, 3400.880969166079, 3430.416829139048, 3452.5671846183836, 3471.75697701161, 5976.641401515912, 5979.521638268939, 6013.248343957, 6020.006698894677, 6034.668093254869, 5515.200295957084, 5925.229720136376, 5992.760289588422, 6000.639961602296, 6008.579399442041, 5338.893222135555, 5357.571394288448, 5407.188921661763, 5424.728763561826, 5456.563474921997, 4339.631131353839, 5291.761870715827, 5350.384705758829, 5471.987682278771, 5530.253415788878, 5368.731563421833, 5385.569154467653, 5385.892282154355, 5399.082156033464, 5403.2705584745945, 4458.955410445887, 5364.91952620711, 5386.2997810284805, 5391.730413479349, 5393.19102134679, 5219.686818790885, 5341.813036543703, 5349.331333583302, 5353.0899747043095, 5379.38137114233, 5940.495057920082, 5963.0, 5979.312379076375, 5983.850403739898, 5986.341502434729, 6255.87488250237, 6298.212723409574, 6305.968470157666, 6318.4945204384, 6323.494120470351, 6380.904286435707, 6390.6485143317095, 6392.4886009119155, 6394.264659564164, 6399.26408463028, 4728.40894888139, 6058.3032951210735, 6060.090986352038, 6074.696265186767, 6078.240219972504, 6265.96867015662, 6288.371162883675, 6486.454141547104, 6520.119783829217, 6532.640704761284, 6233.096201050913, 6270.561060725797, 6277.18396608438, 6292.748290068437, 6296.370362963758, 5316.308879845673, 6370.58591191571, 6374.681265936777, 6391.328910464427, 6392.520560957947, 6301.747930082745, 6311.684415779193, 6330.272018717815, 6330.778422755181, 6337.493000559944, 5543.863507980855, 5612.887742245132, 6068.150458935753, 6238.750449982041, 6264.310925798159, 5091.363579552556, 5134.845954621367, 5149.098907691139, 5174.767135478913, 5189.273501709764, 4533.002739397327, 4551.180787458289, 4566.315052742115, 4575.081911620248, 4604.37840891482, 5829.329627092939, 5868.530517558585, 6043.607165534227, 6092.664903430354, 6111.755529778848, 6300.3699630037545, 6346.048092786119, 6380.106785050097, 6398.104265402847, 6398.9040164397575, 6087.225302117827, 6087.482563982111, 6092.177556029879, 6095.99416096348, 6117.449429551361, 5650.660960342392, 5670.291213598301, 5671.404502527258, 5673.8297851064535, 5684.403137670568, 6219.595726277777, 6356.555041147075, 6401.93598064032, 6412.39082287182, 6422.165118534561, 5258.342707161605, 6268.498520118471, 6270.341614130451, 6271.43557079865, 6271.62370257786, 6480.0, 6565.573237739532, 6581.177352830896, 6595.1096601958125, 6621.172353455818, 6292.119103325446, 6315.242170939333, 6316.526260530387, 6327.588706734047, 6331.715072821642, 6223.066540019034, 6342.841428964312, 6380.87238255223, 6391.648459334781, 6394.26465956421, 6132.601380910227, 6185.969070154621, 6210.4100110489435, 6241.875162496815, 6259.2488901332135, 6240.968795155995, 6297.905531416941, 6299.842503937438, 6309.211348581427, 6309.432151106423, 6247.656378899204, 6248.5313601479165, 6254.28075771274, 6259.1550140730415, 6267.843303917439, 6133.877322453615, 6170.660613666291, 6197.597156184834, 6235.875282494416, 6274.749010039547, 6195.16365290698, 6195.690215489118, 6240.563160578898, 6241.500679945502, 6254.687265636791], "value": 5835.9300359531235, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [715.8961950517174, 805.8348038652077, 856.17379229044, 876.8553188723861, 877.5831480046978, 38042.61957380429, 38962.0, 40306.0, 40489.98775030626, 40534.39198412026, 39421.01447463815, 39601.00997475065, 39655.801720991425, 39696.0, 39711.60288397115, 7246.202917679051, 9036.63853445863, 9199.494027828467, 9207.171354578086, 9209.861852072225, 7201.4238860891, 10777.676669699922, 11002.064824489928, 11042.447877606128, 11063.502142403611, 10855.837162442569, 10883.1837612179, 10893.782124357507, 10901.1279097672, 10985.61550345738, 7181.712731490734, 10844.891551084467, 10864.022237998579, 10875.293105948089, 10878.510467029002, 6332.778352757631, 7293.63531823412, 7338.22948590401, 7344.30229128232, 10512.0, 37216.62783372186, 37248.0, 37253.627463725286, 37400.43899341512, 37403.438948415795, 3673.3571624965793, 3729.776213427203, 3732.4401339798974, 3744.307303148926, 3755.680767134797, 26281.554514501695, 26678.73321266782, 26894.0, 27599.172024839085, 28561.857525698946, 3007.7142671446177, 3034.605501284841, 3069.6623371429123, 3216.115568218735, 3218.1311046017445, 347050.0, 347276.79084814, 347859.0, 348058.0, 350971.0, 51259.0, 51510.22734658983, 51555.0, 51564.48435515597, 51696.741516292175, 53149.7342513285, 53265.0, 53316.733416333445, 53321.73339133357, 53337.66655833635, 14044.36800343987, 14359.0, 14362.066465679698, 14370.640733981734, 14386.0, 12558.623241302776, 12559.058070644738, 12588.622341329774, 12590.559330423392, 12599.559015434415, 9324.741159943322, 9596.424214547149, 11008.339499630049, 11537.48081336342, 11629.651110466699, 4910.435299940481, 5431.918521222185, 5606.6916319602, 5628.774849005994, 5642.548596112301, 932.1191474056951, 945.7210123013728, 948.6489998700387, 966.5360626899128, 970.2335155227432, 25600.615990760154, 26747.86626066896, 28294.0, 28977.42045159085, 29072.854635726686, 816.1267443835039, 843.2115971566483, 903.4353529044347, 992.4045572656348, 1057.9788404231872, 12837.358132093357, 12879.935600321938, 12886.677833054062, 13017.810140825619, 13100.017498687446, 408324.0, 411012.0, 412987.0, 413767.9311603423, 414198.0, 44213.336799948025, 44250.893727657065, 44333.778331108784, 44334.0, 44422.111557768665, 1223.431104536377, 1246.4141853328922, 1373.9931300343635, 1418.2058047493438, 1434.1610158057445, 20740.0, 25691.100811471508, 26599.468010640066, 27152.456950861266, 27190.456190876466, 42305.5769442314, 42465.5753442474, 42541.0, 42568.0, 42601.57398425976, 457543.0, 458096.7095164636, 461103.0, 461142.0, 461903.0, 27186.592201116604, 27527.0, 27765.44469110647, 27790.86104569464, 27884.30289242785, 35861.38623761989, 36233.0, 36619.08452288714, 36721.0, 36853.63146368502, 25080.37299067538, 26221.606675899497, 26725.19824405271, 26951.595726063733, 27137.321566960985, 23081.422964426023, 25885.46607419212, 25967.961281549284, 27039.72960270451, 27101.457970840867, 30155.0, 30273.24316892095, 30664.77340906428, 30683.926062587703, 30914.381712365175, 27383.356998580148, 27968.86015569909, 28329.43341133207, 28676.856615716788, 29406.55890161692, 18059.18733657015, 21555.0, 21990.90045497687, 22065.889670551544, 22492.100315987176], "value": 17506.84904997068, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.54890777789984, 394.9763014219147, 405.65316654260624, 421.39319380092667, 447.92385294499934, 12321.38393080347, 20991.950402479873, 21002.684959725615, 21743.347699569, 21997.900104994766, 21040.789592104073, 21461.785382146172, 22028.77971220287, 22050.558988820216, 22139.667904981437, 5886.705664716768, 6610.471162307016, 6646.069550262967, 6776.42400395967, 6837.897431538531, 6601.63690996995, 6813.250542440328, 6813.557118787263, 6822.113125293729, 6858.211305699833, 6511.186101737283, 6642.634655093968, 6713.194416670007, 6714.56355336904, 6810.62541560214, 6699.0, 6753.358430949052, 6759.4453275746855, 6777.491688123361, 7024.683889224997, 7232.710691572331, 7307.3423391894985, 7312.5246858954, 7315.0, 7323.890141647879, 25110.49779004428, 25546.36134096644, 25603.61594576083, 25659.1019314325, 25857.612135817977, 2872.5978363029194, 2887.4946884295164, 2922.3072102808055, 2926.634170728659, 2932.8533573321247, 15828.129452880086, 15862.048277103295, 16159.676806463922, 16288.75566866486, 16554.006759594464, 1907.246637578149, 1950.590376021023, 1968.163530499532, 1980.9108590113335, 1984.9503762406055, 160531.0, 164313.0, 168636.99999999878, 171687.0, 173090.0, 14368.568942931728, 19515.51211219731, 19577.608447830964, 19759.40721778349, 20013.49831271091, 20201.595968080557, 27194.864025679744, 27217.31956701059, 29977.0, 30876.91930782412, 9800.31397802147, 10119.494025298705, 10337.793244135075, 10355.275130740927, 10456.006679365448, 7068.3285087916565, 7424.628768561551, 7515.173330933702, 8182.427230093956, 8518.148185181431, 9167.0, 9222.631094756134, 9227.231830450837, 9346.53267336644, 9392.436453812794, 3881.941770873439, 3962.484876965976, 3969.4839670843185, 3971.815501474178, 3988.6011398860464, 879.6877108626474, 892.6563273139888, 896.121800635381, 928.972130836076, 934.9719508414759, 21138.260160894293, 21510.13959441636, 21565.892170539362, 21684.0, 21685.0, 912.0879120879121, 931.9068093190763, 931.9813603728023, 944.3578366710702, 949.240607513986, 8060.758177254692, 11123.943225393736, 11138.777224455465, 11168.93895079966, 11388.715282117848, 705010.0, 709146.0, 720549.0, 723517.0, 737535.0, 146730.0, 149816.2509187447, 153880.0, 154813.0, 162381.18809405877, 1164.8991702840904, 1167.626359564948, 1194.689380760991, 1215.8358621586149, 1257.8050402187675, 19019.524511887314, 19593.8040619592, 19598.314059007866, 19692.21231150738, 19707.901460492605, 45282.0, 57025.0, 62126.68936655288, 62729.05906411499, 63863.68068159629, 83513.58243208745, 83519.16480835114, 85378.57310713407, 86414.56792715997, 86575.1342486567, 9339.626414943326, 9900.405975641484, 10373.740656483647, 11213.0, 11423.0, 12487.31319777421, 12601.621951341474, 12642.873571264538, 12706.618801435972, 12759.106862519535, 9349.345545812, 10627.840582391116, 11039.344098384985, 11121.110311174925, 11128.777424451628, 8951.507667078113, 9276.16514513697, 9946.0, 10036.799264014824, 10215.336003159771, 9743.9025609743, 10333.449982502385, 10624.512568240607, 11043.116550675766, 11273.210875238654, 11075.390853503135, 11211.495482703462, 11227.887721122685, 11499.54001839917, 11539.249948753304, 10638.946805265925, 10843.728906777395, 10844.511996959998, 11004.724881878017, 11241.943790281324], "value": 11234.033531262392, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1541.3372249932531, 1567.5062355358054, 1572.8269890312072, 1587.214328907191, 1592.577966838788, 9723.222142228613, 10170.237232207586, 10174.694759157219, 10195.082442580166, 10201.897981020187, 9998.900010999887, 10721.088707459856, 11017.889821101786, 11119.5552177913, 11144.164187685916, 2302.067662596651, 2338.8830558472096, 2342.1334106380577, 2353.52929414117, 2355.4817940053163, 2199.4281486813384, 2256.706628138348, 2306.8269879759, 2313.8033267172227, 2316.6061769499142, 2279.9886000569973, 2287.1651847075864, 2311.653252012195, 2326.6510023496444, 2332.137109269564, 2253.5830871288863, 2290.942726431836, 2295.0360848443693, 2297.6558713152826, 2306.850054746436, 2280.224723593986, 2280.293109136173, 2281.167373908528, 2286.897089630954, 2291.6104262275453, 10978.945105274503, 11048.502817373157, 11052.944735276273, 11065.889341106566, 11066.336019838835, 5388.488093631099, 5498.230247765316, 5537.750801213955, 5547.611667183299, 5549.139883318092, 3130.8434578270994, 3248.788828726149, 3365.444701624229, 3378.864845406181, 3379.0, 1041.578160844859, 1062.4262898035129, 1104.1553211792984, 1150.5627861412693, 1168.5617893290016, 13565.0, 13886.513972010931, 14139.434422623082, 15068.246587670683, 15470.613234669223, 4367.5632436756705, 4483.7533935633855, 4510.345999830006, 4528.637708983273, 4538.568835960578, 11793.88206117945, 11795.997340226006, 11806.0, 11814.291142531476, 11817.350045747395, 4400.4939431965095, 4728.267118596623, 4888.486708895586, 5490.478404551562, 5505.394406615269, 5002.899942001212, 5109.233614957711, 5127.512886275797, 5141.280220769096, 5151.356080489939, 3614.7469677122876, 3641.5266015417824, 3686.0416291764336, 3694.371956767356, 3707.6663100321102, 941.3457646935451, 963.2775418436173, 970.7281961050917, 975.7219192530094, 977.4330888084894, 887.245841035115, 915.8351496730519, 921.488573841511, 922.928026580318, 945.9621615135455, 6510.18622672166, 6574.112494813139, 6577.769778057841, 6631.0, 6638.634875081917, 958.726762872578, 973.5083782689696, 979.5062529642353, 1002.8946960569181, 1033.963811266617, 3873.2640798248244, 4039.6566291864933, 4190.308599081118, 4230.915381692349, 4388.605025547652, 13189.0, 13717.382717777724, 13742.519011834738, 13744.725105498033, 13838.0, 13173.209607423585, 13299.26854023038, 13659.521916732867, 13663.863361366459, 13681.863181368259, 10089.596416143271, 10129.797404051878, 10162.54268557902, 10318.535665895202, 10318.948405257926, 6527.902081468686, 6541.934580654323, 6554.868902622016, 6637.1703537057865, 6674.232463266787, 12181.69545761363, 12548.309842958724, 12698.0, 12713.93643031779, 12715.237085774883, 11390.0, 11426.885731142582, 12586.874131258937, 12591.748165036464, 12638.936805315914, 8446.95776521138, 8688.39181257306, 8713.085126061673, 8717.346199034972, 8727.432716873383, 10147.289689721649, 10332.17342612574, 10451.216158788273, 10465.895341046797, 10478.266521343432, 8769.298456123623, 8837.160469755363, 8903.955480222558, 8915.598798054232, 9092.954310254141, 8651.394402391772, 8651.95674021626, 8689.261412779984, 8759.824803504021, 8788.42875213109, 6626.83432914181, 7747.72882949094, 7913.604319783873, 7922.009748781403, 7925.454536365353, 5793.536517078539, 5830.650160990354, 5879.176915231957, 5998.070299103646, 6079.635221886701, 5503.669779813224, 5805.535557155502, 5884.264466941632, 6030.7286172121485, 6062.969685151546], "value": 5000.607496399305, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.14322485384196, 370.2354637673205, 380.8381437888896, 383.2316206006956, 384.4598339333237, 4377.978110109449, 4990.005996402166, 5039.319691841601, 5170.870728231796, 5206.8698282542955, 3682.871099511511, 4247.214265360911, 4294.613484786369, 4570.931436028454, 4767.043354016167, 4329.242382583051, 4338.739675619465, 4339.349097635364, 4343.2399330117105, 4392.780360981954, 3938.645521903028, 4365.912681746363, 4423.88940276494, 4433.69206084206, 4476.171908196994, 3301.8679252829857, 4112.97943510282, 4114.526829414611, 4116.814743336557, 4209.284421648327, 4084.836606535735, 4126.66986641068, 4131.628153466202, 4155.096985557041, 4192.748435093874, 3863.285292220948, 3877.1276462795927, 3886.0, 3895.5325360956585, 3910.530736311632, 4112.588741125864, 4263.381809637616, 4457.554244575549, 4464.776761161929, 4878.536539028786, 4708.281477260809, 4811.206150985084, 4822.469528351879, 4829.855104346875, 4855.44162421319, 4527.7736113194205, 5333.893322133575, 5337.733113344318, 5359.651622644555, 5394.6493477924205, 3422.5379573757723, 3465.324261768956, 4186.769727664977, 4268.9573104268875, 4314.546972567867, 5539.750711218005, 5612.326520817528, 5643.335216111257, 5660.575456840754, 5684.8010319638615, 3783.319002579562, 3793.7534060285993, 3935.1736135411884, 4083.1629515949157, 4409.338599210144, 3917.373220284741, 4085.958080689405, 4452.844150454718, 4507.684462087623, 4547.0, 4072.6334629883454, 4734.242521196592, 4738.8341408050555, 4846.843154796082, 4847.5394837490385, 4583.012778882327, 5098.770555325019, 5186.714730689849, 5387.865303367369, 5402.648827826179, 1327.707904261061, 1414.8893118901613, 1423.8789702875165, 1434.5266062199448, 1438.3671184678917, 1077.7413420779114, 1123.6909849791373, 1146.8245048825022, 1153.6366044695894, 1164.7828019719414, 4530.388397566352, 4613.400257966443, 4956.677815941952, 4994.750262486861, 5027.271045698353, 4771.475137734847, 4893.437254715682, 5255.816046438356, 5370.677759334374, 5573.893286060305, 4698.248280275208, 5054.9241761373605, 5076.543111119943, 5083.331251093132, 5094.420729573844, 2416.6979127609047, 2417.0, 2848.5442329227226, 2891.8120322178993, 2892.681805001448, 5255.605829562798, 5411.945880541144, 5428.321459817523, 5628.915566266509, 5784.21913041734, 4884.926726099111, 5245.370555533361, 5611.839441814931, 5658.377578466366, 5676.233708449389, 4781.378420805412, 5222.817201398009, 5325.988062268234, 5623.044082505984, 5664.490195882308, 4076.571959944163, 5309.0, 5421.5933804964, 5449.945500545103, 5540.806071787468, 5235.188545775411, 5470.753816078366, 5519.420460851713, 5530.626317945969, 5544.556435485071, 4740.771837236493, 5403.945960540502, 5596.804111856066, 5724.971375143097, 5855.707214639337, 3482.164280572695, 3993.181397813499, 4177.968260628508, 4273.0, 4413.933790993074, 4866.610671146371, 5034.395872495324, 5122.8975420492125, 5490.478404551562, 5502.504774570308, 4508.977455112704, 4606.493285738633, 4980.825671101494, 5284.762185701729, 5320.600954928474, 4688.648351373592, 4740.6207503398955, 5253.395859476209, 5334.226537152169, 5356.758945847524, 4644.628429725546, 4935.407751069894, 4991.5258050485145, 5145.4340022598235, 5157.008934817872, 4772.5227477252, 4787.640926930424, 5286.62993590445, 5306.575473961997, 5399.757010934439, 4271.636910862611, 4366.563343665608, 4709.80993837867, 4981.854173540034, 5137.023965446553], "value": 4060.3417877585703, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [728.5191773429538, 758.480440897985, 758.7420277105783, 826.5660528222684, 839.9538025408602, 14867.330970106344, 15572.45496407626, 16153.919230403832, 16157.838421615796, 16178.35286588538, 14315.570532884005, 14554.345054472547, 14738.926305368484, 14748.926255368735, 15188.31652575634, 919.6459363145203, 942.0391200975001, 943.481085403029, 946.1579194516886, 947.739371672792, 929.2705226397279, 937.6343226141776, 937.7889974755659, 944.4710961861346, 956.7942892278159, 999.3154689037996, 1003.7691330993875, 1004.3873237325263, 1006.5722068121056, 1007.8639383683219, 1001.5743309093606, 1002.669119190669, 1003.759097816526, 1004.8342023566103, 1005.0150852164846, 742.8997085393456, 743.6765007221876, 744.4714252880461, 745.1095940351282, 745.1579714922158, 15388.846111538853, 15723.056616602926, 15765.211739412984, 16099.758503622455, 16407.097609631466, 13946.721065578631, 13952.908932353308, 14033.578992630237, 14047.508337208148, 14229.0, 9629.470379129145, 10065.0, 11580.073594112451, 11766.411679415995, 11840.28958262507, 3283.96716032839, 3569.1969306906, 3640.1809592841664, 3670.687991520724, 3679.4480827875764, 81311.68194862432, 90888.0, 108822.91177088207, 113424.43287783508, 114896.0, 8829.69096081634, 10392.792144157074, 10425.530851111718, 10465.84301235482, 10972.957569031088, 20815.479613009495, 21374.465638358855, 21414.892925535583, 21468.926553672252, 21472.818994955116, 7647.57938313387, 7695.115061767969, 7711.768646940601, 7783.066032076187, 7845.254700803414, 3391.6269210386836, 4164.479440069991, 4201.138766552849, 4237.809298581571, 4340.435743353344, 3247.350529894031, 3323.1692076980753, 3339.19859233787, 3341.498775183742, 3348.4977253412185, 581.354696287121, 588.8969430349672, 590.8818236352661, 596.3976383852254, 602.9487493563096, 545.0402823487367, 579.2874764040254, 670.9329067093349, 676.9390754832089, 693.9375456208865, 10066.396016239049, 10121.392716437038, 10391.37651740898, 10426.0, 10588.523516441779, 511.7462217566976, 548.8847342058133, 558.9972050139804, 604.9848753781191, 693.4694958356861, 4481.2381895077915, 4916.434610019822, 4985.775640096204, 5044.0920634286185, 5084.288199652052, 86616.56691716627, 89120.0, 94433.97311228623, 96819.51590242004, 104471.0, 82494.17505824864, 84575.0, 85565.57217213874, 86687.0, 88416.55791721, 76130.0, 78946.28956538759, 80199.0, 81687.0, 81858.77211841827, 10484.895151048391, 10971.396573188551, 11104.167187461135, 11197.776044479227, 11255.155863310121, 48433.0, 49241.26138108003, 49255.753721231165, 50312.4906252813, 50391.49608503868, 43340.39957602554, 62606.0, 64111.71776564536, 64802.0, 65440.672796635714, 12276.263424194576, 12280.631581052583, 12303.630891073282, 12505.687357816127, 12763.48946042185, 11600.593979210687, 12167.878321216675, 12214.26714397139, 12588.181768185405, 14591.854081459049, 11538.653840384803, 11680.123990700562, 12052.276863388224, 12170.330631815335, 12326.0, 11579.30524168519, 11893.821592675944, 11986.940065299617, 12210.0, 12437.875621243671, 11396.430178491208, 11909.940450297692, 11916.52333906634, 11968.640940771791, 12201.20692155007, 8414.579271036546, 8500.659973600987, 8873.334499912662, 8880.689175878813, 9036.683716069905, 8248.0, 9244.550194198408, 9931.702048938254, 9963.750906227402, 9966.900330996597], "value": 7311.798954135969, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1457.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 116.0, 115.0, 115.0, 116.0, 116.0, 115.0, 115.0, 112.0, 116.0], "value": 115.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 110.0, 107.0, 144.0, 111.0, 107.0, 108.0, 108.0, 127.0, 107.0], "value": 116.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 182.0, 237.0, 268.0, 184.0, 184.0, 182.0, 182.0, 185.0, 183.0], "value": 197.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 63.0, 60.0, 94.0, 65.0, 63.0, 60.0, 61.0, 77.0, 61.0], "value": 68.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 69.0, 88.0, 71.0, 69.0, 68.0, 83.0, 68.0, 69.0, 84.0], "value": 75.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 87.0, 87.0, 88.0, 87.0, 88.0, 88.0, 87.0, 88.0], "value": 87.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 103.0, 149.0, 108.0, 96.0, 94.0, 94.0, 94.0, 95.0], "value": 102.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 83.0, 83.0, 84.0, 83.0, 84.0, 84.0, 85.0, 84.0], "value": 84.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 63.0, 64.0, 65.0, 64.0, 64.0, 66.0, 64.0, 63.0], "value": 63.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 62.0, 57.0, 85.0, 90.0, 84.0, 78.0, 58.0, 58.0, 59.0], "value": 68.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 99.0, 102.0, 79.0, 85.0, 82.0, 84.0, 83.0, 86.0, 84.0], "value": 87.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 130.0, 141.0, 127.0, 144.0, 154.0, 142.0, 136.0, 206.0, 176.0], "value": 150.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [207.0, 167.0, 164.0, 163.0, 163.0, 166.0, 167.0, 165.0, 180.0, 219.0], "value": 176.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 65.0, 65.0, 65.0, 64.0, 63.0, 64.0, 64.0], "value": 64.6, "unit": "score"}]}]} 10:16:23 INFO - Return code: 0 10:16:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:16:23 ERROR - # TBPL SUCCESS # 10:16:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:16:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:16:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:16:23 INFO - 2017-04-04 10:16:23.984 screenresolution[1649:9641] starting screenresolution argv=screenresolution get 10:16:23 INFO - 2017-04-04 10:16:23.988 screenresolution[1649:9641] Display 0: 1600x1200x32@60 10:16:23 INFO - 2017-04-04 10:16:23.995 screenresolution[1650:9644] starting screenresolution argv=screenresolution list 10:16:23 INFO - Available Modes on Display 0 10:16:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:16:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:16:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:16:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:16:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:16:24 INFO - Intel Iris: 10:16:24 INFO - Chipset Model: Intel Iris 10:16:24 INFO - Type: GPU 10:16:24 INFO - Bus: Built-In 10:16:24 INFO - VRAM (Dynamic, Max): 1536 MB 10:16:24 INFO - Vendor: Intel (0x8086) 10:16:24 INFO - Device ID: 0x0a2e 10:16:24 INFO - Revision ID: 0x0009 10:16:24 INFO - Displays: 10:16:24 INFO - Display: 10:16:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:16:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:16:24 INFO - Display Serial Number: 1600x1200 60 10:16:24 INFO - Main Display: Yes 10:16:24 INFO - Mirror: Off 10:16:24 INFO - Online: Yes 10:16:24 INFO - Rotation: Supported 10:16:24 INFO - Return code: 0 10:16:24 INFO - Running post-action listener: _resource_record_post_action 10:16:24 INFO - [mozharness: 2017-04-04 17:16:24.232765Z] Finished run-tests step (success) 10:16:24 INFO - Running post-run listener: _resource_record_post_run 10:16:24 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 39138304; Write bytes: 507908096; Read time: 382; Write time: 1699 10:16:24 INFO - TinderboxPrint: CPU usage
53.7% 10:16:24 INFO - TinderboxPrint: I/O read bytes / time
39,138,304 / 382 10:16:24 INFO - TinderboxPrint: I/O write bytes / time
507,908,096 / 1,699 10:16:24 INFO - TinderboxPrint: CPU idle
2,224.6 (46.3%) 10:16:24 INFO - TinderboxPrint: CPU system
954.8 (19.9%) 10:16:24 INFO - TinderboxPrint: CPU user
1,626.3 (33.8%) 10:16:24 INFO - TinderboxPrint: Swap in / out
246,554,624 / 0 10:16:24 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205914624; Write bytes: 201046016; Read time: 15733; Write time: 435 10:16:24 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 37045248; Write bytes: 295798784; Read time: 355; Write time: 1228 10:16:24 INFO - Running post-run listener: _upload_blobber_files 10:16:24 INFO - Blob upload gear active. 10:16:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:16:24 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:16:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:16:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:16:25 INFO - (blobuploader) - INFO - Open directory for files ... 10:16:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:16:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:16:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:16:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:16:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:16:26 INFO - (blobuploader) - INFO - Done attempting. 10:16:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:16:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:16:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:16:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:16:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:16:27 INFO - (blobuploader) - INFO - Done attempting. 10:16:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:16:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:16:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:16:28 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:16:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:16:28 INFO - (blobuploader) - INFO - Done attempting. 10:16:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:16:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:16:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:16:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:16:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:16:30 INFO - (blobuploader) - INFO - Done attempting. 10:16:30 INFO - (blobuploader) - INFO - Iteration through files over. 10:16:30 INFO - Return code: 0 10:16:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:16:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:16:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1ca3ec9fa06b7f87b5920447cf04fa7879e6a94c64f92c9bd4ceab18ed9e14baeda80625a1823ee8add1a3b5f4b2bbd8108aa92a10c62e4883c0c83c08cecb86", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/88ea6b4244caf36885998409a5094d280ed30253eef05f0e4f492403a2e414be5cf802f6125f976e9411c484ea850b415046feddefa4cdc73dcbfad2c84d4986", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/69b54d53a873c5edd7633106d2cbc1c115b2560deefbb157779bd13f7b04e148f1be0689c6dcbe0fbb06b7d96880e94fe39cddf262ed57d6eaa27e959a77bb87", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/483b496854b231c888c2f180f0528b0350371e4bdb1d074c3efe0458ddf474c3eaaf092f0a4d5ba51800cf2d8d223060da77a347013aeefa208178a85f8e2c24"} 10:16:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:16:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:16:30 INFO - Contents: 10:16:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1ca3ec9fa06b7f87b5920447cf04fa7879e6a94c64f92c9bd4ceab18ed9e14baeda80625a1823ee8add1a3b5f4b2bbd8108aa92a10c62e4883c0c83c08cecb86", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/88ea6b4244caf36885998409a5094d280ed30253eef05f0e4f492403a2e414be5cf802f6125f976e9411c484ea850b415046feddefa4cdc73dcbfad2c84d4986", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/69b54d53a873c5edd7633106d2cbc1c115b2560deefbb157779bd13f7b04e148f1be0689c6dcbe0fbb06b7d96880e94fe39cddf262ed57d6eaa27e959a77bb87", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/483b496854b231c888c2f180f0528b0350371e4bdb1d074c3efe0458ddf474c3eaaf092f0a4d5ba51800cf2d8d223060da77a347013aeefa208178a85f8e2c24"} 10:16:30 INFO - Running post-run listener: copy_logs_to_upload_dir 10:16:30 INFO - Copying logs to upload dir... 10:16:30 INFO - mkdir: /builds/slave/test/build/upload/logs 10:16:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1283.875261 ========= master_lag: 1.29 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-04-04 10:16:31.578787) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-04 10:16:31.582065) ========= 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.gwr8oTWkoi/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.Rjfwxuyqbb/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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/1ca3ec9fa06b7f87b5920447cf04fa7879e6a94c64f92c9bd4ceab18ed9e14baeda80625a1823ee8add1a3b5f4b2bbd8108aa92a10c62e4883c0c83c08cecb86", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/88ea6b4244caf36885998409a5094d280ed30253eef05f0e4f492403a2e414be5cf802f6125f976e9411c484ea850b415046feddefa4cdc73dcbfad2c84d4986", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/69b54d53a873c5edd7633106d2cbc1c115b2560deefbb157779bd13f7b04e148f1be0689c6dcbe0fbb06b7d96880e94fe39cddf262ed57d6eaa27e959a77bb87", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/483b496854b231c888c2f180f0528b0350371e4bdb1d074c3efe0458ddf474c3eaaf092f0a4d5ba51800cf2d8d223060da77a347013aeefa208178a85f8e2c24"} build_url:https://queue.taskcluster.net/v1/task/ey7VVxidSbSCracC4NkSug/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011825 build_url: 'https://queue.taskcluster.net/v1/task/ey7VVxidSbSCracC4NkSug/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1ca3ec9fa06b7f87b5920447cf04fa7879e6a94c64f92c9bd4ceab18ed9e14baeda80625a1823ee8add1a3b5f4b2bbd8108aa92a10c62e4883c0c83c08cecb86", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/88ea6b4244caf36885998409a5094d280ed30253eef05f0e4f492403a2e414be5cf802f6125f976e9411c484ea850b415046feddefa4cdc73dcbfad2c84d4986", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/69b54d53a873c5edd7633106d2cbc1c115b2560deefbb157779bd13f7b04e148f1be0689c6dcbe0fbb06b7d96880e94fe39cddf262ed57d6eaa27e959a77bb87", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/483b496854b231c888c2f180f0528b0350371e4bdb1d074c3efe0458ddf474c3eaaf092f0a4d5ba51800cf2d8d223060da77a347013aeefa208178a85f8e2c24"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-04 10:16:31.618461) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 10:16:31.618749) ========= 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.gwr8oTWkoi/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.Rjfwxuyqbb/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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.005544 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 10:16:31.669774) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-04 10:16:31.670512) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-04 10:16:31.671238) ========= ========= Total master_lag: 1.43 =========