builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0286 starttime: 1471639499.28 results: success (0) buildid: 20160819102824 builduid: 3e06750bcfb24b8aa952519e26568ca1 revision: 6b1f62a32be285d0d8956629b2860fb5212bc8de ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-19 13:44:59.284018) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-19 13:44:59.284534) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-19 13:44:59.284875) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-19 13:44:59.312747) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 13:44:59.313246) ========= 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.kn1ylyn9xf/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.O3vBRCIqRT/Listeners TMPDIR=/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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-08-19 13:44:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 227M=0s 2016-08-19 13:44:59 (227 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.119378 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 13:44:59.459250) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 13:44:59.459698) ========= 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.kn1ylyn9xf/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.O3vBRCIqRT/Listeners TMPDIR=/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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.026154 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 13:44:59.509596) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-19 13:44:59.510077) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6b1f62a32be285d0d8956629b2860fb5212bc8de --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 6b1f62a32be285d0d8956629b2860fb5212bc8de --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kn1ylyn9xf/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.O3vBRCIqRT/Listeners TMPDIR=/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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-08-19 13:44:59,594 truncating revision to first 12 chars 2016-08-19 13:44:59,595 Setting DEBUG logging. 2016-08-19 13:44:59,595 attempt 1/10 2016-08-19 13:44:59,595 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6b1f62a32be2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-19 13:45:00,696 unpacking tar archive at: fx-team-6b1f62a32be2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.375099 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-19 13:45:00.908852) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-19 13:45:00.909172) ========= script_repo_revision: 6b1f62a32be285d0d8956629b2860fb5212bc8de ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-19 13:45:00.909596) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-19 13:45:00.909870) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-19 13:45:00.930019) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-08-19 13:45:00.930354) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kn1ylyn9xf/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.O3vBRCIqRT/Listeners TMPDIR=/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 13:45:01 INFO - MultiFileLogger online at 20160819 13:45:01 in /builds/slave/test 13:45:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 13:45:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:45:01 INFO - {'append_to_log': False, 13:45:01 INFO - 'base_work_dir': '/builds/slave/test', 13:45:01 INFO - 'blob_upload_branch': 'Fx-Team', 13:45:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:45:01 INFO - 'branch': 'Fx-Team', 13:45:01 INFO - 'buildbot_json_path': 'buildprops.json', 13:45:01 INFO - 'config_files': ('talos/mac_config.py',), 13:45:01 INFO - 'default_actions': ('clobber', 13:45:01 INFO - 'read-buildbot-config', 13:45:01 INFO - 'download-and-extract', 13:45:01 INFO - 'populate-webroot', 13:45:01 INFO - 'create-virtualenv', 13:45:01 INFO - 'install', 13:45:01 INFO - 'run-tests'), 13:45:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:45:01 INFO - 'download_minidump_stackwalk': True, 13:45:01 INFO - 'download_symbols': 'ondemand', 13:45:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:45:01 INFO - 'tooltool.py': '/tools/tooltool.py', 13:45:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:45:01 INFO - '/tools/misc-python/virtualenv.py')}, 13:45:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:45:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:45:01 INFO - 'installer_path': 'installer.exe', 13:45:01 INFO - 'log_level': 'info', 13:45:01 INFO - 'log_name': 'talos', 13:45:01 INFO - 'log_to_console': True, 13:45:01 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:45:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:45:01 INFO - 'opt_config_files': (), 13:45:01 INFO - 'pip_index': False, 13:45:01 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:45:01 INFO - 'cmd': ('bash', 13:45:01 INFO - '-c', 13:45:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:45:01 INFO - 'enabled': True, 13:45:01 INFO - 'halt_on_failure': False, 13:45:01 INFO - 'name': 'check_screen_resolution'},), 13:45:01 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:45:01 INFO - 'cmd': ('bash', 13:45:01 INFO - '-c', 13:45:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:45:01 INFO - 'enabled': True, 13:45:01 INFO - 'halt_on_failure': False, 13:45:01 INFO - 'name': 'check_screen_resolution'},), 13:45:01 INFO - 'run_cmd_checks_enabled': True, 13:45:01 INFO - 'sps_profile': False, 13:45:01 INFO - 'sps_profile_interval': 0, 13:45:01 INFO - 'suite': 'dromaeojs', 13:45:01 INFO - 'system_bits': '32', 13:45:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:45:01 INFO - 'title': 't-yosemite-r7-0286', 13:45:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:45:01 INFO - 'use_talos_json': True, 13:45:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:45:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:45:01 INFO - 'work_dir': 'build'} 13:45:01 INFO - [mozharness: 2016-08-19 20:45:01.125697Z] Running clobber step. 13:45:01 INFO - Running pre-action listener: _resource_record_pre_action 13:45:01 INFO - Running main action method: clobber 13:45:01 INFO - rmtree: /builds/slave/test/build 13:45:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:45:03 INFO - Running post-action listener: _resource_record_post_action 13:45:03 INFO - [mozharness: 2016-08-19 20:45:03.033893Z] Finished clobber step (success) 13:45:03 INFO - [mozharness: 2016-08-19 20:45:03.034048Z] Running read-buildbot-config step. 13:45:03 INFO - Running pre-action listener: _resource_record_pre_action 13:45:03 INFO - Running main action method: read_buildbot_config 13:45:03 INFO - Using buildbot properties: 13:45:03 INFO - { 13:45:03 INFO - "project": "", 13:45:03 INFO - "product": "firefox", 13:45:03 INFO - "script_repo_revision": "production", 13:45:03 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 13:45:03 INFO - "repository": "", 13:45:03 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 13:45:03 INFO - "buildid": "20160819102824", 13:45:03 INFO - "pgo_build": "False", 13:45:03 INFO - "basedir": "/builds/slave/test", 13:45:03 INFO - "buildnumber": 920, 13:45:03 INFO - "slavename": "t-yosemite-r7-0286", 13:45:03 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 13:45:03 INFO - "platform": "yosemite_r7", 13:45:03 INFO - "scheduler": "tests-fx-team-macosx64-talos", 13:45:03 INFO - "branch": "fx-team", 13:45:03 INFO - "repo_path": "integration/fx-team", 13:45:03 INFO - "revision": "6b1f62a32be285d0d8956629b2860fb5212bc8de", 13:45:03 INFO - "stage_platform": "macosx64", 13:45:03 INFO - "builduid": "3e06750bcfb24b8aa952519e26568ca1", 13:45:03 INFO - "slavebuilddir": "test" 13:45:03 INFO - } 13:45:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/X7wbiwOiQFGQ64rIAW6KAg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 13:45:03 INFO - Running post-action listener: _resource_record_post_action 13:45:03 INFO - [mozharness: 2016-08-19 20:45:03.037650Z] Finished read-buildbot-config step (success) 13:45:03 INFO - [mozharness: 2016-08-19 20:45:03.037756Z] Running download-and-extract step. 13:45:03 INFO - Running pre-action listener: _resource_record_pre_action 13:45:03 INFO - Running main action method: download_and_extract 13:45:03 INFO - mkdir: /builds/slave/test/build/tests 13:45:03 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')]} 13:45:03 INFO - trying https://queue.taskcluster.net/v1/task/X7wbiwOiQFGQ64rIAW6KAg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 13:45:03 INFO - Downloading https://queue.taskcluster.net/v1/task/X7wbiwOiQFGQ64rIAW6KAg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 13:45:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/X7wbiwOiQFGQ64rIAW6KAg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 13:45:04 INFO - Downloaded 1199 bytes. 13:45:04 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 13:45:04 INFO - Using the following test package requirements: 13:45:04 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 13:45:04 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:45:04 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 13:45:04 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:45:04 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 13:45:04 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:45:04 INFO - u'jsshell-mac.zip'], 13:45:04 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:45:04 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 13:45:04 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 13:45:04 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:45:04 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 13:45:04 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:45:04 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 13:45:04 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:45:04 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 13:45:04 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:45:04 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 13:45:04 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:45:04 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')]} 13:45:04 INFO - trying https://queue.taskcluster.net/v1/task/X7wbiwOiQFGQ64rIAW6KAg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 13:45:04 INFO - Downloading https://queue.taskcluster.net/v1/task/X7wbiwOiQFGQ64rIAW6KAg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 13:45:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X7wbiwOiQFGQ64rIAW6KAg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:45:06 INFO - Downloaded 16350141 bytes. 13:45:06 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 13:45:12 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 13:45:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:45:12 INFO - trying https://queue.taskcluster.net/v1/task/X7wbiwOiQFGQ64rIAW6KAg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 13:45:12 INFO - Downloading https://queue.taskcluster.net/v1/task/X7wbiwOiQFGQ64rIAW6KAg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 13:45:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X7wbiwOiQFGQ64rIAW6KAg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:45:13 INFO - Downloaded 16350141 bytes. 13:45:13 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 13:45: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')]} 13:45:20 INFO - trying https://queue.taskcluster.net/v1/task/X7wbiwOiQFGQ64rIAW6KAg/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 13:45:20 INFO - Downloading https://queue.taskcluster.net/v1/task/X7wbiwOiQFGQ64rIAW6KAg/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 13:45:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X7wbiwOiQFGQ64rIAW6KAg/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 13:45:22 INFO - Downloaded 14413981 bytes. 13:45:22 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 13:45:22 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')]} 13:45:22 INFO - trying https://queue.taskcluster.net/v1/task/X7wbiwOiQFGQ64rIAW6KAg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 13:45:22 INFO - Downloading https://queue.taskcluster.net/v1/task/X7wbiwOiQFGQ64rIAW6KAg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 13:45:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/X7wbiwOiQFGQ64rIAW6KAg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 13:45:26 INFO - Downloaded 111359557 bytes. 13:45:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/X7wbiwOiQFGQ64rIAW6KAg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 13:45:26 INFO - mkdir: /builds/slave/test/properties 13:45:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:45:26 INFO - Writing to file /builds/slave/test/properties/build_url 13:45:26 INFO - Contents: 13:45:26 INFO - build_url:https://queue.taskcluster.net/v1/task/X7wbiwOiQFGQ64rIAW6KAg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 13:45:27 INFO - Running post-action listener: _resource_record_post_action 13:45:27 INFO - Running post-action listener: set_extra_try_arguments 13:45:27 INFO - [mozharness: 2016-08-19 20:45:27.106750Z] Finished download-and-extract step (success) 13:45:27 INFO - [mozharness: 2016-08-19 20:45:27.106877Z] Running populate-webroot step. 13:45:27 INFO - Running pre-action listener: _resource_record_pre_action 13:45:27 INFO - Running main action method: populate_webroot 13:45:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:45:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:45:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:45:27 INFO - '--tppagecycles', 13:45:27 INFO - '7'], 13:45:27 INFO - 'tests': ['tsvgm']}}, 13:45:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:45:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:45:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:45:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:45:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:45:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:45:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:27 INFO - 'talos_options': ['--disable-e10s'], 13:45:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:45:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:45:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:27 INFO - 'talos_options': ['--disable-e10s'], 13:45:27 INFO - 'tests': ['damp', 'tps']}, 13:45:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:27 INFO - 'tests': ['damp', 'tps']}, 13:45:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:45:27 INFO - 'tests': ['dromaeo_dom']}, 13:45:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:45:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:45:27 INFO - 'tests': ['basic_compositor_video']}, 13:45:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:45:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:45:27 INFO - 'tests': ['a11yr', 13:45:27 INFO - 'ts_paint', 13:45:27 INFO - 'tpaint', 13:45:27 INFO - 'sessionrestore', 13:45:27 INFO - 'sessionrestore_no_auto_restore', 13:45:27 INFO - 'tabpaint']}, 13:45:27 INFO - 'other-e10s': {'tests': ['a11yr', 13:45:27 INFO - 'ts_paint', 13:45:27 INFO - 'tpaint', 13:45:27 INFO - 'sessionrestore', 13:45:27 INFO - 'sessionrestore_no_auto_restore', 13:45:27 INFO - 'tabpaint']}, 13:45:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:45:27 INFO - 'ts_paint', 13:45:27 INFO - 'tpaint', 13:45:27 INFO - 'sessionrestore', 13:45:27 INFO - 'sessionrestore_no_auto_restore', 13:45:27 INFO - 'tabpaint']}, 13:45:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:45:27 INFO - 'ts_paint', 13:45:27 INFO - 'tpaint', 13:45:27 INFO - 'sessionrestore', 13:45:27 INFO - 'sessionrestore_no_auto_restore', 13:45:27 INFO - 'tabpaint']}, 13:45:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:45:27 INFO - 'tests': ['a11yr', 13:45:27 INFO - 'ts_paint', 13:45:27 INFO - 'tpaint', 13:45:27 INFO - 'sessionrestore', 13:45:27 INFO - 'sessionrestore_no_auto_restore', 13:45:27 INFO - 'tabpaint']}, 13:45:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:45:27 INFO - 'tests': ['a11yr', 13:45:27 INFO - 'ts_paint', 13:45:27 INFO - 'tpaint', 13:45:27 INFO - 'sessionrestore', 13:45:27 INFO - 'sessionrestore_no_auto_restore', 13:45:27 INFO - 'tabpaint']}, 13:45:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:45:27 INFO - 'tests': ['tsvgx', 13:45:27 INFO - 'tsvgr_opacity', 13:45:27 INFO - 'tart', 13:45:27 INFO - 'tscrollx', 13:45:27 INFO - 'cart']}, 13:45:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:45:27 INFO - 'tsvgr_opacity', 13:45:27 INFO - 'tart', 13:45:27 INFO - 'tscrollx', 13:45:27 INFO - 'cart']}, 13:45:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:27 INFO - 'talos_options': ['--disable-e10s'], 13:45:27 INFO - 'tests': ['tp5o']}, 13:45:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:27 INFO - 'tests': ['tp5o']}, 13:45:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:27 INFO - 'talos_options': ['--disable-e10s', 13:45:27 INFO - '--xperf_path', 13:45:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:45:27 INFO - 'tests': ['tp5n']}, 13:45:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:27 INFO - 'talos_options': ['--xperf_path', 13:45:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:45:27 INFO - 'tests': ['tp5n']}}, 13:45:27 INFO - 'talos.zip': {'path': '', 13:45:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:45:27 INFO - Running post-action listener: _resource_record_post_action 13:45:27 INFO - [mozharness: 2016-08-19 20:45:27.126070Z] Finished populate-webroot step (success) 13:45:27 INFO - [mozharness: 2016-08-19 20:45:27.126164Z] Running create-virtualenv step. 13:45:27 INFO - Running pre-action listener: _resource_record_pre_action 13:45:27 INFO - Running main action method: create_virtualenv 13:45:27 INFO - Creating virtualenv /builds/slave/test/build/venv 13:45:27 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 13:45:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:45:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:45:27 INFO - Using real prefix '/tools/python27' 13:45:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:45:27 INFO - Installing distribute.............................................................................................................................................................................................done. 13:45:30 INFO - Installing pip.................done. 13:45:30 INFO - Return code: 0 13:45:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:45:30 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')]} 13:45:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:30 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')]} 13:45:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:30 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 0x10503da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050d2618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fedbbd81190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fa1d30>, '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 0x104d06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f99b20>, '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.kn1ylyn9xf/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.O3vBRCIqRT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 13:45:30 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 13:45:30 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 13:45:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kn1ylyn9xf/Render', 13:45:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:45:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:45:30 INFO - 'HOME': '/Users/cltbld', 13:45:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:45:30 INFO - 'LOGNAME': 'cltbld', 13:45:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:30 INFO - 'MOZ_NO_REMOTE': '1', 13:45:30 INFO - 'NO_EM_RESTART': '1', 13:45:30 INFO - 'PAGER': '/bin/cat', 13:45:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:45:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:30 INFO - 'PWD': '/builds/slave/test', 13:45:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:45:30 INFO - 'SHELL': '/bin/bash', 13:45:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O3vBRCIqRT/Listeners', 13:45:30 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 13:45:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:45:30 INFO - 'USER': 'cltbld', 13:45:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:45:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:45:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:30 INFO - 'XPC_FLAGS': '0x0', 13:45:30 INFO - 'XPC_SERVICE_NAME': '0', 13:45:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:45:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:31 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 13:45:31 INFO - Cleaning up... 13:45:31 INFO - Return code: 0 13:45:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:45:31 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')]} 13:45:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:31 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')]} 13:45:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:31 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 0x10503da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050d2618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fedbbd81190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fa1d30>, '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 0x104d06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f99b20>, '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.kn1ylyn9xf/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.O3vBRCIqRT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 13:45:31 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 13:45:31 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 13:45:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kn1ylyn9xf/Render', 13:45:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:45:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:45:31 INFO - 'HOME': '/Users/cltbld', 13:45:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:45:31 INFO - 'LOGNAME': 'cltbld', 13:45:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:31 INFO - 'MOZ_NO_REMOTE': '1', 13:45:31 INFO - 'NO_EM_RESTART': '1', 13:45:31 INFO - 'PAGER': '/bin/cat', 13:45:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:45:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:31 INFO - 'PWD': '/builds/slave/test', 13:45:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:45:31 INFO - 'SHELL': '/bin/bash', 13:45:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O3vBRCIqRT/Listeners', 13:45:31 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 13:45:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:45:31 INFO - 'USER': 'cltbld', 13:45:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:45:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:45:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:31 INFO - 'XPC_FLAGS': '0x0', 13:45:31 INFO - 'XPC_SERVICE_NAME': '0', 13:45:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:45:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:31 INFO - Downloading/unpacking psutil>=3.1.1 13:45: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 13:45: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 13:45: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 13:45: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 13:45: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 13:45: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 13:45:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:45:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:45:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:45:34 INFO - Installing collected packages: psutil 13:45:34 INFO - Running setup.py install for psutil 13:45:34 INFO - building 'psutil._psutil_osx' extension 13:45:34 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 13:45:35 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 13:45:35 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 13:45:35 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 13:45:35 INFO - building 'psutil._psutil_posix' extension 13:45:35 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 13:45:35 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:45:35 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:45:35 INFO - ^ 13:45:35 INFO - 1 warning generated. 13:45:35 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 13:45:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:45:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:45:35 INFO - Successfully installed psutil 13:45:35 INFO - Cleaning up... 13:45:35 INFO - Return code: 0 13:45:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:45: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')]} 13:45:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45: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')]} 13:45:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10503da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050d2618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fedbbd81190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fa1d30>, '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 0x104d06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f99b20>, '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.kn1ylyn9xf/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.O3vBRCIqRT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 13:45: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:45: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 mozsystemmonitor==0.3 13:45:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kn1ylyn9xf/Render', 13:45:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:45:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:45:35 INFO - 'HOME': '/Users/cltbld', 13:45:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:45:35 INFO - 'LOGNAME': 'cltbld', 13:45:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:35 INFO - 'MOZ_NO_REMOTE': '1', 13:45:35 INFO - 'NO_EM_RESTART': '1', 13:45:35 INFO - 'PAGER': '/bin/cat', 13:45:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:45:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:35 INFO - 'PWD': '/builds/slave/test', 13:45:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:45:35 INFO - 'SHELL': '/bin/bash', 13:45:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O3vBRCIqRT/Listeners', 13:45:35 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 13:45:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:45:35 INFO - 'USER': 'cltbld', 13:45:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:45:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:45:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:35 INFO - 'XPC_FLAGS': '0x0', 13:45:35 INFO - 'XPC_SERVICE_NAME': '0', 13:45:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:45:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:45:36 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 13:45:36 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 13:45:36 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 13:45:36 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 13:45:36 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 13:45:36 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 13:45:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:45:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:45:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:45:38 INFO - Installing collected packages: mozsystemmonitor 13:45:38 INFO - Running setup.py install for mozsystemmonitor 13:45:38 INFO - Successfully installed mozsystemmonitor 13:45:38 INFO - Cleaning up... 13:45:38 INFO - Return code: 0 13:45:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:45:38 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')]} 13:45:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:38 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')]} 13:45:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:38 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 0x10503da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050d2618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fedbbd81190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fa1d30>, '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 0x104d06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f99b20>, '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.kn1ylyn9xf/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.O3vBRCIqRT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 13:45:38 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 13:45:38 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 13:45:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kn1ylyn9xf/Render', 13:45:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:45:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:45:38 INFO - 'HOME': '/Users/cltbld', 13:45:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:45:38 INFO - 'LOGNAME': 'cltbld', 13:45:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:38 INFO - 'MOZ_NO_REMOTE': '1', 13:45:38 INFO - 'NO_EM_RESTART': '1', 13:45:38 INFO - 'PAGER': '/bin/cat', 13:45:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:45:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:38 INFO - 'PWD': '/builds/slave/test', 13:45:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:45:38 INFO - 'SHELL': '/bin/bash', 13:45:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O3vBRCIqRT/Listeners', 13:45:38 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 13:45:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:45:38 INFO - 'USER': 'cltbld', 13:45:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:45:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:45:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:38 INFO - 'XPC_FLAGS': '0x0', 13:45:38 INFO - 'XPC_SERVICE_NAME': '0', 13:45:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:45:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:39 INFO - Downloading/unpacking jsonschema==2.5.1 13:45:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:45:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:45:41 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 13:45:41 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 13:45:41 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 13:45:41 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 13:45:41 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 13:45:41 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 13:45:42 INFO - Downloading functools32-3.2.3-2.tar.gz 13:45:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:45:42 INFO - warning: no files found matching '*.txt' 13:45:42 INFO - no previously-included directories found matching 'build' 13:45:42 INFO - no previously-included directories found matching 'dist' 13:45:42 INFO - no previously-included directories found matching '.git*' 13:45:42 INFO - Installing collected packages: jsonschema, functools32 13:45:42 INFO - Running setup.py install for functools32 13:45:42 INFO - warning: no files found matching '*.txt' 13:45:42 INFO - no previously-included directories found matching 'build' 13:45:42 INFO - no previously-included directories found matching 'dist' 13:45:42 INFO - no previously-included directories found matching '.git*' 13:45:42 INFO - Successfully installed jsonschema functools32 13:45:42 INFO - Cleaning up... 13:45:42 INFO - Return code: 0 13:45:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:45:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:45:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:45:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10503da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050d2618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fedbbd81190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fa1d30>, '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 0x104d06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f99b20>, '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.kn1ylyn9xf/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.O3vBRCIqRT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 13:45:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:45:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 13:45:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kn1ylyn9xf/Render', 13:45:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:45:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:45:42 INFO - 'HOME': '/Users/cltbld', 13:45:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:45:42 INFO - 'LOGNAME': 'cltbld', 13:45:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:42 INFO - 'MOZ_NO_REMOTE': '1', 13:45:42 INFO - 'NO_EM_RESTART': '1', 13:45:42 INFO - 'PAGER': '/bin/cat', 13:45:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:45:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:42 INFO - 'PWD': '/builds/slave/test', 13:45:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:45:42 INFO - 'SHELL': '/bin/bash', 13:45:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O3vBRCIqRT/Listeners', 13:45:42 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 13:45:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:45:42 INFO - 'USER': 'cltbld', 13:45:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:45:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:45:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:42 INFO - 'XPC_FLAGS': '0x0', 13:45:42 INFO - 'XPC_SERVICE_NAME': '0', 13:45:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:45:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:45:42 INFO - Cleaning up... 13:45:42 INFO - Return code: 0 13:45:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:45:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:45:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:45:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10503da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050d2618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fedbbd81190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fa1d30>, '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 0x104d06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f99b20>, '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.kn1ylyn9xf/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.O3vBRCIqRT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 13:45:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:45:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:45:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kn1ylyn9xf/Render', 13:45:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:45:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:45:42 INFO - 'HOME': '/Users/cltbld', 13:45:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:45:42 INFO - 'LOGNAME': 'cltbld', 13:45:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:42 INFO - 'MOZ_NO_REMOTE': '1', 13:45:42 INFO - 'NO_EM_RESTART': '1', 13:45:42 INFO - 'PAGER': '/bin/cat', 13:45:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:45:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:42 INFO - 'PWD': '/builds/slave/test', 13:45:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:45:42 INFO - 'SHELL': '/bin/bash', 13:45:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O3vBRCIqRT/Listeners', 13:45:42 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 13:45:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:45:42 INFO - 'USER': 'cltbld', 13:45:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:45:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:45:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:42 INFO - 'XPC_FLAGS': '0x0', 13:45:42 INFO - 'XPC_SERVICE_NAME': '0', 13:45:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:45:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:42 INFO - Downloading/unpacking blobuploader==1.2.4 13:45:42 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 13:45:42 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 13:45:42 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 13:45:42 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 13:45:42 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 13:45:42 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 13:45:45 INFO - Downloading blobuploader-1.2.4.tar.gz 13:45:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:45:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:45:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:45:46 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 13:45:46 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 13:45:46 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 13:45:46 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 13:45:46 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 13:45:46 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 13:45:46 INFO - Downloading docopt-0.6.1.tar.gz 13:45:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:45:46 INFO - Installing collected packages: blobuploader, requests, docopt 13:45:46 INFO - Running setup.py install for blobuploader 13:45:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:45:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:45:46 INFO - Running setup.py install for requests 13:45:47 INFO - Running setup.py install for docopt 13:45:47 INFO - Successfully installed blobuploader requests docopt 13:45:47 INFO - Cleaning up... 13:45:47 INFO - Return code: 0 13:45:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:45:47 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')]} 13:45:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:47 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')]} 13:45:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:47 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 0x10503da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050d2618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fedbbd81190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fa1d30>, '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 0x104d06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f99b20>, '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.kn1ylyn9xf/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.O3vBRCIqRT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 13:45:47 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 13:45:47 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 13:45:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kn1ylyn9xf/Render', 13:45:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:45:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:45:47 INFO - 'HOME': '/Users/cltbld', 13:45:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:45:47 INFO - 'LOGNAME': 'cltbld', 13:45:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:47 INFO - 'MOZ_NO_REMOTE': '1', 13:45:47 INFO - 'NO_EM_RESTART': '1', 13:45:47 INFO - 'PAGER': '/bin/cat', 13:45:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:45:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:47 INFO - 'PWD': '/builds/slave/test', 13:45:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:45:47 INFO - 'SHELL': '/bin/bash', 13:45:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O3vBRCIqRT/Listeners', 13:45:47 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 13:45:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:45:47 INFO - 'USER': 'cltbld', 13:45:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:45:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:45:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:47 INFO - 'XPC_FLAGS': '0x0', 13:45:47 INFO - 'XPC_SERVICE_NAME': '0', 13:45:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:45:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:45:47 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-tMFu5U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:45:48 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-om5mek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:45:48 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-ZvVKRg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:45:48 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-I6ctkP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:45:48 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-FtxsBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:45:48 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-fLaqjd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:45:48 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-I0qXgG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:45:48 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-nAurwa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:45:48 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-ls3BBv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:45:48 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-D8k0cY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:45:48 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-TnatL2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:45:49 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-TzJOmf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:45:49 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-FP6wGj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:45:49 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-saU35d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:45:49 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-APb80D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:45:49 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-riWU11-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:45:49 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-IS7X0s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:45:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:45:49 INFO - Running setup.py install for manifestparser 13:45:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:45:49 INFO - Running setup.py install for mozcrash 13:45:49 INFO - Running setup.py install for mozdebug 13:45:50 INFO - Running setup.py install for mozdevice 13:45:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:45:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:45:50 INFO - Running setup.py install for mozfile 13:45:50 INFO - Running setup.py install for mozhttpd 13:45:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:45:50 INFO - Running setup.py install for mozinfo 13:45:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:45:50 INFO - Running setup.py install for mozInstall 13:45:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:45:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:45:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:45:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:45:50 INFO - Running setup.py install for mozleak 13:45:50 INFO - Running setup.py install for mozlog 13:45:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:45:51 INFO - Running setup.py install for moznetwork 13:45:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:45:51 INFO - Running setup.py install for mozprocess 13:45:51 INFO - Running setup.py install for mozprofile 13:45:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:45:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:45:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:45:51 INFO - Running setup.py install for mozrunner 13:45:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:45:51 INFO - Running setup.py install for mozscreenshot 13:45:51 INFO - Running setup.py install for moztest 13:45:52 INFO - Running setup.py install for mozversion 13:45:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:45:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:45:52 INFO - Cleaning up... 13:45:52 INFO - Return code: 0 13:45:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:45:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:45:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:45:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:52 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 0x10503da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050d2618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fedbbd81190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fa1d30>, '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 0x104d06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f99b20>, '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.kn1ylyn9xf/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.O3vBRCIqRT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 13:45:52 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 13:45:52 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 13:45:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kn1ylyn9xf/Render', 13:45:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:45:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:45:52 INFO - 'HOME': '/Users/cltbld', 13:45:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:45:52 INFO - 'LOGNAME': 'cltbld', 13:45:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:52 INFO - 'MOZ_NO_REMOTE': '1', 13:45:52 INFO - 'NO_EM_RESTART': '1', 13:45:52 INFO - 'PAGER': '/bin/cat', 13:45:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:45:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:52 INFO - 'PWD': '/builds/slave/test', 13:45:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:45:52 INFO - 'SHELL': '/bin/bash', 13:45:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O3vBRCIqRT/Listeners', 13:45:52 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 13:45:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:45:52 INFO - 'USER': 'cltbld', 13:45:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:45:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:45:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:52 INFO - 'XPC_FLAGS': '0x0', 13:45:52 INFO - 'XPC_SERVICE_NAME': '0', 13:45:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:45:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:45:52 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-9YLJLj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:45:52 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)) 13:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:45:52 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-TspuZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:45:52 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)) 13:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:45:52 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-H2RHG8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:45:52 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)) 13:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:45:52 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-ltyInS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:45:52 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)) 13:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:45:52 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-4Qj3Ha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:45:53 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)) 13:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:45:53 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-OBUZQZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:45:53 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)) 13:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:45:53 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-jyzyuw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:45:53 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)) 13:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:45:53 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-rggKtW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:45:53 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)) 13:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:45:53 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-UOMGDJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:45:53 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)) 13:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:45:53 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-xBM88s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:45:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 13:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:45:53 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-5msF7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:45:53 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)) 13:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:45:53 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-d4MxI8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:45:53 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)) 13:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:45:53 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-jqjR03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:45:53 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)) 13:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:45:53 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-6SWHEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:45:54 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)) 13:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:45:54 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-nBi7Qs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:45:54 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)) 13:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:45:54 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-80clQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:45:54 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)) 13:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:45:54 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-5RP4QE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:45:54 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)) 13:45:54 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)) 13:45:54 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)) 13:45:54 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)) 13:45:54 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)) 13:45:54 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)) 13:45:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:45:54 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 13:45:54 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 13:45:54 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 13:45:54 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 13:45:54 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 13:45:54 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 13:45:57 INFO - Downloading blessings-1.6.tar.gz 13:45:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:45:57 INFO - Installing collected packages: blessings 13:45:57 INFO - Running setup.py install for blessings 13:45:57 INFO - Successfully installed blessings 13:45:57 INFO - Cleaning up... 13:45:57 INFO - Return code: 0 13:45:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:45:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:45:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:45:57 INFO - Reading from file tmpfile_stdout 13:45:57 INFO - Current package versions: 13:45:57 INFO - blessings == 1.6 13:45:57 INFO - blobuploader == 1.2.4 13:45:57 INFO - docopt == 0.6.1 13:45:57 INFO - functools32 == 3.2.3-2 13:45:57 INFO - jsonschema == 2.5.1 13:45:57 INFO - manifestparser == 1.1 13:45:57 INFO - mozInstall == 1.12 13:45:57 INFO - mozcrash == 0.17 13:45:57 INFO - mozdebug == 0.1 13:45:57 INFO - mozdevice == 0.48 13:45:57 INFO - mozfile == 1.2 13:45:57 INFO - mozhttpd == 0.7 13:45:57 INFO - mozinfo == 0.9 13:45:57 INFO - mozleak == 0.1 13:45:57 INFO - mozlog == 3.3 13:45:57 INFO - moznetwork == 0.27 13:45:57 INFO - mozprocess == 0.23 13:45:57 INFO - mozprofile == 0.28 13:45:57 INFO - mozrunner == 6.12 13:45:57 INFO - mozscreenshot == 0.1 13:45:57 INFO - mozsystemmonitor == 0.3 13:45:57 INFO - moztest == 0.7 13:45:57 INFO - mozversion == 1.4 13:45:57 INFO - psutil == 3.1.1 13:45:57 INFO - requests == 1.2.3 13:45:57 INFO - wsgiref == 0.1.2 13:45:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:45:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:45:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:45:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:58 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 0x10503da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050d2618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fedbbd81190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fa1d30>, '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 0x104d06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f99b20>, '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.kn1ylyn9xf/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.O3vBRCIqRT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 13:45:58 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 13:45:58 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 13:45:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kn1ylyn9xf/Render', 13:45:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:45:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:45:58 INFO - 'HOME': '/Users/cltbld', 13:45:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:45:58 INFO - 'LOGNAME': 'cltbld', 13:45:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:58 INFO - 'MOZ_NO_REMOTE': '1', 13:45:58 INFO - 'NO_EM_RESTART': '1', 13:45:58 INFO - 'PAGER': '/bin/cat', 13:45:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:45:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:58 INFO - 'PWD': '/builds/slave/test', 13:45:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:45:58 INFO - 'SHELL': '/bin/bash', 13:45:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O3vBRCIqRT/Listeners', 13:45:58 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 13:45:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:45:58 INFO - 'USER': 'cltbld', 13:45:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:45:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:45:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:58 INFO - 'XPC_FLAGS': '0x0', 13:45:58 INFO - 'XPC_SERVICE_NAME': '0', 13:45:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:45:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:58 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)) 13:45:58 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)) 13:45:58 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)) 13:45:58 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)) 13:45:58 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)) 13:45:58 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)) 13:45:58 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)) 13:45:58 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)) 13:45:58 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)) 13:45:58 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)) 13:45:58 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)) 13:45:58 INFO - Cleaning up... 13:45:58 INFO - Return code: 0 13:45:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:45:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:45:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:45:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10503da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050d2618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fedbbd81190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fa1d30>, '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 0x104d06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f99b20>, '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.kn1ylyn9xf/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.O3vBRCIqRT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 13:45:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:45:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:45:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kn1ylyn9xf/Render', 13:45:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:45:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:45:58 INFO - 'HOME': '/Users/cltbld', 13:45:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:45:58 INFO - 'LOGNAME': 'cltbld', 13:45:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:58 INFO - 'MOZ_NO_REMOTE': '1', 13:45:58 INFO - 'NO_EM_RESTART': '1', 13:45:58 INFO - 'PAGER': '/bin/cat', 13:45:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:45:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:58 INFO - 'PWD': '/builds/slave/test', 13:45:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:45:58 INFO - 'SHELL': '/bin/bash', 13:45:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O3vBRCIqRT/Listeners', 13:45:58 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 13:45:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:45:58 INFO - 'USER': 'cltbld', 13:45:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:45:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:45:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:58 INFO - 'XPC_FLAGS': '0x0', 13:45:58 INFO - 'XPC_SERVICE_NAME': '0', 13:45:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:45:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:45:58 INFO - Cleaning up... 13:45:58 INFO - Return code: 0 13:45:58 INFO - Running post-action listener: _resource_record_post_action 13:45:58 INFO - Running post-action listener: _start_resource_monitoring 13:45:58 INFO - Starting resource monitoring. 13:45:58 INFO - [mozharness: 2016-08-19 20:45:58.789656Z] Finished create-virtualenv step (success) 13:45:58 INFO - [mozharness: 2016-08-19 20:45:58.790639Z] Running install step. 13:45:58 INFO - Running pre-action listener: _resource_record_pre_action 13:45:58 INFO - Running main action method: install 13:45:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:45:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:45:59 INFO - Reading from file tmpfile_stdout 13:45:59 INFO - Detecting whether we're running mozinstall >=1.0... 13:45:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:45:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:45:59 INFO - Reading from file tmpfile_stdout 13:45:59 INFO - Output received: 13:45:59 INFO - Usage: mozinstall [options] installer 13:45:59 INFO - Options: 13:45:59 INFO - -h, --help show this help message and exit 13:45:59 INFO - -d DEST, --destination=DEST 13:45:59 INFO - Directory to install application into. [default: 13:45:59 INFO - "/builds/slave/test"] 13:45:59 INFO - --app=APP Application being installed. [default: firefox] 13:45:59 INFO - mkdir: /builds/slave/test/build/application 13:45:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 13:45:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 13:46:33 INFO - Reading from file tmpfile_stdout 13:46:33 INFO - Output received: 13:46:33 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 13:46:33 INFO - Running post-action listener: _resource_record_post_action 13:46:33 INFO - [mozharness: 2016-08-19 20:46:33.694948Z] Finished install step (success) 13:46:33 INFO - [mozharness: 2016-08-19 20:46:33.695107Z] Running run-tests step. 13:46:33 INFO - Running pre-action listener: _resource_record_pre_action 13:46:33 INFO - Running main action method: run_tests 13:46:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:46:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:46:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:46:33 INFO - 2016-08-19 13:46:33.707 screenresolution[1635:7507] starting screenresolution argv=screenresolution get 13:46:33 INFO - 2016-08-19 13:46:33.710 screenresolution[1635:7507] Display 0: 1600x1200x32@60 13:46:33 INFO - 2016-08-19 13:46:33.715 screenresolution[1636:7509] starting screenresolution argv=screenresolution list 13:46:33 INFO - Available Modes on Display 0 13:46:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:46:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:46:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:46:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:46:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:46:33 INFO - Intel Iris: 13:46:33 INFO - Chipset Model: Intel Iris 13:46:33 INFO - Type: GPU 13:46:33 INFO - Bus: Built-In 13:46:33 INFO - VRAM (Dynamic, Max): 1536 MB 13:46:33 INFO - Vendor: Intel (0x8086) 13:46:33 INFO - Device ID: 0x0a2e 13:46:33 INFO - Revision ID: 0x0009 13:46:33 INFO - Displays: 13:46:33 INFO - Display: 13:46:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:46:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:46:33 INFO - Display Serial Number: 1600x1200 60 13:46:33 INFO - Main Display: Yes 13:46:33 INFO - Mirror: Off 13:46:33 INFO - Online: Yes 13:46:33 INFO - Rotation: Supported 13:46:33 INFO - Return code: 0 13:46:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:46:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:46:33 INFO - Python 2.7.3 13:46:33 INFO - Return code: 0 13:46:33 INFO - grabbing minidump binary from tooltool 13:46:33 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')]} 13:46:33 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 0x104fa1d30>, '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 0x104d06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f99b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:46:33 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 13:46:33 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 13:46:33 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 13:46:34 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:46:34 INFO - Return code: 0 13:46:34 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:46:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:46:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:46:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:46:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:46:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/X7wbiwOiQFGQ64rIAW6KAg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0286', '--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 13:46:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/X7wbiwOiQFGQ64rIAW6KAg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0286 --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 13:46:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kn1ylyn9xf/Render', 13:46:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:46:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:46:34 INFO - 'HOME': '/Users/cltbld', 13:46:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:46:34 INFO - 'LOGNAME': 'cltbld', 13:46:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:46:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:46:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:46:34 INFO - 'MOZ_NO_REMOTE': '1', 13:46:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:46:34 INFO - 'NO_EM_RESTART': '1', 13:46:34 INFO - 'PAGER': '/bin/cat', 13:46:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:46:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:46:34 INFO - 'PWD': '/builds/slave/test', 13:46:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:46:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:46:34 INFO - 'SHELL': '/bin/bash', 13:46:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O3vBRCIqRT/Listeners', 13:46:34 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 13:46:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:46:34 INFO - 'USER': 'cltbld', 13:46:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:46:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:46:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:46:34 INFO - 'XPC_FLAGS': '0x0', 13:46:34 INFO - 'XPC_SERVICE_NAME': '0', 13:46:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:46:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/X7wbiwOiQFGQ64rIAW6KAg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0286', '--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 13:46:34 INFO - mozversion application_buildid: 20160819102824 13:46:34 INFO - mozversion application_changeset: 6b1f62a32be285d0d8956629b2860fb5212bc8de 13:46:34 INFO - mozversion application_display_name: Nightly 13:46:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:46:34 INFO - mozversion application_name: Firefox 13:46:34 INFO - mozversion application_remotingname: firefox 13:46:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:46:34 INFO - mozversion application_vendor: Mozilla 13:46:34 INFO - mozversion application_version: 51.0a1 13:46:34 INFO - mozversion platform_buildid: 20160819102824 13:46:34 INFO - mozversion platform_changeset: 6b1f62a32be285d0d8956629b2860fb5212bc8de 13:46:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:46:34 INFO - mozversion platform_version: 51.0a1 13:46:34 INFO - using testdate: 1471639594 13:46:34 INFO - actual date: 1471639594 13:46:34 INFO - starting webserver on 'localhost:49269' 13:46:34 INFO - SUITE-START | Running 2 tests 13:46:34 INFO - TEST-START | dromaeo_css 13:46:34 INFO - operating with platform_type : mac_ 13:46:34 INFO - Initialising browser for dromaeo_css test... 13:46:34 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/tmpFkFrUf/profile http://localhost:49269/getInfo.html) 13:46:37 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 13:46:37 INFO - PROCESS | 1649 | colorDepth:24 13:46:37 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 13:46:37 INFO - PROCESS | 1649 | __metrics 13:46:37 INFO - PROCESS | 1649 | 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" 13:46:37 INFO - PROCESS | 1649 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:46:37 INFO - PROCESS | 1649 | ************************* 13:46:37 INFO - PROCESS | 1649 | A coding exception was thrown in a Promise resolution callback. 13:46:37 INFO - PROCESS | 1649 | See https://developer.mozilla.org/Mozilla/JavaScript_code_modules/Promise.jsm/Promise 13:46:37 INFO - PROCESS | 1649 | 13:46:37 ERROR - PROCESS | 1649 | Full message: TypeError: win is null 13:46:37 INFO - PROCESS | 1649 | Full stack: onSuccess@resource://app/components/nsBrowserGlue.js:758:17 13:46:37 INFO - PROCESS | 1649 | Handler.prototype.process@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:937:23 13:46:37 INFO - PROCESS | 1649 | this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:816:7 13:46:37 INFO - PROCESS | 1649 | Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:747:11 13:46:37 INFO - PROCESS | 1649 | this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:779:7 13:46:37 INFO - PROCESS | 1649 | this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:714:7 13:46:37 INFO - PROCESS | 1649 | get _worker/worker.onmessage@resource://gre/modules/PromiseWorker.jsm:235:9 13:46:37 INFO - PROCESS | 1649 | Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:551:9 13:46:37 INFO - PROCESS | 1649 | 13:46:37 INFO - PROCESS | 1649 | ************************* 13:46:37 INFO - TEST-INFO | 1649: exit 0 13:46:37 INFO - Browser initialized. 13:46:37 INFO - Running cycle 1/1 for dromaeo_css test... 13:46:37 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/tmpFkFrUf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:46:49 INFO - PROCESS | 1651 | RSS: Main: 243707904 13:46:49 INFO - PROCESS | 1651 | 13:47:41 INFO - PROCESS | 1651 | 1471639661763 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] 13:49:53 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49269/tests/dromaeo/cssquery-ext.html) 13:49:54 INFO - PROCESS | 1651 | RSS: Main: 343257088 13:49:54 INFO - PROCESS | 1651 | 13:52:57 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-ext.html (next: http://localhost:49269/tests/dromaeo/cssquery-jquery.html) 13:52:57 INFO - PROCESS | 1651 | RSS: Main: 384749568 13:52:57 INFO - PROCESS | 1651 | 13:56:00 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49269/tests/dromaeo/cssquery-mootools.html) 13:56:00 INFO - PROCESS | 1651 | RSS: Main: 376602624 13:56:00 INFO - PROCESS | 1651 | 13:59:03 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49269/tests/dromaeo/cssquery-prototype.html) 13:59:03 INFO - PROCESS | 1651 | RSS: Main: 346218496 13:59:03 INFO - PROCESS | 1651 | 14:02:07 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49269/tests/dromaeo/cssquery-yui.html) 14:02:07 INFO - PROCESS | 1651 | RSS: Main: 344342528 14:02:07 INFO - PROCESS | 1651 | 14:05:11 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-yui.html (next: http://localhost:49269/tests/dromaeo/cssquery-dojo.html) 14:05:11 INFO - PROCESS | 1651 | RSS: Main: 441085952 14:05:11 INFO - PROCESS | 1651 | 14:05:11 INFO - PROCESS | 1651 | __start_tp_report 14:05:11 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 14:05:11 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 14:05:11 INFO - PROCESS | 1651 | |i|pagename|runs| 14:05:11 INFO - PROCESS | 1651 | |0;dojo.html;3351.5307856900035;3377.3076519313536;3384.830758462076;3397.3714862750408;3420.931581368373;5671.943280567193;5701.173329867167;5737.225474560938;5822.796202132931;5833.30000399952;5439.99999999999;5708.628939118955;5756.941356343778;5797.623154494955;5801.361850196486;5179.533841954223;5202.531772140506;5208.947910520884;5293.444188360225;5323.893522129574;5322;5352.116900711378;5354.063038968185;5354.303940487731;5361.490658387447;5141.485851414866;5255.474452554714;5282.418933917266;5328.653637513568;5337.919931201035;5188.688678679291;5252.343457067866;5253.7635806388425;5257.342832145981;5262.684238945637;5091.363579552556;5127.282180494733;5129.153689641242;5151.742412879341;5170.276161337416;5592;5650;5702.8289151325525;5718.34239062509;5722.97138514309;6117.449429551361;6160.1375807387;6186.041163619646;6191.504679625619;6208.844778880564;6273.247210334744;6294.0873573332065;6332.208473940757;6338.809835704937;6366.395192456709;5882.441168089024;5894.469497745224;5914.231149950522;5915.674637894957;5922.200502932135;6179.104029915727;6252;6280.466160376328;6305.873882522324;6355.110284560165;6229.314775374705;6232.034034724625;6244.469220116341;6246.406591373812;6257.749690012349;5292.259083728281;6298.716557754912;6316.968415157987;6317.210348706411;6334.683265836689;4595.655325850575;6098.817035488943;6185.628862268279;6263.686815659199;6303.779367722108;6265.373462653698;6282;6319.747210111544;6324.43080122782;6333.68331583419;4985.177445721415;4996.625253105959;5002.299678045077;5011.899762004739;5013.573846223112;4421.734695918255;4424.889377765581;4472.329150627367;4505.797239124247;4539.228331183706;5742.167385729046;5840.2115714378015;5849.181114643953;5849.5027922626205;5854.473097421167;6300.464460520815;6319.652419116993;6334;6334.1765570475545;6334.461570766444;5601.747921343549;5691.943080569225;5836.591438599257;5848.912266316009;5866.178734977107;5407.107827208545;5473.644213126134;5487.5884308677005;5494.2582751328055;5498.697571633598;6274.058891166362;6308.211473565804;6312.43188113072;6329.683515824282;6335.904961425675;6176.752929882934;6252.030935205051;6282.654454005074;6295.937040629535;6350.396712312323;6268.780592679234;6295.779647712308;6334.176557047738;6336.144620476177;6343.175387199634;6245.5628106032145;6276.497880169667;6277.96861015692;6285.842853928505;6288.371162883675;6165;6239.1577137087725;6314.463270622048;6319.905201422074;6325.493960483058;6067.969660151847;6134.509239260759;6187.752489900354;6209.472194863487;6259.374062593704;5479.808206712746;6219.253689557282;6231.283402408781;6232.657203853832;6242.812715618538;5883.441073098049;5958.106284057253;6069.51443884497;6103.298120715996;6119.357467465852;6145.477634401126;6237.157983672146;6237.781677641261;6251.343608920998;6252.687365631791;6042.214512113397;6057.18228039209;6059.3334733178435;6071.453569178795;6076.088586712029 14:05:11 INFO - PROCESS | 1651 | |1;ext.html;492.719150084452;504.5282660712233;517.8627663669128;524.8031988004499;541.9648471419589;40093;41598.58401415985;41844.372334415006;43782.467613633526;43901.341479877825;42420;43054.354184687254;43092.78453607728;43150.7842460788;43267;8582.442141260799;9271.67549135782;9935.900640993606;9967.750806229866;9973.252006099536;9857;9986.600535978552;9991.800163996715;9994.300398972075;10019.549120289568;9959.502024898726;10013.94993025034;10028.147607453338;10036.598536058586;10042.598296068149;9935.00649935008;9969.451680157588;9981.70054898347;9991.450470224136;10016.298859079867;9696.951515242448;9795.559199836025;9798.608055677765;9798.951005244999;9803.607855685765;40836.795816021026;41308.58691413078;41338;41352.172956541;41411;3337.8998630041137;3473.7915725056578;3481;3667.174885650734;3897.1099016976746;31153.532697009563;31576;31747.88882389105;32041.51937720936;32273.1931701707;3238.77328586999;3281.376538457709;3290.2103495161227;3295.9176020599675;3379.4422231603944;491471.4264286771;491767.5411622955;492049;492587;501133;60300.79398412007;60543.78912421727;60545;60698;60725.69637151786;34074.97775066752;34493.13767155791;34770.130746731535;63734.0439893402;64000.67999659972;16498.092604906844;16634.58413539671;16648.500544983668;16662.666746665;16664.50006499807;12810.615681529569;12859.871401286055;12865.48538058486;12868.970482361388;12871.099023068295;18955.90522047381;19000.61998760017;19151.904240478987;19170.424887253404;19210.231590736494;7751.379889608817;7889.09275433321;7928.563928983961;7979.3616510679;7992.920070799334;799.1648727080216;871.6600525794945;874.606427107804;1081.7944590527775;1103.426218366445;29800.40399192004;30060.398792024036;30264.69735302619;30554.847225764173;30596.388072238875;826.7478419082238;1052.615810209572;1077.4774234496263;1149.6263714292888;1156.173336064701;15324.15717135546;15627.687446251011;15671.294791734399;15706.214689265491;15884.285207165705;668261;672008;672769;674228;674661.6266918634;56992;57577;57717;57718;57752;1254.4104270992618;1303.641498587896;1388.8611138886233;1414.4059495012325;1415.0448447298238;26818.06136785203;28246.011389601266;32030.839845800623;32058.67941320557;32970.17574560655;50931.745341273054;51474.485255148466;51552;51594.484055158966;51698.22452663138;558653;564390;565379;566951;567758;23315.417114572272;26566.867165664047;27303.863480683263;27489;28364.716352837033;43444.56555434405;45986.62040138801;47823;48266;49802.25296620626;34927.82536087303;36325.636743632225;39390.40914386229;39958.800205998785;41162.588374115876;39280;40067.39898901577;40714.59285407227;41029;41090.79454602708;38132.237355253295;38487.2302553953;38589;38656.2268754629;39012.2197556053;33850.153746156546;34638.480422793175;35392.646073538934;35455.64544354523;35522.467162992056;24583.877080614482;25184.11855585046;25300.620490692287;25532;25700.357491062125 14:05:11 INFO - PROCESS | 1651 | |2;jquery.html;350.6055687351729;355.1086772201773;373.52375720955797;384.73068851803737;404.3389058888716;15912.602184945368;16791.1604419779;21473.14107435701;21560;21634.459138521546;20479.897600512013;20645.793542064574;21275.255366062192;22006.88996555015;22010.44973875654;5844.503217226541;5887.88224235515;6019.879602407971;6102.481289090432;6149.262088549358;4198.20234155511;5989.940100599004;6092.695365231721;6094.725737341831;6103.45068943795;5807.274090738658;6437.774677886275;6706.564073335242;6807.047013418125;6842.965785171067;6596.307387724268;6696.631685257309;6724.798256052277;6766.424853887425;6802.455803535755;5889.528837692974;5898.911516327258;5902.173695682608;5902.439268269508;5912.645241285537;24443.877780610983;24958.37604059895;25664.486710265875;26218.86890565554;26612.86693566539;2162.1567588640287;2294.7934685878186;2334.708161479815;2346.378209774411;2370.277065495023;9832.164266037395;10232.43721595312;10446.63436779709;10720.303180293256;10731.980461856112;1717.8797484176112;1869.1308541528256;1881.3885487216573;1900.4583693647244;1926.3546711851548;104957.47521262421;110598;130683;130872;132899.33550332283;11208.887911120784;11381.829272560919;11584.710382240512;11703.941480292544;11742.007717375962;14396.064255823338;14406.991510594367;14413.639659008399;14443.205623690797;14446;8177.754667359989;8493.362997775192;8501.107383724744;8563.871541926876;8702.434341767765;7253.709851605982;8408.579571021424;8457.746267611981;8598.312135029182;8612.8708069379;4450.577195166454;4508.504064552896;4526.841560545365;4614.10025045113;4661.137689527448;1905.4093231098404;1912.6844070728453;1920.270297287022;1922.2983610982171;1924.4611508777564;833.0919297965247;882.6292956957965;914.4284821986258;942.6606421688186;982.1406269514175;19865.60268794616;20113.29603463872;21521;21636.242731504637;21722.23972160967;874.5976850648645;881.6517475597103;904.7104926423613;918.7289749523907;924.8520236762085;11027.393493357942;11535.480903359368;11571.76856462866;11597.76804463906;11609.30344179352;537821.3108934509;565663.3433665693;580225;593912;595813;75100;77510.6124469374;117302.41348793202;139327.30336348253;145958;975.5268694683073;988.4563490080427;1044.2846650044896;1050.7110544600296;1051.2220956492295;19722.408327750192;20056.298029568894;20258.290959816335;20289.28987485431;20309.08609112623;55456.44543554513;56244.43755562392;57880.71059644675;58391.416085838595;59856.40143598682;80080.59959700164;80312.18907338215;87076.1292387068;88221;90091.54954225187;5270.341207349082;5499;7920.445568810128;7971.44199906001;8377.832443350977;9300.348975571917;11435.59975400857;12221.38893055326;13180.736385272048;13220.603381898558;10983.473801025968;11091.944540277247;11260.662180134608;11392.658220253406;11434.542618295174;11021;11099.778004440028;11444.71388215268;11485.368304743319;11499.482523286639;10582.682519524427;11259.943700281447;11340;11877.76244475123;11965.401729913296;6662.733490660319;8146.75559733209;8219.79450513718;8290.33677305802;8362.790930226793;10993.450327483753;11181.217314787888;11199.832002519806;11501.367424791717;11523.34962958541 14:05:11 INFO - PROCESS | 1651 | |3;mootools.html;1357.484156020712;1513.4778501417013;1547.2805145607294;1698.7197112476442;1857.7677790276216;7689.615519224038;8454.07005229425;8713.912860871389;8729;8877.289816814655;8615.439996400246;8708.390412671115;8708.782280442976;8744.256738177246;8763.211310982011;2342.7305859826083;2369.727481339642;2375.180562705864;2376.7147942246957;2376.738558758535;2341.519988402382;2354.2231063748923;2386.331827088418;2393.3537944754908;2404.987975060131;2357.7170739511284;2396.029608008759;2401.6637670726113;2401.7838394544574;2405.0740464921046;2343.69531960844;2372.5729368713623;2377.0610608809598;2379.3456799380137;2386.2244770449674;1795.8024617292087;2057.609054279682;2353.411647088228;2365.302235840414;2366.9526609467885;8646.956765216197;8698.521581313025;8725.301975841918;8769.210771030574;8776.385653004292;5215.80036591586;5430.3755068167275;5438.211459338413;5442.6462279951675;5455.345358556959;3434.3303055904107;3644.5079914211774;3658.3414985302634;3726.310632532963;3729.869454569104;1108.0636861851722;1108.0969010256615;1115.7433790228292;1116.1963386361888;1116.5589592111153;11367.658970230823;11369.09047276216;11418.029467495273;11444.427778611036;11458.312501249951;4342.044750154961;4441.356003379492;4604.148232576984;4623.12160689468;4623.56076172763;8975.730728078168;8977.371583989057;8981.730548083568;8987.820243595223;8999.82000359989;5200.2199670049795;5201.349831271091;5202.557782588447;5203.037438073969;5206.73966301691;4086.0397806515443;4242.53332133465;4753.35829662998;4855.854324370274;4922.483139270325;3161.604799400075;3741.0834345584963;3785.072657198949;3826.7563042011457;3842.116313247913;1008.5209525475341;1162.1632424654404;1178.9882101178878;1189.339916346436;1191.9284842909453;768.7194174126404;840.3193413335218;930.1535602601735;939.8026414452904;943.7404713703786;5801.854953626109;5845.444682755132;5993.760249590055;5999.550033747487;6094.6647934363145;418.080223508283;972.4311277902507;1015.4770293298957;1037.6497233765526;1049.3861091261545;3462.480627905784;3958.050067983663;3958.802059896994;4064.4309796628495;4110.7328023678365;10520.053195212467;10836.241463097507;10836.512356943957;10853.24027318096;10875.293105948089;10795.514201860935;10803.78392432147;10809.135269178447;10816.405097719544;10839.83740243897;7678.003719033091;8075.192480751878;8081.757547273592;8107.878381824277;8205.548694821842;5415.241866138665;5924.7926322578505;5942.494887934574;5951.315598706205;6181.84545386369;9762.267829912927;10006.249531285328;10056.899431005597;10061.39631622105;10063.899361006297;9575.425474471554;10041.748956276151;10058.04448577384;10194.541245643815;10229.130523905551;6924.93075069263;7129.607871567114;7345.595992220479;7475.439342049477;7669.118051424158;8121.025476942805;8386.790330241549;8402.991641003118;8405.579721013803;8409.159084091787;7446.329830315298;7557.622118894144;7567.394608431422;7697.230276972258;7705.460617756928;7293.4894557382595;7373.668184931584;7396.96301518489;7412.369948554433;7433.442491813027;6887.552309100093;7034.648267586498;7054.118235220598;7061.399781018671;7063.611501367474;4614.4693360264;4878.317035615088;4920.827771027997;5020.523050310215;5059.848204553869;4967.230079337708;5107.668001579886;5175.731945673334;5263.7894484220205;5292 14:05:11 INFO - PROCESS | 1651 | |4;prototype.html;296.12199827511427;304.9268175637846;306.0787031036579;311.62293624714096;313.7568384502012;5406.8377948661555;5464.923329134928;5466.808661696831;5496.230527726121;5510.118381059031;4802.879928001802;5130.153524668425;5374.973125134369;5408.810691625794;5422.864428389292;3034.514477683571;3434.4676575130893;3780.7731536107785;4048.655864251542;4148.688848336372;3649.3066317399744;3804.353259945802;4046.3728122141115;4117.258893399187;4160.375943608467;3412.539307193534;3586.4441011643107;3725.9441108383394;4133.1940271647045;4136.834526618946;4076.1847630473876;4117.435374557679;4121.464209652756;4123.5876412358675;4142.440770495975;2792;3485.6928651755593;3515.859365625372;3542.919409580077;3602.8919132426067;4454.754988475633;5250.317458730341;5256.526912577886;5259.632495551146;5287.735613219324;4708.74101924394;4720.740359280238;4726.432828060655;4728.976355118202;4730.455997560291;4603;4787.353707249512;5561.88762247548;5666.320041594994;5690.7439165237665;3536.345776031417;3936.0159960009996;3958.386450100239;3959.307121253769;3966.5636779954184;4933.901321973576;5419.891602167934;5828.271466066742;5877.5632539900425;5980.372060933583;4004.5383435045997;4005.0788318686864;4010.8341495592636;4042.1511482588985;4061.573534778806;3872.037891013377;4098.5286692030795;4102.712810103324;4116.506019277646;4126.855560055384;4517.457905051349;4671.602913752369;4751.0068656746025;4760.976195119002;4761.976190119027;5412.213969390092;5681.914771278434;5707.543396528268;5715.685637289906;5816.73824677882;1359.3814814259686;1385.5219949117538;1389.4650559534653;1393.171063217384;1397.4969011155977;786.838698066895;855.4824331279486;856.7001549457765;867.7830542364409;869.9173578510031;4046.838126474967;4380.5838445347645;4466.553344665507;4471.8658440246845;4507.549245075532;4055.7769322686945;4093.570175131628;4593.816247350135;4689.1559519286175;4902.318286036826;4450.888727781831;4475.351074094238;4475.865724028285;4490.518129017416;4501.41481607389;2357.6519101761596;2470.9374968763245;2506.4861703351135;2513.9944022390823;2532.569463191262;4513.729176249435;4769.66612337133;4900.975495122501;4976.213320540509;5046.6719663221775;4196.712791528625;4369.737815731066;4738.431388233365;4938.9628178082285;4982.850514484571;4502.639788816887;4699.812007519729;4795.808167673324;5035.7985680572365;5041.369828771403;4486.910681123882;4861.149298872612;4881.3410189625365;4882.95117048825;4907.312976183266;4508.295022986182;4646.65150113736;4811.9518804811505;4863.197572400656;4890.731009794353;4988.63361547763;5310.707911064774;5586.413426590312;5881.676507792113;6069.787557435468;4010.558838527818;4022.255882661717;4025.879223623296;4044.191161767717;4066.877993660195;5207.3490813648295;5561.304836895388;5930.555208359477;5934.762609495572;5972.372900845348;5101.311322971352;5306.442823503477;5507.73322135919;5548.722563871709;5744.885102298014;5100.444364468873;5123.79504819818;5699.430056994267;5783.479486846204;5835.883282334415;5250.293654562206;5361.169018802092;5380.762424642432;5664.49019588239;5674.06377947634;5753.971230143822;5769.884602308014;5774.335951365647;5778.595498315078;5784.739686714192;5056.924146137737;5272.894542109059;5388.440490766854;5550.5282051026115;5661.830145095653 14:05:11 INFO - PROCESS | 1651 | |5;yui.html;698.7608377212082;703.2440126863623;704.1303989572878;801.5471258738809;816.0452270843113;14473.78289325661;15582.844171558281;15647.061176329427;16057.518274451755;16109.83890161098;13599.32003399831;13838.584842454742;14481.855181448182;14593.41626334948;14931.253437328145;836.0803116571768;857.7769779857251;858.3519442820661;860.9483430994129;862.0000799073076;690.5131882023187;712.5368510468211;842.6797816829596;860.6858496648741;864.9091845356241;912.5665308978248;914.5153068873475;915.199200699388;915.6520522201588;925.5326060339553;908.8454962656331;910.9225715814164;912.9132732390412;913.4564933864373;914.0585197246846;531.2138035707136;647.3655817299026;668.6957434367351;668.7625892808031;673.7944926797325;14085.225312607803;14126.50557230492;14260;14362.640933976734;14423.06250093751;13277.601671949857;13422;13433.86566134336;13473.595792126154;13952;12267.69330766729;12371;12556.81164782529;13013.804792928113;13033.608991730263;4349.913001739979;4350.521442641307;4382.561743825592;4526.705764125354;4597.60920321773;114244.00583918259;116177.41911290474;117245;118280.81719182784;120279;10578.750217062401;10592.046715795615;10627.84058239127;10676.893231067745;10879.619213327655;20009.399718008193;20118;20444;20662.17351305961;20738.274160404617;7561.344261150276;7628.389728821792;7630.38956883448;7667.961660191663;7801.102873169658;4356.346548017823;4367.956320436819;4447.2439685253585;4463.575960283768;4551.158035763395;3255.3489302139665;3335.5830521184853;3345.0968238575447;3354.278830051551;3355.6644335566734;522.9727391809427;630.2153818496001;638.4636904999822;639.859230969186;640.1997503121098;550.5182964905707;559.9580031497654;627.5920651576421;637.3690046853674;638.4796390941368;8458.830823383621;8700.825983480296;8856.60473504618;8935;9012.41419307743;615.6644628677382;616.4544378225303;624.0483263023834;631.5863109663178;650.7559665125578;4146.150039241948;4307.246231909403;4316.589923957219;4350.282203436397;4515;99167.00832991577;153254.23372883064;162979;163696;171038;142638;142831.57168428184;147312;149320;152361;117349;118438.40780796041;118612.81387186017;119002.2149667773;122248;7442.292982166686;8295.751127466187;8392.370572207232;8398.99212094528;8417.789555261168;55074.44925550693;66798;67677.17165253535;68490.97263541151;69069;92832;102239;103628;104478;109790;9402.341836071682;11318.943405283251;11389.259698119597;11498.54005839757;11560.479778409823;11998.160128790902;12069.456874440495;12253.203541769757;12350.320732359807;12591.11862169676;11274.436278186222;11372;11390.202685812244;11816.409179540817;12090.818637720617;11557.13321500874;11619.302841829518;11753.059755219732;11769.411529423323;11888.227265227733;11034.889651103385;11061.83407248908;11087.113030957342;11126.388048657402;11255.831162532404;9418.387804792666;9645.27660425485;9769.85345219808;9833.16418104469;9882.950585247316;9099.454032758056;9641.710748677551;9696.321257511907;9724.31929764938;9959.751006224902 14:05:11 INFO - PROCESS | 1651 | __end_tp_report 14:05:11 INFO - PROCESS | 1651 | __start_cc_report 14:05:11 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,1323 14:05:11 INFO - PROCESS | 1651 | __end_cc_report 14:05:11 INFO - PROCESS | 1651 | __startTimestamp1471640711276__endTimestamp 14:05:11 INFO - PROCESS | 1651 | 14:05:11 INFO - PROCESS | 1651 | ------- Summary: start ------- 14:05:11 INFO - PROCESS | 1651 | Number of tests: 6 14:05:11 INFO - PROCESS | 1651 | 14:05:11 INFO - PROCESS | 1651 | [#0] dojo.html Cycles:165 Average:5783.56 Median:6059.33 stddev:650.04 (10.7%) stddev-sans-first:623.41 14:05:11 INFO - PROCESS | 1651 | Values: 3351.5 3377.3 3384.8 3397.4 3420.9 5671.9 5701.2 5737.2 5822.8 5833.3 5440.0 5708.6 5756.9 5797.6 5801.4 5179.5 5202.5 5208.9 5293.4 5323.9 5322.0 5352.1 5354.1 5354.3 5361.5 5141.5 5255.5 5282.4 5328.7 5337.9 5188.7 5252.3 5253.8 5257.3 5262.7 5091.4 5127.3 5129.2 5151.7 5170.3 5592.0 5650.0 5702.8 5718.3 5723.0 6117.4 6160.1 6186.0 6191.5 6208.8 6273.2 6294.1 6332.2 6338.8 6366.4 5882.4 5894.5 5914.2 5915.7 5922.2 6179.1 6252.0 6280.5 6305.9 6355.1 6229.3 6232.0 6244.5 6246.4 6257.7 5292.3 6298.7 6317.0 6317.2 6334.7 4595.7 6098.8 6185.6 6263.7 6303.8 6265.4 6282.0 6319.7 6324.4 6333.7 4985.2 4996.6 5002.3 5011.9 5013.6 4421.7 4424.9 4472.3 4505.8 4539.2 5742.2 5840.2 5849.2 5849.5 5854.5 6300.5 6319.7 6334.0 6334.2 6334.5 5601.7 5691.9 5836.6 5848.9 5866.2 5407.1 5473.6 5487.6 5494.3 5498.7 6274.1 6308.2 6312.4 6329.7 6335.9 6176.8 6252.0 6282.7 6295.9 6350.4 6268.8 6295.8 6334.2 6336.1 6343.2 6245.6 6276.5 6278.0 6285.8 6288.4 6165.0 6239.2 6314.5 6319.9 6325.5 6068.0 6134.5 6187.8 6209.5 6259.4 5479.8 6219.3 6231.3 6232.7 6242.8 5883.4 5958.1 6069.5 6103.3 6119.4 6145.5 6237.2 6237.8 6251.3 6252.7 6042.2 6057.2 6059.3 6071.5 6076.1 14:05:11 INFO - PROCESS | 1651 | 14:05:11 INFO - PROCESS | 1651 | [#1] ext.html Cycles:180 Average:70804.01 Median:40080.20 stddev:155484.70 (387.9%) stddev-sans-first:155831.26 14:05:11 INFO - PROCESS | 1651 | Values: 492.7 504.5 517.9 524.8 542.0 40093.0 41598.6 41844.4 43782.5 43901.3 42420.0 43054.4 43092.8 43150.8 43267.0 8582.4 9271.7 9935.9 9967.8 9973.3 9857.0 9986.6 9991.8 9994.3 10019.5 9959.5 10013.9 10028.1 10036.6 10042.6 9935.0 9969.5 9981.7 9991.5 10016.3 9697.0 9795.6 9798.6 9799.0 9803.6 40836.8 41308.6 41338.0 41352.2 41411.0 3337.9 3473.8 3481.0 3667.2 3897.1 31153.5 31576.0 31747.9 32041.5 32273.2 3238.8 3281.4 3290.2 3295.9 3379.4 491471.4 491767.5 492049.0 492587.0 501133.0 60300.8 60543.8 60545.0 60698.0 60725.7 34075.0 34493.1 34770.1 63734.0 64000.7 16498.1 16634.6 16648.5 16662.7 16664.5 12810.6 12859.9 12865.5 12869.0 12871.1 18955.9 19000.6 19151.9 19170.4 19210.2 7751.4 7889.1 7928.6 7979.4 7992.9 799.2 871.7 874.6 1081.8 1103.4 29800.4 30060.4 30264.7 30554.8 30596.4 826.7 1052.6 1077.5 1149.6 1156.2 15324.2 15627.7 15671.3 15706.2 15884.3 668261.0 672008.0 672769.0 674228.0 674661.6 56992.0 57577.0 57717.0 57718.0 57752.0 1254.4 1303.6 1388.9 1414.4 1415.0 26818.1 28246.0 32030.8 32058.7 32970.2 50931.7 51474.5 51552.0 51594.5 51698.2 558653.0 564390.0 565379.0 566951.0 567758.0 23315.4 26566.9 27303.9 27489.0 28364.7 43444.6 45986.6 47823.0 48266.0 49802.3 34927.8 36325.6 39390.4 39958.8 41162.6 39280.0 40067.4 40714.6 41029.0 41090.8 38132.2 38487.2 38589.0 38656.2 39012.2 33850.2 34638.5 35392.6 35455.6 35522.5 24583.9 25184.1 25300.6 25532.0 25700.4 14:05:11 INFO - PROCESS | 1651 | 14:05:11 INFO - PROCESS | 1651 | [#2] jquery.html Cycles:180 Average:34421.23 Median:25311.43 stddev:96149.28 (379.9%) stddev-sans-first:96384.97 14:05:11 INFO - PROCESS | 1651 | Values: 350.6 355.1 373.5 384.7 404.3 15912.6 16791.2 21473.1 21560.0 21634.5 20479.9 20645.8 21275.3 22006.9 22010.4 5844.5 5887.9 6019.9 6102.5 6149.3 4198.2 5989.9 6092.7 6094.7 6103.5 5807.3 6437.8 6706.6 6807.0 6843.0 6596.3 6696.6 6724.8 6766.4 6802.5 5889.5 5898.9 5902.2 5902.4 5912.6 24443.9 24958.4 25664.5 26218.9 26612.9 2162.2 2294.8 2334.7 2346.4 2370.3 9832.2 10232.4 10446.6 10720.3 10732.0 1717.9 1869.1 1881.4 1900.5 1926.4 104957.5 110598.0 130683.0 130872.0 132899.3 11208.9 11381.8 11584.7 11703.9 11742.0 14396.1 14407.0 14413.6 14443.2 14446.0 8177.8 8493.4 8501.1 8563.9 8702.4 7253.7 8408.6 8457.7 8598.3 8612.9 4450.6 4508.5 4526.8 4614.1 4661.1 1905.4 1912.7 1920.3 1922.3 1924.5 833.1 882.6 914.4 942.7 982.1 19865.6 20113.3 21521.0 21636.2 21722.2 874.6 881.7 904.7 918.7 924.9 11027.4 11535.5 11571.8 11597.8 11609.3 537821.3 565663.3 580225.0 593912.0 595813.0 75100.0 77510.6 117302.4 139327.3 145958.0 975.5 988.5 1044.3 1050.7 1051.2 19722.4 20056.3 20258.3 20289.3 20309.1 55456.4 56244.4 57880.7 58391.4 59856.4 80080.6 80312.2 87076.1 88221.0 90091.5 5270.3 5499.0 7920.4 7971.4 8377.8 9300.3 11435.6 12221.4 13180.7 13220.6 10983.5 11091.9 11260.7 11392.7 11434.5 11021.0 11099.8 11444.7 11485.4 11499.5 10582.7 11259.9 11340.0 11877.8 11965.4 6662.7 8146.8 8219.8 8290.3 8362.8 10993.5 11181.2 11199.8 11501.4 11523.3 14:05:11 INFO - PROCESS | 1651 | 14:05:11 INFO - PROCESS | 1651 | [#3] mootools.html Cycles:180 Average:5659.75 Median:4804.61 stddev:3168.72 (66.0%) stddev-sans-first:3161.11 14:05:11 INFO - PROCESS | 1651 | Values: 1357.5 1513.5 1547.3 1698.7 1857.8 7689.6 8454.1 8713.9 8729.0 8877.3 8615.4 8708.4 8708.8 8744.3 8763.2 2342.7 2369.7 2375.2 2376.7 2376.7 2341.5 2354.2 2386.3 2393.4 2405.0 2357.7 2396.0 2401.7 2401.8 2405.1 2343.7 2372.6 2377.1 2379.3 2386.2 1795.8 2057.6 2353.4 2365.3 2367.0 8647.0 8698.5 8725.3 8769.2 8776.4 5215.8 5430.4 5438.2 5442.6 5455.3 3434.3 3644.5 3658.3 3726.3 3729.9 1108.1 1108.1 1115.7 1116.2 1116.6 11367.7 11369.1 11418.0 11444.4 11458.3 4342.0 4441.4 4604.1 4623.1 4623.6 8975.7 8977.4 8981.7 8987.8 8999.8 5200.2 5201.3 5202.6 5203.0 5206.7 4086.0 4242.5 4753.4 4855.9 4922.5 3161.6 3741.1 3785.1 3826.8 3842.1 1008.5 1162.2 1179.0 1189.3 1191.9 768.7 840.3 930.2 939.8 943.7 5801.9 5845.4 5993.8 5999.6 6094.7 418.1 972.4 1015.5 1037.6 1049.4 3462.5 3958.1 3958.8 4064.4 4110.7 10520.1 10836.2 10836.5 10853.2 10875.3 10795.5 10803.8 10809.1 10816.4 10839.8 7678.0 8075.2 8081.8 8107.9 8205.5 5415.2 5924.8 5942.5 5951.3 6181.8 9762.3 10006.2 10056.9 10061.4 10063.9 9575.4 10041.7 10058.0 10194.5 10229.1 6924.9 7129.6 7345.6 7475.4 7669.1 8121.0 8386.8 8403.0 8405.6 8409.2 7446.3 7557.6 7567.4 7697.2 7705.5 7293.5 7373.7 7397.0 7412.4 7433.4 6887.6 7034.6 7054.1 7061.4 7063.6 4614.5 4878.3 4920.8 5020.5 5059.8 4967.2 5107.7 5175.7 5263.8 5292.0 14:05:11 INFO - PROCESS | 1651 | 14:05:11 INFO - PROCESS | 1651 | [#4] prototype.html Cycles:180 Average:4381.72 Median:4734.44 stddev:1329.33 (28.1%) stddev-sans-first:1297.21 14:05:11 INFO - PROCESS | 1651 | Values: 296.1 304.9 306.1 311.6 313.8 5406.8 5464.9 5466.8 5496.2 5510.1 4802.9 5130.2 5375.0 5408.8 5422.9 3034.5 3434.5 3780.8 4048.7 4148.7 3649.3 3804.4 4046.4 4117.3 4160.4 3412.5 3586.4 3725.9 4133.2 4136.8 4076.2 4117.4 4121.5 4123.6 4142.4 2792.0 3485.7 3515.9 3542.9 3602.9 4454.8 5250.3 5256.5 5259.6 5287.7 4708.7 4720.7 4726.4 4729.0 4730.5 4603.0 4787.4 5561.9 5666.3 5690.7 3536.3 3936.0 3958.4 3959.3 3966.6 4933.9 5419.9 5828.3 5877.6 5980.4 4004.5 4005.1 4010.8 4042.2 4061.6 3872.0 4098.5 4102.7 4116.5 4126.9 4517.5 4671.6 4751.0 4761.0 4762.0 5412.2 5681.9 5707.5 5715.7 5816.7 1359.4 1385.5 1389.5 1393.2 1397.5 786.8 855.5 856.7 867.8 869.9 4046.8 4380.6 4466.6 4471.9 4507.5 4055.8 4093.6 4593.8 4689.2 4902.3 4450.9 4475.4 4475.9 4490.5 4501.4 2357.7 2470.9 2506.5 2514.0 2532.6 4513.7 4769.7 4901.0 4976.2 5046.7 4196.7 4369.7 4738.4 4939.0 4982.9 4502.6 4699.8 4795.8 5035.8 5041.4 4486.9 4861.1 4881.3 4883.0 4907.3 4508.3 4646.7 4812.0 4863.2 4890.7 4988.6 5310.7 5586.4 5881.7 6069.8 4010.6 4022.3 4025.9 4044.2 4066.9 5207.3 5561.3 5930.6 5934.8 5972.4 5101.3 5306.4 5507.7 5548.7 5744.9 5100.4 5123.8 5699.4 5783.5 5835.9 5250.3 5361.2 5380.8 5664.5 5674.1 5754.0 5769.9 5774.3 5778.6 5784.7 5056.9 5272.9 5388.4 5550.5 5661.8 14:05:11 INFO - PROCESS | 1651 | 14:05:11 INFO - PROCESS | 1651 | [#5] yui.html Cycles:180 Average:25765.86 Median:4350.10 stddev:43048.12 (989.6%) stddev-sans-first:43127.74 14:05:11 INFO - PROCESS | 1651 | Values: 698.8 703.2 704.1 801.5 816.0 14473.8 15582.8 15647.1 16057.5 16109.8 13599.3 13838.6 14481.9 14593.4 14931.3 836.1 857.8 858.4 860.9 862.0 690.5 712.5 842.7 860.7 864.9 912.6 914.5 915.2 915.7 925.5 908.8 910.9 912.9 913.5 914.1 531.2 647.4 668.7 668.8 673.8 14085.2 14126.5 14260.0 14362.6 14423.1 13277.6 13422.0 13433.9 13473.6 13952.0 12267.7 12371.0 12556.8 13013.8 13033.6 4349.9 4350.5 4382.6 4526.7 4597.6 114244.0 116177.4 117245.0 118280.8 120279.0 10578.8 10592.0 10627.8 10676.9 10879.6 20009.4 20118.0 20444.0 20662.2 20738.3 7561.3 7628.4 7630.4 7668.0 7801.1 4356.3 4368.0 4447.2 4463.6 4551.2 3255.3 3335.6 3345.1 3354.3 3355.7 523.0 630.2 638.5 639.9 640.2 550.5 560.0 627.6 637.4 638.5 8458.8 8700.8 8856.6 8935.0 9012.4 615.7 616.5 624.0 631.6 650.8 4146.2 4307.2 4316.6 4350.3 4515.0 99167.0 153254.2 162979.0 163696.0 171038.0 142638.0 142831.6 147312.0 149320.0 152361.0 117349.0 118438.4 118612.8 119002.2 122248.0 7442.3 8295.8 8392.4 8399.0 8417.8 55074.4 66798.0 67677.2 68491.0 69069.0 92832.0 102239.0 103628.0 104478.0 109790.0 9402.3 11318.9 11389.3 11498.5 11560.5 11998.2 12069.5 12253.2 12350.3 12591.1 11274.4 11372.0 11390.2 11816.4 12090.8 11557.1 11619.3 11753.1 11769.4 11888.2 11034.9 11061.8 11087.1 11126.4 11255.8 9418.4 9645.3 9769.9 9833.2 9883.0 9099.5 9641.7 9696.3 9724.3 9959.8 14:05:11 INFO - PROCESS | 1651 | -------- Summary: end -------- 14:05:11 INFO - PROCESS | 1651 | 14:05:11 INFO - TEST-INFO | 1651: exit 0 14:05:11 INFO - TEST-OK | dromaeo_css | took 1117370ms 14:05:11 INFO - TEST-START | kraken 14:05:11 INFO - operating with platform_type : mac_ 14:05:11 INFO - Initialising browser for kraken test... 14:05:11 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/tmpWmjrtE/profile http://localhost:49269/getInfo.html) 14:05:14 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 14:05:14 INFO - PROCESS | 1658 | colorDepth:24 14:05:14 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 14:05:14 INFO - PROCESS | 1658 | __metrics 14:05:14 INFO - PROCESS | 1658 | 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" 14:05:14 INFO - PROCESS | 1658 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:05:14 INFO - PROCESS | 1658 | ************************* 14:05:14 INFO - PROCESS | 1658 | A coding exception was thrown in a Promise resolution callback. 14:05:14 INFO - PROCESS | 1658 | See https://developer.mozilla.org/Mozilla/JavaScript_code_modules/Promise.jsm/Promise 14:05:14 INFO - PROCESS | 1658 | 14:05:14 ERROR - PROCESS | 1658 | Full message: TypeError: win is null 14:05:14 INFO - PROCESS | 1658 | Full stack: onSuccess@resource://app/components/nsBrowserGlue.js:758:17 14:05:14 INFO - PROCESS | 1658 | Handler.prototype.process@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:937:23 14:05:14 INFO - PROCESS | 1658 | this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:816:7 14:05:14 INFO - PROCESS | 1658 | Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:747:11 14:05:14 INFO - PROCESS | 1658 | this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:779:7 14:05:14 INFO - PROCESS | 1658 | this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:714:7 14:05:14 INFO - PROCESS | 1658 | get _worker/worker.onmessage@resource://gre/modules/PromiseWorker.jsm:235:9 14:05:14 INFO - PROCESS | 1658 | EventHandlerNonNull*get _worker@resource://gre/modules/PromiseWorker.jsm:217:5 14:05:14 INFO - PROCESS | 1658 | postMessage@resource://gre/modules/PromiseWorker.jsm:291:9 14:05:14 INFO - PROCESS | 1658 | TaskImpl_run@resource://gre/modules/Task.jsm:319:40 14:05:14 INFO - PROCESS | 1658 | Handler.prototype.process@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:937:23 14:05:14 INFO - PROCESS | 1658 | this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:816:7 14:05:14 INFO - PROCESS | 1658 | Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:747:11 14:05:14 INFO - PROCESS | 1658 | this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:779:7 14:05:14 INFO - PROCESS | 1658 | Promise.prototype.then@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:454:5 14:05:14 INFO - PROCESS | 1658 | this.DeferredSave.prototype._deferredSave@resource://gre/modules/DeferredSave.jsm:220:5 14:05:14 INFO - PROCESS | 1658 | this.DeferredSave.prototype._startTimer/<@resource://gre/modules/DeferredSave.jsm:175:40 14:05:14 INFO - PROCESS | 1658 | syncLoadManifestFromFile@resource://gre/modules/addons/XPIProvider.jsm:1537:5 14:05:14 INFO - PROCESS | 1658 | addMetadata@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:1654:21 14:05:14 INFO - PROCESS | 1658 | processFileChanges@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2018:23 14:05:14 INFO - PROCESS | 1658 | this.XPIProvider.checkForChanges@resource://gre/modules/addons/XPIProvider.jsm:3793:34 14:05:14 INFO - PROCESS | 1658 | this.XPIProvider.startup@resource://gre/modules/addons/XPIProvider.jsm:2778:25 14:05:14 INFO - PROCESS | 1658 | callProvider@resource://gre/modules/AddonManager.jsm:236:12 14:05:14 INFO - PROCESS | 1658 | _startProvider@resource://gre/modules/AddonManager.jsm:788:5 14:05:14 INFO - PROCESS | 1658 | AddonManagerInternal.startup@resource://gre/modules/AddonManager.jsm:972:9 14:05:14 INFO - PROCESS | 1658 | this.AddonManagerPrivate.startup@resource://gre/modules/AddonManager.jsm:3016:5 14:05:14 INFO - PROCESS | 1658 | amManager.prototype.observe@resource://gre/components/addonManager.js:71:9 14:05:14 INFO - PROCESS | 1658 | 14:05:14 INFO - PROCESS | 1658 | ************************* 14:05:14 INFO - TEST-INFO | 1658: exit 0 14:05:14 INFO - Browser initialized. 14:05:14 INFO - Running cycle 1/1 for kraken test... 14:05:14 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/tmpWmjrtE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:05:26 INFO - PROCESS | 1659 | RSS: Main: 250421248 14:05:26 INFO - PROCESS | 1659 | 14:05:29 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection) 14:05:30 INFO - PROCESS | 1659 | RSS: Main: 313679872 14:05:30 INFO - PROCESS | 1659 | 14:05:32 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-dft) 14:05:33 INFO - PROCESS | 1659 | RSS: Main: 310353920 14:05:33 INFO - PROCESS | 1659 | 14:05:37 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-fft) 14:05:37 INFO - PROCESS | 1659 | RSS: Main: 398876672 14:05:37 INFO - PROCESS | 1659 | 14:05:39 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator) 14:05:40 INFO - PROCESS | 1659 | RSS: Main: 301699072 14:05:40 INFO - PROCESS | 1659 | 14:05:42 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:05:43 INFO - PROCESS | 1659 | RSS: Main: 306270208 14:05:43 INFO - PROCESS | 1659 | 14:05:46 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom) 14:05:46 INFO - PROCESS | 1659 | RSS: Main: 343531520 14:05:46 INFO - PROCESS | 1659 | 14:05:49 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate) 14:05:50 INFO - PROCESS | 1659 | RSS: Main: 343597056 14:05:50 INFO - PROCESS | 1659 | 14:05:52 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial) 14:05:53 INFO - PROCESS | 1659 | RSS: Main: 343097344 14:05:53 INFO - PROCESS | 1659 | 14:05:55 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:05:55 INFO - PROCESS | 1659 | RSS: Main: 317308928 14:05:55 INFO - PROCESS | 1659 | 14:05:57 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:05:58 INFO - PROCESS | 1659 | RSS: Main: 319348736 14:05:58 INFO - PROCESS | 1659 | 14:06:00 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:06:01 INFO - PROCESS | 1659 | RSS: Main: 320581632 14:06:01 INFO - PROCESS | 1659 | 14:06:04 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:06:04 INFO - PROCESS | 1659 | RSS: Main: 328486912 14:06:04 INFO - PROCESS | 1659 | 14:06:07 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:06:08 INFO - PROCESS | 1659 | RSS: Main: 330911744 14:06:08 INFO - PROCESS | 1659 | 14:06:09 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49269/tests/kraken/driver.html?testName=ai-astar) 14:06:10 INFO - PROCESS | 1659 | RSS: Main: 374009856 14:06:10 INFO - PROCESS | 1659 | 14:06:10 INFO - PROCESS | 1659 | __start_tp_report 14:06:10 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 14:06:10 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 14:06:10 INFO - PROCESS | 1659 | |i|pagename|runs| 14:06:10 INFO - PROCESS | 1659 | |0;ai-astar;102;114;114;113;115;114;112;113;113;113 14:06:10 INFO - PROCESS | 1659 | |1;audio-beat-detection;144;113;108;160;108;101;152;103;144;107 14:06:10 INFO - PROCESS | 1659 | |2;audio-dft;182;184;185;186;184;182;208;255;184;196 14:06:10 INFO - PROCESS | 1659 | |3;audio-fft;77;73;58;87;58;63;62;65;100;56 14:06:10 INFO - PROCESS | 1659 | |4;audio-oscillator;82;87;105;99;70;69;95;71;68;104 14:06:10 INFO - PROCESS | 1659 | |5;imaging-gaussian-blur;91;88;91;88;91;88;90;88;91;88 14:06:10 INFO - PROCESS | 1659 | |6;imaging-darkroom;95;95;96;96;96;95;96;97;95;96 14:06:10 INFO - PROCESS | 1659 | |7;imaging-desaturate;87;83;85;85;85;85;85;85;87;86 14:06:10 INFO - PROCESS | 1659 | |8;json-parse-financial;54;53;54;54;54;54;56;53;54;54 14:06:10 INFO - PROCESS | 1659 | |9;json-stringify-tinderbox;66;69;74;71;73;72;68;70;67;68 14:06:10 INFO - PROCESS | 1659 | |10;stanford-crypto-aes;84;88;85;87;85;83;84;85;90;86 14:06:10 INFO - PROCESS | 1659 | |11;stanford-crypto-ccm;141;140;138;136;136;136;139;138;210;137 14:06:10 INFO - PROCESS | 1659 | |12;stanford-crypto-pbkdf2;170;172;168;169;168;167;169;168;166;168 14:06:10 INFO - PROCESS | 1659 | |13;stanford-crypto-sha256-iterative;67;67;68;68;69;67;65;65;63;67 14:06:10 INFO - PROCESS | 1659 | __end_tp_report 14:06:10 INFO - PROCESS | 1659 | __start_cc_report 14:06:10 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,2058 14:06:10 INFO - PROCESS | 1659 | __end_cc_report 14:06:10 INFO - PROCESS | 1659 | __startTimestamp1471640770161__endTimestamp 14:06:10 INFO - PROCESS | 1659 | 14:06:10 INFO - PROCESS | 1659 | ------- Summary: start ------- 14:06:10 INFO - PROCESS | 1659 | Number of tests: 14 14:06:10 INFO - PROCESS | 1659 | 14:06:10 INFO - PROCESS | 1659 | [#0] ai-astar Cycles:10 Average:112.30 Median:113.50 stddev:3.71 (3.3%) stddev-sans-first:0.88 14:06:10 INFO - PROCESS | 1659 | Values: 102.0 114.0 114.0 113.0 115.0 114.0 112.0 113.0 113.0 113.0 14:06:10 INFO - PROCESS | 1659 | 14:06:10 INFO - PROCESS | 1659 | [#1] audio-beat-detection Cycles:10 Average:124.00 Median:128.50 stddev:23.03 (17.9%) stddev-sans-first:23.26 14:06:10 INFO - PROCESS | 1659 | Values: 144.0 113.0 108.0 160.0 108.0 101.0 152.0 103.0 144.0 107.0 14:06:10 INFO - PROCESS | 1659 | 14:06:10 INFO - PROCESS | 1659 | [#2] audio-dft Cycles:10 Average:194.60 Median:185.50 stddev:22.73 (12.3%) stddev-sans-first:23.65 14:06:10 INFO - PROCESS | 1659 | Values: 182.0 184.0 185.0 186.0 184.0 182.0 208.0 255.0 184.0 196.0 14:06:10 INFO - PROCESS | 1659 | 14:06:10 INFO - PROCESS | 1659 | [#3] audio-fft Cycles:10 Average:69.90 Median:64.00 stddev:14.41 (22.5%) stddev-sans-first:15.05 14:06:10 INFO - PROCESS | 1659 | Values: 77.0 73.0 58.0 87.0 58.0 63.0 62.0 65.0 100.0 56.0 14:06:10 INFO - PROCESS | 1659 | 14:06:10 INFO - PROCESS | 1659 | [#4] audio-oscillator Cycles:10 Average:85.00 Median:76.50 stddev:15.04 (19.7%) stddev-sans-first:15.91 14:06:10 INFO - PROCESS | 1659 | Values: 82.0 87.0 105.0 99.0 70.0 69.0 95.0 71.0 68.0 104.0 14:06:10 INFO - PROCESS | 1659 | 14:06:10 INFO - PROCESS | 1659 | [#5] imaging-gaussian-blur Cycles:10 Average:89.40 Median:90.50 stddev:1.51 (1.7%) stddev-sans-first:1.48 14:06:10 INFO - PROCESS | 1659 | Values: 91.0 88.0 91.0 88.0 91.0 88.0 90.0 88.0 91.0 88.0 14:06:10 INFO - PROCESS | 1659 | 14:06:10 INFO - PROCESS | 1659 | [#6] imaging-darkroom Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 14:06:10 INFO - PROCESS | 1659 | Values: 95.0 95.0 96.0 96.0 96.0 95.0 96.0 97.0 95.0 96.0 14:06:10 INFO - PROCESS | 1659 | 14:06:10 INFO - PROCESS | 1659 | [#7] imaging-desaturate Cycles:10 Average:85.30 Median:85.00 stddev:1.16 (1.4%) stddev-sans-first:1.05 14:06:10 INFO - PROCESS | 1659 | Values: 87.0 83.0 85.0 85.0 85.0 85.0 85.0 85.0 87.0 86.0 14:06:10 INFO - PROCESS | 1659 | 14:06:10 INFO - PROCESS | 1659 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:54.00 stddev:0.82 (1.5%) stddev-sans-first:0.87 14:06:10 INFO - PROCESS | 1659 | Values: 54.0 53.0 54.0 54.0 54.0 54.0 56.0 53.0 54.0 54.0 14:06:10 INFO - PROCESS | 1659 | 14:06:10 INFO - PROCESS | 1659 | [#9] json-stringify-tinderbox Cycles:10 Average:69.80 Median:70.50 stddev:2.66 (3.8%) stddev-sans-first:2.44 14:06:10 INFO - PROCESS | 1659 | Values: 66.0 69.0 74.0 71.0 73.0 72.0 68.0 70.0 67.0 68.0 14:06:10 INFO - PROCESS | 1659 | 14:06:10 INFO - PROCESS | 1659 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:85.50 stddev:2.11 (2.5%) stddev-sans-first:2.15 14:06:10 INFO - PROCESS | 1659 | Values: 84.0 88.0 85.0 87.0 85.0 83.0 84.0 85.0 90.0 86.0 14:06:10 INFO - PROCESS | 1659 | 14:06:10 INFO - PROCESS | 1659 | [#11] stanford-crypto-ccm Cycles:10 Average:145.10 Median:138.50 stddev:22.87 (16.5%) stddev-sans-first:24.21 14:06:10 INFO - PROCESS | 1659 | Values: 141.0 140.0 138.0 136.0 136.0 136.0 139.0 138.0 210.0 137.0 14:06:10 INFO - PROCESS | 1659 | 14:06:10 INFO - PROCESS | 1659 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.50 Median:168.50 stddev:1.65 (1.0%) stddev-sans-first:1.66 14:06:10 INFO - PROCESS | 1659 | Values: 170.0 172.0 168.0 169.0 168.0 167.0 169.0 168.0 166.0 168.0 14:06:10 INFO - PROCESS | 1659 | 14:06:10 INFO - PROCESS | 1659 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:1.78 (2.7%) stddev-sans-first:1.88 14:06:10 INFO - PROCESS | 1659 | Values: 67.0 67.0 68.0 68.0 69.0 67.0 65.0 65.0 63.0 67.0 14:06:10 INFO - PROCESS | 1659 | -------- Summary: end -------- 14:06:10 INFO - PROCESS | 1659 | 14:06:10 INFO - TEST-INFO | 1659: exit 0 14:06:11 INFO - TEST-OK | kraken | took 59122ms 14:06:11 INFO - SUITE-END | took 1176s 14:06:11 INFO - Completed test suite (00:19:36) 14:06:11 INFO - javascript benchmark 14:06:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3351.5307856900035, 3377.3076519313536, 3384.830758462076, 3397.3714862750408, 3420.931581368373, 5671.943280567193, 5701.173329867167, 5737.225474560938, 5822.796202132931, 5833.30000399952, 5439.99999999999, 5708.628939118955, 5756.941356343778, 5797.623154494955, 5801.361850196486, 5179.533841954223, 5202.531772140506, 5208.947910520884, 5293.444188360225, 5323.893522129574, 5322.0, 5352.116900711378, 5354.063038968185, 5354.303940487731, 5361.490658387447, 5141.485851414866, 5255.474452554714, 5282.418933917266, 5328.653637513568, 5337.919931201035, 5188.688678679291, 5252.343457067866, 5253.7635806388425, 5257.342832145981, 5262.684238945637, 5091.363579552556, 5127.282180494733, 5129.153689641242, 5151.742412879341, 5170.276161337416, 5592.0, 5650.0, 5702.8289151325525, 5718.34239062509, 5722.97138514309, 6117.449429551361, 6160.1375807387, 6186.041163619646, 6191.504679625619, 6208.844778880564, 6273.247210334744, 6294.0873573332065, 6332.208473940757, 6338.809835704937, 6366.395192456709, 5882.441168089024, 5894.469497745224, 5914.231149950522, 5915.674637894957, 5922.200502932135, 6179.104029915727, 6252.0, 6280.466160376328, 6305.873882522324, 6355.110284560165, 6229.314775374705, 6232.034034724625, 6244.469220116341, 6246.406591373812, 6257.749690012349, 5292.259083728281, 6298.716557754912, 6316.968415157987, 6317.210348706411, 6334.683265836689, 4595.655325850575, 6098.817035488943, 6185.628862268279, 6263.686815659199, 6303.779367722108, 6265.373462653698, 6282.0, 6319.747210111544, 6324.43080122782, 6333.68331583419, 4985.177445721415, 4996.625253105959, 5002.299678045077, 5011.899762004739, 5013.573846223112, 4421.734695918255, 4424.889377765581, 4472.329150627367, 4505.797239124247, 4539.228331183706, 5742.167385729046, 5840.2115714378015, 5849.181114643953, 5849.5027922626205, 5854.473097421167, 6300.464460520815, 6319.652419116993, 6334.0, 6334.1765570475545, 6334.461570766444, 5601.747921343549, 5691.943080569225, 5836.591438599257, 5848.912266316009, 5866.178734977107, 5407.107827208545, 5473.644213126134, 5487.5884308677005, 5494.2582751328055, 5498.697571633598, 6274.058891166362, 6308.211473565804, 6312.43188113072, 6329.683515824282, 6335.904961425675, 6176.752929882934, 6252.030935205051, 6282.654454005074, 6295.937040629535, 6350.396712312323, 6268.780592679234, 6295.779647712308, 6334.176557047738, 6336.144620476177, 6343.175387199634, 6245.5628106032145, 6276.497880169667, 6277.96861015692, 6285.842853928505, 6288.371162883675, 6165.0, 6239.1577137087725, 6314.463270622048, 6319.905201422074, 6325.493960483058, 6067.969660151847, 6134.509239260759, 6187.752489900354, 6209.472194863487, 6259.374062593704, 5479.808206712746, 6219.253689557282, 6231.283402408781, 6232.657203853832, 6242.812715618538, 5883.441073098049, 5958.106284057253, 6069.51443884497, 6103.298120715996, 6119.357467465852, 6145.477634401126, 6237.157983672146, 6237.781677641261, 6251.343608920998, 6252.687365631791, 6042.214512113397, 6057.18228039209, 6059.3334733178435, 6071.453569178795, 6076.088586712029], "value": 5742.496615623943, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [492.719150084452, 504.5282660712233, 517.8627663669128, 524.8031988004499, 541.9648471419589, 40093.0, 41598.58401415985, 41844.372334415006, 43782.467613633526, 43901.341479877825, 42420.0, 43054.354184687254, 43092.78453607728, 43150.7842460788, 43267.0, 8582.442141260799, 9271.67549135782, 9935.900640993606, 9967.750806229866, 9973.252006099536, 9857.0, 9986.600535978552, 9991.800163996715, 9994.300398972075, 10019.549120289568, 9959.502024898726, 10013.94993025034, 10028.147607453338, 10036.598536058586, 10042.598296068149, 9935.00649935008, 9969.451680157588, 9981.70054898347, 9991.450470224136, 10016.298859079867, 9696.951515242448, 9795.559199836025, 9798.608055677765, 9798.951005244999, 9803.607855685765, 40836.795816021026, 41308.58691413078, 41338.0, 41352.172956541, 41411.0, 3337.8998630041137, 3473.7915725056578, 3481.0, 3667.174885650734, 3897.1099016976746, 31153.532697009563, 31576.0, 31747.88882389105, 32041.51937720936, 32273.1931701707, 3238.77328586999, 3281.376538457709, 3290.2103495161227, 3295.9176020599675, 3379.4422231603944, 491471.4264286771, 491767.5411622955, 492049.0, 492587.0, 501133.0, 60300.79398412007, 60543.78912421727, 60545.0, 60698.0, 60725.69637151786, 34074.97775066752, 34493.13767155791, 34770.130746731535, 63734.0439893402, 64000.67999659972, 16498.092604906844, 16634.58413539671, 16648.500544983668, 16662.666746665, 16664.50006499807, 12810.615681529569, 12859.871401286055, 12865.48538058486, 12868.970482361388, 12871.099023068295, 18955.90522047381, 19000.61998760017, 19151.904240478987, 19170.424887253404, 19210.231590736494, 7751.379889608817, 7889.09275433321, 7928.563928983961, 7979.3616510679, 7992.920070799334, 799.1648727080216, 871.6600525794945, 874.606427107804, 1081.7944590527775, 1103.426218366445, 29800.40399192004, 30060.398792024036, 30264.69735302619, 30554.847225764173, 30596.388072238875, 826.7478419082238, 1052.615810209572, 1077.4774234496263, 1149.6263714292888, 1156.173336064701, 15324.15717135546, 15627.687446251011, 15671.294791734399, 15706.214689265491, 15884.285207165705, 668261.0, 672008.0, 672769.0, 674228.0, 674661.6266918634, 56992.0, 57577.0, 57717.0, 57718.0, 57752.0, 1254.4104270992618, 1303.641498587896, 1388.8611138886233, 1414.4059495012325, 1415.0448447298238, 26818.06136785203, 28246.011389601266, 32030.839845800623, 32058.67941320557, 32970.17574560655, 50931.745341273054, 51474.485255148466, 51552.0, 51594.484055158966, 51698.22452663138, 558653.0, 564390.0, 565379.0, 566951.0, 567758.0, 23315.417114572272, 26566.867165664047, 27303.863480683263, 27489.0, 28364.716352837033, 43444.56555434405, 45986.62040138801, 47823.0, 48266.0, 49802.25296620626, 34927.82536087303, 36325.636743632225, 39390.40914386229, 39958.800205998785, 41162.588374115876, 39280.0, 40067.39898901577, 40714.59285407227, 41029.0, 41090.79454602708, 38132.237355253295, 38487.2302553953, 38589.0, 38656.2268754629, 39012.2197556053, 33850.153746156546, 34638.480422793175, 35392.646073538934, 35455.64544354523, 35522.467162992056, 24583.877080614482, 25184.11855585046, 25300.620490692287, 25532.0, 25700.357491062125], "value": 20132.816549489064, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.6055687351729, 355.1086772201773, 373.52375720955797, 384.73068851803737, 404.3389058888716, 15912.602184945368, 16791.1604419779, 21473.14107435701, 21560.0, 21634.459138521546, 20479.897600512013, 20645.793542064574, 21275.255366062192, 22006.88996555015, 22010.44973875654, 5844.503217226541, 5887.88224235515, 6019.879602407971, 6102.481289090432, 6149.262088549358, 4198.20234155511, 5989.940100599004, 6092.695365231721, 6094.725737341831, 6103.45068943795, 5807.274090738658, 6437.774677886275, 6706.564073335242, 6807.047013418125, 6842.965785171067, 6596.307387724268, 6696.631685257309, 6724.798256052277, 6766.424853887425, 6802.455803535755, 5889.528837692974, 5898.911516327258, 5902.173695682608, 5902.439268269508, 5912.645241285537, 24443.877780610983, 24958.37604059895, 25664.486710265875, 26218.86890565554, 26612.86693566539, 2162.1567588640287, 2294.7934685878186, 2334.708161479815, 2346.378209774411, 2370.277065495023, 9832.164266037395, 10232.43721595312, 10446.63436779709, 10720.303180293256, 10731.980461856112, 1717.8797484176112, 1869.1308541528256, 1881.3885487216573, 1900.4583693647244, 1926.3546711851548, 104957.47521262421, 110598.0, 130683.0, 130872.0, 132899.33550332283, 11208.887911120784, 11381.829272560919, 11584.710382240512, 11703.941480292544, 11742.007717375962, 14396.064255823338, 14406.991510594367, 14413.639659008399, 14443.205623690797, 14446.0, 8177.754667359989, 8493.362997775192, 8501.107383724744, 8563.871541926876, 8702.434341767765, 7253.709851605982, 8408.579571021424, 8457.746267611981, 8598.312135029182, 8612.8708069379, 4450.577195166454, 4508.504064552896, 4526.841560545365, 4614.10025045113, 4661.137689527448, 1905.4093231098404, 1912.6844070728453, 1920.270297287022, 1922.2983610982171, 1924.4611508777564, 833.0919297965247, 882.6292956957965, 914.4284821986258, 942.6606421688186, 982.1406269514175, 19865.60268794616, 20113.29603463872, 21521.0, 21636.242731504637, 21722.23972160967, 874.5976850648645, 881.6517475597103, 904.7104926423613, 918.7289749523907, 924.8520236762085, 11027.393493357942, 11535.480903359368, 11571.76856462866, 11597.76804463906, 11609.30344179352, 537821.3108934509, 565663.3433665693, 580225.0, 593912.0, 595813.0, 75100.0, 77510.6124469374, 117302.41348793202, 139327.30336348253, 145958.0, 975.5268694683073, 988.4563490080427, 1044.2846650044896, 1050.7110544600296, 1051.2220956492295, 19722.408327750192, 20056.298029568894, 20258.290959816335, 20289.28987485431, 20309.08609112623, 55456.44543554513, 56244.43755562392, 57880.71059644675, 58391.416085838595, 59856.40143598682, 80080.59959700164, 80312.18907338215, 87076.1292387068, 88221.0, 90091.54954225187, 5270.341207349082, 5499.0, 7920.445568810128, 7971.44199906001, 8377.832443350977, 9300.348975571917, 11435.59975400857, 12221.38893055326, 13180.736385272048, 13220.603381898558, 10983.473801025968, 11091.944540277247, 11260.662180134608, 11392.658220253406, 11434.542618295174, 11021.0, 11099.778004440028, 11444.71388215268, 11485.368304743319, 11499.482523286639, 10582.682519524427, 11259.943700281447, 11340.0, 11877.76244475123, 11965.401729913296, 6662.733490660319, 8146.75559733209, 8219.79450513718, 8290.33677305802, 8362.790930226793, 10993.450327483753, 11181.217314787888, 11199.832002519806, 11501.367424791717, 11523.34962958541], "value": 9639.328083932169, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1357.484156020712, 1513.4778501417013, 1547.2805145607294, 1698.7197112476442, 1857.7677790276216, 7689.615519224038, 8454.07005229425, 8713.912860871389, 8729.0, 8877.289816814655, 8615.439996400246, 8708.390412671115, 8708.782280442976, 8744.256738177246, 8763.211310982011, 2342.7305859826083, 2369.727481339642, 2375.180562705864, 2376.7147942246957, 2376.738558758535, 2341.519988402382, 2354.2231063748923, 2386.331827088418, 2393.3537944754908, 2404.987975060131, 2357.7170739511284, 2396.029608008759, 2401.6637670726113, 2401.7838394544574, 2405.0740464921046, 2343.69531960844, 2372.5729368713623, 2377.0610608809598, 2379.3456799380137, 2386.2244770449674, 1795.8024617292087, 2057.609054279682, 2353.411647088228, 2365.302235840414, 2366.9526609467885, 8646.956765216197, 8698.521581313025, 8725.301975841918, 8769.210771030574, 8776.385653004292, 5215.80036591586, 5430.3755068167275, 5438.211459338413, 5442.6462279951675, 5455.345358556959, 3434.3303055904107, 3644.5079914211774, 3658.3414985302634, 3726.310632532963, 3729.869454569104, 1108.0636861851722, 1108.0969010256615, 1115.7433790228292, 1116.1963386361888, 1116.5589592111153, 11367.658970230823, 11369.09047276216, 11418.029467495273, 11444.427778611036, 11458.312501249951, 4342.044750154961, 4441.356003379492, 4604.148232576984, 4623.12160689468, 4623.56076172763, 8975.730728078168, 8977.371583989057, 8981.730548083568, 8987.820243595223, 8999.82000359989, 5200.2199670049795, 5201.349831271091, 5202.557782588447, 5203.037438073969, 5206.73966301691, 4086.0397806515443, 4242.53332133465, 4753.35829662998, 4855.854324370274, 4922.483139270325, 3161.604799400075, 3741.0834345584963, 3785.072657198949, 3826.7563042011457, 3842.116313247913, 1008.5209525475341, 1162.1632424654404, 1178.9882101178878, 1189.339916346436, 1191.9284842909453, 768.7194174126404, 840.3193413335218, 930.1535602601735, 939.8026414452904, 943.7404713703786, 5801.854953626109, 5845.444682755132, 5993.760249590055, 5999.550033747487, 6094.6647934363145, 418.080223508283, 972.4311277902507, 1015.4770293298957, 1037.6497233765526, 1049.3861091261545, 3462.480627905784, 3958.050067983663, 3958.802059896994, 4064.4309796628495, 4110.7328023678365, 10520.053195212467, 10836.241463097507, 10836.512356943957, 10853.24027318096, 10875.293105948089, 10795.514201860935, 10803.78392432147, 10809.135269178447, 10816.405097719544, 10839.83740243897, 7678.003719033091, 8075.192480751878, 8081.757547273592, 8107.878381824277, 8205.548694821842, 5415.241866138665, 5924.7926322578505, 5942.494887934574, 5951.315598706205, 6181.84545386369, 9762.267829912927, 10006.249531285328, 10056.899431005597, 10061.39631622105, 10063.899361006297, 9575.425474471554, 10041.748956276151, 10058.04448577384, 10194.541245643815, 10229.130523905551, 6924.93075069263, 7129.607871567114, 7345.595992220479, 7475.439342049477, 7669.118051424158, 8121.025476942805, 8386.790330241549, 8402.991641003118, 8405.579721013803, 8409.159084091787, 7446.329830315298, 7557.622118894144, 7567.394608431422, 7697.230276972258, 7705.460617756928, 7293.4894557382595, 7373.668184931584, 7396.96301518489, 7412.369948554433, 7433.442491813027, 6887.552309100093, 7034.648267586498, 7054.118235220598, 7061.399781018671, 7063.611501367474, 4614.4693360264, 4878.317035615088, 4920.827771027997, 5020.523050310215, 5059.848204553869, 4967.230079337708, 5107.668001579886, 5175.731945673334, 5263.7894484220205, 5292.0], "value": 4540.570372076089, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.12199827511427, 304.9268175637846, 306.0787031036579, 311.62293624714096, 313.7568384502012, 5406.8377948661555, 5464.923329134928, 5466.808661696831, 5496.230527726121, 5510.118381059031, 4802.879928001802, 5130.153524668425, 5374.973125134369, 5408.810691625794, 5422.864428389292, 3034.514477683571, 3434.4676575130893, 3780.7731536107785, 4048.655864251542, 4148.688848336372, 3649.3066317399744, 3804.353259945802, 4046.3728122141115, 4117.258893399187, 4160.375943608467, 3412.539307193534, 3586.4441011643107, 3725.9441108383394, 4133.1940271647045, 4136.834526618946, 4076.1847630473876, 4117.435374557679, 4121.464209652756, 4123.5876412358675, 4142.440770495975, 2792.0, 3485.6928651755593, 3515.859365625372, 3542.919409580077, 3602.8919132426067, 4454.754988475633, 5250.317458730341, 5256.526912577886, 5259.632495551146, 5287.735613219324, 4708.74101924394, 4720.740359280238, 4726.432828060655, 4728.976355118202, 4730.455997560291, 4603.0, 4787.353707249512, 5561.88762247548, 5666.320041594994, 5690.7439165237665, 3536.345776031417, 3936.0159960009996, 3958.386450100239, 3959.307121253769, 3966.5636779954184, 4933.901321973576, 5419.891602167934, 5828.271466066742, 5877.5632539900425, 5980.372060933583, 4004.5383435045997, 4005.0788318686864, 4010.8341495592636, 4042.1511482588985, 4061.573534778806, 3872.037891013377, 4098.5286692030795, 4102.712810103324, 4116.506019277646, 4126.855560055384, 4517.457905051349, 4671.602913752369, 4751.0068656746025, 4760.976195119002, 4761.976190119027, 5412.213969390092, 5681.914771278434, 5707.543396528268, 5715.685637289906, 5816.73824677882, 1359.3814814259686, 1385.5219949117538, 1389.4650559534653, 1393.171063217384, 1397.4969011155977, 786.838698066895, 855.4824331279486, 856.7001549457765, 867.7830542364409, 869.9173578510031, 4046.838126474967, 4380.5838445347645, 4466.553344665507, 4471.8658440246845, 4507.549245075532, 4055.7769322686945, 4093.570175131628, 4593.816247350135, 4689.1559519286175, 4902.318286036826, 4450.888727781831, 4475.351074094238, 4475.865724028285, 4490.518129017416, 4501.41481607389, 2357.6519101761596, 2470.9374968763245, 2506.4861703351135, 2513.9944022390823, 2532.569463191262, 4513.729176249435, 4769.66612337133, 4900.975495122501, 4976.213320540509, 5046.6719663221775, 4196.712791528625, 4369.737815731066, 4738.431388233365, 4938.9628178082285, 4982.850514484571, 4502.639788816887, 4699.812007519729, 4795.808167673324, 5035.7985680572365, 5041.369828771403, 4486.910681123882, 4861.149298872612, 4881.3410189625365, 4882.95117048825, 4907.312976183266, 4508.295022986182, 4646.65150113736, 4811.9518804811505, 4863.197572400656, 4890.731009794353, 4988.63361547763, 5310.707911064774, 5586.413426590312, 5881.676507792113, 6069.787557435468, 4010.558838527818, 4022.255882661717, 4025.879223623296, 4044.191161767717, 4066.877993660195, 5207.3490813648295, 5561.304836895388, 5930.555208359477, 5934.762609495572, 5972.372900845348, 5101.311322971352, 5306.442823503477, 5507.73322135919, 5548.722563871709, 5744.885102298014, 5100.444364468873, 5123.79504819818, 5699.430056994267, 5783.479486846204, 5835.883282334415, 5250.293654562206, 5361.169018802092, 5380.762424642432, 5664.49019588239, 5674.06377947634, 5753.971230143822, 5769.884602308014, 5774.335951365647, 5778.595498315078, 5784.739686714192, 5056.924146137737, 5272.894542109059, 5388.440490766854, 5550.5282051026115, 5661.830145095653], "value": 3961.835819365442, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [698.7608377212082, 703.2440126863623, 704.1303989572878, 801.5471258738809, 816.0452270843113, 14473.78289325661, 15582.844171558281, 15647.061176329427, 16057.518274451755, 16109.83890161098, 13599.32003399831, 13838.584842454742, 14481.855181448182, 14593.41626334948, 14931.253437328145, 836.0803116571768, 857.7769779857251, 858.3519442820661, 860.9483430994129, 862.0000799073076, 690.5131882023187, 712.5368510468211, 842.6797816829596, 860.6858496648741, 864.9091845356241, 912.5665308978248, 914.5153068873475, 915.199200699388, 915.6520522201588, 925.5326060339553, 908.8454962656331, 910.9225715814164, 912.9132732390412, 913.4564933864373, 914.0585197246846, 531.2138035707136, 647.3655817299026, 668.6957434367351, 668.7625892808031, 673.7944926797325, 14085.225312607803, 14126.50557230492, 14260.0, 14362.640933976734, 14423.06250093751, 13277.601671949857, 13422.0, 13433.86566134336, 13473.595792126154, 13952.0, 12267.69330766729, 12371.0, 12556.81164782529, 13013.804792928113, 13033.608991730263, 4349.913001739979, 4350.521442641307, 4382.561743825592, 4526.705764125354, 4597.60920321773, 114244.00583918259, 116177.41911290474, 117245.0, 118280.81719182784, 120279.0, 10578.750217062401, 10592.046715795615, 10627.84058239127, 10676.893231067745, 10879.619213327655, 20009.399718008193, 20118.0, 20444.0, 20662.17351305961, 20738.274160404617, 7561.344261150276, 7628.389728821792, 7630.38956883448, 7667.961660191663, 7801.102873169658, 4356.346548017823, 4367.956320436819, 4447.2439685253585, 4463.575960283768, 4551.158035763395, 3255.3489302139665, 3335.5830521184853, 3345.0968238575447, 3354.278830051551, 3355.6644335566734, 522.9727391809427, 630.2153818496001, 638.4636904999822, 639.859230969186, 640.1997503121098, 550.5182964905707, 559.9580031497654, 627.5920651576421, 637.3690046853674, 638.4796390941368, 8458.830823383621, 8700.825983480296, 8856.60473504618, 8935.0, 9012.41419307743, 615.6644628677382, 616.4544378225303, 624.0483263023834, 631.5863109663178, 650.7559665125578, 4146.150039241948, 4307.246231909403, 4316.589923957219, 4350.282203436397, 4515.0, 99167.00832991577, 153254.23372883064, 162979.0, 163696.0, 171038.0, 142638.0, 142831.57168428184, 147312.0, 149320.0, 152361.0, 117349.0, 118438.40780796041, 118612.81387186017, 119002.2149667773, 122248.0, 7442.292982166686, 8295.751127466187, 8392.370572207232, 8398.99212094528, 8417.789555261168, 55074.44925550693, 66798.0, 67677.17165253535, 68490.97263541151, 69069.0, 92832.0, 102239.0, 103628.0, 104478.0, 109790.0, 9402.341836071682, 11318.943405283251, 11389.259698119597, 11498.54005839757, 11560.479778409823, 11998.160128790902, 12069.456874440495, 12253.203541769757, 12350.320732359807, 12591.11862169676, 11274.436278186222, 11372.0, 11390.202685812244, 11816.409179540817, 12090.818637720617, 11557.13321500874, 11619.302841829518, 11753.059755219732, 11769.411529423323, 11888.227265227733, 11034.889651103385, 11061.83407248908, 11087.113030957342, 11126.388048657402, 11255.831162532404, 9418.387804792666, 9645.27660425485, 9769.85345219808, 9833.16418104469, 9882.950585247316, 9099.454032758056, 9641.710748677551, 9696.321257511907, 9724.31929764938, 9959.751006224902], "value": 7577.7793172304355, "unit": "score"}], "name": "dromaeo_css", "value": 7304.797213148605, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 114.0, 114.0, 113.0, 115.0, 114.0, 112.0, 113.0, 113.0, 113.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 113.0, 108.0, 160.0, 108.0, 101.0, 152.0, 103.0, 144.0, 107.0], "value": 124.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 184.0, 185.0, 186.0, 184.0, 182.0, 208.0, 255.0, 184.0, 196.0], "value": 194.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 73.0, 58.0, 87.0, 58.0, 63.0, 62.0, 65.0, 100.0, 56.0], "value": 69.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 87.0, 105.0, 99.0, 70.0, 69.0, 95.0, 71.0, 68.0, 104.0], "value": 85.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 88.0, 91.0, 88.0, 91.0, 88.0, 90.0, 88.0, 91.0, 88.0], "value": 89.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 97.0, 95.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 83.0, 85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 87.0, 86.0], "value": 85.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 54.0, 54.0, 54.0, 54.0, 56.0, 53.0, 54.0, 54.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 74.0, 71.0, 73.0, 72.0, 68.0, 70.0, 67.0, 68.0], "value": 69.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 88.0, 85.0, 87.0, 85.0, 83.0, 84.0, 85.0, 90.0, 86.0], "value": 85.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 140.0, 138.0, 136.0, 136.0, 136.0, 139.0, 138.0, 210.0, 137.0], "value": 145.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 172.0, 168.0, 169.0, 168.0, 167.0, 169.0, 168.0, 166.0, 168.0], "value": 168.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 68.0, 69.0, 67.0, 65.0, 65.0, 63.0, 67.0], "value": 66.6, "unit": "score"}], "name": "kraken", "value": 1445.8999999999996, "alertThreshold": 2.0}]} 14:06:11 INFO - Return code: 0 14:06:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:06:11 ERROR - # TBPL SUCCESS # 14:06:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:06:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:06:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:06:11 INFO - 2016-08-19 14:06:11.498 screenresolution[1663:9839] starting screenresolution argv=screenresolution get 14:06:11 INFO - 2016-08-19 14:06:11.500 screenresolution[1663:9839] Display 0: 1600x1200x32@60 14:06:11 INFO - 2016-08-19 14:06:11.506 screenresolution[1664:9842] starting screenresolution argv=screenresolution list 14:06:11 INFO - Available Modes on Display 0 14:06:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:06:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:06:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:06:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:06:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:06:11 INFO - Intel Iris: 14:06:11 INFO - Chipset Model: Intel Iris 14:06:11 INFO - Type: GPU 14:06:11 INFO - Bus: Built-In 14:06:11 INFO - VRAM (Dynamic, Max): 1536 MB 14:06:11 INFO - Vendor: Intel (0x8086) 14:06:11 INFO - Device ID: 0x0a2e 14:06:11 INFO - Revision ID: 0x0009 14:06:11 INFO - Displays: 14:06:11 INFO - Display: 14:06:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:06:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:06:11 INFO - Display Serial Number: 1600x1200 60 14:06:11 INFO - Main Display: Yes 14:06:11 INFO - Mirror: Off 14:06:11 INFO - Online: Yes 14:06:11 INFO - Rotation: Supported 14:06:11 INFO - Return code: 0 14:06:11 INFO - Running post-action listener: _resource_record_post_action 14:06:11 INFO - [mozharness: 2016-08-19 21:06:11.740903Z] Finished run-tests step (success) 14:06:11 INFO - Running post-run listener: _resource_record_post_run 14:06:11 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 37086208; Write bytes: 705001472; Read time: 236; Write time: 2034 14:06:11 INFO - TinderboxPrint: CPU usage
53.7% 14:06:11 INFO - TinderboxPrint: I/O read bytes / time
37,086,208 / 236 14:06:11 INFO - TinderboxPrint: I/O write bytes / time
705,001,472 / 2,034 14:06:11 INFO - TinderboxPrint: CPU idle
2,243.9 (46.3%) 14:06:11 INFO - TinderboxPrint: CPU system
968.6 (20.0%) 14:06:11 INFO - TinderboxPrint: CPU user
1,637.2 (33.8%) 14:06:11 INFO - TinderboxPrint: Swap in / out
442,793,984 / 0 14:06:11 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 386466304; Write bytes: 379742208; Read time: 29135; Write time: 852 14:06:11 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 36127744; Write bytes: 297639936; Read time: 223; Write time: 1115 14:06:12 INFO - Running post-run listener: _upload_blobber_files 14:06:12 INFO - Blob upload gear active. 14:06:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:06:12 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 14:06:12 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:06:12 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:06:12 INFO - (blobuploader) - INFO - Open directory for files ... 14:06:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:06:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:06:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:06:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:06:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:06:14 INFO - (blobuploader) - INFO - Done attempting. 14:06:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:06:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:06:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:06:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:06:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:06:15 INFO - (blobuploader) - INFO - Done attempting. 14:06:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:06:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:06:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:06:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:06:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:06:17 INFO - (blobuploader) - INFO - Done attempting. 14:06:17 INFO - (blobuploader) - INFO - Iteration through files over. 14:06:17 INFO - Return code: 0 14:06:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:06:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:06:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b8c96876e51a21f73c1996318fa57a1b1a0e45c0fe3feb4f9297d584d8e4a998c3388e44b806a80c314d13e1d30706d39a815d16a65b66b5d56e877517915e4d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ba8aefef41546ccc3671ec560b303272a94163cc7e0e8586be5ff4b9f07f903bdaf36ab20b87515318a94051c1f6978223a7e2afeec8fe28f42de850a466a40d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8c78e015ebbaa87312e6c51e04c73b4a69f703921c5a5a9fbf2f2789368931bba6e112cd5ee72cfde89e3984283148c8edaa99c6fe313095a497087e4f83460e"} 14:06:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:06:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:06:17 INFO - Contents: 14:06:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b8c96876e51a21f73c1996318fa57a1b1a0e45c0fe3feb4f9297d584d8e4a998c3388e44b806a80c314d13e1d30706d39a815d16a65b66b5d56e877517915e4d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ba8aefef41546ccc3671ec560b303272a94163cc7e0e8586be5ff4b9f07f903bdaf36ab20b87515318a94051c1f6978223a7e2afeec8fe28f42de850a466a40d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8c78e015ebbaa87312e6c51e04c73b4a69f703921c5a5a9fbf2f2789368931bba6e112cd5ee72cfde89e3984283148c8edaa99c6fe313095a497087e4f83460e"} 14:06:17 INFO - Running post-run listener: copy_logs_to_upload_dir 14:06:17 INFO - Copying logs to upload dir... 14:06:17 INFO - mkdir: /builds/slave/test/build/upload/logs 14:06:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.858922 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-08-19 14:06:17.829458) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-19 14:06:17.832966) ========= 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.kn1ylyn9xf/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.O3vBRCIqRT/Listeners TMPDIR=/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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/Fx-Team/sha512/b8c96876e51a21f73c1996318fa57a1b1a0e45c0fe3feb4f9297d584d8e4a998c3388e44b806a80c314d13e1d30706d39a815d16a65b66b5d56e877517915e4d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ba8aefef41546ccc3671ec560b303272a94163cc7e0e8586be5ff4b9f07f903bdaf36ab20b87515318a94051c1f6978223a7e2afeec8fe28f42de850a466a40d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8c78e015ebbaa87312e6c51e04c73b4a69f703921c5a5a9fbf2f2789368931bba6e112cd5ee72cfde89e3984283148c8edaa99c6fe313095a497087e4f83460e"} build_url:https://queue.taskcluster.net/v1/task/X7wbiwOiQFGQ64rIAW6KAg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011105 build_url: 'https://queue.taskcluster.net/v1/task/X7wbiwOiQFGQ64rIAW6KAg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b8c96876e51a21f73c1996318fa57a1b1a0e45c0fe3feb4f9297d584d8e4a998c3388e44b806a80c314d13e1d30706d39a815d16a65b66b5d56e877517915e4d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ba8aefef41546ccc3671ec560b303272a94163cc7e0e8586be5ff4b9f07f903bdaf36ab20b87515318a94051c1f6978223a7e2afeec8fe28f42de850a466a40d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8c78e015ebbaa87312e6c51e04c73b4a69f703921c5a5a9fbf2f2789368931bba6e112cd5ee72cfde89e3984283148c8edaa99c6fe313095a497087e4f83460e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-19 14:06:17.868035) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 14:06:17.868359) ========= 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.kn1ylyn9xf/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.O3vBRCIqRT/Listeners TMPDIR=/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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.005069 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 14:06:17.917693) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-19 14:06:17.918020) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-19 14:06:17.918356) ========= ========= Total master_lag: 0.18 =========