builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0190 starttime: 1471611060.05 results: success (0) buildid: 20160819034155 builduid: bc7fef971c7244a0b5f0a315241d0afd revision: 7700ad7a72edf62983555b21a88879fa75dc4ec1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-19 05:51:00.055706) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-19 05:51:00.056149) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-19 05:51:00.056453) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-19 05:51:00.080974) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 05:51:00.081365) ========= 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.quxg7cZzct/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.vP8pfcd5k4/Listeners TMPDIR=/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 05:51:00-- 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% 170M=0s 2016-08-19 05:51:00 (170 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098070 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 05:51:00.201815) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 05:51:00.202131) ========= 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.quxg7cZzct/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.vP8pfcd5k4/Listeners TMPDIR=/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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.020784 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 05:51:00.251217) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-19 05:51:00.251583) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7700ad7a72edf62983555b21a88879fa75dc4ec1 --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 7700ad7a72edf62983555b21a88879fa75dc4ec1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.quxg7cZzct/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.vP8pfcd5k4/Listeners TMPDIR=/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 05:51:00,331 truncating revision to first 12 chars 2016-08-19 05:51:00,331 Setting DEBUG logging. 2016-08-19 05:51:00,331 attempt 1/10 2016-08-19 05:51:00,331 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7700ad7a72ed?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-19 05:51:01,495 unpacking tar archive at: fx-team-7700ad7a72ed/testing/mozharness/ program finished with exit code 0 elapsedTime=1.429475 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-19 05:51:01.705369) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-19 05:51:01.705695) ========= script_repo_revision: 7700ad7a72edf62983555b21a88879fa75dc4ec1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-19 05:51:01.706152) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-19 05:51:01.706455) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-19 05:51:01.726072) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-08-19 05:51:01.726374) ========= /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.quxg7cZzct/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.vP8pfcd5k4/Listeners TMPDIR=/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 05:51:01 INFO - MultiFileLogger online at 20160819 05:51:01 in /builds/slave/test 05:51: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 05:51:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:51:01 INFO - {'append_to_log': False, 05:51:01 INFO - 'base_work_dir': '/builds/slave/test', 05:51:01 INFO - 'blob_upload_branch': 'Fx-Team', 05:51:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:51:01 INFO - 'branch': 'Fx-Team', 05:51:01 INFO - 'buildbot_json_path': 'buildprops.json', 05:51:01 INFO - 'config_files': ('talos/mac_config.py',), 05:51:01 INFO - 'default_actions': ('clobber', 05:51:01 INFO - 'read-buildbot-config', 05:51:01 INFO - 'download-and-extract', 05:51:01 INFO - 'populate-webroot', 05:51:01 INFO - 'create-virtualenv', 05:51:01 INFO - 'install', 05:51:01 INFO - 'run-tests'), 05:51:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:51:01 INFO - 'download_minidump_stackwalk': True, 05:51:01 INFO - 'download_symbols': 'ondemand', 05:51:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:51:01 INFO - 'tooltool.py': '/tools/tooltool.py', 05:51:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:51:01 INFO - '/tools/misc-python/virtualenv.py')}, 05:51:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:51:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:51:01 INFO - 'installer_path': 'installer.exe', 05:51:01 INFO - 'log_level': 'info', 05:51:01 INFO - 'log_name': 'talos', 05:51:01 INFO - 'log_to_console': True, 05:51:01 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:51:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:51:01 INFO - 'opt_config_files': (), 05:51:01 INFO - 'pip_index': False, 05:51:01 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:51:01 INFO - 'cmd': ('bash', 05:51:01 INFO - '-c', 05:51:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:51:01 INFO - 'enabled': True, 05:51:01 INFO - 'halt_on_failure': False, 05:51:01 INFO - 'name': 'check_screen_resolution'},), 05:51:01 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:51:01 INFO - 'cmd': ('bash', 05:51:01 INFO - '-c', 05:51:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:51:01 INFO - 'enabled': True, 05:51:01 INFO - 'halt_on_failure': False, 05:51:01 INFO - 'name': 'check_screen_resolution'},), 05:51:01 INFO - 'run_cmd_checks_enabled': True, 05:51:01 INFO - 'sps_profile': False, 05:51:01 INFO - 'sps_profile_interval': 0, 05:51:01 INFO - 'suite': 'dromaeojs', 05:51:01 INFO - 'system_bits': '32', 05:51:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:51:01 INFO - 'title': 't-yosemite-r7-0190', 05:51:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:51:01 INFO - 'use_talos_json': True, 05:51:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:51:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:51:01 INFO - 'work_dir': 'build'} 05:51:01 INFO - [mozharness: 2016-08-19 12:51:01.938926Z] Running clobber step. 05:51:01 INFO - Running pre-action listener: _resource_record_pre_action 05:51:01 INFO - Running main action method: clobber 05:51:01 INFO - rmtree: /builds/slave/test/build 05:51:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:51:03 INFO - Running post-action listener: _resource_record_post_action 05:51:03 INFO - [mozharness: 2016-08-19 12:51:03.765658Z] Finished clobber step (success) 05:51:03 INFO - [mozharness: 2016-08-19 12:51:03.765863Z] Running read-buildbot-config step. 05:51:03 INFO - Running pre-action listener: _resource_record_pre_action 05:51:03 INFO - Running main action method: read_buildbot_config 05:51:03 INFO - Using buildbot properties: 05:51:03 INFO - { 05:51:03 INFO - "project": "", 05:51:03 INFO - "product": "firefox", 05:51:03 INFO - "script_repo_revision": "production", 05:51:03 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 05:51:03 INFO - "repository": "", 05:51:03 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 05:51:03 INFO - "buildid": "20160819034155", 05:51:03 INFO - "pgo_build": "False", 05:51:03 INFO - "basedir": "/builds/slave/test", 05:51:03 INFO - "buildnumber": 123, 05:51:03 INFO - "slavename": "t-yosemite-r7-0190", 05:51:03 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 05:51:03 INFO - "platform": "yosemite_r7", 05:51:03 INFO - "scheduler": "tests-fx-team-macosx64-talos", 05:51:03 INFO - "branch": "fx-team", 05:51:03 INFO - "repo_path": "integration/fx-team", 05:51:03 INFO - "revision": "7700ad7a72edf62983555b21a88879fa75dc4ec1", 05:51:03 INFO - "stage_platform": "macosx64", 05:51:03 INFO - "builduid": "bc7fef971c7244a0b5f0a315241d0afd", 05:51:03 INFO - "slavebuilddir": "test" 05:51:03 INFO - } 05:51:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/Db6Sj8WTTPyAHQcmfEoraA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 05:51:03 INFO - Running post-action listener: _resource_record_post_action 05:51:03 INFO - [mozharness: 2016-08-19 12:51:03.769670Z] Finished read-buildbot-config step (success) 05:51:03 INFO - [mozharness: 2016-08-19 12:51:03.769822Z] Running download-and-extract step. 05:51:03 INFO - Running pre-action listener: _resource_record_pre_action 05:51:03 INFO - Running main action method: download_and_extract 05:51:03 INFO - mkdir: /builds/slave/test/build/tests 05:51: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')]} 05:51:03 INFO - trying https://queue.taskcluster.net/v1/task/Db6Sj8WTTPyAHQcmfEoraA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 05:51:03 INFO - Downloading https://queue.taskcluster.net/v1/task/Db6Sj8WTTPyAHQcmfEoraA/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 05:51:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Db6Sj8WTTPyAHQcmfEoraA/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 05:51:04 INFO - Downloaded 1199 bytes. 05:51:04 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 05:51:04 INFO - Using the following test package requirements: 05:51:04 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 05:51:04 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:51:04 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 05:51:04 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:51:04 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 05:51:04 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:51:04 INFO - u'jsshell-mac.zip'], 05:51:04 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:51:04 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 05:51:04 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 05:51:04 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:51:04 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 05:51:04 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:51:04 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 05:51:04 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:51:04 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 05:51:04 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:51:04 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 05:51:04 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:51: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')]} 05:51:04 INFO - trying https://queue.taskcluster.net/v1/task/Db6Sj8WTTPyAHQcmfEoraA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:51:04 INFO - Downloading https://queue.taskcluster.net/v1/task/Db6Sj8WTTPyAHQcmfEoraA/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 05:51:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Db6Sj8WTTPyAHQcmfEoraA/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 05:51:05 INFO - Downloaded 16339549 bytes. 05:51:05 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 05:51: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 05:51: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')]} 05:51:12 INFO - trying https://queue.taskcluster.net/v1/task/Db6Sj8WTTPyAHQcmfEoraA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:51:12 INFO - Downloading https://queue.taskcluster.net/v1/task/Db6Sj8WTTPyAHQcmfEoraA/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 05:51:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Db6Sj8WTTPyAHQcmfEoraA/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 05:51:13 INFO - Downloaded 16339549 bytes. 05:51: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 05:51:19 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')]} 05:51:19 INFO - trying https://queue.taskcluster.net/v1/task/Db6Sj8WTTPyAHQcmfEoraA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 05:51:19 INFO - Downloading https://queue.taskcluster.net/v1/task/Db6Sj8WTTPyAHQcmfEoraA/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 05:51:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Db6Sj8WTTPyAHQcmfEoraA/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 05:51:21 INFO - Downloaded 14413981 bytes. 05:51:21 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 05:51:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:51:21 INFO - trying https://queue.taskcluster.net/v1/task/Db6Sj8WTTPyAHQcmfEoraA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:51:21 INFO - Downloading https://queue.taskcluster.net/v1/task/Db6Sj8WTTPyAHQcmfEoraA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 05:51:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Db6Sj8WTTPyAHQcmfEoraA/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 05:51:24 INFO - Downloaded 111248044 bytes. 05:51:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Db6Sj8WTTPyAHQcmfEoraA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:51:24 INFO - mkdir: /builds/slave/test/properties 05:51:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:51:24 INFO - Writing to file /builds/slave/test/properties/build_url 05:51:24 INFO - Contents: 05:51:24 INFO - build_url:https://queue.taskcluster.net/v1/task/Db6Sj8WTTPyAHQcmfEoraA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:51:24 INFO - Running post-action listener: _resource_record_post_action 05:51:24 INFO - Running post-action listener: set_extra_try_arguments 05:51:24 INFO - [mozharness: 2016-08-19 12:51:24.966643Z] Finished download-and-extract step (success) 05:51:24 INFO - [mozharness: 2016-08-19 12:51:24.966769Z] Running populate-webroot step. 05:51:24 INFO - Running pre-action listener: _resource_record_pre_action 05:51:24 INFO - Running main action method: populate_webroot 05:51:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:51:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:51:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:51:24 INFO - '--tppagecycles', 05:51:24 INFO - '7'], 05:51:24 INFO - 'tests': ['tsvgm']}}, 05:51:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:51:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:51:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:51:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:51:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:51:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:51:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:24 INFO - 'talos_options': ['--disable-e10s'], 05:51:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:51:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:51:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:24 INFO - 'talos_options': ['--disable-e10s'], 05:51:24 INFO - 'tests': ['damp', 'tps']}, 05:51:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:24 INFO - 'tests': ['damp', 'tps']}, 05:51:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:51:24 INFO - 'tests': ['dromaeo_dom']}, 05:51:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:51:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:51:24 INFO - 'tests': ['basic_compositor_video']}, 05:51:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:51:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:51:24 INFO - 'tests': ['a11yr', 05:51:24 INFO - 'ts_paint', 05:51:24 INFO - 'tpaint', 05:51:24 INFO - 'sessionrestore', 05:51:24 INFO - 'sessionrestore_no_auto_restore', 05:51:24 INFO - 'tabpaint']}, 05:51:24 INFO - 'other-e10s': {'tests': ['a11yr', 05:51:24 INFO - 'ts_paint', 05:51:24 INFO - 'tpaint', 05:51:24 INFO - 'sessionrestore', 05:51:24 INFO - 'sessionrestore_no_auto_restore', 05:51:24 INFO - 'tabpaint']}, 05:51:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:51:24 INFO - 'ts_paint', 05:51:24 INFO - 'tpaint', 05:51:24 INFO - 'sessionrestore', 05:51:24 INFO - 'sessionrestore_no_auto_restore', 05:51:24 INFO - 'tabpaint']}, 05:51:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:51:24 INFO - 'ts_paint', 05:51:24 INFO - 'tpaint', 05:51:24 INFO - 'sessionrestore', 05:51:24 INFO - 'sessionrestore_no_auto_restore', 05:51:24 INFO - 'tabpaint']}, 05:51:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:51:24 INFO - 'tests': ['a11yr', 05:51:24 INFO - 'ts_paint', 05:51:24 INFO - 'tpaint', 05:51:24 INFO - 'sessionrestore', 05:51:24 INFO - 'sessionrestore_no_auto_restore', 05:51:24 INFO - 'tabpaint']}, 05:51:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:51:24 INFO - 'tests': ['a11yr', 05:51:24 INFO - 'ts_paint', 05:51:24 INFO - 'tpaint', 05:51:24 INFO - 'sessionrestore', 05:51:24 INFO - 'sessionrestore_no_auto_restore', 05:51:24 INFO - 'tabpaint']}, 05:51:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:51:24 INFO - 'tests': ['tsvgx', 05:51:24 INFO - 'tsvgr_opacity', 05:51:24 INFO - 'tart', 05:51:24 INFO - 'tscrollx', 05:51:24 INFO - 'cart']}, 05:51:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:51:24 INFO - 'tsvgr_opacity', 05:51:24 INFO - 'tart', 05:51:24 INFO - 'tscrollx', 05:51:24 INFO - 'cart']}, 05:51:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:24 INFO - 'talos_options': ['--disable-e10s'], 05:51:24 INFO - 'tests': ['tp5o']}, 05:51:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:24 INFO - 'tests': ['tp5o']}, 05:51:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:24 INFO - 'talos_options': ['--disable-e10s', 05:51:24 INFO - '--xperf_path', 05:51:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:51:24 INFO - 'tests': ['tp5n']}, 05:51:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:24 INFO - 'talos_options': ['--xperf_path', 05:51:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:51:24 INFO - 'tests': ['tp5n']}}, 05:51:24 INFO - 'talos.zip': {'path': '', 05:51:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:51:24 INFO - Running post-action listener: _resource_record_post_action 05:51:24 INFO - [mozharness: 2016-08-19 12:51:24.985338Z] Finished populate-webroot step (success) 05:51:24 INFO - [mozharness: 2016-08-19 12:51:24.985468Z] Running create-virtualenv step. 05:51:24 INFO - Running pre-action listener: _resource_record_pre_action 05:51:24 INFO - Running main action method: create_virtualenv 05:51:24 INFO - Creating virtualenv /builds/slave/test/build/venv 05:51:24 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 05:51:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:51:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:51:25 INFO - Using real prefix '/tools/python27' 05:51:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:51:25 INFO - Installing distribute.............................................................................................................................................................................................done. 05:51:28 INFO - Installing pip.................done. 05:51:28 INFO - Return code: 0 05:51:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:51:28 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')]} 05:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:28 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')]} 05:51:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:28 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 0x10b9c5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba5a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5c949a960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b929d30>, '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 0x10b68edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b921b20>, '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.quxg7cZzct/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.vP8pfcd5k4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 05:51:28 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 05:51:28 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 05:51:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.quxg7cZzct/Render', 05:51:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:51:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:51:28 INFO - 'HOME': '/Users/cltbld', 05:51:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:51:28 INFO - 'LOGNAME': 'cltbld', 05:51:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:28 INFO - 'MOZ_NO_REMOTE': '1', 05:51:28 INFO - 'NO_EM_RESTART': '1', 05:51:28 INFO - 'PAGER': '/bin/cat', 05:51:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:51:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:28 INFO - 'PWD': '/builds/slave/test', 05:51:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:51:28 INFO - 'SHELL': '/bin/bash', 05:51:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vP8pfcd5k4/Listeners', 05:51:28 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 05:51:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:51:28 INFO - 'USER': 'cltbld', 05:51:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:51:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:51:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:28 INFO - 'XPC_FLAGS': '0x0', 05:51:28 INFO - 'XPC_SERVICE_NAME': '0', 05:51:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:51:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:28 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 05:51:28 INFO - Cleaning up... 05:51:28 INFO - Return code: 0 05:51:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:51:28 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')]} 05:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:28 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')]} 05:51:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:28 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 0x10b9c5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba5a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5c949a960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b929d30>, '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 0x10b68edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b921b20>, '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.quxg7cZzct/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.vP8pfcd5k4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 05:51:28 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 05:51:28 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 05:51:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.quxg7cZzct/Render', 05:51:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:51:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:51:28 INFO - 'HOME': '/Users/cltbld', 05:51:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:51:28 INFO - 'LOGNAME': 'cltbld', 05:51:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:28 INFO - 'MOZ_NO_REMOTE': '1', 05:51:28 INFO - 'NO_EM_RESTART': '1', 05:51:28 INFO - 'PAGER': '/bin/cat', 05:51:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:51:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:28 INFO - 'PWD': '/builds/slave/test', 05:51:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:51:28 INFO - 'SHELL': '/bin/bash', 05:51:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vP8pfcd5k4/Listeners', 05:51:28 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 05:51:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:51:28 INFO - 'USER': 'cltbld', 05:51:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:51:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:51:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:28 INFO - 'XPC_FLAGS': '0x0', 05:51:28 INFO - 'XPC_SERVICE_NAME': '0', 05:51:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:51:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:29 INFO - Downloading/unpacking psutil>=3.1.1 05:51:29 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 05:51:29 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 05:51:29 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 05:51:29 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 05:51:29 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 05:51:29 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 05:51:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:51:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:51:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:51:32 INFO - Installing collected packages: psutil 05:51:32 INFO - Running setup.py install for psutil 05:51:32 INFO - building 'psutil._psutil_osx' extension 05:51:32 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 05:51:32 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 05:51:32 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 05:51:33 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 05:51:33 INFO - building 'psutil._psutil_posix' extension 05:51:33 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 05:51:33 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:51:33 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:51:33 INFO - ^ 05:51:33 INFO - 1 warning generated. 05:51:33 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 05:51:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:51:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:51:33 INFO - Successfully installed psutil 05:51:33 INFO - Cleaning up... 05:51:33 INFO - Return code: 0 05:51:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:51: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')]} 05:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51: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')]} 05:51:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:33 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 0x10b9c5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba5a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5c949a960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b929d30>, '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 0x10b68edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b921b20>, '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.quxg7cZzct/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.vP8pfcd5k4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 05:51:33 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 05:51:33 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 05:51:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.quxg7cZzct/Render', 05:51:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:51:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:51:33 INFO - 'HOME': '/Users/cltbld', 05:51:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:51:33 INFO - 'LOGNAME': 'cltbld', 05:51:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:33 INFO - 'MOZ_NO_REMOTE': '1', 05:51:33 INFO - 'NO_EM_RESTART': '1', 05:51:33 INFO - 'PAGER': '/bin/cat', 05:51:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:51:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:33 INFO - 'PWD': '/builds/slave/test', 05:51:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:51:33 INFO - 'SHELL': '/bin/bash', 05:51:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vP8pfcd5k4/Listeners', 05:51:33 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 05:51:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:51:33 INFO - 'USER': 'cltbld', 05:51:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:51:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:51:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:33 INFO - 'XPC_FLAGS': '0x0', 05:51:33 INFO - 'XPC_SERVICE_NAME': '0', 05:51:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:51:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:51:33 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 05:51:33 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 05:51:33 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 05:51:33 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 05:51:33 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 05:51:33 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 05:51:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:51:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:51:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:51:36 INFO - Installing collected packages: mozsystemmonitor 05:51:36 INFO - Running setup.py install for mozsystemmonitor 05:51:36 INFO - Successfully installed mozsystemmonitor 05:51:36 INFO - Cleaning up... 05:51:36 INFO - Return code: 0 05:51:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:51:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:51:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:51:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:36 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 0x10b9c5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba5a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5c949a960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b929d30>, '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 0x10b68edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b921b20>, '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.quxg7cZzct/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.vP8pfcd5k4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 05:51:36 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 05:51:36 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 05:51:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.quxg7cZzct/Render', 05:51:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:51:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:51:36 INFO - 'HOME': '/Users/cltbld', 05:51:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:51:36 INFO - 'LOGNAME': 'cltbld', 05:51:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:36 INFO - 'MOZ_NO_REMOTE': '1', 05:51:36 INFO - 'NO_EM_RESTART': '1', 05:51:36 INFO - 'PAGER': '/bin/cat', 05:51:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:51:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:36 INFO - 'PWD': '/builds/slave/test', 05:51:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:51:36 INFO - 'SHELL': '/bin/bash', 05:51:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vP8pfcd5k4/Listeners', 05:51:36 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 05:51:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:51:36 INFO - 'USER': 'cltbld', 05:51:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:51:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:51:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:36 INFO - 'XPC_FLAGS': '0x0', 05:51:36 INFO - 'XPC_SERVICE_NAME': '0', 05:51:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:51:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:36 INFO - Downloading/unpacking jsonschema==2.5.1 05:51: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 05:51: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 05:51: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 05:51: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 05:51: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 05:51: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 05:51:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:51:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:51: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 05:51: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 05:51: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 05:51: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 05:51: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 05:51: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 05:51:39 INFO - Downloading functools32-3.2.3-2.tar.gz 05:51:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:51:39 INFO - warning: no files found matching '*.txt' 05:51:39 INFO - no previously-included directories found matching 'build' 05:51:39 INFO - no previously-included directories found matching 'dist' 05:51:39 INFO - no previously-included directories found matching '.git*' 05:51:39 INFO - Installing collected packages: jsonschema, functools32 05:51:39 INFO - Running setup.py install for functools32 05:51:39 INFO - warning: no files found matching '*.txt' 05:51:39 INFO - no previously-included directories found matching 'build' 05:51:39 INFO - no previously-included directories found matching 'dist' 05:51:39 INFO - no previously-included directories found matching '.git*' 05:51:39 INFO - Successfully installed jsonschema functools32 05:51:39 INFO - Cleaning up... 05:51:39 INFO - Return code: 0 05:51:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:51:39 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')]} 05:51:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:39 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')]} 05:51:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:39 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 0x10b9c5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba5a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5c949a960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b929d30>, '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 0x10b68edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b921b20>, '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.quxg7cZzct/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.vP8pfcd5k4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 05:51:39 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 05:51:39 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 05:51:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.quxg7cZzct/Render', 05:51:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:51:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:51:39 INFO - 'HOME': '/Users/cltbld', 05:51:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:51:39 INFO - 'LOGNAME': 'cltbld', 05:51:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:39 INFO - 'MOZ_NO_REMOTE': '1', 05:51:39 INFO - 'NO_EM_RESTART': '1', 05:51:39 INFO - 'PAGER': '/bin/cat', 05:51:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:51:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:39 INFO - 'PWD': '/builds/slave/test', 05:51:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:51:39 INFO - 'SHELL': '/bin/bash', 05:51:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vP8pfcd5k4/Listeners', 05:51:39 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 05:51:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:51:39 INFO - 'USER': 'cltbld', 05:51:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:51:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:51:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:39 INFO - 'XPC_FLAGS': '0x0', 05:51:39 INFO - 'XPC_SERVICE_NAME': '0', 05:51:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:51:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:40 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:51:40 INFO - Cleaning up... 05:51:40 INFO - Return code: 0 05:51:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:51:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:51:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:51:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b9c5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba5a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5c949a960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b929d30>, '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 0x10b68edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b921b20>, '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.quxg7cZzct/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.vP8pfcd5k4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 05:51:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:51:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:51:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.quxg7cZzct/Render', 05:51:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:51:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:51:40 INFO - 'HOME': '/Users/cltbld', 05:51:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:51:40 INFO - 'LOGNAME': 'cltbld', 05:51:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:40 INFO - 'MOZ_NO_REMOTE': '1', 05:51:40 INFO - 'NO_EM_RESTART': '1', 05:51:40 INFO - 'PAGER': '/bin/cat', 05:51:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:51:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:40 INFO - 'PWD': '/builds/slave/test', 05:51:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:51:40 INFO - 'SHELL': '/bin/bash', 05:51:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vP8pfcd5k4/Listeners', 05:51:40 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 05:51:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:51:40 INFO - 'USER': 'cltbld', 05:51:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:51:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:51:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:40 INFO - 'XPC_FLAGS': '0x0', 05:51:40 INFO - 'XPC_SERVICE_NAME': '0', 05:51:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:51:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:40 INFO - Downloading/unpacking blobuploader==1.2.4 05:51:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:42 INFO - Downloading blobuploader-1.2.4.tar.gz 05:51:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:51:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:51: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 05:51: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 05:51: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 05:51: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 05:51: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 05:51: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 05:51:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:51:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:51:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:43 INFO - Downloading docopt-0.6.1.tar.gz 05:51:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:51:43 INFO - Installing collected packages: blobuploader, requests, docopt 05:51:43 INFO - Running setup.py install for blobuploader 05:51:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:51:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:51:44 INFO - Running setup.py install for requests 05:51:44 INFO - Running setup.py install for docopt 05:51:44 INFO - Successfully installed blobuploader requests docopt 05:51:44 INFO - Cleaning up... 05:51:44 INFO - Return code: 0 05:51:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:51:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:51:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:51:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:44 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 0x10b9c5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba5a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5c949a960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b929d30>, '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 0x10b68edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b921b20>, '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.quxg7cZzct/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.vP8pfcd5k4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 05:51:44 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 05:51:44 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 05:51:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.quxg7cZzct/Render', 05:51:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:51:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:51:44 INFO - 'HOME': '/Users/cltbld', 05:51:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:51:44 INFO - 'LOGNAME': 'cltbld', 05:51:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:44 INFO - 'MOZ_NO_REMOTE': '1', 05:51:44 INFO - 'NO_EM_RESTART': '1', 05:51:44 INFO - 'PAGER': '/bin/cat', 05:51:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:51:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:44 INFO - 'PWD': '/builds/slave/test', 05:51:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:51:44 INFO - 'SHELL': '/bin/bash', 05:51:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vP8pfcd5k4/Listeners', 05:51:44 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 05:51:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:51:44 INFO - 'USER': 'cltbld', 05:51:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:51:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:51:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:44 INFO - 'XPC_FLAGS': '0x0', 05:51:44 INFO - 'XPC_SERVICE_NAME': '0', 05:51:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:51:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:51:45 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-XVEpzj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:51:45 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-ngLQir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:51:45 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-d9ZzHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:51:45 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-FPynoV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:51:45 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-wUb_bd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:51:45 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-lMEbwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:51:45 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-fpeMg3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:51:45 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-3O1_kq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:51:45 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-Yukx8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:51:46 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-7d2Ki_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:51:46 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-lUgx38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:51:46 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-xy9SxP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:51:46 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-vA4XbG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:51:46 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-Cw0F5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:51:46 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-0Vi7Kb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:51:46 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-rQUhAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:51:46 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-P0xX7E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:51:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:51:46 INFO - Running setup.py install for manifestparser 05:51:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:51:47 INFO - Running setup.py install for mozcrash 05:51:47 INFO - Running setup.py install for mozdebug 05:51:47 INFO - Running setup.py install for mozdevice 05:51:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:51:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:51:47 INFO - Running setup.py install for mozfile 05:51:47 INFO - Running setup.py install for mozhttpd 05:51:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:51:47 INFO - Running setup.py install for mozinfo 05:51:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:51:47 INFO - Running setup.py install for mozInstall 05:51:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:51:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:51:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:51:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:51:48 INFO - Running setup.py install for mozleak 05:51:48 INFO - Running setup.py install for mozlog 05:51:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:51:48 INFO - Running setup.py install for moznetwork 05:51:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:51:48 INFO - Running setup.py install for mozprocess 05:51:48 INFO - Running setup.py install for mozprofile 05:51:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:51:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:51:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:51:48 INFO - Running setup.py install for mozrunner 05:51:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:51:49 INFO - Running setup.py install for mozscreenshot 05:51:49 INFO - Running setup.py install for moztest 05:51:49 INFO - Running setup.py install for mozversion 05:51:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:51:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:51:49 INFO - Cleaning up... 05:51:49 INFO - Return code: 0 05:51:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:51:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:51:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:49 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 0x10b9c5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba5a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5c949a960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b929d30>, '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 0x10b68edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b921b20>, '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.quxg7cZzct/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.vP8pfcd5k4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 05:51:49 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 05:51:49 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 05:51:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.quxg7cZzct/Render', 05:51:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:51:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:51:49 INFO - 'HOME': '/Users/cltbld', 05:51:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:51:49 INFO - 'LOGNAME': 'cltbld', 05:51:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:49 INFO - 'MOZ_NO_REMOTE': '1', 05:51:49 INFO - 'NO_EM_RESTART': '1', 05:51:49 INFO - 'PAGER': '/bin/cat', 05:51:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:51:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:49 INFO - 'PWD': '/builds/slave/test', 05:51:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:51:49 INFO - 'SHELL': '/bin/bash', 05:51:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vP8pfcd5k4/Listeners', 05:51:49 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 05:51:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:51:49 INFO - 'USER': 'cltbld', 05:51:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:51:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:51:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:49 INFO - 'XPC_FLAGS': '0x0', 05:51:49 INFO - 'XPC_SERVICE_NAME': '0', 05:51:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:51:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:51:49 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-kmUBhb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:51:49 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)) 05:51:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:51:49 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-hJxjPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:51:49 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)) 05:51:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:51:49 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-b6LuYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:51:50 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)) 05:51:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:51:50 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-FkOZp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:51:50 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)) 05:51:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:51:50 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-uUGA1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:51:50 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)) 05:51:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:51:50 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-kb2Ot5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:51:50 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)) 05:51:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:51:50 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-EWRNhe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:51:50 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)) 05:51:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:51:50 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-GxnXaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:51:50 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)) 05:51:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:51:50 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-GDb5ZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:51:50 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)) 05:51:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:51:50 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-_SGDIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:51:50 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)) 05:51:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:51:50 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-xb0yWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:51:50 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)) 05:51:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:51:50 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-akMUFo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:51:51 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)) 05:51:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:51:51 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-lJ6gwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:51:51 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)) 05:51:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:51:51 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-fMklIa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:51:51 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)) 05:51:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:51:51 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-fP6WbH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:51:51 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)) 05:51:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:51:51 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-UzhRvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:51:51 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)) 05:51:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:51:51 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-tzAhMa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:51:51 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)) 05:51:51 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)) 05:51:51 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)) 05:51:51 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)) 05:51:51 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)) 05:51:51 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)) 05:51:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:51:51 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 05:51:51 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 05:51:51 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 05:51:51 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 05:51:51 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 05:51:51 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 05:51:53 INFO - Downloading blessings-1.6.tar.gz 05:51:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:51:54 INFO - Installing collected packages: blessings 05:51:54 INFO - Running setup.py install for blessings 05:51:54 INFO - Successfully installed blessings 05:51:54 INFO - Cleaning up... 05:51:54 INFO - Return code: 0 05:51:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:51:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:51:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:51:54 INFO - Reading from file tmpfile_stdout 05:51:54 INFO - Current package versions: 05:51:54 INFO - blessings == 1.6 05:51:54 INFO - blobuploader == 1.2.4 05:51:54 INFO - docopt == 0.6.1 05:51:54 INFO - functools32 == 3.2.3-2 05:51:54 INFO - jsonschema == 2.5.1 05:51:54 INFO - manifestparser == 1.1 05:51:54 INFO - mozInstall == 1.12 05:51:54 INFO - mozcrash == 0.17 05:51:54 INFO - mozdebug == 0.1 05:51:54 INFO - mozdevice == 0.48 05:51:54 INFO - mozfile == 1.2 05:51:54 INFO - mozhttpd == 0.7 05:51:54 INFO - mozinfo == 0.9 05:51:54 INFO - mozleak == 0.1 05:51:54 INFO - mozlog == 3.3 05:51:54 INFO - moznetwork == 0.27 05:51:54 INFO - mozprocess == 0.23 05:51:54 INFO - mozprofile == 0.28 05:51:54 INFO - mozrunner == 6.12 05:51:54 INFO - mozscreenshot == 0.1 05:51:54 INFO - mozsystemmonitor == 0.3 05:51:54 INFO - moztest == 0.7 05:51:54 INFO - mozversion == 1.4 05:51:54 INFO - psutil == 3.1.1 05:51:54 INFO - requests == 1.2.3 05:51:54 INFO - wsgiref == 0.1.2 05:51:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:51:54 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')]} 05:51:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:54 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')]} 05:51:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:54 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 0x10b9c5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba5a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5c949a960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b929d30>, '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 0x10b68edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b921b20>, '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.quxg7cZzct/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.vP8pfcd5k4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 05:51:54 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 05:51:54 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 05:51:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.quxg7cZzct/Render', 05:51:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:51:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:51:54 INFO - 'HOME': '/Users/cltbld', 05:51:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:51:54 INFO - 'LOGNAME': 'cltbld', 05:51:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:54 INFO - 'MOZ_NO_REMOTE': '1', 05:51:54 INFO - 'NO_EM_RESTART': '1', 05:51:54 INFO - 'PAGER': '/bin/cat', 05:51:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:51:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:54 INFO - 'PWD': '/builds/slave/test', 05:51:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:51:54 INFO - 'SHELL': '/bin/bash', 05:51:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vP8pfcd5k4/Listeners', 05:51:54 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 05:51:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:51:54 INFO - 'USER': 'cltbld', 05:51:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:51:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:51:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:54 INFO - 'XPC_FLAGS': '0x0', 05:51:54 INFO - 'XPC_SERVICE_NAME': '0', 05:51:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:51:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:54 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)) 05:51:54 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)) 05:51:54 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)) 05:51:54 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)) 05:51:54 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)) 05:51:54 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)) 05:51:54 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)) 05:51:54 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)) 05:51:54 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)) 05:51:54 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)) 05:51:54 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)) 05:51:54 INFO - Cleaning up... 05:51:54 INFO - Return code: 0 05:51:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:51:54 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')]} 05:51:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:54 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')]} 05:51:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:54 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 0x10b9c5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba5a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5c949a960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b929d30>, '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 0x10b68edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b921b20>, '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.quxg7cZzct/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.vP8pfcd5k4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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 05:51:54 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 05:51:54 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 05:51:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.quxg7cZzct/Render', 05:51:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:51:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:51:54 INFO - 'HOME': '/Users/cltbld', 05:51:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:51:54 INFO - 'LOGNAME': 'cltbld', 05:51:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:54 INFO - 'MOZ_NO_REMOTE': '1', 05:51:54 INFO - 'NO_EM_RESTART': '1', 05:51:54 INFO - 'PAGER': '/bin/cat', 05:51:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:51:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:54 INFO - 'PWD': '/builds/slave/test', 05:51:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:51:54 INFO - 'SHELL': '/bin/bash', 05:51:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vP8pfcd5k4/Listeners', 05:51:54 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 05:51:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:51:54 INFO - 'USER': 'cltbld', 05:51:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:51:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:51:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:54 INFO - 'XPC_FLAGS': '0x0', 05:51:54 INFO - 'XPC_SERVICE_NAME': '0', 05:51:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:51:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:51:55 INFO - Cleaning up... 05:51:55 INFO - Return code: 0 05:51:55 INFO - Running post-action listener: _resource_record_post_action 05:51:55 INFO - Running post-action listener: _start_resource_monitoring 05:51:55 INFO - Starting resource monitoring. 05:51:55 INFO - [mozharness: 2016-08-19 12:51:55.169711Z] Finished create-virtualenv step (success) 05:51:55 INFO - [mozharness: 2016-08-19 12:51:55.170736Z] Running install step. 05:51:55 INFO - Running pre-action listener: _resource_record_pre_action 05:51:55 INFO - Running main action method: install 05:51:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:51:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:51:55 INFO - Reading from file tmpfile_stdout 05:51:55 INFO - Detecting whether we're running mozinstall >=1.0... 05:51:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:51:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:51:55 INFO - Reading from file tmpfile_stdout 05:51:55 INFO - Output received: 05:51:55 INFO - Usage: mozinstall [options] installer 05:51:55 INFO - Options: 05:51:55 INFO - -h, --help show this help message and exit 05:51:55 INFO - -d DEST, --destination=DEST 05:51:55 INFO - Directory to install application into. [default: 05:51:55 INFO - "/builds/slave/test"] 05:51:55 INFO - --app=APP Application being installed. [default: firefox] 05:51:55 INFO - mkdir: /builds/slave/test/build/application 05:51:55 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'] 05:51:55 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 05:52:30 INFO - Reading from file tmpfile_stdout 05:52:30 INFO - Output received: 05:52:30 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:52:30 INFO - Running post-action listener: _resource_record_post_action 05:52:30 INFO - [mozharness: 2016-08-19 12:52:30.047582Z] Finished install step (success) 05:52:30 INFO - [mozharness: 2016-08-19 12:52:30.047730Z] Running run-tests step. 05:52:30 INFO - Running pre-action listener: _resource_record_pre_action 05:52:30 INFO - Running main action method: run_tests 05:52:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:52:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:52:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:52:30 INFO - 2016-08-19 05:52:30.062 screenresolution[1986:10370] starting screenresolution argv=screenresolution get 05:52:30 INFO - 2016-08-19 05:52:30.064 screenresolution[1986:10370] Display 0: 1600x1200x32@60 05:52:30 INFO - 2016-08-19 05:52:30.070 screenresolution[1987:10373] starting screenresolution argv=screenresolution list 05:52:30 INFO - Available Modes on Display 0 05:52:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:52:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:52:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:52:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:52:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:52:30 INFO - Intel Iris: 05:52:30 INFO - Chipset Model: Intel Iris 05:52:30 INFO - Type: GPU 05:52:30 INFO - Bus: Built-In 05:52:30 INFO - VRAM (Dynamic, Max): 1536 MB 05:52:30 INFO - Vendor: Intel (0x8086) 05:52:30 INFO - Device ID: 0x0a2e 05:52:30 INFO - Revision ID: 0x0009 05:52:30 INFO - Displays: 05:52:30 INFO - Display: 05:52:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:52:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:52:30 INFO - Display Serial Number: 1600x1200 60 05:52:30 INFO - Main Display: Yes 05:52:30 INFO - Mirror: Off 05:52:30 INFO - Online: Yes 05:52:30 INFO - Rotation: Supported 05:52:30 INFO - Return code: 0 05:52:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:52:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:52:30 INFO - Python 2.7.3 05:52:30 INFO - Return code: 0 05:52:30 INFO - grabbing minidump binary from tooltool 05:52: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')]} 05:52:30 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 0x10b929d30>, '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 0x10b68edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b921b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:52:30 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 05:52:30 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 05:52:30 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 05:52:30 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:52:30 INFO - Return code: 0 05:52:30 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:52:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:52:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:52:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:52:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:52:30 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/Db6Sj8WTTPyAHQcmfEoraA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0190', '--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 05:52:30 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/Db6Sj8WTTPyAHQcmfEoraA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0190 --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 05:52:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.quxg7cZzct/Render', 05:52:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:52:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:52:30 INFO - 'HOME': '/Users/cltbld', 05:52:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:52:30 INFO - 'LOGNAME': 'cltbld', 05:52:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:52:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:52:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:30 INFO - 'MOZ_NO_REMOTE': '1', 05:52:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:52:30 INFO - 'NO_EM_RESTART': '1', 05:52:30 INFO - 'PAGER': '/bin/cat', 05:52:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:52:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:30 INFO - 'PWD': '/builds/slave/test', 05:52:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:52:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:52:30 INFO - 'SHELL': '/bin/bash', 05:52:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vP8pfcd5k4/Listeners', 05:52:30 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 05:52:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:52:30 INFO - 'USER': 'cltbld', 05:52:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:52:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:52:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:30 INFO - 'XPC_FLAGS': '0x0', 05:52:30 INFO - 'XPC_SERVICE_NAME': '0', 05:52:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:52:30 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/Db6Sj8WTTPyAHQcmfEoraA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0190', '--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 05:52:30 INFO - mozversion application_buildid: 20160819034155 05:52:30 INFO - mozversion application_changeset: 7700ad7a72edf62983555b21a88879fa75dc4ec1 05:52:30 INFO - mozversion application_display_name: Nightly 05:52:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:52:30 INFO - mozversion application_name: Firefox 05:52:30 INFO - mozversion application_remotingname: firefox 05:52:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:52:30 INFO - mozversion application_vendor: Mozilla 05:52:30 INFO - mozversion application_version: 51.0a1 05:52:30 INFO - mozversion platform_buildid: 20160819034155 05:52:30 INFO - mozversion platform_changeset: 7700ad7a72edf62983555b21a88879fa75dc4ec1 05:52:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:52:30 INFO - mozversion platform_version: 51.0a1 05:52:30 INFO - using testdate: 1471611150 05:52:30 INFO - actual date: 1471611150 05:52:30 INFO - starting webserver on 'localhost:49392' 05:52:30 INFO - SUITE-START | Running 2 tests 05:52:30 INFO - TEST-START | dromaeo_css 05:52:30 INFO - operating with platform_type : mac_ 05:52:30 INFO - Initialising browser for dromaeo_css test... 05:52:30 INFO - TEST-INFO | started process 1997 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/tmpqYy3no/profile http://localhost:49392/getInfo.html) 05:52:33 INFO - PROCESS | 1997 | __metrics Screen width/height:1600/1200 05:52:33 INFO - PROCESS | 1997 | colorDepth:24 05:52:33 INFO - PROCESS | 1997 | Browser inner width/height: 1024/689 05:52:33 INFO - PROCESS | 1997 | __metrics 05:52:33 INFO - PROCESS | 1997 | 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" 05:52:33 INFO - PROCESS | 1997 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:52:34 INFO - TEST-INFO | 1997: exit 0 05:52:34 INFO - Browser initialized. 05:52:34 INFO - Running cycle 1/1 for dromaeo_css test... 05:52:34 INFO - TEST-INFO | started process 2000 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/tmpqYy3no/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:52:46 INFO - PROCESS | 2000 | RSS: Main: 228065280 05:52:46 INFO - PROCESS | 2000 | 05:53:37 INFO - PROCESS | 2000 | 1471611217562 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] 05:55:49 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49392/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49392/tests/dromaeo/cssquery-ext.html) 05:55:51 INFO - PROCESS | 2000 | RSS: Main: 358191104 05:55:51 INFO - PROCESS | 2000 | 05:58:54 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49392/tests/dromaeo/cssquery-ext.html (next: http://localhost:49392/tests/dromaeo/cssquery-jquery.html) 05:58:54 INFO - PROCESS | 2000 | RSS: Main: 374018048 05:58:54 INFO - PROCESS | 2000 | 06:01:57 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49392/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49392/tests/dromaeo/cssquery-mootools.html) 06:01:57 INFO - PROCESS | 2000 | RSS: Main: 352641024 06:01:57 INFO - PROCESS | 2000 | 06:05:00 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49392/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49392/tests/dromaeo/cssquery-prototype.html) 06:05:00 INFO - PROCESS | 2000 | RSS: Main: 348082176 06:05:00 INFO - PROCESS | 2000 | 06:08:04 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49392/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49392/tests/dromaeo/cssquery-yui.html) 06:08:04 INFO - PROCESS | 2000 | RSS: Main: 334819328 06:08:04 INFO - PROCESS | 2000 | 06:11:08 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49392/tests/dromaeo/cssquery-yui.html (next: http://localhost:49392/tests/dromaeo/cssquery-dojo.html) 06:11:08 INFO - PROCESS | 2000 | RSS: Main: 405143552 06:11:08 INFO - PROCESS | 2000 | 06:11:08 INFO - PROCESS | 2000 | __start_tp_report 06:11:08 INFO - PROCESS | 2000 | _x_x_mozilla_page_load 06:11:08 INFO - PROCESS | 2000 | _x_x_mozilla_page_load_details 06:11:08 INFO - PROCESS | 2000 | |i|pagename|runs| 06:11:08 INFO - PROCESS | 2000 | |0;dojo.html;2981.284491721987;3381;3392.864285428583;3396.813175275362;3405.1997780521574;5793.507551858087;5868.530517558585;5886.440788125126;5970.104484327348;5987.281526216854;5881.941180588193;5891.440313170253;5893.55798315126;5913.940860591393;5930.199423077883;5309.62832601718;5353.678779273256;5406.756695948692;5407.405185429599;5442.809501667422;5408.891822163554;5434.7826086956475;5442.836714898559;5446.319210098738;5449.591280653947;5331.2003199519995;5367.409584945653;5375.43557926418;5389.137737961927;5434.646747961389;5453.127499600065;5457.372402173761;5471.890562188773;5480.725963701799;5531.3362396512275;4329.610335069828;5200.5059519345605;5326.440723723992;5383.138697808371;5396.703181325026;5801.390853960358;5814.244148260699;5824.184614154022;5924.7333869975955;5950.107483877409;6292.339304373067;6319.6524191169465;6324.71538780756;6325.430711236011;6328.746850125989;6216.222972128484;6241.095041219043;6293.748250069992;6328.050792381179;6352.7141278642575;6100.847478812976;6103.816885493442;6106.572539922163;6128.448439640454;6129.69351532426;6448.451881590117;6457.515686323544;6457.903131453032;6470.838229044311;6486.156799616019;6147.323794382614;6198.132261483396;6255.155554000243;6260.749570017239;6275;6328.841778955563;6335.493160547145;6342.302346741947;6351.174347334817;6366.363363663597;6279.183706118175;6284.654344011124;6301.086342480315;6317.557770955989;6352.110704501373;6193.783217587363;6263.498920086473;6266.749330026839;6314.810555683337;6327.430531252209;5057.671251368649;5078.060558796635;5083.288339632454;5128.512791284822;5132.923006154911;3842.3083844907624;4580.679352445363;4614.538546145359;4630.837920672828;4643.674942753974;5850.707464626752;5948.167256584082;5951.732172052268;5953.583249172603;6016.518678505709;6240.781572644935;6273.309935907047;6302.149209856702;6368.076628888785;6405.327440618761;5906.704664766745;5947.881042379128;5974.85062873423;5977.910331345033;6002.429769171922;5606.971965140148;5616.354119276254;5617.971910140505;5627.212190293362;5627.6904770237215;5629;6315.431611155018;6333.240011198685;6343.302236753953;6505.8048258550425;6228.4705800007505;6268.937310626835;6272.560920735505;6347.492200624031;6358.459530939922;6498.675066246763;6499.870002600016;6507.28419873823;6509.251436084911;6511.641859697762;6195.876082478235;6281.874362512633;6284.528660350401;6312.558120931674;6318.115463835159;6145.156453064153;6244.375562443719;6264.780732674334;6308.747650093945;6355.968220158869;6294.402031806971;6302.684865756602;6307.337729538516;6307.526935479766;6316.336784637547;6101.450869421773;6283.59156654816;6287.937120628735;6296.968515157578;6323.588966717149;6130.846728831815;6144.511472853502;6164.876702466016;6219.720112594853;6228.190335256388;6274.592151510137;6308.589941653778;6317.842053948688;6320;6339.746410143727;6024.518038556993;6106.175666284995;6201.658908760061;6208.4722798562625;6217.036359364306 06:11:08 INFO - PROCESS | 2000 | |1;ext.html;468.4542507978206;479.8680362900203;520.2170733046764;530.9230161626564;538.6956369651149;30850.69149308506;39815.203695926066;41019.17961640769;41055.17889642213;41126.7943660282;42247;42610.57389426105;42669.7866510667;42705.359419608656;42717.78641106798;8637.179467950566;9540.76148096298;9718.902810971906;9721.222302215841;9738.367006144614;8666.436681615707;11756.706082347924;12050.517979280818;12065.457054432527;12299.631011069681;12036.097292703038;12087.395630218498;12133.150679452441;12136.93931530341;12161.635150945485;12066.276023438579;12155;12160.939195303967;12162.148649594532;12170.574029908956;9858.90141098587;9880.802383952352;11842.644720658394;11901.702457438634;11925.224860384047;32988.50517242243;39817.80091099526;40154.39768403476;40309.193816123516;40344.59655403467;3368.1747971747077;3431.6396778338412;3441.5181874537584;3529.858805647771;3911.9608803911883;30556.388872222433;31603.20991975196;31686.049418517483;31733.682663173302;31736.206594835083;3168.556402103707;3246.724028457584;3308.7353011759;3376.4428869236544;3382.594088709346;514807;516346;518045;518797;523515.38242308924;59412.70293648504;59449.10826337608;59700.104498432556;59851.70074149602;59951.40048599545;60179.699101504215;61194;61286.69356653188;61286.69356653278;61365.38634613686;16143.677126457405;16350.918245408697;16371.42700005494;16379.262933167798;16392.508224753277;11408.828867566994;11712.355820429959;12566.057545683927;12692.746145077046;12816.35918204086;16182.919085404734;16251.187440627922;16253.187340632921;16298.674026519404;16470;6293.496520278367;6461.57999730016;6552.672366381662;6961.164660240703;6996.510244282953;884.8849649545647;1008.0473952115327;1045.994770026145;1069.6523629820183;1079.3308148947704;30464.238394039883;30544.389112217632;31042.379152416826;31307.84346078255;31340.373192536477;1032.4476405123223;1090.7327704712238;1102.2780079048237;1138.738090239233;1170.69561913903;15366;15780;15831.89176757639;16061.277242524115;16226.945248558806;667342;669474;669933;671248;677557;59133.40866591279;59502.70248648815;59546.10680839791;59598.10602840961;59812.99999999913;1259.0871618077003;1365.208179256029;1395.0722769358465;1408.4929425406845;1423.131889547396;30291.545626816056;31266;31282.90509832145;31891;32009.519857201696;49718;50241.748791255806;50248.497515024384;50344;50511.989760205324;425527;503629;503634;504724;505063;26109.08618198354;26879.462410752065;26964.685650295858;27688.30779230455;39685.404718929814;40671.983200420225;47754.761226193645;48512;48758.0248395023;48906;38464.61535384722;39173;39355;40413;40684;32900.835495822364;39073.023174420865;39114.80442597769;39124;40466;38819.417708733825;39122.82631521059;39176.412353815285;39274.2145157101;39447.408288875115;32469.35061298808;34448.9909423167;34727;34850.82574587111;35159.29681406306;25872.223833285032;25975.870120649277;26195;26360.736392636594;26371.340716482242 06:11:08 INFO - PROCESS | 2000 | |2;jquery.html;354.97692649977733;373.348506855537;378.92610940866535;387.506163738787;410.8007616306091;13308;16131.951423157501;20519.897400513015;21239.787602123975;21343.25298614549;18895.62208755824;21274.680879786814;21450;21565;22089;5850.21022162008;5955.523558115362;6012.5791194616395;6073.574849760518;6136.23297087864;5995.6102853314615;6097.512199024068;6104.053871649901;6109.480694141003;6121.540884433663;4161.646260067898;6250.624962502242;6652.301508341627;6732.990051492291;6800.931990680079;6464.709088091;6642.070110184578;6720.361565651256;6722.1261236039245;6749.223839258474;5826.883462330772;5834.154047663107;5837.474627283523;5840.094785308284;5841.795537156179;25053.37366565832;26134.954601815905;26882.865585671945;27110;27322.45355092887;2186.5080356919725;2275.84069115162;2303.205394139036;2547.808914331414;2740.49300879336;9623.1820295275;10107.292489525737;10210.591576336938;10447.373157610567;10495;1849.870509064366;1865.216609024213;1886.2737845929278;1964.8274084501497;1976.1107501624326;112668;122188;123566.38216808948;124961;125642;11154.888451115547;11262.493187806569;11550.960413562652;11562.479688414041;11716.472758725879;14551.636209094857;14583.270836458347;14598;14599.708005839824;14607.415703371746;8380.329573634095;8595.78510537229;8651;8758.56207189638;8760.912390876138;8514.403991720645;8516.967279166724;8520;8675.869861952076;8762.649494020296;4469.9776501117285;4583.885402864888;4584.470745912724;4638.611115275636;4678.836240731558;1646.6871294454015;1866.1602278974515;1923.4325873866962;1927.807219278061;1931.643395058027;707.6850801393433;771.221066722603;900.4377405201969;933.244072301438;1045.3414348960107;21001.369958901258;22064.448388790086;22338.771367574613;22431.663525047137;22564.66153007706;957.6935380678116;983.9360441571275;993.9701808945744;1020.8315627921459;1046.947652617366;10846.783064338826;11650.242734222249;11747.236429632047;11777.705557361134;11793.469293881795;580375;599010;603596;613521;616989.9150504308;133784.66215337918;137841.3107934454;140688.29655851657;141034;141429.5857041437;1008.566316483919;1019.0522813783252;1033.705393962717;1055.145332280855;1056.624898161157;15156.166410847069;16255.756163657317;20210.39368818938;20332.593348132657;20370.18519259213;30809.229769255053;53838.73080634572;56549.71725141348;57147.71358153128;58354.7082264586;83378;84298.57850710707;84316.57841710752;84670;84895.57552212446;7772.572508512086;7786.532808031537;7953.8409231816195;8073.313768329758;8097.149799270992;9644.75888102803;12019.459124339252;12231.388430578258;12347.69130771738;12599.244045356942;10591.682249532527;10667.733306667395;10731.034206921415;10964.342139471339;10991.39547324873;8987.595558199766;9620.37467564606;10121.493925303852;10648.763759610569;10708.518116684923;9709.9029009709;9821.312508124363;10728.89271107279;10931.508082136164;11109.944450277697;7792.571408572356;8015.47899386538;8038.799030024296;8040.87938680932;8097.449303469389;10644.574217031231;10800.729981750519;11133.777324453627;11190.496427660937;11423.771524569629 06:11:08 INFO - PROCESS | 2000 | |3;mootools.html;1332.4936524120833;1483.5326872035307;1531.7472617018193;1663.9584010399738;1812.3384964487957;7671.386289096873;8213.876791848126;8229.423940324179;8237.6293066812;8240.258376746091;8089.23152300532;8431.325493960483;8590.012148602913;8619.698310559132;8756.781080472976;2365.432296248905;2399.8200134989856;2400.435897564071;2401.891914863835;2404.266698656909;2354.105439932832;2373.727021392545;2402.843815152018;2404.807615390773;2410.385351735305;2360;2380.143148466551;2393.5093305872256;2400.195934361991;2401.3396316013063;1988.3040935672543;2324.9651255231183;2342.2504798464497;2356.198892376583;2364.2788949370433;2332.5684748321614;2347.988260058689;2380.8809559521956;2385.8807059646947;2387.069043073203;8769.254613357809;8930.821383572356;8939.240164586017;8946.552672366355;8949.821003579891;5189.66267192635;5210.973945130288;5384.488473595002;5390.056740070472;5396.865078373072;3642.581103173116;3733.1600389912323;3740.775553466801;3761.605031471711;3765.5104836371097;1082.6427278997912;1091.110744743032;1112.7051331397186;1113.0761467981556;1114.7324642085923;11601.361925094116;11698;11715.707107322385;11747.647570572897;11756.470958806874;4394.406755088086;4542.568455996675;4633.285684296764;4673.813047478131;4686.109639168547;9205.585748641328;9217.124373184537;9251.398659087137;9252.537373131316;9290.303227257982;5284.339457567804;5290.285811415487;5291.920621190685;5292.285541451932;5295.099833028317;4067.6949228807366;4433.8226470941445;4915.87710307238;4967.90064198714;4990.051890140861;3730.309892669865;3743.5694895086867;3790.1093243087853;3829.1767270037076;3847.576766555677;1173.5364531010202;1177.917545771805;1182.0602620916393;1197.7724232395817;1199.5321824488456;907.2923119966437;912.3659056955485;930.5440334236175;944.8299306124826;962.0187408842941;5473.28847249855;5610.270664813548;5944.197533333031;5956.404359564009;6289;434.1057421711285;434.71960585422227;440.5528388685487;445.97993090311013;458.3720303184658;4020.7386519876113;4028.3685107531496;4113.465249517603;4134.979325103355;4204.1171354016;10481.895181048092;10918.126549875991;10989.285696429866;11051.889481105087;11076.778464430827;10525.9473702631;10998.285111467729;11024.393658348868;11036.668899933014;11039.72400689973;8087.676492940334;8331.583420828934;8347.373946954003;8349.123342049119;8353.37349698775;5105.489451054865;5877.617954832922;5981.581289309706;5997.370276121119;6108.144859719731;10155.187584993035;10169.898301016896;10221.642242521477;10293.330933489298;10309;9386.624535018524;9782.706518804447;9843.803123937625;9972.900270997197;10286.382817031003;6086.573939824169;6858.554193977376;6926.06498122747;6960.756373526902;6973.96513017452;8327.875081873897;8422;8439.915600844159;8440.113788052166;8446.197611226924;7100.218975912542;7556.962215188889;7559.244075592397;7650.426218033558;7732.690692372242;7196.748113815991;7347.485676002629;7363.300486453778;7366.742164024234;7373.078365204349;6148.815535533941;7047.718091276497;7058.294170582901;7148.606826624586;7151.678174482056;5061.164907790173;5102.923456148235;5119.616028797929;5140.845774626767;5193;5055.898882022266;5078.568321692697;5231.503007214308;5249.2651028855225;5332.466753324637 06:11:08 INFO - PROCESS | 2000 | |4;prototype.html;291.67769614575906;298.4329773430482;307.86761692472226;307.9630444346678;309.4569031349982;5139.897202055957;5183.352080989876;5332.813351532697;5342.732863356831;5388.973055134724;5104.33643626328;5200.453952335007;5297.867553311169;5317.3619165700175;5333.253344531759;3368.2758206985495;4080.653384383154;4095.1604920991276;4095.221907837516;4113.300738874398;3578.499010138583;3956.8417263309434;4084.8766589188062;4102.323116685743;4111.1366613011305;3797.620237976194;3912.2371137628174;3959.9208015839667;4053.6149065838845;4075.8981025474304;3328.62003667379;3525;4060.7969601519953;4064.126212864219;4065.6340929316207;3092.922676933072;3545;3550.6449355064547;3551.8224088795714;3578.1949061461223;4823.662343635947;4922.975385123087;5085.313482679828;5172.767225474825;5203.219517072469;3489.319582681378;4114.300568903293;4256.893207765972;4590.357349971006;4668.463126740435;4825.7587120644175;5282.709450980195;5560.499555040065;5582.944170558324;5583.776648934037;3015.411994661042;3755.4742336072973;3812.2844719876166;3863.5466478785893;3907.5115610548683;5563.887222555505;5920.615160014585;5922.615030023035;5922.703864806743;5960.672163031031;3281.45855933773;3654.3056819204267;3888.902777430587;3914.373700207953;3914.9608503914596;3347;3439.9828000860334;3475.374432602105;3961.445397644332;3967.3652215645934;4548.113117942035;4560.931586026212;4578.748168850745;4594.471635761864;4626.537346265414;4921.606271498272;5641.689707066069;5676.120201368794;5677.517411020027;5721.084626459747;1111.6164923101517;1271.3579642280774;1293.224065560656;1301.4902712853234;1313.487739781486;869.7651634058768;877.8683197520423;895.8521843895815;902.5712786426526;905.4431524612447;3943.9014024649614;4879.339965639841;5062.341895553554;5117.820876269313;5160.612954028463;4944.826931057396;5405.78376864921;5671.631343962629;5683.346415162309;5683.516901063374;4274.465691788527;4921.630877684188;5112.207607820794;5125.33370661819;5145.993062705548;2405.951880962371;2627.89488420461;2684.3289177705574;3048.7103725146076;3055.9847200764298;5553.972230138824;5677.779277455367;6000.33996260411;6009.519238460913;6034.034554471351;4959.876003099879;5079.1365467870555;5574.693391863405;5805.10020946754;5985.431384018511;5327.082250389856;6057.878842423215;6075.726592303446;6078.270607527125;6117.908231376533;5397.919031214614;5560.638558493685;5887.852803679943;5893.941060589339;5912.940870591411;4907.2393778964315;5288.757142071687;5495.368032676293;5823.699638642628;5848;6058.212432383762;6066.1204125402455;6102;6143.662098584442;6162.568620196544;3621.8913432597064;3856.787876666698;3857.7685338879755;3909.5308562972627;3928.214357128643;5056.191009438619;5206.739663016759;5837.766489340379;5856.707164641836;5866.858596612291;4956.628252880976;5530.6128570999645;5653.462921022497;5704.828855134353;5706.031419160383;5666.271787104973;5689.34572524165;5697.658140511417;5703;5720.7963540417495;5198.530697918459;5550.8057217997175;5564.358514238228;5582.190582365453;5589.748461319169;4908.190148625436;4971.751412429292;5449.6375906023495;5701.771929122954;5703;4488.438945131858;4792.137415265286;5321.79145654549;5555.527780138734;5598.564624388404 06:11:08 INFO - PROCESS | 2000 | |5;yui.html;603.1363088057901;706.9045678833356;710.2010238481711;711.2574193226594;780;15343.539693809189;16269.105199214067;16516;16531.090790006543;16610.08644524552;14955.47655832046;15069.39722411105;15112.924435377836;15129.394824207018;15390;846.7036537211973;887.0109827542276;888.800019995499;890.025422162734;894.7360528644033;693.7121094745675;719.899214110025;880.8678698195258;883.9745894762077;885.1148851148852;891.2335391563283;922.0548937339247;923.8475651517491;925.4909799610222;929.2844509727539;910.3309067835136;910.8588168833808;911.2664305234284;911.7128104647015;913.0777914306598;536.9140937449989;673.4107655801174;686.5400181878103;689.152342618582;689.7689274093185;15421;15425.691486170326;15477.613059673486;15486.5354039379;15498.457553985669;13871.722565548733;14456.855431445656;14465.566033019026;14518.92740536301;14576.271186440636;11124.833127503094;13168.5525027703;13560.932195339059;13803.930980345134;13861.23763193024;3943.743656662308;4721.669483136182;4732.929006064912;4917.50824917509;4942.456329803718;101209;128301.99999999907;129555.35222323923;129940.3502982479;132602;11343.716407089889;11465.31208127515;11484.253523520945;11495.310281383145;11959.162858599988;22957.88521057384;22989.655155172684;23022.7697723024;23026.884865575565;23057.308280751604;7995.320397766255;8090;8130.812182234038;8213.219744124299;8348.791280218044;4438.178936896685;4512.300593408027;4521.140983213245;4576.908461830745;4692.366530518405;3578.481120237551;3683.7605555638797;3685.1155722626377;3688.188598508324;3690.833912473945;668.6756922892394;677.0926957876469;681.8295426143465;684.2234064337014;695.7078027228577;522.6602708239599;576;601.608259704158;620.7920346683911;634.3117717276714;7828.452008359474;8793.604287807064;9064;9162.444113263786;9210.102042334845;591.6213623281103;612.6018088242589;614.5483069943588;637.2448648351718;638.4062821575978;4163.687723420756;4403.779811009436;4421.845235416809;4428.468583769968;4537.77311134442;139428;162068;169572;172652;173438;147011;148101;148172;156012;157341.42658573267;121471;121734;124112;125442;129639.42391809657;8450.070492245972;8594.613242404232;8596.484210947363;8757.912420875964;8809.295256379346;63543;65161;67604.3239567598;68719.65640171767;69544.60910781857;85392.57303713441;104166.437503436;104571;105601.47199263955;105640.47179764052;13106.279154646205;13327.933360333136;13706.93146534261;13886.444542218198;13959;14727.779083313544;15195.924020379827;15716.68566628684;15765.29056192497;15793.68412631764;14006.929965350108;14240.287985600886;14290.928545357207;14547.78178327347;14841.109533428029;13630.522931697344;14226.71546569042;14472.710545788814;14583.708325833211;14706.338214780146;13676.452941882611;13805.585832425044;14104;14122.364493598017;14238;10814.945925270324;11011.834822477509;11093.722656933318;11431.54221842308;11538.307701537935;11491.367974761468;11631.941840290745;11670;11778.293302401884;11794.469248883992 06:11:08 INFO - PROCESS | 2000 | __end_tp_report 06:11:08 INFO - PROCESS | 2000 | __start_cc_report 06:11:08 INFO - PROCESS | 2000 | _x_x_mozilla_cycle_collect,1332 06:11:08 INFO - PROCESS | 2000 | __end_cc_report 06:11:08 INFO - PROCESS | 2000 | __startTimestamp1471612268766__endTimestamp 06:11:08 INFO - PROCESS | 2000 | 06:11:08 INFO - PROCESS | 2000 | ------- Summary: start ------- 06:11:08 INFO - PROCESS | 2000 | Number of tests: 6 06:11:08 INFO - PROCESS | 2000 | 06:11:08 INFO - PROCESS | 2000 | [#0] dojo.html Cycles:165 Average:5887.72 Median:6147.32 stddev:663.43 (10.8%) stddev-sans-first:625.06 06:11:08 INFO - PROCESS | 2000 | Values: 2981.3 3381.0 3392.9 3396.8 3405.2 5793.5 5868.5 5886.4 5970.1 5987.3 5881.9 5891.4 5893.6 5913.9 5930.2 5309.6 5353.7 5406.8 5407.4 5442.8 5408.9 5434.8 5442.8 5446.3 5449.6 5331.2 5367.4 5375.4 5389.1 5434.6 5453.1 5457.4 5471.9 5480.7 5531.3 4329.6 5200.5 5326.4 5383.1 5396.7 5801.4 5814.2 5824.2 5924.7 5950.1 6292.3 6319.7 6324.7 6325.4 6328.7 6216.2 6241.1 6293.7 6328.1 6352.7 6100.8 6103.8 6106.6 6128.4 6129.7 6448.5 6457.5 6457.9 6470.8 6486.2 6147.3 6198.1 6255.2 6260.7 6275.0 6328.8 6335.5 6342.3 6351.2 6366.4 6279.2 6284.7 6301.1 6317.6 6352.1 6193.8 6263.5 6266.7 6314.8 6327.4 5057.7 5078.1 5083.3 5128.5 5132.9 3842.3 4580.7 4614.5 4630.8 4643.7 5850.7 5948.2 5951.7 5953.6 6016.5 6240.8 6273.3 6302.1 6368.1 6405.3 5906.7 5947.9 5974.9 5977.9 6002.4 5607.0 5616.4 5618.0 5627.2 5627.7 5629.0 6315.4 6333.2 6343.3 6505.8 6228.5 6268.9 6272.6 6347.5 6358.5 6498.7 6499.9 6507.3 6509.3 6511.6 6195.9 6281.9 6284.5 6312.6 6318.1 6145.2 6244.4 6264.8 6308.7 6356.0 6294.4 6302.7 6307.3 6307.5 6316.3 6101.5 6283.6 6287.9 6297.0 6323.6 6130.8 6144.5 6164.9 6219.7 6228.2 6274.6 6308.6 6317.8 6320.0 6339.7 6024.5 6106.2 6201.7 6208.5 6217.0 06:11:08 INFO - PROCESS | 2000 | 06:11:08 INFO - PROCESS | 2000 | [#1] ext.html Cycles:180 Average:69733.38 Median:19344.58 stddev:150968.35 (780.4%) stddev-sans-first:151302.28 06:11:08 INFO - PROCESS | 2000 | Values: 468.5 479.9 520.2 530.9 538.7 30850.7 39815.2 41019.2 41055.2 41126.8 42247.0 42610.6 42669.8 42705.4 42717.8 8637.2 9540.8 9718.9 9721.2 9738.4 8666.4 11756.7 12050.5 12065.5 12299.6 12036.1 12087.4 12133.2 12136.9 12161.6 12066.3 12155.0 12160.9 12162.1 12170.6 9858.9 9880.8 11842.6 11901.7 11925.2 32988.5 39817.8 40154.4 40309.2 40344.6 3368.2 3431.6 3441.5 3529.9 3912.0 30556.4 31603.2 31686.0 31733.7 31736.2 3168.6 3246.7 3308.7 3376.4 3382.6 514807.0 516346.0 518045.0 518797.0 523515.4 59412.7 59449.1 59700.1 59851.7 59951.4 60179.7 61194.0 61286.7 61286.7 61365.4 16143.7 16350.9 16371.4 16379.3 16392.5 11408.8 11712.4 12566.1 12692.7 12816.4 16182.9 16251.2 16253.2 16298.7 16470.0 6293.5 6461.6 6552.7 6961.2 6996.5 884.9 1008.0 1046.0 1069.7 1079.3 30464.2 30544.4 31042.4 31307.8 31340.4 1032.4 1090.7 1102.3 1138.7 1170.7 15366.0 15780.0 15831.9 16061.3 16226.9 667342.0 669474.0 669933.0 671248.0 677557.0 59133.4 59502.7 59546.1 59598.1 59813.0 1259.1 1365.2 1395.1 1408.5 1423.1 30291.5 31266.0 31282.9 31891.0 32009.5 49718.0 50241.7 50248.5 50344.0 50512.0 425527.0 503629.0 503634.0 504724.0 505063.0 26109.1 26879.5 26964.7 27688.3 39685.4 40672.0 47754.8 48512.0 48758.0 48906.0 38464.6 39173.0 39355.0 40413.0 40684.0 32900.8 39073.0 39114.8 39124.0 40466.0 38819.4 39122.8 39176.4 39274.2 39447.4 32469.4 34449.0 34727.0 34850.8 35159.3 25872.2 25975.9 26195.0 26360.7 26371.3 06:11:08 INFO - PROCESS | 2000 | 06:11:08 INFO - PROCESS | 2000 | [#2] jquery.html Cycles:180 Average:35708.24 Median:13800.59 stddev:101048.15 (732.2%) stddev-sans-first:101296.75 06:11:08 INFO - PROCESS | 2000 | Values: 355.0 373.3 378.9 387.5 410.8 13308.0 16132.0 20519.9 21239.8 21343.3 18895.6 21274.7 21450.0 21565.0 22089.0 5850.2 5955.5 6012.6 6073.6 6136.2 5995.6 6097.5 6104.1 6109.5 6121.5 4161.6 6250.6 6652.3 6733.0 6800.9 6464.7 6642.1 6720.4 6722.1 6749.2 5826.9 5834.2 5837.5 5840.1 5841.8 25053.4 26135.0 26882.9 27110.0 27322.5 2186.5 2275.8 2303.2 2547.8 2740.5 9623.2 10107.3 10210.6 10447.4 10495.0 1849.9 1865.2 1886.3 1964.8 1976.1 112668.0 122188.0 123566.4 124961.0 125642.0 11154.9 11262.5 11551.0 11562.5 11716.5 14551.6 14583.3 14598.0 14599.7 14607.4 8380.3 8595.8 8651.0 8758.6 8760.9 8514.4 8517.0 8520.0 8675.9 8762.6 4470.0 4583.9 4584.5 4638.6 4678.8 1646.7 1866.2 1923.4 1927.8 1931.6 707.7 771.2 900.4 933.2 1045.3 21001.4 22064.4 22338.8 22431.7 22564.7 957.7 983.9 994.0 1020.8 1046.9 10846.8 11650.2 11747.2 11777.7 11793.5 580375.0 599010.0 603596.0 613521.0 616989.9 133784.7 137841.3 140688.3 141034.0 141429.6 1008.6 1019.1 1033.7 1055.1 1056.6 15156.2 16255.8 20210.4 20332.6 20370.2 30809.2 53838.7 56549.7 57147.7 58354.7 83378.0 84298.6 84316.6 84670.0 84895.6 7772.6 7786.5 7953.8 8073.3 8097.1 9644.8 12019.5 12231.4 12347.7 12599.2 10591.7 10667.7 10731.0 10964.3 10991.4 8987.6 9620.4 10121.5 10648.8 10708.5 9709.9 9821.3 10728.9 10931.5 11109.9 7792.6 8015.5 8038.8 8040.9 8097.4 10644.6 10800.7 11133.8 11190.5 11423.8 06:11:08 INFO - PROCESS | 2000 | 06:11:08 INFO - PROCESS | 2000 | [#3] mootools.html Cycles:180 Average:5669.99 Median:5022.98 stddev:3199.29 (63.7%) stddev-sans-first:3191.65 06:11:08 INFO - PROCESS | 2000 | Values: 1332.5 1483.5 1531.7 1664.0 1812.3 7671.4 8213.9 8229.4 8237.6 8240.3 8089.2 8431.3 8590.0 8619.7 8756.8 2365.4 2399.8 2400.4 2401.9 2404.3 2354.1 2373.7 2402.8 2404.8 2410.4 2360.0 2380.1 2393.5 2400.2 2401.3 1988.3 2325.0 2342.3 2356.2 2364.3 2332.6 2348.0 2380.9 2385.9 2387.1 8769.3 8930.8 8939.2 8946.6 8949.8 5189.7 5211.0 5384.5 5390.1 5396.9 3642.6 3733.2 3740.8 3761.6 3765.5 1082.6 1091.1 1112.7 1113.1 1114.7 11601.4 11698.0 11715.7 11747.6 11756.5 4394.4 4542.6 4633.3 4673.8 4686.1 9205.6 9217.1 9251.4 9252.5 9290.3 5284.3 5290.3 5291.9 5292.3 5295.1 4067.7 4433.8 4915.9 4967.9 4990.1 3730.3 3743.6 3790.1 3829.2 3847.6 1173.5 1177.9 1182.1 1197.8 1199.5 907.3 912.4 930.5 944.8 962.0 5473.3 5610.3 5944.2 5956.4 6289.0 434.1 434.7 440.6 446.0 458.4 4020.7 4028.4 4113.5 4135.0 4204.1 10481.9 10918.1 10989.3 11051.9 11076.8 10525.9 10998.3 11024.4 11036.7 11039.7 8087.7 8331.6 8347.4 8349.1 8353.4 5105.5 5877.6 5981.6 5997.4 6108.1 10155.2 10169.9 10221.6 10293.3 10309.0 9386.6 9782.7 9843.8 9972.9 10286.4 6086.6 6858.6 6926.1 6960.8 6974.0 8327.9 8422.0 8439.9 8440.1 8446.2 7100.2 7557.0 7559.2 7650.4 7732.7 7196.7 7347.5 7363.3 7366.7 7373.1 6148.8 7047.7 7058.3 7148.6 7151.7 5061.2 5102.9 5119.6 5140.8 5193.0 5055.9 5078.6 5231.5 5249.3 5332.5 06:11:08 INFO - PROCESS | 2000 | 06:11:08 INFO - PROCESS | 2000 | [#4] prototype.html Cycles:180 Average:4526.07 Median:5108.27 stddev:1432.80 (28.0%) stddev-sans-first:1401.12 06:11:08 INFO - PROCESS | 2000 | Values: 291.7 298.4 307.9 308.0 309.5 5139.9 5183.4 5332.8 5342.7 5389.0 5104.3 5200.5 5297.9 5317.4 5333.3 3368.3 4080.7 4095.2 4095.2 4113.3 3578.5 3956.8 4084.9 4102.3 4111.1 3797.6 3912.2 3959.9 4053.6 4075.9 3328.6 3525.0 4060.8 4064.1 4065.6 3092.9 3545.0 3550.6 3551.8 3578.2 4823.7 4923.0 5085.3 5172.8 5203.2 3489.3 4114.3 4256.9 4590.4 4668.5 4825.8 5282.7 5560.5 5582.9 5583.8 3015.4 3755.5 3812.3 3863.5 3907.5 5563.9 5920.6 5922.6 5922.7 5960.7 3281.5 3654.3 3888.9 3914.4 3915.0 3347.0 3440.0 3475.4 3961.4 3967.4 4548.1 4560.9 4578.7 4594.5 4626.5 4921.6 5641.7 5676.1 5677.5 5721.1 1111.6 1271.4 1293.2 1301.5 1313.5 869.8 877.9 895.9 902.6 905.4 3943.9 4879.3 5062.3 5117.8 5160.6 4944.8 5405.8 5671.6 5683.3 5683.5 4274.5 4921.6 5112.2 5125.3 5146.0 2406.0 2627.9 2684.3 3048.7 3056.0 5554.0 5677.8 6000.3 6009.5 6034.0 4959.9 5079.1 5574.7 5805.1 5985.4 5327.1 6057.9 6075.7 6078.3 6117.9 5397.9 5560.6 5887.9 5893.9 5912.9 4907.2 5288.8 5495.4 5823.7 5848.0 6058.2 6066.1 6102.0 6143.7 6162.6 3621.9 3856.8 3857.8 3909.5 3928.2 5056.2 5206.7 5837.8 5856.7 5866.9 4956.6 5530.6 5653.5 5704.8 5706.0 5666.3 5689.3 5697.7 5703.0 5720.8 5198.5 5550.8 5564.4 5582.2 5589.7 4908.2 4971.8 5449.6 5701.8 5703.0 4488.4 4792.1 5321.8 5555.5 5598.6 06:11:08 INFO - PROCESS | 2000 | 06:11:08 INFO - PROCESS | 2000 | [#5] yui.html Cycles:180 Average:27351.78 Median:23006.21 stddev:44871.17 (195.0%) stddev-sans-first:44952.10 06:11:08 INFO - PROCESS | 2000 | Values: 603.1 706.9 710.2 711.3 780.0 15343.5 16269.1 16516.0 16531.1 16610.1 14955.5 15069.4 15112.9 15129.4 15390.0 846.7 887.0 888.8 890.0 894.7 693.7 719.9 880.9 884.0 885.1 891.2 922.1 923.8 925.5 929.3 910.3 910.9 911.3 911.7 913.1 536.9 673.4 686.5 689.2 689.8 15421.0 15425.7 15477.6 15486.5 15498.5 13871.7 14456.9 14465.6 14518.9 14576.3 11124.8 13168.6 13560.9 13803.9 13861.2 3943.7 4721.7 4732.9 4917.5 4942.5 101209.0 128302.0 129555.4 129940.4 132602.0 11343.7 11465.3 11484.3 11495.3 11959.2 22957.9 22989.7 23022.8 23026.9 23057.3 7995.3 8090.0 8130.8 8213.2 8348.8 4438.2 4512.3 4521.1 4576.9 4692.4 3578.5 3683.8 3685.1 3688.2 3690.8 668.7 677.1 681.8 684.2 695.7 522.7 576.0 601.6 620.8 634.3 7828.5 8793.6 9064.0 9162.4 9210.1 591.6 612.6 614.5 637.2 638.4 4163.7 4403.8 4421.8 4428.5 4537.8 139428.0 162068.0 169572.0 172652.0 173438.0 147011.0 148101.0 148172.0 156012.0 157341.4 121471.0 121734.0 124112.0 125442.0 129639.4 8450.1 8594.6 8596.5 8757.9 8809.3 63543.0 65161.0 67604.3 68719.7 69544.6 85392.6 104166.4 104571.0 105601.5 105640.5 13106.3 13327.9 13706.9 13886.4 13959.0 14727.8 15195.9 15716.7 15765.3 15793.7 14006.9 14240.3 14290.9 14547.8 14841.1 13630.5 14226.7 14472.7 14583.7 14706.3 13676.5 13805.6 14104.0 14122.4 14238.0 10814.9 11011.8 11093.7 11431.5 11538.3 11491.4 11631.9 11670.0 11778.3 11794.5 06:11:08 INFO - PROCESS | 2000 | -------- Summary: end -------- 06:11:08 INFO - PROCESS | 2000 | 06:11:09 INFO - TEST-INFO | 2000: exit 0 06:11:09 INFO - TEST-OK | dromaeo_css | took 1118768ms 06:11:09 INFO - TEST-START | kraken 06:11:09 INFO - operating with platform_type : mac_ 06:11:09 INFO - Initialising browser for kraken test... 06:11:09 INFO - TEST-INFO | started process 2003 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/tmpZpq1eo/profile http://localhost:49392/getInfo.html) 06:11:11 INFO - PROCESS | 2003 | __metrics Screen width/height:1600/1200 06:11:11 INFO - PROCESS | 2003 | colorDepth:24 06:11:11 INFO - PROCESS | 2003 | Browser inner width/height: 1024/689 06:11:11 INFO - PROCESS | 2003 | __metrics 06:11:11 INFO - PROCESS | 2003 | 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" 06:11:11 INFO - PROCESS | 2003 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:11:12 INFO - TEST-INFO | 2003: exit 0 06:11:12 INFO - Browser initialized. 06:11:12 INFO - Running cycle 1/1 for kraken test... 06:11:12 INFO - TEST-INFO | started process 2004 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/tmpZpq1eo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:11:24 INFO - PROCESS | 2004 | RSS: Main: 228220928 06:11:24 INFO - PROCESS | 2004 | 06:11:27 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:49392/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49392/tests/kraken/driver.html?testName=audio-beat-detection) 06:11:28 INFO - PROCESS | 2004 | RSS: Main: 285253632 06:11:28 INFO - PROCESS | 2004 | 06:11:30 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:49392/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49392/tests/kraken/driver.html?testName=audio-dft) 06:11:31 INFO - PROCESS | 2004 | RSS: Main: 292835328 06:11:31 INFO - PROCESS | 2004 | 06:11:35 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:49392/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49392/tests/kraken/driver.html?testName=audio-fft) 06:11:35 INFO - PROCESS | 2004 | RSS: Main: 387883008 06:11:35 INFO - PROCESS | 2004 | 06:11:37 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:49392/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49392/tests/kraken/driver.html?testName=audio-oscillator) 06:11:38 INFO - PROCESS | 2004 | RSS: Main: 289501184 06:11:38 INFO - PROCESS | 2004 | 06:11:40 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:49392/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49392/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:11:41 INFO - PROCESS | 2004 | RSS: Main: 294907904 06:11:41 INFO - PROCESS | 2004 | 06:11:43 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:49392/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49392/tests/kraken/driver.html?testName=imaging-darkroom) 06:11:44 INFO - PROCESS | 2004 | RSS: Main: 332587008 06:11:44 INFO - PROCESS | 2004 | 06:11:47 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:49392/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49392/tests/kraken/driver.html?testName=imaging-desaturate) 06:11:48 INFO - PROCESS | 2004 | RSS: Main: 333033472 06:11:48 INFO - PROCESS | 2004 | 06:11:51 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:49392/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49392/tests/kraken/driver.html?testName=json-parse-financial) 06:11:51 INFO - PROCESS | 2004 | RSS: Main: 330039296 06:11:51 INFO - PROCESS | 2004 | 06:11:53 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:49392/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49392/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:11:53 INFO - PROCESS | 2004 | RSS: Main: 300793856 06:11:53 INFO - PROCESS | 2004 | 06:11:55 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:49392/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49392/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:11:56 INFO - PROCESS | 2004 | RSS: Main: 307376128 06:11:56 INFO - PROCESS | 2004 | 06:11:58 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:49392/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49392/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:11:59 INFO - PROCESS | 2004 | RSS: Main: 300769280 06:11:59 INFO - PROCESS | 2004 | 06:12:02 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:49392/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49392/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:12:02 INFO - PROCESS | 2004 | RSS: Main: 310816768 06:12:02 INFO - PROCESS | 2004 | 06:12:05 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:49392/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49392/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:12:06 INFO - PROCESS | 2004 | RSS: Main: 312270848 06:12:06 INFO - PROCESS | 2004 | 06:12:08 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:49392/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49392/tests/kraken/driver.html?testName=ai-astar) 06:12:08 INFO - PROCESS | 2004 | RSS: Main: 355516416 06:12:08 INFO - PROCESS | 2004 | 06:12:08 INFO - PROCESS | 2004 | __start_tp_report 06:12:08 INFO - PROCESS | 2004 | _x_x_mozilla_page_load 06:12:08 INFO - PROCESS | 2004 | _x_x_mozilla_page_load_details 06:12:08 INFO - PROCESS | 2004 | |i|pagename|runs| 06:12:08 INFO - PROCESS | 2004 | |0;ai-astar;103;112;112;111;107;111;111;112;111;111 06:12:08 INFO - PROCESS | 2004 | |1;audio-beat-detection;144;115;130;197;136;129;129;107;161;105 06:12:08 INFO - PROCESS | 2004 | |2;audio-dft;200;263;198;185;182;184;185;185;180;184 06:12:08 INFO - PROCESS | 2004 | |3;audio-fft;80;59;62;87;59;58;65;63;84;56 06:12:08 INFO - PROCESS | 2004 | |4;audio-oscillator;85;92;136;103;101;68;95;71;69;102 06:12:08 INFO - PROCESS | 2004 | |5;imaging-gaussian-blur;88;85;88;115;88;85;89;85;88;84 06:12:08 INFO - PROCESS | 2004 | |6;imaging-darkroom;94;101;94;128;141;92;93;94;93;93 06:12:08 INFO - PROCESS | 2004 | |7;imaging-desaturate;86;86;86;84;85;86;127;140;99;85 06:12:08 INFO - PROCESS | 2004 | |8;json-parse-financial;55;53;57;55;55;56;53;53;56;54 06:12:08 INFO - PROCESS | 2004 | |9;json-stringify-tinderbox;63;64;69;79;71;70;70;68;69;70 06:12:08 INFO - PROCESS | 2004 | |10;stanford-crypto-aes;84;86;87;85;97;105;105;75;100;105 06:12:08 INFO - PROCESS | 2004 | |11;stanford-crypto-ccm;140;139;143;144;140;137;136;138;158;141 06:12:08 INFO - PROCESS | 2004 | |12;stanford-crypto-pbkdf2;169;168;186;169;170;167;166;166;169;169 06:12:08 INFO - PROCESS | 2004 | |13;stanford-crypto-sha256-iterative;68;69;69;67;67;68;65;73;73;86 06:12:08 INFO - PROCESS | 2004 | __end_tp_report 06:12:08 INFO - PROCESS | 2004 | __start_cc_report 06:12:08 INFO - PROCESS | 2004 | _x_x_mozilla_cycle_collect,2060 06:12:08 INFO - PROCESS | 2004 | __end_cc_report 06:12:08 INFO - PROCESS | 2004 | __startTimestamp1471612328420__endTimestamp 06:12:08 INFO - PROCESS | 2004 | 06:12:08 INFO - PROCESS | 2004 | ------- Summary: start ------- 06:12:08 INFO - PROCESS | 2004 | Number of tests: 14 06:12:08 INFO - PROCESS | 2004 | 06:12:08 INFO - PROCESS | 2004 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.00 stddev:2.88 (2.6%) stddev-sans-first:1.54 06:12:08 INFO - PROCESS | 2004 | Values: 103.0 112.0 112.0 111.0 107.0 111.0 111.0 112.0 111.0 111.0 06:12:08 INFO - PROCESS | 2004 | 06:12:08 INFO - PROCESS | 2004 | [#1] audio-beat-detection Cycles:10 Average:135.30 Median:133.00 stddev:27.45 (20.6%) stddev-sans-first:28.94 06:12:08 INFO - PROCESS | 2004 | Values: 144.0 115.0 130.0 197.0 136.0 129.0 129.0 107.0 161.0 105.0 06:12:08 INFO - PROCESS | 2004 | 06:12:08 INFO - PROCESS | 2004 | [#2] audio-dft Cycles:10 Average:194.60 Median:185.00 stddev:24.93 (13.5%) stddev-sans-first:26.36 06:12:08 INFO - PROCESS | 2004 | Values: 200.0 263.0 198.0 185.0 182.0 184.0 185.0 185.0 180.0 184.0 06:12:08 INFO - PROCESS | 2004 | 06:12:08 INFO - PROCESS | 2004 | [#3] audio-fft Cycles:10 Average:67.30 Median:64.00 stddev:11.70 (18.3%) stddev-sans-first:11.47 06:12:08 INFO - PROCESS | 2004 | Values: 80.0 59.0 62.0 87.0 59.0 58.0 65.0 63.0 84.0 56.0 06:12:08 INFO - PROCESS | 2004 | 06:12:08 INFO - PROCESS | 2004 | [#4] audio-oscillator Cycles:10 Average:92.20 Median:70.00 stddev:20.66 (29.5%) stddev-sans-first:21.75 06:12:08 INFO - PROCESS | 2004 | Values: 85.0 92.0 136.0 103.0 101.0 68.0 95.0 71.0 69.0 102.0 06:12:08 INFO - PROCESS | 2004 | 06:12:08 INFO - PROCESS | 2004 | [#5] imaging-gaussian-blur Cycles:10 Average:89.50 Median:88.00 stddev:9.13 (10.4%) stddev-sans-first:9.67 06:12:08 INFO - PROCESS | 2004 | Values: 88.0 85.0 88.0 115.0 88.0 85.0 89.0 85.0 88.0 84.0 06:12:08 INFO - PROCESS | 2004 | 06:12:08 INFO - PROCESS | 2004 | [#6] imaging-darkroom Cycles:10 Average:102.30 Median:93.00 stddev:17.42 (18.7%) stddev-sans-first:18.22 06:12:08 INFO - PROCESS | 2004 | Values: 94.0 101.0 94.0 128.0 141.0 92.0 93.0 94.0 93.0 93.0 06:12:08 INFO - PROCESS | 2004 | 06:12:08 INFO - PROCESS | 2004 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:86.00 stddev:20.25 (23.5%) stddev-sans-first:21.13 06:12:08 INFO - PROCESS | 2004 | Values: 86.0 86.0 86.0 84.0 85.0 86.0 127.0 140.0 99.0 85.0 06:12:08 INFO - PROCESS | 2004 | 06:12:08 INFO - PROCESS | 2004 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:55.00 stddev:1.42 (2.6%) stddev-sans-first:1.50 06:12:08 INFO - PROCESS | 2004 | Values: 55.0 53.0 57.0 55.0 55.0 56.0 53.0 53.0 56.0 54.0 06:12:08 INFO - PROCESS | 2004 | 06:12:08 INFO - PROCESS | 2004 | [#9] json-stringify-tinderbox Cycles:10 Average:69.30 Median:70.00 stddev:4.32 (6.2%) stddev-sans-first:3.94 06:12:08 INFO - PROCESS | 2004 | Values: 63.0 64.0 69.0 79.0 71.0 70.0 70.0 68.0 69.0 70.0 06:12:08 INFO - PROCESS | 2004 | 06:12:08 INFO - PROCESS | 2004 | [#10] stanford-crypto-aes Cycles:10 Average:92.90 Median:84.50 stddev:10.81 (12.8%) stddev-sans-first:10.97 06:12:08 INFO - PROCESS | 2004 | Values: 84.0 86.0 87.0 85.0 97.0 105.0 105.0 75.0 100.0 105.0 06:12:08 INFO - PROCESS | 2004 | 06:12:08 INFO - PROCESS | 2004 | [#11] stanford-crypto-ccm Cycles:10 Average:141.60 Median:140.50 stddev:6.28 (4.5%) stddev-sans-first:6.63 06:12:08 INFO - PROCESS | 2004 | Values: 140.0 139.0 143.0 144.0 140.0 137.0 136.0 138.0 158.0 141.0 06:12:08 INFO - PROCESS | 2004 | 06:12:08 INFO - PROCESS | 2004 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.90 Median:169.00 stddev:5.82 (3.4%) stddev-sans-first:6.16 06:12:08 INFO - PROCESS | 2004 | Values: 169.0 168.0 186.0 169.0 170.0 167.0 166.0 166.0 169.0 169.0 06:12:08 INFO - PROCESS | 2004 | 06:12:08 INFO - PROCESS | 2004 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.50 Median:69.00 stddev:6.00 (8.7%) stddev-sans-first:6.30 06:12:08 INFO - PROCESS | 2004 | Values: 68.0 69.0 69.0 67.0 67.0 68.0 65.0 73.0 73.0 86.0 06:12:08 INFO - PROCESS | 2004 | -------- Summary: end -------- 06:12:08 INFO - PROCESS | 2004 | 06:12:09 INFO - TEST-INFO | 2004: exit 0 06:12:09 INFO - TEST-OK | kraken | took 59847ms 06:12:09 INFO - SUITE-END | took 1178s 06:12:09 INFO - Completed test suite (00:19:38) 06:12:09 INFO - javascript benchmark 06:12:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2981.284491721987, 3381.0, 3392.864285428583, 3396.813175275362, 3405.1997780521574, 5793.507551858087, 5868.530517558585, 5886.440788125126, 5970.104484327348, 5987.281526216854, 5881.941180588193, 5891.440313170253, 5893.55798315126, 5913.940860591393, 5930.199423077883, 5309.62832601718, 5353.678779273256, 5406.756695948692, 5407.405185429599, 5442.809501667422, 5408.891822163554, 5434.7826086956475, 5442.836714898559, 5446.319210098738, 5449.591280653947, 5331.2003199519995, 5367.409584945653, 5375.43557926418, 5389.137737961927, 5434.646747961389, 5453.127499600065, 5457.372402173761, 5471.890562188773, 5480.725963701799, 5531.3362396512275, 4329.610335069828, 5200.5059519345605, 5326.440723723992, 5383.138697808371, 5396.703181325026, 5801.390853960358, 5814.244148260699, 5824.184614154022, 5924.7333869975955, 5950.107483877409, 6292.339304373067, 6319.6524191169465, 6324.71538780756, 6325.430711236011, 6328.746850125989, 6216.222972128484, 6241.095041219043, 6293.748250069992, 6328.050792381179, 6352.7141278642575, 6100.847478812976, 6103.816885493442, 6106.572539922163, 6128.448439640454, 6129.69351532426, 6448.451881590117, 6457.515686323544, 6457.903131453032, 6470.838229044311, 6486.156799616019, 6147.323794382614, 6198.132261483396, 6255.155554000243, 6260.749570017239, 6275.0, 6328.841778955563, 6335.493160547145, 6342.302346741947, 6351.174347334817, 6366.363363663597, 6279.183706118175, 6284.654344011124, 6301.086342480315, 6317.557770955989, 6352.110704501373, 6193.783217587363, 6263.498920086473, 6266.749330026839, 6314.810555683337, 6327.430531252209, 5057.671251368649, 5078.060558796635, 5083.288339632454, 5128.512791284822, 5132.923006154911, 3842.3083844907624, 4580.679352445363, 4614.538546145359, 4630.837920672828, 4643.674942753974, 5850.707464626752, 5948.167256584082, 5951.732172052268, 5953.583249172603, 6016.518678505709, 6240.781572644935, 6273.309935907047, 6302.149209856702, 6368.076628888785, 6405.327440618761, 5906.704664766745, 5947.881042379128, 5974.85062873423, 5977.910331345033, 6002.429769171922, 5606.971965140148, 5616.354119276254, 5617.971910140505, 5627.212190293362, 5627.6904770237215, 5629.0, 6315.431611155018, 6333.240011198685, 6343.302236753953, 6505.8048258550425, 6228.4705800007505, 6268.937310626835, 6272.560920735505, 6347.492200624031, 6358.459530939922, 6498.675066246763, 6499.870002600016, 6507.28419873823, 6509.251436084911, 6511.641859697762, 6195.876082478235, 6281.874362512633, 6284.528660350401, 6312.558120931674, 6318.115463835159, 6145.156453064153, 6244.375562443719, 6264.780732674334, 6308.747650093945, 6355.968220158869, 6294.402031806971, 6302.684865756602, 6307.337729538516, 6307.526935479766, 6316.336784637547, 6101.450869421773, 6283.59156654816, 6287.937120628735, 6296.968515157578, 6323.588966717149, 6130.846728831815, 6144.511472853502, 6164.876702466016, 6219.720112594853, 6228.190335256388, 6274.592151510137, 6308.589941653778, 6317.842053948688, 6320.0, 6339.746410143727, 6024.518038556993, 6106.175666284995, 6201.658908760061, 6208.4722798562625, 6217.036359364306], "value": 5843.247963208371, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [468.4542507978206, 479.8680362900203, 520.2170733046764, 530.9230161626564, 538.6956369651149, 30850.69149308506, 39815.203695926066, 41019.17961640769, 41055.17889642213, 41126.7943660282, 42247.0, 42610.57389426105, 42669.7866510667, 42705.359419608656, 42717.78641106798, 8637.179467950566, 9540.76148096298, 9718.902810971906, 9721.222302215841, 9738.367006144614, 8666.436681615707, 11756.706082347924, 12050.517979280818, 12065.457054432527, 12299.631011069681, 12036.097292703038, 12087.395630218498, 12133.150679452441, 12136.93931530341, 12161.635150945485, 12066.276023438579, 12155.0, 12160.939195303967, 12162.148649594532, 12170.574029908956, 9858.90141098587, 9880.802383952352, 11842.644720658394, 11901.702457438634, 11925.224860384047, 32988.50517242243, 39817.80091099526, 40154.39768403476, 40309.193816123516, 40344.59655403467, 3368.1747971747077, 3431.6396778338412, 3441.5181874537584, 3529.858805647771, 3911.9608803911883, 30556.388872222433, 31603.20991975196, 31686.049418517483, 31733.682663173302, 31736.206594835083, 3168.556402103707, 3246.724028457584, 3308.7353011759, 3376.4428869236544, 3382.594088709346, 514807.0, 516346.0, 518045.0, 518797.0, 523515.38242308924, 59412.70293648504, 59449.10826337608, 59700.104498432556, 59851.70074149602, 59951.40048599545, 60179.699101504215, 61194.0, 61286.69356653188, 61286.69356653278, 61365.38634613686, 16143.677126457405, 16350.918245408697, 16371.42700005494, 16379.262933167798, 16392.508224753277, 11408.828867566994, 11712.355820429959, 12566.057545683927, 12692.746145077046, 12816.35918204086, 16182.919085404734, 16251.187440627922, 16253.187340632921, 16298.674026519404, 16470.0, 6293.496520278367, 6461.57999730016, 6552.672366381662, 6961.164660240703, 6996.510244282953, 884.8849649545647, 1008.0473952115327, 1045.994770026145, 1069.6523629820183, 1079.3308148947704, 30464.238394039883, 30544.389112217632, 31042.379152416826, 31307.84346078255, 31340.373192536477, 1032.4476405123223, 1090.7327704712238, 1102.2780079048237, 1138.738090239233, 1170.69561913903, 15366.0, 15780.0, 15831.89176757639, 16061.277242524115, 16226.945248558806, 667342.0, 669474.0, 669933.0, 671248.0, 677557.0, 59133.40866591279, 59502.70248648815, 59546.10680839791, 59598.10602840961, 59812.99999999913, 1259.0871618077003, 1365.208179256029, 1395.0722769358465, 1408.4929425406845, 1423.131889547396, 30291.545626816056, 31266.0, 31282.90509832145, 31891.0, 32009.519857201696, 49718.0, 50241.748791255806, 50248.497515024384, 50344.0, 50511.989760205324, 425527.0, 503629.0, 503634.0, 504724.0, 505063.0, 26109.08618198354, 26879.462410752065, 26964.685650295858, 27688.30779230455, 39685.404718929814, 40671.983200420225, 47754.761226193645, 48512.0, 48758.0248395023, 48906.0, 38464.61535384722, 39173.0, 39355.0, 40413.0, 40684.0, 32900.835495822364, 39073.023174420865, 39114.80442597769, 39124.0, 40466.0, 38819.417708733825, 39122.82631521059, 39176.412353815285, 39274.2145157101, 39447.408288875115, 32469.35061298808, 34448.9909423167, 34727.0, 34850.82574587111, 35159.29681406306, 25872.223833285032, 25975.870120649277, 26195.0, 26360.736392636594, 26371.340716482242], "value": 20425.756583591217, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.97692649977733, 373.348506855537, 378.92610940866535, 387.506163738787, 410.8007616306091, 13308.0, 16131.951423157501, 20519.897400513015, 21239.787602123975, 21343.25298614549, 18895.62208755824, 21274.680879786814, 21450.0, 21565.0, 22089.0, 5850.21022162008, 5955.523558115362, 6012.5791194616395, 6073.574849760518, 6136.23297087864, 5995.6102853314615, 6097.512199024068, 6104.053871649901, 6109.480694141003, 6121.540884433663, 4161.646260067898, 6250.624962502242, 6652.301508341627, 6732.990051492291, 6800.931990680079, 6464.709088091, 6642.070110184578, 6720.361565651256, 6722.1261236039245, 6749.223839258474, 5826.883462330772, 5834.154047663107, 5837.474627283523, 5840.094785308284, 5841.795537156179, 25053.37366565832, 26134.954601815905, 26882.865585671945, 27110.0, 27322.45355092887, 2186.5080356919725, 2275.84069115162, 2303.205394139036, 2547.808914331414, 2740.49300879336, 9623.1820295275, 10107.292489525737, 10210.591576336938, 10447.373157610567, 10495.0, 1849.870509064366, 1865.216609024213, 1886.2737845929278, 1964.8274084501497, 1976.1107501624326, 112668.0, 122188.0, 123566.38216808948, 124961.0, 125642.0, 11154.888451115547, 11262.493187806569, 11550.960413562652, 11562.479688414041, 11716.472758725879, 14551.636209094857, 14583.270836458347, 14598.0, 14599.708005839824, 14607.415703371746, 8380.329573634095, 8595.78510537229, 8651.0, 8758.56207189638, 8760.912390876138, 8514.403991720645, 8516.967279166724, 8520.0, 8675.869861952076, 8762.649494020296, 4469.9776501117285, 4583.885402864888, 4584.470745912724, 4638.611115275636, 4678.836240731558, 1646.6871294454015, 1866.1602278974515, 1923.4325873866962, 1927.807219278061, 1931.643395058027, 707.6850801393433, 771.221066722603, 900.4377405201969, 933.244072301438, 1045.3414348960107, 21001.369958901258, 22064.448388790086, 22338.771367574613, 22431.663525047137, 22564.66153007706, 957.6935380678116, 983.9360441571275, 993.9701808945744, 1020.8315627921459, 1046.947652617366, 10846.783064338826, 11650.242734222249, 11747.236429632047, 11777.705557361134, 11793.469293881795, 580375.0, 599010.0, 603596.0, 613521.0, 616989.9150504308, 133784.66215337918, 137841.3107934454, 140688.29655851657, 141034.0, 141429.5857041437, 1008.566316483919, 1019.0522813783252, 1033.705393962717, 1055.145332280855, 1056.624898161157, 15156.166410847069, 16255.756163657317, 20210.39368818938, 20332.593348132657, 20370.18519259213, 30809.229769255053, 53838.73080634572, 56549.71725141348, 57147.71358153128, 58354.7082264586, 83378.0, 84298.57850710707, 84316.57841710752, 84670.0, 84895.57552212446, 7772.572508512086, 7786.532808031537, 7953.8409231816195, 8073.313768329758, 8097.149799270992, 9644.75888102803, 12019.459124339252, 12231.388430578258, 12347.69130771738, 12599.244045356942, 10591.682249532527, 10667.733306667395, 10731.034206921415, 10964.342139471339, 10991.39547324873, 8987.595558199766, 9620.37467564606, 10121.493925303852, 10648.763759610569, 10708.518116684923, 9709.9029009709, 9821.312508124363, 10728.89271107279, 10931.508082136164, 11109.944450277697, 7792.571408572356, 8015.47899386538, 8038.799030024296, 8040.87938680932, 8097.449303469389, 10644.574217031231, 10800.729981750519, 11133.777324453627, 11190.496427660937, 11423.771524569629], "value": 9669.767439240613, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1332.4936524120833, 1483.5326872035307, 1531.7472617018193, 1663.9584010399738, 1812.3384964487957, 7671.386289096873, 8213.876791848126, 8229.423940324179, 8237.6293066812, 8240.258376746091, 8089.23152300532, 8431.325493960483, 8590.012148602913, 8619.698310559132, 8756.781080472976, 2365.432296248905, 2399.8200134989856, 2400.435897564071, 2401.891914863835, 2404.266698656909, 2354.105439932832, 2373.727021392545, 2402.843815152018, 2404.807615390773, 2410.385351735305, 2360.0, 2380.143148466551, 2393.5093305872256, 2400.195934361991, 2401.3396316013063, 1988.3040935672543, 2324.9651255231183, 2342.2504798464497, 2356.198892376583, 2364.2788949370433, 2332.5684748321614, 2347.988260058689, 2380.8809559521956, 2385.8807059646947, 2387.069043073203, 8769.254613357809, 8930.821383572356, 8939.240164586017, 8946.552672366355, 8949.821003579891, 5189.66267192635, 5210.973945130288, 5384.488473595002, 5390.056740070472, 5396.865078373072, 3642.581103173116, 3733.1600389912323, 3740.775553466801, 3761.605031471711, 3765.5104836371097, 1082.6427278997912, 1091.110744743032, 1112.7051331397186, 1113.0761467981556, 1114.7324642085923, 11601.361925094116, 11698.0, 11715.707107322385, 11747.647570572897, 11756.470958806874, 4394.406755088086, 4542.568455996675, 4633.285684296764, 4673.813047478131, 4686.109639168547, 9205.585748641328, 9217.124373184537, 9251.398659087137, 9252.537373131316, 9290.303227257982, 5284.339457567804, 5290.285811415487, 5291.920621190685, 5292.285541451932, 5295.099833028317, 4067.6949228807366, 4433.8226470941445, 4915.87710307238, 4967.90064198714, 4990.051890140861, 3730.309892669865, 3743.5694895086867, 3790.1093243087853, 3829.1767270037076, 3847.576766555677, 1173.5364531010202, 1177.917545771805, 1182.0602620916393, 1197.7724232395817, 1199.5321824488456, 907.2923119966437, 912.3659056955485, 930.5440334236175, 944.8299306124826, 962.0187408842941, 5473.28847249855, 5610.270664813548, 5944.197533333031, 5956.404359564009, 6289.0, 434.1057421711285, 434.71960585422227, 440.5528388685487, 445.97993090311013, 458.3720303184658, 4020.7386519876113, 4028.3685107531496, 4113.465249517603, 4134.979325103355, 4204.1171354016, 10481.895181048092, 10918.126549875991, 10989.285696429866, 11051.889481105087, 11076.778464430827, 10525.9473702631, 10998.285111467729, 11024.393658348868, 11036.668899933014, 11039.72400689973, 8087.676492940334, 8331.583420828934, 8347.373946954003, 8349.123342049119, 8353.37349698775, 5105.489451054865, 5877.617954832922, 5981.581289309706, 5997.370276121119, 6108.144859719731, 10155.187584993035, 10169.898301016896, 10221.642242521477, 10293.330933489298, 10309.0, 9386.624535018524, 9782.706518804447, 9843.803123937625, 9972.900270997197, 10286.382817031003, 6086.573939824169, 6858.554193977376, 6926.06498122747, 6960.756373526902, 6973.96513017452, 8327.875081873897, 8422.0, 8439.915600844159, 8440.113788052166, 8446.197611226924, 7100.218975912542, 7556.962215188889, 7559.244075592397, 7650.426218033558, 7732.690692372242, 7196.748113815991, 7347.485676002629, 7363.300486453778, 7366.742164024234, 7373.078365204349, 6148.815535533941, 7047.718091276497, 7058.294170582901, 7148.606826624586, 7151.678174482056, 5061.164907790173, 5102.923456148235, 5119.616028797929, 5140.845774626767, 5193.0, 5055.898882022266, 5078.568321692697, 5231.503007214308, 5249.2651028855225, 5332.466753324637], "value": 4481.456693195792, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.67769614575906, 298.4329773430482, 307.86761692472226, 307.9630444346678, 309.4569031349982, 5139.897202055957, 5183.352080989876, 5332.813351532697, 5342.732863356831, 5388.973055134724, 5104.33643626328, 5200.453952335007, 5297.867553311169, 5317.3619165700175, 5333.253344531759, 3368.2758206985495, 4080.653384383154, 4095.1604920991276, 4095.221907837516, 4113.300738874398, 3578.499010138583, 3956.8417263309434, 4084.8766589188062, 4102.323116685743, 4111.1366613011305, 3797.620237976194, 3912.2371137628174, 3959.9208015839667, 4053.6149065838845, 4075.8981025474304, 3328.62003667379, 3525.0, 4060.7969601519953, 4064.126212864219, 4065.6340929316207, 3092.922676933072, 3545.0, 3550.6449355064547, 3551.8224088795714, 3578.1949061461223, 4823.662343635947, 4922.975385123087, 5085.313482679828, 5172.767225474825, 5203.219517072469, 3489.319582681378, 4114.300568903293, 4256.893207765972, 4590.357349971006, 4668.463126740435, 4825.7587120644175, 5282.709450980195, 5560.499555040065, 5582.944170558324, 5583.776648934037, 3015.411994661042, 3755.4742336072973, 3812.2844719876166, 3863.5466478785893, 3907.5115610548683, 5563.887222555505, 5920.615160014585, 5922.615030023035, 5922.703864806743, 5960.672163031031, 3281.45855933773, 3654.3056819204267, 3888.902777430587, 3914.373700207953, 3914.9608503914596, 3347.0, 3439.9828000860334, 3475.374432602105, 3961.445397644332, 3967.3652215645934, 4548.113117942035, 4560.931586026212, 4578.748168850745, 4594.471635761864, 4626.537346265414, 4921.606271498272, 5641.689707066069, 5676.120201368794, 5677.517411020027, 5721.084626459747, 1111.6164923101517, 1271.3579642280774, 1293.224065560656, 1301.4902712853234, 1313.487739781486, 869.7651634058768, 877.8683197520423, 895.8521843895815, 902.5712786426526, 905.4431524612447, 3943.9014024649614, 4879.339965639841, 5062.341895553554, 5117.820876269313, 5160.612954028463, 4944.826931057396, 5405.78376864921, 5671.631343962629, 5683.346415162309, 5683.516901063374, 4274.465691788527, 4921.630877684188, 5112.207607820794, 5125.33370661819, 5145.993062705548, 2405.951880962371, 2627.89488420461, 2684.3289177705574, 3048.7103725146076, 3055.9847200764298, 5553.972230138824, 5677.779277455367, 6000.33996260411, 6009.519238460913, 6034.034554471351, 4959.876003099879, 5079.1365467870555, 5574.693391863405, 5805.10020946754, 5985.431384018511, 5327.082250389856, 6057.878842423215, 6075.726592303446, 6078.270607527125, 6117.908231376533, 5397.919031214614, 5560.638558493685, 5887.852803679943, 5893.941060589339, 5912.940870591411, 4907.2393778964315, 5288.757142071687, 5495.368032676293, 5823.699638642628, 5848.0, 6058.212432383762, 6066.1204125402455, 6102.0, 6143.662098584442, 6162.568620196544, 3621.8913432597064, 3856.787876666698, 3857.7685338879755, 3909.5308562972627, 3928.214357128643, 5056.191009438619, 5206.739663016759, 5837.766489340379, 5856.707164641836, 5866.858596612291, 4956.628252880976, 5530.6128570999645, 5653.462921022497, 5704.828855134353, 5706.031419160383, 5666.271787104973, 5689.34572524165, 5697.658140511417, 5703.0, 5720.7963540417495, 5198.530697918459, 5550.8057217997175, 5564.358514238228, 5582.190582365453, 5589.748461319169, 4908.190148625436, 4971.751412429292, 5449.6375906023495, 5701.771929122954, 5703.0, 4488.438945131858, 4792.137415265286, 5321.79145654549, 5555.527780138734, 5598.564624388404], "value": 4068.261262519605, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [603.1363088057901, 706.9045678833356, 710.2010238481711, 711.2574193226594, 780.0, 15343.539693809189, 16269.105199214067, 16516.0, 16531.090790006543, 16610.08644524552, 14955.47655832046, 15069.39722411105, 15112.924435377836, 15129.394824207018, 15390.0, 846.7036537211973, 887.0109827542276, 888.800019995499, 890.025422162734, 894.7360528644033, 693.7121094745675, 719.899214110025, 880.8678698195258, 883.9745894762077, 885.1148851148852, 891.2335391563283, 922.0548937339247, 923.8475651517491, 925.4909799610222, 929.2844509727539, 910.3309067835136, 910.8588168833808, 911.2664305234284, 911.7128104647015, 913.0777914306598, 536.9140937449989, 673.4107655801174, 686.5400181878103, 689.152342618582, 689.7689274093185, 15421.0, 15425.691486170326, 15477.613059673486, 15486.5354039379, 15498.457553985669, 13871.722565548733, 14456.855431445656, 14465.566033019026, 14518.92740536301, 14576.271186440636, 11124.833127503094, 13168.5525027703, 13560.932195339059, 13803.930980345134, 13861.23763193024, 3943.743656662308, 4721.669483136182, 4732.929006064912, 4917.50824917509, 4942.456329803718, 101209.0, 128301.99999999907, 129555.35222323923, 129940.3502982479, 132602.0, 11343.716407089889, 11465.31208127515, 11484.253523520945, 11495.310281383145, 11959.162858599988, 22957.88521057384, 22989.655155172684, 23022.7697723024, 23026.884865575565, 23057.308280751604, 7995.320397766255, 8090.0, 8130.812182234038, 8213.219744124299, 8348.791280218044, 4438.178936896685, 4512.300593408027, 4521.140983213245, 4576.908461830745, 4692.366530518405, 3578.481120237551, 3683.7605555638797, 3685.1155722626377, 3688.188598508324, 3690.833912473945, 668.6756922892394, 677.0926957876469, 681.8295426143465, 684.2234064337014, 695.7078027228577, 522.6602708239599, 576.0, 601.608259704158, 620.7920346683911, 634.3117717276714, 7828.452008359474, 8793.604287807064, 9064.0, 9162.444113263786, 9210.102042334845, 591.6213623281103, 612.6018088242589, 614.5483069943588, 637.2448648351718, 638.4062821575978, 4163.687723420756, 4403.779811009436, 4421.845235416809, 4428.468583769968, 4537.77311134442, 139428.0, 162068.0, 169572.0, 172652.0, 173438.0, 147011.0, 148101.0, 148172.0, 156012.0, 157341.42658573267, 121471.0, 121734.0, 124112.0, 125442.0, 129639.42391809657, 8450.070492245972, 8594.613242404232, 8596.484210947363, 8757.912420875964, 8809.295256379346, 63543.0, 65161.0, 67604.3239567598, 68719.65640171767, 69544.60910781857, 85392.57303713441, 104166.437503436, 104571.0, 105601.47199263955, 105640.47179764052, 13106.279154646205, 13327.933360333136, 13706.93146534261, 13886.444542218198, 13959.0, 14727.779083313544, 15195.924020379827, 15716.68566628684, 15765.29056192497, 15793.68412631764, 14006.929965350108, 14240.287985600886, 14290.928545357207, 14547.78178327347, 14841.109533428029, 13630.522931697344, 14226.71546569042, 14472.710545788814, 14583.708325833211, 14706.338214780146, 13676.452941882611, 13805.585832425044, 14104.0, 14122.364493598017, 14238.0, 10814.945925270324, 11011.834822477509, 11093.722656933318, 11431.54221842308, 11538.307701537935, 11491.367974761468, 11631.941840290745, 11670.0, 11778.293302401884, 11794.469248883992], "value": 8126.920049566508, "unit": "score"}], "name": "dromaeo_css", "value": 7450.3222830476325, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 112.0, 111.0, 107.0, 111.0, 111.0, 112.0, 111.0, 111.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 115.0, 130.0, 197.0, 136.0, 129.0, 129.0, 107.0, 161.0, 105.0], "value": 135.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 263.0, 198.0, 185.0, 182.0, 184.0, 185.0, 185.0, 180.0, 184.0], "value": 194.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 62.0, 87.0, 59.0, 58.0, 65.0, 63.0, 84.0, 56.0], "value": 67.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 92.0, 136.0, 103.0, 101.0, 68.0, 95.0, 71.0, 69.0, 102.0], "value": 92.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 88.0, 115.0, 88.0, 85.0, 89.0, 85.0, 88.0, 84.0], "value": 89.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 101.0, 94.0, 128.0, 141.0, 92.0, 93.0, 94.0, 93.0, 93.0], "value": 102.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 86.0, 84.0, 85.0, 86.0, 127.0, 140.0, 99.0, 85.0], "value": 96.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 57.0, 55.0, 55.0, 56.0, 53.0, 53.0, 56.0, 54.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 69.0, 79.0, 71.0, 70.0, 70.0, 68.0, 69.0, 70.0], "value": 69.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 87.0, 85.0, 97.0, 105.0, 105.0, 75.0, 100.0, 105.0], "value": 92.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 139.0, 143.0, 144.0, 140.0, 137.0, 136.0, 138.0, 158.0, 141.0], "value": 141.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 168.0, 186.0, 169.0, 170.0, 167.0, 166.0, 166.0, 169.0, 169.0], "value": 169.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 69.0, 67.0, 67.0, 68.0, 65.0, 73.0, 73.0, 86.0], "value": 70.5, "unit": "score"}], "name": "kraken", "value": 1486.6, "alertThreshold": 2.0}]} 06:12:09 INFO - Return code: 0 06:12:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:12:09 INFO - # TBPL SUCCESS # 06:12:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:12:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:12:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:12:09 INFO - 2016-08-19 06:12:09.711 screenresolution[2008:12285] starting screenresolution argv=screenresolution get 06:12:09 INFO - 2016-08-19 06:12:09.714 screenresolution[2008:12285] Display 0: 1600x1200x32@60 06:12:09 INFO - 2016-08-19 06:12:09.720 screenresolution[2009:12288] starting screenresolution argv=screenresolution list 06:12:09 INFO - Available Modes on Display 0 06:12:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:12:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:12:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:12:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:12:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:12:09 INFO - Intel Iris: 06:12:09 INFO - Chipset Model: Intel Iris 06:12:09 INFO - Type: GPU 06:12:09 INFO - Bus: Built-In 06:12:09 INFO - VRAM (Dynamic, Max): 1536 MB 06:12:09 INFO - Vendor: Intel (0x8086) 06:12:09 INFO - Device ID: 0x0a2e 06:12:09 INFO - Revision ID: 0x0009 06:12:09 INFO - Displays: 06:12:09 INFO - Display: 06:12:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:12:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:12:09 INFO - Display Serial Number: 1600x1200 60 06:12:09 INFO - Main Display: Yes 06:12:09 INFO - Mirror: Off 06:12:09 INFO - Online: Yes 06:12:09 INFO - Rotation: Supported 06:12:09 INFO - Return code: 0 06:12:09 INFO - Running post-action listener: _resource_record_post_action 06:12:09 INFO - [mozharness: 2016-08-19 13:12:09.957451Z] Finished run-tests step (success) 06:12:09 INFO - Running post-run listener: _resource_record_post_run 06:12:10 INFO - Total resource usage - Wall time: 1214s; CPU: 54.0%; Read bytes: 327680; Write bytes: 704342016; Read time: 8; Write time: 1836 06:12:10 INFO - TinderboxPrint: CPU usage
53.7% 06:12:10 INFO - TinderboxPrint: I/O read bytes / time
327,680 / 8 06:12:10 INFO - TinderboxPrint: I/O write bytes / time
704,342,016 / 1,836 06:12:10 INFO - TinderboxPrint: CPU idle
2,249.1 (46.3%) 06:12:10 INFO - TinderboxPrint: CPU system
978.5 (20.1%) 06:12:10 INFO - TinderboxPrint: CPU user
1,630.1 (33.6%) 06:12:10 INFO - TinderboxPrint: Swap in / out
405,667,840 / 0 06:12:10 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 386077184; Write bytes: 380257792; Read time: 29344; Write time: 688 06:12:10 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 327680; Write bytes: 295566336; Read time: 8; Write time: 1085 06:12:10 INFO - Running post-run listener: _upload_blobber_files 06:12:10 INFO - Blob upload gear active. 06:12:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:12:10 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 06:12:10 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'] 06:12:10 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 06:12:10 INFO - (blobuploader) - INFO - Open directory for files ... 06:12:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:12:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:12:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:12:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:12:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:12:11 INFO - (blobuploader) - INFO - Done attempting. 06:12:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:12:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:12:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:12:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:12:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:12:12 INFO - (blobuploader) - INFO - Done attempting. 06:12:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:12:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:12:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:12:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:12:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:12:15 INFO - (blobuploader) - INFO - Done attempting. 06:12:15 INFO - (blobuploader) - INFO - Iteration through files over. 06:12:15 INFO - Return code: 0 06:12:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:12:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:12:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cd890cdc132b3b7775bc0546cd373c3d925fef0e7d111bd4624c84d5528592ad4042a1557d76498a771f3ab30135f04845e4864df864dbade8271147e67346f3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0a0e0e278f474b0145388f518e511bfcd9a2de09ebb26b36ee3fa51f5664526275c78afe2f79feecbf0fdc449226e1c1cfe0916af3003dc9c90ee78b49b1b7b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/64f6710e682f52ddad3b00eb239df03763a20389252826caa77fe7629e1eaad187825f38f5e6ff894e303ed598e01cdc6345e7cb8e135022c8c43f7e6e39c316"} 06:12:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:12:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:12:15 INFO - Contents: 06:12:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cd890cdc132b3b7775bc0546cd373c3d925fef0e7d111bd4624c84d5528592ad4042a1557d76498a771f3ab30135f04845e4864df864dbade8271147e67346f3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0a0e0e278f474b0145388f518e511bfcd9a2de09ebb26b36ee3fa51f5664526275c78afe2f79feecbf0fdc449226e1c1cfe0916af3003dc9c90ee78b49b1b7b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/64f6710e682f52ddad3b00eb239df03763a20389252826caa77fe7629e1eaad187825f38f5e6ff894e303ed598e01cdc6345e7cb8e135022c8c43f7e6e39c316"} 06:12:15 INFO - Running post-run listener: copy_logs_to_upload_dir 06:12:15 INFO - Copying logs to upload dir... 06:12:15 INFO - mkdir: /builds/slave/test/build/upload/logs 06:12:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.531434 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-08-19 06:12:15.299547) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-19 06:12:15.302743) ========= 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.quxg7cZzct/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.vP8pfcd5k4/Listeners TMPDIR=/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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/cd890cdc132b3b7775bc0546cd373c3d925fef0e7d111bd4624c84d5528592ad4042a1557d76498a771f3ab30135f04845e4864df864dbade8271147e67346f3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0a0e0e278f474b0145388f518e511bfcd9a2de09ebb26b36ee3fa51f5664526275c78afe2f79feecbf0fdc449226e1c1cfe0916af3003dc9c90ee78b49b1b7b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/64f6710e682f52ddad3b00eb239df03763a20389252826caa77fe7629e1eaad187825f38f5e6ff894e303ed598e01cdc6345e7cb8e135022c8c43f7e6e39c316"} build_url:https://queue.taskcluster.net/v1/task/Db6Sj8WTTPyAHQcmfEoraA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011167 build_url: 'https://queue.taskcluster.net/v1/task/Db6Sj8WTTPyAHQcmfEoraA/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/cd890cdc132b3b7775bc0546cd373c3d925fef0e7d111bd4624c84d5528592ad4042a1557d76498a771f3ab30135f04845e4864df864dbade8271147e67346f3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0a0e0e278f474b0145388f518e511bfcd9a2de09ebb26b36ee3fa51f5664526275c78afe2f79feecbf0fdc449226e1c1cfe0916af3003dc9c90ee78b49b1b7b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/64f6710e682f52ddad3b00eb239df03763a20389252826caa77fe7629e1eaad187825f38f5e6ff894e303ed598e01cdc6345e7cb8e135022c8c43f7e6e39c316"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-19 06:12:15.335874) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 06:12:15.336230) ========= 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.quxg7cZzct/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.vP8pfcd5k4/Listeners TMPDIR=/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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.005193 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 06:12:15.386786) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-19 06:12:15.387427) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-19 06:12:15.387990) ========= ========= Total master_lag: 0.18 =========