builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0079 starttime: 1474646499.52 results: success (0) buildid: 20160923064759 builduid: 29d7030082d941c585ea3251d6c2d31d revision: dace749327dde3d7409bfe0ab871459116f702a9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-23 09:01:39.525046) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-23 09:01:39.525483) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-23 09:01:39.525772) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-23 09:01:39.551043) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 09:01:39.551380) ========= 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.NkoXfVDkEg/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.Mc75rdXl0G/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-09-23 09:01:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 159M=0s 2016-09-23 09:01:39 (159 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.139836 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 09:01:39.714107) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 09:01:39.714573) ========= 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.NkoXfVDkEg/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.Mc75rdXl0G/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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.036390 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 09:01:39.772382) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-09-23 09:01:39.772737) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev dace749327dde3d7409bfe0ab871459116f702a9 --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 dace749327dde3d7409bfe0ab871459116f702a9 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NkoXfVDkEg/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.Mc75rdXl0G/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-09-23 09:01:39,849 truncating revision to first 12 chars 2016-09-23 09:01:39,849 Setting DEBUG logging. 2016-09-23 09:01:39,849 attempt 1/10 2016-09-23 09:01:39,849 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/dace749327dd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-23 09:01:41,701 unpacking tar archive at: mozilla-aurora-dace749327dd/testing/mozharness/ program finished with exit code 0 elapsedTime=2.123037 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-09-23 09:01:41.919220) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-23 09:01:41.919640) ========= script_repo_revision: dace749327dde3d7409bfe0ab871459116f702a9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-23 09:01:41.920114) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-23 09:01:41.920442) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-23 09:01:41.937174) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-09-23 09:01:41.937533) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NkoXfVDkEg/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.Mc75rdXl0G/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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:01:42 INFO - MultiFileLogger online at 20160923 09:01:42 in /builds/slave/test 09:01:42 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:01:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:01:42 INFO - {'append_to_log': False, 09:01:42 INFO - 'base_work_dir': '/builds/slave/test', 09:01:42 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:01:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:01:42 INFO - 'branch': 'Mozilla-Aurora', 09:01:42 INFO - 'buildbot_json_path': 'buildprops.json', 09:01:42 INFO - 'config_files': ('talos/mac_config.py',), 09:01:42 INFO - 'default_actions': ('clobber', 09:01:42 INFO - 'read-buildbot-config', 09:01:42 INFO - 'download-and-extract', 09:01:42 INFO - 'populate-webroot', 09:01:42 INFO - 'create-virtualenv', 09:01:42 INFO - 'install', 09:01:42 INFO - 'run-tests'), 09:01:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:01:42 INFO - 'download_minidump_stackwalk': True, 09:01:42 INFO - 'download_symbols': 'ondemand', 09:01:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:01:42 INFO - 'tooltool.py': '/tools/tooltool.py', 09:01:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:01:42 INFO - '/tools/misc-python/virtualenv.py')}, 09:01:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:01:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:01:42 INFO - 'installer_path': 'installer.exe', 09:01:42 INFO - 'log_level': 'info', 09:01:42 INFO - 'log_name': 'talos', 09:01:42 INFO - 'log_to_console': True, 09:01:42 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:01:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:01:42 INFO - 'opt_config_files': (), 09:01:42 INFO - 'pip_index': False, 09:01:42 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:01:42 INFO - 'cmd': ('bash', 09:01:42 INFO - '-c', 09:01:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:01:42 INFO - 'enabled': True, 09:01:42 INFO - 'halt_on_failure': False, 09:01:42 INFO - 'name': 'check_screen_resolution'},), 09:01:42 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:01:42 INFO - 'cmd': ('bash', 09:01:42 INFO - '-c', 09:01:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:01:42 INFO - 'enabled': True, 09:01:42 INFO - 'halt_on_failure': False, 09:01:42 INFO - 'name': 'check_screen_resolution'},), 09:01:42 INFO - 'run_cmd_checks_enabled': True, 09:01:42 INFO - 'sps_profile': False, 09:01:42 INFO - 'sps_profile_interval': 0, 09:01:42 INFO - 'suite': 'dromaeojs', 09:01:42 INFO - 'system_bits': '32', 09:01:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:01:42 INFO - 'title': 't-yosemite-r7-0079', 09:01:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:01:42 INFO - 'use_talos_json': True, 09:01:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:01:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:01:42 INFO - 'work_dir': 'build'} 09:01:42 INFO - [mozharness: 2016-09-23 16:01:42.136771Z] Running clobber step. 09:01:42 INFO - Running pre-action listener: _resource_record_pre_action 09:01:42 INFO - Running main action method: clobber 09:01:42 INFO - rmtree: /builds/slave/test/build 09:01:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:01:44 INFO - Running post-action listener: _resource_record_post_action 09:01:44 INFO - [mozharness: 2016-09-23 16:01:44.266797Z] Finished clobber step (success) 09:01:44 INFO - [mozharness: 2016-09-23 16:01:44.266988Z] Running read-buildbot-config step. 09:01:44 INFO - Running pre-action listener: _resource_record_pre_action 09:01:44 INFO - Running main action method: read_buildbot_config 09:01:44 INFO - Using buildbot properties: 09:01:44 INFO - { 09:01:44 INFO - "project": "", 09:01:44 INFO - "product": "firefox", 09:01:44 INFO - "script_repo_revision": "production", 09:01:44 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 09:01:44 INFO - "repository": "", 09:01:44 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 09:01:44 INFO - "buildid": "20160923064759", 09:01:44 INFO - "pgo_build": "False", 09:01:44 INFO - "basedir": "/builds/slave/test", 09:01:44 INFO - "buildnumber": 31, 09:01:44 INFO - "slavename": "t-yosemite-r7-0079", 09:01:44 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 09:01:44 INFO - "platform": "yosemite_r7", 09:01:44 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 09:01:44 INFO - "branch": "mozilla-aurora", 09:01:44 INFO - "repo_path": "releases/mozilla-aurora", 09:01:44 INFO - "revision": "dace749327dde3d7409bfe0ab871459116f702a9", 09:01:44 INFO - "stage_platform": "macosx64", 09:01:44 INFO - "builduid": "29d7030082d941c585ea3251d6c2d31d", 09:01:44 INFO - "slavebuilddir": "test" 09:01:44 INFO - } 09:01:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/DURbrwJ0QJCE-B6kEGKVwg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 09:01:44 INFO - Running post-action listener: _resource_record_post_action 09:01:44 INFO - [mozharness: 2016-09-23 16:01:44.270359Z] Finished read-buildbot-config step (success) 09:01:44 INFO - [mozharness: 2016-09-23 16:01:44.270470Z] Running download-and-extract step. 09:01:44 INFO - Running pre-action listener: _resource_record_pre_action 09:01:44 INFO - Running main action method: download_and_extract 09:01:44 INFO - mkdir: /builds/slave/test/build/tests 09:01: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:01:44 INFO - trying https://queue.taskcluster.net/v1/task/DURbrwJ0QJCE-B6kEGKVwg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 09:01:44 INFO - Downloading https://queue.taskcluster.net/v1/task/DURbrwJ0QJCE-B6kEGKVwg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 09:01:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DURbrwJ0QJCE-B6kEGKVwg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 09:01:45 INFO - Downloaded 1199 bytes. 09:01:45 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 09:01:45 INFO - Using the following test package requirements: 09:01:45 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 09:01:45 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:01:45 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 09:01:45 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:01:45 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 09:01:45 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:01:45 INFO - u'jsshell-mac.zip'], 09:01:45 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:01:45 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 09:01:45 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 09:01:45 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:01:45 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 09:01:45 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:01:45 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 09:01:45 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:01:45 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 09:01:45 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:01:45 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 09:01:45 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 09:01:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DURbrwJ0QJCE-B6kEGKVwg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 09:01:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DURbrwJ0QJCE-B6kEGKVwg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:01:45 INFO - Fetch https://queue.taskcluster.net/v1/task/DURbrwJ0QJCE-B6kEGKVwg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 09:01:45 INFO - Expected file size: 16430828 09:01:52 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 09:01:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DURbrwJ0QJCE-B6kEGKVwg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 09:01:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DURbrwJ0QJCE-B6kEGKVwg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:01:52 INFO - Fetch https://queue.taskcluster.net/v1/task/DURbrwJ0QJCE-B6kEGKVwg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 09:01:53 INFO - Expected file size: 16430828 09:02:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DURbrwJ0QJCE-B6kEGKVwg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 09:02:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DURbrwJ0QJCE-B6kEGKVwg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 09:02:00 INFO - Fetch https://queue.taskcluster.net/v1/task/DURbrwJ0QJCE-B6kEGKVwg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 09:02:00 INFO - Expected file size: 14414059 09:02:01 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:02:01 INFO - trying https://queue.taskcluster.net/v1/task/DURbrwJ0QJCE-B6kEGKVwg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 09:02:01 INFO - Downloading https://queue.taskcluster.net/v1/task/DURbrwJ0QJCE-B6kEGKVwg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 09:02:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DURbrwJ0QJCE-B6kEGKVwg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 09:02:04 INFO - Downloaded 115256132 bytes. 09:02:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DURbrwJ0QJCE-B6kEGKVwg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 09:02:04 INFO - mkdir: /builds/slave/test/properties 09:02:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:02:04 INFO - Writing to file /builds/slave/test/properties/build_url 09:02:04 INFO - Contents: 09:02:04 INFO - build_url:https://queue.taskcluster.net/v1/task/DURbrwJ0QJCE-B6kEGKVwg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 09:02:04 INFO - Running post-action listener: _resource_record_post_action 09:02:04 INFO - Running post-action listener: set_extra_try_arguments 09:02:04 INFO - [mozharness: 2016-09-23 16:02:04.877889Z] Finished download-and-extract step (success) 09:02:04 INFO - [mozharness: 2016-09-23 16:02:04.878025Z] Running populate-webroot step. 09:02:04 INFO - Running pre-action listener: _resource_record_pre_action 09:02:04 INFO - Running main action method: populate_webroot 09:02:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:02:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:02:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:02:04 INFO - '--tppagecycles', 09:02:04 INFO - '7'], 09:02:04 INFO - 'tests': ['tsvgm']}}, 09:02:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:02:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:02:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:02:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:02:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:02:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:02:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:02:04 INFO - 'talos_options': ['--disable-e10s'], 09:02:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:02:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:02:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:02:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:02:04 INFO - 'talos_options': ['--disable-e10s'], 09:02:04 INFO - 'tests': ['damp', 'tps']}, 09:02:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:02:04 INFO - 'tests': ['damp', 'tps']}, 09:02:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:02:04 INFO - 'tests': ['dromaeo_dom']}, 09:02:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:02:04 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:02:04 INFO - 'tests': ['basic_compositor_video']}, 09:02:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:02:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:02:04 INFO - 'tests': ['a11yr', 09:02:04 INFO - 'ts_paint', 09:02:04 INFO - 'tpaint', 09:02:04 INFO - 'sessionrestore', 09:02:04 INFO - 'sessionrestore_no_auto_restore', 09:02:04 INFO - 'tabpaint']}, 09:02:04 INFO - 'other-e10s': {'tests': ['a11yr', 09:02:04 INFO - 'ts_paint', 09:02:04 INFO - 'tpaint', 09:02:04 INFO - 'sessionrestore', 09:02:04 INFO - 'sessionrestore_no_auto_restore', 09:02:04 INFO - 'tabpaint']}, 09:02:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:02:04 INFO - 'ts_paint', 09:02:04 INFO - 'tpaint', 09:02:04 INFO - 'sessionrestore', 09:02:04 INFO - 'sessionrestore_no_auto_restore', 09:02:04 INFO - 'tabpaint']}, 09:02:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:02:04 INFO - 'ts_paint', 09:02:04 INFO - 'tpaint', 09:02:04 INFO - 'sessionrestore', 09:02:04 INFO - 'sessionrestore_no_auto_restore', 09:02:04 INFO - 'tabpaint']}, 09:02:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:02:04 INFO - 'tests': ['a11yr', 09:02:04 INFO - 'ts_paint', 09:02:04 INFO - 'tpaint', 09:02:04 INFO - 'sessionrestore', 09:02:04 INFO - 'sessionrestore_no_auto_restore', 09:02:04 INFO - 'tabpaint']}, 09:02:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:02:04 INFO - 'tests': ['a11yr', 09:02:04 INFO - 'ts_paint', 09:02:04 INFO - 'tpaint', 09:02:04 INFO - 'sessionrestore', 09:02:04 INFO - 'sessionrestore_no_auto_restore', 09:02:04 INFO - 'tabpaint']}, 09:02:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:02:04 INFO - 'tests': ['tsvgx', 09:02:04 INFO - 'tsvgr_opacity', 09:02:04 INFO - 'tart', 09:02:04 INFO - 'tscrollx', 09:02:04 INFO - 'cart']}, 09:02:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:02:04 INFO - 'tsvgr_opacity', 09:02:04 INFO - 'tart', 09:02:04 INFO - 'tscrollx', 09:02:04 INFO - 'cart']}, 09:02:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:02:04 INFO - 'talos_options': ['--disable-e10s'], 09:02:04 INFO - 'tests': ['tp5o']}, 09:02:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:02:04 INFO - 'tests': ['tp5o']}, 09:02:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:02:04 INFO - 'talos_options': ['--disable-e10s', 09:02:04 INFO - '--xperf_path', 09:02:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:02:04 INFO - 'tests': ['tp5n']}, 09:02:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:02:04 INFO - 'talos_options': ['--xperf_path', 09:02:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:02:04 INFO - 'tests': ['tp5n']}}, 09:02:04 INFO - 'talos.zip': {'path': '', 09:02:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:02:04 INFO - Running post-action listener: _resource_record_post_action 09:02:04 INFO - [mozharness: 2016-09-23 16:02:04.896150Z] Finished populate-webroot step (success) 09:02:04 INFO - [mozharness: 2016-09-23 16:02:04.896261Z] Running create-virtualenv step. 09:02:04 INFO - Running pre-action listener: _resource_record_pre_action 09:02:04 INFO - Running main action method: create_virtualenv 09:02:04 INFO - Creating virtualenv /builds/slave/test/build/venv 09:02:04 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:02:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:02:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:02:05 INFO - Using real prefix '/tools/python27' 09:02:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:02:05 INFO - Installing distribute.............................................................................................................................................................................................done. 09:02:08 INFO - Installing pip.................done. 09:02:08 INFO - Return code: 0 09:02:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:02: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:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:02:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02: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:02:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:02:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:08 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 0x10e761490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6d7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9050d89380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e575d30>, '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 0x10e3dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e56db20>, '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.NkoXfVDkEg/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.Mc75rdXl0G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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:02:08 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:02:08 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:02:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NkoXfVDkEg/Render', 09:02:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:02:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:02:08 INFO - 'HOME': '/Users/cltbld', 09:02:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:02:08 INFO - 'LOGNAME': 'cltbld', 09:02:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:02:08 INFO - 'MOZ_NO_REMOTE': '1', 09:02:08 INFO - 'NO_EM_RESTART': '1', 09:02:08 INFO - 'PAGER': '/bin/cat', 09:02:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:02:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:02:08 INFO - 'PWD': '/builds/slave/test', 09:02:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:02:08 INFO - 'SHELL': '/bin/bash', 09:02:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Mc75rdXl0G/Listeners', 09:02:08 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 09:02:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:02:08 INFO - 'USER': 'cltbld', 09:02:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:02:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:02:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:02:08 INFO - 'XPC_FLAGS': '0x0', 09:02:08 INFO - 'XPC_SERVICE_NAME': '0', 09:02:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:02:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:02:08 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:02:08 INFO - Cleaning up... 09:02:08 INFO - Return code: 0 09:02:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:02: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:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:02:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02: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:02:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:02:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:08 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 0x10e761490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6d7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9050d89380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e575d30>, '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 0x10e3dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e56db20>, '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.NkoXfVDkEg/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.Mc75rdXl0G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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:02:08 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:02:08 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:02:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NkoXfVDkEg/Render', 09:02:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:02:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:02:08 INFO - 'HOME': '/Users/cltbld', 09:02:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:02:08 INFO - 'LOGNAME': 'cltbld', 09:02:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:02:08 INFO - 'MOZ_NO_REMOTE': '1', 09:02:08 INFO - 'NO_EM_RESTART': '1', 09:02:08 INFO - 'PAGER': '/bin/cat', 09:02:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:02:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:02:08 INFO - 'PWD': '/builds/slave/test', 09:02:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:02:08 INFO - 'SHELL': '/bin/bash', 09:02:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Mc75rdXl0G/Listeners', 09:02:08 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 09:02:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:02:08 INFO - 'USER': 'cltbld', 09:02:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:02:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:02:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:02:08 INFO - 'XPC_FLAGS': '0x0', 09:02:08 INFO - 'XPC_SERVICE_NAME': '0', 09:02:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:02:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:02:09 INFO - Downloading/unpacking psutil>=3.1.1 09:02:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:02:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:02:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:02:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:02:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:02:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:02:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:02:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:02:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:02:12 INFO - Installing collected packages: psutil 09:02:12 INFO - Running setup.py install for psutil 09:02:12 INFO - building 'psutil._psutil_osx' extension 09:02:12 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:02:13 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:02:13 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:02:13 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:02:13 INFO - building 'psutil._psutil_posix' extension 09:02:13 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:02:13 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:02:13 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:02:13 INFO - ^ 09:02:13 INFO - 1 warning generated. 09:02:13 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:02:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:02:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:02:13 INFO - Successfully installed psutil 09:02:13 INFO - Cleaning up... 09:02:13 INFO - Return code: 0 09:02:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:02:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:02:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:02:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:02:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:02:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e761490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6d7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9050d89380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e575d30>, '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 0x10e3dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e56db20>, '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.NkoXfVDkEg/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.Mc75rdXl0G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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:02:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:02:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:02:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NkoXfVDkEg/Render', 09:02:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:02:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:02:13 INFO - 'HOME': '/Users/cltbld', 09:02:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:02:13 INFO - 'LOGNAME': 'cltbld', 09:02:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:02:13 INFO - 'MOZ_NO_REMOTE': '1', 09:02:13 INFO - 'NO_EM_RESTART': '1', 09:02:13 INFO - 'PAGER': '/bin/cat', 09:02:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:02:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:02:13 INFO - 'PWD': '/builds/slave/test', 09:02:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:02:13 INFO - 'SHELL': '/bin/bash', 09:02:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Mc75rdXl0G/Listeners', 09:02:13 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 09:02:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:02:13 INFO - 'USER': 'cltbld', 09:02:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:02:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:02:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:02:13 INFO - 'XPC_FLAGS': '0x0', 09:02:13 INFO - 'XPC_SERVICE_NAME': '0', 09:02:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:02:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:02:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:02:14 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:02:14 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:02:14 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:02:14 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:02:14 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:02:14 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:02:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:02:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:02:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:02:16 INFO - Installing collected packages: mozsystemmonitor 09:02:16 INFO - Running setup.py install for mozsystemmonitor 09:02:16 INFO - Successfully installed mozsystemmonitor 09:02:16 INFO - Cleaning up... 09:02:16 INFO - Return code: 0 09:02:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:02:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:02:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:02:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:02:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:02:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:16 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 0x10e761490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6d7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9050d89380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e575d30>, '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 0x10e3dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e56db20>, '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.NkoXfVDkEg/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.Mc75rdXl0G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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:02:16 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:02:16 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:02:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NkoXfVDkEg/Render', 09:02:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:02:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:02:16 INFO - 'HOME': '/Users/cltbld', 09:02:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:02:16 INFO - 'LOGNAME': 'cltbld', 09:02:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:02:16 INFO - 'MOZ_NO_REMOTE': '1', 09:02:16 INFO - 'NO_EM_RESTART': '1', 09:02:16 INFO - 'PAGER': '/bin/cat', 09:02:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:02:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:02:16 INFO - 'PWD': '/builds/slave/test', 09:02:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:02:16 INFO - 'SHELL': '/bin/bash', 09:02:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Mc75rdXl0G/Listeners', 09:02:16 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 09:02:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:02:16 INFO - 'USER': 'cltbld', 09:02:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:02:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:02:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:02:16 INFO - 'XPC_FLAGS': '0x0', 09:02:16 INFO - 'XPC_SERVICE_NAME': '0', 09:02:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:02:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:02:17 INFO - Downloading/unpacking jsonschema==2.5.1 09:02:17 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:02:17 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:02:17 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:02:17 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:02:17 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:02:17 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:02:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:02:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:02:19 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:02:19 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:02:19 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:02:19 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:02:19 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:02:19 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:02:19 INFO - Downloading functools32-3.2.3-2.tar.gz 09:02:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:02:19 INFO - warning: no files found matching '*.txt' 09:02:19 INFO - no previously-included directories found matching 'build' 09:02:19 INFO - no previously-included directories found matching 'dist' 09:02:19 INFO - no previously-included directories found matching '.git*' 09:02:19 INFO - Installing collected packages: jsonschema, functools32 09:02:19 INFO - Running setup.py install for functools32 09:02:20 INFO - warning: no files found matching '*.txt' 09:02:20 INFO - no previously-included directories found matching 'build' 09:02:20 INFO - no previously-included directories found matching 'dist' 09:02:20 INFO - no previously-included directories found matching '.git*' 09:02:20 INFO - Successfully installed jsonschema functools32 09:02:20 INFO - Cleaning up... 09:02:20 INFO - Return code: 0 09:02:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:02:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:02:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:02:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:02:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:02:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e761490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6d7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9050d89380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e575d30>, '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 0x10e3dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e56db20>, '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.NkoXfVDkEg/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.Mc75rdXl0G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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:02:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:02:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:02:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NkoXfVDkEg/Render', 09:02:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:02:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:02:20 INFO - 'HOME': '/Users/cltbld', 09:02:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:02:20 INFO - 'LOGNAME': 'cltbld', 09:02:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:02:20 INFO - 'MOZ_NO_REMOTE': '1', 09:02:20 INFO - 'NO_EM_RESTART': '1', 09:02:20 INFO - 'PAGER': '/bin/cat', 09:02:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:02:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:02:20 INFO - 'PWD': '/builds/slave/test', 09:02:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:02:20 INFO - 'SHELL': '/bin/bash', 09:02:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Mc75rdXl0G/Listeners', 09:02:20 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 09:02:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:02:20 INFO - 'USER': 'cltbld', 09:02:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:02:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:02:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:02:20 INFO - 'XPC_FLAGS': '0x0', 09:02:20 INFO - 'XPC_SERVICE_NAME': '0', 09:02:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:02:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:02:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:02:20 INFO - Cleaning up... 09:02:20 INFO - Return code: 0 09:02:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:02:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:02:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:02:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:02:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:02:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e761490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6d7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9050d89380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e575d30>, '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 0x10e3dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e56db20>, '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.NkoXfVDkEg/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.Mc75rdXl0G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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:02:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:02:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:02:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NkoXfVDkEg/Render', 09:02:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:02:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:02:20 INFO - 'HOME': '/Users/cltbld', 09:02:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:02:20 INFO - 'LOGNAME': 'cltbld', 09:02:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:02:20 INFO - 'MOZ_NO_REMOTE': '1', 09:02:20 INFO - 'NO_EM_RESTART': '1', 09:02:20 INFO - 'PAGER': '/bin/cat', 09:02:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:02:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:02:20 INFO - 'PWD': '/builds/slave/test', 09:02:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:02:20 INFO - 'SHELL': '/bin/bash', 09:02:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Mc75rdXl0G/Listeners', 09:02:20 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 09:02:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:02:20 INFO - 'USER': 'cltbld', 09:02:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:02:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:02:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:02:20 INFO - 'XPC_FLAGS': '0x0', 09:02:20 INFO - 'XPC_SERVICE_NAME': '0', 09:02:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:02:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:02:20 INFO - Downloading/unpacking blobuploader==1.2.4 09:02:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:02:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:02:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:02:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:02:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:02:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:02:23 INFO - Downloading blobuploader-1.2.4.tar.gz 09:02:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:02:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:02:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:02:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:02:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:02:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:02:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:02:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:02:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:02:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:02:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:02:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:02:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:02:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:02:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:02:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:02:24 INFO - Downloading docopt-0.6.1.tar.gz 09:02:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:02:24 INFO - Installing collected packages: blobuploader, requests, docopt 09:02:24 INFO - Running setup.py install for blobuploader 09:02:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:02:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:02:24 INFO - Running setup.py install for requests 09:02:25 INFO - Running setup.py install for docopt 09:02:25 INFO - Successfully installed blobuploader requests docopt 09:02:25 INFO - Cleaning up... 09:02:25 INFO - Return code: 0 09:02:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:02: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:02:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:02:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02: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:02:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:02:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:25 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 0x10e761490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6d7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9050d89380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e575d30>, '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 0x10e3dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e56db20>, '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.NkoXfVDkEg/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.Mc75rdXl0G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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:02:25 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:02:25 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:02:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NkoXfVDkEg/Render', 09:02:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:02:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:02:25 INFO - 'HOME': '/Users/cltbld', 09:02:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:02:25 INFO - 'LOGNAME': 'cltbld', 09:02:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:02:25 INFO - 'MOZ_NO_REMOTE': '1', 09:02:25 INFO - 'NO_EM_RESTART': '1', 09:02:25 INFO - 'PAGER': '/bin/cat', 09:02:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:02:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:02:25 INFO - 'PWD': '/builds/slave/test', 09:02:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:02:25 INFO - 'SHELL': '/bin/bash', 09:02:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Mc75rdXl0G/Listeners', 09:02:25 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 09:02:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:02:25 INFO - 'USER': 'cltbld', 09:02:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:02:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:02:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:02:25 INFO - 'XPC_FLAGS': '0x0', 09:02:25 INFO - 'XPC_SERVICE_NAME': '0', 09:02:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:02:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:02:25 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-BTEtt4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:02:25 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-c0Fepb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:02:25 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-age2xt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:02:25 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-1juYZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:02:25 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-CubpBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:02:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:02:26 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-VhKXAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:02:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:02:26 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-dDe4kr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:02:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:02:26 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-HWmqUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:02:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:02:26 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-GffNqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:02:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:02:26 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-mbrB_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:02:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:02:26 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-Edj6n7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:02:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:02:26 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-gRP9uW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:02:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:02:26 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-KYGdGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:02:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:02:26 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-S1FFgK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:02:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:02:26 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-rFCcfD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:02:27 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-i5eiKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:02:27 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-l0zlpu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:02:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:02:27 INFO - Running setup.py install for manifestparser 09:02:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:02:27 INFO - Running setup.py install for mozcrash 09:02:27 INFO - Running setup.py install for mozdebug 09:02:27 INFO - Running setup.py install for mozdevice 09:02:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:02:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:02:27 INFO - Running setup.py install for mozfile 09:02:28 INFO - Running setup.py install for mozhttpd 09:02:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:02:28 INFO - Running setup.py install for mozinfo 09:02:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:02:28 INFO - Running setup.py install for mozInstall 09:02:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:02:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:02:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:02:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:02:28 INFO - Running setup.py install for mozleak 09:02:28 INFO - Running setup.py install for mozlog 09:02:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:02:28 INFO - Running setup.py install for moznetwork 09:02:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:02:28 INFO - Running setup.py install for mozprocess 09:02:29 INFO - Running setup.py install for mozprofile 09:02:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:02:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:02:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:02:29 INFO - Running setup.py install for mozrunner 09:02:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:02:29 INFO - Running setup.py install for mozscreenshot 09:02:29 INFO - Running setup.py install for moztest 09:02:29 INFO - Running setup.py install for mozversion 09:02:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:02:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:02:29 INFO - Cleaning up... 09:02:29 INFO - Return code: 0 09:02:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:02:29 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:02:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:02:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:29 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:02:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:02:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:29 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 0x10e761490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6d7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9050d89380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e575d30>, '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 0x10e3dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e56db20>, '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.NkoXfVDkEg/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.Mc75rdXl0G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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:02:29 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:02:29 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:02:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NkoXfVDkEg/Render', 09:02:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:02:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:02:29 INFO - 'HOME': '/Users/cltbld', 09:02:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:02:29 INFO - 'LOGNAME': 'cltbld', 09:02:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:02:29 INFO - 'MOZ_NO_REMOTE': '1', 09:02:29 INFO - 'NO_EM_RESTART': '1', 09:02:29 INFO - 'PAGER': '/bin/cat', 09:02:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:02:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:02:29 INFO - 'PWD': '/builds/slave/test', 09:02:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:02:29 INFO - 'SHELL': '/bin/bash', 09:02:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Mc75rdXl0G/Listeners', 09:02:29 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 09:02:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:02:29 INFO - 'USER': 'cltbld', 09:02:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:02:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:02:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:02:29 INFO - 'XPC_FLAGS': '0x0', 09:02:29 INFO - 'XPC_SERVICE_NAME': '0', 09:02:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:02:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:02:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:02:30 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-kOILC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:02:30 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:02:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:02:30 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-bwls8s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:02:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:02:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:02:30 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-z4Ulf7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:02:30 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:02:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:02:30 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-7kWxqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:02:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:02:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:02:30 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-S7JDGw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:02:30 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:02:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:02:30 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-Kt142v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:02:30 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:02:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:02:30 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-2RWLcP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:02:30 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:02:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:02:30 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-DiTPrk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:02:30 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:02:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:02:30 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-l6uUAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:02:31 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:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:02:31 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-zAVpJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:02:31 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:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:02:31 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-P37cu0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:02:31 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:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:02:31 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-1sHjLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:02:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:02:31 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-LW90HW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:02:31 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:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:02:31 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-uRFsY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:02:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:02:31 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-ZpzVqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:02:31 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:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:02:31 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-k0DF49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:02:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:02:31 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-R6Rnb3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:02:31 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:02:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:02:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:02:31 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:02:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:02:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:02:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:02:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:02:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:02:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:02:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:02:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:02:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:02:34 INFO - Downloading blessings-1.6.tar.gz 09:02:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:02:34 INFO - Installing collected packages: blessings 09:02:34 INFO - Running setup.py install for blessings 09:02:34 INFO - Successfully installed blessings 09:02:34 INFO - Cleaning up... 09:02:34 INFO - Return code: 0 09:02:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:02:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:02:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:02:35 INFO - Reading from file tmpfile_stdout 09:02:35 INFO - Current package versions: 09:02:35 INFO - blessings == 1.6 09:02:35 INFO - blobuploader == 1.2.4 09:02:35 INFO - docopt == 0.6.1 09:02:35 INFO - functools32 == 3.2.3-2 09:02:35 INFO - jsonschema == 2.5.1 09:02:35 INFO - manifestparser == 1.1 09:02:35 INFO - mozInstall == 1.12 09:02:35 INFO - mozcrash == 0.17 09:02:35 INFO - mozdebug == 0.1 09:02:35 INFO - mozdevice == 0.48 09:02:35 INFO - mozfile == 1.2 09:02:35 INFO - mozhttpd == 0.7 09:02:35 INFO - mozinfo == 0.9 09:02:35 INFO - mozleak == 0.1 09:02:35 INFO - mozlog == 3.4 09:02:35 INFO - moznetwork == 0.27 09:02:35 INFO - mozprocess == 0.23 09:02:35 INFO - mozprofile == 0.28 09:02:35 INFO - mozrunner == 6.12 09:02:35 INFO - mozscreenshot == 0.1 09:02:35 INFO - mozsystemmonitor == 0.3 09:02:35 INFO - moztest == 0.7 09:02:35 INFO - mozversion == 1.4 09:02:35 INFO - psutil == 3.1.1 09:02:35 INFO - requests == 1.2.3 09:02:35 INFO - wsgiref == 0.1.2 09:02:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:02:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:02:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:02:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:02:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:02:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:35 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 0x10e761490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6d7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9050d89380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e575d30>, '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 0x10e3dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e56db20>, '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.NkoXfVDkEg/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.Mc75rdXl0G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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:02:35 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:02:35 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:02:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NkoXfVDkEg/Render', 09:02:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:02:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:02:35 INFO - 'HOME': '/Users/cltbld', 09:02:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:02:35 INFO - 'LOGNAME': 'cltbld', 09:02:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:02:35 INFO - 'MOZ_NO_REMOTE': '1', 09:02:35 INFO - 'NO_EM_RESTART': '1', 09:02:35 INFO - 'PAGER': '/bin/cat', 09:02:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:02:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:02:35 INFO - 'PWD': '/builds/slave/test', 09:02:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:02:35 INFO - 'SHELL': '/bin/bash', 09:02:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Mc75rdXl0G/Listeners', 09:02:35 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 09:02:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:02:35 INFO - 'USER': 'cltbld', 09:02:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:02:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:02:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:02:35 INFO - 'XPC_FLAGS': '0x0', 09:02:35 INFO - 'XPC_SERVICE_NAME': '0', 09:02:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:02:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:02:35 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:02:35 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:02:35 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:02:35 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:02:35 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:02:35 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:02:35 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:02:35 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:02:35 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:02:35 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:02:35 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:02:35 INFO - Cleaning up... 09:02:35 INFO - Return code: 0 09:02:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:02:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:02:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:02:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:02:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:02:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:35 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 0x10e761490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6d7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9050d89380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e575d30>, '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 0x10e3dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e56db20>, '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.NkoXfVDkEg/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.Mc75rdXl0G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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:02:35 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:02:35 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:02:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NkoXfVDkEg/Render', 09:02:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:02:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:02:35 INFO - 'HOME': '/Users/cltbld', 09:02:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:02:35 INFO - 'LOGNAME': 'cltbld', 09:02:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:02:35 INFO - 'MOZ_NO_REMOTE': '1', 09:02:35 INFO - 'NO_EM_RESTART': '1', 09:02:35 INFO - 'PAGER': '/bin/cat', 09:02:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:02:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:02:35 INFO - 'PWD': '/builds/slave/test', 09:02:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:02:35 INFO - 'SHELL': '/bin/bash', 09:02:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Mc75rdXl0G/Listeners', 09:02:35 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 09:02:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:02:35 INFO - 'USER': 'cltbld', 09:02:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:02:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:02:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:02:35 INFO - 'XPC_FLAGS': '0x0', 09:02:35 INFO - 'XPC_SERVICE_NAME': '0', 09:02:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:02:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:02:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:02:35 INFO - Cleaning up... 09:02:35 INFO - Return code: 0 09:02:35 INFO - Running post-action listener: _resource_record_post_action 09:02:35 INFO - Running post-action listener: _start_resource_monitoring 09:02:35 INFO - Starting resource monitoring. 09:02:35 INFO - [mozharness: 2016-09-23 16:02:35.659541Z] Finished create-virtualenv step (success) 09:02:35 INFO - [mozharness: 2016-09-23 16:02:35.660560Z] Running install step. 09:02:35 INFO - Running pre-action listener: _resource_record_pre_action 09:02:35 INFO - Running main action method: install 09:02:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:02:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:02:35 INFO - Reading from file tmpfile_stdout 09:02:35 INFO - Detecting whether we're running mozinstall >=1.0... 09:02:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:02:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:02:36 INFO - Reading from file tmpfile_stdout 09:02:36 INFO - Output received: 09:02:36 INFO - Usage: mozinstall [options] installer 09:02:36 INFO - Options: 09:02:36 INFO - -h, --help show this help message and exit 09:02:36 INFO - -d DEST, --destination=DEST 09:02:36 INFO - Directory to install application into. [default: 09:02:36 INFO - "/builds/slave/test"] 09:02:36 INFO - --app=APP Application being installed. [default: firefox] 09:02:36 INFO - mkdir: /builds/slave/test/build/application 09:02:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:02:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 09:03:08 INFO - Reading from file tmpfile_stdout 09:03:08 INFO - Output received: 09:03:08 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 09:03:08 INFO - Running post-action listener: _resource_record_post_action 09:03:08 INFO - [mozharness: 2016-09-23 16:03:08.671214Z] Finished install step (success) 09:03:08 INFO - [mozharness: 2016-09-23 16:03:08.671371Z] Running run-tests step. 09:03:08 INFO - Running pre-action listener: _resource_record_pre_action 09:03:08 INFO - Running main action method: run_tests 09:03:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:03:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:03:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:03:08 INFO - 2016-09-23 09:03:08.685 screenresolution[1637:7453] starting screenresolution argv=screenresolution get 09:03:08 INFO - 2016-09-23 09:03:08.688 screenresolution[1637:7453] Display 0: 1600x1200x32@60 09:03:08 INFO - 2016-09-23 09:03:08.694 screenresolution[1638:7455] starting screenresolution argv=screenresolution list 09:03:08 INFO - Available Modes on Display 0 09:03:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:03:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:03:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:03:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:03:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:03:08 INFO - Intel Iris: 09:03:08 INFO - Chipset Model: Intel Iris 09:03:08 INFO - Type: GPU 09:03:08 INFO - Bus: Built-In 09:03:08 INFO - VRAM (Dynamic, Max): 1536 MB 09:03:08 INFO - Vendor: Intel (0x8086) 09:03:08 INFO - Device ID: 0x0a2e 09:03:08 INFO - Revision ID: 0x0009 09:03:08 INFO - Displays: 09:03:08 INFO - Display: 09:03:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:03:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:03:08 INFO - Display Serial Number: 1600x1200 60 09:03:08 INFO - Main Display: Yes 09:03:08 INFO - Mirror: Off 09:03:08 INFO - Online: Yes 09:03:08 INFO - Rotation: Supported 09:03:08 INFO - Return code: 0 09:03:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:03:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:03:08 INFO - Python 2.7.3 09:03:08 INFO - Return code: 0 09:03:08 INFO - grabbing minidump binary from tooltool 09:03: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:03:08 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 0x10e575d30>, '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 0x10e3dbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e56db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:03:08 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:03:08 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:03:08 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:03:09 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:03:09 INFO - Return code: 0 09:03:09 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:03:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:03:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:03:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:03:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:03:09 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/DURbrwJ0QJCE-B6kEGKVwg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0079', '--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:03:09 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/DURbrwJ0QJCE-B6kEGKVwg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0079 --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:03:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NkoXfVDkEg/Render', 09:03:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:03:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:03:09 INFO - 'HOME': '/Users/cltbld', 09:03:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:03:09 INFO - 'LOGNAME': 'cltbld', 09:03:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:03:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:03:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:09 INFO - 'MOZ_NO_REMOTE': '1', 09:03:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:03:09 INFO - 'NO_EM_RESTART': '1', 09:03:09 INFO - 'PAGER': '/bin/cat', 09:03:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:03:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:09 INFO - 'PWD': '/builds/slave/test', 09:03:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:03:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:03:09 INFO - 'SHELL': '/bin/bash', 09:03:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Mc75rdXl0G/Listeners', 09:03:09 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 09:03:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:03:09 INFO - 'USER': 'cltbld', 09:03:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:03:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:03:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:09 INFO - 'XPC_FLAGS': '0x0', 09:03:09 INFO - 'XPC_SERVICE_NAME': '0', 09:03:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:03:09 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/DURbrwJ0QJCE-B6kEGKVwg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0079', '--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:03:09 INFO - mozversion application_buildid: 20160923064759 09:03:09 INFO - mozversion application_changeset: dace749327dde3d7409bfe0ab871459116f702a9 09:03:09 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:03:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:03:09 INFO - mozversion application_name: Firefox 09:03:09 INFO - mozversion application_remotingname: firefox-dev 09:03:09 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:03:09 INFO - mozversion application_vendor: Mozilla 09:03:09 INFO - mozversion application_version: 51.0a2 09:03:09 INFO - mozversion platform_buildid: 20160923064759 09:03:09 INFO - mozversion platform_changeset: dace749327dde3d7409bfe0ab871459116f702a9 09:03:09 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:03:09 INFO - mozversion platform_version: 51.0a2 09:03:09 INFO - using testdate: 1474646589 09:03:09 INFO - actual date: 1474646589 09:03:09 INFO - starting webserver on 'localhost:49267' 09:03:09 INFO - SUITE-START | Running 2 tests 09:03:09 INFO - TEST-START | dromaeo_css 09:03:09 INFO - operating with platform_type : mac_ 09:03:09 INFO - Initialising browser for dromaeo_css test... 09:03:09 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/tmp6TqKPF/profile http://localhost:49267/getInfo.html) 09:03:11 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 09:03:11 INFO - PROCESS | 1648 | colorDepth:24 09:03:11 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 09:03:11 INFO - PROCESS | 1648 | __metrics 09:03:11 INFO - PROCESS | 1648 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:03:11 INFO - PROCESS | 1648 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:03:12 INFO - TEST-INFO | 1648: exit 0 09:03:12 INFO - Browser initialized. 09:03:12 INFO - Running cycle 1/1 for dromaeo_css test... 09:03:12 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/tmp6TqKPF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:03:24 INFO - PROCESS | 1650 | RSS: Main: 238931968 09:03:24 INFO - PROCESS | 1650 | 09:04:16 INFO - PROCESS | 1650 | 1474646656070 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:06:27 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 09:06:28 INFO - PROCESS | 1650 | RSS: Main: 340869120 09:06:28 INFO - PROCESS | 1650 | 09:09:31 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 09:09:32 INFO - PROCESS | 1650 | RSS: Main: 386850816 09:09:32 INFO - PROCESS | 1650 | 09:12:34 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 09:12:35 INFO - PROCESS | 1650 | RSS: Main: 342519808 09:12:35 INFO - PROCESS | 1650 | 09:15:37 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 09:15:38 INFO - PROCESS | 1650 | RSS: Main: 340664320 09:15:38 INFO - PROCESS | 1650 | 09:18:41 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 09:18:42 INFO - PROCESS | 1650 | RSS: Main: 327790592 09:18:42 INFO - PROCESS | 1650 | 09:21:45 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 09:21:45 INFO - PROCESS | 1650 | RSS: Main: 397553664 09:21:45 INFO - PROCESS | 1650 | 09:21:45 INFO - PROCESS | 1650 | __start_tp_report 09:21:45 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 09:21:45 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 09:21:45 INFO - PROCESS | 1650 | |i|pagename|runs| 09:21:45 INFO - PROCESS | 1650 | |0;dojo.html;3344.2976974835283;3355.1612096975755;3389.4068538005845;3404.914877128073;3430.108171875313;5771.422857714227;5789.71051447427;5811.418858114186;5811.651300921948;5842.591018628697;5788.305403351593;5861.384554621756;5865;5879.794207202749;5885.676287804169;5257.842264732045;5271.9472805272035;5314.681119132845;5333.306670132877;5357.4374690657505;5218.947810521903;5230.555402790767;5240.764165612557;5243;5398.62209645323;5313.707746073965;5318.069337865877;5345;5351.839444816662;5363.115086010804;5313.814016509404;5316.601254905898;5329.040772660919;5329.973350133263;5348.598855085884;5154.536091751723;5221.13851214553;5265.947340526623;5283.207518872162;5321.4412486688725;5679.119736440858;5695.088785794253;5762.481376676077;5776.364599894008;5801.8549536261935;5515.007298686235;6072.119542666333;6161.210393814957;6272.529560282951;6279.905801412982;6241.407066328737;6281.905771413432;6306.148669929593;6323.367663233686;6332.841678958017;5796.362400135981;5849.912251316234;5859.238299021185;5886.764529418861;5913.8817223655715;6292.087647291117;6342.429181373606;6352.364763523703;6355.968220158869;6362.236531616143;5201.271821944931;6263.217097862767;6275.121482992385;6297.874042519124;6308.053791931247;4645.605123564535;6163.8150855474405;6216.906746398808;6261.123442718023;6344.968275158687;6225.875482490415;6335.556511044275;6339.809805705836;6349.142865713162;6352.078948552434;6272.933601287792;6302;6329.873402531924;6338.8415289617205;6341.4609758170145;4898.24077268024;4942.703437793743;4967.528084831935;5016;5025.874353141201;3775.3581891078584;4443.511213766483;4490.169318676056;4494.5505449454795;4499.437570303712;5851.590388672752;5858.384869588632;5861.41385861419;5862.882742345215;5866.6480011199465;6140.105498721277;6330.4619107375465;6338;6351.079093531504;6361.300256971729;5620.887582248332;5758.798442054592;5804.100364443518;5818.912716309259;5909.970450147722;5454.563634909197;5485.314335708036;5492.862678433071;5503.587230957694;5508.20131080999;6293.842653933597;6314.8737025258315;6319.873602528016;6320.0203968385895;6328.177336946167;5759.568032397503;6220.315765265907;6269.028300613412;6269.655168965568;6334.6832658365975;6278.905816412666;6306.716197771203;6321.683915804099;6324;6326.778562750282;6301.842453938505;6304.243490780952;6315.336889626523;6319.715612797527;6321.810345689637;6161.983272759944;6198.969005154945;6226.968865155645;6306.46395056407;6313.747450102128;6116.724747386289;6242.157308763259;6263;6265.530085243716;6273.9372606273355;6209.534284928558;6241.906371404341;6244.219472565929;6256.530760192913;6265.185525881606;4869.853904382874;5951.958407278796;6068.059450785136;6102.206713127265;6150.477209437069;6050.152978582913;6055.666938318434;6090.451859332681;6095.376470354164;6166.784162554289;5989.341172470938;6001.5798894077;6004.669743164168;6021.789237376671;6027.517798576191 09:21:45 INFO - PROCESS | 1650 | |1;ext.html;441.8762746430999;443.70050216104124;471.47901568766514;526.9697740916511;538.9598075713872;29892.252693682643;30663.233419164506;39465.99999999996;40807;40873.7956310218;42709.786451067775;43055;43099;43161.35257971125;43362.34956475655;9628.22974162069;9866.90133098667;9874.259430542737;9875.95062024689;9882.654107106253;8775.166359195866;8988.011318754965;9639.373440726366;11906;12131.272123672563;12196.207246528948;12315;12357.567485138023;12372;12385.814212786816;12195.878041219563;12287.56993505232;12307.630771076882;12307.75384492305;12327.075469339836;8681.826363472695;8889.199972002487;11717.179797414185;11951.043916486748;12015.759684806342;40986.9753256168;41384.79307603473;41415.1716965662;41508.79245603783;41586.58413415858;3284.441644920369;3302.53764472974;3368.2758206985613;3576.946345804789;3603.351396748584;30202.395952081057;30458.238544036576;30771.846140769154;30942;31799.523007154912;3221.548983142362;3263.96736032639;3285.129440698217;3299.835008249578;3330.1008727643643;524275.37862310826;529340.3532982349;529378;530200;532111;62867.371326287066;63285.683571581845;63345.683271583344;63354.0496892547;63538.68230658909;66104;66145.33854661488;66164;66208.66895665588;66504;16623.50129496117;17234.65530689404;17261.741073883903;17262.482125536255;17264.654706905792;11251.774964500828;12981.221126732238;13022.544210952572;13027.934860325828;13060.95512359009;16124.355025799072;16602.91698541524;18667.253309867723;18980.335688250845;19196.61606767857;6673.499487538357;7740.26467485588;7877.291043806085;7888.64501097452;7937.2062793721325;875.6497401039635;944.5182956692137;960.8894977077586;1038.6468600675807;1066.9010918753695;29604;29643.110706678835;29650.258743531154;29921.551176732366;30249.848750756104;1027.7636143686843;1040.666986564292;1062.1874266186373;1071.346478648024;1111.3109871879487;15036.699266014619;15340.079595224322;15362.692746145014;15427.648308253618;15686.450974216075;707486;715903;716193;717107;718117;57147;57564.56088597735;57779.55551111172;57820.8435831281;57841.13238301429;1227.4353797253364;1257.1074537078412;1259.1878238536092;1386.230641993683;1408.746425643394;29804;32080;32091.358172835946;32100.03699889007;32668.50997234996;53604.195937061755;54194.45805541894;54255;54298.45701542934;54514.63713407196;512341;516672;516678;517227;517267;26375.340616483973;26383.472330553665;26605.201843944713;26771.7322826777;26967.460650787267;46169.76915115403;46244.76877615591;46629.76685116688;46856.297155542015;46912.29631555461;38050;38303.42544861885;38323.23353532858;38431.423528647654;39250.6074939247;38138;38399.80800095982;38477.80761096177;39097.41353879637;39758.80120599378;31955.201119972186;36154.63845361618;36841.44737828881;36866.63133368739;38318.23363532769;30545.167289962672;33319.000429987136;34479.827600861834;34509.82745086359;34577.13557161091;24796.628050578896;25198.74801251964;25334.493310133326;25797.226083217534;25859.0949316773 09:21:45 INFO - PROCESS | 1650 | |2;jquery.html;351.8135388244231;372.1347866211059;374.53744625387657;385.3910820902973;407.79202606670606;15018.174000429972;15189.848101518981;17100.315987360507;20780.584388312225;21193.470163245926;19601;20628.484287892774;21036.263730769388;21190;21434.356969290948;5912.965231084565;5977.850553736159;6142.262928448592;6253.812385628438;6262.154609127755;6007.15899774032;6132.233470816148;6159.10692949522;6159.630422174661;6170.784022559212;3818.732688711791;4378.912421751563;4396.0108975480425;4580;6786.762463313785;6527.086207930894;6796.2863899290605;6822.829429264259;6853.074834897275;6873.896891546656;5950.523958083343;5958.851028724273;5969.164316995624;5971.462568368867;5973.402659734035;25527.74472255272;25988.220353389428;26375.20874373772;26492.337691557674;26739.732602674114;2326.7789559991775;2453.055573604175;2467.8889449974795;2474.480359124586;2497.0760818497274;14530.56408307742;15357.846421535753;16010.119443430724;16018.279177437043;16070;1845.5478407790042;1868.246775880095;1916.5017095555118;1918.9712154317556;1926.1909997800958;87799.56100219522;106555.46722266417;111546;115907.84092159054;121256.99999999911;10977.83533247002;11111.944440277746;11189.272697274651;11228.887711122947;11309.943450282695;13872.306384680725;13873.445062197601;13894.166350019032;13907.58277251684;13910.026298159235;6914.757983470555;8709.390342676079;8722.30221582272;8785.692500762443;8787.253083487974;8478.576071196416;8742;8788.912110878937;8905.198532132139;8918.55407229636;6582.736690532325;6683.131192944886;6688.431483323875;6692.3976842083475;6763.492738044666;1800.9369672061414;1826.1417133947289;1841.2266847923636;1841.5304097455064;1845.4740398986494;849.4987957105337;881.8765372847806;903.3495882964255;944.4663764972769;968.3705591365668;21928.89035554812;22314.776852231593;22819.832115948957;22839.543209136056;22976.65535016976;977.5014742481386;980.5091487669139;1007.9344842585208;1025.4308858583408;1091.8089334366614;11037.668869933916;11604.43340149086;11823.76352472963;11854.992325652243;11899.798537270633;581788;582152;586872;599778;603444.9827750921;99250;100523.49738251408;119620.80379196096;121014;124030;991.4101109839634;998.0836793356773;1000.5347513406156;1016.8830584482731;1026.348268849271;18909.90545047266;19659.606807863478;20261.29085482001;20326;20328;52801.735991319794;53114.750819935085;54500;57832.71083644555;57909;75067.24932750821;77948.61025694835;79694;79734;81374.18625813903;7994.800129996796;8004.057723100254;8119.093235904009;8411.579421029046;8439.578021099043;9419.905800941902;13009.089363744448;13251.867481325064;13369.799453008018;13633.522826701017;10988.780224395307;11082.833757493805;11427;11548.538058477567;11795.115366347387;8927.508987005776;10636.255462117577;11185.496652650812;11227.887721122685;11724.120690948042;9379.484128372733;10643.09533689614;11400.372979485875;11611.941940290244;12018.218815776947;7735.806604834699;8103.987001624797;8213.671453141807;8359.623816928375;8378.204070613281;8497.702580409656;9435.29235307341;9587.760305992406;11225.775484490101;11386.430678465878 09:21:45 INFO - PROCESS | 1650 | |3;mootools.html;1354.9593512194626;1525.1764047414392;1534.9462768803091;1728.5073753980118;1881.9059047047654;7930.246626570473;8465.238128568428;8596.355273354493;8929.732108036753;8949.149830766082;8639.43843650164;8839.071897450756;8873.467591944487;8936.642534298637;8940.91059089409;2355.823313251509;2402.4834660547976;2407.2537513370826;2407.9759202408013;2408.1089996701157;2382.332946774906;2409.506051259488;2428.5264373447185;2428.9028438862424;2435.2207293666033;2401.519696060786;2413.8189635777385;2427.5630386530415;2429.708434987804;2431.4407686232175;2365.455945132629;2391.390195500145;2396.74834142416;2403.3631087761755;2404.5190961807707;2306.884655767222;2400.7959323457526;2400.9879950600134;2413.553492603874;2421.128393778238;7856.607169641552;8118.10700822909;8761.693340733107;8916.910830891673;8929.01780804111;4730.62155027597;5098.209777484496;5251.10731175701;5262.184361423985;5294.867628309285;3116.781825272232;3590.317839610466;3623.927521449556;3711.480392745018;3712;1103.7351035751362;1103.7406209540752;1106.0819519798547;1118.669992352258;1127.7631697343568;11656.766864662659;11815.586454474053;11817.881821181763;11839.408029598571;11850.11124165691;4664.323673067454;4685.929711054268;4880.951190488121;4898.755062246873;4919.3604831371695;10209.897901021044;10220.540075696612;10221.846672299922;10233.74415639615;10245.948770256102;5374.785008599691;5377.892442151213;5387.4073851876265;5387.434319396407;5387.46125387466;4721.811127554859;4826.420829500412;4883;4898.167311557044;4911.87720306988;3867.9806600966817;3873.4189871519498;3907.316219661548;3950.881473555798;3984.2828290907337;1007.8034783217203;1177;1181.79318619243;1194.4147367789722;1195.2589394575418;777.739457281817;861.793169639282;909.4588719711761;913.1872633356318;929.4376901974343;5684.459976302244;5694.857628559319;5769.59612827098;6073.757049717962;6196.225471816023;846.5259454705384;889.6619284671783;921.4977837078808;938.2447130060231;947.5593848860314;3741.663250307485;3884.9805750971063;3949.328614135604;3955.5253369595835;4008.2785098681934;10486.685399438029;10870.782584348268;10905;10925.344479331265;10955.34267943926;10882.564697412174;10894.782104357868;10895.019448249695;10898.291611045257;10898.727531811768;7849.254320839511;8163.55100469468;8262.42163048581;8286.295664868434;8309.459885107448;4950.653454258168;6004.129401236709;6024.8795024100145;6065.059915713072;6101.572889897665;9437.622495100119;9735.902640973783;10141.391516508738;10172.694819155437;10283.640072597424;10324.002732853683;10341.63804266847;10384.844227336445;10428.217883658604;10510.369377837354;7214.567125972459;7293.452991025588;7305.5981920994855;7309.086364204474;7362.153352364547;8314.168583141638;8368.456050356708;8420.87368689458;8433.83132337362;8448.112948140357;7453.962730186531;7543.367881333098;7571.356434702891;7708.922910770821;7714;7138.607376594129;7422.66598003102;7426.183119856703;7440.181580026085;7468.813279668052;6884.896726549206;6929.965350173217;7026.051483049927;7033.824154396181;7036.753713620204;4951.232558953368;4987.47631498702;5032.496750325085;5038.924416133834;5128.4615115413835;4994.650374473752;5007.39911210657;5095.031943930641;5095.464976177448;5158.742062896915 09:21:45 INFO - PROCESS | 1650 | |4;prototype.html;250.3004103530632;287.51697148790026;305.81192566571553;309.5897935235813;316.11330218736447;5085.618578606605;5193.272941788153;5237.423883372826;5238.580913526918;5423.728813559316;5224.21636754487;5292.718514520992;5317.8404647860525;5342.706151161685;5421.993862270965;4083.4691490106243;4085.632293093636;4089.078133277355;4092.242935057009;4119.382092686106;3060;3614.6806415658357;3627.6009638939695;3746.756460830037;4095.877123686294;3955.6044395560357;4081.8367265309353;4086.2849001424634;4088.550259471456;4114.300568903279;4061.1268577255883;4065.6544193743566;4086.366613174963;4091.9974606221367;4180.602842729936;3436.6735160159747;3578.3737845876867;3587.4080776671817;3593.5328407306883;3603.7297202709638;4084.7344922580232;4328.264195086843;5166.844994650129;5175.327207463043;5178.922316165261;4689.201746585277;4696.483386827446;4698.553637404441;4708.693934894221;4713.222318317474;4326.706845371958;5635.690037047961;5657.745401456944;5665.575081868877;5721.828345149611;3598.6221446747977;3914.8042597870276;3927.6268754468565;3929.5677475477673;3969.2656858480987;5844.415558444164;5896.882062358772;5905.999999999957;5941.524678025748;5976.85057873548;4005.859794907164;4020.6984476164403;4021.6380525752825;4022.3162062449455;4023.3562629979065;3574.803385813805;3937.5078115235597;3954.1103251768122;3958.2677204716642;3969.4641223435046;4335.674824388184;4361.9749358900635;4412.624926881251;4514.819407223675;4563.498015218323;4972.618619338884;5153.191510626717;5724.141378793214;5733.025385684444;5736.942630573724;1126.1947707389093;1343.9450031725244;1345.9461621535224;1347.3398034962797;1356.6269275949194;660.9622892059516;705.4673721340355;776.3750181104152;797.6649807081039;837.2585023151829;3982.3628219484744;4071.7629484559848;4288.056627541936;4433.6009759121835;4486.170058539115;4598.908021839545;4627.6529260305615;4786.95213047865;4826.420829500483;4851.603877285914;3668.872054208606;3672.4307732301536;4304.48346198452;4452.376667266585;4506.549345065468;2673.930427828884;2893.652761668613;3060.6939306069216;3073.339232065117;3077.9076627701206;4754.429468463737;5403.405625381205;5897.557683173779;5919.289685237799;5943.762249510058;4960.627952903546;5619.7471113799975;5825.854353641193;5938.6436813791315;5950.613210141327;5356.892862142735;5847.766089356378;5888.322842873039;5889.293284805851;5951.970240148771;5737.770489180386;5783.710814459176;5785.884282314414;5793.406813126424;5834.474897259267;5321.3348331458565;5641.915371269352;5647;5734.856628584319;5742.0764044044045;4979.833772309057;5020.799168033238;5460.3993560707495;5656.284983208001;5937.109433584997;3533;3808.428735689669;3836.2327534492656;3860.3823388257742;3871.793077945544;4807.95192048075;4895.779689913891;5351.732413379394;5354.3842458117815;5485.835424937259;4715.693479923794;5202.60980426462;5326.946730532645;5501.669899806025;5577.135543990688;4735.171345014677;4792.808287668454;5655.434456554476;5677.432256774455;5677.545796336366;5413.240696773486;5549.139883318092;5587.469190426903;5589;5645.68948707825;5344.064788661891;5357.491038351351;5696.686682232351;5697.319290809304;5723.6851973141875;4465.5087940327185;5148.871278218075;5291.9206211906085;5585.2180694701965;5628.620987858001 09:21:45 INFO - PROCESS | 1650 | |5;yui.html;707.2538471912134;707.3951771235594;754.830163213277;777.3159619534808;781.2929298984418;15030.699386012288;16213.351465941349;16215.189240537955;16250.18749062548;16256;14598.416063357454;14696.265186740648;14736.410543578244;14775.261236938164;14799.112053276811;645.2482857471041;665.4643012375036;668.2682462703332;668.9966550167243;826.5330088499993;674.4233680203429;676.918769747631;812.8252425728467;837.4138103327665;843.983120337596;754.3248792330861;902.6524787956652;903.7605034665819;903.832790933676;906.2795077913042;864.269692110169;887.3965703321738;893.0890491698431;894.2801045158644;900.2078171209326;508.10319785578486;524.7586110389226;627.8995360742259;646.360103497534;666.5267659961434;14733.631659208499;15216.847831521654;15235.390584376612;15235.847641523555;15308.693826123526;11898.762024759542;13725.45098196081;13860.653483662889;13953.930230348884;14009.789853152211;11041;11403.942980285046;11569.768604627945;12292.446839892227;12797.936010319889;4482.731036137842;4566.748828814414;4754.500777418356;4783.425988881322;4804.759762011886;78837.60581197115;97251.08246752538;109617.45191274073;113243.43378283139;115715;8292.668293268202;10466.842997355046;10656.467176641137;10797.676069717922;10930.398828064373;19713.310034149024;20675.689864652042;20792.58414831695;20846.166153354;20876.164953401996;6581.572197807223;8021.157778433298;8038.63826127814;8119.431639785158;8213.630386632616;4344.913101737948;4424.225760491901;4468.865934021985;4514.503404625489;4575.611073058761;3570.517980072657;3754.3992961126087;3755.549334079928;3760.2479504099288;3762.4168253920684;649.136648257816;658.2200092889941;668.1681306773002;674.3256743256743;680.0513283968836;588.2529187931303;609.6891682881751;625.327772644409;655.672163918041;662.6322391073;8155.429119961545;8337.624806883583;9548.283878709124;9646.42121472714;9830.115289623967;615.7906311853991;651.6481100205835;669.5279827721445;693.6185098196073;700.4886432904009;4303.1393721255245;4609.262517997105;4626.907461850811;4645.674802763774;4690.695104818176;89865.55067224622;124364;128523.71476285305;144419;149362;118512;121988;125769;127862.36068819596;131696;72471.99999999895;89853;108296;110103.44948275207;113973.4301328488;9493.335466517277;9973.551190196313;10067.496625168858;10101.49492525356;10125.443100629536;62035.37964620477;62553;63066;64556.677216613614;64603;78227;90091;94119;96586;99880.50059749655;12655.430505627453;13104.475820967436;13301.201927884358;13370.264635444755;13430.19418834873;14134.78797818013;14152.363143658355;14284.142951422948;14924.552263432115;14956.626084347978;12520.436580354088;12711;13339.199648020762;13695.452181912611;13892.305384730926;12899.548515802277;13497.527586534425;13785.310734463437;14367.856321436651;14551.199684017058;12788.104832661624;12905.290209038592;13577.59267221985;13791.310434478035;14093.436262549383;10145.391276523433;11141.331520108819;11691.473883675426;11759;11861.40692965331;11114.555417783198;11320.943395282971;11487.770244595229;11681.591144309908;11822.586209482626 09:21:45 INFO - PROCESS | 1650 | __end_tp_report 09:21:45 INFO - PROCESS | 1650 | __start_cc_report 09:21:45 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,1100 09:21:45 INFO - PROCESS | 1650 | __end_cc_report 09:21:45 INFO - PROCESS | 1650 | __startTimestamp1474647705849__endTimestamp 09:21:45 INFO - PROCESS | 1650 | 09:21:45 INFO - PROCESS | 1650 | ------- Summary: start ------- 09:21:45 INFO - PROCESS | 1650 | Number of tests: 6 09:21:45 INFO - PROCESS | 1650 | 09:21:45 INFO - PROCESS | 1650 | [#0] dojo.html Cycles:165 Average:5787.08 Median:6001.58 stddev:658.85 (11.0%) stddev-sans-first:632.39 09:21:45 INFO - PROCESS | 1650 | Values: 3344.3 3355.2 3389.4 3404.9 3430.1 5771.4 5789.7 5811.4 5811.7 5842.6 5788.3 5861.4 5865.0 5879.8 5885.7 5257.8 5271.9 5314.7 5333.3 5357.4 5218.9 5230.6 5240.8 5243.0 5398.6 5313.7 5318.1 5345.0 5351.8 5363.1 5313.8 5316.6 5329.0 5330.0 5348.6 5154.5 5221.1 5265.9 5283.2 5321.4 5679.1 5695.1 5762.5 5776.4 5801.9 5515.0 6072.1 6161.2 6272.5 6279.9 6241.4 6281.9 6306.1 6323.4 6332.8 5796.4 5849.9 5859.2 5886.8 5913.9 6292.1 6342.4 6352.4 6356.0 6362.2 5201.3 6263.2 6275.1 6297.9 6308.1 4645.6 6163.8 6216.9 6261.1 6345.0 6225.9 6335.6 6339.8 6349.1 6352.1 6272.9 6302.0 6329.9 6338.8 6341.5 4898.2 4942.7 4967.5 5016.0 5025.9 3775.4 4443.5 4490.2 4494.6 4499.4 5851.6 5858.4 5861.4 5862.9 5866.6 6140.1 6330.5 6338.0 6351.1 6361.3 5620.9 5758.8 5804.1 5818.9 5910.0 5454.6 5485.3 5492.9 5503.6 5508.2 6293.8 6314.9 6319.9 6320.0 6328.2 5759.6 6220.3 6269.0 6269.7 6334.7 6278.9 6306.7 6321.7 6324.0 6326.8 6301.8 6304.2 6315.3 6319.7 6321.8 6162.0 6199.0 6227.0 6306.5 6313.7 6116.7 6242.2 6263.0 6265.5 6273.9 6209.5 6241.9 6244.2 6256.5 6265.2 4869.9 5952.0 6068.1 6102.2 6150.5 6050.2 6055.7 6090.5 6095.4 6166.8 5989.3 6001.6 6004.7 6021.8 6027.5 09:21:45 INFO - PROCESS | 1650 | 09:21:45 INFO - PROCESS | 1650 | [#1] ext.html Cycles:180 Average:72125.55 Median:36498.04 stddev:158834.86 (435.2%) stddev-sans-first:159189.25 09:21:45 INFO - PROCESS | 1650 | Values: 441.9 443.7 471.5 527.0 539.0 29892.3 30663.2 39466.0 40807.0 40873.8 42709.8 43055.0 43099.0 43161.4 43362.3 9628.2 9866.9 9874.3 9876.0 9882.7 8775.2 8988.0 9639.4 11906.0 12131.3 12196.2 12315.0 12357.6 12372.0 12385.8 12195.9 12287.6 12307.6 12307.8 12327.1 8681.8 8889.2 11717.2 11951.0 12015.8 40987.0 41384.8 41415.2 41508.8 41586.6 3284.4 3302.5 3368.3 3576.9 3603.4 30202.4 30458.2 30771.8 30942.0 31799.5 3221.5 3264.0 3285.1 3299.8 3330.1 524275.4 529340.4 529378.0 530200.0 532111.0 62867.4 63285.7 63345.7 63354.0 63538.7 66104.0 66145.3 66164.0 66208.7 66504.0 16623.5 17234.7 17261.7 17262.5 17264.7 11251.8 12981.2 13022.5 13027.9 13061.0 16124.4 16602.9 18667.3 18980.3 19196.6 6673.5 7740.3 7877.3 7888.6 7937.2 875.6 944.5 960.9 1038.6 1066.9 29604.0 29643.1 29650.3 29921.6 30249.8 1027.8 1040.7 1062.2 1071.3 1111.3 15036.7 15340.1 15362.7 15427.6 15686.5 707486.0 715903.0 716193.0 717107.0 718117.0 57147.0 57564.6 57779.6 57820.8 57841.1 1227.4 1257.1 1259.2 1386.2 1408.7 29804.0 32080.0 32091.4 32100.0 32668.5 53604.2 54194.5 54255.0 54298.5 54514.6 512341.0 516672.0 516678.0 517227.0 517267.0 26375.3 26383.5 26605.2 26771.7 26967.5 46169.8 46244.8 46629.8 46856.3 46912.3 38050.0 38303.4 38323.2 38431.4 39250.6 38138.0 38399.8 38477.8 39097.4 39758.8 31955.2 36154.6 36841.4 36866.6 38318.2 30545.2 33319.0 34479.8 34509.8 34577.1 24796.6 25198.7 25334.5 25797.2 25859.1 09:21:45 INFO - PROCESS | 1650 | 09:21:45 INFO - PROCESS | 1650 | [#2] jquery.html Cycles:180 Average:34473.53 Median:26433.77 stddev:98111.14 (371.2%) stddev-sans-first:98352.92 09:21:45 INFO - PROCESS | 1650 | Values: 351.8 372.1 374.5 385.4 407.8 15018.2 15189.8 17100.3 20780.6 21193.5 19601.0 20628.5 21036.3 21190.0 21434.4 5913.0 5977.9 6142.3 6253.8 6262.2 6007.2 6132.2 6159.1 6159.6 6170.8 3818.7 4378.9 4396.0 4580.0 6786.8 6527.1 6796.3 6822.8 6853.1 6873.9 5950.5 5958.9 5969.2 5971.5 5973.4 25527.7 25988.2 26375.2 26492.3 26739.7 2326.8 2453.1 2467.9 2474.5 2497.1 14530.6 15357.8 16010.1 16018.3 16070.0 1845.5 1868.2 1916.5 1919.0 1926.2 87799.6 106555.5 111546.0 115907.8 121257.0 10977.8 11111.9 11189.3 11228.9 11309.9 13872.3 13873.4 13894.2 13907.6 13910.0 6914.8 8709.4 8722.3 8785.7 8787.3 8478.6 8742.0 8788.9 8905.2 8918.6 6582.7 6683.1 6688.4 6692.4 6763.5 1800.9 1826.1 1841.2 1841.5 1845.5 849.5 881.9 903.3 944.5 968.4 21928.9 22314.8 22819.8 22839.5 22976.7 977.5 980.5 1007.9 1025.4 1091.8 11037.7 11604.4 11823.8 11855.0 11899.8 581788.0 582152.0 586872.0 599778.0 603445.0 99250.0 100523.5 119620.8 121014.0 124030.0 991.4 998.1 1000.5 1016.9 1026.3 18909.9 19659.6 20261.3 20326.0 20328.0 52801.7 53114.8 54500.0 57832.7 57909.0 75067.2 77948.6 79694.0 79734.0 81374.2 7994.8 8004.1 8119.1 8411.6 8439.6 9419.9 13009.1 13251.9 13369.8 13633.5 10988.8 11082.8 11427.0 11548.5 11795.1 8927.5 10636.3 11185.5 11227.9 11724.1 9379.5 10643.1 11400.4 11611.9 12018.2 7735.8 8104.0 8213.7 8359.6 8378.2 8497.7 9435.3 9587.8 11225.8 11386.4 09:21:45 INFO - PROCESS | 1650 | 09:21:45 INFO - PROCESS | 1650 | [#3] mootools.html Cycles:180 Average:5746.86 Median:4898.46 stddev:3236.51 (66.1%) stddev-sans-first:3228.76 09:21:45 INFO - PROCESS | 1650 | Values: 1355.0 1525.2 1534.9 1728.5 1881.9 7930.2 8465.2 8596.4 8929.7 8949.1 8639.4 8839.1 8873.5 8936.6 8940.9 2355.8 2402.5 2407.3 2408.0 2408.1 2382.3 2409.5 2428.5 2428.9 2435.2 2401.5 2413.8 2427.6 2429.7 2431.4 2365.5 2391.4 2396.7 2403.4 2404.5 2306.9 2400.8 2401.0 2413.6 2421.1 7856.6 8118.1 8761.7 8916.9 8929.0 4730.6 5098.2 5251.1 5262.2 5294.9 3116.8 3590.3 3623.9 3711.5 3712.0 1103.7 1103.7 1106.1 1118.7 1127.8 11656.8 11815.6 11817.9 11839.4 11850.1 4664.3 4685.9 4881.0 4898.8 4919.4 10209.9 10220.5 10221.8 10233.7 10245.9 5374.8 5377.9 5387.4 5387.4 5387.5 4721.8 4826.4 4883.0 4898.2 4911.9 3868.0 3873.4 3907.3 3950.9 3984.3 1007.8 1177.0 1181.8 1194.4 1195.3 777.7 861.8 909.5 913.2 929.4 5684.5 5694.9 5769.6 6073.8 6196.2 846.5 889.7 921.5 938.2 947.6 3741.7 3885.0 3949.3 3955.5 4008.3 10486.7 10870.8 10905.0 10925.3 10955.3 10882.6 10894.8 10895.0 10898.3 10898.7 7849.3 8163.6 8262.4 8286.3 8309.5 4950.7 6004.1 6024.9 6065.1 6101.6 9437.6 9735.9 10141.4 10172.7 10283.6 10324.0 10341.6 10384.8 10428.2 10510.4 7214.6 7293.5 7305.6 7309.1 7362.2 8314.2 8368.5 8420.9 8433.8 8448.1 7454.0 7543.4 7571.4 7708.9 7714.0 7138.6 7422.7 7426.2 7440.2 7468.8 6884.9 6930.0 7026.1 7033.8 7036.8 4951.2 4987.5 5032.5 5038.9 5128.5 4994.7 5007.4 5095.0 5095.5 5158.7 09:21:45 INFO - PROCESS | 1650 | 09:21:45 INFO - PROCESS | 1650 | [#4] prototype.html Cycles:180 Average:4461.54 Median:4800.38 stddev:1376.82 (28.7%) stddev-sans-first:1343.91 09:21:45 INFO - PROCESS | 1650 | Values: 250.3 287.5 305.8 309.6 316.1 5085.6 5193.3 5237.4 5238.6 5423.7 5224.2 5292.7 5317.8 5342.7 5422.0 4083.5 4085.6 4089.1 4092.2 4119.4 3060.0 3614.7 3627.6 3746.8 4095.9 3955.6 4081.8 4086.3 4088.6 4114.3 4061.1 4065.7 4086.4 4092.0 4180.6 3436.7 3578.4 3587.4 3593.5 3603.7 4084.7 4328.3 5166.8 5175.3 5178.9 4689.2 4696.5 4698.6 4708.7 4713.2 4326.7 5635.7 5657.7 5665.6 5721.8 3598.6 3914.8 3927.6 3929.6 3969.3 5844.4 5896.9 5906.0 5941.5 5976.9 4005.9 4020.7 4021.6 4022.3 4023.4 3574.8 3937.5 3954.1 3958.3 3969.5 4335.7 4362.0 4412.6 4514.8 4563.5 4972.6 5153.2 5724.1 5733.0 5736.9 1126.2 1343.9 1345.9 1347.3 1356.6 661.0 705.5 776.4 797.7 837.3 3982.4 4071.8 4288.1 4433.6 4486.2 4598.9 4627.7 4787.0 4826.4 4851.6 3668.9 3672.4 4304.5 4452.4 4506.5 2673.9 2893.7 3060.7 3073.3 3077.9 4754.4 5403.4 5897.6 5919.3 5943.8 4960.6 5619.7 5825.9 5938.6 5950.6 5356.9 5847.8 5888.3 5889.3 5952.0 5737.8 5783.7 5785.9 5793.4 5834.5 5321.3 5641.9 5647.0 5734.9 5742.1 4979.8 5020.8 5460.4 5656.3 5937.1 3533.0 3808.4 3836.2 3860.4 3871.8 4808.0 4895.8 5351.7 5354.4 5485.8 4715.7 5202.6 5326.9 5501.7 5577.1 4735.2 4792.8 5655.4 5677.4 5677.5 5413.2 5549.1 5587.5 5589.0 5645.7 5344.1 5357.5 5696.7 5697.3 5723.7 4465.5 5148.9 5291.9 5585.2 5628.6 09:21:45 INFO - PROCESS | 1650 | 09:21:45 INFO - PROCESS | 1650 | [#5] yui.html Cycles:180 Average:23701.04 Median:3761.33 stddev:36803.38 (978.5%) stddev-sans-first:36866.12 09:21:45 INFO - PROCESS | 1650 | Values: 707.3 707.4 754.8 777.3 781.3 15030.7 16213.4 16215.2 16250.2 16256.0 14598.4 14696.3 14736.4 14775.3 14799.1 645.2 665.5 668.3 669.0 826.5 674.4 676.9 812.8 837.4 844.0 754.3 902.7 903.8 903.8 906.3 864.3 887.4 893.1 894.3 900.2 508.1 524.8 627.9 646.4 666.5 14733.6 15216.8 15235.4 15235.8 15308.7 11898.8 13725.5 13860.7 13953.9 14009.8 11041.0 11403.9 11569.8 12292.4 12797.9 4482.7 4566.7 4754.5 4783.4 4804.8 78837.6 97251.1 109617.5 113243.4 115715.0 8292.7 10466.8 10656.5 10797.7 10930.4 19713.3 20675.7 20792.6 20846.2 20876.2 6581.6 8021.2 8038.6 8119.4 8213.6 4344.9 4424.2 4468.9 4514.5 4575.6 3570.5 3754.4 3755.5 3760.2 3762.4 649.1 658.2 668.2 674.3 680.1 588.3 609.7 625.3 655.7 662.6 8155.4 8337.6 9548.3 9646.4 9830.1 615.8 651.6 669.5 693.6 700.5 4303.1 4609.3 4626.9 4645.7 4690.7 89865.6 124364.0 128523.7 144419.0 149362.0 118512.0 121988.0 125769.0 127862.4 131696.0 72472.0 89853.0 108296.0 110103.4 113973.4 9493.3 9973.6 10067.5 10101.5 10125.4 62035.4 62553.0 63066.0 64556.7 64603.0 78227.0 90091.0 94119.0 96586.0 99880.5 12655.4 13104.5 13301.2 13370.3 13430.2 14134.8 14152.4 14284.1 14924.6 14956.6 12520.4 12711.0 13339.2 13695.5 13892.3 12899.5 13497.5 13785.3 14367.9 14551.2 12788.1 12905.3 13577.6 13791.3 14093.4 10145.4 11141.3 11691.5 11759.0 11861.4 11114.6 11320.9 11487.8 11681.6 11822.6 09:21:45 INFO - PROCESS | 1650 | -------- Summary: end -------- 09:21:45 INFO - PROCESS | 1650 | 09:21:46 INFO - TEST-INFO | 1650: exit 0 09:21:46 INFO - TEST-OK | dromaeo_css | took 1117220ms 09:21:46 INFO - TEST-START | kraken 09:21:46 INFO - operating with platform_type : mac_ 09:21:46 INFO - Initialising browser for kraken test... 09:21:46 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/tmp2SwKSK/profile http://localhost:49267/getInfo.html) 09:21:48 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 09:21:48 INFO - PROCESS | 1659 | colorDepth:24 09:21:48 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 09:21:48 INFO - PROCESS | 1659 | __metrics 09:21:49 INFO - PROCESS | 1659 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:21:49 INFO - PROCESS | 1659 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:21:49 INFO - TEST-INFO | 1659: exit 0 09:21:49 INFO - Browser initialized. 09:21:49 INFO - Running cycle 1/1 for kraken test... 09:21:49 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/tmp2SwKSK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:22:01 INFO - PROCESS | 1660 | RSS: Main: 237658112 09:22:01 INFO - PROCESS | 1660 | 09:22:04 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection) 09:22:05 INFO - PROCESS | 1660 | RSS: Main: 285663232 09:22:05 INFO - PROCESS | 1660 | 09:22:08 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft) 09:22:08 INFO - PROCESS | 1660 | RSS: Main: 295825408 09:22:08 INFO - PROCESS | 1660 | 09:22:11 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft) 09:22:12 INFO - PROCESS | 1660 | RSS: Main: 390066176 09:22:12 INFO - PROCESS | 1660 | 09:22:14 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator) 09:22:15 INFO - PROCESS | 1660 | RSS: Main: 291889152 09:22:15 INFO - PROCESS | 1660 | 09:22:17 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:22:18 INFO - PROCESS | 1660 | RSS: Main: 293318656 09:22:18 INFO - PROCESS | 1660 | 09:22:20 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom) 09:22:21 INFO - PROCESS | 1660 | RSS: Main: 331288576 09:22:21 INFO - PROCESS | 1660 | 09:22:24 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate) 09:22:24 INFO - PROCESS | 1660 | RSS: Main: 331735040 09:22:24 INFO - PROCESS | 1660 | 09:22:27 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial) 09:22:28 INFO - PROCESS | 1660 | RSS: Main: 328126464 09:22:28 INFO - PROCESS | 1660 | 09:22:29 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:22:30 INFO - PROCESS | 1660 | RSS: Main: 301236224 09:22:30 INFO - PROCESS | 1660 | 09:22:32 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:22:33 INFO - PROCESS | 1660 | RSS: Main: 306470912 09:22:33 INFO - PROCESS | 1660 | 09:22:35 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:22:35 INFO - PROCESS | 1660 | RSS: Main: 305561600 09:22:35 INFO - PROCESS | 1660 | 09:22:38 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:22:39 INFO - PROCESS | 1660 | RSS: Main: 324423680 09:22:39 INFO - PROCESS | 1660 | 09:22:42 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:22:43 INFO - PROCESS | 1660 | RSS: Main: 320581632 09:22:43 INFO - PROCESS | 1660 | 09:22:44 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar) 09:22:45 INFO - PROCESS | 1660 | RSS: Main: 364056576 09:22:45 INFO - PROCESS | 1660 | 09:22:45 INFO - PROCESS | 1660 | __start_tp_report 09:22:45 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 09:22:45 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 09:22:45 INFO - PROCESS | 1660 | |i|pagename|runs| 09:22:45 INFO - PROCESS | 1660 | |0;ai-astar;114;111;113;113;118;163;119;118;164;160 09:22:45 INFO - PROCESS | 1660 | |1;audio-beat-detection;143;108;108;142;108;111;110;108;140;108 09:22:45 INFO - PROCESS | 1660 | |2;audio-dft;183;183;183;183;179;181;182;183;185;184 09:22:45 INFO - PROCESS | 1660 | |3;audio-fft;82;62;76;112;82;58;59;58;82;57 09:22:45 INFO - PROCESS | 1660 | |4;audio-oscillator;89;70;95;69;71;95;127;95;68;89 09:22:45 INFO - PROCESS | 1660 | |5;imaging-gaussian-blur;87;85;90;86;88;82;88;89;132;129 09:22:45 INFO - PROCESS | 1660 | |6;imaging-darkroom;97;96;96;95;95;97;96;97;95;96 09:22:45 INFO - PROCESS | 1660 | |7;imaging-desaturate;84;87;84;84;84;84;84;84;97;135 09:22:45 INFO - PROCESS | 1660 | |8;json-parse-financial;58;54;55;53;55;56;57;57;56;56 09:22:45 INFO - PROCESS | 1660 | |9;json-stringify-tinderbox;63;70;68;74;70;68;67;68;69;69 09:22:45 INFO - PROCESS | 1660 | |10;stanford-crypto-aes;97;97;94;83;85;80;81;83;83;86 09:22:45 INFO - PROCESS | 1660 | |11;stanford-crypto-ccm;138;135;138;146;149;145;142;150;193;141 09:22:45 INFO - PROCESS | 1660 | |12;stanford-crypto-pbkdf2;166;162;160;155;212;222;193;164;163;162 09:22:45 INFO - PROCESS | 1660 | |13;stanford-crypto-sha256-iterative;68;68;67;66;66;62;66;65;67;67 09:22:45 INFO - PROCESS | 1660 | __end_tp_report 09:22:45 INFO - PROCESS | 1660 | __start_cc_report 09:22:45 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,1952 09:22:45 INFO - PROCESS | 1660 | __end_cc_report 09:22:45 INFO - PROCESS | 1660 | __startTimestamp1474647765014__endTimestamp 09:22:45 INFO - PROCESS | 1660 | 09:22:45 INFO - PROCESS | 1660 | ------- Summary: start ------- 09:22:45 INFO - PROCESS | 1660 | Number of tests: 14 09:22:45 INFO - PROCESS | 1660 | 09:22:45 INFO - PROCESS | 1660 | [#0] ai-astar Cycles:10 Average:129.30 Median:118.50 stddev:22.96 (19.4%) stddev-sans-first:23.67 09:22:45 INFO - PROCESS | 1660 | Values: 114.0 111.0 113.0 113.0 118.0 163.0 119.0 118.0 164.0 160.0 09:22:45 INFO - PROCESS | 1660 | 09:22:45 INFO - PROCESS | 1660 | [#1] audio-beat-detection Cycles:10 Average:118.60 Median:110.50 stddev:15.97 (14.4%) stddev-sans-first:14.29 09:22:45 INFO - PROCESS | 1660 | Values: 143.0 108.0 108.0 142.0 108.0 111.0 110.0 108.0 140.0 108.0 09:22:45 INFO - PROCESS | 1660 | 09:22:45 INFO - PROCESS | 1660 | [#2] audio-dft Cycles:10 Average:182.60 Median:183.00 stddev:1.65 (0.9%) stddev-sans-first:1.74 09:22:45 INFO - PROCESS | 1660 | Values: 183.0 183.0 183.0 183.0 179.0 181.0 182.0 183.0 185.0 184.0 09:22:45 INFO - PROCESS | 1660 | 09:22:45 INFO - PROCESS | 1660 | [#3] audio-fft Cycles:10 Average:72.80 Median:69.00 stddev:17.62 (25.5%) stddev-sans-first:18.38 09:22:45 INFO - PROCESS | 1660 | Values: 82.0 62.0 76.0 112.0 82.0 58.0 59.0 58.0 82.0 57.0 09:22:45 INFO - PROCESS | 1660 | 09:22:45 INFO - PROCESS | 1660 | [#4] audio-oscillator Cycles:10 Average:86.80 Median:89.00 stddev:18.35 (20.6%) stddev-sans-first:19.44 09:22:45 INFO - PROCESS | 1660 | Values: 89.0 70.0 95.0 69.0 71.0 95.0 127.0 95.0 68.0 89.0 09:22:45 INFO - PROCESS | 1660 | 09:22:45 INFO - PROCESS | 1660 | [#5] imaging-gaussian-blur Cycles:10 Average:95.60 Median:87.50 stddev:18.54 (21.2%) stddev-sans-first:19.40 09:22:45 INFO - PROCESS | 1660 | Values: 87.0 85.0 90.0 86.0 88.0 82.0 88.0 89.0 132.0 129.0 09:22:45 INFO - PROCESS | 1660 | 09:22:45 INFO - PROCESS | 1660 | [#6] imaging-darkroom Cycles:10 Average:96.00 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.78 09:22:45 INFO - PROCESS | 1660 | Values: 97.0 96.0 96.0 95.0 95.0 97.0 96.0 97.0 95.0 96.0 09:22:45 INFO - PROCESS | 1660 | 09:22:45 INFO - PROCESS | 1660 | [#7] imaging-desaturate Cycles:10 Average:90.70 Median:84.00 stddev:16.09 (19.2%) stddev-sans-first:16.88 09:22:45 INFO - PROCESS | 1660 | Values: 84.0 87.0 84.0 84.0 84.0 84.0 84.0 84.0 97.0 135.0 09:22:45 INFO - PROCESS | 1660 | 09:22:45 INFO - PROCESS | 1660 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:56.00 stddev:1.49 (2.7%) stddev-sans-first:1.33 09:22:45 INFO - PROCESS | 1660 | Values: 58.0 54.0 55.0 53.0 55.0 56.0 57.0 57.0 56.0 56.0 09:22:45 INFO - PROCESS | 1660 | 09:22:45 INFO - PROCESS | 1660 | [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:69.00 stddev:2.76 (4.0%) stddev-sans-first:2.05 09:22:45 INFO - PROCESS | 1660 | Values: 63.0 70.0 68.0 74.0 70.0 68.0 67.0 68.0 69.0 69.0 09:22:45 INFO - PROCESS | 1660 | 09:22:45 INFO - PROCESS | 1660 | [#10] stanford-crypto-aes Cycles:10 Average:86.90 Median:85.50 stddev:6.56 (7.7%) stddev-sans-first:5.85 09:22:45 INFO - PROCESS | 1660 | Values: 97.0 97.0 94.0 83.0 85.0 80.0 81.0 83.0 83.0 86.0 09:22:45 INFO - PROCESS | 1660 | 09:22:45 INFO - PROCESS | 1660 | [#11] stanford-crypto-ccm Cycles:10 Average:147.70 Median:145.50 stddev:16.65 (11.4%) stddev-sans-first:17.29 09:22:45 INFO - PROCESS | 1660 | Values: 138.0 135.0 138.0 146.0 149.0 145.0 142.0 150.0 193.0 141.0 09:22:45 INFO - PROCESS | 1660 | 09:22:45 INFO - PROCESS | 1660 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.90 Median:165.00 stddev:24.04 (14.6%) stddev-sans-first:25.23 09:22:45 INFO - PROCESS | 1660 | Values: 166.0 162.0 160.0 155.0 212.0 222.0 193.0 164.0 163.0 162.0 09:22:45 INFO - PROCESS | 1660 | 09:22:45 INFO - PROCESS | 1660 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:67.00 stddev:1.75 (2.6%) stddev-sans-first:1.73 09:22:45 INFO - PROCESS | 1660 | Values: 68.0 68.0 67.0 66.0 66.0 62.0 66.0 65.0 67.0 67.0 09:22:45 INFO - PROCESS | 1660 | -------- Summary: end -------- 09:22:45 INFO - PROCESS | 1660 | 09:22:45 INFO - TEST-INFO | 1660: exit 0 09:22:45 INFO - TEST-OK | kraken | took 59340ms 09:22:45 INFO - SUITE-END | took 1176s 09:22:46 INFO - Completed test suite (00:19:36) 09:22:46 INFO - javascript benchmark 09:22:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3344.2976974835283, 3355.1612096975755, 3389.4068538005845, 3404.914877128073, 3430.108171875313, 5771.422857714227, 5789.71051447427, 5811.418858114186, 5811.651300921948, 5842.591018628697, 5788.305403351593, 5861.384554621756, 5865.0, 5879.794207202749, 5885.676287804169, 5257.842264732045, 5271.9472805272035, 5314.681119132845, 5333.306670132877, 5357.4374690657505, 5218.947810521903, 5230.555402790767, 5240.764165612557, 5243.0, 5398.62209645323, 5313.707746073965, 5318.069337865877, 5345.0, 5351.839444816662, 5363.115086010804, 5313.814016509404, 5316.601254905898, 5329.040772660919, 5329.973350133263, 5348.598855085884, 5154.536091751723, 5221.13851214553, 5265.947340526623, 5283.207518872162, 5321.4412486688725, 5679.119736440858, 5695.088785794253, 5762.481376676077, 5776.364599894008, 5801.8549536261935, 5515.007298686235, 6072.119542666333, 6161.210393814957, 6272.529560282951, 6279.905801412982, 6241.407066328737, 6281.905771413432, 6306.148669929593, 6323.367663233686, 6332.841678958017, 5796.362400135981, 5849.912251316234, 5859.238299021185, 5886.764529418861, 5913.8817223655715, 6292.087647291117, 6342.429181373606, 6352.364763523703, 6355.968220158869, 6362.236531616143, 5201.271821944931, 6263.217097862767, 6275.121482992385, 6297.874042519124, 6308.053791931247, 4645.605123564535, 6163.8150855474405, 6216.906746398808, 6261.123442718023, 6344.968275158687, 6225.875482490415, 6335.556511044275, 6339.809805705836, 6349.142865713162, 6352.078948552434, 6272.933601287792, 6302.0, 6329.873402531924, 6338.8415289617205, 6341.4609758170145, 4898.24077268024, 4942.703437793743, 4967.528084831935, 5016.0, 5025.874353141201, 3775.3581891078584, 4443.511213766483, 4490.169318676056, 4494.5505449454795, 4499.437570303712, 5851.590388672752, 5858.384869588632, 5861.41385861419, 5862.882742345215, 5866.6480011199465, 6140.105498721277, 6330.4619107375465, 6338.0, 6351.079093531504, 6361.300256971729, 5620.887582248332, 5758.798442054592, 5804.100364443518, 5818.912716309259, 5909.970450147722, 5454.563634909197, 5485.314335708036, 5492.862678433071, 5503.587230957694, 5508.20131080999, 6293.842653933597, 6314.8737025258315, 6319.873602528016, 6320.0203968385895, 6328.177336946167, 5759.568032397503, 6220.315765265907, 6269.028300613412, 6269.655168965568, 6334.6832658365975, 6278.905816412666, 6306.716197771203, 6321.683915804099, 6324.0, 6326.778562750282, 6301.842453938505, 6304.243490780952, 6315.336889626523, 6319.715612797527, 6321.810345689637, 6161.983272759944, 6198.969005154945, 6226.968865155645, 6306.46395056407, 6313.747450102128, 6116.724747386289, 6242.157308763259, 6263.0, 6265.530085243716, 6273.9372606273355, 6209.534284928558, 6241.906371404341, 6244.219472565929, 6256.530760192913, 6265.185525881606, 4869.853904382874, 5951.958407278796, 6068.059450785136, 6102.206713127265, 6150.477209437069, 6050.152978582913, 6055.666938318434, 6090.451859332681, 6095.376470354164, 6166.784162554289, 5989.341172470938, 6001.5798894077, 6004.669743164168, 6021.789237376671, 6027.517798576191], "value": 5745.606402373811, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [441.8762746430999, 443.70050216104124, 471.47901568766514, 526.9697740916511, 538.9598075713872, 29892.252693682643, 30663.233419164506, 39465.99999999996, 40807.0, 40873.7956310218, 42709.786451067775, 43055.0, 43099.0, 43161.35257971125, 43362.34956475655, 9628.22974162069, 9866.90133098667, 9874.259430542737, 9875.95062024689, 9882.654107106253, 8775.166359195866, 8988.011318754965, 9639.373440726366, 11906.0, 12131.272123672563, 12196.207246528948, 12315.0, 12357.567485138023, 12372.0, 12385.814212786816, 12195.878041219563, 12287.56993505232, 12307.630771076882, 12307.75384492305, 12327.075469339836, 8681.826363472695, 8889.199972002487, 11717.179797414185, 11951.043916486748, 12015.759684806342, 40986.9753256168, 41384.79307603473, 41415.1716965662, 41508.79245603783, 41586.58413415858, 3284.441644920369, 3302.53764472974, 3368.2758206985613, 3576.946345804789, 3603.351396748584, 30202.395952081057, 30458.238544036576, 30771.846140769154, 30942.0, 31799.523007154912, 3221.548983142362, 3263.96736032639, 3285.129440698217, 3299.835008249578, 3330.1008727643643, 524275.37862310826, 529340.3532982349, 529378.0, 530200.0, 532111.0, 62867.371326287066, 63285.683571581845, 63345.683271583344, 63354.0496892547, 63538.68230658909, 66104.0, 66145.33854661488, 66164.0, 66208.66895665588, 66504.0, 16623.50129496117, 17234.65530689404, 17261.741073883903, 17262.482125536255, 17264.654706905792, 11251.774964500828, 12981.221126732238, 13022.544210952572, 13027.934860325828, 13060.95512359009, 16124.355025799072, 16602.91698541524, 18667.253309867723, 18980.335688250845, 19196.61606767857, 6673.499487538357, 7740.26467485588, 7877.291043806085, 7888.64501097452, 7937.2062793721325, 875.6497401039635, 944.5182956692137, 960.8894977077586, 1038.6468600675807, 1066.9010918753695, 29604.0, 29643.110706678835, 29650.258743531154, 29921.551176732366, 30249.848750756104, 1027.7636143686843, 1040.666986564292, 1062.1874266186373, 1071.346478648024, 1111.3109871879487, 15036.699266014619, 15340.079595224322, 15362.692746145014, 15427.648308253618, 15686.450974216075, 707486.0, 715903.0, 716193.0, 717107.0, 718117.0, 57147.0, 57564.56088597735, 57779.55551111172, 57820.8435831281, 57841.13238301429, 1227.4353797253364, 1257.1074537078412, 1259.1878238536092, 1386.230641993683, 1408.746425643394, 29804.0, 32080.0, 32091.358172835946, 32100.03699889007, 32668.50997234996, 53604.195937061755, 54194.45805541894, 54255.0, 54298.45701542934, 54514.63713407196, 512341.0, 516672.0, 516678.0, 517227.0, 517267.0, 26375.340616483973, 26383.472330553665, 26605.201843944713, 26771.7322826777, 26967.460650787267, 46169.76915115403, 46244.76877615591, 46629.76685116688, 46856.297155542015, 46912.29631555461, 38050.0, 38303.42544861885, 38323.23353532858, 38431.423528647654, 39250.6074939247, 38138.0, 38399.80800095982, 38477.80761096177, 39097.41353879637, 39758.80120599378, 31955.201119972186, 36154.63845361618, 36841.44737828881, 36866.63133368739, 38318.23363532769, 30545.167289962672, 33319.000429987136, 34479.827600861834, 34509.82745086359, 34577.13557161091, 24796.628050578896, 25198.74801251964, 25334.493310133326, 25797.226083217534, 25859.0949316773], "value": 20442.28293337832, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.8135388244231, 372.1347866211059, 374.53744625387657, 385.3910820902973, 407.79202606670606, 15018.174000429972, 15189.848101518981, 17100.315987360507, 20780.584388312225, 21193.470163245926, 19601.0, 20628.484287892774, 21036.263730769388, 21190.0, 21434.356969290948, 5912.965231084565, 5977.850553736159, 6142.262928448592, 6253.812385628438, 6262.154609127755, 6007.15899774032, 6132.233470816148, 6159.10692949522, 6159.630422174661, 6170.784022559212, 3818.732688711791, 4378.912421751563, 4396.0108975480425, 4580.0, 6786.762463313785, 6527.086207930894, 6796.2863899290605, 6822.829429264259, 6853.074834897275, 6873.896891546656, 5950.523958083343, 5958.851028724273, 5969.164316995624, 5971.462568368867, 5973.402659734035, 25527.74472255272, 25988.220353389428, 26375.20874373772, 26492.337691557674, 26739.732602674114, 2326.7789559991775, 2453.055573604175, 2467.8889449974795, 2474.480359124586, 2497.0760818497274, 14530.56408307742, 15357.846421535753, 16010.119443430724, 16018.279177437043, 16070.0, 1845.5478407790042, 1868.246775880095, 1916.5017095555118, 1918.9712154317556, 1926.1909997800958, 87799.56100219522, 106555.46722266417, 111546.0, 115907.84092159054, 121256.99999999911, 10977.83533247002, 11111.944440277746, 11189.272697274651, 11228.887711122947, 11309.943450282695, 13872.306384680725, 13873.445062197601, 13894.166350019032, 13907.58277251684, 13910.026298159235, 6914.757983470555, 8709.390342676079, 8722.30221582272, 8785.692500762443, 8787.253083487974, 8478.576071196416, 8742.0, 8788.912110878937, 8905.198532132139, 8918.55407229636, 6582.736690532325, 6683.131192944886, 6688.431483323875, 6692.3976842083475, 6763.492738044666, 1800.9369672061414, 1826.1417133947289, 1841.2266847923636, 1841.5304097455064, 1845.4740398986494, 849.4987957105337, 881.8765372847806, 903.3495882964255, 944.4663764972769, 968.3705591365668, 21928.89035554812, 22314.776852231593, 22819.832115948957, 22839.543209136056, 22976.65535016976, 977.5014742481386, 980.5091487669139, 1007.9344842585208, 1025.4308858583408, 1091.8089334366614, 11037.668869933916, 11604.43340149086, 11823.76352472963, 11854.992325652243, 11899.798537270633, 581788.0, 582152.0, 586872.0, 599778.0, 603444.9827750921, 99250.0, 100523.49738251408, 119620.80379196096, 121014.0, 124030.0, 991.4101109839634, 998.0836793356773, 1000.5347513406156, 1016.8830584482731, 1026.348268849271, 18909.90545047266, 19659.606807863478, 20261.29085482001, 20326.0, 20328.0, 52801.735991319794, 53114.750819935085, 54500.0, 57832.71083644555, 57909.0, 75067.24932750821, 77948.61025694835, 79694.0, 79734.0, 81374.18625813903, 7994.800129996796, 8004.057723100254, 8119.093235904009, 8411.579421029046, 8439.578021099043, 9419.905800941902, 13009.089363744448, 13251.867481325064, 13369.799453008018, 13633.522826701017, 10988.780224395307, 11082.833757493805, 11427.0, 11548.538058477567, 11795.115366347387, 8927.508987005776, 10636.255462117577, 11185.496652650812, 11227.887721122685, 11724.120690948042, 9379.484128372733, 10643.09533689614, 11400.372979485875, 11611.941940290244, 12018.218815776947, 7735.806604834699, 8103.987001624797, 8213.671453141807, 8359.623816928375, 8378.204070613281, 8497.702580409656, 9435.29235307341, 9587.760305992406, 11225.775484490101, 11386.430678465878], "value": 9791.663837571674, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1354.9593512194626, 1525.1764047414392, 1534.9462768803091, 1728.5073753980118, 1881.9059047047654, 7930.246626570473, 8465.238128568428, 8596.355273354493, 8929.732108036753, 8949.149830766082, 8639.43843650164, 8839.071897450756, 8873.467591944487, 8936.642534298637, 8940.91059089409, 2355.823313251509, 2402.4834660547976, 2407.2537513370826, 2407.9759202408013, 2408.1089996701157, 2382.332946774906, 2409.506051259488, 2428.5264373447185, 2428.9028438862424, 2435.2207293666033, 2401.519696060786, 2413.8189635777385, 2427.5630386530415, 2429.708434987804, 2431.4407686232175, 2365.455945132629, 2391.390195500145, 2396.74834142416, 2403.3631087761755, 2404.5190961807707, 2306.884655767222, 2400.7959323457526, 2400.9879950600134, 2413.553492603874, 2421.128393778238, 7856.607169641552, 8118.10700822909, 8761.693340733107, 8916.910830891673, 8929.01780804111, 4730.62155027597, 5098.209777484496, 5251.10731175701, 5262.184361423985, 5294.867628309285, 3116.781825272232, 3590.317839610466, 3623.927521449556, 3711.480392745018, 3712.0, 1103.7351035751362, 1103.7406209540752, 1106.0819519798547, 1118.669992352258, 1127.7631697343568, 11656.766864662659, 11815.586454474053, 11817.881821181763, 11839.408029598571, 11850.11124165691, 4664.323673067454, 4685.929711054268, 4880.951190488121, 4898.755062246873, 4919.3604831371695, 10209.897901021044, 10220.540075696612, 10221.846672299922, 10233.74415639615, 10245.948770256102, 5374.785008599691, 5377.892442151213, 5387.4073851876265, 5387.434319396407, 5387.46125387466, 4721.811127554859, 4826.420829500412, 4883.0, 4898.167311557044, 4911.87720306988, 3867.9806600966817, 3873.4189871519498, 3907.316219661548, 3950.881473555798, 3984.2828290907337, 1007.8034783217203, 1177.0, 1181.79318619243, 1194.4147367789722, 1195.2589394575418, 777.739457281817, 861.793169639282, 909.4588719711761, 913.1872633356318, 929.4376901974343, 5684.459976302244, 5694.857628559319, 5769.59612827098, 6073.757049717962, 6196.225471816023, 846.5259454705384, 889.6619284671783, 921.4977837078808, 938.2447130060231, 947.5593848860314, 3741.663250307485, 3884.9805750971063, 3949.328614135604, 3955.5253369595835, 4008.2785098681934, 10486.685399438029, 10870.782584348268, 10905.0, 10925.344479331265, 10955.34267943926, 10882.564697412174, 10894.782104357868, 10895.019448249695, 10898.291611045257, 10898.727531811768, 7849.254320839511, 8163.55100469468, 8262.42163048581, 8286.295664868434, 8309.459885107448, 4950.653454258168, 6004.129401236709, 6024.8795024100145, 6065.059915713072, 6101.572889897665, 9437.622495100119, 9735.902640973783, 10141.391516508738, 10172.694819155437, 10283.640072597424, 10324.002732853683, 10341.63804266847, 10384.844227336445, 10428.217883658604, 10510.369377837354, 7214.567125972459, 7293.452991025588, 7305.5981920994855, 7309.086364204474, 7362.153352364547, 8314.168583141638, 8368.456050356708, 8420.87368689458, 8433.83132337362, 8448.112948140357, 7453.962730186531, 7543.367881333098, 7571.356434702891, 7708.922910770821, 7714.0, 7138.607376594129, 7422.66598003102, 7426.183119856703, 7440.181580026085, 7468.813279668052, 6884.896726549206, 6929.965350173217, 7026.051483049927, 7033.824154396181, 7036.753713620204, 4951.232558953368, 4987.47631498702, 5032.496750325085, 5038.924416133834, 5128.4615115413835, 4994.650374473752, 5007.39911210657, 5095.031943930641, 5095.464976177448, 5158.742062896915], "value": 4604.975209417442, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [250.3004103530632, 287.51697148790026, 305.81192566571553, 309.5897935235813, 316.11330218736447, 5085.618578606605, 5193.272941788153, 5237.423883372826, 5238.580913526918, 5423.728813559316, 5224.21636754487, 5292.718514520992, 5317.8404647860525, 5342.706151161685, 5421.993862270965, 4083.4691490106243, 4085.632293093636, 4089.078133277355, 4092.242935057009, 4119.382092686106, 3060.0, 3614.6806415658357, 3627.6009638939695, 3746.756460830037, 4095.877123686294, 3955.6044395560357, 4081.8367265309353, 4086.2849001424634, 4088.550259471456, 4114.300568903279, 4061.1268577255883, 4065.6544193743566, 4086.366613174963, 4091.9974606221367, 4180.602842729936, 3436.6735160159747, 3578.3737845876867, 3587.4080776671817, 3593.5328407306883, 3603.7297202709638, 4084.7344922580232, 4328.264195086843, 5166.844994650129, 5175.327207463043, 5178.922316165261, 4689.201746585277, 4696.483386827446, 4698.553637404441, 4708.693934894221, 4713.222318317474, 4326.706845371958, 5635.690037047961, 5657.745401456944, 5665.575081868877, 5721.828345149611, 3598.6221446747977, 3914.8042597870276, 3927.6268754468565, 3929.5677475477673, 3969.2656858480987, 5844.415558444164, 5896.882062358772, 5905.999999999957, 5941.524678025748, 5976.85057873548, 4005.859794907164, 4020.6984476164403, 4021.6380525752825, 4022.3162062449455, 4023.3562629979065, 3574.803385813805, 3937.5078115235597, 3954.1103251768122, 3958.2677204716642, 3969.4641223435046, 4335.674824388184, 4361.9749358900635, 4412.624926881251, 4514.819407223675, 4563.498015218323, 4972.618619338884, 5153.191510626717, 5724.141378793214, 5733.025385684444, 5736.942630573724, 1126.1947707389093, 1343.9450031725244, 1345.9461621535224, 1347.3398034962797, 1356.6269275949194, 660.9622892059516, 705.4673721340355, 776.3750181104152, 797.6649807081039, 837.2585023151829, 3982.3628219484744, 4071.7629484559848, 4288.056627541936, 4433.6009759121835, 4486.170058539115, 4598.908021839545, 4627.6529260305615, 4786.95213047865, 4826.420829500483, 4851.603877285914, 3668.872054208606, 3672.4307732301536, 4304.48346198452, 4452.376667266585, 4506.549345065468, 2673.930427828884, 2893.652761668613, 3060.6939306069216, 3073.339232065117, 3077.9076627701206, 4754.429468463737, 5403.405625381205, 5897.557683173779, 5919.289685237799, 5943.762249510058, 4960.627952903546, 5619.7471113799975, 5825.854353641193, 5938.6436813791315, 5950.613210141327, 5356.892862142735, 5847.766089356378, 5888.322842873039, 5889.293284805851, 5951.970240148771, 5737.770489180386, 5783.710814459176, 5785.884282314414, 5793.406813126424, 5834.474897259267, 5321.3348331458565, 5641.915371269352, 5647.0, 5734.856628584319, 5742.0764044044045, 4979.833772309057, 5020.799168033238, 5460.3993560707495, 5656.284983208001, 5937.109433584997, 3533.0, 3808.428735689669, 3836.2327534492656, 3860.3823388257742, 3871.793077945544, 4807.95192048075, 4895.779689913891, 5351.732413379394, 5354.3842458117815, 5485.835424937259, 4715.693479923794, 5202.60980426462, 5326.946730532645, 5501.669899806025, 5577.135543990688, 4735.171345014677, 4792.808287668454, 5655.434456554476, 5677.432256774455, 5677.545796336366, 5413.240696773486, 5549.139883318092, 5587.469190426903, 5589.0, 5645.68948707825, 5344.064788661891, 5357.491038351351, 5696.686682232351, 5697.319290809304, 5723.6851973141875, 4465.5087940327185, 5148.871278218075, 5291.9206211906085, 5585.2180694701965, 5628.620987858001], "value": 4011.3398162335143, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [707.2538471912134, 707.3951771235594, 754.830163213277, 777.3159619534808, 781.2929298984418, 15030.699386012288, 16213.351465941349, 16215.189240537955, 16250.18749062548, 16256.0, 14598.416063357454, 14696.265186740648, 14736.410543578244, 14775.261236938164, 14799.112053276811, 645.2482857471041, 665.4643012375036, 668.2682462703332, 668.9966550167243, 826.5330088499993, 674.4233680203429, 676.918769747631, 812.8252425728467, 837.4138103327665, 843.983120337596, 754.3248792330861, 902.6524787956652, 903.7605034665819, 903.832790933676, 906.2795077913042, 864.269692110169, 887.3965703321738, 893.0890491698431, 894.2801045158644, 900.2078171209326, 508.10319785578486, 524.7586110389226, 627.8995360742259, 646.360103497534, 666.5267659961434, 14733.631659208499, 15216.847831521654, 15235.390584376612, 15235.847641523555, 15308.693826123526, 11898.762024759542, 13725.45098196081, 13860.653483662889, 13953.930230348884, 14009.789853152211, 11041.0, 11403.942980285046, 11569.768604627945, 12292.446839892227, 12797.936010319889, 4482.731036137842, 4566.748828814414, 4754.500777418356, 4783.425988881322, 4804.759762011886, 78837.60581197115, 97251.08246752538, 109617.45191274073, 113243.43378283139, 115715.0, 8292.668293268202, 10466.842997355046, 10656.467176641137, 10797.676069717922, 10930.398828064373, 19713.310034149024, 20675.689864652042, 20792.58414831695, 20846.166153354, 20876.164953401996, 6581.572197807223, 8021.157778433298, 8038.63826127814, 8119.431639785158, 8213.630386632616, 4344.913101737948, 4424.225760491901, 4468.865934021985, 4514.503404625489, 4575.611073058761, 3570.517980072657, 3754.3992961126087, 3755.549334079928, 3760.2479504099288, 3762.4168253920684, 649.136648257816, 658.2200092889941, 668.1681306773002, 674.3256743256743, 680.0513283968836, 588.2529187931303, 609.6891682881751, 625.327772644409, 655.672163918041, 662.6322391073, 8155.429119961545, 8337.624806883583, 9548.283878709124, 9646.42121472714, 9830.115289623967, 615.7906311853991, 651.6481100205835, 669.5279827721445, 693.6185098196073, 700.4886432904009, 4303.1393721255245, 4609.262517997105, 4626.907461850811, 4645.674802763774, 4690.695104818176, 89865.55067224622, 124364.0, 128523.71476285305, 144419.0, 149362.0, 118512.0, 121988.0, 125769.0, 127862.36068819596, 131696.0, 72471.99999999895, 89853.0, 108296.0, 110103.44948275207, 113973.4301328488, 9493.335466517277, 9973.551190196313, 10067.496625168858, 10101.49492525356, 10125.443100629536, 62035.37964620477, 62553.0, 63066.0, 64556.677216613614, 64603.0, 78227.0, 90091.0, 94119.0, 96586.0, 99880.50059749655, 12655.430505627453, 13104.475820967436, 13301.201927884358, 13370.264635444755, 13430.19418834873, 14134.78797818013, 14152.363143658355, 14284.142951422948, 14924.552263432115, 14956.626084347978, 12520.436580354088, 12711.0, 13339.199648020762, 13695.452181912611, 13892.305384730926, 12899.548515802277, 13497.527586534425, 13785.310734463437, 14367.856321436651, 14551.199684017058, 12788.104832661624, 12905.290209038592, 13577.59267221985, 13791.310434478035, 14093.436262549383, 10145.391276523433, 11141.331520108819, 11691.473883675426, 11759.0, 11861.40692965331, 11114.555417783198, 11320.943395282971, 11487.770244595229, 11681.591144309908, 11822.586209482626], "value": 7719.053906845864, "unit": "score"}], "name": "dromaeo_css", "value": 7398.466853853912, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 111.0, 113.0, 113.0, 118.0, 163.0, 119.0, 118.0, 164.0, 160.0], "value": 129.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 108.0, 108.0, 142.0, 108.0, 111.0, 110.0, 108.0, 140.0, 108.0], "value": 118.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 183.0, 183.0, 183.0, 179.0, 181.0, 182.0, 183.0, 185.0, 184.0], "value": 182.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 62.0, 76.0, 112.0, 82.0, 58.0, 59.0, 58.0, 82.0, 57.0], "value": 72.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 70.0, 95.0, 69.0, 71.0, 95.0, 127.0, 95.0, 68.0, 89.0], "value": 86.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 90.0, 86.0, 88.0, 82.0, 88.0, 89.0, 132.0, 129.0], "value": 95.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 96.0, 95.0, 95.0, 97.0, 96.0, 97.0, 95.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 87.0, 84.0, 84.0, 84.0, 84.0, 84.0, 84.0, 97.0, 135.0], "value": 90.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 54.0, 55.0, 53.0, 55.0, 56.0, 57.0, 57.0, 56.0, 56.0], "value": 55.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 70.0, 68.0, 74.0, 70.0, 68.0, 67.0, 68.0, 69.0, 69.0], "value": 68.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 94.0, 83.0, 85.0, 80.0, 81.0, 83.0, 83.0, 86.0], "value": 86.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 135.0, 138.0, 146.0, 149.0, 145.0, 142.0, 150.0, 193.0, 141.0], "value": 147.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 162.0, 160.0, 155.0, 212.0, 222.0, 193.0, 164.0, 163.0, 162.0], "value": 175.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 67.0, 66.0, 66.0, 62.0, 66.0, 65.0, 67.0, 67.0], "value": 66.2, "unit": "score"}], "name": "kraken", "value": 1473.4000000000003, "alertThreshold": 2.0}]} 09:22:46 INFO - Return code: 0 09:22:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:22:46 INFO - # TBPL SUCCESS # 09:22:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:22:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:22:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:22:46 INFO - 2016-09-23 09:22:46.330 screenresolution[1664:9841] starting screenresolution argv=screenresolution get 09:22:46 INFO - 2016-09-23 09:22:46.333 screenresolution[1664:9841] Display 0: 1600x1200x32@60 09:22:46 INFO - 2016-09-23 09:22:46.339 screenresolution[1665:9844] starting screenresolution argv=screenresolution list 09:22:46 INFO - Available Modes on Display 0 09:22:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:22:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:22:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:22:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:22:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:22:46 INFO - Intel Iris: 09:22:46 INFO - Chipset Model: Intel Iris 09:22:46 INFO - Type: GPU 09:22:46 INFO - Bus: Built-In 09:22:46 INFO - VRAM (Dynamic, Max): 1536 MB 09:22:46 INFO - Vendor: Intel (0x8086) 09:22:46 INFO - Device ID: 0x0a2e 09:22:46 INFO - Revision ID: 0x0009 09:22:46 INFO - Displays: 09:22:46 INFO - Display: 09:22:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:22:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:22:46 INFO - Display Serial Number: 1600x1200 60 09:22:46 INFO - Main Display: Yes 09:22:46 INFO - Mirror: Off 09:22:46 INFO - Online: Yes 09:22:46 INFO - Rotation: Supported 09:22:46 INFO - Return code: 0 09:22:46 INFO - Running post-action listener: _resource_record_post_action 09:22:46 INFO - [mozharness: 2016-09-23 16:22:46.584750Z] Finished run-tests step (success) 09:22:46 INFO - Running post-run listener: _resource_record_post_run 09:22:46 INFO - Total resource usage - Wall time: 1210s; CPU: 53.0%; Read bytes: 38462464; Write bytes: 662500352; Read time: 377; Write time: 1949 09:22:46 INFO - TinderboxPrint: CPU usage
53.3% 09:22:46 INFO - TinderboxPrint: I/O read bytes / time
38,462,464 / 377 09:22:46 INFO - TinderboxPrint: I/O write bytes / time
662,500,352 / 1,949 09:22:46 INFO - TinderboxPrint: CPU idle
2,259.2 (46.7%) 09:22:46 INFO - TinderboxPrint: CPU system
968.0 (20.0%) 09:22:46 INFO - TinderboxPrint: CPU user
1,614.5 (33.3%) 09:22:46 INFO - TinderboxPrint: Swap in / out
401,223,680 / 0 09:22:46 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 353378816; Write bytes: 348407296; Read time: 27473; Write time: 642 09:22:46 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 37499904; Write bytes: 296103424; Read time: 361; Write time: 1240 09:22:47 INFO - Running post-run listener: _upload_blobber_files 09:22:47 INFO - Blob upload gear active. 09:22:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:22:47 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:22:47 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:22:47 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:22:47 INFO - (blobuploader) - INFO - Open directory for files ... 09:22:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:22:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:22:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:22:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:22:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:22:48 INFO - (blobuploader) - INFO - Done attempting. 09:22:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:22:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:22:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:22:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:22:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:22:49 INFO - (blobuploader) - INFO - Done attempting. 09:22:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:22:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:22:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:22:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:22:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:22:52 INFO - (blobuploader) - INFO - Done attempting. 09:22:52 INFO - (blobuploader) - INFO - Iteration through files over. 09:22:52 INFO - Return code: 0 09:22:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:22:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:22:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4b267b5f01a63f387046b8bac5643ec571a52ee520f8604c805b45b06f4382ab36bf9ed0f85dcea4d48ca687cd251d767a56086136c0ec71aa29c8e7beb9686e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f1deed69948296a4a456a6c93a47892471e3c9107cd4ff8530040a803e2e8b4d6f065975ccbd34431ef80c2734b5511ef84820a5ff20cd5616941d53cdf44c25", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7b1b8344b1804d4fced2a89d35259c7310f66a2cfaa6137bd3c61379f6fbb44f75a08540e593a0cf7cc40e107fad4bf403b66ba58cc1faf168e9e4c6721cbf19"} 09:22:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:22:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:22:52 INFO - Contents: 09:22:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4b267b5f01a63f387046b8bac5643ec571a52ee520f8604c805b45b06f4382ab36bf9ed0f85dcea4d48ca687cd251d767a56086136c0ec71aa29c8e7beb9686e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f1deed69948296a4a456a6c93a47892471e3c9107cd4ff8530040a803e2e8b4d6f065975ccbd34431ef80c2734b5511ef84820a5ff20cd5616941d53cdf44c25", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7b1b8344b1804d4fced2a89d35259c7310f66a2cfaa6137bd3c61379f6fbb44f75a08540e593a0cf7cc40e107fad4bf403b66ba58cc1faf168e9e4c6721cbf19"} 09:22:52 INFO - Running post-run listener: copy_logs_to_upload_dir 09:22:52 INFO - Copying logs to upload dir... 09:22:52 INFO - mkdir: /builds/slave/test/build/upload/logs 09:22:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.970450 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-09-23 09:22:52.948457) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-23 09:22:52.952225) ========= 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.NkoXfVDkEg/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.Mc75rdXl0G/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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/4b267b5f01a63f387046b8bac5643ec571a52ee520f8604c805b45b06f4382ab36bf9ed0f85dcea4d48ca687cd251d767a56086136c0ec71aa29c8e7beb9686e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f1deed69948296a4a456a6c93a47892471e3c9107cd4ff8530040a803e2e8b4d6f065975ccbd34431ef80c2734b5511ef84820a5ff20cd5616941d53cdf44c25", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7b1b8344b1804d4fced2a89d35259c7310f66a2cfaa6137bd3c61379f6fbb44f75a08540e593a0cf7cc40e107fad4bf403b66ba58cc1faf168e9e4c6721cbf19"} build_url:https://queue.taskcluster.net/v1/task/DURbrwJ0QJCE-B6kEGKVwg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011090 build_url: 'https://queue.taskcluster.net/v1/task/DURbrwJ0QJCE-B6kEGKVwg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4b267b5f01a63f387046b8bac5643ec571a52ee520f8604c805b45b06f4382ab36bf9ed0f85dcea4d48ca687cd251d767a56086136c0ec71aa29c8e7beb9686e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f1deed69948296a4a456a6c93a47892471e3c9107cd4ff8530040a803e2e8b4d6f065975ccbd34431ef80c2734b5511ef84820a5ff20cd5616941d53cdf44c25", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7b1b8344b1804d4fced2a89d35259c7310f66a2cfaa6137bd3c61379f6fbb44f75a08540e593a0cf7cc40e107fad4bf403b66ba58cc1faf168e9e4c6721cbf19"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-23 09:22:52.985857) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 09:22:52.986198) ========= 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.NkoXfVDkEg/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.Mc75rdXl0G/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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.004941 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 09:22:53.034837) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-23 09:22:53.035172) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-23 09:22:53.035523) ========= ========= Total master_lag: 0.17 =========