builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0329 starttime: 1487265364.37 results: success (0) buildid: 20170216073239 builduid: 7b2665f36be9484581f0c71611117a12 revision: 3afbdf81cbf92638d71dfe6b159ed2de69cdda62 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-16 09:16:04.369150) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-16 09:16:04.369592) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-16 09:16:04.369870) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-16 09:16:04.395020) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 09:16:04.395471) ========= 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.ig3pMQfiIv/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.fQIQgPmLkx/Listeners TMPDIR=/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-16 09:16:04-- 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% 151M=0s 2017-02-16 09:16:04 (151 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.166958 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 09:16:04.585995) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 09:16:04.586317) ========= 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.ig3pMQfiIv/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.fQIQgPmLkx/Listeners TMPDIR=/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/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.020521 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 09:16:04.635305) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-16 09:16:04.635668) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3afbdf81cbf92638d71dfe6b159ed2de69cdda62 --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 3afbdf81cbf92638d71dfe6b159ed2de69cdda62 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ig3pMQfiIv/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.fQIQgPmLkx/Listeners TMPDIR=/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-16 09:16:04,727 truncating revision to first 12 chars 2017-02-16 09:16:04,728 Setting DEBUG logging. 2017-02-16 09:16:04,728 attempt 1/10 2017-02-16 09:16:04,728 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/3afbdf81cbf9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-16 09:16:05,855 unpacking tar archive at: mozilla-aurora-3afbdf81cbf9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.410879 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-16 09:16:06.070060) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-16 09:16:06.070415) ========= script_repo_revision: 3afbdf81cbf92638d71dfe6b159ed2de69cdda62 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-16 09:16:06.070844) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-16 09:16:06.071132) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-16 09:16:06.090813) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-02-16 09:16:06.091193) ========= /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.ig3pMQfiIv/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.fQIQgPmLkx/Listeners TMPDIR=/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/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:16:06 INFO - MultiFileLogger online at 20170216 09:16:06 in /builds/slave/test 09:16: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:16:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:16:06 INFO - {'append_to_log': False, 09:16:06 INFO - 'base_work_dir': '/builds/slave/test', 09:16:06 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:16:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:16:06 INFO - 'branch': 'Mozilla-Aurora', 09:16:06 INFO - 'buildbot_json_path': 'buildprops.json', 09:16:06 INFO - 'config_files': ('talos/mac_config.py',), 09:16:06 INFO - 'default_actions': ('clobber', 09:16:06 INFO - 'read-buildbot-config', 09:16:06 INFO - 'download-and-extract', 09:16:06 INFO - 'populate-webroot', 09:16:06 INFO - 'create-virtualenv', 09:16:06 INFO - 'install', 09:16:06 INFO - 'run-tests'), 09:16:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:16:06 INFO - 'download_minidump_stackwalk': True, 09:16:06 INFO - 'download_symbols': 'ondemand', 09:16:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:16:06 INFO - 'tooltool.py': '/tools/tooltool.py', 09:16:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:16:06 INFO - '/tools/misc-python/virtualenv.py')}, 09:16:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:16:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:16:06 INFO - 'installer_path': 'installer.exe', 09:16:06 INFO - 'log_level': 'info', 09:16:06 INFO - 'log_name': 'talos', 09:16:06 INFO - 'log_to_console': True, 09:16:06 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:16:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:16:06 INFO - 'opt_config_files': (), 09:16:06 INFO - 'pip_index': False, 09:16:06 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:16:06 INFO - 'cmd': ('bash', 09:16:06 INFO - '-c', 09:16:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:16:06 INFO - 'enabled': True, 09:16:06 INFO - 'halt_on_failure': False, 09:16:06 INFO - 'name': 'check_screen_resolution'},), 09:16:06 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:16:06 INFO - 'cmd': ('bash', 09:16:06 INFO - '-c', 09:16:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:16:06 INFO - 'enabled': True, 09:16:06 INFO - 'halt_on_failure': False, 09:16:06 INFO - 'name': 'check_screen_resolution'},), 09:16:06 INFO - 'run_cmd_checks_enabled': True, 09:16:06 INFO - 'sps_profile': False, 09:16:06 INFO - 'sps_profile_interval': 0, 09:16:06 INFO - 'suite': 'dromaeojs', 09:16:06 INFO - 'system_bits': '32', 09:16:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:16:06 INFO - 'title': 't-yosemite-r7-0329', 09:16:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:16:06 INFO - 'use_talos_json': True, 09:16:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:16:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:16:06 INFO - 'work_dir': 'build'} 09:16:06 INFO - [mozharness: 2017-02-16 17:16:06.297682Z] Running clobber step. 09:16:06 INFO - Running pre-action listener: _resource_record_pre_action 09:16:06 INFO - Running main action method: clobber 09:16:06 INFO - rmtree: /builds/slave/test/build 09:16:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:16:08 INFO - Running post-action listener: _resource_record_post_action 09:16:08 INFO - [mozharness: 2017-02-16 17:16:08.196862Z] Finished clobber step (success) 09:16:08 INFO - [mozharness: 2017-02-16 17:16:08.197000Z] Running read-buildbot-config step. 09:16:08 INFO - Running pre-action listener: _resource_record_pre_action 09:16:08 INFO - Running main action method: read_buildbot_config 09:16:08 INFO - Using buildbot properties: 09:16:08 INFO - { 09:16:08 INFO - "project": "", 09:16:08 INFO - "product": "firefox", 09:16:08 INFO - "script_repo_revision": "production", 09:16:08 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 09:16:08 INFO - "repository": "", 09:16:08 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 09:16:08 INFO - "buildid": "20170216073239", 09:16:08 INFO - "pgo_build": "False", 09:16:08 INFO - "basedir": "/builds/slave/test", 09:16:08 INFO - "buildnumber": 62, 09:16:08 INFO - "slavename": "t-yosemite-r7-0329", 09:16:08 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 09:16:08 INFO - "platform": "yosemite_r7", 09:16:08 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 09:16:08 INFO - "branch": "mozilla-aurora", 09:16:08 INFO - "repo_path": "releases/mozilla-aurora", 09:16:08 INFO - "revision": "3afbdf81cbf92638d71dfe6b159ed2de69cdda62", 09:16:08 INFO - "stage_platform": "macosx64", 09:16:08 INFO - "builduid": "7b2665f36be9484581f0c71611117a12", 09:16:08 INFO - "slavebuilddir": "test" 09:16:08 INFO - } 09:16:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/AI3csdEBTJWqq6xAd0V81g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 09:16:08 INFO - Running post-action listener: _resource_record_post_action 09:16:08 INFO - [mozharness: 2017-02-16 17:16:08.200381Z] Finished read-buildbot-config step (success) 09:16:08 INFO - [mozharness: 2017-02-16 17:16:08.200526Z] Running download-and-extract step. 09:16:08 INFO - Running pre-action listener: _resource_record_pre_action 09:16:08 INFO - Running main action method: download_and_extract 09:16:08 INFO - mkdir: /builds/slave/test/build/tests 09:16:08 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:16:08 INFO - trying https://queue.taskcluster.net/v1/task/AI3csdEBTJWqq6xAd0V81g/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 09:16:08 INFO - Downloading https://queue.taskcluster.net/v1/task/AI3csdEBTJWqq6xAd0V81g/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 09:16:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AI3csdEBTJWqq6xAd0V81g/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 09:16:09 INFO - Downloaded 1199 bytes. 09:16:09 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 09:16:09 INFO - Using the following test package requirements: 09:16:09 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 09:16:09 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:16:09 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 09:16:09 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:16:09 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 09:16:09 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:16:09 INFO - u'jsshell-mac.zip'], 09:16:09 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:16:09 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 09:16:09 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 09:16:09 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:16:09 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 09:16:09 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:16:09 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 09:16:09 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:16:09 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 09:16:09 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:16:09 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 09:16:09 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 09:16:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AI3csdEBTJWqq6xAd0V81g/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 09:16:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AI3csdEBTJWqq6xAd0V81g/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:16:09 INFO - Fetch https://queue.taskcluster.net/v1/task/AI3csdEBTJWqq6xAd0V81g/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 09:16:10 INFO - Expected file size: 16358274 09:16:10 INFO - Obtained file size: 16358274 09:16:16 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 09:16:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AI3csdEBTJWqq6xAd0V81g/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 09:16:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AI3csdEBTJWqq6xAd0V81g/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:16:16 INFO - Fetch https://queue.taskcluster.net/v1/task/AI3csdEBTJWqq6xAd0V81g/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 09:16:17 INFO - Expected file size: 16358274 09:16:17 INFO - Obtained file size: 16358274 09:16:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AI3csdEBTJWqq6xAd0V81g/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 09:16:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AI3csdEBTJWqq6xAd0V81g/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 09:16:23 INFO - Fetch https://queue.taskcluster.net/v1/task/AI3csdEBTJWqq6xAd0V81g/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 09:16:24 INFO - Expected file size: 14403485 09:16:24 INFO - Obtained file size: 14403485 09:16:25 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:16:25 INFO - trying https://queue.taskcluster.net/v1/task/AI3csdEBTJWqq6xAd0V81g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 09:16:25 INFO - Downloading https://queue.taskcluster.net/v1/task/AI3csdEBTJWqq6xAd0V81g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 09:16:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AI3csdEBTJWqq6xAd0V81g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 09:16:27 INFO - Downloaded 73946275 bytes. 09:16:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AI3csdEBTJWqq6xAd0V81g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 09:16:27 INFO - mkdir: /builds/slave/test/properties 09:16:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:16:27 INFO - Writing to file /builds/slave/test/properties/build_url 09:16:27 INFO - Contents: 09:16:27 INFO - build_url:https://queue.taskcluster.net/v1/task/AI3csdEBTJWqq6xAd0V81g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 09:16:28 INFO - Running post-action listener: _resource_record_post_action 09:16:28 INFO - Running post-action listener: set_extra_try_arguments 09:16:28 INFO - [mozharness: 2017-02-16 17:16:28.010920Z] Finished download-and-extract step (success) 09:16:28 INFO - [mozharness: 2017-02-16 17:16:28.011039Z] Running populate-webroot step. 09:16:28 INFO - Running pre-action listener: _resource_record_pre_action 09:16:28 INFO - Running main action method: populate_webroot 09:16:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:16:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:16:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:16:28 INFO - '--tppagecycles', 09:16:28 INFO - '7'], 09:16:28 INFO - 'tests': ['tsvgm']}}, 09:16:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:16:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:16:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:16:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:16:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:16:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:16:28 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:16:28 INFO - 'talos_options': ['--disable-e10s'], 09:16:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:16:28 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:16:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:16:28 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:16:28 INFO - 'talos_options': ['--disable-e10s'], 09:16:28 INFO - 'tests': ['damp', 'tps']}, 09:16:28 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:16:28 INFO - 'tests': ['damp', 'tps']}, 09:16:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:16:28 INFO - 'tests': ['dromaeo_dom']}, 09:16:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:16:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:16:28 INFO - 'tests': ['basic_compositor_video']}, 09:16:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:16:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:16:28 INFO - 'tests': ['a11yr', 09:16:28 INFO - 'ts_paint', 09:16:28 INFO - 'tpaint', 09:16:28 INFO - 'sessionrestore', 09:16:28 INFO - 'sessionrestore_no_auto_restore', 09:16:28 INFO - 'tabpaint']}, 09:16:28 INFO - 'other-e10s': {'tests': ['a11yr', 09:16:28 INFO - 'ts_paint', 09:16:28 INFO - 'tpaint', 09:16:28 INFO - 'sessionrestore', 09:16:28 INFO - 'sessionrestore_no_auto_restore', 09:16:28 INFO - 'tabpaint']}, 09:16:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:16:28 INFO - 'ts_paint', 09:16:28 INFO - 'tpaint', 09:16:28 INFO - 'sessionrestore', 09:16:28 INFO - 'sessionrestore_no_auto_restore', 09:16:28 INFO - 'tabpaint']}, 09:16:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:16:28 INFO - 'ts_paint', 09:16:28 INFO - 'tpaint', 09:16:28 INFO - 'sessionrestore', 09:16:28 INFO - 'sessionrestore_no_auto_restore', 09:16:28 INFO - 'tabpaint']}, 09:16:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:16:28 INFO - 'tests': ['a11yr', 09:16:28 INFO - 'ts_paint', 09:16:28 INFO - 'tpaint', 09:16:28 INFO - 'sessionrestore', 09:16:28 INFO - 'sessionrestore_no_auto_restore', 09:16:28 INFO - 'tabpaint']}, 09:16:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:16:28 INFO - 'tests': ['a11yr', 09:16:28 INFO - 'ts_paint', 09:16:28 INFO - 'tpaint', 09:16:28 INFO - 'sessionrestore', 09:16:28 INFO - 'sessionrestore_no_auto_restore', 09:16:28 INFO - 'tabpaint']}, 09:16:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:16:28 INFO - 'tests': ['tsvgx', 09:16:28 INFO - 'tsvgr_opacity', 09:16:28 INFO - 'tart', 09:16:28 INFO - 'tscrollx', 09:16:28 INFO - 'cart', 09:16:28 INFO - 'tsvg_static']}, 09:16:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:16:28 INFO - 'tsvgr_opacity', 09:16:28 INFO - 'tart', 09:16:28 INFO - 'tscrollx', 09:16:28 INFO - 'cart', 09:16:28 INFO - 'tsvg_static']}, 09:16:28 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:16:28 INFO - 'talos_options': ['--disable-e10s'], 09:16:28 INFO - 'tests': ['tp5o']}, 09:16:28 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:16:28 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:16:28 INFO - 'talos_options': ['--disable-e10s', 09:16:28 INFO - '--xperf_path', 09:16:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:16:28 INFO - 'tests': ['tp5n']}, 09:16:28 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:16:28 INFO - 'talos_options': ['--xperf_path', 09:16:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:16:28 INFO - 'tests': ['tp5n']}}, 09:16:28 INFO - 'talos.zip': {'path': '', 09:16:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:16:28 INFO - Running post-action listener: _resource_record_post_action 09:16:28 INFO - [mozharness: 2017-02-16 17:16:28.029316Z] Finished populate-webroot step (success) 09:16:28 INFO - [mozharness: 2017-02-16 17:16:28.029452Z] Running create-virtualenv step. 09:16:28 INFO - Running pre-action listener: _resource_record_pre_action 09:16:28 INFO - Running main action method: create_virtualenv 09:16:28 INFO - Creating virtualenv /builds/slave/test/build/venv 09:16:28 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:16:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:16:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:16:28 INFO - Using real prefix '/tools/python27' 09:16:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:16:28 INFO - Installing distribute.............................................................................................................................................................................................done. 09:16:31 INFO - Installing pip.................done. 09:16:31 INFO - Return code: 0 09:16:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:16:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:16:32 INFO - Reading from file tmpfile_stdout 09:16:32 INFO - Output received: 09:16:32 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:16:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:16:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:32 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 0x10f6afb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6b2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa449cc0ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f48dd30>, '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 0x10f3b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f482be8>, '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.ig3pMQfiIv/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.fQIQgPmLkx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/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:16:32 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:16:32 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:16:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ig3pMQfiIv/Render', 09:16:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:16:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:16:32 INFO - 'HOME': '/Users/cltbld', 09:16:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:16:32 INFO - 'LOGNAME': 'cltbld', 09:16:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:32 INFO - 'MOZ_NO_REMOTE': '1', 09:16:32 INFO - 'NO_EM_RESTART': '1', 09:16:32 INFO - 'PAGER': '/bin/cat', 09:16:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:16:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:32 INFO - 'PWD': '/builds/slave/test', 09:16:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:16:32 INFO - 'SHELL': '/bin/bash', 09:16:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fQIQgPmLkx/Listeners', 09:16:32 INFO - 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/', 09:16:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:16:32 INFO - 'USER': 'cltbld', 09:16:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:16:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:16:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:32 INFO - 'XPC_FLAGS': '0x0', 09:16:32 INFO - 'XPC_SERVICE_NAME': '0', 09:16:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:16:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:32 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:16:32 INFO - Cleaning up... 09:16:32 INFO - Return code: 0 09:16:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:16:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:32 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 0x10f6afb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6b2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa449cc0ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f48dd30>, '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 0x10f3b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f482be8>, '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.ig3pMQfiIv/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.fQIQgPmLkx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/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:16:32 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:16:32 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:16:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ig3pMQfiIv/Render', 09:16:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:16:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:16:32 INFO - 'HOME': '/Users/cltbld', 09:16:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:16:32 INFO - 'LOGNAME': 'cltbld', 09:16:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:32 INFO - 'MOZ_NO_REMOTE': '1', 09:16:32 INFO - 'NO_EM_RESTART': '1', 09:16:32 INFO - 'PAGER': '/bin/cat', 09:16:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:16:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:32 INFO - 'PWD': '/builds/slave/test', 09:16:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:16:32 INFO - 'SHELL': '/bin/bash', 09:16:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fQIQgPmLkx/Listeners', 09:16:32 INFO - 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/', 09:16:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:16:32 INFO - 'USER': 'cltbld', 09:16:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:16:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:16:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:32 INFO - 'XPC_FLAGS': '0x0', 09:16:32 INFO - 'XPC_SERVICE_NAME': '0', 09:16:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:16:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:32 INFO - Downloading/unpacking psutil>=3.1.1 09:16:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:16:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:16:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:16:36 INFO - Installing collected packages: psutil 09:16:36 INFO - Running setup.py install for psutil 09:16:36 INFO - building 'psutil._psutil_osx' extension 09:16:36 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:16:36 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:16:36 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:16:36 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:16:36 INFO - building 'psutil._psutil_posix' extension 09:16:36 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:16:36 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:16:36 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:16:36 INFO - ^ 09:16:36 INFO - 1 warning generated. 09:16:36 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:16:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:16:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:16:36 INFO - Successfully installed psutil 09:16:36 INFO - Cleaning up... 09:16:36 INFO - Return code: 0 09:16:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:16:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:37 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 0x10f6afb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6b2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa449cc0ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f48dd30>, '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 0x10f3b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f482be8>, '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.ig3pMQfiIv/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.fQIQgPmLkx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/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:16:37 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:16:37 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:16:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ig3pMQfiIv/Render', 09:16:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:16:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:16:37 INFO - 'HOME': '/Users/cltbld', 09:16:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:16:37 INFO - 'LOGNAME': 'cltbld', 09:16:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:37 INFO - 'MOZ_NO_REMOTE': '1', 09:16:37 INFO - 'NO_EM_RESTART': '1', 09:16:37 INFO - 'PAGER': '/bin/cat', 09:16:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:16:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:37 INFO - 'PWD': '/builds/slave/test', 09:16:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:16:37 INFO - 'SHELL': '/bin/bash', 09:16:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fQIQgPmLkx/Listeners', 09:16:37 INFO - 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/', 09:16:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:16:37 INFO - 'USER': 'cltbld', 09:16:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:16:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:16:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:37 INFO - 'XPC_FLAGS': '0x0', 09:16:37 INFO - 'XPC_SERVICE_NAME': '0', 09:16:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:16:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:16:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:16:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:16:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:16:39 INFO - Installing collected packages: mozsystemmonitor 09:16:39 INFO - Running setup.py install for mozsystemmonitor 09:16:40 INFO - Successfully installed mozsystemmonitor 09:16:40 INFO - Cleaning up... 09:16:40 INFO - Return code: 0 09:16:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:16:40 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:16:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:40 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:16:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:40 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 0x10f6afb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6b2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa449cc0ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f48dd30>, '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 0x10f3b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f482be8>, '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.ig3pMQfiIv/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.fQIQgPmLkx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/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:16:40 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:16:40 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:16:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ig3pMQfiIv/Render', 09:16:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:16:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:16:40 INFO - 'HOME': '/Users/cltbld', 09:16:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:16:40 INFO - 'LOGNAME': 'cltbld', 09:16:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:40 INFO - 'MOZ_NO_REMOTE': '1', 09:16:40 INFO - 'NO_EM_RESTART': '1', 09:16:40 INFO - 'PAGER': '/bin/cat', 09:16:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:16:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:40 INFO - 'PWD': '/builds/slave/test', 09:16:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:16:40 INFO - 'SHELL': '/bin/bash', 09:16:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fQIQgPmLkx/Listeners', 09:16:40 INFO - 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/', 09:16:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:16:40 INFO - 'USER': 'cltbld', 09:16:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:16:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:16:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:40 INFO - 'XPC_FLAGS': '0x0', 09:16:40 INFO - 'XPC_SERVICE_NAME': '0', 09:16:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:16:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:40 INFO - Downloading/unpacking jsonschema==2.5.1 09:16:40 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:16:40 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:16:40 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:16:40 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:16:40 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:16:40 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:16:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:16:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:16:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:43 INFO - Downloading functools32-3.2.3-2.tar.gz 09:16:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:16:43 INFO - warning: no files found matching '*.txt' 09:16:43 INFO - no previously-included directories found matching 'build' 09:16:43 INFO - no previously-included directories found matching 'dist' 09:16:43 INFO - no previously-included directories found matching '.git*' 09:16:43 INFO - Installing collected packages: jsonschema, functools32 09:16:43 INFO - Running setup.py install for functools32 09:16:43 INFO - warning: no files found matching '*.txt' 09:16:43 INFO - no previously-included directories found matching 'build' 09:16:43 INFO - no previously-included directories found matching 'dist' 09:16:43 INFO - no previously-included directories found matching '.git*' 09:16:43 INFO - Successfully installed jsonschema functools32 09:16:43 INFO - Cleaning up... 09:16:43 INFO - Return code: 0 09:16:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:16:43 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:16:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:43 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:16:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:43 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 0x10f6afb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6b2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa449cc0ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f48dd30>, '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 0x10f3b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f482be8>, '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.ig3pMQfiIv/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.fQIQgPmLkx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/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:16:43 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:16:43 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:16:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ig3pMQfiIv/Render', 09:16:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:16:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:16:43 INFO - 'HOME': '/Users/cltbld', 09:16:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:16:43 INFO - 'LOGNAME': 'cltbld', 09:16:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:43 INFO - 'MOZ_NO_REMOTE': '1', 09:16:43 INFO - 'NO_EM_RESTART': '1', 09:16:43 INFO - 'PAGER': '/bin/cat', 09:16:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:16:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:43 INFO - 'PWD': '/builds/slave/test', 09:16:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:16:43 INFO - 'SHELL': '/bin/bash', 09:16:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fQIQgPmLkx/Listeners', 09:16:43 INFO - 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/', 09:16:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:16:43 INFO - 'USER': 'cltbld', 09:16:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:16:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:16:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:43 INFO - 'XPC_FLAGS': '0x0', 09:16:43 INFO - 'XPC_SERVICE_NAME': '0', 09:16:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:16:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:16:44 INFO - Cleaning up... 09:16:44 INFO - Return code: 0 09:16:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:16:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f6afb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6b2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa449cc0ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f48dd30>, '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 0x10f3b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f482be8>, '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.ig3pMQfiIv/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.fQIQgPmLkx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/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:16:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:16:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:16:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ig3pMQfiIv/Render', 09:16:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:16:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:16:44 INFO - 'HOME': '/Users/cltbld', 09:16:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:16:44 INFO - 'LOGNAME': 'cltbld', 09:16:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:44 INFO - 'MOZ_NO_REMOTE': '1', 09:16:44 INFO - 'NO_EM_RESTART': '1', 09:16:44 INFO - 'PAGER': '/bin/cat', 09:16:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:16:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:44 INFO - 'PWD': '/builds/slave/test', 09:16:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:16:44 INFO - 'SHELL': '/bin/bash', 09:16:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fQIQgPmLkx/Listeners', 09:16:44 INFO - 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/', 09:16:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:16:44 INFO - 'USER': 'cltbld', 09:16:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:16:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:16:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:44 INFO - 'XPC_FLAGS': '0x0', 09:16:44 INFO - 'XPC_SERVICE_NAME': '0', 09:16:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:16:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:44 INFO - Downloading/unpacking blobuploader==1.2.4 09:16:44 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:16:44 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:16:44 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:16:44 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:16:44 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:16:44 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:16:46 INFO - Downloading blobuploader-1.2.4.tar.gz 09:16:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:16:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:16:47 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:16:47 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:16:47 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:16:47 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:16:47 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:16:47 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:16:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:16:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:16:47 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:16:47 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:16:47 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:16:47 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:16:47 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:16:47 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:16:48 INFO - Downloading docopt-0.6.1.tar.gz 09:16:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:16:48 INFO - Installing collected packages: blobuploader, requests, docopt 09:16:48 INFO - Running setup.py install for blobuploader 09:16:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:16:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:16:48 INFO - Running setup.py install for requests 09:16:48 INFO - Running setup.py install for docopt 09:16:49 INFO - Successfully installed blobuploader requests docopt 09:16:49 INFO - Cleaning up... 09:16:49 INFO - Return code: 0 09:16:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:16:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:49 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 0x10f6afb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6b2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa449cc0ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f48dd30>, '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 0x10f3b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f482be8>, '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.ig3pMQfiIv/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.fQIQgPmLkx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/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:16:49 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:16:49 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:16:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ig3pMQfiIv/Render', 09:16:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:16:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:16:49 INFO - 'HOME': '/Users/cltbld', 09:16:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:16:49 INFO - 'LOGNAME': 'cltbld', 09:16:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:49 INFO - 'MOZ_NO_REMOTE': '1', 09:16:49 INFO - 'NO_EM_RESTART': '1', 09:16:49 INFO - 'PAGER': '/bin/cat', 09:16:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:16:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:49 INFO - 'PWD': '/builds/slave/test', 09:16:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:16:49 INFO - 'SHELL': '/bin/bash', 09:16:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fQIQgPmLkx/Listeners', 09:16:49 INFO - 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/', 09:16:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:16:49 INFO - 'USER': 'cltbld', 09:16:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:16:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:16:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:49 INFO - 'XPC_FLAGS': '0x0', 09:16:49 INFO - 'XPC_SERVICE_NAME': '0', 09:16:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:16:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:16:49 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-qdPezD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:16:49 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-Z6quAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:16:49 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-7l7dA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:16:49 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-rsh6dj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:16:49 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-XPlJd4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:16:49 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-hM63jx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:16:50 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-xwK7Ez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:16:50 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-5G6Vay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:16:50 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-rMmXHh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:16:50 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-ozM5Fh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:16:50 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-pV5vFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:16:50 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-Ay3Xfg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:16:50 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-mBh8FC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:16:50 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-U7mSGV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:16:50 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-rnF8xB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:16:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:16:51 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-lVMlbC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:16:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:16:51 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-3yciQR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:16:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:16:51 INFO - Running setup.py install for manifestparser 09:16:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:16:51 INFO - Running setup.py install for mozcrash 09:16:51 INFO - Running setup.py install for mozdebug 09:16:51 INFO - Running setup.py install for mozdevice 09:16:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:16:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:16:51 INFO - Running setup.py install for mozfile 09:16:51 INFO - Running setup.py install for mozhttpd 09:16:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:16:52 INFO - Running setup.py install for mozinfo 09:16:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:16:52 INFO - Running setup.py install for mozInstall 09:16:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:16:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:16:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:16:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:16:52 INFO - Running setup.py install for mozleak 09:16:52 INFO - Running setup.py install for mozlog 09:16:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:16:52 INFO - Running setup.py install for moznetwork 09:16:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:16:52 INFO - Running setup.py install for mozprocess 09:16:52 INFO - Running setup.py install for mozprofile 09:16:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:16:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:16:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:16:53 INFO - Running setup.py install for mozrunner 09:16:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:16:53 INFO - Running setup.py install for mozscreenshot 09:16:53 INFO - Running setup.py install for moztest 09:16:53 INFO - Running setup.py install for mozversion 09:16:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:16:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:16:53 INFO - Cleaning up... 09:16:53 INFO - Return code: 0 09:16:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:16:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:53 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 0x10f6afb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6b2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa449cc0ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f48dd30>, '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 0x10f3b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f482be8>, '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.ig3pMQfiIv/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.fQIQgPmLkx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/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:16:53 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:16:53 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:16:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ig3pMQfiIv/Render', 09:16:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:16:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:16:53 INFO - 'HOME': '/Users/cltbld', 09:16:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:16:53 INFO - 'LOGNAME': 'cltbld', 09:16:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:53 INFO - 'MOZ_NO_REMOTE': '1', 09:16:53 INFO - 'NO_EM_RESTART': '1', 09:16:53 INFO - 'PAGER': '/bin/cat', 09:16:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:16:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:53 INFO - 'PWD': '/builds/slave/test', 09:16:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:16:53 INFO - 'SHELL': '/bin/bash', 09:16:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fQIQgPmLkx/Listeners', 09:16:53 INFO - 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/', 09:16:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:16:53 INFO - 'USER': 'cltbld', 09:16:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:16:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:16:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:53 INFO - 'XPC_FLAGS': '0x0', 09:16:53 INFO - 'XPC_SERVICE_NAME': '0', 09:16:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:16:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:16:54 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-gm26Rv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:16:54 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:16:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:16:54 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-n0RkCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:16:54 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:16:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:16:54 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-C5XbLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:16:54 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:16:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:16:54 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-czNxM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:16:54 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:16:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:16:54 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-k8VoDm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:16:54 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:16:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:16:54 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-AXRSeb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:16:54 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:16:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:16:54 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-ZIvU8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:16:54 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:16:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:16:54 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-YUUHoz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:16:54 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:16:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:16:54 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-V8W5vn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:16:55 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:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:16:55 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-Nwmma9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:16:55 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:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:16:55 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-iHqOQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:16:55 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:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:16:55 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-TcejyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:16:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:16:55 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-3kHF0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:16:55 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:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:16:55 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-8T6kWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:16:55 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:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:16:55 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-YccxF9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:16:55 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:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:16:55 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-SQNmsM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:16:55 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:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:16:55 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-KrJko1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:16:55 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:16:55 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:16:55 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:16:55 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:16:55 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:16:55 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:16:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:16:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:58 INFO - Downloading blessings-1.6.tar.gz 09:16:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:16:58 INFO - Installing collected packages: blessings 09:16:58 INFO - Running setup.py install for blessings 09:16:58 INFO - Successfully installed blessings 09:16:58 INFO - Cleaning up... 09:16:58 INFO - Return code: 0 09:16:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:16:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:16:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:16:59 INFO - Reading from file tmpfile_stdout 09:16:59 INFO - Current package versions: 09:16:59 INFO - blessings == 1.6 09:16:59 INFO - blobuploader == 1.2.4 09:16:59 INFO - docopt == 0.6.1 09:16:59 INFO - functools32 == 3.2.3-2 09:16:59 INFO - jsonschema == 2.5.1 09:16:59 INFO - manifestparser == 1.1 09:16:59 INFO - mozInstall == 1.12 09:16:59 INFO - mozcrash == 1.0 09:16:59 INFO - mozdebug == 0.1 09:16:59 INFO - mozdevice == 0.49 09:16:59 INFO - mozfile == 1.2 09:16:59 INFO - mozhttpd == 0.7 09:16:59 INFO - mozinfo == 0.9 09:16:59 INFO - mozleak == 0.1 09:16:59 INFO - mozlog == 3.4 09:16:59 INFO - moznetwork == 0.27 09:16:59 INFO - mozprocess == 0.24 09:16:59 INFO - mozprofile == 0.28 09:16:59 INFO - mozrunner == 6.13 09:16:59 INFO - mozscreenshot == 0.1 09:16:59 INFO - mozsystemmonitor == 0.3 09:16:59 INFO - moztest == 0.8 09:16:59 INFO - mozversion == 1.4 09:16:59 INFO - psutil == 3.1.1 09:16:59 INFO - requests == 1.2.3 09:16:59 INFO - wsgiref == 0.1.2 09:16:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:16:59 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:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:59 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:16:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:59 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 0x10f6afb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6b2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa449cc0ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f48dd30>, '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 0x10f3b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f482be8>, '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.ig3pMQfiIv/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.fQIQgPmLkx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/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:16:59 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:16:59 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:16:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ig3pMQfiIv/Render', 09:16:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:16:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:16:59 INFO - 'HOME': '/Users/cltbld', 09:16:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:16:59 INFO - 'LOGNAME': 'cltbld', 09:16:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:59 INFO - 'MOZ_NO_REMOTE': '1', 09:16:59 INFO - 'NO_EM_RESTART': '1', 09:16:59 INFO - 'PAGER': '/bin/cat', 09:16:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:16:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:59 INFO - 'PWD': '/builds/slave/test', 09:16:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:16:59 INFO - 'SHELL': '/bin/bash', 09:16:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fQIQgPmLkx/Listeners', 09:16:59 INFO - 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/', 09:16:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:16:59 INFO - 'USER': 'cltbld', 09:16:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:16:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:16:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:59 INFO - 'XPC_FLAGS': '0x0', 09:16:59 INFO - 'XPC_SERVICE_NAME': '0', 09:16:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:17:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:00 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:17:00 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:17:00 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:17:00 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:17:00 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:17:00 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:17:00 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:17:00 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:17:00 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:17:00 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:17:00 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:17:00 INFO - Cleaning up... 09:17:00 INFO - Return code: 0 09:17:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:17:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:17:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:17:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:00 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 0x10f6afb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6b2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa449cc0ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f48dd30>, '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 0x10f3b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f482be8>, '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.ig3pMQfiIv/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.fQIQgPmLkx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/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:17:00 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:17:00 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:17:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ig3pMQfiIv/Render', 09:17:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:17:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:17:00 INFO - 'HOME': '/Users/cltbld', 09:17:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:17:00 INFO - 'LOGNAME': 'cltbld', 09:17:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:00 INFO - 'MOZ_NO_REMOTE': '1', 09:17:00 INFO - 'NO_EM_RESTART': '1', 09:17:00 INFO - 'PAGER': '/bin/cat', 09:17:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:17:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:00 INFO - 'PWD': '/builds/slave/test', 09:17:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:17:00 INFO - 'SHELL': '/bin/bash', 09:17:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fQIQgPmLkx/Listeners', 09:17:00 INFO - 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/', 09:17:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:17:00 INFO - 'USER': 'cltbld', 09:17:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:17:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:17:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:00 INFO - 'XPC_FLAGS': '0x0', 09:17:00 INFO - 'XPC_SERVICE_NAME': '0', 09:17:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:17:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:17:00 INFO - Cleaning up... 09:17:00 INFO - Return code: 0 09:17:00 INFO - Running post-action listener: _resource_record_post_action 09:17:00 INFO - Running post-action listener: _start_resource_monitoring 09:17:00 INFO - Starting resource monitoring. 09:17:00 INFO - [mozharness: 2017-02-16 17:17:00.709435Z] Finished create-virtualenv step (success) 09:17:00 INFO - [mozharness: 2017-02-16 17:17:00.710356Z] Running install step. 09:17:00 INFO - Running pre-action listener: _resource_record_pre_action 09:17:00 INFO - Running main action method: install 09:17:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:17:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:17:00 INFO - Reading from file tmpfile_stdout 09:17:00 INFO - Detecting whether we're running mozinstall >=1.0... 09:17:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:17:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:17:01 INFO - Reading from file tmpfile_stdout 09:17:01 INFO - Output received: 09:17:01 INFO - Usage: mozinstall [options] installer 09:17:01 INFO - Options: 09:17:01 INFO - -h, --help show this help message and exit 09:17:01 INFO - -d DEST, --destination=DEST 09:17:01 INFO - Directory to install application into. [default: 09:17:01 INFO - "/builds/slave/test"] 09:17:01 INFO - --app=APP Application being installed. [default: firefox] 09:17:01 INFO - mkdir: /builds/slave/test/build/application 09:17:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:17:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 09:17:20 INFO - Reading from file tmpfile_stdout 09:17:20 INFO - Output received: 09:17:20 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 09:17:20 INFO - Running post-action listener: _resource_record_post_action 09:17:20 INFO - [mozharness: 2017-02-16 17:17:20.879144Z] Finished install step (success) 09:17:20 INFO - [mozharness: 2017-02-16 17:17:20.879304Z] Running run-tests step. 09:17:20 INFO - Running pre-action listener: _resource_record_pre_action 09:17:20 INFO - Running main action method: run_tests 09:17:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:17:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:17:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:17:20 INFO - 2017-02-16 09:17:20.893 screenresolution[1896:14336] starting screenresolution argv=screenresolution get 09:17:20 INFO - 2017-02-16 09:17:20.896 screenresolution[1896:14336] Display 0: 1600x1200x32@60 09:17:20 INFO - 2017-02-16 09:17:20.902 screenresolution[1897:14339] starting screenresolution argv=screenresolution list 09:17:20 INFO - Available Modes on Display 0 09:17:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:17:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:17:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:17:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:17:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:17:21 INFO - Intel Iris: 09:17:21 INFO - Chipset Model: Intel Iris 09:17:21 INFO - Type: GPU 09:17:21 INFO - Bus: Built-In 09:17:21 INFO - VRAM (Dynamic, Max): 1536 MB 09:17:21 INFO - Vendor: Intel (0x8086) 09:17:21 INFO - Device ID: 0x0a2e 09:17:21 INFO - Revision ID: 0x0009 09:17:21 INFO - Displays: 09:17:21 INFO - Display: 09:17:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:17:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:17:21 INFO - Display Serial Number: 1600x1200 60 09:17:21 INFO - Main Display: Yes 09:17:21 INFO - Mirror: Off 09:17:21 INFO - Online: Yes 09:17:21 INFO - Rotation: Supported 09:17:21 INFO - Return code: 0 09:17:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:17:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:17:21 INFO - Python 2.7.3 09:17:21 INFO - Return code: 0 09:17:21 INFO - grabbing minidump binary from tooltool 09:17: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:17:21 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 0x10f48dd30>, '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 0x10f3b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f482be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:17:21 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:17:21 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:17:21 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:17:21 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:17:21 INFO - Return code: 0 09:17:21 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:17:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:17:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:17:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:17:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:17:21 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/AI3csdEBTJWqq6xAd0V81g/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0329', '--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:17:21 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/AI3csdEBTJWqq6xAd0V81g/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0329 --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:17:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ig3pMQfiIv/Render', 09:17:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:17:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:17:21 INFO - 'HOME': '/Users/cltbld', 09:17:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:17:21 INFO - 'LOGNAME': 'cltbld', 09:17:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:17:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:17:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:21 INFO - 'MOZ_NO_REMOTE': '1', 09:17:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:17:21 INFO - 'NO_EM_RESTART': '1', 09:17:21 INFO - 'PAGER': '/bin/cat', 09:17:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:17:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:21 INFO - 'PWD': '/builds/slave/test', 09:17:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:17:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:17:21 INFO - 'SHELL': '/bin/bash', 09:17:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fQIQgPmLkx/Listeners', 09:17:21 INFO - 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/', 09:17:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:17:21 INFO - 'USER': 'cltbld', 09:17:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:17:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:17:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:21 INFO - 'XPC_FLAGS': '0x0', 09:17:21 INFO - 'XPC_SERVICE_NAME': '0', 09:17:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:17:21 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/AI3csdEBTJWqq6xAd0V81g/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0329', '--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:17:21 INFO - mozversion application_buildid: 20170216073239 09:17:21 INFO - mozversion application_changeset: 3afbdf81cbf92638d71dfe6b159ed2de69cdda62 09:17:21 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:17:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:17:21 INFO - mozversion application_name: Firefox 09:17:21 INFO - mozversion application_remotingname: firefox-dev 09:17:21 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:17:21 INFO - mozversion application_vendor: Mozilla 09:17:21 INFO - mozversion application_version: 53.0a2 09:17:21 INFO - mozversion platform_buildid: 20170216073239 09:17:21 INFO - mozversion platform_changeset: 3afbdf81cbf92638d71dfe6b159ed2de69cdda62 09:17:21 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:17:21 INFO - mozversion platform_version: 53.0a2 09:17:21 INFO - using testdate: 1487265441 09:17:21 INFO - actual date: 1487265441 09:17:21 INFO - starting webserver on 'localhost:52447' 09:17:21 INFO - SUITE-START | Running 2 tests 09:17:21 INFO - TEST-START | dromaeo_css 09:17:21 INFO - operating with platform_type : mac_ 09:17:21 INFO - Initialising browser for dromaeo_css test... 09:17:21 INFO - TEST-INFO | started process 1907 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/tmpnjMMlr/profile http://localhost:52447/getInfo.html) 09:17:23 INFO - PROCESS | 1907 | __metrics Screen width/height:1600/1200 09:17:23 INFO - PROCESS | 1907 | colorDepth:24 09:17:23 INFO - PROCESS | 1907 | Browser inner width/height: 1024/689 09:17:23 INFO - PROCESS | 1907 | __metrics 09:17:23 INFO - PROCESS | 1907 | 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:17:23 INFO - PROCESS | 1907 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:17:24 INFO - TEST-INFO | 1907: exit 0 09:17:24 INFO - Browser initialized. 09:17:24 INFO - Running cycle 1/1 for dromaeo_css test... 09:17:24 INFO - TEST-INFO | started process 1909 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/tmpnjMMlr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:17:36 INFO - PROCESS | 1909 | RSS: Main: 213504000 09:17:36 INFO - PROCESS | 1909 | 09:20:41 INFO - PROCESS | 1909 | Cycle 1(1): loaded http://localhost:52447/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52447/tests/dromaeo/cssquery-ext.html) 09:20:42 INFO - PROCESS | 1909 | RSS: Main: 378257408 09:20:42 INFO - PROCESS | 1909 | 09:22:26 INFO - PROCESS | 1909 | ************************* 09:22:26 INFO - PROCESS | 1909 | A coding exception was thrown and uncaught in a Task. 09:22:26 INFO - PROCESS | 1909 | 09:22:26 ERROR - PROCESS | 1909 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:22:26 INFO - PROCESS | 1909 | Full stack: 09:22:26 INFO - PROCESS | 1909 | ************************* 09:23:45 INFO - PROCESS | 1909 | Cycle 1(1): loaded http://localhost:52447/tests/dromaeo/cssquery-ext.html (next: http://localhost:52447/tests/dromaeo/cssquery-jquery.html) 09:23:46 INFO - PROCESS | 1909 | RSS: Main: 367775744 09:23:46 INFO - PROCESS | 1909 | 09:26:48 INFO - PROCESS | 1909 | Cycle 1(1): loaded http://localhost:52447/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52447/tests/dromaeo/cssquery-mootools.html) 09:26:49 INFO - PROCESS | 1909 | RSS: Main: 349708288 09:26:49 INFO - PROCESS | 1909 | 09:29:51 INFO - PROCESS | 1909 | Cycle 1(1): loaded http://localhost:52447/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52447/tests/dromaeo/cssquery-prototype.html) 09:29:52 INFO - PROCESS | 1909 | RSS: Main: 318156800 09:29:52 INFO - PROCESS | 1909 | 09:32:55 INFO - PROCESS | 1909 | Cycle 1(1): loaded http://localhost:52447/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52447/tests/dromaeo/cssquery-yui.html) 09:32:56 INFO - PROCESS | 1909 | RSS: Main: 311984128 09:32:56 INFO - PROCESS | 1909 | 09:35:59 INFO - PROCESS | 1909 | Cycle 1(1): loaded http://localhost:52447/tests/dromaeo/cssquery-yui.html (next: http://localhost:52447/tests/dromaeo/cssquery-dojo.html) 09:35:59 INFO - PROCESS | 1909 | RSS: Main: 441188352 09:35:59 INFO - PROCESS | 1909 | 09:35:59 INFO - PROCESS | 1909 | __start_tp_report 09:35:59 INFO - PROCESS | 1909 | _x_x_mozilla_page_load 09:35:59 INFO - PROCESS | 1909 | _x_x_mozilla_page_load_details 09:35:59 INFO - PROCESS | 1909 | |i|pagename|runs| 09:35:59 INFO - PROCESS | 1909 | |0;dojo.html;3297.98351008245;3315.1712071982006;3331.0673011556755;3344.331133773243;3392.372411103946;5666.716664166791;5719.628224165426;5734.225879506265;5754.769809207632;5760.164776107462;5589.105743081108;5635.943640563593;5700.315962084545;5725.4847063764255;5735.942640573593;5098.4391716911205;5176;5213.32226810516;5229.450907654698;5268.947310526884;5118.1555043417975;5127.154019586764;5136.126858434057;5278.868028299285;5321.467853214686;5201.141811601081;5209.921851172236;5223.921641175385;5229.163333866582;5230.973845130788;5190.71451070191;5205.817796377128;5228.816991405282;5231.843044708665;5231.895362092756;4998.625103117244;5111.284420181178;5128.102582048126;5168.8449346519665;5227.686338819645;4126.277901367249;5537.141743029837;5759.280089988752;5772.971135144339;5787.479126878559;6182.319944806068;6183.6598987055695;6196.380361963813;6204.410580994843;6205.906911396332;5388.191771234347;6123.018364072999;6141.578063794062;6146.508279337642;6233.812985610439;4843.951560484421;4915.754212289371;5805.448482394208;5811.389804070596;5826.621269617462;6218.626882387071;6220.253569571681;6222.688865556704;6223.190985171898;6231.501479881598;5967.910481342783;6007.429294217042;6022.57841951068;6105.32841387447;6120.112583675342;6117.705611546597;6126.884121540732;6174.567780255429;6193.845153871099;6211.09939058843;6158.784442544579;6173.32093469718;6177.62934223948;6188.845278867974;6200.0699895015205;6083.8174854754425;6169.290531588835;6186.133941248228;6209.59637623553;6212.782552610637;4910.165271903785;4941.184704523714;4953.306537084811;4974.850754477371;4993.925091123636;4414.977925110354;4420.182266280748;4426.004149066434;4465.12929978651;4466.531014243457;5736.827895163152;5753.769849206069;5771.913421298684;5774.133879918046;5790.392008839095;6060.909086363708;6121.392004143319;6147.477464415575;6171.6297022178815;6239.282482514569;5752.338481074647;5760.971195143998;5792.739326730307;5826.096954971986;5843.941560584425;5313.229581710631;5321.122014867504;5352.330958630171;5358.946410535923;5408.864778380494;6162.815115546541;6182.567220294626;6222.408871157233;6230.034344676583;6232.688365581794;6138.386161383826;6248.250209974651;6261.530385221035;6265.15420418256;6274.341194174728;6153.169322141453;6186.597871138361;6196.969015155076;6206.627602343874;6226.066090086523;6167.876642467036;6172.783952561639;6172.98145805937;6177.413145751147;6182.629042257299;6210;6233.470155036873;6242.656653883898;6244.1570387997035;6244.750209991731;5994;6050.122732203894;6060.666663333559;6068.150458935841;6102.9694851525455;5997.730102145501;6109.48069414087;6120.234970628671;6129.847850912788;6134.4978165938865;5838.211841401527;5972.984592619352;5974;5984.790532331347;5996.980513312835;5906.852328691817;5982.461578457785;6033.064874944391;6128.601640893327;6141.232345956755;5840.2991641003355;5901.616394934315;5924.6445213285615;5940.524758019435;5960.284765828128 09:35:59 INFO - PROCESS | 1909 | |1;ext.html;498.990020199596;501.7206124382825;503.8639567316822;507.95936325094;513.304472439844;31219.219519512022;41404.79297603512;42666;42671.35992960108;44670.77664611681;44798.77600612;45061.324080138744;45136;45141;45239.54760452395;8401.873971890427;9093.363464557468;9309.72070837876;9317.534123293843;9319.767005824875;8404.621792019343;11137.777244455106;11334.659960201207;11380.374079425628;11564.537418503292;11335.659930202108;11363.375014374205;11382.146339024564;11403.258788178784;11412.486438110263;8475.110113438062;9756.121949024622;11202.831957520644;11277.492512836941;11321.20751547388;8471.06818249992;10995.945020274847;11207.607733729363;11212.719682008015;11431.142664300127;41351.379729304084;41627.7918610405;41748;41776.37335439971;41886.371704424455;3964.5044369453817;3975;4004.7196696231276;4006.399040143973;4038.353863381845;29600.407991840042;29641.40717185666;29716.70283297161;30573.08280751581;30700.692993070006;2998.7600991920594;3144.7326977206735;3146.1348129264406;3228.660990595977;3240.821754803485;473429;473962;474580;475056;475187.6240618809;65211.34788652148;65596.67201664057;65715.67142164259;65730.01404978929;65798;69433.65283173653;69467.65266173637;69634.60730785457;69656;69667.3033269671;16533.58666033359;16671.0830904299;16830.495085147464;16846.747298790528;16864.241109150116;11663.008644265332;11966.760664786656;13013.479460821462;13077.542286019943;13149.342532873317;16290.185490725416;18487.11727107052;18632.81367186338;22002;22633.886830566073;7371.741989030358;7558;8768.5177315247;8944.37389382737;9014.323925705598;774.3456779021718;792.4254915186443;797.2346547314527;806.8749343851713;828.1718281718282;30347.241318967204;30356;30455.543166852072;30607.7530058247;31033.844830775703;1019.4087429290994;1039.2517387481003;1045.4824861693357;1070.0583486531802;1092.7869065532145;15835.366585336458;15864.365425382855;15865.841341586436;15870.603234918988;16257.430989915296;676881;679959.2004079995;679972;681000;683463.5826820834;62939.6853015732;63653.68173159197;63776.72446551043;63844.68077659582;63849.680751595944;1400.4958215042577;1425.4369524037947;1437.3819257719072;1440.2510694439043;1454.301935071193;27891.721082789725;29796.404071918874;29811.70188298176;30528.626211820076;30665.693343066283;53789.924201514965;54059.72970135124;54088.45911540834;54103;54123;516948;518295;518487;518648;519623;43330.783346083066;44506.777466112464;44648.77675611731;44764.552354476036;44910.775446123866;46337.53662463467;48711.57502772891;49576.752116240634;49669.75825604389;49839.75080124576;37533.62466375301;39708.007299817735;40529.37882484785;40610.96852963848;41147.97130071772;33791.83104084464;34724.82637586897;39091.6090839088;39256.607433925295;40584;38069.42895856509;38260.61739382682;38890.80554597209;38953.805230974795;39016.41475377928;31197;34527.65472345345;34807.82596087003;34917;35048;22643.320700379016;23484.137600574537;24861.502769944862;25319.493610128062;25486.23541293764 09:35:59 INFO - PROCESS | 1909 | |2;jquery.html;370.3611270558289;393.5356279590084;394.63299131807406;406.3620116417225;427.84811391955856;14379.577768203351;16368.59078523036;19212.13545390457;20193.19227230909;20580.38258852233;20702.585948281063;20822;21362.57274854502;21864.45338866525;22101.778982210173;5536;5667.178259152421;5744.655320680752;5798.10129429939;5900;5692.77228910843;5800.651960882339;5812.331581868097;5812.796552120677;5815;4124.8762537123785;4347.826086956518;6192.8451788705415;6561.212654481469;6578.8684226315445;6327.5570710050315;6431.389018043278;6496.9675151624415;6596.43930265928;6597.604143751366;5776.797812076557;5782.56630752691;5786.797462088806;5796.072628379439;5806.680632565207;26751.331216719736;28010.719892801015;28034.299142521395;28044.298892527648;28330.43339133206;2651.231142968537;2767.9723202767914;2768.750812426891;2770.6536682914634;2783.7633801126926;15037.323320450496;15900;15996.040237585783;16178.029318240826;16466.42367517143;1828.2778302570543;2040.9795902040937;2163.9242626508153;2173.5109600339956;2177.967330490044;103909;130848.34575827155;133671.33164334213;135441.6455835449;139452;19827.30604428838;21433.57132857334;21662.35012949614;22679.433014174778;23552.76447235506;41652.37521437181;41741;42601;42618.360724589154;42773.358399624034;8487.278581320657;8673.913260867437;8965.131158029499;8985.146411090936;9074.500902450429;8690.826183476294;8741.606627701769;8749.912500875038;8926.509042002752;8948.060453652273;4141.689373297015;4813.711177329302;4889.951100489021;4895.730734809548;4978.402591688948;1757.7099778536654;2008.096356639489;2037.5822956293923;2050.3643870399924;2058.5574101568236;1018.1142406106735;1024.0680980307884;1030.701096681954;1035.5081336365167;1077.0414331245197;21781;22016.952187667714;22183;22186.675197952696;22351.888240558692;1051.1433181956681;1053.2995557954027;1079.63292480557;1084.208527774729;1089.8910108989196;10998.285111467729;11420.086393088533;11422.25755325901;11425.2002359834;11473.139514536444;699900;732205;735496.8701877905;754264;759579;148765.25617371843;151035.24482377517;151168.2441587807;152917.47082529255;157407;1010.7927874785652;1022.8261195596617;1045.2526443592867;1045.9738506537244;1050.207093644309;17133.657326853143;19143.234270629575;19230.519237018627;19280.517987050436;19317.8068219316;56083;56676.716616416656;56758.432415675314;57330.71334643467;57968.71015644895;81056.18943810722;81123.59438202772;82881.342373151;83184.58407707923;84790.57604711936;7873.133955265031;8182.181781822008;8316.334693224648;8376.49741015541;8620.741377758677;8878.284930774687;12619.915148490143;12678.366081696062;12809.295488748208;12978.545750898673;10823.188260880308;11080.501377438195;11221.102311814871;11283.830742539032;11368.090552755924;10729.517171727448;10817.51321190564;10817.972292632187;11002.944985275022;11152.665420037412;10754.462276886281;11124.189823437318;11259;11314.886851131383;11517.25137866036;8099.623064079238;8101.554414507259;8404.243618074403;8474.719674309497;8598.742037738877;8203.671853126047;8936.731898043068;10795.892041079489;10811.513481893177;11008.449577520933 09:35:59 INFO - PROCESS | 1909 | |3;mootools.html;1421.0620990146506;1440.258266992499;1460.386637612203;1460.656745664769;1468.0384348251898;8108.756737297883;8482.915170848306;8486.278666313356;8497.02284237313;8512.872306915393;7145.535540189884;7337.33963943245;7641.61791910405;7657.923420765791;8002.95998520008;2318.4783423729696;2348.4598542335275;2354.105439932823;2359.634256690216;2360.2919124262653;2335.4044718596733;2341.2976107167783;2361.9645705314433;2369.680093187415;2380.3573035280465;2317.9420514487106;2320.3503019154664;2345.44881952741;2346.9178578749747;2350.5533948549805;2299.5171014087064;2305.6310990241564;2327.5461285049423;2334.2297041976108;2340.1107579119994;2297;2352.9647055294186;2355.4229213842546;2356.929292121239;2362.5038741864228;8365.581720913991;8444.324454043723;8450.78873028173;8457.534835584102;8463.95768021162;5032.119379108642;5061.246996730843;5110.233464980282;5195.428502864682;5200.713960732158;3302.3065156317202;3426.674465925733;3487.9476807847905;3549.982250088733;3568.6074531801482;1161.6398916335963;1224.577520755338;1232.2975903734875;1238.4303220518573;1250.974980500394;10860.45697715111;10952.34285942838;10965.013148816644;10966.396848173346;10971.725706857313;3947.585503522089;4329.502107257643;4631.791569379386;4713.434387873409;4724.905501889943;9431.528423578931;9511.667091651898;9520.285978551636;9522.285828562886;9522.285828562886;5214.9478505214465;5221.269022336875;5222.92165617516;5231.869203269949;5240.082985477527;4266.530681625019;4398.978005110018;4465.486469056035;4684.508126646653;4808.831690890872;3815.809209539512;3849.8845034649007;3945.704072194597;3969.226000929791;3971.0667993021616;1145.4444594371723;1240.169086711887;1254.4982007197011;1274.0826604844497;1279.9360031998363;672.8553361027402;804.8008467383556;886.259972922604;925.643627203518;941.6233506597279;5492.917606235909;5500.662218557097;5680.5171560417;5682;5805.8548536286935;992.1120597065586;997.7056768253383;1015.3856916565371;1024.1908891975404;1057.6562617149457;3645.5989841117457;3686.7419280650097;3772.320982223171;3848.6728628066926;3876.26350993316;9864.704058878246;10140.949295253477;10141.492925353703;10143.036411540892;10148.340357876714;9262.861057084148;9883.061109194616;9902.752431189278;10119.544620492095;10129.797404052026;7846.215378462108;7883.132855385903;7966.402519811038;7995.40034497415;8034.839303213903;4981.42713587942;5386.973065134649;5393.568514518751;5540.806071787468;5547.5007249347755;8894.911050889408;8947.463152210888;9207.079292070739;9352.298577606844;9358;9104.726858194264;9153.130452606993;9335.159835614828;9483.715488535356;9548.52257387114;7056.54132481387;7065.399441047569;7749.457537972288;7918.485298455582;7936.047674278892;7636.427267954815;7766.728164514441;7853.921460785319;7960.044794624682;7967.9203207967175;6966.338197871194;7050.5769653820935;7095.9645201773665;7134.892976605459;7198.424126070006;6886.793396198122;7003.124609423822;7028.332308430691;7047.6828542714675;7063.505554611128;6295.811125666238;6351.618902865843;6417.93582064192;6438.7746428876635;6441.066045423481;4990.650654454299;5002.949970500248;5014.423341315795;5027.195648696191;5107.208382700687;4937.5556199942175;4979.71744299909;5090;5153.6907785532985;5182.922256166085 09:35:59 INFO - PROCESS | 1909 | |4;prototype.html;354.59398988158557;365.81526329203746;371.7453544322138;373.9719521035923;376.4898562447885;4532.376975485007;4542.863714088574;4682.180618391785;5226.398964119127;5352.759125839337;4494.617957473619;4599;5275.997560463509;5282.418933917266;5286.4449232830575;3286.342731453707;3957.366821308591;4094.5905409458965;4105.507339119295;4196.433481480007;3611.855525778966;4080.6327430531246;4107.568705285947;4140.296149654566;4158.97920510397;3776.8678096266635;3875.028096201402;4131.917361652765;4167.895212917472;4169.353750168729;3869.2454971280613;3914.4911161548957;4090.365993271048;4109.835606575733;4171.91656166875;3657.3965295726175;3658.2866341063504;3659.597444281127;3661.8831256466765;3691.870784522556;5118.744062796883;5170.379554453452;5176.275321454999;5180.870478238036;5211.374635043819;4590.449146102489;4696.66145148631;4717.198076327033;4749;4777.402824646919;5569.777208911639;5573.749181286852;5576.749046292886;5593.3847276799515;5603.579731520112;4052.37188235821;4063.2482990646827;4065.532463766675;4087.7751723655188;4105.117399759066;5573.526250268732;5726.5705072119345;5767.88464230713;5824.912626310566;5917.485068845724;3973.0663294125857;4072.1041370898356;4080.489938757655;4095.610916962884;4107.609777071233;4187.43469631602;4190.979045104755;4191.350340697197;4194.937075943863;4195.244855925902;4552.292890166188;4652.697574657636;4754.429468463737;4762.333273341735;4784.712917224978;4943.629227807929;5408.648437851527;5561.499465048084;5577.2191893135;5599.524040456526;1297.4485843516468;1341.4567100324384;1350.696093378982;1351.4729255590328;1361.5370773936909;866.77463859397;888.2668532773502;908.1191244492832;944.3719926249105;966.0677446264389;4254.532001479834;4469.0280963159785;4726.692764970266;5110.207917772751;5153;4931.556159945622;5698.7435565399655;5704;5705.686187259741;5705.690699394341;4326.480822301344;5122.259591118734;5135.229715542699;5150.532098352027;5153;2600.0379859452123;2812.718728127171;2816.155153453956;2865.867982147082;2873.741363277315;5222.007818514546;5376.623636345496;5603.719814009283;5620.398186516823;5635.408282130399;4827;4877.3903262092235;4879.926801097987;5349.93353053426;5587.8603034923635;4508;5194.844154675366;5295.655782374133;5456.536194423518;5619.999999999918;4922.630802689884;5114.5652619527755;5159.535641792257;5435.043384381541;5471.72641367922;5289.418164002033;5423.430539793423;5544.833654990357;5690.338113577018;5745.621050947659;5321.946780532146;5982.641041537521;6003.939960600338;6004.669743164168;6027.57806953509;3875.5349358076082;3886.9028274292236;3911.882643520699;3913.5385660347797;3927.7250592458254;4899.828506002273;5227.398849132398;5434.994526012701;5604.935062338142;5766.971165144148;4976.452590215146;5574.352182713179;5579.358373787067;5607.5513958882375;5624.015797235385;4310.43964284641;4709.929351059805;5412.8646783829145;5580;5594.356648985418;4623.768811559476;4957.603391728581;5048.7475626219275;5452.563794896478;5457.890842183055;5233.528982391603;5288.889333240063;5398.730063496888;5442.945570544244;5599.020171469895;4792.472827988988;5019.749012549285;5228.738563071755;5339.941644350244;5487.396386397413 09:35:59 INFO - PROCESS | 1909 | |5;yui.html;693.9548929319591;709.528163771092;711.7366574367485;740.4039748002857;815.6044318505526;14018.369173387196;14555;14561.271936403191;14610.123392596452;14645.707085858276;11101.4449277536;13689.794653080211;13702;13716.657083572916;13733.450661973535;641.473991327112;680.1667956752975;871.8648609465542;880.3265501891059;896.3501461440469;857.5712143928037;874.7725591346264;875.5315905990296;877.9736607901741;883.9878339301496;890.6081324217324;933.6405483888718;935.822193783179;936.4802534593298;938.4041133879967;925.3846192282158;926.4672813132443;928;928.5774972387615;929.2937367600605;697.285282585349;698.0227681246245;698.2458944340101;699.2308460693248;700.5061431690646;14237.216953067576;14631.195284259362;14642.853571464362;14812.851871481254;15131;13561.932190338985;13960.650983725387;13970.161790292615;14001.29993500321;14088.647783805385;11332.320060796379;11378.943105284503;11423.94288028563;11617.302961822317;12063.638090857288;3603.891883243507;3707.2214834884708;3713.294474049949;3727.8881633551036;3853.171568112841;99638.50180749122;102405.97594024039;103188;103540;105537;10220.948895255477;10290.845637315297;10601.151907847354;10649.89350106489;10655.520501577448;21578.676319855214;21856.672149917766;21961.78038219629;21997.340079797632;22004.88997555002;7559.3196612305155;7559.622018899033;7572.583507907118;7573.848523029508;7801.180876008051;4124.670026397881;4177.49870015594;4183.874483765492;4225.535191128974;4318;2916.941661166765;3329.0845017619863;3402.6937575618313;3403.9659603403647;3423.7603367764514;585.0814221671934;585.9765609375662;591.7278052096084;596.764278110144;600.3066458240739;644.3492073006204;673.1484671890063;675.4630069095081;683.5112894280613;705.5660768627257;8882.822343553222;8895.688650897317;9711.320207585542;9930.851037234448;10040.14658754014;549.3627392225079;579.6753817862011;585.631052436962;587.8706684529396;597.2146627185238;4555.202839503074;4641.559051890065;4671.649626277975;4675.13510000651;4683.929741053887;101274.97450050958;103248;103342.48328758308;103794.48102759589;104328;54539;62163;77172.61413693007;77907;91509.54245228865;59497.81004379975;73112.63443682747;74487;77613.2238677606;80119.798203027;9844.556994935389;10482.109020733018;10657.360558366523;10731;10833.566657333933;45000.32499512444;45873.77063114663;46944;47050.05899882052;50060.74969625129;65544;67759.32240677727;69501.60996780137;69508.30491695019;72423.27576724165;12048.819267711167;12114.878851211375;12257.69355766113;12424.627261182179;12489.021956087825;12848;13513.054086214264;13578.524751633646;13859.514916977858;14377.56867293983;12602.87397126017;12631.87368126307;12917.935410322889;12998.675033124247;13225.272610006157;12882.742345153232;12980.545680901123;13042.152260103063;13166.934165329112;13566.321683915567;10736.41087130277;12579.182353147016;12589.480159340428;13005.674858128623;13459.3943272551;9971.551280192554;10395.896041039796;10590.682279531626;10718;11145.665630031112;8971.641134354553;10480.951904809459;10598.47007649599;10621.840672389766;10624.203184761329 09:35:59 INFO - PROCESS | 1909 | __end_tp_report 09:35:59 INFO - PROCESS | 1909 | __start_cc_report 09:35:59 INFO - PROCESS | 1909 | _x_x_mozilla_cycle_collect,1770 09:35:59 INFO - PROCESS | 1909 | __end_cc_report 09:35:59 INFO - PROCESS | 1909 | __startTimestamp1487266559752__endTimestamp 09:35:59 INFO - PROCESS | 1909 | 09:35:59 INFO - PROCESS | 1909 | ------- Summary: start ------- 09:35:59 INFO - PROCESS | 1909 | Number of tests: 6 09:35:59 INFO - PROCESS | 1909 | 09:35:59 INFO - PROCESS | 1909 | [#0] dojo.html Cycles:165 Average:5699.40 Median:5960.28 stddev:641.95 (10.8%) stddev-sans-first:615.66 09:35:59 INFO - PROCESS | 1909 | Values: 3298.0 3315.2 3331.1 3344.3 3392.4 5666.7 5719.6 5734.2 5754.8 5760.2 5589.1 5635.9 5700.3 5725.5 5735.9 5098.4 5176.0 5213.3 5229.5 5268.9 5118.2 5127.2 5136.1 5278.9 5321.5 5201.1 5209.9 5223.9 5229.2 5231.0 5190.7 5205.8 5228.8 5231.8 5231.9 4998.6 5111.3 5128.1 5168.8 5227.7 4126.3 5537.1 5759.3 5773.0 5787.5 6182.3 6183.7 6196.4 6204.4 6205.9 5388.2 6123.0 6141.6 6146.5 6233.8 4844.0 4915.8 5805.4 5811.4 5826.6 6218.6 6220.3 6222.7 6223.2 6231.5 5967.9 6007.4 6022.6 6105.3 6120.1 6117.7 6126.9 6174.6 6193.8 6211.1 6158.8 6173.3 6177.6 6188.8 6200.1 6083.8 6169.3 6186.1 6209.6 6212.8 4910.2 4941.2 4953.3 4974.9 4993.9 4415.0 4420.2 4426.0 4465.1 4466.5 5736.8 5753.8 5771.9 5774.1 5790.4 6060.9 6121.4 6147.5 6171.6 6239.3 5752.3 5761.0 5792.7 5826.1 5843.9 5313.2 5321.1 5352.3 5358.9 5408.9 6162.8 6182.6 6222.4 6230.0 6232.7 6138.4 6248.3 6261.5 6265.2 6274.3 6153.2 6186.6 6197.0 6206.6 6226.1 6167.9 6172.8 6173.0 6177.4 6182.6 6210.0 6233.5 6242.7 6244.2 6244.8 5994.0 6050.1 6060.7 6068.2 6103.0 5997.7 6109.5 6120.2 6129.8 6134.5 5838.2 5973.0 5974.0 5984.8 5997.0 5906.9 5982.5 6033.1 6128.6 6141.2 5840.3 5901.6 5924.6 5940.5 5960.3 09:35:59 INFO - PROCESS | 1909 | 09:35:59 INFO - PROCESS | 1909 | [#1] ext.html Cycles:180 Average:70770.77 Median:4005.56 stddev:150688.01 (3762.0%) stddev-sans-first:151018.37 09:35:59 INFO - PROCESS | 1909 | Values: 499.0 501.7 503.9 508.0 513.3 31219.2 41404.8 42666.0 42671.4 44670.8 44798.8 45061.3 45136.0 45141.0 45239.5 8401.9 9093.4 9309.7 9317.5 9319.8 8404.6 11137.8 11334.7 11380.4 11564.5 11335.7 11363.4 11382.1 11403.3 11412.5 8475.1 9756.1 11202.8 11277.5 11321.2 8471.1 10995.9 11207.6 11212.7 11431.1 41351.4 41627.8 41748.0 41776.4 41886.4 3964.5 3975.0 4004.7 4006.4 4038.4 29600.4 29641.4 29716.7 30573.1 30700.7 2998.8 3144.7 3146.1 3228.7 3240.8 473429.0 473962.0 474580.0 475056.0 475187.6 65211.3 65596.7 65715.7 65730.0 65798.0 69433.7 69467.7 69634.6 69656.0 69667.3 16533.6 16671.1 16830.5 16846.7 16864.2 11663.0 11966.8 13013.5 13077.5 13149.3 16290.2 18487.1 18632.8 22002.0 22633.9 7371.7 7558.0 8768.5 8944.4 9014.3 774.3 792.4 797.2 806.9 828.2 30347.2 30356.0 30455.5 30607.8 31033.8 1019.4 1039.3 1045.5 1070.1 1092.8 15835.4 15864.4 15865.8 15870.6 16257.4 676881.0 679959.2 679972.0 681000.0 683463.6 62939.7 63653.7 63776.7 63844.7 63849.7 1400.5 1425.4 1437.4 1440.3 1454.3 27891.7 29796.4 29811.7 30528.6 30665.7 53789.9 54059.7 54088.5 54103.0 54123.0 516948.0 518295.0 518487.0 518648.0 519623.0 43330.8 44506.8 44648.8 44764.6 44910.8 46337.5 48711.6 49576.8 49669.8 49839.8 37533.6 39708.0 40529.4 40611.0 41148.0 33791.8 34724.8 39091.6 39256.6 40584.0 38069.4 38260.6 38890.8 38953.8 39016.4 31197.0 34527.7 34807.8 34917.0 35048.0 22643.3 23484.1 24861.5 25319.5 25486.2 09:35:59 INFO - PROCESS | 1909 | 09:35:59 INFO - PROCESS | 1909 | [#2] jquery.html Cycles:180 Average:41398.27 Median:23116.10 stddev:122477.59 (529.8%) stddev-sans-first:122782.43 09:35:59 INFO - PROCESS | 1909 | Values: 370.4 393.5 394.6 406.4 427.8 14379.6 16368.6 19212.1 20193.2 20580.4 20702.6 20822.0 21362.6 21864.5 22101.8 5536.0 5667.2 5744.7 5798.1 5900.0 5692.8 5800.7 5812.3 5812.8 5815.0 4124.9 4347.8 6192.8 6561.2 6578.9 6327.6 6431.4 6497.0 6596.4 6597.6 5776.8 5782.6 5786.8 5796.1 5806.7 26751.3 28010.7 28034.3 28044.3 28330.4 2651.2 2768.0 2768.8 2770.7 2783.8 15037.3 15900.0 15996.0 16178.0 16466.4 1828.3 2041.0 2163.9 2173.5 2178.0 103909.0 130848.3 133671.3 135441.6 139452.0 19827.3 21433.6 21662.4 22679.4 23552.8 41652.4 41741.0 42601.0 42618.4 42773.4 8487.3 8673.9 8965.1 8985.1 9074.5 8690.8 8741.6 8749.9 8926.5 8948.1 4141.7 4813.7 4890.0 4895.7 4978.4 1757.7 2008.1 2037.6 2050.4 2058.6 1018.1 1024.1 1030.7 1035.5 1077.0 21781.0 22017.0 22183.0 22186.7 22351.9 1051.1 1053.3 1079.6 1084.2 1089.9 10998.3 11420.1 11422.3 11425.2 11473.1 699900.0 732205.0 735496.9 754264.0 759579.0 148765.3 151035.2 151168.2 152917.5 157407.0 1010.8 1022.8 1045.3 1046.0 1050.2 17133.7 19143.2 19230.5 19280.5 19317.8 56083.0 56676.7 56758.4 57330.7 57968.7 81056.2 81123.6 82881.3 83184.6 84790.6 7873.1 8182.2 8316.3 8376.5 8620.7 8878.3 12619.9 12678.4 12809.3 12978.5 10823.2 11080.5 11221.1 11283.8 11368.1 10729.5 10817.5 10818.0 11002.9 11152.7 10754.5 11124.2 11259.0 11314.9 11517.3 8099.6 8101.6 8404.2 8474.7 8598.7 8203.7 8936.7 10795.9 10811.5 11008.4 09:35:59 INFO - PROCESS | 1909 | 09:35:59 INFO - PROCESS | 1909 | [#3] mootools.html Cycles:180 Average:5448.83 Median:5131.96 stddev:2960.17 (57.7%) stddev-sans-first:2952.99 09:35:59 INFO - PROCESS | 1909 | Values: 1421.1 1440.3 1460.4 1460.7 1468.0 8108.8 8482.9 8486.3 8497.0 8512.9 7145.5 7337.3 7641.6 7657.9 8003.0 2318.5 2348.5 2354.1 2359.6 2360.3 2335.4 2341.3 2362.0 2369.7 2380.4 2317.9 2320.4 2345.4 2346.9 2350.6 2299.5 2305.6 2327.5 2334.2 2340.1 2297.0 2353.0 2355.4 2356.9 2362.5 8365.6 8444.3 8450.8 8457.5 8464.0 5032.1 5061.2 5110.2 5195.4 5200.7 3302.3 3426.7 3487.9 3550.0 3568.6 1161.6 1224.6 1232.3 1238.4 1251.0 10860.5 10952.3 10965.0 10966.4 10971.7 3947.6 4329.5 4631.8 4713.4 4724.9 9431.5 9511.7 9520.3 9522.3 9522.3 5214.9 5221.3 5222.9 5231.9 5240.1 4266.5 4399.0 4465.5 4684.5 4808.8 3815.8 3849.9 3945.7 3969.2 3971.1 1145.4 1240.2 1254.5 1274.1 1279.9 672.9 804.8 886.3 925.6 941.6 5492.9 5500.7 5680.5 5682.0 5805.9 992.1 997.7 1015.4 1024.2 1057.7 3645.6 3686.7 3772.3 3848.7 3876.3 9864.7 10140.9 10141.5 10143.0 10148.3 9262.9 9883.1 9902.8 10119.5 10129.8 7846.2 7883.1 7966.4 7995.4 8034.8 4981.4 5387.0 5393.6 5540.8 5547.5 8894.9 8947.5 9207.1 9352.3 9358.0 9104.7 9153.1 9335.2 9483.7 9548.5 7056.5 7065.4 7749.5 7918.5 7936.0 7636.4 7766.7 7853.9 7960.0 7967.9 6966.3 7050.6 7096.0 7134.9 7198.4 6886.8 7003.1 7028.3 7047.7 7063.5 6295.8 6351.6 6417.9 6438.8 6441.1 4990.7 5002.9 5014.4 5027.2 5107.2 4937.6 4979.7 5090.0 5153.7 5182.9 09:35:59 INFO - PROCESS | 1909 | 09:35:59 INFO - PROCESS | 1909 | [#4] prototype.html Cycles:180 Average:4496.75 Median:4950.62 stddev:1318.05 (26.6%) stddev-sans-first:1284.56 09:35:59 INFO - PROCESS | 1909 | Values: 354.6 365.8 371.7 374.0 376.5 4532.4 4542.9 4682.2 5226.4 5352.8 4494.6 4599.0 5276.0 5282.4 5286.4 3286.3 3957.4 4094.6 4105.5 4196.4 3611.9 4080.6 4107.6 4140.3 4159.0 3776.9 3875.0 4131.9 4167.9 4169.4 3869.2 3914.5 4090.4 4109.8 4171.9 3657.4 3658.3 3659.6 3661.9 3691.9 5118.7 5170.4 5176.3 5180.9 5211.4 4590.4 4696.7 4717.2 4749.0 4777.4 5569.8 5573.7 5576.7 5593.4 5603.6 4052.4 4063.2 4065.5 4087.8 4105.1 5573.5 5726.6 5767.9 5824.9 5917.5 3973.1 4072.1 4080.5 4095.6 4107.6 4187.4 4191.0 4191.4 4194.9 4195.2 4552.3 4652.7 4754.4 4762.3 4784.7 4943.6 5408.6 5561.5 5577.2 5599.5 1297.4 1341.5 1350.7 1351.5 1361.5 866.8 888.3 908.1 944.4 966.1 4254.5 4469.0 4726.7 5110.2 5153.0 4931.6 5698.7 5704.0 5705.7 5705.7 4326.5 5122.3 5135.2 5150.5 5153.0 2600.0 2812.7 2816.2 2865.9 2873.7 5222.0 5376.6 5603.7 5620.4 5635.4 4827.0 4877.4 4879.9 5349.9 5587.9 4508.0 5194.8 5295.7 5456.5 5620.0 4922.6 5114.6 5159.5 5435.0 5471.7 5289.4 5423.4 5544.8 5690.3 5745.6 5321.9 5982.6 6003.9 6004.7 6027.6 3875.5 3886.9 3911.9 3913.5 3927.7 4899.8 5227.4 5435.0 5604.9 5767.0 4976.5 5574.4 5579.4 5607.6 5624.0 4310.4 4709.9 5412.9 5580.0 5594.4 4623.8 4957.6 5048.7 5452.6 5457.9 5233.5 5288.9 5398.7 5442.9 5599.0 4792.5 5019.7 5228.7 5339.9 5487.4 09:35:59 INFO - PROCESS | 1909 | 09:35:59 INFO - PROCESS | 1909 | [#5] yui.html Cycles:180 Average:19536.33 Median:3790.53 stddev:28056.80 (740.2%) stddev-sans-first:28099.83 09:35:59 INFO - PROCESS | 1909 | Values: 694.0 709.5 711.7 740.4 815.6 14018.4 14555.0 14561.3 14610.1 14645.7 11101.4 13689.8 13702.0 13716.7 13733.5 641.5 680.2 871.9 880.3 896.4 857.6 874.8 875.5 878.0 884.0 890.6 933.6 935.8 936.5 938.4 925.4 926.5 928.0 928.6 929.3 697.3 698.0 698.2 699.2 700.5 14237.2 14631.2 14642.9 14812.9 15131.0 13561.9 13960.7 13970.2 14001.3 14088.6 11332.3 11378.9 11423.9 11617.3 12063.6 3603.9 3707.2 3713.3 3727.9 3853.2 99638.5 102406.0 103188.0 103540.0 105537.0 10220.9 10290.8 10601.2 10649.9 10655.5 21578.7 21856.7 21961.8 21997.3 22004.9 7559.3 7559.6 7572.6 7573.8 7801.2 4124.7 4177.5 4183.9 4225.5 4318.0 2916.9 3329.1 3402.7 3404.0 3423.8 585.1 586.0 591.7 596.8 600.3 644.3 673.1 675.5 683.5 705.6 8882.8 8895.7 9711.3 9930.9 10040.1 549.4 579.7 585.6 587.9 597.2 4555.2 4641.6 4671.6 4675.1 4683.9 101275.0 103248.0 103342.5 103794.5 104328.0 54539.0 62163.0 77172.6 77907.0 91509.5 59497.8 73112.6 74487.0 77613.2 80119.8 9844.6 10482.1 10657.4 10731.0 10833.6 45000.3 45873.8 46944.0 47050.1 50060.7 65544.0 67759.3 69501.6 69508.3 72423.3 12048.8 12114.9 12257.7 12424.6 12489.0 12848.0 13513.1 13578.5 13859.5 14377.6 12602.9 12631.9 12917.9 12998.7 13225.3 12882.7 12980.5 13042.2 13166.9 13566.3 10736.4 12579.2 12589.5 13005.7 13459.4 9971.6 10395.9 10590.7 10718.0 11145.7 8971.6 10481.0 10598.5 10621.8 10624.2 09:35:59 INFO - PROCESS | 1909 | -------- Summary: end -------- 09:35:59 INFO - PROCESS | 1909 | 09:36:00 INFO - TEST-INFO | 1909: exit 0 09:36:00 INFO - TEST-OK | dromaeo_css | took 1119016ms 09:36:00 INFO - TEST-START | kraken 09:36:00 INFO - operating with platform_type : mac_ 09:36:00 INFO - Initialising browser for kraken test... 09:36:00 INFO - TEST-INFO | started process 1913 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/tmpKhQq9S/profile http://localhost:52447/getInfo.html) 09:36:02 INFO - PROCESS | 1913 | __metrics Screen width/height:1600/1200 09:36:02 INFO - PROCESS | 1913 | colorDepth:24 09:36:02 INFO - PROCESS | 1913 | Browser inner width/height: 1024/689 09:36:02 INFO - PROCESS | 1913 | __metrics 09:36:03 INFO - PROCESS | 1913 | 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:36:03 INFO - PROCESS | 1913 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:36:03 INFO - TEST-INFO | 1913: exit 0 09:36:03 INFO - Browser initialized. 09:36:03 INFO - Running cycle 1/1 for kraken test... 09:36:03 INFO - TEST-INFO | started process 1914 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/tmpKhQq9S/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:36:15 INFO - PROCESS | 1914 | RSS: Main: 213110784 09:36:15 INFO - PROCESS | 1914 | 09:36:18 INFO - PROCESS | 1914 | Cycle 1(1): loaded http://localhost:52447/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52447/tests/kraken/driver.html?testName=audio-beat-detection) 09:36:19 INFO - PROCESS | 1914 | RSS: Main: 265801728 09:36:19 INFO - PROCESS | 1914 | 09:36:22 INFO - PROCESS | 1914 | Cycle 1(1): loaded http://localhost:52447/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52447/tests/kraken/driver.html?testName=audio-dft) 09:36:22 INFO - PROCESS | 1914 | RSS: Main: 276185088 09:36:22 INFO - PROCESS | 1914 | 09:36:25 INFO - PROCESS | 1914 | Cycle 1(1): loaded http://localhost:52447/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52447/tests/kraken/driver.html?testName=audio-fft) 09:36:26 INFO - PROCESS | 1914 | RSS: Main: 373608448 09:36:26 INFO - PROCESS | 1914 | 09:36:28 INFO - PROCESS | 1914 | Cycle 1(1): loaded http://localhost:52447/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52447/tests/kraken/driver.html?testName=audio-oscillator) 09:36:29 INFO - PROCESS | 1914 | RSS: Main: 276791296 09:36:29 INFO - PROCESS | 1914 | 09:36:31 INFO - PROCESS | 1914 | Cycle 1(1): loaded http://localhost:52447/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52447/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:36:31 INFO - PROCESS | 1914 | RSS: Main: 278458368 09:36:31 INFO - PROCESS | 1914 | 09:36:34 INFO - PROCESS | 1914 | Cycle 1(1): loaded http://localhost:52447/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52447/tests/kraken/driver.html?testName=imaging-darkroom) 09:36:35 INFO - PROCESS | 1914 | RSS: Main: 319770624 09:36:35 INFO - PROCESS | 1914 | 09:36:38 INFO - PROCESS | 1914 | Cycle 1(1): loaded http://localhost:52447/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52447/tests/kraken/driver.html?testName=imaging-desaturate) 09:36:38 INFO - PROCESS | 1914 | RSS: Main: 319574016 09:36:38 INFO - PROCESS | 1914 | 09:36:41 INFO - PROCESS | 1914 | Cycle 1(1): loaded http://localhost:52447/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52447/tests/kraken/driver.html?testName=json-parse-financial) 09:36:42 INFO - PROCESS | 1914 | RSS: Main: 318717952 09:36:42 INFO - PROCESS | 1914 | 09:36:43 INFO - PROCESS | 1914 | Cycle 1(1): loaded http://localhost:52447/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52447/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:36:44 INFO - PROCESS | 1914 | RSS: Main: 294891520 09:36:44 INFO - PROCESS | 1914 | 09:36:46 INFO - PROCESS | 1914 | Cycle 1(1): loaded http://localhost:52447/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52447/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:36:46 INFO - PROCESS | 1914 | RSS: Main: 297598976 09:36:46 INFO - PROCESS | 1914 | 09:36:48 INFO - PROCESS | 1914 | Cycle 1(1): loaded http://localhost:52447/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52447/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:36:49 INFO - PROCESS | 1914 | RSS: Main: 300310528 09:36:49 INFO - PROCESS | 1914 | 09:36:52 INFO - PROCESS | 1914 | Cycle 1(1): loaded http://localhost:52447/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52447/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:36:53 INFO - PROCESS | 1914 | RSS: Main: 315990016 09:36:53 INFO - PROCESS | 1914 | 09:36:56 INFO - PROCESS | 1914 | Cycle 1(1): loaded http://localhost:52447/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52447/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:36:56 INFO - PROCESS | 1914 | RSS: Main: 309796864 09:36:56 INFO - PROCESS | 1914 | 09:36:58 INFO - PROCESS | 1914 | Cycle 1(1): loaded http://localhost:52447/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52447/tests/kraken/driver.html?testName=ai-astar) 09:36:58 INFO - PROCESS | 1914 | RSS: Main: 354381824 09:36:58 INFO - PROCESS | 1914 | 09:36:58 INFO - PROCESS | 1914 | __start_tp_report 09:36:58 INFO - PROCESS | 1914 | _x_x_mozilla_page_load 09:36:58 INFO - PROCESS | 1914 | _x_x_mozilla_page_load_details 09:36:58 INFO - PROCESS | 1914 | |i|pagename|runs| 09:36:58 INFO - PROCESS | 1914 | |0;ai-astar;115;116;115;114;115;116;112;114;115;115 09:36:58 INFO - PROCESS | 1914 | |1;audio-beat-detection;140;109;109;142;112;108;111;138;160;133 09:36:58 INFO - PROCESS | 1914 | |2;audio-dft;189;185;189;258;243;185;186;185;182;183 09:36:58 INFO - PROCESS | 1914 | |3;audio-fft;81;59;59;89;60;59;59;59;74;57 09:36:58 INFO - PROCESS | 1914 | |4;audio-oscillator;85;72;87;70;68;71;82;67;68;82 09:36:58 INFO - PROCESS | 1914 | |5;imaging-gaussian-blur;87;84;87;85;86;84;86;114;87;84 09:36:58 INFO - PROCESS | 1914 | |6;imaging-darkroom;94;95;94;95;93;95;95;95;93;127 09:36:58 INFO - PROCESS | 1914 | |7;imaging-desaturate;87;86;87;87;86;87;85;85;88;84 09:36:58 INFO - PROCESS | 1914 | |8;json-parse-financial;58;52;52;54;54;56;54;56;56;58 09:36:58 INFO - PROCESS | 1914 | |9;json-stringify-tinderbox;66;74;79;73;70;68;69;68;69;69 09:36:58 INFO - PROCESS | 1914 | |10;stanford-crypto-aes;84;82;84;85;83;84;85;82;84;82 09:36:58 INFO - PROCESS | 1914 | |11;stanford-crypto-ccm;138;138;137;151;142;137;140;135;208;168 09:36:58 INFO - PROCESS | 1914 | |12;stanford-crypto-pbkdf2;165;166;171;167;180;165;167;168;167;165 09:36:58 INFO - PROCESS | 1914 | |13;stanford-crypto-sha256-iterative;67;66;65;65;65;65;64;65;63;65 09:36:58 INFO - PROCESS | 1914 | __end_tp_report 09:36:58 INFO - PROCESS | 1914 | __start_cc_report 09:36:58 INFO - PROCESS | 1914 | _x_x_mozilla_cycle_collect,2020 09:36:58 INFO - PROCESS | 1914 | __end_cc_report 09:36:58 INFO - PROCESS | 1914 | __startTimestamp1487266618773__endTimestamp 09:36:58 INFO - PROCESS | 1914 | 09:36:58 INFO - PROCESS | 1914 | ------- Summary: start ------- 09:36:58 INFO - PROCESS | 1914 | Number of tests: 14 09:36:58 INFO - PROCESS | 1914 | 09:36:58 INFO - PROCESS | 1914 | [#0] ai-astar Cycles:10 Average:114.70 Median:115.00 stddev:1.16 (1.0%) stddev-sans-first:1.22 09:36:58 INFO - PROCESS | 1914 | Values: 115.0 116.0 115.0 114.0 115.0 116.0 112.0 114.0 115.0 115.0 09:36:58 INFO - PROCESS | 1914 | 09:36:58 INFO - PROCESS | 1914 | [#1] audio-beat-detection Cycles:10 Average:126.20 Median:135.50 stddev:18.63 (13.7%) stddev-sans-first:19.08 09:36:58 INFO - PROCESS | 1914 | Values: 140.0 109.0 109.0 142.0 112.0 108.0 111.0 138.0 160.0 133.0 09:36:58 INFO - PROCESS | 1914 | 09:36:58 INFO - PROCESS | 1914 | [#2] audio-dft Cycles:10 Average:198.50 Median:187.50 stddev:27.72 (14.8%) stddev-sans-first:29.19 09:36:58 INFO - PROCESS | 1914 | Values: 189.0 185.0 189.0 258.0 243.0 185.0 186.0 185.0 182.0 183.0 09:36:58 INFO - PROCESS | 1914 | 09:36:58 INFO - PROCESS | 1914 | [#3] audio-fft Cycles:10 Average:65.60 Median:59.50 stddev:11.44 (19.2%) stddev-sans-first:10.69 09:36:58 INFO - PROCESS | 1914 | Values: 81.0 59.0 59.0 89.0 60.0 59.0 59.0 59.0 74.0 57.0 09:36:58 INFO - PROCESS | 1914 | 09:36:58 INFO - PROCESS | 1914 | [#4] audio-oscillator Cycles:10 Average:75.20 Median:77.00 stddev:7.84 (10.2%) stddev-sans-first:7.47 09:36:58 INFO - PROCESS | 1914 | Values: 85.0 72.0 87.0 70.0 68.0 71.0 82.0 67.0 68.0 82.0 09:36:58 INFO - PROCESS | 1914 | 09:36:58 INFO - PROCESS | 1914 | [#5] imaging-gaussian-blur Cycles:10 Average:88.40 Median:86.00 stddev:9.08 (10.6%) stddev-sans-first:9.62 09:36:58 INFO - PROCESS | 1914 | Values: 87.0 84.0 87.0 85.0 86.0 84.0 86.0 114.0 87.0 84.0 09:36:58 INFO - PROCESS | 1914 | 09:36:58 INFO - PROCESS | 1914 | [#6] imaging-darkroom Cycles:10 Average:97.60 Median:95.00 stddev:10.36 (10.9%) stddev-sans-first:10.91 09:36:58 INFO - PROCESS | 1914 | Values: 94.0 95.0 94.0 95.0 93.0 95.0 95.0 95.0 93.0 127.0 09:36:58 INFO - PROCESS | 1914 | 09:36:58 INFO - PROCESS | 1914 | [#7] imaging-desaturate Cycles:10 Average:86.20 Median:87.00 stddev:1.23 (1.4%) stddev-sans-first:1.27 09:36:58 INFO - PROCESS | 1914 | Values: 87.0 86.0 87.0 87.0 86.0 87.0 85.0 85.0 88.0 84.0 09:36:58 INFO - PROCESS | 1914 | 09:36:58 INFO - PROCESS | 1914 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:56.00 stddev:2.16 (3.9%) stddev-sans-first:2.00 09:36:58 INFO - PROCESS | 1914 | Values: 58.0 52.0 52.0 54.0 54.0 56.0 54.0 56.0 56.0 58.0 09:36:58 INFO - PROCESS | 1914 | 09:36:58 INFO - PROCESS | 1914 | [#9] json-stringify-tinderbox Cycles:10 Average:70.50 Median:69.50 stddev:3.81 (5.5%) stddev-sans-first:3.67 09:36:58 INFO - PROCESS | 1914 | Values: 66.0 74.0 79.0 73.0 70.0 68.0 69.0 68.0 69.0 69.0 09:36:58 INFO - PROCESS | 1914 | 09:36:58 INFO - PROCESS | 1914 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:84.00 stddev:1.18 (1.4%) stddev-sans-first:1.24 09:36:58 INFO - PROCESS | 1914 | Values: 84.0 82.0 84.0 85.0 83.0 84.0 85.0 82.0 84.0 82.0 09:36:58 INFO - PROCESS | 1914 | 09:36:58 INFO - PROCESS | 1914 | [#11] stanford-crypto-ccm Cycles:10 Average:149.40 Median:141.00 stddev:22.85 (16.2%) stddev-sans-first:23.86 09:36:58 INFO - PROCESS | 1914 | Values: 138.0 138.0 137.0 151.0 142.0 137.0 140.0 135.0 208.0 168.0 09:36:58 INFO - PROCESS | 1914 | 09:36:58 INFO - PROCESS | 1914 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.10 Median:167.00 stddev:4.56 (2.7%) stddev-sans-first:4.69 09:36:58 INFO - PROCESS | 1914 | Values: 165.0 166.0 171.0 167.0 180.0 165.0 167.0 168.0 167.0 165.0 09:36:58 INFO - PROCESS | 1914 | 09:36:58 INFO - PROCESS | 1914 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:65.00 stddev:1.05 (1.6%) stddev-sans-first:0.83 09:36:58 INFO - PROCESS | 1914 | Values: 67.0 66.0 65.0 65.0 65.0 65.0 64.0 65.0 63.0 65.0 09:36:58 INFO - PROCESS | 1914 | -------- Summary: end -------- 09:36:58 INFO - PROCESS | 1914 | 09:36:59 INFO - TEST-INFO | 1914: exit 0 09:36:59 INFO - TEST-OK | kraken | took 59196ms 09:36:59 INFO - SUITE-END | took 1178s 09:36:59 INFO - Completed test suite (00:19:38) 09:36:59 INFO - javascript benchmark 09:36:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3297.98351008245, 3315.1712071982006, 3331.0673011556755, 3344.331133773243, 3392.372411103946, 5666.716664166791, 5719.628224165426, 5734.225879506265, 5754.769809207632, 5760.164776107462, 5589.105743081108, 5635.943640563593, 5700.315962084545, 5725.4847063764255, 5735.942640573593, 5098.4391716911205, 5176.0, 5213.32226810516, 5229.450907654698, 5268.947310526884, 5118.1555043417975, 5127.154019586764, 5136.126858434057, 5278.868028299285, 5321.467853214686, 5201.141811601081, 5209.921851172236, 5223.921641175385, 5229.163333866582, 5230.973845130788, 5190.71451070191, 5205.817796377128, 5228.816991405282, 5231.843044708665, 5231.895362092756, 4998.625103117244, 5111.284420181178, 5128.102582048126, 5168.8449346519665, 5227.686338819645, 4126.277901367249, 5537.141743029837, 5759.280089988752, 5772.971135144339, 5787.479126878559, 6182.319944806068, 6183.6598987055695, 6196.380361963813, 6204.410580994843, 6205.906911396332, 5388.191771234347, 6123.018364072999, 6141.578063794062, 6146.508279337642, 6233.812985610439, 4843.951560484421, 4915.754212289371, 5805.448482394208, 5811.389804070596, 5826.621269617462, 6218.626882387071, 6220.253569571681, 6222.688865556704, 6223.190985171898, 6231.501479881598, 5967.910481342783, 6007.429294217042, 6022.57841951068, 6105.32841387447, 6120.112583675342, 6117.705611546597, 6126.884121540732, 6174.567780255429, 6193.845153871099, 6211.09939058843, 6158.784442544579, 6173.32093469718, 6177.62934223948, 6188.845278867974, 6200.0699895015205, 6083.8174854754425, 6169.290531588835, 6186.133941248228, 6209.59637623553, 6212.782552610637, 4910.165271903785, 4941.184704523714, 4953.306537084811, 4974.850754477371, 4993.925091123636, 4414.977925110354, 4420.182266280748, 4426.004149066434, 4465.12929978651, 4466.531014243457, 5736.827895163152, 5753.769849206069, 5771.913421298684, 5774.133879918046, 5790.392008839095, 6060.909086363708, 6121.392004143319, 6147.477464415575, 6171.6297022178815, 6239.282482514569, 5752.338481074647, 5760.971195143998, 5792.739326730307, 5826.096954971986, 5843.941560584425, 5313.229581710631, 5321.122014867504, 5352.330958630171, 5358.946410535923, 5408.864778380494, 6162.815115546541, 6182.567220294626, 6222.408871157233, 6230.034344676583, 6232.688365581794, 6138.386161383826, 6248.250209974651, 6261.530385221035, 6265.15420418256, 6274.341194174728, 6153.169322141453, 6186.597871138361, 6196.969015155076, 6206.627602343874, 6226.066090086523, 6167.876642467036, 6172.783952561639, 6172.98145805937, 6177.413145751147, 6182.629042257299, 6210.0, 6233.470155036873, 6242.656653883898, 6244.1570387997035, 6244.750209991731, 5994.0, 6050.122732203894, 6060.666663333559, 6068.150458935841, 6102.9694851525455, 5997.730102145501, 6109.48069414087, 6120.234970628671, 6129.847850912788, 6134.4978165938865, 5838.211841401527, 5972.984592619352, 5974.0, 5984.790532331347, 5996.980513312835, 5906.852328691817, 5982.461578457785, 6033.064874944391, 6128.601640893327, 6141.232345956755, 5840.2991641003355, 5901.616394934315, 5924.6445213285615, 5940.524758019435, 5960.284765828128], "value": 5658.976209737246, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [498.990020199596, 501.7206124382825, 503.8639567316822, 507.95936325094, 513.304472439844, 31219.219519512022, 41404.79297603512, 42666.0, 42671.35992960108, 44670.77664611681, 44798.77600612, 45061.324080138744, 45136.0, 45141.0, 45239.54760452395, 8401.873971890427, 9093.363464557468, 9309.72070837876, 9317.534123293843, 9319.767005824875, 8404.621792019343, 11137.777244455106, 11334.659960201207, 11380.374079425628, 11564.537418503292, 11335.659930202108, 11363.375014374205, 11382.146339024564, 11403.258788178784, 11412.486438110263, 8475.110113438062, 9756.121949024622, 11202.831957520644, 11277.492512836941, 11321.20751547388, 8471.06818249992, 10995.945020274847, 11207.607733729363, 11212.719682008015, 11431.142664300127, 41351.379729304084, 41627.7918610405, 41748.0, 41776.37335439971, 41886.371704424455, 3964.5044369453817, 3975.0, 4004.7196696231276, 4006.399040143973, 4038.353863381845, 29600.407991840042, 29641.40717185666, 29716.70283297161, 30573.08280751581, 30700.692993070006, 2998.7600991920594, 3144.7326977206735, 3146.1348129264406, 3228.660990595977, 3240.821754803485, 473429.0, 473962.0, 474580.0, 475056.0, 475187.6240618809, 65211.34788652148, 65596.67201664057, 65715.67142164259, 65730.01404978929, 65798.0, 69433.65283173653, 69467.65266173637, 69634.60730785457, 69656.0, 69667.3033269671, 16533.58666033359, 16671.0830904299, 16830.495085147464, 16846.747298790528, 16864.241109150116, 11663.008644265332, 11966.760664786656, 13013.479460821462, 13077.542286019943, 13149.342532873317, 16290.185490725416, 18487.11727107052, 18632.81367186338, 22002.0, 22633.886830566073, 7371.741989030358, 7558.0, 8768.5177315247, 8944.37389382737, 9014.323925705598, 774.3456779021718, 792.4254915186443, 797.2346547314527, 806.8749343851713, 828.1718281718282, 30347.241318967204, 30356.0, 30455.543166852072, 30607.7530058247, 31033.844830775703, 1019.4087429290994, 1039.2517387481003, 1045.4824861693357, 1070.0583486531802, 1092.7869065532145, 15835.366585336458, 15864.365425382855, 15865.841341586436, 15870.603234918988, 16257.430989915296, 676881.0, 679959.2004079995, 679972.0, 681000.0, 683463.5826820834, 62939.6853015732, 63653.68173159197, 63776.72446551043, 63844.68077659582, 63849.680751595944, 1400.4958215042577, 1425.4369524037947, 1437.3819257719072, 1440.2510694439043, 1454.301935071193, 27891.721082789725, 29796.404071918874, 29811.70188298176, 30528.626211820076, 30665.693343066283, 53789.924201514965, 54059.72970135124, 54088.45911540834, 54103.0, 54123.0, 516948.0, 518295.0, 518487.0, 518648.0, 519623.0, 43330.783346083066, 44506.777466112464, 44648.77675611731, 44764.552354476036, 44910.775446123866, 46337.53662463467, 48711.57502772891, 49576.752116240634, 49669.75825604389, 49839.75080124576, 37533.62466375301, 39708.007299817735, 40529.37882484785, 40610.96852963848, 41147.97130071772, 33791.83104084464, 34724.82637586897, 39091.6090839088, 39256.607433925295, 40584.0, 38069.42895856509, 38260.61739382682, 38890.80554597209, 38953.805230974795, 39016.41475377928, 31197.0, 34527.65472345345, 34807.82596087003, 34917.0, 35048.0, 22643.320700379016, 23484.137600574537, 24861.502769944862, 25319.493610128062, 25486.23541293764], "value": 20830.26659359383, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.3611270558289, 393.5356279590084, 394.63299131807406, 406.3620116417225, 427.84811391955856, 14379.577768203351, 16368.59078523036, 19212.13545390457, 20193.19227230909, 20580.38258852233, 20702.585948281063, 20822.0, 21362.57274854502, 21864.45338866525, 22101.778982210173, 5536.0, 5667.178259152421, 5744.655320680752, 5798.10129429939, 5900.0, 5692.77228910843, 5800.651960882339, 5812.331581868097, 5812.796552120677, 5815.0, 4124.8762537123785, 4347.826086956518, 6192.8451788705415, 6561.212654481469, 6578.8684226315445, 6327.5570710050315, 6431.389018043278, 6496.9675151624415, 6596.43930265928, 6597.604143751366, 5776.797812076557, 5782.56630752691, 5786.797462088806, 5796.072628379439, 5806.680632565207, 26751.331216719736, 28010.719892801015, 28034.299142521395, 28044.298892527648, 28330.43339133206, 2651.231142968537, 2767.9723202767914, 2768.750812426891, 2770.6536682914634, 2783.7633801126926, 15037.323320450496, 15900.0, 15996.040237585783, 16178.029318240826, 16466.42367517143, 1828.2778302570543, 2040.9795902040937, 2163.9242626508153, 2173.5109600339956, 2177.967330490044, 103909.0, 130848.34575827155, 133671.33164334213, 135441.6455835449, 139452.0, 19827.30604428838, 21433.57132857334, 21662.35012949614, 22679.433014174778, 23552.76447235506, 41652.37521437181, 41741.0, 42601.0, 42618.360724589154, 42773.358399624034, 8487.278581320657, 8673.913260867437, 8965.131158029499, 8985.146411090936, 9074.500902450429, 8690.826183476294, 8741.606627701769, 8749.912500875038, 8926.509042002752, 8948.060453652273, 4141.689373297015, 4813.711177329302, 4889.951100489021, 4895.730734809548, 4978.402591688948, 1757.7099778536654, 2008.096356639489, 2037.5822956293923, 2050.3643870399924, 2058.5574101568236, 1018.1142406106735, 1024.0680980307884, 1030.701096681954, 1035.5081336365167, 1077.0414331245197, 21781.0, 22016.952187667714, 22183.0, 22186.675197952696, 22351.888240558692, 1051.1433181956681, 1053.2995557954027, 1079.63292480557, 1084.208527774729, 1089.8910108989196, 10998.285111467729, 11420.086393088533, 11422.25755325901, 11425.2002359834, 11473.139514536444, 699900.0, 732205.0, 735496.8701877905, 754264.0, 759579.0, 148765.25617371843, 151035.24482377517, 151168.2441587807, 152917.47082529255, 157407.0, 1010.7927874785652, 1022.8261195596617, 1045.2526443592867, 1045.9738506537244, 1050.207093644309, 17133.657326853143, 19143.234270629575, 19230.519237018627, 19280.517987050436, 19317.8068219316, 56083.0, 56676.716616416656, 56758.432415675314, 57330.71334643467, 57968.71015644895, 81056.18943810722, 81123.59438202772, 82881.342373151, 83184.58407707923, 84790.57604711936, 7873.133955265031, 8182.181781822008, 8316.334693224648, 8376.49741015541, 8620.741377758677, 8878.284930774687, 12619.915148490143, 12678.366081696062, 12809.295488748208, 12978.545750898673, 10823.188260880308, 11080.501377438195, 11221.102311814871, 11283.830742539032, 11368.090552755924, 10729.517171727448, 10817.51321190564, 10817.972292632187, 11002.944985275022, 11152.665420037412, 10754.462276886281, 11124.189823437318, 11259.0, 11314.886851131383, 11517.25137866036, 8099.623064079238, 8101.554414507259, 8404.243618074403, 8474.719674309497, 8598.742037738877, 8203.671853126047, 8936.731898043068, 10795.892041079489, 10811.513481893177, 11008.449577520933], "value": 10579.708712101587, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1421.0620990146506, 1440.258266992499, 1460.386637612203, 1460.656745664769, 1468.0384348251898, 8108.756737297883, 8482.915170848306, 8486.278666313356, 8497.02284237313, 8512.872306915393, 7145.535540189884, 7337.33963943245, 7641.61791910405, 7657.923420765791, 8002.95998520008, 2318.4783423729696, 2348.4598542335275, 2354.105439932823, 2359.634256690216, 2360.2919124262653, 2335.4044718596733, 2341.2976107167783, 2361.9645705314433, 2369.680093187415, 2380.3573035280465, 2317.9420514487106, 2320.3503019154664, 2345.44881952741, 2346.9178578749747, 2350.5533948549805, 2299.5171014087064, 2305.6310990241564, 2327.5461285049423, 2334.2297041976108, 2340.1107579119994, 2297.0, 2352.9647055294186, 2355.4229213842546, 2356.929292121239, 2362.5038741864228, 8365.581720913991, 8444.324454043723, 8450.78873028173, 8457.534835584102, 8463.95768021162, 5032.119379108642, 5061.246996730843, 5110.233464980282, 5195.428502864682, 5200.713960732158, 3302.3065156317202, 3426.674465925733, 3487.9476807847905, 3549.982250088733, 3568.6074531801482, 1161.6398916335963, 1224.577520755338, 1232.2975903734875, 1238.4303220518573, 1250.974980500394, 10860.45697715111, 10952.34285942838, 10965.013148816644, 10966.396848173346, 10971.725706857313, 3947.585503522089, 4329.502107257643, 4631.791569379386, 4713.434387873409, 4724.905501889943, 9431.528423578931, 9511.667091651898, 9520.285978551636, 9522.285828562886, 9522.285828562886, 5214.9478505214465, 5221.269022336875, 5222.92165617516, 5231.869203269949, 5240.082985477527, 4266.530681625019, 4398.978005110018, 4465.486469056035, 4684.508126646653, 4808.831690890872, 3815.809209539512, 3849.8845034649007, 3945.704072194597, 3969.226000929791, 3971.0667993021616, 1145.4444594371723, 1240.169086711887, 1254.4982007197011, 1274.0826604844497, 1279.9360031998363, 672.8553361027402, 804.8008467383556, 886.259972922604, 925.643627203518, 941.6233506597279, 5492.917606235909, 5500.662218557097, 5680.5171560417, 5682.0, 5805.8548536286935, 992.1120597065586, 997.7056768253383, 1015.3856916565371, 1024.1908891975404, 1057.6562617149457, 3645.5989841117457, 3686.7419280650097, 3772.320982223171, 3848.6728628066926, 3876.26350993316, 9864.704058878246, 10140.949295253477, 10141.492925353703, 10143.036411540892, 10148.340357876714, 9262.861057084148, 9883.061109194616, 9902.752431189278, 10119.544620492095, 10129.797404052026, 7846.215378462108, 7883.132855385903, 7966.402519811038, 7995.40034497415, 8034.839303213903, 4981.42713587942, 5386.973065134649, 5393.568514518751, 5540.806071787468, 5547.5007249347755, 8894.911050889408, 8947.463152210888, 9207.079292070739, 9352.298577606844, 9358.0, 9104.726858194264, 9153.130452606993, 9335.159835614828, 9483.715488535356, 9548.52257387114, 7056.54132481387, 7065.399441047569, 7749.457537972288, 7918.485298455582, 7936.047674278892, 7636.427267954815, 7766.728164514441, 7853.921460785319, 7960.044794624682, 7967.9203207967175, 6966.338197871194, 7050.5769653820935, 7095.9645201773665, 7134.892976605459, 7198.424126070006, 6886.793396198122, 7003.124609423822, 7028.332308430691, 7047.6828542714675, 7063.505554611128, 6295.811125666238, 6351.618902865843, 6417.93582064192, 6438.7746428876635, 6441.066045423481, 4990.650654454299, 5002.949970500248, 5014.423341315795, 5027.195648696191, 5107.208382700687, 4937.5556199942175, 4979.71744299909, 5090.0, 5153.6907785532985, 5182.922256166085], "value": 4439.034037054202, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.59398988158557, 365.81526329203746, 371.7453544322138, 373.9719521035923, 376.4898562447885, 4532.376975485007, 4542.863714088574, 4682.180618391785, 5226.398964119127, 5352.759125839337, 4494.617957473619, 4599.0, 5275.997560463509, 5282.418933917266, 5286.4449232830575, 3286.342731453707, 3957.366821308591, 4094.5905409458965, 4105.507339119295, 4196.433481480007, 3611.855525778966, 4080.6327430531246, 4107.568705285947, 4140.296149654566, 4158.97920510397, 3776.8678096266635, 3875.028096201402, 4131.917361652765, 4167.895212917472, 4169.353750168729, 3869.2454971280613, 3914.4911161548957, 4090.365993271048, 4109.835606575733, 4171.91656166875, 3657.3965295726175, 3658.2866341063504, 3659.597444281127, 3661.8831256466765, 3691.870784522556, 5118.744062796883, 5170.379554453452, 5176.275321454999, 5180.870478238036, 5211.374635043819, 4590.449146102489, 4696.66145148631, 4717.198076327033, 4749.0, 4777.402824646919, 5569.777208911639, 5573.749181286852, 5576.749046292886, 5593.3847276799515, 5603.579731520112, 4052.37188235821, 4063.2482990646827, 4065.532463766675, 4087.7751723655188, 4105.117399759066, 5573.526250268732, 5726.5705072119345, 5767.88464230713, 5824.912626310566, 5917.485068845724, 3973.0663294125857, 4072.1041370898356, 4080.489938757655, 4095.610916962884, 4107.609777071233, 4187.43469631602, 4190.979045104755, 4191.350340697197, 4194.937075943863, 4195.244855925902, 4552.292890166188, 4652.697574657636, 4754.429468463737, 4762.333273341735, 4784.712917224978, 4943.629227807929, 5408.648437851527, 5561.499465048084, 5577.2191893135, 5599.524040456526, 1297.4485843516468, 1341.4567100324384, 1350.696093378982, 1351.4729255590328, 1361.5370773936909, 866.77463859397, 888.2668532773502, 908.1191244492832, 944.3719926249105, 966.0677446264389, 4254.532001479834, 4469.0280963159785, 4726.692764970266, 5110.207917772751, 5153.0, 4931.556159945622, 5698.7435565399655, 5704.0, 5705.686187259741, 5705.690699394341, 4326.480822301344, 5122.259591118734, 5135.229715542699, 5150.532098352027, 5153.0, 2600.0379859452123, 2812.718728127171, 2816.155153453956, 2865.867982147082, 2873.741363277315, 5222.007818514546, 5376.623636345496, 5603.719814009283, 5620.398186516823, 5635.408282130399, 4827.0, 4877.3903262092235, 4879.926801097987, 5349.93353053426, 5587.8603034923635, 4508.0, 5194.844154675366, 5295.655782374133, 5456.536194423518, 5619.999999999918, 4922.630802689884, 5114.5652619527755, 5159.535641792257, 5435.043384381541, 5471.72641367922, 5289.418164002033, 5423.430539793423, 5544.833654990357, 5690.338113577018, 5745.621050947659, 5321.946780532146, 5982.641041537521, 6003.939960600338, 6004.669743164168, 6027.57806953509, 3875.5349358076082, 3886.9028274292236, 3911.882643520699, 3913.5385660347797, 3927.7250592458254, 4899.828506002273, 5227.398849132398, 5434.994526012701, 5604.935062338142, 5766.971165144148, 4976.452590215146, 5574.352182713179, 5579.358373787067, 5607.5513958882375, 5624.015797235385, 4310.43964284641, 4709.929351059805, 5412.8646783829145, 5580.0, 5594.356648985418, 4623.768811559476, 4957.603391728581, 5048.7475626219275, 5452.563794896478, 5457.890842183055, 5233.528982391603, 5288.889333240063, 5398.730063496888, 5442.945570544244, 5599.020171469895, 4792.472827988988, 5019.749012549285, 5228.738563071755, 5339.941644350244, 5487.396386397413], "value": 4094.1131014155626, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [693.9548929319591, 709.528163771092, 711.7366574367485, 740.4039748002857, 815.6044318505526, 14018.369173387196, 14555.0, 14561.271936403191, 14610.123392596452, 14645.707085858276, 11101.4449277536, 13689.794653080211, 13702.0, 13716.657083572916, 13733.450661973535, 641.473991327112, 680.1667956752975, 871.8648609465542, 880.3265501891059, 896.3501461440469, 857.5712143928037, 874.7725591346264, 875.5315905990296, 877.9736607901741, 883.9878339301496, 890.6081324217324, 933.6405483888718, 935.822193783179, 936.4802534593298, 938.4041133879967, 925.3846192282158, 926.4672813132443, 928.0, 928.5774972387615, 929.2937367600605, 697.285282585349, 698.0227681246245, 698.2458944340101, 699.2308460693248, 700.5061431690646, 14237.216953067576, 14631.195284259362, 14642.853571464362, 14812.851871481254, 15131.0, 13561.932190338985, 13960.650983725387, 13970.161790292615, 14001.29993500321, 14088.647783805385, 11332.320060796379, 11378.943105284503, 11423.94288028563, 11617.302961822317, 12063.638090857288, 3603.891883243507, 3707.2214834884708, 3713.294474049949, 3727.8881633551036, 3853.171568112841, 99638.50180749122, 102405.97594024039, 103188.0, 103540.0, 105537.0, 10220.948895255477, 10290.845637315297, 10601.151907847354, 10649.89350106489, 10655.520501577448, 21578.676319855214, 21856.672149917766, 21961.78038219629, 21997.340079797632, 22004.88997555002, 7559.3196612305155, 7559.622018899033, 7572.583507907118, 7573.848523029508, 7801.180876008051, 4124.670026397881, 4177.49870015594, 4183.874483765492, 4225.535191128974, 4318.0, 2916.941661166765, 3329.0845017619863, 3402.6937575618313, 3403.9659603403647, 3423.7603367764514, 585.0814221671934, 585.9765609375662, 591.7278052096084, 596.764278110144, 600.3066458240739, 644.3492073006204, 673.1484671890063, 675.4630069095081, 683.5112894280613, 705.5660768627257, 8882.822343553222, 8895.688650897317, 9711.320207585542, 9930.851037234448, 10040.14658754014, 549.3627392225079, 579.6753817862011, 585.631052436962, 587.8706684529396, 597.2146627185238, 4555.202839503074, 4641.559051890065, 4671.649626277975, 4675.13510000651, 4683.929741053887, 101274.97450050958, 103248.0, 103342.48328758308, 103794.48102759589, 104328.0, 54539.0, 62163.0, 77172.61413693007, 77907.0, 91509.54245228865, 59497.81004379975, 73112.63443682747, 74487.0, 77613.2238677606, 80119.798203027, 9844.556994935389, 10482.109020733018, 10657.360558366523, 10731.0, 10833.566657333933, 45000.32499512444, 45873.77063114663, 46944.0, 47050.05899882052, 50060.74969625129, 65544.0, 67759.32240677727, 69501.60996780137, 69508.30491695019, 72423.27576724165, 12048.819267711167, 12114.878851211375, 12257.69355766113, 12424.627261182179, 12489.021956087825, 12848.0, 13513.054086214264, 13578.524751633646, 13859.514916977858, 14377.56867293983, 12602.87397126017, 12631.87368126307, 12917.935410322889, 12998.675033124247, 13225.272610006157, 12882.742345153232, 12980.545680901123, 13042.152260103063, 13166.934165329112, 13566.321683915567, 10736.41087130277, 12579.182353147016, 12589.480159340428, 13005.674858128623, 13459.3943272551, 9971.551280192554, 10395.896041039796, 10590.682279531626, 10718.0, 11145.665630031112, 8971.641134354553, 10480.951904809459, 10598.47007649599, 10621.840672389766, 10624.203184761329], "value": 7250.974571023716, "unit": "score"}], "name": "dromaeo_css", "value": 7401.167682110531, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 116.0, 115.0, 114.0, 115.0, 116.0, 112.0, 114.0, 115.0, 115.0], "value": 114.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 109.0, 109.0, 142.0, 112.0, 108.0, 111.0, 138.0, 160.0, 133.0], "value": 126.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 185.0, 189.0, 258.0, 243.0, 185.0, 186.0, 185.0, 182.0, 183.0], "value": 198.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 59.0, 89.0, 60.0, 59.0, 59.0, 59.0, 74.0, 57.0], "value": 65.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 72.0, 87.0, 70.0, 68.0, 71.0, 82.0, 67.0, 68.0, 82.0], "value": 75.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 87.0, 85.0, 86.0, 84.0, 86.0, 114.0, 87.0, 84.0], "value": 88.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 93.0, 95.0, 95.0, 95.0, 93.0, 127.0], "value": 97.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 87.0, 87.0, 86.0, 87.0, 85.0, 85.0, 88.0, 84.0], "value": 86.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 52.0, 52.0, 54.0, 54.0, 56.0, 54.0, 56.0, 56.0, 58.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 74.0, 79.0, 73.0, 70.0, 68.0, 69.0, 68.0, 69.0, 69.0], "value": 70.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 84.0, 85.0, 83.0, 84.0, 85.0, 82.0, 84.0, 82.0], "value": 83.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 138.0, 137.0, 151.0, 142.0, 137.0, 140.0, 135.0, 208.0, 168.0], "value": 149.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 166.0, 171.0, 167.0, 180.0, 165.0, 167.0, 168.0, 167.0, 165.0], "value": 168.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 65.0, 65.0, 65.0, 65.0, 64.0, 65.0, 63.0, 65.0], "value": 65.0, "unit": "score"}], "name": "kraken", "value": 1443.9, "alertThreshold": 2.0}]} 09:37:00 INFO - Return code: 0 09:37:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:37:00 ERROR - # TBPL SUCCESS # 09:37:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:37:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:37:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:37:00 INFO - 2017-02-16 09:37:00.111 screenresolution[1918:16376] starting screenresolution argv=screenresolution get 09:37:00 INFO - 2017-02-16 09:37:00.114 screenresolution[1918:16376] Display 0: 1600x1200x32@60 09:37:00 INFO - 2017-02-16 09:37:00.120 screenresolution[1919:16379] starting screenresolution argv=screenresolution list 09:37:00 INFO - Available Modes on Display 0 09:37:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:37:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:37:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:37:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:37:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:37:00 INFO - Intel Iris: 09:37:00 INFO - Chipset Model: Intel Iris 09:37:00 INFO - Type: GPU 09:37:00 INFO - Bus: Built-In 09:37:00 INFO - VRAM (Dynamic, Max): 1536 MB 09:37:00 INFO - Vendor: Intel (0x8086) 09:37:00 INFO - Device ID: 0x0a2e 09:37:00 INFO - Revision ID: 0x0009 09:37:00 INFO - Displays: 09:37:00 INFO - Display: 09:37:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:37:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:37:00 INFO - Display Serial Number: 1600x1200 60 09:37:00 INFO - Main Display: Yes 09:37:00 INFO - Mirror: Off 09:37:00 INFO - Online: Yes 09:37:00 INFO - Rotation: Supported 09:37:00 INFO - Return code: 0 09:37:00 INFO - Running post-action listener: _resource_record_post_action 09:37:00 INFO - [mozharness: 2017-02-16 17:37:00.353601Z] Finished run-tests step (success) 09:37:00 INFO - Running post-run listener: _resource_record_post_run 09:37:00 INFO - Total resource usage - Wall time: 1199s; CPU: 54.0%; Read bytes: 675840; Write bytes: 506915328; Read time: 11; Write time: 1565 09:37:00 INFO - TinderboxPrint: CPU usage
53.9% 09:37:00 INFO - TinderboxPrint: I/O read bytes / time
675,840 / 11 09:37:00 INFO - TinderboxPrint: I/O write bytes / time
506,915,328 / 1,565 09:37:00 INFO - TinderboxPrint: CPU idle
2,213.8 (46.1%) 09:37:00 INFO - TinderboxPrint: CPU system
959.5 (20.0%) 09:37:00 INFO - TinderboxPrint: CPU user
1,624.3 (33.9%) 09:37:00 INFO - TinderboxPrint: Swap in / out
208,752,640 / 0 09:37:00 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 207380992; Write bytes: 201991680; Read time: 15887; Write time: 424 09:37:00 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 610304; Write bytes: 294884352; Read time: 9; Write time: 1101 09:37:00 INFO - Running post-run listener: _upload_blobber_files 09:37:00 INFO - Blob upload gear active. 09:37:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:37:00 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 09:37:00 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'] 09:37:00 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 09:37:01 INFO - (blobuploader) - INFO - Open directory for files ... 09:37:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:37:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:37:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:37:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:37:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:37:02 INFO - (blobuploader) - INFO - Done attempting. 09:37:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:37:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:37:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:37:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:37:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:37:03 INFO - (blobuploader) - INFO - Done attempting. 09:37:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:37:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:37:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:37:04 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:37:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:37:04 INFO - (blobuploader) - INFO - Done attempting. 09:37:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:37:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:37:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:37:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:37:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:37:08 INFO - (blobuploader) - INFO - Done attempting. 09:37:08 INFO - (blobuploader) - INFO - Iteration through files over. 09:37:08 INFO - Return code: 0 09:37:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:37:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:37:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/42812e4b7672dfb0490315022e3be14dc475968693d12a5ed33c69c89649387566ef1726d76e47eac218dfa08cff05b052bf60a0770343b3498d109f71910e31", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2b54fb31b1b39da4951be59451f39f1908c258095db160bfcf5173231d0c4c43dd04b3e59ae7c08e20de953ae43caaaa8b6d30e5f432a51956695216caa90739", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9af2aee497d190db78fc2a27108fa7fbf58ec03ee9baddd34c355b28cf3bca14f45f52f1100c7ce36cb51875896d4a24a0b024c6e749927e0bfcf4bbcb769283", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c1bd58511adeaf5b1e9de477340f1272d4a2b0851f96a30f8d0ae11aa9c5004243c2376a36f28fea969ee02cc6861eec4af4c3fad734d31f7cf4fee0fa8ed6fb"} 09:37:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:37:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:37:08 INFO - Contents: 09:37:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/42812e4b7672dfb0490315022e3be14dc475968693d12a5ed33c69c89649387566ef1726d76e47eac218dfa08cff05b052bf60a0770343b3498d109f71910e31", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2b54fb31b1b39da4951be59451f39f1908c258095db160bfcf5173231d0c4c43dd04b3e59ae7c08e20de953ae43caaaa8b6d30e5f432a51956695216caa90739", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9af2aee497d190db78fc2a27108fa7fbf58ec03ee9baddd34c355b28cf3bca14f45f52f1100c7ce36cb51875896d4a24a0b024c6e749927e0bfcf4bbcb769283", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c1bd58511adeaf5b1e9de477340f1272d4a2b0851f96a30f8d0ae11aa9c5004243c2376a36f28fea969ee02cc6861eec4af4c3fad734d31f7cf4fee0fa8ed6fb"} 09:37:08 INFO - Running post-run listener: copy_logs_to_upload_dir 09:37:08 INFO - Copying logs to upload dir... 09:37:08 INFO - mkdir: /builds/slave/test/build/upload/logs 09:37:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.272712 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-02-16 09:37:08.405767) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-16 09:37:08.408993) ========= 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.ig3pMQfiIv/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.fQIQgPmLkx/Listeners TMPDIR=/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/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/42812e4b7672dfb0490315022e3be14dc475968693d12a5ed33c69c89649387566ef1726d76e47eac218dfa08cff05b052bf60a0770343b3498d109f71910e31", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2b54fb31b1b39da4951be59451f39f1908c258095db160bfcf5173231d0c4c43dd04b3e59ae7c08e20de953ae43caaaa8b6d30e5f432a51956695216caa90739", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9af2aee497d190db78fc2a27108fa7fbf58ec03ee9baddd34c355b28cf3bca14f45f52f1100c7ce36cb51875896d4a24a0b024c6e749927e0bfcf4bbcb769283", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c1bd58511adeaf5b1e9de477340f1272d4a2b0851f96a30f8d0ae11aa9c5004243c2376a36f28fea969ee02cc6861eec4af4c3fad734d31f7cf4fee0fa8ed6fb"} build_url:https://queue.taskcluster.net/v1/task/AI3csdEBTJWqq6xAd0V81g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011001 build_url: 'https://queue.taskcluster.net/v1/task/AI3csdEBTJWqq6xAd0V81g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/42812e4b7672dfb0490315022e3be14dc475968693d12a5ed33c69c89649387566ef1726d76e47eac218dfa08cff05b052bf60a0770343b3498d109f71910e31", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2b54fb31b1b39da4951be59451f39f1908c258095db160bfcf5173231d0c4c43dd04b3e59ae7c08e20de953ae43caaaa8b6d30e5f432a51956695216caa90739", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9af2aee497d190db78fc2a27108fa7fbf58ec03ee9baddd34c355b28cf3bca14f45f52f1100c7ce36cb51875896d4a24a0b024c6e749927e0bfcf4bbcb769283", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c1bd58511adeaf5b1e9de477340f1272d4a2b0851f96a30f8d0ae11aa9c5004243c2376a36f28fea969ee02cc6861eec4af4c3fad734d31f7cf4fee0fa8ed6fb"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-16 09:37:08.448903) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 09:37:08.449284) ========= 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.ig3pMQfiIv/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.fQIQgPmLkx/Listeners TMPDIR=/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/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.005130 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 09:37:08.498580) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-16 09:37:08.498953) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-16 09:37:08.499315) ========= ========= Total master_lag: 0.19 =========