builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0293 starttime: 1471614550.53 results: success (0) buildid: 20160819034155 builduid: bc7fef971c7244a0b5f0a315241d0afd revision: 7700ad7a72edf62983555b21a88879fa75dc4ec1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-19 06:49:10.534684) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-19 06:49:10.535253) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-19 06:49:10.535585) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-19 06:49:10.561757) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 06:49:10.562181) ========= 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.i6YuXT97wQ/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.61FBlQZIQM/Listeners TMPDIR=/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/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 06:49:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 19.3M=0.001s 2016-08-19 06:49:10 (19.3 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115466 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 06:49:10.701232) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 06:49:10.701883) ========= 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.i6YuXT97wQ/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.61FBlQZIQM/Listeners TMPDIR=/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/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.026452 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 06:49:10.751631) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-19 06:49:10.751994) ========= 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.i6YuXT97wQ/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.61FBlQZIQM/Listeners TMPDIR=/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/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 06:49:10,836 truncating revision to first 12 chars 2016-08-19 06:49:10,836 Setting DEBUG logging. 2016-08-19 06:49:10,836 attempt 1/10 2016-08-19 06:49:10,837 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 06:49:11,931 unpacking tar archive at: fx-team-7700ad7a72ed/testing/mozharness/ program finished with exit code 0 elapsedTime=1.353122 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-19 06:49:12.127799) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-19 06:49:12.128217) ========= script_repo_revision: 7700ad7a72edf62983555b21a88879fa75dc4ec1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-19 06:49:12.128641) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-19 06:49:12.128950) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-19 06:49:12.147602) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-08-19 06:49:12.147991) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.i6YuXT97wQ/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.61FBlQZIQM/Listeners TMPDIR=/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/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 06:49:12 INFO - MultiFileLogger online at 20160819 06:49:12 in /builds/slave/test 06:49:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 06:49:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:49:12 INFO - {'append_to_log': False, 06:49:12 INFO - 'base_work_dir': '/builds/slave/test', 06:49:12 INFO - 'blob_upload_branch': 'Fx-Team', 06:49:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:49:12 INFO - 'branch': 'Fx-Team', 06:49:12 INFO - 'buildbot_json_path': 'buildprops.json', 06:49:12 INFO - 'config_files': ('talos/mac_config.py',), 06:49:12 INFO - 'default_actions': ('clobber', 06:49:12 INFO - 'read-buildbot-config', 06:49:12 INFO - 'download-and-extract', 06:49:12 INFO - 'populate-webroot', 06:49:12 INFO - 'create-virtualenv', 06:49:12 INFO - 'install', 06:49:12 INFO - 'run-tests'), 06:49:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:49:12 INFO - 'download_minidump_stackwalk': True, 06:49:12 INFO - 'download_symbols': 'ondemand', 06:49:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:49:12 INFO - 'tooltool.py': '/tools/tooltool.py', 06:49:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:49:12 INFO - '/tools/misc-python/virtualenv.py')}, 06:49:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:49:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:49:12 INFO - 'installer_path': 'installer.exe', 06:49:12 INFO - 'log_level': 'info', 06:49:12 INFO - 'log_name': 'talos', 06:49:12 INFO - 'log_to_console': True, 06:49:12 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:49:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:49:12 INFO - 'opt_config_files': (), 06:49:12 INFO - 'pip_index': False, 06:49:12 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:49:12 INFO - 'cmd': ('bash', 06:49:12 INFO - '-c', 06:49:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:49:12 INFO - 'enabled': True, 06:49:12 INFO - 'halt_on_failure': False, 06:49:12 INFO - 'name': 'check_screen_resolution'},), 06:49:12 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:49:12 INFO - 'cmd': ('bash', 06:49:12 INFO - '-c', 06:49:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:49:12 INFO - 'enabled': True, 06:49:12 INFO - 'halt_on_failure': False, 06:49:12 INFO - 'name': 'check_screen_resolution'},), 06:49:12 INFO - 'run_cmd_checks_enabled': True, 06:49:12 INFO - 'sps_profile': False, 06:49:12 INFO - 'sps_profile_interval': 0, 06:49:12 INFO - 'suite': 'dromaeojs-e10s', 06:49:12 INFO - 'system_bits': '32', 06:49:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:49:12 INFO - 'title': 't-yosemite-r7-0293', 06:49:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:49:12 INFO - 'use_talos_json': True, 06:49:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:49:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:49:12 INFO - 'work_dir': 'build'} 06:49:12 INFO - [mozharness: 2016-08-19 13:49:12.349541Z] Running clobber step. 06:49:12 INFO - Running pre-action listener: _resource_record_pre_action 06:49:12 INFO - Running main action method: clobber 06:49:12 INFO - rmtree: /builds/slave/test/build 06:49:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:49:14 INFO - Running post-action listener: _resource_record_post_action 06:49:14 INFO - [mozharness: 2016-08-19 13:49:14.413253Z] Finished clobber step (success) 06:49:14 INFO - [mozharness: 2016-08-19 13:49:14.413538Z] Running read-buildbot-config step. 06:49:14 INFO - Running pre-action listener: _resource_record_pre_action 06:49:14 INFO - Running main action method: read_buildbot_config 06:49:14 INFO - Using buildbot properties: 06:49:14 INFO - { 06:49:14 INFO - "project": "", 06:49:14 INFO - "product": "firefox", 06:49:14 INFO - "script_repo_revision": "production", 06:49:14 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 06:49:14 INFO - "repository": "", 06:49:14 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 06:49:14 INFO - "buildid": "20160819034155", 06:49:14 INFO - "pgo_build": "False", 06:49:14 INFO - "basedir": "/builds/slave/test", 06:49:14 INFO - "buildnumber": 77, 06:49:14 INFO - "slavename": "t-yosemite-r7-0293", 06:49:14 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 06:49:14 INFO - "platform": "yosemite_r7", 06:49:14 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 06:49:14 INFO - "branch": "fx-team", 06:49:14 INFO - "repo_path": "integration/fx-team", 06:49:14 INFO - "revision": "7700ad7a72edf62983555b21a88879fa75dc4ec1", 06:49:14 INFO - "stage_platform": "macosx64", 06:49:14 INFO - "builduid": "bc7fef971c7244a0b5f0a315241d0afd", 06:49:14 INFO - "slavebuilddir": "test" 06:49:14 INFO - } 06:49:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/Db6Sj8WTTPyAHQcmfEoraA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 06:49:14 INFO - Running post-action listener: _resource_record_post_action 06:49:14 INFO - [mozharness: 2016-08-19 13:49:14.419242Z] Finished read-buildbot-config step (success) 06:49:14 INFO - [mozharness: 2016-08-19 13:49:14.419445Z] Running download-and-extract step. 06:49:14 INFO - Running pre-action listener: _resource_record_pre_action 06:49:14 INFO - Running main action method: download_and_extract 06:49:14 INFO - mkdir: /builds/slave/test/build/tests 06:49:14 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')]} 06:49:14 INFO - trying https://queue.taskcluster.net/v1/task/Db6Sj8WTTPyAHQcmfEoraA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 06:49:14 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 06:49:14 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 06:49:15 INFO - Downloaded 1199 bytes. 06:49:15 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 06:49:15 INFO - Using the following test package requirements: 06:49:15 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 06:49:15 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 06:49:15 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 06:49:15 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 06:49:15 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 06:49:15 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 06:49:15 INFO - u'jsshell-mac.zip'], 06:49:15 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 06:49:15 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 06:49:15 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 06:49:15 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 06:49:15 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 06:49:15 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 06:49:15 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 06:49:15 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 06:49:15 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 06:49:15 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 06:49:15 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 06:49:15 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:49:15 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')]} 06:49:15 INFO - trying https://queue.taskcluster.net/v1/task/Db6Sj8WTTPyAHQcmfEoraA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 06:49:15 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 06:49:15 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 06:49:16 INFO - Downloaded 16339549 bytes. 06:49:16 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 06:49:23 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 06:49:23 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')]} 06:49:23 INFO - trying https://queue.taskcluster.net/v1/task/Db6Sj8WTTPyAHQcmfEoraA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 06:49:23 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 06:49:23 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 06:49:24 INFO - Downloaded 16339549 bytes. 06:49:24 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 06:49:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:31 INFO - trying https://queue.taskcluster.net/v1/task/Db6Sj8WTTPyAHQcmfEoraA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 06:49:31 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 06:49:31 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 06:49:32 INFO - Downloaded 14413981 bytes. 06:49:32 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 06:49:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:32 INFO - trying https://queue.taskcluster.net/v1/task/Db6Sj8WTTPyAHQcmfEoraA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 06:49:32 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 06:49:32 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 06:49:35 INFO - Downloaded 111248044 bytes. 06:49:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Db6Sj8WTTPyAHQcmfEoraA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 06:49:35 INFO - mkdir: /builds/slave/test/properties 06:49:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:49:35 INFO - Writing to file /builds/slave/test/properties/build_url 06:49:35 INFO - Contents: 06:49:35 INFO - build_url:https://queue.taskcluster.net/v1/task/Db6Sj8WTTPyAHQcmfEoraA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 06:49:36 INFO - Running post-action listener: _resource_record_post_action 06:49:36 INFO - Running post-action listener: set_extra_try_arguments 06:49:36 INFO - [mozharness: 2016-08-19 13:49:36.063765Z] Finished download-and-extract step (success) 06:49:36 INFO - [mozharness: 2016-08-19 13:49:36.063908Z] Running populate-webroot step. 06:49:36 INFO - Running pre-action listener: _resource_record_pre_action 06:49:36 INFO - Running main action method: populate_webroot 06:49:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:49:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:49:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:49:36 INFO - '--tppagecycles', 06:49:36 INFO - '7'], 06:49:36 INFO - 'tests': ['tsvgm']}}, 06:49:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:49:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:49:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:49:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:49:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:49:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:49:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:36 INFO - 'talos_options': ['--disable-e10s'], 06:49:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:49:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:49:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:36 INFO - 'talos_options': ['--disable-e10s'], 06:49:36 INFO - 'tests': ['damp', 'tps']}, 06:49:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:36 INFO - 'tests': ['damp', 'tps']}, 06:49:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:49:36 INFO - 'tests': ['dromaeo_dom']}, 06:49:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:49:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:49:36 INFO - 'tests': ['basic_compositor_video']}, 06:49:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:49:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:49:36 INFO - 'tests': ['a11yr', 06:49:36 INFO - 'ts_paint', 06:49:36 INFO - 'tpaint', 06:49:36 INFO - 'sessionrestore', 06:49:36 INFO - 'sessionrestore_no_auto_restore', 06:49:36 INFO - 'tabpaint']}, 06:49:36 INFO - 'other-e10s': {'tests': ['a11yr', 06:49:36 INFO - 'ts_paint', 06:49:36 INFO - 'tpaint', 06:49:36 INFO - 'sessionrestore', 06:49:36 INFO - 'sessionrestore_no_auto_restore', 06:49:36 INFO - 'tabpaint']}, 06:49:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:49:36 INFO - 'ts_paint', 06:49:36 INFO - 'tpaint', 06:49:36 INFO - 'sessionrestore', 06:49:36 INFO - 'sessionrestore_no_auto_restore', 06:49:36 INFO - 'tabpaint']}, 06:49:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:49:36 INFO - 'ts_paint', 06:49:36 INFO - 'tpaint', 06:49:36 INFO - 'sessionrestore', 06:49:36 INFO - 'sessionrestore_no_auto_restore', 06:49:36 INFO - 'tabpaint']}, 06:49:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:49:36 INFO - 'tests': ['a11yr', 06:49:36 INFO - 'ts_paint', 06:49:36 INFO - 'tpaint', 06:49:36 INFO - 'sessionrestore', 06:49:36 INFO - 'sessionrestore_no_auto_restore', 06:49:36 INFO - 'tabpaint']}, 06:49:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:49:36 INFO - 'tests': ['a11yr', 06:49:36 INFO - 'ts_paint', 06:49:36 INFO - 'tpaint', 06:49:36 INFO - 'sessionrestore', 06:49:36 INFO - 'sessionrestore_no_auto_restore', 06:49:36 INFO - 'tabpaint']}, 06:49:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:49:36 INFO - 'tests': ['tsvgx', 06:49:36 INFO - 'tsvgr_opacity', 06:49:36 INFO - 'tart', 06:49:36 INFO - 'tscrollx', 06:49:36 INFO - 'cart']}, 06:49:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:49:36 INFO - 'tsvgr_opacity', 06:49:36 INFO - 'tart', 06:49:36 INFO - 'tscrollx', 06:49:36 INFO - 'cart']}, 06:49:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:36 INFO - 'talos_options': ['--disable-e10s'], 06:49:36 INFO - 'tests': ['tp5o']}, 06:49:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:36 INFO - 'tests': ['tp5o']}, 06:49:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:36 INFO - 'talos_options': ['--disable-e10s', 06:49:36 INFO - '--xperf_path', 06:49:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:49:36 INFO - 'tests': ['tp5n']}, 06:49:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:49:36 INFO - 'talos_options': ['--xperf_path', 06:49:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:49:36 INFO - 'tests': ['tp5n']}}, 06:49:36 INFO - 'talos.zip': {'path': '', 06:49:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:49:36 INFO - Running post-action listener: _resource_record_post_action 06:49:36 INFO - [mozharness: 2016-08-19 13:49:36.082527Z] Finished populate-webroot step (success) 06:49:36 INFO - [mozharness: 2016-08-19 13:49:36.082664Z] Running create-virtualenv step. 06:49:36 INFO - Running pre-action listener: _resource_record_pre_action 06:49:36 INFO - Running main action method: create_virtualenv 06:49:36 INFO - Creating virtualenv /builds/slave/test/build/venv 06:49:36 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 06:49:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:49:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:49:36 INFO - Using real prefix '/tools/python27' 06:49:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:49:36 INFO - Installing distribute.............................................................................................................................................................................................done. 06:49:39 INFO - Installing pip.................done. 06:49:39 INFO - Return code: 0 06:49:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:49: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')]} 06:49:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49: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')]} 06:49:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c166a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1fb618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87a154c930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0cad30>, '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 0x10be2fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c0c2b20>, '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.i6YuXT97wQ/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.61FBlQZIQM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/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 06:49: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', 'pip>=1.5'] in /builds/slave/test/build 06:49: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 pip>=1.5 06:49:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.i6YuXT97wQ/Render', 06:49:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:49:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:49:39 INFO - 'HOME': '/Users/cltbld', 06:49:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:49:39 INFO - 'LOGNAME': 'cltbld', 06:49:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:39 INFO - 'MOZ_NO_REMOTE': '1', 06:49:39 INFO - 'NO_EM_RESTART': '1', 06:49:39 INFO - 'PAGER': '/bin/cat', 06:49:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:49:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:49:39 INFO - 'PWD': '/builds/slave/test', 06:49:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:49:39 INFO - 'SHELL': '/bin/bash', 06:49:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.61FBlQZIQM/Listeners', 06:49:39 INFO - 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', 06:49:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:49:39 INFO - 'USER': 'cltbld', 06:49:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:49:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:49:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:39 INFO - 'XPC_FLAGS': '0x0', 06:49:39 INFO - 'XPC_SERVICE_NAME': '0', 06:49:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:49:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:40 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 06:49:40 INFO - Cleaning up... 06:49:40 INFO - Return code: 0 06:49:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:49: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')]} 06:49:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49: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')]} 06:49:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49: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', '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 0x10c166a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1fb618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87a154c930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0cad30>, '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 0x10be2fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c0c2b20>, '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.i6YuXT97wQ/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.61FBlQZIQM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/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 06:49: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', 'psutil>=3.1.1'] in /builds/slave/test/build 06:49: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 psutil>=3.1.1 06:49:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.i6YuXT97wQ/Render', 06:49:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:49:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:49:40 INFO - 'HOME': '/Users/cltbld', 06:49:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:49:40 INFO - 'LOGNAME': 'cltbld', 06:49:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:40 INFO - 'MOZ_NO_REMOTE': '1', 06:49:40 INFO - 'NO_EM_RESTART': '1', 06:49:40 INFO - 'PAGER': '/bin/cat', 06:49:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:49:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:49:40 INFO - 'PWD': '/builds/slave/test', 06:49:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:49:40 INFO - 'SHELL': '/bin/bash', 06:49:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.61FBlQZIQM/Listeners', 06:49:40 INFO - 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', 06:49:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:49:40 INFO - 'USER': 'cltbld', 06:49:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:49:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:49:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:40 INFO - 'XPC_FLAGS': '0x0', 06:49:40 INFO - 'XPC_SERVICE_NAME': '0', 06:49:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:49:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:40 INFO - Downloading/unpacking psutil>=3.1.1 06:49: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 06:49: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 06:49: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 06:49: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 06:49: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 06:49: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 06:49:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:49:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:49:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:49:43 INFO - Installing collected packages: psutil 06:49:43 INFO - Running setup.py install for psutil 06:49:43 INFO - building 'psutil._psutil_osx' extension 06:49:43 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 06:49:43 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 06:49:43 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 06:49:44 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 06:49:44 INFO - building 'psutil._psutil_posix' extension 06:49:44 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 06:49:44 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:49:44 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:49:44 INFO - ^ 06:49:44 INFO - 1 warning generated. 06:49:44 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 06:49:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:49:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:49:44 INFO - Successfully installed psutil 06:49:44 INFO - Cleaning up... 06:49:44 INFO - Return code: 0 06:49:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:49: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')]} 06:49:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49: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')]} 06:49:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c166a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1fb618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87a154c930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0cad30>, '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 0x10be2fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c0c2b20>, '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.i6YuXT97wQ/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.61FBlQZIQM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/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 06:49:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:49:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:49:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.i6YuXT97wQ/Render', 06:49:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:49:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:49:44 INFO - 'HOME': '/Users/cltbld', 06:49:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:49:44 INFO - 'LOGNAME': 'cltbld', 06:49:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:44 INFO - 'MOZ_NO_REMOTE': '1', 06:49:44 INFO - 'NO_EM_RESTART': '1', 06:49:44 INFO - 'PAGER': '/bin/cat', 06:49:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:49:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:49:44 INFO - 'PWD': '/builds/slave/test', 06:49:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:49:44 INFO - 'SHELL': '/bin/bash', 06:49:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.61FBlQZIQM/Listeners', 06:49:44 INFO - 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', 06:49:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:49:44 INFO - 'USER': 'cltbld', 06:49:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:49:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:49:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:44 INFO - 'XPC_FLAGS': '0x0', 06:49:44 INFO - 'XPC_SERVICE_NAME': '0', 06:49:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:49:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:49:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:49:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:49:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:49:47 INFO - Installing collected packages: mozsystemmonitor 06:49:47 INFO - Running setup.py install for mozsystemmonitor 06:49:47 INFO - Successfully installed mozsystemmonitor 06:49:47 INFO - Cleaning up... 06:49:47 INFO - Return code: 0 06:49:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:49:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:47 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 0x10c166a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1fb618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87a154c930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0cad30>, '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 0x10be2fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c0c2b20>, '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.i6YuXT97wQ/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.61FBlQZIQM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/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 06:49:47 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 06:49:47 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 06:49:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.i6YuXT97wQ/Render', 06:49:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:49:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:49:47 INFO - 'HOME': '/Users/cltbld', 06:49:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:49:47 INFO - 'LOGNAME': 'cltbld', 06:49:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:47 INFO - 'MOZ_NO_REMOTE': '1', 06:49:47 INFO - 'NO_EM_RESTART': '1', 06:49:47 INFO - 'PAGER': '/bin/cat', 06:49:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:49:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:49:47 INFO - 'PWD': '/builds/slave/test', 06:49:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:49:47 INFO - 'SHELL': '/bin/bash', 06:49:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.61FBlQZIQM/Listeners', 06:49:47 INFO - 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', 06:49:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:49:47 INFO - 'USER': 'cltbld', 06:49:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:49:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:49:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:47 INFO - 'XPC_FLAGS': '0x0', 06:49:47 INFO - 'XPC_SERVICE_NAME': '0', 06:49:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:49:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:47 INFO - Downloading/unpacking jsonschema==2.5.1 06:49:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:49:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:49:50 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 06:49:50 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 06:49:50 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 06:49:50 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 06:49:50 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 06:49:50 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 06:49:50 INFO - Downloading functools32-3.2.3-2.tar.gz 06:49:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:49:50 INFO - warning: no files found matching '*.txt' 06:49:50 INFO - no previously-included directories found matching 'build' 06:49:50 INFO - no previously-included directories found matching 'dist' 06:49:50 INFO - no previously-included directories found matching '.git*' 06:49:50 INFO - Installing collected packages: jsonschema, functools32 06:49:50 INFO - Running setup.py install for functools32 06:49:50 INFO - warning: no files found matching '*.txt' 06:49:50 INFO - no previously-included directories found matching 'build' 06:49:50 INFO - no previously-included directories found matching 'dist' 06:49:50 INFO - no previously-included directories found matching '.git*' 06:49:50 INFO - Successfully installed jsonschema functools32 06:49:50 INFO - Cleaning up... 06:49:50 INFO - Return code: 0 06:49:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:49:50 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')]} 06:49:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:50 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')]} 06:49:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:50 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 0x10c166a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1fb618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87a154c930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0cad30>, '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 0x10be2fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c0c2b20>, '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.i6YuXT97wQ/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.61FBlQZIQM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/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 06:49:50 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 06:49:50 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 06:49:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.i6YuXT97wQ/Render', 06:49:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:49:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:49:50 INFO - 'HOME': '/Users/cltbld', 06:49:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:49:50 INFO - 'LOGNAME': 'cltbld', 06:49:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:50 INFO - 'MOZ_NO_REMOTE': '1', 06:49:50 INFO - 'NO_EM_RESTART': '1', 06:49:50 INFO - 'PAGER': '/bin/cat', 06:49:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:49:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:49:50 INFO - 'PWD': '/builds/slave/test', 06:49:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:49:50 INFO - 'SHELL': '/bin/bash', 06:49:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.61FBlQZIQM/Listeners', 06:49:50 INFO - 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', 06:49:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:49:50 INFO - 'USER': 'cltbld', 06:49:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:49:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:49:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:50 INFO - 'XPC_FLAGS': '0x0', 06:49:50 INFO - 'XPC_SERVICE_NAME': '0', 06:49:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:49:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:49:51 INFO - Cleaning up... 06:49:51 INFO - Return code: 0 06:49:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:49:51 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')]} 06:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:51 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')]} 06:49:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:51 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 0x10c166a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1fb618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87a154c930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0cad30>, '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 0x10be2fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c0c2b20>, '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.i6YuXT97wQ/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.61FBlQZIQM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/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 06:49:51 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 06:49:51 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 06:49:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.i6YuXT97wQ/Render', 06:49:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:49:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:49:51 INFO - 'HOME': '/Users/cltbld', 06:49:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:49:51 INFO - 'LOGNAME': 'cltbld', 06:49:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:51 INFO - 'MOZ_NO_REMOTE': '1', 06:49:51 INFO - 'NO_EM_RESTART': '1', 06:49:51 INFO - 'PAGER': '/bin/cat', 06:49:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:49:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:49:51 INFO - 'PWD': '/builds/slave/test', 06:49:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:49:51 INFO - 'SHELL': '/bin/bash', 06:49:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.61FBlQZIQM/Listeners', 06:49:51 INFO - 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', 06:49:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:49:51 INFO - 'USER': 'cltbld', 06:49:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:49:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:49:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:51 INFO - 'XPC_FLAGS': '0x0', 06:49:51 INFO - 'XPC_SERVICE_NAME': '0', 06:49:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:49:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:51 INFO - Downloading/unpacking blobuploader==1.2.4 06:49: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 06:49: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 06:49: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 06:49: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 06:49: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 06:49: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 06:49:53 INFO - Downloading blobuploader-1.2.4.tar.gz 06:49:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:49:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:49:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:49:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:49:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:49:55 INFO - Downloading docopt-0.6.1.tar.gz 06:49:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:49:55 INFO - Installing collected packages: blobuploader, requests, docopt 06:49:55 INFO - Running setup.py install for blobuploader 06:49:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:49:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:49:55 INFO - Running setup.py install for requests 06:49:55 INFO - Running setup.py install for docopt 06:49:55 INFO - Successfully installed blobuploader requests docopt 06:49:55 INFO - Cleaning up... 06:49:56 INFO - Return code: 0 06:49:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:49:56 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')]} 06:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:49:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:56 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')]} 06:49:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:49:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:49:56 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 0x10c166a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1fb618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87a154c930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0cad30>, '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 0x10be2fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c0c2b20>, '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.i6YuXT97wQ/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.61FBlQZIQM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/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 06:49:56 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 06:49:56 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 06:49:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.i6YuXT97wQ/Render', 06:49:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:49:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:49:56 INFO - 'HOME': '/Users/cltbld', 06:49:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:49:56 INFO - 'LOGNAME': 'cltbld', 06:49:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:56 INFO - 'MOZ_NO_REMOTE': '1', 06:49:56 INFO - 'NO_EM_RESTART': '1', 06:49:56 INFO - 'PAGER': '/bin/cat', 06:49:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:49:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:49:56 INFO - 'PWD': '/builds/slave/test', 06:49:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:49:56 INFO - 'SHELL': '/bin/bash', 06:49:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.61FBlQZIQM/Listeners', 06:49:56 INFO - 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', 06:49:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:49:56 INFO - 'USER': 'cltbld', 06:49:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:49:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:49:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:56 INFO - 'XPC_FLAGS': '0x0', 06:49:56 INFO - 'XPC_SERVICE_NAME': '0', 06:49:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:49:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:49:56 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-B5X5E3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:49:56 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-NQOug6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:49:56 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-tSHJlR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:49:56 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-XyEWs9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:49:56 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-ffBH5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:49:56 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-5vjBwe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:49:56 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-9KCmfI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:49:57 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-vzTXfM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:49:57 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-syqWe3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:49:57 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-ioqBKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:49:57 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-9bwbK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:49:57 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-wcR_WU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:49:57 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-f9e_Pz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:49:57 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-cj7ynp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:49:57 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-IJfcH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:49:57 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-PU9OgM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:49:57 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-fw9QlP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:49:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:49:58 INFO - Running setup.py install for manifestparser 06:49:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:49:58 INFO - Running setup.py install for mozcrash 06:49:58 INFO - Running setup.py install for mozdebug 06:49:58 INFO - Running setup.py install for mozdevice 06:49:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:49:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:49:58 INFO - Running setup.py install for mozfile 06:49:58 INFO - Running setup.py install for mozhttpd 06:49:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:49:58 INFO - Running setup.py install for mozinfo 06:49:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:49:59 INFO - Running setup.py install for mozInstall 06:49:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:49:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:49:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:49:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:49:59 INFO - Running setup.py install for mozleak 06:49:59 INFO - Running setup.py install for mozlog 06:49:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:49:59 INFO - Running setup.py install for moznetwork 06:49:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:49:59 INFO - Running setup.py install for mozprocess 06:49:59 INFO - Running setup.py install for mozprofile 06:50:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:50:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:50:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:50:00 INFO - Running setup.py install for mozrunner 06:50:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:50:00 INFO - Running setup.py install for mozscreenshot 06:50:00 INFO - Running setup.py install for moztest 06:50:00 INFO - Running setup.py install for mozversion 06:50:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:50:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:50:00 INFO - Cleaning up... 06:50:00 INFO - Return code: 0 06:50:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:50:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:50:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:00 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 0x10c166a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1fb618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87a154c930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0cad30>, '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 0x10be2fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c0c2b20>, '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.i6YuXT97wQ/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.61FBlQZIQM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/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 06:50:00 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 06:50:00 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 06:50:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.i6YuXT97wQ/Render', 06:50:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:50:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:50:00 INFO - 'HOME': '/Users/cltbld', 06:50:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:50:00 INFO - 'LOGNAME': 'cltbld', 06:50:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:00 INFO - 'MOZ_NO_REMOTE': '1', 06:50:00 INFO - 'NO_EM_RESTART': '1', 06:50:00 INFO - 'PAGER': '/bin/cat', 06:50:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:50:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:00 INFO - 'PWD': '/builds/slave/test', 06:50:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:50:00 INFO - 'SHELL': '/bin/bash', 06:50:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.61FBlQZIQM/Listeners', 06:50:00 INFO - 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', 06:50:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:50:00 INFO - 'USER': 'cltbld', 06:50:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:50:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:50:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:00 INFO - 'XPC_FLAGS': '0x0', 06:50:00 INFO - 'XPC_SERVICE_NAME': '0', 06:50:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:50:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:50:00 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-O13JXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:50:01 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)) 06:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:50:01 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-A3YLZm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:50:01 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)) 06:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:50:01 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-LzfeTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:50:01 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)) 06:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:50:01 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-aTGHIL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:50:01 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)) 06:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:50:01 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-j9GPeZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:50:01 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)) 06:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:50:01 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-ozO899-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:50:01 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)) 06:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:50:01 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-MOXqVO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:50:01 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)) 06:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:50:01 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-ebVnRP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:50:01 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)) 06:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:50:01 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-20XoY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:50:01 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)) 06:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:50:01 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-Az1ta5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:50:02 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)) 06:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:50:02 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-HdK6vE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:50:02 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)) 06:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:50:02 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-4MpkA2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:50:02 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)) 06:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:50:02 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-fOfYYY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:50:02 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)) 06:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:50:02 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-VAEXuC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:50:02 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)) 06:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:50:02 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-nZflx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:50:02 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)) 06:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:50:02 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-BKOG8i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:50:02 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)) 06:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:50:02 INFO - Running setup.py (path:/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/pip-MMJqIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:50:02 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)) 06:50:02 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)) 06:50:02 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)) 06:50:02 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)) 06:50:02 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)) 06:50:02 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)) 06:50:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:50:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:05 INFO - Downloading blessings-1.6.tar.gz 06:50:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:50:05 INFO - Installing collected packages: blessings 06:50:05 INFO - Running setup.py install for blessings 06:50:05 INFO - Successfully installed blessings 06:50:05 INFO - Cleaning up... 06:50:05 INFO - Return code: 0 06:50:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:50:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:50:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:50:05 INFO - Reading from file tmpfile_stdout 06:50:05 INFO - Current package versions: 06:50:05 INFO - blessings == 1.6 06:50:05 INFO - blobuploader == 1.2.4 06:50:05 INFO - docopt == 0.6.1 06:50:05 INFO - functools32 == 3.2.3-2 06:50:05 INFO - jsonschema == 2.5.1 06:50:05 INFO - manifestparser == 1.1 06:50:05 INFO - mozInstall == 1.12 06:50:05 INFO - mozcrash == 0.17 06:50:05 INFO - mozdebug == 0.1 06:50:05 INFO - mozdevice == 0.48 06:50:05 INFO - mozfile == 1.2 06:50:05 INFO - mozhttpd == 0.7 06:50:05 INFO - mozinfo == 0.9 06:50:05 INFO - mozleak == 0.1 06:50:05 INFO - mozlog == 3.3 06:50:05 INFO - moznetwork == 0.27 06:50:05 INFO - mozprocess == 0.23 06:50:05 INFO - mozprofile == 0.28 06:50:05 INFO - mozrunner == 6.12 06:50:05 INFO - mozscreenshot == 0.1 06:50:05 INFO - mozsystemmonitor == 0.3 06:50:05 INFO - moztest == 0.7 06:50:05 INFO - mozversion == 1.4 06:50:05 INFO - psutil == 3.1.1 06:50:05 INFO - requests == 1.2.3 06:50:05 INFO - wsgiref == 0.1.2 06:50:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:50:05 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')]} 06:50:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:05 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')]} 06:50:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:05 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 0x10c166a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1fb618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87a154c930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0cad30>, '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 0x10be2fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c0c2b20>, '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.i6YuXT97wQ/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.61FBlQZIQM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/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 06:50:05 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 06:50:05 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 06:50:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.i6YuXT97wQ/Render', 06:50:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:50:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:50:05 INFO - 'HOME': '/Users/cltbld', 06:50:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:50:05 INFO - 'LOGNAME': 'cltbld', 06:50:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:05 INFO - 'MOZ_NO_REMOTE': '1', 06:50:05 INFO - 'NO_EM_RESTART': '1', 06:50:05 INFO - 'PAGER': '/bin/cat', 06:50:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:50:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:05 INFO - 'PWD': '/builds/slave/test', 06:50:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:50:05 INFO - 'SHELL': '/bin/bash', 06:50:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.61FBlQZIQM/Listeners', 06:50:05 INFO - 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', 06:50:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:50:05 INFO - 'USER': 'cltbld', 06:50:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:50:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:50:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:05 INFO - 'XPC_FLAGS': '0x0', 06:50:05 INFO - 'XPC_SERVICE_NAME': '0', 06:50:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:50:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:06 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)) 06:50:06 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)) 06:50:06 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)) 06:50:06 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)) 06:50:06 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)) 06:50:06 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)) 06:50:06 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)) 06:50:06 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)) 06:50:06 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)) 06:50:06 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)) 06:50:06 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)) 06:50:06 INFO - Cleaning up... 06:50:06 INFO - Return code: 0 06:50:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:50:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:50:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:50:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c166a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1fb618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87a154c930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0cad30>, '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 0x10be2fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c0c2b20>, '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.i6YuXT97wQ/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.61FBlQZIQM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/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 06:50:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:50:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:50:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.i6YuXT97wQ/Render', 06:50:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:50:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:50:06 INFO - 'HOME': '/Users/cltbld', 06:50:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:50:06 INFO - 'LOGNAME': 'cltbld', 06:50:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:06 INFO - 'MOZ_NO_REMOTE': '1', 06:50:06 INFO - 'NO_EM_RESTART': '1', 06:50:06 INFO - 'PAGER': '/bin/cat', 06:50:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:50:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:06 INFO - 'PWD': '/builds/slave/test', 06:50:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:50:06 INFO - 'SHELL': '/bin/bash', 06:50:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.61FBlQZIQM/Listeners', 06:50:06 INFO - 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', 06:50:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:50:06 INFO - 'USER': 'cltbld', 06:50:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:50:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:50:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:06 INFO - 'XPC_FLAGS': '0x0', 06:50:06 INFO - 'XPC_SERVICE_NAME': '0', 06:50:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:50:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:50:06 INFO - Cleaning up... 06:50:06 INFO - Return code: 0 06:50:06 INFO - Running post-action listener: _resource_record_post_action 06:50:06 INFO - Running post-action listener: _start_resource_monitoring 06:50:06 INFO - Starting resource monitoring. 06:50:06 INFO - [mozharness: 2016-08-19 13:50:06.385954Z] Finished create-virtualenv step (success) 06:50:06 INFO - [mozharness: 2016-08-19 13:50:06.386982Z] Running install step. 06:50:06 INFO - Running pre-action listener: _resource_record_pre_action 06:50:06 INFO - Running main action method: install 06:50:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:50:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:50:06 INFO - Reading from file tmpfile_stdout 06:50:06 INFO - Detecting whether we're running mozinstall >=1.0... 06:50:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:50:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:50:06 INFO - Reading from file tmpfile_stdout 06:50:06 INFO - Output received: 06:50:06 INFO - Usage: mozinstall [options] installer 06:50:06 INFO - Options: 06:50:06 INFO - -h, --help show this help message and exit 06:50:06 INFO - -d DEST, --destination=DEST 06:50:06 INFO - Directory to install application into. [default: 06:50:06 INFO - "/builds/slave/test"] 06:50:06 INFO - --app=APP Application being installed. [default: firefox] 06:50:06 INFO - mkdir: /builds/slave/test/build/application 06:50:06 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'] 06:50:06 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 06:50:40 INFO - Reading from file tmpfile_stdout 06:50:40 INFO - Output received: 06:50:40 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:50:40 INFO - Running post-action listener: _resource_record_post_action 06:50:40 INFO - [mozharness: 2016-08-19 13:50:40.686678Z] Finished install step (success) 06:50:40 INFO - [mozharness: 2016-08-19 13:50:40.686824Z] Running run-tests step. 06:50:40 INFO - Running pre-action listener: _resource_record_pre_action 06:50:40 INFO - Running main action method: run_tests 06:50:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:50:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:50:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:50:40 INFO - 2016-08-19 06:50:40.701 screenresolution[1634:7504] starting screenresolution argv=screenresolution get 06:50:40 INFO - 2016-08-19 06:50:40.704 screenresolution[1634:7504] Display 0: 1600x1200x32@60 06:50:40 INFO - 2016-08-19 06:50:40.709 screenresolution[1635:7506] starting screenresolution argv=screenresolution list 06:50:40 INFO - Available Modes on Display 0 06:50:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:50:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:50:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:50:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:50:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:50:40 INFO - Intel Iris: 06:50:40 INFO - Chipset Model: Intel Iris 06:50:40 INFO - Type: GPU 06:50:40 INFO - Bus: Built-In 06:50:40 INFO - VRAM (Dynamic, Max): 1536 MB 06:50:40 INFO - Vendor: Intel (0x8086) 06:50:40 INFO - Device ID: 0x0a2e 06:50:40 INFO - Revision ID: 0x0009 06:50:40 INFO - Displays: 06:50:40 INFO - Display: 06:50:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:50:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:50:40 INFO - Display Serial Number: 1600x1200 60 06:50:40 INFO - Main Display: Yes 06:50:40 INFO - Mirror: Off 06:50:40 INFO - Online: Yes 06:50:40 INFO - Rotation: Supported 06:50:40 INFO - Return code: 0 06:50:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:50:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:50:40 INFO - Python 2.7.3 06:50:40 INFO - Return code: 0 06:50:40 INFO - grabbing minidump binary from tooltool 06:50: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')]} 06:50:40 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 0x10c0cad30>, '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 0x10be2fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c0c2b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:50:40 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 06:50:40 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 06:50:40 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 06:50:41 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:50:41 INFO - Return code: 0 06:50:41 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:50:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:50:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:50:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:50:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:50:41 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-e10s', '--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-0293', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 06:50:41 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-e10s --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-0293 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 06:50:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.i6YuXT97wQ/Render', 06:50:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:50:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:50:41 INFO - 'HOME': '/Users/cltbld', 06:50:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:50:41 INFO - 'LOGNAME': 'cltbld', 06:50:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:50:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:50:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:41 INFO - 'MOZ_NO_REMOTE': '1', 06:50:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:50:41 INFO - 'NO_EM_RESTART': '1', 06:50:41 INFO - 'PAGER': '/bin/cat', 06:50:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:50:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:41 INFO - 'PWD': '/builds/slave/test', 06:50:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:50:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:50:41 INFO - 'SHELL': '/bin/bash', 06:50:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.61FBlQZIQM/Listeners', 06:50:41 INFO - 'TMPDIR': '/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/', 06:50:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:50:41 INFO - 'USER': 'cltbld', 06:50:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:50:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:50:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:41 INFO - 'XPC_FLAGS': '0x0', 06:50:41 INFO - 'XPC_SERVICE_NAME': '0', 06:50:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:50:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--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-0293', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 06:50:41 INFO - mozversion application_buildid: 20160819034155 06:50:41 INFO - mozversion application_changeset: 7700ad7a72edf62983555b21a88879fa75dc4ec1 06:50:41 INFO - mozversion application_display_name: Nightly 06:50:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:50:41 INFO - mozversion application_name: Firefox 06:50:41 INFO - mozversion application_remotingname: firefox 06:50:41 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:50:41 INFO - mozversion application_vendor: Mozilla 06:50:41 INFO - mozversion application_version: 51.0a1 06:50:41 INFO - mozversion platform_buildid: 20160819034155 06:50:41 INFO - mozversion platform_changeset: 7700ad7a72edf62983555b21a88879fa75dc4ec1 06:50:41 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:50:41 INFO - mozversion platform_version: 51.0a1 06:50:41 INFO - using testdate: 1471614641 06:50:41 INFO - actual date: 1471614641 06:50:41 INFO - starting webserver on 'localhost:49267' 06:50:41 INFO - SUITE-START | Running 2 tests 06:50:41 INFO - TEST-START | dromaeo_css 06:50:41 INFO - operating with platform_type : mac_ 06:50:41 INFO - Initialising browser for dromaeo_css test... 06:50:41 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/tmpdfecJF/profile http://localhost:49267/getInfo.html) 06:50:44 INFO - PROCESS | 1645 | __metrics Screen width/height:1600/1200 06:50:44 INFO - PROCESS | 1645 | colorDepth:24 06:50:44 INFO - PROCESS | 1645 | Browser inner width/height: 1024/689 06:50:44 INFO - PROCESS | 1645 | __metrics 06:50:44 ERROR - PROCESS | 1645 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 06:50:44 INFO - TEST-INFO | 1645: exit 0 06:50:44 INFO - Browser initialized. 06:50:44 INFO - Running cycle 1/1 for dromaeo_css test... 06:50:44 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/tmpdfecJF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:50:56 INFO - PROCESS | 1648 | RSS: Main: 239210496 06:50:56 INFO - PROCESS | 1648 | 06:51:46 INFO - PROCESS | 1648 | 1471614706359 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] 06:53:58 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 06:53:59 INFO - PROCESS | 1648 | RSS: Main: 255397888 06:53:59 INFO - PROCESS | 1648 | 06:57:02 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 06:57:02 INFO - PROCESS | 1648 | RSS: Main: 266907648 06:57:02 INFO - PROCESS | 1648 | 07:00:04 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 07:00:05 INFO - PROCESS | 1648 | RSS: Main: 271093760 07:00:05 INFO - PROCESS | 1648 | 07:03:07 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 07:03:07 INFO - PROCESS | 1648 | RSS: Main: 271265792 07:03:07 INFO - PROCESS | 1648 | 07:06:10 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 07:06:11 INFO - PROCESS | 1648 | RSS: Main: 275902464 07:06:11 INFO - PROCESS | 1648 | 07:09:13 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 07:09:14 INFO - PROCESS | 1648 | RSS: Main: 278396928 07:09:14 INFO - PROCESS | 1648 | 07:09:14 INFO - PROCESS | 1648 | __start_tp_report 07:09:14 INFO - PROCESS | 1648 | _x_x_mozilla_page_load 07:09:14 INFO - PROCESS | 1648 | _x_x_mozilla_page_load_details 07:09:14 INFO - PROCESS | 1648 | |i|pagename|runs| 07:09:14 INFO - PROCESS | 1648 | |0;dojo.html;3424.948625770614;3427.2460058787074;3450.603180634226;3469.288795796862;3496.737744669149;4928.975355123228;5838.036723940555;5851.941480585193;5873.941260587399;5890.381509941459;5865.413458654143;5876.76492940283;5877.559183061266;5894.675792831393;5970.044792833148;5291.973540132303;5319.20211968204;5410.269613602152;5437.238786569884;5455.809046683366;5193.350831146106;5237.162054071349;5319.228711836781;5359.517643412092;5396.676199428047;5294.285271488338;5318.787248510093;5331.493508116722;5334.3598768147685;5373.516383525482;5316.3620365556;5333.626646134772;5335.626506144571;5339.279197308391;5375.731213439351;5147.613928955306;5211.7133557654315;5270.868228294285;5320.122179840322;5328.413874473805;5756.366799652035;5817;5859.003969325225;5891.617044892111;5950.345461999176;6157.107219453199;6226.968865155691;6233.657148856811;6249.156363890862;6250.562460627758;6130.601510901777;6153.077038444225;6213.599992008239;6262.937370626281;6270.843228919268;5929.258842644669;6021.668808215502;6033.728482218311;6044.788432404845;6080.14877917092;6332.620042797447;6354.555181137369;6368.808935731936;6379.808605741835;6459.934110871747;6113.083037544404;6137.285055221596;6234.812955611339;6238.937610623836;6294.8111556653375;6170.876582468415;6261.499080073583;6273.12176295319;6278.089676996809;6289.49684025286;6174.320824709278;6179.969100154471;6221.035739460391;6223.937760622426;6236.6258024518675;6101.913673707429;6129.389354848322;6169.96915015422;6242.063690446469;6250.124982502453;4384.693071484965;4406.471223453142;4460.643148548108;4960;4994.250862370601;3674.9816250918575;3842.9039274018373;4413.13943780966;4465.776711164429;4481.103779244164;5614.101743720985;5832.416758324219;5870.236869206976;5906.084556893688;5916.7041647918295;6155.415235552616;6229.065640154013;6243.937560624427;6252.9370007098905;6261.812145635638;5082.263071854561;5950.9107363389585;5974.61165024272;5981.491573216238;6006.039033754579;5442.2108794225405;5485.232067510552;5519.889602207933;5549.056660367666;5554.611177217636;5438.864028399322;6270.717817698214;6363.9045414318825;6377.01156320771;6399.904001439889;6228.314885362697;6233.002719565029;6249.9375006251175;6260.154879091265;6261.7182226799;6205.5345849060595;6247.937520624736;6364.6181229126405;6378.075179099097;6397.200349956255;6128.533679014772;6181;6226.159468471698;6228.065790131516;6228.719707613259;6241.095041219089;6255.499560035278;6256.249250090018;6258.280297765633;6259.123722678738;6023.156758053964;6118.131909153847;6118.938810612015;6122.357152498924;6234.1583886174785;6128.717018009172;6199.814005579839;6218.129461875432;6230.875382492234;6230.906536401867;5578.386377498553;6041.456268935817;6118.143459915526;6122.938770612237;6135.907961380493;6118.20463339763;6188.721507532082;6190.7523699051535;6226.719797609027;6235.688215589294;6105.186826067751;6105.611380716617;6114.932460008582;6132.6477122388715;6140.846478838065 07:09:14 INFO - PROCESS | 1648 | |1;ext.html;502.09372083389485;524.7454984332599;529.4573062610826;532.0688794609434;533.9679619222844;38183.80908095459;40672.59327406729;40822;40959.9760006;41118.99999999996;41755.37366939498;42141.73574792761;42333.57666423335;42336.57663423365;42439.78780106095;9664.27517936154;9826.459544725038;9854.556544955458;9861.260405469618;9872.308938374317;9784.55969481375;9912.306138570302;9914.504274786268;9921.3055086144;9924.553395097239;9935.801283974351;9953.651622193225;9972.252081093948;9977.600895964153;9993.300468967174;9887.209023278192;9894.30739848211;9915.157211637019;9925.90074099257;9989.950050249703;7939.5633240171765;9737.026297370277;9831.557579908922;9846.507674616241;10260.794784104351;40319.55685982384;40334.79832600847;40534;40559;40573.79713101416;3242.1793040055068;3291.210109573709;3349.916252093693;3368.646292139339;3471.2817155507933;23616.7638323618;26687.46625067488;28531.857340713163;29952.8502357489;32360.029199124063;3220.6457289698114;3229.9031029069165;3306.8591335989045;3356.077078803324;3443.5867695876655;449385;516400;520798.39600801753;523664;525208.3739581354;28315.71684283172;32342.35315293681;33181;34795.30409391798;62248.06627900585;34561.827190863885;34723.30553388918;34755.30489390198;35126.824365878005;35159.29681406358;14518.056326338965;14589.92705036468;14679.045862018935;14709.632259193391;14753.77869331961;12308.692282693004;12493.50025998968;12607.621771346874;12634.620961371174;12658.620241392773;7712.190220026929;7712.305892469704;7749.806254843674;7771.611419429006;7789.766307010798;3201.951970720441;3238.8704451822136;3240.3357311751033;3244.23760416302;3275.950860737091;910.2081189365294;921.7234829551242;934.7429456899271;1005.8591797148405;1012.7873146639141;24746;29497.410051799274;30761.69238307633;31317.68682313193;31411.842940785606;999.6101520407047;1029.6807989523122;1039.0181278691564;1064.5528877871313;1070.8500809886623;15151.090934543963;15541.378344866305;15710.978786379077;15764.054156750632;16138.435154769526;660755;665222.6738866274;666239;668589;668644;59169.11246331308;59432;59446.70276648589;59674.70162649159;59804.40195598076;1309.299524754252;1347.1176379471462;1380.875721185078;1388.409925781559;1388.6667199871958;28744.425111497236;29816.850915745283;29886.85056574703;30168.69831301659;30697.846510767304;40949.795251023555;50480;51000.74499627478;51222.48777512326;51427.48572514227;580508;581857;583105;583982;584702;26668.866655666596;26861.462770744867;26961.46077078408;27251;27334;47404.52595474001;49072;49372;49398;50405.49594504008;30568;39465;39482.921493561604;40877.79561102176;41063.17873642451;32692.83653581717;39284;39709;40829;40962;34907.65092349044;38776.2244755109;39127.82616521509;39361.2127757449;41176.58823411728;33615.66384336125;34389.484157737155;35228;35228.47157292591;35280.29439411146;23342.533149337258;25940.22179334623;26031.739682602933;26326.21021369362;26488.7351126494 07:09:14 INFO - PROCESS | 1648 | |2;jquery.html;360.9460375702947;362.7207050571059;369.8502106646808;378.3549048871674;388.31850103069144;19997;20285.492862678442;20293.898530507344;21103.050362733677;21304.786952130475;11874.703132421671;12062;17053.976761394326;20511.692324615142;21232.681509777365;5560.221568980346;5663.8584035399035;5731.054376027951;5734.971325143369;5748.338941021773;5437.564994800427;5538.446155384449;5553.972230138844;5598.748056337475;5613.101903695409;5600.635958662674;5609.775608975636;5613.522850557708;5623.718814059281;5701.34434540027;6032.487238584704;6120.877582448348;6221.96889015552;6229.3459186785185;6240.31356550779;5251.317328747276;5400.162974738922;5439.265699130646;5447.809326673548;5511.834644960658;25250.242492725247;25958;26054.86972565125;26188.86905565479;26189.345266368495;2121.95756084879;2289.2331069091874;2294.6443301288327;2479.5983987796412;2653.946921061568;10317.214352124884;12657.810132848015;12853.550125745554;15624.375024998986;16054.75917861233;1907.6852319367288;1923.7210604462275;1927.9518012049812;1968.6514737404923;1969.9015049247623;96575.51712241465;133606.3319683405;134111.65888341088;135434.3228283862;136393;11340.26288291275;11503.53985840557;11613.187076904704;11635.709107272216;11667.88332116685;14467.92766036163;14574.854251457562;14578.97947143711;14609.853901461061;14625.92687036558;8422.873656895152;8544.487330760174;8569.742907712654;8612.61243244043;8700.869486957701;7158.713651453883;8442.029166645914;8479.321654267644;8519.701810436605;8666.220040196413;4393.956060439355;4518.073794872043;4542.159700455426;4570.154521413483;4613.584777369986;1576.4718819195698;1634.730269505542;1660.7508873669046;1697.3804561335023;1971.6592716952323;790.5335105562151;812.4678335690132;839.3788596438714;914.2366124286162;930.6230976454547;20365.796342036687;20897.686534701992;20930;20944.37166884996;21283.78716212818;919.0189174673287;946.4463288975888;950.254050570299;952.4808979106404;1016.8068067067234;10325.451182322562;10780.460976951277;11075.335479871072;11121.05471034971;11216.270942388719;541798;549706;584644;609255;612611;109209.45395272973;109577.35633965497;121993;135549;139738;998.2612866478753;999.3753903809974;1037.258360272409;1039.740064983754;1043.6242952537082;16387.262573183998;18476.907615461838;18680.159392827085;19071;19273.807261927202;35857;49877.50122498729;53050;53694;55305.44694553003;80966.90330967092;82597.58701206456;82654.76017859616;82937;84477.57761211401;7768.805779855549;7887.487313324616;8173.386995975206;8192.221738934792;8213.301869340934;8882.15619516145;11420.543178272776;11549.191556590958;11562.826557601475;12151.939240303742;10766.246362754531;11073.667789966314;11095.611653592085;11268.04221641137;11472.827907581226;10660.8933910663;10681.839772403264;10781.892181078403;10830.18773591968;11414.029807466459;11016.724581885197;11094.89051094884;11313.660590182308;11460.255083419552;11461.48423320936;8059.516429014044;8254.463459875089;8259.339252859876;8434.70478533273;8446.704365347183;10594.864998181325;10756.838647420138;10911.018008378967;11208.159388045766;11338.319700817978 07:09:14 INFO - PROCESS | 1648 | |3;mootools.html;1277.591170825336;1509.0492989416666;1673.1717799689156;1823.2889173222454;1834.3304693786772;7857.567833769141;8412.158784121584;8533.658653653847;8930.464172149676;8967.41711788734;8557.443766155195;8669.046404895473;8750.168733970262;8779.253763430115;8782.780430489225;2349.89425475854;2368.0646144772804;2372.9169479068237;2377.8454400464;2378.95242095158;2327.418145463634;2347.295811256625;2370.8340416170877;2376.2277259890607;2393.401649587603;2179.8474106812528;2260.8921628402045;2362.527494501098;2365.7161140663056;2370.810335173182;2013.6878783788536;2335.0309621506967;2347.0494449747794;2361.480474295652;2365.4914193448403;2342.636891281854;2344.0623750499767;2350.9882450587806;2351.012574718622;2351.106579499779;7815.413843961725;7976.361891048702;8007.67969281228;8348.916510834875;8806.339524535686;4631.305304204397;4723.173444647173;5031.421386540522;5242.973785131088;5297.231901374279;3283.3433313337428;3363.2937083212555;3409.9147521312166;3608.873689420884;3612.945805812915;1057.82897441104;1086.9619563315325;1087.5704096881766;1109.7724966381872;1113.5712750591;11486.023687986532;11501.884981150166;11580.957713805714;11651.067914566815;11667.88332116685;4524.185646583581;4597.126545956257;4724.763761811896;4750.1474424974285;4768.380110585671;8865.069167737423;9073.500957447404;9971.202303815677;9986.60053597848;10001.899981000242;5267.868303292448;5288.391834938954;5290.100682883919;5290.947090529045;5318.44156363584;4330.307150855848;4657.767111644404;4791.47293797682;4792.7124372537755;4835.637327200474;3506.053365591276;3833.15670552478;3868.671162951124;3890.9610903891166;3972.225416043844;1110.816715241976;1296.1380681846467;1297.54585894936;1300.876416740408;1308.770965081107;832.7376876283951;926.2497377124416;930.8184903943801;930.9581068851918;965.2229954886244;5289.312389389432;5823.505002074871;6078.179445774764;6202.596831206048;6246.3441338659695;940.6801687426308;940.7507010642186;988.9950550247203;995.6714284286168;1027.8201314769885;3927.7250592458254;4032.5967403259438;4034.293998550242;4105.651019663303;4295.914081718348;10180.134688551409;10520.526576304084;10521.158307335394;10535.683929482127;10536.789264214825;9086.772830679154;10395.272330936914;10478.947605261925;10510;10565.947170264253;7864.056313242448;8039.196080392031;8098.230668086522;8162.469439486415;8260.297874680598;6039.275286965417;6052.213212282375;6067.817965461043;6119.4798442132915;6214.8135555933395;9804.215662747105;9909.157721593745;9975.501224938578;10019.298649094493;10080.294379393372;10029.097381235724;10181.236407269336;10257.948710256402;10262.384256944608;10317.86503484601;7438.9585458037;7618.923810762043;8228.547429891414;8286.792830179294;8400.915990840012;7446.14369347532;7713.421493387906;8342.374321926001;8504.872426913726;8596.226339629464;6762.087118238975;6923.9960205768875;7350.52221605594;7400.5189662671755;7467.850642987001;7001.36987671112;7178.784636460915;7276.927230727625;7342.339189472973;7342.449316301192;6912.377885990285;6947.687354068978;6996;7004.4396448283;7032;4466.084452687256;4905.803767849389;4948.554630083166;4987.2768448574025;5074.213496907985;4968.925466117938;5110.4123025852505;5137.794488220429;5151.484851514819;5215.504527069922 07:09:14 INFO - PROCESS | 1648 | |4;prototype.html;284.7024859022321;297.39776951672866;304.39121756487026;305.0695379093763;308.25556281579986;4525.298578720295;5090.440051594322;5575.69333686647;5626.352969408519;5667.206591077247;4890.73100979446;4972.502749725026;5462.399136095037;5560.86097847554;5596.748146333414;3597.4244120940652;4161.730672144995;4208.558101399355;4212.684048696345;4239.512456067561;3851.2490064437447;4146.834126634931;4236.4704411948505;4240.893977650552;4247;3851.0937086142258;3865.342891708416;4093.5292441369324;4143.689223308249;4147.937780933288;4105.856295029675;4113.835446582133;4127.711060225785;4147.6267135957905;4153.54311025787;3543.2382037861985;3557.2351944332095;3557.7331700122336;3565.180008598037;3576.3204991051616;4756.048790241965;5170.560502357304;5248.895022099575;5294.49702278283;5387.703676297802;4108.568600296986;4263.87208383749;4481.596656300949;4716.292556116576;4726.196546587088;4949.752512374367;5179.715115668637;5549.58485586177;5787.479126878601;5925.4370834770625;3799.9430008549894;3832;3908.687305015592;3911.5306163260307;3925.862594809168;4925.433575138869;6086.300075491331;6105.542084343692;6128.406614280319;6151.384861513813;3931.840107168392;3941.940870886939;3945.408188771707;3948.3485224937563;3966.960330396717;3844.884653460401;3960.980195099006;4008.599140086026;4022.9597704022585;4039.1315867088715;3846.8461261549783;4271;4374.737515749065;4647.814087436533;4727.338172655831;4525.619685995737;4840.878978025507;5713.885722285531;5877.764889404376;5888.735006924699;1123.1520202247414;1257.6352857671357;1343.43575698207;1350.3450826349213;1351.4796803230827;875.1554749666602;898.766320756608;903.421810041574;909.8908131024319;911.4394647291867;4594.931076033862;5358.223057656618;5384.353877534721;5397.514223719884;5411.377691565442;5210.7915683373;5530.810875661752;5935.347111817697;6002.729877155539;6029.909551356734;4622;5163.036692619955;5261.394939581921;5386.192071189353;5419.701916394557;2339.321596736961;2347.8378202789386;2619.5415802234534;2628.88170032349;2720.4765331414073;4430.446194225722;4805.903881922342;4927.093015121024;5182.186234817784;5192.610554208374;4662.463816661059;4816.397950256218;5054.115529782273;5124.5131712487255;5125.001873903733;4646.62826973848;4743.976280118577;5182.885679578833;5247.609383513296;5256.526912577886;4254.787260636894;4603.815847366068;5094.064255583003;5129.281271078438;5144.742762861767;4219.177260434309;4295.008291711248;4865.686264708438;4970.577500912318;5018.5232402921665;4457.50967393593;4960.8759781005765;5022.723750193774;5170.482951704799;5190;3128.89048883288;3453.2575496268423;3461.3942560051387;3475.6097560975813;3480.756347055682;4947.45577986414;5087.23691446286;5087.262346959744;5447.809326673548;6124.785632502841;5521.972390138024;5532.695701736443;5944.256967879015;5971.656377315069;5986.371430999857;5096.541311282002;5434.2120392542065;5961.493273071837;6011.218541589566;6020.8795824084145;4829.768409055669;5622.718864056699;5655.604107712421;5812.912806307824;5840;5297.337832770903;5697.344805347272;5705.686187259575;5999.040153575407;6029.969850150721;5279.39286982002;5500.642458240201;5851.64890106595;5864.179014937827;5891.911621325769 07:09:14 INFO - PROCESS | 1648 | |5;yui.html;634.2294112653126;634.3402861024534;638.894582393905;697.5814511293222;756.4591317208195;15510.844891551082;16392.75410868838;16416.753748693765;16433.26050327735;16483.84613077085;14772.335244913978;14948.775768363483;15410;16018.439354622591;16186;713.4577720932077;839.8404303182406;865.247234905633;865.5499140446964;866.9306455483578;661.8279247395687;752.8042708895672;828.4366630691128;857.9442336248155;863.9179277968583;898.3576742629019;899.9055099214586;903.7695387676166;904.2449554621899;909.6588779207797;844.9860167798666;896.9461832290084;897.5557099235888;903.2864037410438;904.4799240436776;613.714622700442;674.4671709349608;675.0987431778582;679.3987321220756;683.1767719897512;15335;15499.690006199813;15515.612109697235;15569;15597.376104955789;14081.929590351983;14269.857301426957;14374.281285935765;14501.854981450157;14731.631709207355;11029.393383363991;11936.761264774656;11949.342786146759;11984.760304793943;12270.38648067593;3474.5309383233193;3771.8114094295174;3852.5376954765607;3865.5361356637104;3878.592747761501;124754;128677.35661321634;128754;128927;129322.35338823246;10909.781804364027;11033.503492342863;11124.996251012182;11157.326401039747;11238.7190320241;22637.773622263565;22741.658875116886;22758.544829103324;22819.657705134436;22834.97242624086;7989.520628762293;8139.145389734111;8156.062052863878;8174.918250817415;8186.877196842052;4550.635949124062;4628.652851036186;4642.187617166982;4764.927891224447;4783.760811959388;3612.945805812915;3701;3732.2908647356917;3745.981270093687;3758.755680880734;654.3554598720257;667.279338314619;669.7957123077508;678.8879834827297;681.2336121862904;551.2943432406526;571.5570432914525;586.2876604925036;678.8268991407159;696.6621188723465;9001.504917229484;9264.887876837754;9315.115064068903;9370.29722770795;9556.808863822685;630.8990561510228;631.5105793010362;665.5656318917701;669.4309836638915;685.5167107189419;4578.771061446914;4592.6555508337005;4593;4606.677532572688;4676.672632915664;109832;115314;121430;125721;148779;72941.27058729451;98332.52501212487;109405.45297273462;109825;110113;109604.4519777396;111195;111614.99999999837;114345;114392;9694.382516720587;9788.46163460988;9930.307548281982;10015.499225038864;10030.799384012425;51804.740976294874;53384;54652.633684158216;62416.68791656195;63698.859574127535;76551;87463;90924.09075909156;92971;93089;13503.459861605426;13579.52471663487;13645;13727.519536816164;13815.717781322228;13559.186448813103;14025.929870350583;14911.179885106423;15078.623034424227;15224.162671053198;13903.791443128563;13948.372323245276;14003;14379.42482300738;14655.780163297346;13713;13832.37754301079;13864.445422183;13916.234607096707;13923.79114313266;13582.320883955565;13992.650183745081;14195.432182712575;14283.07160034636;14434.566962991126;11013.504392302526;11397.430128493708;11424.714382140513;11511.251768635011;11561.439205707122;9824.4105353679;11574.363410012531;11691.356975366436;11711.88288117108;11749.412529373327 07:09:14 INFO - PROCESS | 1648 | __end_tp_report 07:09:14 INFO - PROCESS | 1648 | __start_cc_report 07:09:14 INFO - PROCESS | 1648 | _x_x_mozilla_cycle_collect,410 07:09:14 INFO - PROCESS | 1648 | __end_cc_report 07:09:14 INFO - PROCESS | 1648 | __startTimestamp1471615754124__endTimestamp 07:09:14 INFO - PROCESS | 1648 | 07:09:14 INFO - PROCESS | 1648 | ------- Summary: start ------- 07:09:14 INFO - PROCESS | 1648 | Number of tests: 6 07:09:14 INFO - PROCESS | 1648 | 07:09:14 INFO - PROCESS | 1648 | [#0] dojo.html Cycles:165 Average:5793.17 Median:6113.08 stddev:666.93 (10.9%) stddev-sans-first:642.58 07:09:14 INFO - PROCESS | 1648 | Values: 3424.9 3427.2 3450.6 3469.3 3496.7 4929.0 5838.0 5851.9 5873.9 5890.4 5865.4 5876.8 5877.6 5894.7 5970.0 5292.0 5319.2 5410.3 5437.2 5455.8 5193.4 5237.2 5319.2 5359.5 5396.7 5294.3 5318.8 5331.5 5334.4 5373.5 5316.4 5333.6 5335.6 5339.3 5375.7 5147.6 5211.7 5270.9 5320.1 5328.4 5756.4 5817.0 5859.0 5891.6 5950.3 6157.1 6227.0 6233.7 6249.2 6250.6 6130.6 6153.1 6213.6 6262.9 6270.8 5929.3 6021.7 6033.7 6044.8 6080.1 6332.6 6354.6 6368.8 6379.8 6459.9 6113.1 6137.3 6234.8 6238.9 6294.8 6170.9 6261.5 6273.1 6278.1 6289.5 6174.3 6180.0 6221.0 6223.9 6236.6 6101.9 6129.4 6170.0 6242.1 6250.1 4384.7 4406.5 4460.6 4960.0 4994.3 3675.0 3842.9 4413.1 4465.8 4481.1 5614.1 5832.4 5870.2 5906.1 5916.7 6155.4 6229.1 6243.9 6252.9 6261.8 5082.3 5950.9 5974.6 5981.5 6006.0 5442.2 5485.2 5519.9 5549.1 5554.6 5438.9 6270.7 6363.9 6377.0 6399.9 6228.3 6233.0 6249.9 6260.2 6261.7 6205.5 6247.9 6364.6 6378.1 6397.2 6128.5 6181.0 6226.2 6228.1 6228.7 6241.1 6255.5 6256.2 6258.3 6259.1 6023.2 6118.1 6118.9 6122.4 6234.2 6128.7 6199.8 6218.1 6230.9 6230.9 5578.4 6041.5 6118.1 6122.9 6135.9 6118.2 6188.7 6190.8 6226.7 6235.7 6105.2 6105.6 6114.9 6132.6 6140.8 07:09:14 INFO - PROCESS | 1648 | 07:09:14 INFO - PROCESS | 1648 | [#1] ext.html Cycles:180 Average:69825.23 Median:39595.96 stddev:157908.61 (398.8%) stddev-sans-first:158265.81 07:09:14 INFO - PROCESS | 1648 | Values: 502.1 524.7 529.5 532.1 534.0 38183.8 40672.6 40822.0 40960.0 41119.0 41755.4 42141.7 42333.6 42336.6 42439.8 9664.3 9826.5 9854.6 9861.3 9872.3 9784.6 9912.3 9914.5 9921.3 9924.6 9935.8 9953.7 9972.3 9977.6 9993.3 9887.2 9894.3 9915.2 9925.9 9990.0 7939.6 9737.0 9831.6 9846.5 10260.8 40319.6 40334.8 40534.0 40559.0 40573.8 3242.2 3291.2 3349.9 3368.6 3471.3 23616.8 26687.5 28531.9 29952.9 32360.0 3220.6 3229.9 3306.9 3356.1 3443.6 449385.0 516400.0 520798.4 523664.0 525208.4 28315.7 32342.4 33181.0 34795.3 62248.1 34561.8 34723.3 34755.3 35126.8 35159.3 14518.1 14589.9 14679.0 14709.6 14753.8 12308.7 12493.5 12607.6 12634.6 12658.6 7712.2 7712.3 7749.8 7771.6 7789.8 3202.0 3238.9 3240.3 3244.2 3276.0 910.2 921.7 934.7 1005.9 1012.8 24746.0 29497.4 30761.7 31317.7 31411.8 999.6 1029.7 1039.0 1064.6 1070.9 15151.1 15541.4 15711.0 15764.1 16138.4 660755.0 665222.7 666239.0 668589.0 668644.0 59169.1 59432.0 59446.7 59674.7 59804.4 1309.3 1347.1 1380.9 1388.4 1388.7 28744.4 29816.9 29886.9 30168.7 30697.8 40949.8 50480.0 51000.7 51222.5 51427.5 580508.0 581857.0 583105.0 583982.0 584702.0 26668.9 26861.5 26961.5 27251.0 27334.0 47404.5 49072.0 49372.0 49398.0 50405.5 30568.0 39465.0 39482.9 40877.8 41063.2 32692.8 39284.0 39709.0 40829.0 40962.0 34907.7 38776.2 39127.8 39361.2 41176.6 33615.7 34389.5 35228.0 35228.5 35280.3 23342.5 25940.2 26031.7 26326.2 26488.7 07:09:14 INFO - PROCESS | 1648 | 07:09:14 INFO - PROCESS | 1648 | [#2] jquery.html Cycles:180 Average:34608.34 Median:13864.92 stddev:97267.31 (701.5%) stddev-sans-first:97506.18 07:09:14 INFO - PROCESS | 1648 | Values: 360.9 362.7 369.9 378.4 388.3 19997.0 20285.5 20293.9 21103.1 21304.8 11874.7 12062.0 17054.0 20511.7 21232.7 5560.2 5663.9 5731.1 5735.0 5748.3 5437.6 5538.4 5554.0 5598.7 5613.1 5600.6 5609.8 5613.5 5623.7 5701.3 6032.5 6120.9 6222.0 6229.3 6240.3 5251.3 5400.2 5439.3 5447.8 5511.8 25250.2 25958.0 26054.9 26188.9 26189.3 2122.0 2289.2 2294.6 2479.6 2653.9 10317.2 12657.8 12853.6 15624.4 16054.8 1907.7 1923.7 1928.0 1968.7 1969.9 96575.5 133606.3 134111.7 135434.3 136393.0 11340.3 11503.5 11613.2 11635.7 11667.9 14467.9 14574.9 14579.0 14609.9 14625.9 8422.9 8544.5 8569.7 8612.6 8700.9 7158.7 8442.0 8479.3 8519.7 8666.2 4394.0 4518.1 4542.2 4570.2 4613.6 1576.5 1634.7 1660.8 1697.4 1971.7 790.5 812.5 839.4 914.2 930.6 20365.8 20897.7 20930.0 20944.4 21283.8 919.0 946.4 950.3 952.5 1016.8 10325.5 10780.5 11075.3 11121.1 11216.3 541798.0 549706.0 584644.0 609255.0 612611.0 109209.5 109577.4 121993.0 135549.0 139738.0 998.3 999.4 1037.3 1039.7 1043.6 16387.3 18476.9 18680.2 19071.0 19273.8 35857.0 49877.5 53050.0 53694.0 55305.4 80966.9 82597.6 82654.8 82937.0 84477.6 7768.8 7887.5 8173.4 8192.2 8213.3 8882.2 11420.5 11549.2 11562.8 12151.9 10766.2 11073.7 11095.6 11268.0 11472.8 10660.9 10681.8 10781.9 10830.2 11414.0 11016.7 11094.9 11313.7 11460.3 11461.5 8059.5 8254.5 8259.3 8434.7 8446.7 10594.9 10756.8 10911.0 11208.2 11338.3 07:09:14 INFO - PROCESS | 1648 | 07:09:14 INFO - PROCESS | 1648 | [#3] mootools.html Cycles:180 Average:5654.57 Median:4870.72 stddev:3142.93 (64.5%) stddev-sans-first:3134.53 07:09:14 INFO - PROCESS | 1648 | Values: 1277.6 1509.0 1673.2 1823.3 1834.3 7857.6 8412.2 8533.7 8930.5 8967.4 8557.4 8669.0 8750.2 8779.3 8782.8 2349.9 2368.1 2372.9 2377.8 2379.0 2327.4 2347.3 2370.8 2376.2 2393.4 2179.8 2260.9 2362.5 2365.7 2370.8 2013.7 2335.0 2347.0 2361.5 2365.5 2342.6 2344.1 2351.0 2351.0 2351.1 7815.4 7976.4 8007.7 8348.9 8806.3 4631.3 4723.2 5031.4 5243.0 5297.2 3283.3 3363.3 3409.9 3608.9 3612.9 1057.8 1087.0 1087.6 1109.8 1113.6 11486.0 11501.9 11581.0 11651.1 11667.9 4524.2 4597.1 4724.8 4750.1 4768.4 8865.1 9073.5 9971.2 9986.6 10001.9 5267.9 5288.4 5290.1 5290.9 5318.4 4330.3 4657.8 4791.5 4792.7 4835.6 3506.1 3833.2 3868.7 3891.0 3972.2 1110.8 1296.1 1297.5 1300.9 1308.8 832.7 926.2 930.8 931.0 965.2 5289.3 5823.5 6078.2 6202.6 6246.3 940.7 940.8 989.0 995.7 1027.8 3927.7 4032.6 4034.3 4105.7 4295.9 10180.1 10520.5 10521.2 10535.7 10536.8 9086.8 10395.3 10478.9 10510.0 10565.9 7864.1 8039.2 8098.2 8162.5 8260.3 6039.3 6052.2 6067.8 6119.5 6214.8 9804.2 9909.2 9975.5 10019.3 10080.3 10029.1 10181.2 10257.9 10262.4 10317.9 7439.0 7618.9 8228.5 8286.8 8400.9 7446.1 7713.4 8342.4 8504.9 8596.2 6762.1 6924.0 7350.5 7400.5 7467.9 7001.4 7178.8 7276.9 7342.3 7342.4 6912.4 6947.7 6996.0 7004.4 7032.0 4466.1 4905.8 4948.6 4987.3 5074.2 4968.9 5110.4 5137.8 5151.5 5215.5 07:09:14 INFO - PROCESS | 1648 | 07:09:14 INFO - PROCESS | 1648 | [#4] prototype.html Cycles:180 Average:4466.37 Median:4926.26 stddev:1378.37 (28.0%) stddev-sans-first:1346.03 07:09:14 INFO - PROCESS | 1648 | Values: 284.7 297.4 304.4 305.1 308.3 4525.3 5090.4 5575.7 5626.4 5667.2 4890.7 4972.5 5462.4 5560.9 5596.7 3597.4 4161.7 4208.6 4212.7 4239.5 3851.2 4146.8 4236.5 4240.9 4247.0 3851.1 3865.3 4093.5 4143.7 4147.9 4105.9 4113.8 4127.7 4147.6 4153.5 3543.2 3557.2 3557.7 3565.2 3576.3 4756.0 5170.6 5248.9 5294.5 5387.7 4108.6 4263.9 4481.6 4716.3 4726.2 4949.8 5179.7 5549.6 5787.5 5925.4 3799.9 3832.0 3908.7 3911.5 3925.9 4925.4 6086.3 6105.5 6128.4 6151.4 3931.8 3941.9 3945.4 3948.3 3967.0 3844.9 3961.0 4008.6 4023.0 4039.1 3846.8 4271.0 4374.7 4647.8 4727.3 4525.6 4840.9 5713.9 5877.8 5888.7 1123.2 1257.6 1343.4 1350.3 1351.5 875.2 898.8 903.4 909.9 911.4 4594.9 5358.2 5384.4 5397.5 5411.4 5210.8 5530.8 5935.3 6002.7 6029.9 4622.0 5163.0 5261.4 5386.2 5419.7 2339.3 2347.8 2619.5 2628.9 2720.5 4430.4 4805.9 4927.1 5182.2 5192.6 4662.5 4816.4 5054.1 5124.5 5125.0 4646.6 4744.0 5182.9 5247.6 5256.5 4254.8 4603.8 5094.1 5129.3 5144.7 4219.2 4295.0 4865.7 4970.6 5018.5 4457.5 4960.9 5022.7 5170.5 5190.0 3128.9 3453.3 3461.4 3475.6 3480.8 4947.5 5087.2 5087.3 5447.8 6124.8 5522.0 5532.7 5944.3 5971.7 5986.4 5096.5 5434.2 5961.5 6011.2 6020.9 4829.8 5622.7 5655.6 5812.9 5840.0 5297.3 5697.3 5705.7 5999.0 6030.0 5279.4 5500.6 5851.6 5864.2 5891.9 07:09:14 INFO - PROCESS | 1648 | 07:09:14 INFO - PROCESS | 1648 | [#5] yui.html Cycles:180 Average:23921.01 Median:3656.97 stddev:36870.15 (1008.2%) stddev-sans-first:36932.12 07:09:14 INFO - PROCESS | 1648 | Values: 634.2 634.3 638.9 697.6 756.5 15510.8 16392.8 16416.8 16433.3 16483.8 14772.3 14948.8 15410.0 16018.4 16186.0 713.5 839.8 865.2 865.5 866.9 661.8 752.8 828.4 857.9 863.9 898.4 899.9 903.8 904.2 909.7 845.0 896.9 897.6 903.3 904.5 613.7 674.5 675.1 679.4 683.2 15335.0 15499.7 15515.6 15569.0 15597.4 14081.9 14269.9 14374.3 14501.9 14731.6 11029.4 11936.8 11949.3 11984.8 12270.4 3474.5 3771.8 3852.5 3865.5 3878.6 124754.0 128677.4 128754.0 128927.0 129322.4 10909.8 11033.5 11125.0 11157.3 11238.7 22637.8 22741.7 22758.5 22819.7 22835.0 7989.5 8139.1 8156.1 8174.9 8186.9 4550.6 4628.7 4642.2 4764.9 4783.8 3612.9 3701.0 3732.3 3746.0 3758.8 654.4 667.3 669.8 678.9 681.2 551.3 571.6 586.3 678.8 696.7 9001.5 9264.9 9315.1 9370.3 9556.8 630.9 631.5 665.6 669.4 685.5 4578.8 4592.7 4593.0 4606.7 4676.7 109832.0 115314.0 121430.0 125721.0 148779.0 72941.3 98332.5 109405.5 109825.0 110113.0 109604.5 111195.0 111615.0 114345.0 114392.0 9694.4 9788.5 9930.3 10015.5 10030.8 51804.7 53384.0 54652.6 62416.7 63698.9 76551.0 87463.0 90924.1 92971.0 93089.0 13503.5 13579.5 13645.0 13727.5 13815.7 13559.2 14025.9 14911.2 15078.6 15224.2 13903.8 13948.4 14003.0 14379.4 14655.8 13713.0 13832.4 13864.4 13916.2 13923.8 13582.3 13992.7 14195.4 14283.1 14434.6 11013.5 11397.4 11424.7 11511.3 11561.4 9824.4 11574.4 11691.4 11711.9 11749.4 07:09:14 INFO - PROCESS | 1648 | -------- Summary: end -------- 07:09:14 INFO - PROCESS | 1648 | 07:09:14 INFO - TEST-INFO | 1648: exit 0 07:09:14 INFO - TEST-OK | dromaeo_css | took 1113453ms 07:09:14 INFO - TEST-START | kraken 07:09:14 INFO - operating with platform_type : mac_ 07:09:14 INFO - Initialising browser for kraken test... 07:09:14 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/tmpkgAyxW/profile http://localhost:49267/getInfo.html) 07:09:17 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 07:09:17 INFO - PROCESS | 1660 | colorDepth:24 07:09:17 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 07:09:17 INFO - PROCESS | 1660 | __metrics 07:09:17 ERROR - PROCESS | 1660 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 07:09:18 INFO - TEST-INFO | 1660: exit 0 07:09:18 INFO - Browser initialized. 07:09:18 INFO - Running cycle 1/1 for kraken test... 07:09:18 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/T/tmpkgAyxW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:09:30 INFO - PROCESS | 1662 | RSS: Main: 239349760 07:09:30 INFO - PROCESS | 1662 | 07:09:33 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection) 07:09:34 INFO - PROCESS | 1662 | RSS: Main: 252039168 07:09:34 INFO - PROCESS | 1662 | 07:09:36 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft) 07:09:37 INFO - PROCESS | 1662 | RSS: Main: 260714496 07:09:37 INFO - PROCESS | 1662 | 07:09:41 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft) 07:09:41 INFO - PROCESS | 1662 | RSS: Main: 263688192 07:09:41 INFO - PROCESS | 1662 | 07:09:43 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator) 07:09:44 INFO - PROCESS | 1662 | RSS: Main: 266051584 07:09:44 INFO - PROCESS | 1662 | 07:09:46 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:09:47 INFO - PROCESS | 1662 | RSS: Main: 266375168 07:09:47 INFO - PROCESS | 1662 | 07:09:49 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom) 07:09:50 INFO - PROCESS | 1662 | RSS: Main: 266596352 07:09:50 INFO - PROCESS | 1662 | 07:09:53 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate) 07:09:54 INFO - PROCESS | 1662 | RSS: Main: 266788864 07:09:54 INFO - PROCESS | 1662 | 07:09:56 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial) 07:09:57 INFO - PROCESS | 1662 | RSS: Main: 267223040 07:09:57 INFO - PROCESS | 1662 | 07:09:59 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:09:59 INFO - PROCESS | 1662 | RSS: Main: 267042816 07:09:59 INFO - PROCESS | 1662 | 07:10:01 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:10:02 INFO - PROCESS | 1662 | RSS: Main: 267370496 07:10:02 INFO - PROCESS | 1662 | 07:10:04 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:10:05 INFO - PROCESS | 1662 | RSS: Main: 266883072 07:10:05 INFO - PROCESS | 1662 | 07:10:08 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:10:09 INFO - PROCESS | 1662 | RSS: Main: 267124736 07:10:09 INFO - PROCESS | 1662 | 07:10:12 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:10:12 INFO - PROCESS | 1662 | RSS: Main: 267128832 07:10:12 INFO - PROCESS | 1662 | 07:10:14 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar) 07:10:14 INFO - PROCESS | 1662 | RSS: Main: 267939840 07:10:14 INFO - PROCESS | 1662 | 07:10:14 INFO - PROCESS | 1662 | __start_tp_report 07:10:14 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 07:10:14 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 07:10:14 INFO - PROCESS | 1662 | |i|pagename|runs| 07:10:14 INFO - PROCESS | 1662 | |0;ai-astar;105;120;112;115;118;129;171;118;117;119 07:10:14 INFO - PROCESS | 1662 | |1;audio-beat-detection;139;113;131;185;135;136;130;97;186;101 07:10:14 INFO - PROCESS | 1662 | |2;audio-dft;202;232;258;226;177;255;273;217;196;195 07:10:14 INFO - PROCESS | 1662 | |3;audio-fft;71;82;75;146;58;60;58;60;143;61 07:10:14 INFO - PROCESS | 1662 | |4;audio-oscillator;71;74;128;72;72;76;115;90;102;139 07:10:14 INFO - PROCESS | 1662 | |5;imaging-gaussian-blur;90;96;89;87;90;86;89;94;92;86 07:10:14 INFO - PROCESS | 1662 | |6;imaging-darkroom;96;96;107;97;114;146;107;99;96;104 07:10:14 INFO - PROCESS | 1662 | |7;imaging-desaturate;106;146;90;91;92;92;94;93;100;89 07:10:14 INFO - PROCESS | 1662 | |8;json-parse-financial;51;55;52;56;61;77;74;78;78;83 07:10:14 INFO - PROCESS | 1662 | |9;json-stringify-tinderbox;63;69;66;66;105;108;76;64;80;63 07:10:14 INFO - PROCESS | 1662 | |10;stanford-crypto-aes;87;105;108;88;84;87;80;101;105;100 07:10:14 INFO - PROCESS | 1662 | |11;stanford-crypto-ccm;151;164;153;137;141;152;145;156;198;166 07:10:14 INFO - PROCESS | 1662 | |12;stanford-crypto-pbkdf2;173;173;168;168;169;171;170;189;227;163 07:10:14 INFO - PROCESS | 1662 | |13;stanford-crypto-sha256-iterative;69;70;69;67;70;66;69;67;69;71 07:10:14 INFO - PROCESS | 1662 | __end_tp_report 07:10:14 INFO - PROCESS | 1662 | __start_cc_report 07:10:14 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,1046 07:10:14 INFO - PROCESS | 1662 | __end_cc_report 07:10:14 INFO - PROCESS | 1662 | __startTimestamp1471615814747__endTimestamp 07:10:14 INFO - PROCESS | 1662 | 07:10:14 INFO - PROCESS | 1662 | ------- Summary: start ------- 07:10:14 INFO - PROCESS | 1662 | Number of tests: 14 07:10:14 INFO - PROCESS | 1662 | 07:10:14 INFO - PROCESS | 1662 | [#0] ai-astar Cycles:10 Average:122.40 Median:118.50 stddev:18.12 (15.3%) stddev-sans-first:18.10 07:10:14 INFO - PROCESS | 1662 | Values: 105.0 120.0 112.0 115.0 118.0 129.0 171.0 118.0 117.0 119.0 07:10:14 INFO - PROCESS | 1662 | 07:10:14 INFO - PROCESS | 1662 | [#1] audio-beat-detection Cycles:10 Average:135.30 Median:137.50 stddev:30.26 (22.0%) stddev-sans-first:32.07 07:10:14 INFO - PROCESS | 1662 | Values: 139.0 113.0 131.0 185.0 135.0 136.0 130.0 97.0 186.0 101.0 07:10:14 INFO - PROCESS | 1662 | 07:10:14 INFO - PROCESS | 1662 | [#2] audio-dft Cycles:10 Average:223.10 Median:229.00 stddev:31.53 (13.8%) stddev-sans-first:32.50 07:10:14 INFO - PROCESS | 1662 | Values: 202.0 232.0 258.0 226.0 177.0 255.0 273.0 217.0 196.0 195.0 07:10:14 INFO - PROCESS | 1662 | 07:10:14 INFO - PROCESS | 1662 | [#3] audio-fft Cycles:10 Average:81.40 Median:60.50 stddev:34.23 (56.6%) stddev-sans-first:36.10 07:10:14 INFO - PROCESS | 1662 | Values: 71.0 82.0 75.0 146.0 58.0 60.0 58.0 60.0 143.0 61.0 07:10:14 INFO - PROCESS | 1662 | 07:10:14 INFO - PROCESS | 1662 | [#4] audio-oscillator Cycles:10 Average:93.90 Median:72.00 stddev:25.65 (35.6%) stddev-sans-first:25.84 07:10:14 INFO - PROCESS | 1662 | Values: 71.0 74.0 128.0 72.0 72.0 76.0 115.0 90.0 102.0 139.0 07:10:14 INFO - PROCESS | 1662 | 07:10:14 INFO - PROCESS | 1662 | [#5] imaging-gaussian-blur Cycles:10 Average:89.90 Median:90.00 stddev:3.31 (3.7%) stddev-sans-first:3.52 07:10:14 INFO - PROCESS | 1662 | Values: 90.0 96.0 89.0 87.0 90.0 86.0 89.0 94.0 92.0 86.0 07:10:14 INFO - PROCESS | 1662 | 07:10:14 INFO - PROCESS | 1662 | [#6] imaging-darkroom Cycles:10 Average:106.20 Median:96.00 stddev:15.27 (15.9%) stddev-sans-first:15.75 07:10:14 INFO - PROCESS | 1662 | Values: 96.0 96.0 107.0 97.0 114.0 146.0 107.0 99.0 96.0 104.0 07:10:14 INFO - PROCESS | 1662 | 07:10:14 INFO - PROCESS | 1662 | [#7] imaging-desaturate Cycles:10 Average:99.30 Median:91.50 stddev:17.20 (18.8%) stddev-sans-first:18.07 07:10:14 INFO - PROCESS | 1662 | Values: 106.0 146.0 90.0 91.0 92.0 92.0 94.0 93.0 100.0 89.0 07:10:14 INFO - PROCESS | 1662 | 07:10:14 INFO - PROCESS | 1662 | [#8] json-parse-financial Cycles:10 Average:66.50 Median:75.50 stddev:12.59 (16.7%) stddev-sans-first:12.04 07:10:14 INFO - PROCESS | 1662 | Values: 51.0 55.0 52.0 56.0 61.0 77.0 74.0 78.0 78.0 83.0 07:10:14 INFO - PROCESS | 1662 | 07:10:14 INFO - PROCESS | 1662 | [#9] json-stringify-tinderbox Cycles:10 Average:76.00 Median:66.00 stddev:17.04 (25.8%) stddev-sans-first:17.41 07:10:14 INFO - PROCESS | 1662 | Values: 63.0 69.0 66.0 66.0 105.0 108.0 76.0 64.0 80.0 63.0 07:10:14 INFO - PROCESS | 1662 | 07:10:14 INFO - PROCESS | 1662 | [#10] stanford-crypto-aes Cycles:10 Average:94.50 Median:82.00 stddev:10.28 (12.5%) stddev-sans-first:10.54 07:10:14 INFO - PROCESS | 1662 | Values: 87.0 105.0 108.0 88.0 84.0 87.0 80.0 101.0 105.0 100.0 07:10:14 INFO - PROCESS | 1662 | 07:10:14 INFO - PROCESS | 1662 | [#11] stanford-crypto-ccm Cycles:10 Average:156.30 Median:154.50 stddev:17.27 (11.2%) stddev-sans-first:18.21 07:10:14 INFO - PROCESS | 1662 | Values: 151.0 164.0 153.0 137.0 141.0 152.0 145.0 156.0 198.0 166.0 07:10:14 INFO - PROCESS | 1662 | 07:10:14 INFO - PROCESS | 1662 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.10 Median:172.00 stddev:18.81 (10.9%) stddev-sans-first:19.89 07:10:14 INFO - PROCESS | 1662 | Values: 173.0 173.0 168.0 168.0 169.0 171.0 170.0 189.0 227.0 163.0 07:10:14 INFO - PROCESS | 1662 | 07:10:14 INFO - PROCESS | 1662 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:1.57 (2.3%) stddev-sans-first:1.66 07:10:14 INFO - PROCESS | 1662 | Values: 69.0 70.0 69.0 67.0 70.0 66.0 69.0 67.0 69.0 71.0 07:10:14 INFO - PROCESS | 1662 | -------- Summary: end -------- 07:10:14 INFO - PROCESS | 1662 | 07:10:15 INFO - TEST-INFO | 1662: exit 0 07:10:15 INFO - TEST-OK | kraken | took 60790ms 07:10:15 INFO - SUITE-END | took 1174s 07:10:15 INFO - Completed test suite (00:19:34) 07:10:15 INFO - javascript benchmark 07:10:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7258.270595823131, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3424.948625770614, 3427.2460058787074, 3450.603180634226, 3469.288795796862, 3496.737744669149, 4928.975355123228, 5838.036723940555, 5851.941480585193, 5873.941260587399, 5890.381509941459, 5865.413458654143, 5876.76492940283, 5877.559183061266, 5894.675792831393, 5970.044792833148, 5291.973540132303, 5319.20211968204, 5410.269613602152, 5437.238786569884, 5455.809046683366, 5193.350831146106, 5237.162054071349, 5319.228711836781, 5359.517643412092, 5396.676199428047, 5294.285271488338, 5318.787248510093, 5331.493508116722, 5334.3598768147685, 5373.516383525482, 5316.3620365556, 5333.626646134772, 5335.626506144571, 5339.279197308391, 5375.731213439351, 5147.613928955306, 5211.7133557654315, 5270.868228294285, 5320.122179840322, 5328.413874473805, 5756.366799652035, 5817.0, 5859.003969325225, 5891.617044892111, 5950.345461999176, 6157.107219453199, 6226.968865155691, 6233.657148856811, 6249.156363890862, 6250.562460627758, 6130.601510901777, 6153.077038444225, 6213.599992008239, 6262.937370626281, 6270.843228919268, 5929.258842644669, 6021.668808215502, 6033.728482218311, 6044.788432404845, 6080.14877917092, 6332.620042797447, 6354.555181137369, 6368.808935731936, 6379.808605741835, 6459.934110871747, 6113.083037544404, 6137.285055221596, 6234.812955611339, 6238.937610623836, 6294.8111556653375, 6170.876582468415, 6261.499080073583, 6273.12176295319, 6278.089676996809, 6289.49684025286, 6174.320824709278, 6179.969100154471, 6221.035739460391, 6223.937760622426, 6236.6258024518675, 6101.913673707429, 6129.389354848322, 6169.96915015422, 6242.063690446469, 6250.124982502453, 4384.693071484965, 4406.471223453142, 4460.643148548108, 4960.0, 4994.250862370601, 3674.9816250918575, 3842.9039274018373, 4413.13943780966, 4465.776711164429, 4481.103779244164, 5614.101743720985, 5832.416758324219, 5870.236869206976, 5906.084556893688, 5916.7041647918295, 6155.415235552616, 6229.065640154013, 6243.937560624427, 6252.9370007098905, 6261.812145635638, 5082.263071854561, 5950.9107363389585, 5974.61165024272, 5981.491573216238, 6006.039033754579, 5442.2108794225405, 5485.232067510552, 5519.889602207933, 5549.056660367666, 5554.611177217636, 5438.864028399322, 6270.717817698214, 6363.9045414318825, 6377.01156320771, 6399.904001439889, 6228.314885362697, 6233.002719565029, 6249.9375006251175, 6260.154879091265, 6261.7182226799, 6205.5345849060595, 6247.937520624736, 6364.6181229126405, 6378.075179099097, 6397.200349956255, 6128.533679014772, 6181.0, 6226.159468471698, 6228.065790131516, 6228.719707613259, 6241.095041219089, 6255.499560035278, 6256.249250090018, 6258.280297765633, 6259.123722678738, 6023.156758053964, 6118.131909153847, 6118.938810612015, 6122.357152498924, 6234.1583886174785, 6128.717018009172, 6199.814005579839, 6218.129461875432, 6230.875382492234, 6230.906536401867, 5578.386377498553, 6041.456268935817, 6118.143459915526, 6122.938770612237, 6135.907961380493, 6118.20463339763, 6188.721507532082, 6190.7523699051535, 6226.719797609027, 6235.688215589294, 6105.186826067751, 6105.611380716617, 6114.932460008582, 6132.6477122388715, 6140.846478838065], "value": 5749.528190178851, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [502.09372083389485, 524.7454984332599, 529.4573062610826, 532.0688794609434, 533.9679619222844, 38183.80908095459, 40672.59327406729, 40822.0, 40959.9760006, 41118.99999999996, 41755.37366939498, 42141.73574792761, 42333.57666423335, 42336.57663423365, 42439.78780106095, 9664.27517936154, 9826.459544725038, 9854.556544955458, 9861.260405469618, 9872.308938374317, 9784.55969481375, 9912.306138570302, 9914.504274786268, 9921.3055086144, 9924.553395097239, 9935.801283974351, 9953.651622193225, 9972.252081093948, 9977.600895964153, 9993.300468967174, 9887.209023278192, 9894.30739848211, 9915.157211637019, 9925.90074099257, 9989.950050249703, 7939.5633240171765, 9737.026297370277, 9831.557579908922, 9846.507674616241, 10260.794784104351, 40319.55685982384, 40334.79832600847, 40534.0, 40559.0, 40573.79713101416, 3242.1793040055068, 3291.210109573709, 3349.916252093693, 3368.646292139339, 3471.2817155507933, 23616.7638323618, 26687.46625067488, 28531.857340713163, 29952.8502357489, 32360.029199124063, 3220.6457289698114, 3229.9031029069165, 3306.8591335989045, 3356.077078803324, 3443.5867695876655, 449385.0, 516400.0, 520798.39600801753, 523664.0, 525208.3739581354, 28315.71684283172, 32342.35315293681, 33181.0, 34795.30409391798, 62248.06627900585, 34561.827190863885, 34723.30553388918, 34755.30489390198, 35126.824365878005, 35159.29681406358, 14518.056326338965, 14589.92705036468, 14679.045862018935, 14709.632259193391, 14753.77869331961, 12308.692282693004, 12493.50025998968, 12607.621771346874, 12634.620961371174, 12658.620241392773, 7712.190220026929, 7712.305892469704, 7749.806254843674, 7771.611419429006, 7789.766307010798, 3201.951970720441, 3238.8704451822136, 3240.3357311751033, 3244.23760416302, 3275.950860737091, 910.2081189365294, 921.7234829551242, 934.7429456899271, 1005.8591797148405, 1012.7873146639141, 24746.0, 29497.410051799274, 30761.69238307633, 31317.68682313193, 31411.842940785606, 999.6101520407047, 1029.6807989523122, 1039.0181278691564, 1064.5528877871313, 1070.8500809886623, 15151.090934543963, 15541.378344866305, 15710.978786379077, 15764.054156750632, 16138.435154769526, 660755.0, 665222.6738866274, 666239.0, 668589.0, 668644.0, 59169.11246331308, 59432.0, 59446.70276648589, 59674.70162649159, 59804.40195598076, 1309.299524754252, 1347.1176379471462, 1380.875721185078, 1388.409925781559, 1388.6667199871958, 28744.425111497236, 29816.850915745283, 29886.85056574703, 30168.69831301659, 30697.846510767304, 40949.795251023555, 50480.0, 51000.74499627478, 51222.48777512326, 51427.48572514227, 580508.0, 581857.0, 583105.0, 583982.0, 584702.0, 26668.866655666596, 26861.462770744867, 26961.46077078408, 27251.0, 27334.0, 47404.52595474001, 49072.0, 49372.0, 49398.0, 50405.49594504008, 30568.0, 39465.0, 39482.921493561604, 40877.79561102176, 41063.17873642451, 32692.83653581717, 39284.0, 39709.0, 40829.0, 40962.0, 34907.65092349044, 38776.2244755109, 39127.82616521509, 39361.2127757449, 41176.58823411728, 33615.66384336125, 34389.484157737155, 35228.0, 35228.47157292591, 35280.29439411146, 23342.533149337258, 25940.22179334623, 26031.739682602933, 26326.21021369362, 26488.7351126494], "value": 18558.131491173397, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.9460375702947, 362.7207050571059, 369.8502106646808, 378.3549048871674, 388.31850103069144, 19997.0, 20285.492862678442, 20293.898530507344, 21103.050362733677, 21304.786952130475, 11874.703132421671, 12062.0, 17053.976761394326, 20511.692324615142, 21232.681509777365, 5560.221568980346, 5663.8584035399035, 5731.054376027951, 5734.971325143369, 5748.338941021773, 5437.564994800427, 5538.446155384449, 5553.972230138844, 5598.748056337475, 5613.101903695409, 5600.635958662674, 5609.775608975636, 5613.522850557708, 5623.718814059281, 5701.34434540027, 6032.487238584704, 6120.877582448348, 6221.96889015552, 6229.3459186785185, 6240.31356550779, 5251.317328747276, 5400.162974738922, 5439.265699130646, 5447.809326673548, 5511.834644960658, 25250.242492725247, 25958.0, 26054.86972565125, 26188.86905565479, 26189.345266368495, 2121.95756084879, 2289.2331069091874, 2294.6443301288327, 2479.5983987796412, 2653.946921061568, 10317.214352124884, 12657.810132848015, 12853.550125745554, 15624.375024998986, 16054.75917861233, 1907.6852319367288, 1923.7210604462275, 1927.9518012049812, 1968.6514737404923, 1969.9015049247623, 96575.51712241465, 133606.3319683405, 134111.65888341088, 135434.3228283862, 136393.0, 11340.26288291275, 11503.53985840557, 11613.187076904704, 11635.709107272216, 11667.88332116685, 14467.92766036163, 14574.854251457562, 14578.97947143711, 14609.853901461061, 14625.92687036558, 8422.873656895152, 8544.487330760174, 8569.742907712654, 8612.61243244043, 8700.869486957701, 7158.713651453883, 8442.029166645914, 8479.321654267644, 8519.701810436605, 8666.220040196413, 4393.956060439355, 4518.073794872043, 4542.159700455426, 4570.154521413483, 4613.584777369986, 1576.4718819195698, 1634.730269505542, 1660.7508873669046, 1697.3804561335023, 1971.6592716952323, 790.5335105562151, 812.4678335690132, 839.3788596438714, 914.2366124286162, 930.6230976454547, 20365.796342036687, 20897.686534701992, 20930.0, 20944.37166884996, 21283.78716212818, 919.0189174673287, 946.4463288975888, 950.254050570299, 952.4808979106404, 1016.8068067067234, 10325.451182322562, 10780.460976951277, 11075.335479871072, 11121.05471034971, 11216.270942388719, 541798.0, 549706.0, 584644.0, 609255.0, 612611.0, 109209.45395272973, 109577.35633965497, 121993.0, 135549.0, 139738.0, 998.2612866478753, 999.3753903809974, 1037.258360272409, 1039.740064983754, 1043.6242952537082, 16387.262573183998, 18476.907615461838, 18680.159392827085, 19071.0, 19273.807261927202, 35857.0, 49877.50122498729, 53050.0, 53694.0, 55305.44694553003, 80966.90330967092, 82597.58701206456, 82654.76017859616, 82937.0, 84477.57761211401, 7768.805779855549, 7887.487313324616, 8173.386995975206, 8192.221738934792, 8213.301869340934, 8882.15619516145, 11420.543178272776, 11549.191556590958, 11562.826557601475, 12151.939240303742, 10766.246362754531, 11073.667789966314, 11095.611653592085, 11268.04221641137, 11472.827907581226, 10660.8933910663, 10681.839772403264, 10781.892181078403, 10830.18773591968, 11414.029807466459, 11016.724581885197, 11094.89051094884, 11313.660590182308, 11460.255083419552, 11461.48423320936, 8059.516429014044, 8254.463459875089, 8259.339252859876, 8434.70478533273, 8446.704365347183, 10594.864998181325, 10756.838647420138, 10911.018008378967, 11208.159388045766, 11338.319700817978], "value": 9508.032274315774, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1277.591170825336, 1509.0492989416666, 1673.1717799689156, 1823.2889173222454, 1834.3304693786772, 7857.567833769141, 8412.158784121584, 8533.658653653847, 8930.464172149676, 8967.41711788734, 8557.443766155195, 8669.046404895473, 8750.168733970262, 8779.253763430115, 8782.780430489225, 2349.89425475854, 2368.0646144772804, 2372.9169479068237, 2377.8454400464, 2378.95242095158, 2327.418145463634, 2347.295811256625, 2370.8340416170877, 2376.2277259890607, 2393.401649587603, 2179.8474106812528, 2260.8921628402045, 2362.527494501098, 2365.7161140663056, 2370.810335173182, 2013.6878783788536, 2335.0309621506967, 2347.0494449747794, 2361.480474295652, 2365.4914193448403, 2342.636891281854, 2344.0623750499767, 2350.9882450587806, 2351.012574718622, 2351.106579499779, 7815.413843961725, 7976.361891048702, 8007.67969281228, 8348.916510834875, 8806.339524535686, 4631.305304204397, 4723.173444647173, 5031.421386540522, 5242.973785131088, 5297.231901374279, 3283.3433313337428, 3363.2937083212555, 3409.9147521312166, 3608.873689420884, 3612.945805812915, 1057.82897441104, 1086.9619563315325, 1087.5704096881766, 1109.7724966381872, 1113.5712750591, 11486.023687986532, 11501.884981150166, 11580.957713805714, 11651.067914566815, 11667.88332116685, 4524.185646583581, 4597.126545956257, 4724.763761811896, 4750.1474424974285, 4768.380110585671, 8865.069167737423, 9073.500957447404, 9971.202303815677, 9986.60053597848, 10001.899981000242, 5267.868303292448, 5288.391834938954, 5290.100682883919, 5290.947090529045, 5318.44156363584, 4330.307150855848, 4657.767111644404, 4791.47293797682, 4792.7124372537755, 4835.637327200474, 3506.053365591276, 3833.15670552478, 3868.671162951124, 3890.9610903891166, 3972.225416043844, 1110.816715241976, 1296.1380681846467, 1297.54585894936, 1300.876416740408, 1308.770965081107, 832.7376876283951, 926.2497377124416, 930.8184903943801, 930.9581068851918, 965.2229954886244, 5289.312389389432, 5823.505002074871, 6078.179445774764, 6202.596831206048, 6246.3441338659695, 940.6801687426308, 940.7507010642186, 988.9950550247203, 995.6714284286168, 1027.8201314769885, 3927.7250592458254, 4032.5967403259438, 4034.293998550242, 4105.651019663303, 4295.914081718348, 10180.134688551409, 10520.526576304084, 10521.158307335394, 10535.683929482127, 10536.789264214825, 9086.772830679154, 10395.272330936914, 10478.947605261925, 10510.0, 10565.947170264253, 7864.056313242448, 8039.196080392031, 8098.230668086522, 8162.469439486415, 8260.297874680598, 6039.275286965417, 6052.213212282375, 6067.817965461043, 6119.4798442132915, 6214.8135555933395, 9804.215662747105, 9909.157721593745, 9975.501224938578, 10019.298649094493, 10080.294379393372, 10029.097381235724, 10181.236407269336, 10257.948710256402, 10262.384256944608, 10317.86503484601, 7438.9585458037, 7618.923810762043, 8228.547429891414, 8286.792830179294, 8400.915990840012, 7446.14369347532, 7713.421493387906, 8342.374321926001, 8504.872426913726, 8596.226339629464, 6762.087118238975, 6923.9960205768875, 7350.52221605594, 7400.5189662671755, 7467.850642987001, 7001.36987671112, 7178.784636460915, 7276.927230727625, 7342.339189472973, 7342.449316301192, 6912.377885990285, 6947.687354068978, 6996.0, 7004.4396448283, 7032.0, 4466.084452687256, 4905.803767849389, 4948.554630083166, 4987.2768448574025, 5074.213496907985, 4968.925466117938, 5110.4123025852505, 5137.794488220429, 5151.484851514819, 5215.504527069922], "value": 4563.917029340714, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [284.7024859022321, 297.39776951672866, 304.39121756487026, 305.0695379093763, 308.25556281579986, 4525.298578720295, 5090.440051594322, 5575.69333686647, 5626.352969408519, 5667.206591077247, 4890.73100979446, 4972.502749725026, 5462.399136095037, 5560.86097847554, 5596.748146333414, 3597.4244120940652, 4161.730672144995, 4208.558101399355, 4212.684048696345, 4239.512456067561, 3851.2490064437447, 4146.834126634931, 4236.4704411948505, 4240.893977650552, 4247.0, 3851.0937086142258, 3865.342891708416, 4093.5292441369324, 4143.689223308249, 4147.937780933288, 4105.856295029675, 4113.835446582133, 4127.711060225785, 4147.6267135957905, 4153.54311025787, 3543.2382037861985, 3557.2351944332095, 3557.7331700122336, 3565.180008598037, 3576.3204991051616, 4756.048790241965, 5170.560502357304, 5248.895022099575, 5294.49702278283, 5387.703676297802, 4108.568600296986, 4263.87208383749, 4481.596656300949, 4716.292556116576, 4726.196546587088, 4949.752512374367, 5179.715115668637, 5549.58485586177, 5787.479126878601, 5925.4370834770625, 3799.9430008549894, 3832.0, 3908.687305015592, 3911.5306163260307, 3925.862594809168, 4925.433575138869, 6086.300075491331, 6105.542084343692, 6128.406614280319, 6151.384861513813, 3931.840107168392, 3941.940870886939, 3945.408188771707, 3948.3485224937563, 3966.960330396717, 3844.884653460401, 3960.980195099006, 4008.599140086026, 4022.9597704022585, 4039.1315867088715, 3846.8461261549783, 4271.0, 4374.737515749065, 4647.814087436533, 4727.338172655831, 4525.619685995737, 4840.878978025507, 5713.885722285531, 5877.764889404376, 5888.735006924699, 1123.1520202247414, 1257.6352857671357, 1343.43575698207, 1350.3450826349213, 1351.4796803230827, 875.1554749666602, 898.766320756608, 903.421810041574, 909.8908131024319, 911.4394647291867, 4594.931076033862, 5358.223057656618, 5384.353877534721, 5397.514223719884, 5411.377691565442, 5210.7915683373, 5530.810875661752, 5935.347111817697, 6002.729877155539, 6029.909551356734, 4622.0, 5163.036692619955, 5261.394939581921, 5386.192071189353, 5419.701916394557, 2339.321596736961, 2347.8378202789386, 2619.5415802234534, 2628.88170032349, 2720.4765331414073, 4430.446194225722, 4805.903881922342, 4927.093015121024, 5182.186234817784, 5192.610554208374, 4662.463816661059, 4816.397950256218, 5054.115529782273, 5124.5131712487255, 5125.001873903733, 4646.62826973848, 4743.976280118577, 5182.885679578833, 5247.609383513296, 5256.526912577886, 4254.787260636894, 4603.815847366068, 5094.064255583003, 5129.281271078438, 5144.742762861767, 4219.177260434309, 4295.008291711248, 4865.686264708438, 4970.577500912318, 5018.5232402921665, 4457.50967393593, 4960.8759781005765, 5022.723750193774, 5170.482951704799, 5190.0, 3128.89048883288, 3453.2575496268423, 3461.3942560051387, 3475.6097560975813, 3480.756347055682, 4947.45577986414, 5087.23691446286, 5087.262346959744, 5447.809326673548, 6124.785632502841, 5521.972390138024, 5532.695701736443, 5944.256967879015, 5971.656377315069, 5986.371430999857, 5096.541311282002, 5434.2120392542065, 5961.493273071837, 6011.218541589566, 6020.8795824084145, 4829.768409055669, 5622.718864056699, 5655.604107712421, 5812.912806307824, 5840.0, 5297.337832770903, 5697.344805347272, 5705.686187259575, 5999.040153575407, 6029.969850150721, 5279.39286982002, 5500.642458240201, 5851.64890106595, 5864.179014937827, 5891.911621325769], "value": 4027.8421977064777, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [634.2294112653126, 634.3402861024534, 638.894582393905, 697.5814511293222, 756.4591317208195, 15510.844891551082, 16392.75410868838, 16416.753748693765, 16433.26050327735, 16483.84613077085, 14772.335244913978, 14948.775768363483, 15410.0, 16018.439354622591, 16186.0, 713.4577720932077, 839.8404303182406, 865.247234905633, 865.5499140446964, 866.9306455483578, 661.8279247395687, 752.8042708895672, 828.4366630691128, 857.9442336248155, 863.9179277968583, 898.3576742629019, 899.9055099214586, 903.7695387676166, 904.2449554621899, 909.6588779207797, 844.9860167798666, 896.9461832290084, 897.5557099235888, 903.2864037410438, 904.4799240436776, 613.714622700442, 674.4671709349608, 675.0987431778582, 679.3987321220756, 683.1767719897512, 15335.0, 15499.690006199813, 15515.612109697235, 15569.0, 15597.376104955789, 14081.929590351983, 14269.857301426957, 14374.281285935765, 14501.854981450157, 14731.631709207355, 11029.393383363991, 11936.761264774656, 11949.342786146759, 11984.760304793943, 12270.38648067593, 3474.5309383233193, 3771.8114094295174, 3852.5376954765607, 3865.5361356637104, 3878.592747761501, 124754.0, 128677.35661321634, 128754.0, 128927.0, 129322.35338823246, 10909.781804364027, 11033.503492342863, 11124.996251012182, 11157.326401039747, 11238.7190320241, 22637.773622263565, 22741.658875116886, 22758.544829103324, 22819.657705134436, 22834.97242624086, 7989.520628762293, 8139.145389734111, 8156.062052863878, 8174.918250817415, 8186.877196842052, 4550.635949124062, 4628.652851036186, 4642.187617166982, 4764.927891224447, 4783.760811959388, 3612.945805812915, 3701.0, 3732.2908647356917, 3745.981270093687, 3758.755680880734, 654.3554598720257, 667.279338314619, 669.7957123077508, 678.8879834827297, 681.2336121862904, 551.2943432406526, 571.5570432914525, 586.2876604925036, 678.8268991407159, 696.6621188723465, 9001.504917229484, 9264.887876837754, 9315.115064068903, 9370.29722770795, 9556.808863822685, 630.8990561510228, 631.5105793010362, 665.5656318917701, 669.4309836638915, 685.5167107189419, 4578.771061446914, 4592.6555508337005, 4593.0, 4606.677532572688, 4676.672632915664, 109832.0, 115314.0, 121430.0, 125721.0, 148779.0, 72941.27058729451, 98332.52501212487, 109405.45297273462, 109825.0, 110113.0, 109604.4519777396, 111195.0, 111614.99999999837, 114345.0, 114392.0, 9694.382516720587, 9788.46163460988, 9930.307548281982, 10015.499225038864, 10030.799384012425, 51804.740976294874, 53384.0, 54652.633684158216, 62416.68791656195, 63698.859574127535, 76551.0, 87463.0, 90924.09075909156, 92971.0, 93089.0, 13503.459861605426, 13579.52471663487, 13645.0, 13727.519536816164, 13815.717781322228, 13559.186448813103, 14025.929870350583, 14911.179885106423, 15078.623034424227, 15224.162671053198, 13903.791443128563, 13948.372323245276, 14003.0, 14379.42482300738, 14655.780163297346, 13713.0, 13832.37754301079, 13864.445422183, 13916.234607096707, 13923.79114313266, 13582.320883955565, 13992.650183745081, 14195.432182712575, 14283.07160034636, 14434.566962991126, 11013.504392302526, 11397.430128493708, 11424.714382140513, 11511.251768635011, 11561.439205707122, 9824.4105353679, 11574.363410012531, 11691.356975366436, 11711.88288117108, 11749.412529373327], "value": 7839.487378524095, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1590.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 120.0, 112.0, 115.0, 118.0, 129.0, 171.0, 118.0, 117.0, 119.0], "value": 122.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 113.0, 131.0, 185.0, 135.0, 136.0, 130.0, 97.0, 186.0, 101.0], "value": 135.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [202.0, 232.0, 258.0, 226.0, 177.0, 255.0, 273.0, 217.0, 196.0, 195.0], "value": 223.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 82.0, 75.0, 146.0, 58.0, 60.0, 58.0, 60.0, 143.0, 61.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 74.0, 128.0, 72.0, 72.0, 76.0, 115.0, 90.0, 102.0, 139.0], "value": 93.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 96.0, 89.0, 87.0, 90.0, 86.0, 89.0, 94.0, 92.0, 86.0], "value": 89.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 107.0, 97.0, 114.0, 146.0, 107.0, 99.0, 96.0, 104.0], "value": 106.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 146.0, 90.0, 91.0, 92.0, 92.0, 94.0, 93.0, 100.0, 89.0], "value": 99.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 55.0, 52.0, 56.0, 61.0, 77.0, 74.0, 78.0, 78.0, 83.0], "value": 66.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 69.0, 66.0, 66.0, 105.0, 108.0, 76.0, 64.0, 80.0, 63.0], "value": 76.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 105.0, 108.0, 88.0, 84.0, 87.0, 80.0, 101.0, 105.0, 100.0], "value": 94.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 164.0, 153.0, 137.0, 141.0, 152.0, 145.0, 156.0, 198.0, 166.0], "value": 156.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 173.0, 168.0, 168.0, 169.0, 171.0, 170.0, 189.0, 227.0, 163.0], "value": 177.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 69.0, 67.0, 70.0, 66.0, 69.0, 67.0, 69.0, 71.0], "value": 68.7, "unit": "score"}]}]} 07:10:16 INFO - Return code: 0 07:10:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:10:16 ERROR - # TBPL SUCCESS # 07:10:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:10:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:10:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:10:16 INFO - 2016-08-19 07:10:16.096 screenresolution[1667:10497] starting screenresolution argv=screenresolution get 07:10:16 INFO - 2016-08-19 07:10:16.098 screenresolution[1667:10497] Display 0: 1600x1200x32@60 07:10:16 INFO - 2016-08-19 07:10:16.104 screenresolution[1668:10500] starting screenresolution argv=screenresolution list 07:10:16 INFO - Available Modes on Display 0 07:10:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:10:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:10:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:10:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:10:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:10:16 INFO - Intel Iris: 07:10:16 INFO - Chipset Model: Intel Iris 07:10:16 INFO - Type: GPU 07:10:16 INFO - Bus: Built-In 07:10:16 INFO - VRAM (Dynamic, Max): 1536 MB 07:10:16 INFO - Vendor: Intel (0x8086) 07:10:16 INFO - Device ID: 0x0a2e 07:10:16 INFO - Revision ID: 0x0009 07:10:16 INFO - Displays: 07:10:16 INFO - Display: 07:10:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:10:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:10:16 INFO - Display Serial Number: 1600x1200 60 07:10:16 INFO - Main Display: Yes 07:10:16 INFO - Mirror: Off 07:10:16 INFO - Online: Yes 07:10:16 INFO - Rotation: Supported 07:10:16 INFO - Return code: 0 07:10:16 INFO - Running post-action listener: _resource_record_post_action 07:10:16 INFO - [mozharness: 2016-08-19 14:10:16.338922Z] Finished run-tests step (success) 07:10:16 INFO - Running post-run listener: _resource_record_post_run 07:10:16 INFO - Total resource usage - Wall time: 1209s; CPU: 55.0%; Read bytes: 37016576; Write bytes: 706499072; Read time: 237; Write time: 1985 07:10:16 INFO - TinderboxPrint: CPU usage
54.9% 07:10:16 INFO - TinderboxPrint: I/O read bytes / time
37,016,576 / 237 07:10:16 INFO - TinderboxPrint: I/O write bytes / time
706,499,072 / 1,985 07:10:16 INFO - TinderboxPrint: CPU idle
2,183.9 (45.1%) 07:10:16 INFO - TinderboxPrint: CPU system
980.7 (20.3%) 07:10:16 INFO - TinderboxPrint: CPU user
1,673.1 (34.6%) 07:10:16 INFO - TinderboxPrint: Swap in / out
442,503,168 / 0 07:10:16 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 403112448; Write bytes: 396367360; Read time: 29876; Write time: 793 07:10:16 INFO - run-tests - Wall time: 1176s; CPU: 55.0%; Read bytes: 34882560; Write bytes: 297106432; Read time: 216; Write time: 1151 07:10:16 INFO - Running post-run listener: _upload_blobber_files 07:10:16 INFO - Blob upload gear active. 07:10:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:10:16 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 07:10:16 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'] 07:10:16 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 07:10:17 INFO - (blobuploader) - INFO - Open directory for files ... 07:10:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:10:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:10:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:10:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:10:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:10:18 INFO - (blobuploader) - INFO - Done attempting. 07:10:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:10:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:10:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:10:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:10:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:10:19 INFO - (blobuploader) - INFO - Done attempting. 07:10:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:10:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:10:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:10:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:10:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:10:21 INFO - (blobuploader) - INFO - Done attempting. 07:10:21 INFO - (blobuploader) - INFO - Iteration through files over. 07:10:21 INFO - Return code: 0 07:10:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:10:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:10:21 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3e225bbc39cebf2afe3b273066bf84792ce0b47541a69e8a38e8d7701fffaf5b2985dc2f1974095901ed888143c6a6422e5faadfa2615c35af20a052cb1ec335", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c9f70c0cb98be0f23e23f432aea4e23ea226bf0961c6908d1af1edbd6fd5d5ac9425e1d8109d620be6845a95e2e16b16260e42a6794169935f6e057bde6a1605", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/26254e9a5aa177eacab5b21a59c157b7f314ba9c08d96fcf358f2e1fce73c72cd554f65cfcca761ba6eceb1189cbfa6722c2f89a7cec5ca98f362667d914c0d8"} 07:10:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:10:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:10:21 INFO - Contents: 07:10:21 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3e225bbc39cebf2afe3b273066bf84792ce0b47541a69e8a38e8d7701fffaf5b2985dc2f1974095901ed888143c6a6422e5faadfa2615c35af20a052cb1ec335", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c9f70c0cb98be0f23e23f432aea4e23ea226bf0961c6908d1af1edbd6fd5d5ac9425e1d8109d620be6845a95e2e16b16260e42a6794169935f6e057bde6a1605", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/26254e9a5aa177eacab5b21a59c157b7f314ba9c08d96fcf358f2e1fce73c72cd554f65cfcca761ba6eceb1189cbfa6722c2f89a7cec5ca98f362667d914c0d8"} 07:10:21 INFO - Running post-run listener: copy_logs_to_upload_dir 07:10:21 INFO - Copying logs to upload dir... 07:10:21 INFO - mkdir: /builds/slave/test/build/upload/logs 07:10:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.513323 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-08-19 07:10:21.716258) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-19 07:10:21.720425) ========= 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.i6YuXT97wQ/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.61FBlQZIQM/Listeners TMPDIR=/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3e225bbc39cebf2afe3b273066bf84792ce0b47541a69e8a38e8d7701fffaf5b2985dc2f1974095901ed888143c6a6422e5faadfa2615c35af20a052cb1ec335", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c9f70c0cb98be0f23e23f432aea4e23ea226bf0961c6908d1af1edbd6fd5d5ac9425e1d8109d620be6845a95e2e16b16260e42a6794169935f6e057bde6a1605", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/26254e9a5aa177eacab5b21a59c157b7f314ba9c08d96fcf358f2e1fce73c72cd554f65cfcca761ba6eceb1189cbfa6722c2f89a7cec5ca98f362667d914c0d8"} 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.011199 build_url: 'https://queue.taskcluster.net/v1/task/Db6Sj8WTTPyAHQcmfEoraA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3e225bbc39cebf2afe3b273066bf84792ce0b47541a69e8a38e8d7701fffaf5b2985dc2f1974095901ed888143c6a6422e5faadfa2615c35af20a052cb1ec335", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c9f70c0cb98be0f23e23f432aea4e23ea226bf0961c6908d1af1edbd6fd5d5ac9425e1d8109d620be6845a95e2e16b16260e42a6794169935f6e057bde6a1605", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/26254e9a5aa177eacab5b21a59c157b7f314ba9c08d96fcf358f2e1fce73c72cd554f65cfcca761ba6eceb1189cbfa6722c2f89a7cec5ca98f362667d914c0d8"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-19 07:10:21.763435) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 07:10:21.763890) ========= 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.i6YuXT97wQ/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.61FBlQZIQM/Listeners TMPDIR=/var/folders/_l/g7gsx8tj15q7mjfg0y9vcz5c00000w/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.005059 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 07:10:21.814194) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-19 07:10:21.814594) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-19 07:10:21.814989) ========= ========= Total master_lag: 0.20 =========