builder: autoland_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0372 starttime: 1471925654.41 results: success (0) buildid: 20160822190716 builduid: dff4f98554044ce686f0aace7ecb8366 revision: d6d2cc94bb924a86a0b8476b0e6681fe2f211283 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 21:14:14.411621) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 21:14:14.412209) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 21:14:14.412555) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 21:14:14.596331) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 21:14:14.596797) ========= 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.3vqg7HU3aR/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.pQgtKZKc9G/Listeners TMPDIR=/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/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-22 21:14:14-- 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% 18.5M=0.001s 2016-08-22 21:14:15 (18.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.531361 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 21:14:15.153361) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 21:14:15.153747) ========= 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.3vqg7HU3aR/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.pQgtKZKc9G/Listeners TMPDIR=/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/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.026134 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 21:14:15.202883) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-22 21:14:15.203291) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev d6d2cc94bb924a86a0b8476b0e6681fe2f211283 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev d6d2cc94bb924a86a0b8476b0e6681fe2f211283 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3vqg7HU3aR/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.pQgtKZKc9G/Listeners TMPDIR=/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/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-22 21:14:15,286 truncating revision to first 12 chars 2016-08-22 21:14:15,286 Setting DEBUG logging. 2016-08-22 21:14:15,287 attempt 1/10 2016-08-22 21:14:15,287 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/d6d2cc94bb92?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-22 21:14:16,329 unpacking tar archive at: autoland-d6d2cc94bb92/testing/mozharness/ program finished with exit code 0 elapsedTime=1.302086 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-22 21:14:16.528916) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 21:14:16.529257) ========= script_repo_revision: d6d2cc94bb924a86a0b8476b0e6681fe2f211283 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 21:14:16.529737) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 21:14:16.530063) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 21:14:16.548823) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-08-22 21:14:16.549155) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3vqg7HU3aR/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.pQgtKZKc9G/Listeners TMPDIR=/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/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 21:14:16 INFO - MultiFileLogger online at 20160822 21:14:16 in /builds/slave/test 21:14:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 21:14:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:14:16 INFO - {'append_to_log': False, 21:14:16 INFO - 'base_work_dir': '/builds/slave/test', 21:14:16 INFO - 'blob_upload_branch': 'Autoland', 21:14:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:14:16 INFO - 'branch': 'Autoland', 21:14:16 INFO - 'buildbot_json_path': 'buildprops.json', 21:14:16 INFO - 'config_files': ('talos/mac_config.py',), 21:14:16 INFO - 'default_actions': ('clobber', 21:14:16 INFO - 'read-buildbot-config', 21:14:16 INFO - 'download-and-extract', 21:14:16 INFO - 'populate-webroot', 21:14:16 INFO - 'create-virtualenv', 21:14:16 INFO - 'install', 21:14:16 INFO - 'run-tests'), 21:14:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:14:16 INFO - 'download_minidump_stackwalk': True, 21:14:16 INFO - 'download_symbols': 'ondemand', 21:14:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:14:16 INFO - 'tooltool.py': '/tools/tooltool.py', 21:14:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:14:16 INFO - '/tools/misc-python/virtualenv.py')}, 21:14:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:14:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:14:16 INFO - 'installer_path': 'installer.exe', 21:14:16 INFO - 'log_level': 'info', 21:14:16 INFO - 'log_name': 'talos', 21:14:16 INFO - 'log_to_console': True, 21:14:16 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:14:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:14:16 INFO - 'opt_config_files': (), 21:14:16 INFO - 'pip_index': False, 21:14:16 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:14:16 INFO - 'cmd': ('bash', 21:14:16 INFO - '-c', 21:14:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:14:16 INFO - 'enabled': True, 21:14:16 INFO - 'halt_on_failure': False, 21:14:16 INFO - 'name': 'check_screen_resolution'},), 21:14:16 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:14:16 INFO - 'cmd': ('bash', 21:14:16 INFO - '-c', 21:14:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:14:16 INFO - 'enabled': True, 21:14:16 INFO - 'halt_on_failure': False, 21:14:16 INFO - 'name': 'check_screen_resolution'},), 21:14:16 INFO - 'run_cmd_checks_enabled': True, 21:14:16 INFO - 'sps_profile': False, 21:14:16 INFO - 'sps_profile_interval': 0, 21:14:16 INFO - 'suite': 'dromaeojs-e10s', 21:14:16 INFO - 'system_bits': '32', 21:14:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:14:16 INFO - 'title': 't-yosemite-r7-0372', 21:14:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:14:16 INFO - 'use_talos_json': True, 21:14:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:14:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:14:16 INFO - 'work_dir': 'build'} 21:14:16 INFO - [mozharness: 2016-08-23 04:14:16.742732Z] Running clobber step. 21:14:16 INFO - Running pre-action listener: _resource_record_pre_action 21:14:16 INFO - Running main action method: clobber 21:14:16 INFO - rmtree: /builds/slave/test/build 21:14:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:14:18 INFO - Running post-action listener: _resource_record_post_action 21:14:18 INFO - [mozharness: 2016-08-23 04:14:18.919751Z] Finished clobber step (success) 21:14:18 INFO - [mozharness: 2016-08-23 04:14:18.919884Z] Running read-buildbot-config step. 21:14:18 INFO - Running pre-action listener: _resource_record_pre_action 21:14:18 INFO - Running main action method: read_buildbot_config 21:14:18 INFO - Using buildbot properties: 21:14:18 INFO - { 21:14:18 INFO - "project": "", 21:14:18 INFO - "product": "firefox", 21:14:18 INFO - "script_repo_revision": "production", 21:14:18 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs-e10s", 21:14:18 INFO - "repository": "", 21:14:18 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs-e10s", 21:14:18 INFO - "buildid": "20160822190716", 21:14:18 INFO - "pgo_build": "False", 21:14:18 INFO - "basedir": "/builds/slave/test", 21:14:18 INFO - "buildnumber": 154, 21:14:18 INFO - "slavename": "t-yosemite-r7-0372", 21:14:18 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 21:14:18 INFO - "platform": "yosemite_r7", 21:14:18 INFO - "scheduler": "tests-autoland-macosx64-talos-7-3600", 21:14:18 INFO - "branch": "autoland", 21:14:18 INFO - "repo_path": "integration/autoland", 21:14:18 INFO - "revision": "d6d2cc94bb924a86a0b8476b0e6681fe2f211283", 21:14:18 INFO - "stage_platform": "macosx64", 21:14:18 INFO - "builduid": "dff4f98554044ce686f0aace7ecb8366", 21:14:18 INFO - "slavebuilddir": "test" 21:14:18 INFO - } 21:14:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/SO65-aCtQki5zmcYW7bS9w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 21:14:18 INFO - Running post-action listener: _resource_record_post_action 21:14:18 INFO - [mozharness: 2016-08-23 04:14:18.923049Z] Finished read-buildbot-config step (success) 21:14:18 INFO - [mozharness: 2016-08-23 04:14:18.923146Z] Running download-and-extract step. 21:14:18 INFO - Running pre-action listener: _resource_record_pre_action 21:14:18 INFO - Running main action method: download_and_extract 21:14:18 INFO - mkdir: /builds/slave/test/build/tests 21:14:18 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')]} 21:14:18 INFO - trying https://queue.taskcluster.net/v1/task/SO65-aCtQki5zmcYW7bS9w/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 21:14:18 INFO - Downloading https://queue.taskcluster.net/v1/task/SO65-aCtQki5zmcYW7bS9w/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 21:14:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SO65-aCtQki5zmcYW7bS9w/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 21:14:20 INFO - Downloaded 1199 bytes. 21:14:20 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 21:14:20 INFO - Using the following test package requirements: 21:14:20 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 21:14:20 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:14:20 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 21:14:20 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:14:20 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 21:14:20 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:14:20 INFO - u'jsshell-mac.zip'], 21:14:20 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:14:20 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 21:14:20 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 21:14:20 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:14:20 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 21:14:20 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:14:20 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 21:14:20 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:14:20 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 21:14:20 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:14:20 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 21:14:20 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 21:14:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:14:20 INFO - trying https://queue.taskcluster.net/v1/task/SO65-aCtQki5zmcYW7bS9w/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 21:14:20 INFO - Downloading https://queue.taskcluster.net/v1/task/SO65-aCtQki5zmcYW7bS9w/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 21:14:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SO65-aCtQki5zmcYW7bS9w/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 21:14:21 INFO - Downloaded 16353634 bytes. 21:14:21 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 21:14:28 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 21:14:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:14:28 INFO - trying https://queue.taskcluster.net/v1/task/SO65-aCtQki5zmcYW7bS9w/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 21:14:28 INFO - Downloading https://queue.taskcluster.net/v1/task/SO65-aCtQki5zmcYW7bS9w/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 21:14:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SO65-aCtQki5zmcYW7bS9w/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 21:14:28 INFO - Downloaded 16353634 bytes. 21:14:28 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 21:14:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:14:35 INFO - trying https://queue.taskcluster.net/v1/task/SO65-aCtQki5zmcYW7bS9w/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 21:14:35 INFO - Downloading https://queue.taskcluster.net/v1/task/SO65-aCtQki5zmcYW7bS9w/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 21:14:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SO65-aCtQki5zmcYW7bS9w/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 21:14:36 INFO - Downloaded 14413981 bytes. 21:14:36 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 21:14:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:14:36 INFO - trying https://queue.taskcluster.net/v1/task/SO65-aCtQki5zmcYW7bS9w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 21:14:36 INFO - Downloading https://queue.taskcluster.net/v1/task/SO65-aCtQki5zmcYW7bS9w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 21:14:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SO65-aCtQki5zmcYW7bS9w/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 21:14:39 INFO - Downloaded 111394998 bytes. 21:14:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SO65-aCtQki5zmcYW7bS9w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 21:14:39 INFO - mkdir: /builds/slave/test/properties 21:14:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:14:39 INFO - Writing to file /builds/slave/test/properties/build_url 21:14:39 INFO - Contents: 21:14:39 INFO - build_url:https://queue.taskcluster.net/v1/task/SO65-aCtQki5zmcYW7bS9w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 21:14:40 INFO - Running post-action listener: _resource_record_post_action 21:14:40 INFO - Running post-action listener: set_extra_try_arguments 21:14:40 INFO - [mozharness: 2016-08-23 04:14:40.243424Z] Finished download-and-extract step (success) 21:14:40 INFO - [mozharness: 2016-08-23 04:14:40.243562Z] Running populate-webroot step. 21:14:40 INFO - Running pre-action listener: _resource_record_pre_action 21:14:40 INFO - Running main action method: populate_webroot 21:14:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:14:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:14:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:14:40 INFO - '--tppagecycles', 21:14:40 INFO - '7'], 21:14:40 INFO - 'tests': ['tsvgm']}}, 21:14:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:14:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:14:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:14:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:14:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:14:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:14:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:14:40 INFO - 'talos_options': ['--disable-e10s'], 21:14:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:14:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:14:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:14:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:14:40 INFO - 'talos_options': ['--disable-e10s'], 21:14:40 INFO - 'tests': ['damp', 'tps']}, 21:14:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:14:40 INFO - 'tests': ['damp', 'tps']}, 21:14:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:14:40 INFO - 'tests': ['dromaeo_dom']}, 21:14:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:14:40 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:14:40 INFO - 'tests': ['basic_compositor_video']}, 21:14:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:14:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:14:40 INFO - 'tests': ['a11yr', 21:14:40 INFO - 'ts_paint', 21:14:40 INFO - 'tpaint', 21:14:40 INFO - 'sessionrestore', 21:14:40 INFO - 'sessionrestore_no_auto_restore', 21:14:40 INFO - 'tabpaint']}, 21:14:40 INFO - 'other-e10s': {'tests': ['a11yr', 21:14:40 INFO - 'ts_paint', 21:14:40 INFO - 'tpaint', 21:14:40 INFO - 'sessionrestore', 21:14:40 INFO - 'sessionrestore_no_auto_restore', 21:14:40 INFO - 'tabpaint']}, 21:14:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:14:40 INFO - 'ts_paint', 21:14:40 INFO - 'tpaint', 21:14:40 INFO - 'sessionrestore', 21:14:40 INFO - 'sessionrestore_no_auto_restore', 21:14:40 INFO - 'tabpaint']}, 21:14:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:14:40 INFO - 'ts_paint', 21:14:40 INFO - 'tpaint', 21:14:40 INFO - 'sessionrestore', 21:14:40 INFO - 'sessionrestore_no_auto_restore', 21:14:40 INFO - 'tabpaint']}, 21:14:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:14:40 INFO - 'tests': ['a11yr', 21:14:40 INFO - 'ts_paint', 21:14:40 INFO - 'tpaint', 21:14:40 INFO - 'sessionrestore', 21:14:40 INFO - 'sessionrestore_no_auto_restore', 21:14:40 INFO - 'tabpaint']}, 21:14:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:14:40 INFO - 'tests': ['a11yr', 21:14:40 INFO - 'ts_paint', 21:14:40 INFO - 'tpaint', 21:14:40 INFO - 'sessionrestore', 21:14:40 INFO - 'sessionrestore_no_auto_restore', 21:14:40 INFO - 'tabpaint']}, 21:14:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:14:40 INFO - 'tests': ['tsvgx', 21:14:40 INFO - 'tsvgr_opacity', 21:14:40 INFO - 'tart', 21:14:40 INFO - 'tscrollx', 21:14:40 INFO - 'cart']}, 21:14:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:14:40 INFO - 'tsvgr_opacity', 21:14:40 INFO - 'tart', 21:14:40 INFO - 'tscrollx', 21:14:40 INFO - 'cart']}, 21:14:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:14:40 INFO - 'talos_options': ['--disable-e10s'], 21:14:40 INFO - 'tests': ['tp5o']}, 21:14:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:14:40 INFO - 'tests': ['tp5o']}, 21:14:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:14:40 INFO - 'talos_options': ['--disable-e10s', 21:14:40 INFO - '--xperf_path', 21:14:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:14:40 INFO - 'tests': ['tp5n']}, 21:14:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:14:40 INFO - 'talos_options': ['--xperf_path', 21:14:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:14:40 INFO - 'tests': ['tp5n']}}, 21:14:40 INFO - 'talos.zip': {'path': '', 21:14:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:14:40 INFO - Running post-action listener: _resource_record_post_action 21:14:40 INFO - [mozharness: 2016-08-23 04:14:40.262309Z] Finished populate-webroot step (success) 21:14:40 INFO - [mozharness: 2016-08-23 04:14:40.262431Z] Running create-virtualenv step. 21:14:40 INFO - Running pre-action listener: _resource_record_pre_action 21:14:40 INFO - Running main action method: create_virtualenv 21:14:40 INFO - Creating virtualenv /builds/slave/test/build/venv 21:14:40 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 21:14:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:14:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:14:40 INFO - Using real prefix '/tools/python27' 21:14:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:14:41 INFO - Installing distribute.............................................................................................................................................................................................done. 21:14:43 INFO - Installing pip.................done. 21:14:43 INFO - Return code: 0 21:14:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:14:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:14:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:14:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:14:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:14:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107632a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076c7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5ab55b740>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107596d30>, '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 0x1072fbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10758eb20>, '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.3vqg7HU3aR/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.pQgtKZKc9G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/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 21:14:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:14:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:14:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3vqg7HU3aR/Render', 21:14:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:14:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:14:43 INFO - 'HOME': '/Users/cltbld', 21:14:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:14:43 INFO - 'LOGNAME': 'cltbld', 21:14:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:43 INFO - 'MOZ_NO_REMOTE': '1', 21:14:43 INFO - 'NO_EM_RESTART': '1', 21:14:43 INFO - 'PAGER': '/bin/cat', 21:14:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:14:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:43 INFO - 'PWD': '/builds/slave/test', 21:14:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:14:43 INFO - 'SHELL': '/bin/bash', 21:14:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pQgtKZKc9G/Listeners', 21:14:43 INFO - 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/', 21:14:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:14:43 INFO - 'USER': 'cltbld', 21:14:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:14:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:14:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:43 INFO - 'XPC_FLAGS': '0x0', 21:14:43 INFO - 'XPC_SERVICE_NAME': '0', 21:14:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:14:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:14:44 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 21:14:44 INFO - Cleaning up... 21:14:44 INFO - Return code: 0 21:14:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:14: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')]} 21:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:14:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14: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')]} 21:14:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:14:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14: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', '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 0x107632a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076c7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5ab55b740>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107596d30>, '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 0x1072fbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10758eb20>, '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.3vqg7HU3aR/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.pQgtKZKc9G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/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 21:14: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', 'psutil>=3.1.1'] in /builds/slave/test/build 21:14: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 psutil>=3.1.1 21:14:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3vqg7HU3aR/Render', 21:14:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:14:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:14:44 INFO - 'HOME': '/Users/cltbld', 21:14:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:14:44 INFO - 'LOGNAME': 'cltbld', 21:14:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:44 INFO - 'MOZ_NO_REMOTE': '1', 21:14:44 INFO - 'NO_EM_RESTART': '1', 21:14:44 INFO - 'PAGER': '/bin/cat', 21:14:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:14:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:44 INFO - 'PWD': '/builds/slave/test', 21:14:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:14:44 INFO - 'SHELL': '/bin/bash', 21:14:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pQgtKZKc9G/Listeners', 21:14:44 INFO - 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/', 21:14:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:14:44 INFO - 'USER': 'cltbld', 21:14:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:14:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:14:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:44 INFO - 'XPC_FLAGS': '0x0', 21:14:44 INFO - 'XPC_SERVICE_NAME': '0', 21:14:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:14:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:14:44 INFO - Downloading/unpacking psutil>=3.1.1 21:14: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 21:14: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 21:14: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 21:14: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 21:14: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 21:14: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 21:14:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:14:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:14:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:14:48 INFO - Installing collected packages: psutil 21:14:48 INFO - Running setup.py install for psutil 21:14:48 INFO - building 'psutil._psutil_osx' extension 21:14:48 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 21:14:48 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 21:14:48 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 21:14:49 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 21:14:49 INFO - building 'psutil._psutil_posix' extension 21:14:49 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 21:14:49 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:14:49 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:14:49 INFO - ^ 21:14:49 INFO - 1 warning generated. 21:14:49 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 21:14:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:14:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:14:49 INFO - Successfully installed psutil 21:14:49 INFO - Cleaning up... 21:14:49 INFO - Return code: 0 21:14:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:14:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:14:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:14:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:14:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:49 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 0x107632a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076c7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5ab55b740>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107596d30>, '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 0x1072fbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10758eb20>, '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.3vqg7HU3aR/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.pQgtKZKc9G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/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 21:14:49 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 21:14:49 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 21:14:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3vqg7HU3aR/Render', 21:14:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:14:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:14:49 INFO - 'HOME': '/Users/cltbld', 21:14:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:14:49 INFO - 'LOGNAME': 'cltbld', 21:14:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:49 INFO - 'MOZ_NO_REMOTE': '1', 21:14:49 INFO - 'NO_EM_RESTART': '1', 21:14:49 INFO - 'PAGER': '/bin/cat', 21:14:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:14:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:49 INFO - 'PWD': '/builds/slave/test', 21:14:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:14:49 INFO - 'SHELL': '/bin/bash', 21:14:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pQgtKZKc9G/Listeners', 21:14:49 INFO - 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/', 21:14:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:14:49 INFO - 'USER': 'cltbld', 21:14:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:14:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:14:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:49 INFO - 'XPC_FLAGS': '0x0', 21:14:49 INFO - 'XPC_SERVICE_NAME': '0', 21:14:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:14:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:14:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:14:49 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 21:14:49 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 21:14:49 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 21:14:49 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 21:14:49 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 21:14:49 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 21:14:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:14:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:14:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:14:52 INFO - Installing collected packages: mozsystemmonitor 21:14:52 INFO - Running setup.py install for mozsystemmonitor 21:14:52 INFO - Successfully installed mozsystemmonitor 21:14:52 INFO - Cleaning up... 21:14:52 INFO - Return code: 0 21:14:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:14:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:14:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:14:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:14:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:52 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 0x107632a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076c7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5ab55b740>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107596d30>, '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 0x1072fbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10758eb20>, '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.3vqg7HU3aR/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.pQgtKZKc9G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/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 21:14:52 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 21:14:52 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 21:14:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3vqg7HU3aR/Render', 21:14:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:14:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:14:52 INFO - 'HOME': '/Users/cltbld', 21:14:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:14:52 INFO - 'LOGNAME': 'cltbld', 21:14:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:52 INFO - 'MOZ_NO_REMOTE': '1', 21:14:52 INFO - 'NO_EM_RESTART': '1', 21:14:52 INFO - 'PAGER': '/bin/cat', 21:14:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:14:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:52 INFO - 'PWD': '/builds/slave/test', 21:14:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:14:52 INFO - 'SHELL': '/bin/bash', 21:14:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pQgtKZKc9G/Listeners', 21:14:52 INFO - 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/', 21:14:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:14:52 INFO - 'USER': 'cltbld', 21:14:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:14:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:14:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:52 INFO - 'XPC_FLAGS': '0x0', 21:14:52 INFO - 'XPC_SERVICE_NAME': '0', 21:14:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:14:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:14:52 INFO - Downloading/unpacking jsonschema==2.5.1 21:14:52 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 21:14:52 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 21:14:52 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 21:14:52 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 21:14:52 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 21:14:52 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 21:14:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:14:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:14:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:14:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:14:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:14:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:14:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:14:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:14:55 INFO - Downloading functools32-3.2.3-2.tar.gz 21:14:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:14:55 INFO - warning: no files found matching '*.txt' 21:14:55 INFO - no previously-included directories found matching 'build' 21:14:55 INFO - no previously-included directories found matching 'dist' 21:14:55 INFO - no previously-included directories found matching '.git*' 21:14:55 INFO - Installing collected packages: jsonschema, functools32 21:14:55 INFO - Running setup.py install for functools32 21:14:55 INFO - warning: no files found matching '*.txt' 21:14:55 INFO - no previously-included directories found matching 'build' 21:14:55 INFO - no previously-included directories found matching 'dist' 21:14:55 INFO - no previously-included directories found matching '.git*' 21:14:55 INFO - Successfully installed jsonschema functools32 21:14:55 INFO - Cleaning up... 21:14:55 INFO - Return code: 0 21:14:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:14:55 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')]} 21:14:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:14:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:55 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')]} 21:14:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:14:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:55 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 0x107632a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076c7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5ab55b740>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107596d30>, '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 0x1072fbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10758eb20>, '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.3vqg7HU3aR/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.pQgtKZKc9G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/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 21:14:55 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 21:14:55 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 21:14:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3vqg7HU3aR/Render', 21:14:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:14:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:14:55 INFO - 'HOME': '/Users/cltbld', 21:14:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:14:55 INFO - 'LOGNAME': 'cltbld', 21:14:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:55 INFO - 'MOZ_NO_REMOTE': '1', 21:14:55 INFO - 'NO_EM_RESTART': '1', 21:14:55 INFO - 'PAGER': '/bin/cat', 21:14:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:14:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:55 INFO - 'PWD': '/builds/slave/test', 21:14:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:14:55 INFO - 'SHELL': '/bin/bash', 21:14:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pQgtKZKc9G/Listeners', 21:14:55 INFO - 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/', 21:14:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:14:55 INFO - 'USER': 'cltbld', 21:14:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:14:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:14:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:55 INFO - 'XPC_FLAGS': '0x0', 21:14:55 INFO - 'XPC_SERVICE_NAME': '0', 21:14:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:14:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:14:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:14:56 INFO - Cleaning up... 21:14:56 INFO - Return code: 0 21:14:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:14: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')]} 21:14:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:14:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14: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')]} 21:14:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:14:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:56 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 0x107632a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076c7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5ab55b740>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107596d30>, '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 0x1072fbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10758eb20>, '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.3vqg7HU3aR/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.pQgtKZKc9G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/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 21:14:56 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 21:14:56 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 21:14:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3vqg7HU3aR/Render', 21:14:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:14:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:14:56 INFO - 'HOME': '/Users/cltbld', 21:14:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:14:56 INFO - 'LOGNAME': 'cltbld', 21:14:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:56 INFO - 'MOZ_NO_REMOTE': '1', 21:14:56 INFO - 'NO_EM_RESTART': '1', 21:14:56 INFO - 'PAGER': '/bin/cat', 21:14:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:14:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:56 INFO - 'PWD': '/builds/slave/test', 21:14:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:14:56 INFO - 'SHELL': '/bin/bash', 21:14:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pQgtKZKc9G/Listeners', 21:14:56 INFO - 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/', 21:14:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:14:56 INFO - 'USER': 'cltbld', 21:14:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:14:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:14:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:56 INFO - 'XPC_FLAGS': '0x0', 21:14:56 INFO - 'XPC_SERVICE_NAME': '0', 21:14:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:14:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:14:56 INFO - Downloading/unpacking blobuploader==1.2.4 21:14:56 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 21:14:56 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 21:14:56 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 21:14:56 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 21:14:56 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 21:14:56 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 21:14:58 INFO - Downloading blobuploader-1.2.4.tar.gz 21:14:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:14:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:14:58 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 21:14:58 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 21:14:58 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 21:14:58 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 21:14:58 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 21:14:58 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 21:14:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:14:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:14:59 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 21:14:59 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 21:14:59 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 21:14:59 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 21:14:59 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 21:14:59 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 21:14:59 INFO - Downloading docopt-0.6.1.tar.gz 21:14:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:15:00 INFO - Installing collected packages: blobuploader, requests, docopt 21:15:00 INFO - Running setup.py install for blobuploader 21:15:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:15:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:15:00 INFO - Running setup.py install for requests 21:15:00 INFO - Running setup.py install for docopt 21:15:00 INFO - Successfully installed blobuploader requests docopt 21:15:00 INFO - Cleaning up... 21:15:00 INFO - Return code: 0 21:15:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:15: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')]} 21:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:15:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:15: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')]} 21:15:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:15:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:15:00 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 0x107632a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076c7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5ab55b740>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107596d30>, '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 0x1072fbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10758eb20>, '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.3vqg7HU3aR/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.pQgtKZKc9G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/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 21:15:00 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 21:15:00 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 21:15:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3vqg7HU3aR/Render', 21:15:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:15:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:15:00 INFO - 'HOME': '/Users/cltbld', 21:15:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:15:00 INFO - 'LOGNAME': 'cltbld', 21:15:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:15:00 INFO - 'MOZ_NO_REMOTE': '1', 21:15:00 INFO - 'NO_EM_RESTART': '1', 21:15:00 INFO - 'PAGER': '/bin/cat', 21:15:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:15:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:15:00 INFO - 'PWD': '/builds/slave/test', 21:15:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:15:00 INFO - 'SHELL': '/bin/bash', 21:15:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pQgtKZKc9G/Listeners', 21:15:00 INFO - 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/', 21:15:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:15:00 INFO - 'USER': 'cltbld', 21:15:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:15:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:15:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:15:00 INFO - 'XPC_FLAGS': '0x0', 21:15:00 INFO - 'XPC_SERVICE_NAME': '0', 21:15:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:15:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:15:01 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-sPMHOi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:15:01 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-xprBWX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:15:01 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-AZ7x2D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:15:01 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-snbYaw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:15:01 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-kv0Qro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:15:01 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-aawObX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:15:01 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-eNcytA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:15:01 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-czQrML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:15:02 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-cxwV4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:15:02 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-shHuHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:15:02 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-CbTWOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:15:02 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-rBByAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:15:02 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-kl3Zs2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:15:02 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-235aiH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:15:02 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-1GMNC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:15:02 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-PyXnKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:15:02 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-vTVqEH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:15:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:15:02 INFO - Running setup.py install for manifestparser 21:15:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:15:03 INFO - Running setup.py install for mozcrash 21:15:03 INFO - Running setup.py install for mozdebug 21:15:03 INFO - Running setup.py install for mozdevice 21:15:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:15:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:15:03 INFO - Running setup.py install for mozfile 21:15:03 INFO - Running setup.py install for mozhttpd 21:15:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:15:03 INFO - Running setup.py install for mozinfo 21:15:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:15:03 INFO - Running setup.py install for mozInstall 21:15:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:15:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:15:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:15:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:15:04 INFO - Running setup.py install for mozleak 21:15:04 INFO - Running setup.py install for mozlog 21:15:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:15:04 INFO - Running setup.py install for moznetwork 21:15:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:15:04 INFO - Running setup.py install for mozprocess 21:15:04 INFO - Running setup.py install for mozprofile 21:15:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:15:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:15:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:15:04 INFO - Running setup.py install for mozrunner 21:15:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:15:05 INFO - Running setup.py install for mozscreenshot 21:15:05 INFO - Running setup.py install for moztest 21:15:05 INFO - Running setup.py install for mozversion 21:15:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:15:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:15:05 INFO - Cleaning up... 21:15:05 INFO - Return code: 0 21:15:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:15: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')]} 21:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:15:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:15: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')]} 21:15:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:15:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:15:05 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 0x107632a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076c7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5ab55b740>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107596d30>, '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 0x1072fbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10758eb20>, '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.3vqg7HU3aR/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.pQgtKZKc9G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/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 21:15:05 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 21:15:05 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 21:15:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3vqg7HU3aR/Render', 21:15:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:15:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:15:05 INFO - 'HOME': '/Users/cltbld', 21:15:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:15:05 INFO - 'LOGNAME': 'cltbld', 21:15:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:15:05 INFO - 'MOZ_NO_REMOTE': '1', 21:15:05 INFO - 'NO_EM_RESTART': '1', 21:15:05 INFO - 'PAGER': '/bin/cat', 21:15:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:15:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:15:05 INFO - 'PWD': '/builds/slave/test', 21:15:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:15:05 INFO - 'SHELL': '/bin/bash', 21:15:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pQgtKZKc9G/Listeners', 21:15:05 INFO - 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/', 21:15:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:15:05 INFO - 'USER': 'cltbld', 21:15:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:15:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:15:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:15:05 INFO - 'XPC_FLAGS': '0x0', 21:15:05 INFO - 'XPC_SERVICE_NAME': '0', 21:15:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:15:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:15:05 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-YDXvAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:15:05 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)) 21:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:15:05 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-PGm7sn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:15:05 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)) 21:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:15:06 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-F8eM4Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:15:06 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)) 21:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:15:06 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-l9dWZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:15:06 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)) 21:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:15:06 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-MZJLPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:15:06 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)) 21:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:15:06 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-tAzJTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:15:06 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)) 21:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:15:06 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-goAnbN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:15:06 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)) 21:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:15:06 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-93WRvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:15:06 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)) 21:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:15:06 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-pGuf4k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:15:06 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)) 21:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:15:06 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-OV42_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:15:06 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)) 21:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:15:06 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-dugF9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:15:06 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)) 21:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:15:06 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-FxK3bJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:15:07 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)) 21:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:15:07 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-lkvbd4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:15:07 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)) 21:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:15:07 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-4fsVMD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:15:07 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)) 21:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:15:07 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-OM3B93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:15:07 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)) 21:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:15:07 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-IxbOA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:15:07 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)) 21:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:15:07 INFO - Running setup.py (path:/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/pip-cNRqvx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:15:07 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)) 21:15:07 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)) 21:15:07 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)) 21:15:07 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)) 21:15:07 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)) 21:15:07 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)) 21:15:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:15:07 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 21:15:07 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 21:15:07 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 21:15:07 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 21:15:07 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 21:15:07 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 21:15:09 INFO - Downloading blessings-1.6.tar.gz 21:15:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:15:10 INFO - Installing collected packages: blessings 21:15:10 INFO - Running setup.py install for blessings 21:15:10 INFO - Successfully installed blessings 21:15:10 INFO - Cleaning up... 21:15:10 INFO - Return code: 0 21:15:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:15:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:15:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:15:10 INFO - Reading from file tmpfile_stdout 21:15:10 INFO - Current package versions: 21:15:10 INFO - blessings == 1.6 21:15:10 INFO - blobuploader == 1.2.4 21:15:10 INFO - docopt == 0.6.1 21:15:10 INFO - functools32 == 3.2.3-2 21:15:10 INFO - jsonschema == 2.5.1 21:15:10 INFO - manifestparser == 1.1 21:15:10 INFO - mozInstall == 1.12 21:15:10 INFO - mozcrash == 0.17 21:15:10 INFO - mozdebug == 0.1 21:15:10 INFO - mozdevice == 0.48 21:15:10 INFO - mozfile == 1.2 21:15:10 INFO - mozhttpd == 0.7 21:15:10 INFO - mozinfo == 0.9 21:15:10 INFO - mozleak == 0.1 21:15:10 INFO - mozlog == 3.3 21:15:10 INFO - moznetwork == 0.27 21:15:10 INFO - mozprocess == 0.23 21:15:10 INFO - mozprofile == 0.28 21:15:10 INFO - mozrunner == 6.12 21:15:10 INFO - mozscreenshot == 0.1 21:15:10 INFO - mozsystemmonitor == 0.3 21:15:10 INFO - moztest == 0.7 21:15:10 INFO - mozversion == 1.4 21:15:10 INFO - psutil == 3.1.1 21:15:10 INFO - requests == 1.2.3 21:15:10 INFO - wsgiref == 0.1.2 21:15:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:15:10 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')]} 21:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:15:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:15:10 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')]} 21:15:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:15:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:15:10 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 0x107632a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076c7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5ab55b740>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107596d30>, '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 0x1072fbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10758eb20>, '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.3vqg7HU3aR/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.pQgtKZKc9G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/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 21:15:10 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 21:15:10 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 21:15:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3vqg7HU3aR/Render', 21:15:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:15:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:15:10 INFO - 'HOME': '/Users/cltbld', 21:15:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:15:10 INFO - 'LOGNAME': 'cltbld', 21:15:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:15:10 INFO - 'MOZ_NO_REMOTE': '1', 21:15:10 INFO - 'NO_EM_RESTART': '1', 21:15:10 INFO - 'PAGER': '/bin/cat', 21:15:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:15:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:15:10 INFO - 'PWD': '/builds/slave/test', 21:15:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:15:10 INFO - 'SHELL': '/bin/bash', 21:15:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pQgtKZKc9G/Listeners', 21:15:10 INFO - 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/', 21:15:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:15:10 INFO - 'USER': 'cltbld', 21:15:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:15:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:15:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:15:10 INFO - 'XPC_FLAGS': '0x0', 21:15:10 INFO - 'XPC_SERVICE_NAME': '0', 21:15:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:15:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:15:10 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)) 21:15:10 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)) 21:15:10 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)) 21:15:10 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)) 21:15:10 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)) 21:15:10 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)) 21:15:10 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)) 21:15:10 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)) 21:15:10 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)) 21:15:10 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)) 21:15:10 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)) 21:15:10 INFO - Cleaning up... 21:15:10 INFO - Return code: 0 21:15:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:15:10 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')]} 21:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:15:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:15:10 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')]} 21:15:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:15:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:15:10 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 0x107632a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076c7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5ab55b740>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107596d30>, '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 0x1072fbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10758eb20>, '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.3vqg7HU3aR/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.pQgtKZKc9G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/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 21:15:10 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 21:15:10 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 21:15:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3vqg7HU3aR/Render', 21:15:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:15:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:15:10 INFO - 'HOME': '/Users/cltbld', 21:15:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:15:10 INFO - 'LOGNAME': 'cltbld', 21:15:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:15:10 INFO - 'MOZ_NO_REMOTE': '1', 21:15:10 INFO - 'NO_EM_RESTART': '1', 21:15:10 INFO - 'PAGER': '/bin/cat', 21:15:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:15:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:15:10 INFO - 'PWD': '/builds/slave/test', 21:15:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:15:10 INFO - 'SHELL': '/bin/bash', 21:15:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pQgtKZKc9G/Listeners', 21:15:10 INFO - 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/', 21:15:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:15:10 INFO - 'USER': 'cltbld', 21:15:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:15:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:15:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:15:10 INFO - 'XPC_FLAGS': '0x0', 21:15:10 INFO - 'XPC_SERVICE_NAME': '0', 21:15:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:15:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:15:11 INFO - Cleaning up... 21:15:11 INFO - Return code: 0 21:15:11 INFO - Running post-action listener: _resource_record_post_action 21:15:11 INFO - Running post-action listener: _start_resource_monitoring 21:15:11 INFO - Starting resource monitoring. 21:15:11 INFO - [mozharness: 2016-08-23 04:15:11.179875Z] Finished create-virtualenv step (success) 21:15:11 INFO - [mozharness: 2016-08-23 04:15:11.180874Z] Running install step. 21:15:11 INFO - Running pre-action listener: _resource_record_pre_action 21:15:11 INFO - Running main action method: install 21:15:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:15:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:15:11 INFO - Reading from file tmpfile_stdout 21:15:11 INFO - Detecting whether we're running mozinstall >=1.0... 21:15:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:15:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:15:11 INFO - Reading from file tmpfile_stdout 21:15:11 INFO - Output received: 21:15:11 INFO - Usage: mozinstall [options] installer 21:15:11 INFO - Options: 21:15:11 INFO - -h, --help show this help message and exit 21:15:11 INFO - -d DEST, --destination=DEST 21:15:11 INFO - Directory to install application into. [default: 21:15:11 INFO - "/builds/slave/test"] 21:15:11 INFO - --app=APP Application being installed. [default: firefox] 21:15:11 INFO - mkdir: /builds/slave/test/build/application 21:15:11 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'] 21:15:11 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 21:15:46 INFO - Reading from file tmpfile_stdout 21:15:46 INFO - Output received: 21:15:46 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 21:15:46 INFO - Running post-action listener: _resource_record_post_action 21:15:46 INFO - [mozharness: 2016-08-23 04:15:46.231846Z] Finished install step (success) 21:15:46 INFO - [mozharness: 2016-08-23 04:15:46.231975Z] Running run-tests step. 21:15:46 INFO - Running pre-action listener: _resource_record_pre_action 21:15:46 INFO - Running main action method: run_tests 21:15:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:15:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:15:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:15:46 INFO - 2016-08-22 21:15:46.246 screenresolution[1641:8091] starting screenresolution argv=screenresolution get 21:15:46 INFO - 2016-08-22 21:15:46.249 screenresolution[1641:8091] Display 0: 1600x1200x32@60 21:15:46 INFO - 2016-08-22 21:15:46.255 screenresolution[1642:8093] starting screenresolution argv=screenresolution list 21:15:46 INFO - Available Modes on Display 0 21:15:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:15:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:15:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:15:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:15:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:15:46 INFO - Intel Iris: 21:15:46 INFO - Chipset Model: Intel Iris 21:15:46 INFO - Type: GPU 21:15:46 INFO - Bus: Built-In 21:15:46 INFO - VRAM (Dynamic, Max): 1536 MB 21:15:46 INFO - Vendor: Intel (0x8086) 21:15:46 INFO - Device ID: 0x0a2e 21:15:46 INFO - Revision ID: 0x0009 21:15:46 INFO - Displays: 21:15:46 INFO - Display: 21:15:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:15:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:15:46 INFO - Display Serial Number: 1600x1200 60 21:15:46 INFO - Main Display: Yes 21:15:46 INFO - Mirror: Off 21:15:46 INFO - Online: Yes 21:15:46 INFO - Rotation: Supported 21:15:46 INFO - Return code: 0 21:15:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:15:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:15:46 INFO - Python 2.7.3 21:15:46 INFO - Return code: 0 21:15:46 INFO - grabbing minidump binary from tooltool 21:15:46 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')]} 21:15:46 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 0x107596d30>, '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 0x1072fbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10758eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:15:46 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 21:15:46 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 21:15:46 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 21:15:46 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:15:46 INFO - Return code: 0 21:15:46 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:15:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:15:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:15:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:15:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:15:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SO65-aCtQki5zmcYW7bS9w/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0372', '--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 21:15:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SO65-aCtQki5zmcYW7bS9w/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0372 --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 21:15:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3vqg7HU3aR/Render', 21:15:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:15:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:15:46 INFO - 'HOME': '/Users/cltbld', 21:15:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:15:46 INFO - 'LOGNAME': 'cltbld', 21:15:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:15:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:15:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:15:46 INFO - 'MOZ_NO_REMOTE': '1', 21:15:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:15:46 INFO - 'NO_EM_RESTART': '1', 21:15:46 INFO - 'PAGER': '/bin/cat', 21:15:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:15:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:15:46 INFO - 'PWD': '/builds/slave/test', 21:15:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:15:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:15:46 INFO - 'SHELL': '/bin/bash', 21:15:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pQgtKZKc9G/Listeners', 21:15:46 INFO - 'TMPDIR': '/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/', 21:15:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:15:46 INFO - 'USER': 'cltbld', 21:15:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:15:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:15:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:15:46 INFO - 'XPC_FLAGS': '0x0', 21:15:46 INFO - 'XPC_SERVICE_NAME': '0', 21:15:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:15:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SO65-aCtQki5zmcYW7bS9w/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0372', '--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 21:15:46 INFO - mozversion application_buildid: 20160822190716 21:15:46 INFO - mozversion application_changeset: d6d2cc94bb924a86a0b8476b0e6681fe2f211283 21:15:46 INFO - mozversion application_display_name: Nightly 21:15:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:15:46 INFO - mozversion application_name: Firefox 21:15:46 INFO - mozversion application_remotingname: firefox 21:15:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 21:15:46 INFO - mozversion application_vendor: Mozilla 21:15:46 INFO - mozversion application_version: 51.0a1 21:15:46 INFO - mozversion platform_buildid: 20160822190716 21:15:46 INFO - mozversion platform_changeset: d6d2cc94bb924a86a0b8476b0e6681fe2f211283 21:15:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 21:15:46 INFO - mozversion platform_version: 51.0a1 21:15:46 INFO - using testdate: 1471925746 21:15:46 INFO - actual date: 1471925746 21:15:46 INFO - starting webserver on 'localhost:49268' 21:15:46 INFO - SUITE-START | Running 2 tests 21:15:46 INFO - TEST-START | dromaeo_css 21:15:46 INFO - operating with platform_type : mac_ 21:15:46 INFO - Initialising browser for dromaeo_css test... 21:15:46 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/tmpB6yqga/profile http://localhost:49268/getInfo.html) 21:15:49 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 21:15:49 INFO - PROCESS | 1652 | colorDepth:24 21:15:49 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 21:15:49 INFO - PROCESS | 1652 | __metrics 21:15:49 ERROR - PROCESS | 1652 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2993: TypeError: this.tabs is undefined 21:15:50 INFO - TEST-INFO | 1652: exit 0 21:15:50 INFO - Browser initialized. 21:15:50 INFO - Running cycle 1/1 for dromaeo_css test... 21:15:50 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/tmpB6yqga/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:16:02 INFO - PROCESS | 1655 | RSS: Main: 239779840 21:16:02 INFO - PROCESS | 1655 | 21:16:51 INFO - PROCESS | 1655 | 1471925811812 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] 21:19:03 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49268/tests/dromaeo/cssquery-ext.html) 21:19:05 INFO - PROCESS | 1655 | RSS: Main: 255868928 21:19:05 INFO - PROCESS | 1655 | 21:22:07 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-ext.html (next: http://localhost:49268/tests/dromaeo/cssquery-jquery.html) 21:22:08 INFO - PROCESS | 1655 | RSS: Main: 264126464 21:22:08 INFO - PROCESS | 1655 | 21:25:10 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49268/tests/dromaeo/cssquery-mootools.html) 21:25:11 INFO - PROCESS | 1655 | RSS: Main: 268914688 21:25:11 INFO - PROCESS | 1655 | 21:28:13 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49268/tests/dromaeo/cssquery-prototype.html) 21:28:13 INFO - PROCESS | 1655 | RSS: Main: 273764352 21:28:13 INFO - PROCESS | 1655 | 21:31:16 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49268/tests/dromaeo/cssquery-yui.html) 21:31:17 INFO - PROCESS | 1655 | RSS: Main: 277204992 21:31:17 INFO - PROCESS | 1655 | 21:34:19 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-yui.html (next: http://localhost:49268/tests/dromaeo/cssquery-dojo.html) 21:34:20 INFO - PROCESS | 1655 | RSS: Main: 275271680 21:34:20 INFO - PROCESS | 1655 | 21:34:20 INFO - PROCESS | 1655 | __start_tp_report 21:34:20 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 21:34:20 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 21:34:20 INFO - PROCESS | 1655 | |i|pagename|runs| 21:34:20 INFO - PROCESS | 1655 | |0;dojo.html;2646.9470610587787;3398.8300584970743;3399.711024562912;3414.5902491701;3419.8461069251875;4703.835365762199;4983.903541220935;5736.082226843706;5786.363500014995;5831.446012628799;5769.682667453289;5797.1594118852745;5802.245708057946;5847.356790753014;5869.647821130725;4385.956140438587;5328.653637513549;5366.275552800381;5366.490183432587;5368.46315368462;5130.127878260686;5185.818496352628;5275.182346736262;5298.788048478056;5322.7072511011875;5282.524572788468;5293.126634105368;5302.44324345942;5320.733963301819;5335.1730481775;5305.336832895888;5322.946770532284;5330.813421530228;5348.866278343073;5352.598555108343;5076.060928728197;5177.689338639656;5202.895942081175;5270.341207349082;5284.128118860383;5642.915356269659;5773.364929857712;5787.826365209051;5807.245058142456;5826.970865145647;5084.79660813567;5482.068048431736;6306.684665766693;6322.399372059647;6331.176946996907;5200.713960732158;6194.5044396448175;6224.87550248997;6252.562320637558;6288.465480434169;5830.737616807254;5862;5866.061430171195;5900.7934722284945;5917.763289468459;5311.309529761106;5883.911741323884;6208;6301.684915754194;6319.684015799192;6024.457798798129;6092.664903430265;6121.602095863755;6188.504919606511;6224.688765561704;5275.340582427197;6155.569110162335;6239.532035097386;6242.563020588606;6306.810795676137;6207.286162091327;6237.844053898689;6265.373462653698;6272.2159730033745;6281.3404592518045;5126.743662816844;6207.720652570645;6220.409061139275;6293.559450838489;6324.620522768649;4972.900541989212;4982.227754698028;4991;4992.251162325608;5020.949790502122;4498.595126438636;4504.684672072924;4506.459224893034;4506.594406503365;4511.932321015187;5391.4608539145775;5853.970730146407;5879;5918.053111502139;6001.459868611846;6250.6874656267;6280.277768056732;6281.78013769525;6292.276388215322;6316.810495685137;5045.9747701261995;5232.822614911691;5955.225820643289;5978.103284507359;5995.190649262381;5349.705766182898;5429.701366424884;5461.453854614507;5469.56243500519;5531.087370583889;6453.967730161319;6455.548111632141;6462.838429039311;6473.676316184078;6474.870502589828;6279.497640188865;6283.057541368831;6298.937010629835;6311.810645680637;6320.968395157995;6196.380361963767;6262.279837818527;6265.310815810349;6271.62370257786;6464.482841372773;6228.34602366745;6232.968835155795;6243.687815609293;6249.50003999688;6262.968685156545;6225.750969961332;6254.781082662085;6255.556776520191;6264.937350626436;6265.906011409741;6037.577369584263;6106.6946652668075;6148.754049838135;6165.691715414301;6202.875942481215;6236.937630623817;6237.625742455467;6245.437910588069;6253.687315634109;6266.811995640138;4901.779419926041;4919.803207871788;5934.3175534814045;6015.909761353496;6129.662868542095;5984.611000284967;6112.541559383153;6150.876982460415;6190.442860142609;6212.130301757667;6126.509879209563;6127.84680382994;6130.816075517741;6135.263768347827;6138.324784273637 21:34:20 INFO - PROCESS | 1655 | |1;ext.html;484.67526757072756;523.2439125463704;523.8847453560217;543.2557396366977;572.9455701708341;37140.62859371406;39502.617408390746;39523.80238098809;39738;39741.40387894184;40671.79664101675;41111.383329250086;41171.794141029255;41323.966900827494;41472.377914331235;9482.905170948288;9682.983286754896;9685.22518198546;9712.320137590372;9734.707958761213;8104.797380065516;9699.951500242489;9735.318527703064;9738.220942324633;9742.318037737361;9737.415755054719;9762.707118786448;9765.365251258681;9772.462514561696;9780.413175209475;7963.960180199091;8238.258556729863;8327;8674.95900491942;9759.170470510015;8204.507729536188;9606.807863842683;9682.322237443383;9706.029397060238;9737.707868763948;38973.610263897564;39251;39310.410343844866;39403.605963940565;39408.211835763126;3144.0096369643716;3227.8386080696105;3424.400729872262;3552.413851714464;3599.2441587266444;26690.46619067627;30972.690273097207;31047.068587942398;31608.6293527984;31775.364492710018;3264.0860559043504;3278.606567211926;3285.785536159601;3300.405926933175;3335.449650807614;391450;489966;490886;491293.5435322836;491812;56764.33681453034;57007.71496142576;57053.71473142608;57067.85864282774;57100.42899570951;31494.527582086288;33904.660953390645;34530.13674658103;35892.10269743225;58821.70589147027;16244.431444899372;16429.424970125987;16434.424795132352;16450.75323870143;16499.340026398808;12483.188592741624;12603.306818125091;12637.2417654941;12652.240865548096;12669.239845609292;18684.53288667767;18689.90655046716;18743.062846857603;18754.09311556711;18783.530411739543;7765.922340776633;7866.960665196638;7898.2891539761695;7919.564423956623;7936.880946785803;874.1957399192758;920.8710780490736;942.2979879989451;970.0348153587225;989.0702739424918;25188.874055629603;26497.470050599266;28970.42059158847;30130.397392052473;30136.698633013828;1025.4462590201208;1036.533559898049;1054.0724162736897;1065.387402243713;1208.6434501821984;13741.587752367444;15049.172295523851;15578.399299179973;15595.688086238211;15951;599936;601557;602870;609727;612359;56762.7161864188;56819;57524.84950301054;57617.13574296389;57931;1144.6451600004025;1198.161287099034;1377.9173249605055;1398.3707331700775;1399.195462609004;29388.26529336698;29520.704792952656;29542.852285738434;30310.393792124476;30432.695673042985;48687.756561216964;49211.75394123006;49289.75355123202;49312.50687493079;49435.011299774524;425968.7403125929;491728.54135729093;528215;535588.3220583872;563551;22772.886135569217;25501.23496295114;26103.694815258783;26618.20145395641;26637.866810665822;34867.82566087153;42163.578364215966;42946.35580466233;43299;43994.34008489811;31942.40287985545;32743.526541305222;34993.30013399768;38010.23979520449;38240.426393603564;38161.940041092486;38371.505852119524;39003;39194.82415527539;40134.39798402968;36921.44617830681;37519.43720844135;37678.811605941795;38229.4265586022;38495;27271.318217044733;30371.2407189822;33704.494432583044;35308.64691353054;35381.584736610246;21641.02615382343;25208.873955630104;25672.743272567037;25803.225903222934;26046.609300860124 21:34:20 INFO - PROCESS | 1655 | |2;jquery.html;331.89379398592445;377.19092546487786;381.1861675323185;387.12123479701097;405.03197358313633;20045.1981920723;21127.366179014636;21532;21713.56572868542;22276.331710048686;20566.48583785406;20817.895910520463;21483.892580537075;21642.89178554109;21828.45428864279;5996.2504686914135;6031.819045428622;6066.211392518966;6096.207493025922;6203.441690247877;4245.851395201169;6142.662153581551;6187.6906154692315;6587.143671322721;6876.587404755705;6903.240643529208;6920.965395173017;6927.341902519278;6931.826704332407;6942.7917162484955;4975.751212439363;5765.365809760923;6027.67391173941;6067.120267561201;6094.360092190301;4557.997240607095;5145.845624631267;5518.834434966958;5521.171824226358;5988.461038506512;11888.643340699793;12110.455029523693;12215.083868709793;13256.867431325756;13437.395317210749;2279.806216471602;2351.71779386473;2405.524017794288;2493.35172855059;2811.9015834445695;10111.747206319827;10126.9493652532;10222.335548189418;10256.589736410535;13480.123791953492;1444.5377479206659;1814.7368631548484;1834.4680042787575;1835.183343412182;1896.0898768591017;76234.61882690607;117887;129236;131889;132486;9877.209823214125;11139.665810025712;11413.258138221156;11680.70798230051;11825.822612660817;13343.26612036328;13783.690549397792;14633.487827925972;14651.853481465261;14664.706705866036;6875.312468753084;6904.758333458405;6927.272636373108;6966.989786480932;7534.133574638987;7628.160902300742;8007.239312265326;8045.752908299223;8539.316854651614;8684.8697269541;4388.836958206078;4423.380726698265;4547.818087276538;4562.88592785183;4577.1074640444795;1661.310556119197;1738.2959901240017;1786.499780061585;1887.3865993551876;1918.213532451688;910.913463220993;913.0777914306598;984.3177341743834;993.5181437003048;1030.4641586375044;20322.695159572617;21682.56634867294;21839.890800545894;21863.672044919338;21954;910.9089091090838;943.9244860411151;953.1659797677032;962.1581116523042;986.888059552558;9340.4862732549;11399.97400233983;11597.420128993517;11612.361320127306;11851.992580630744;476669;482600;484049;589519;590140;140708;143474;143633.28183359225;146839;148307;889.4174315823146;984.6356847966298;1000.0899181744578;1036.6164519127972;1037.201354956679;17430.30278788885;18721;19105.522361941064;20485.590288193853;20730.06714697812;48621.51378486311;54290.728546357015;55143.31281841089;55280.17079743727;56675.71662141663;75520.62239688766;84648;86854.56572717096;88365.3087650891;88565.55717221372;6770.8645827084165;7921.485103468256;7950.204979502235;8085.110637829716;8166.714165004197;10972.835407468734;11618;12921.806172907602;13248.933755331162;13302.334883255991;11100.11199104086;11227.101831853268;11230.887691122984;11382.37396943143;11401.657950261506;10999.450027498433;11259.774804504028;11279;11366.374849383363;11611.361375124448;10710.693350907097;11252.66242012741;11302.321860688386;11570;11795.29228246308;7984.401169912164;8178.959105204436;8237.929069221203;8311.501309921425;8398.286145677686;8293.502389856629;10986.615468458565;11093.5562577496;11259.98660120593;11575.13186511032 21:34:20 INFO - PROCESS | 1655 | |3;mootools.html;1505.1119839294813;1529.533492284853;1673.2470388325257;1730.6452177303654;1881.680114380555;7803.648835802388;7959.602019899004;8483.872741908875;8946.91053089469;8971.506567138806;8617.65529378824;8812.60343284552;8816.647334106645;8825.205731484166;8852.203301702846;2376.7979721723673;2397.340731298898;2402.1712509184304;2404.1825779235055;2406.723226828911;2359.728631207416;2368.6210206366986;2405.6992875890514;2408.205292253561;2409.1688367513266;2174.1738139506965;2254.9323520294415;2390.95218095638;2399.4121440247163;2403;2362.2795047510504;2376.512814872947;2377.4413012941945;2390.5935990881594;2400.1239547565015;2373.133806160756;2374.228375777862;2375.2517956843712;2378.6550950112137;2390.1873363056643;8745.518996455192;8926.37515373924;8932.955335223347;8933.910660893438;8938;5258.6318957672975;5344.599155063386;5379.81170659029;5394.838154855361;5395.406505284454;3472.131967008248;3574.3566158091535;3669.954063092033;3744.1388480649603;3761.247750449921;1115.6429942418429;1119.0488085127577;1123.7303047268679;1128.6388355726172;1131.2590253384046;9935.900640993643;10027.54876030573;11710.063194944383;11746.412679365998;11779.057675385948;4349.652027837828;4357.237483440449;4467.664925130628;4649.256119021008;4665.580097791215;7719.536827790351;9236.214921731727;9253;9263.073692630684;9273.35086543949;4489.932651010237;5257.526822585985;5259.710715910585;5260.500252476008;5273.578113750891;4396.230659634552;4745.2882067690125;4845.6608037437745;4881.8535443936735;4930.309756634074;3206.7113959743733;3285.8521366538084;3747.269282489888;3862.903427414281;3892.4355968384425;1179.5340840368006;1196.252342286071;1198.6224339333082;1206.4390058622782;1206.7072562131843;799.4683535448978;917.7017469322496;934.7990182110879;948.6774496671165;959.2469911119738;4766.928496072562;5255.106631872591;5709.400512946164;5923.378045305181;6190.380961903774;450.24134333647254;455.59679683480357;459.8344595945457;468.05920100597365;468.7445342288461;4012.8996775080273;4042.6159514846045;4074.5110586729784;4155.168966206771;4230.703850730481;10286.27996040285;10753.51609177589;10801.78396432067;10823;10856.837147442795;10757.892421075845;10779.892201078046;10787.6224332148;10787.730306742395;10788.568457261621;6930;7670.309672129647;8222.547759873265;8292.58537073144;8297.917020829715;5151.433342332415;5384.380796208487;5936.703164841827;6215.502759779117;6253;9795.265355098538;9819.9018009819;9872.308938374244;10012.19902407791;10051.949740251252;10114.696559103239;10159.746006349606;10189.337693050225;10207;10334.896651033394;6865.725370985105;7314.049173607397;7556.1310449299035;7666.846663066819;7677.424193185422;8283.254507094149;8507.95746021266;8556.529390883561;8561;8562.957185214034;7490.812729681802;7630.961845190738;7644.273793989562;7714.922850771421;7777.650005749868;7434.545083984104;7461.888071678821;7511.549307041595;7607.733729319447;7685.346745526693;6932.306769323028;7060.223375428802;7076.398506127037;7081.327273908971;7084;5007.649464537448;5040.5967522597375;5158.845234642967;5222.2688823565495;5225.869353266199;5097.439281678938;5119.104156772624;5168.819091331786;5212.139996900621;5325.467453254799 21:34:20 INFO - PROCESS | 1655 | |4;prototype.html;276.3616046931588;293.0914166085136;312.5218415823789;313.3388550159165;314.52977798191694;4746.670932138998;5404.810831620894;5636.0982242841155;5671.971640141799;5734.569907256957;5103.7703303351345;5283.313169287997;5530.5299049580835;5573.777048918048;5633.338165241254;3526.382882995478;3890.1830615570766;4256.25515534781;4277.957220427803;4303.311470164775;3164.528494250173;4134.193832202722;4181.519125300584;4304.97666096934;4312.654987601;3550.5206797082324;3655.469956856254;4078.8572399966006;4094.9590504094876;4160.646345060673;4164.416981622575;4202.6847986400835;4208.957910420887;4209.915801683949;4230.344296634026;3450.6376830432696;3639.0538460000325;3639.7452178347526;3641.8907432776796;3644.21649345392;5309.389420216686;5373.355197376301;5399.865003374908;5403.972980135113;5404.513923595151;4705.200115980291;4710.952890471086;4769.3799806025345;4775.5463230993;4795.386514349688;5513.58648101394;5774.249347584829;5778.508826749689;5791.407362975174;5836.5914385993;3640.5801737322467;3909.3354129798004;3968.2460332537016;3968.4047392891007;3970.027343300881;4770.761461926924;5363.517283444469;5632.183333416631;6152.507799376039;6214.130021796952;3693.7045036397026;4025.81883815229;4026.8187931543152;4028.3756017817286;4035.6771458283265;3243.318903030343;4009.4787677602308;4048.1296521248073;4050.8177132029127;4094.815733292009;4722.362481065081;4747.264174053027;4749.596284315872;4751.95248047522;4764.857054288377;5206.817761378409;5869.501092407193;5909.261342332208;5997.220361352996;6000.549958753111;1116.5757012335423;1181.7518321152481;1283.5250957145915;1343.5834891183765;1373.2515778900324;892.8258989497116;900.7611383138554;912.2565109435789;916.9037251088673;929.0152438415302;4784.832530861403;4791.95208047922;5108.927125303728;5476.780928762884;5546.750396232179;4843.418789745253;6031.517478601701;6033.276006879202;6043.2748070231855;6066.75732970685;5273.367195936512;5467.020473841766;5549.694766787785;5561.6663000220115;5569.443055694398;2528.608065749812;2617.345663584104;2685.0602289198623;2708.334374359794;2720.2655283073855;4757.35775670287;5292.877202450496;5299.549538289211;5368.651037682538;5378.731063446812;4685.742284174403;4726.740029298421;4931.778069986859;5033.723145226974;5182.046233646861;4691.624670026458;5198.740062996835;5202.502798656666;5251.372074656869;5272.657277276965;4522.050369422458;5018.899622007612;5091.59267258611;5114.391660253224;5147.716875571879;5053.3071421074355;5372.355317361941;5505.421930697219;6097.908531371944;6112.938870611415;5606.327240731139;6253.37466253371;6408.551401401857;6421.839454013687;6456.257530384066;3258;3852.3065848147603;4040.7271709411443;4043.7169398141846;4064.7764372958586;5514.283143191359;5629.493345598916;5879.764809407576;5950.19672344228;6032.245969253843;4971.676841005323;5003.54968052877;5607.682194684327;5732.656040637575;5943.928409039821;5117.5650069743;5794.01501744696;5916.881662366814;5954.46409823118;5966;4541.704789188692;5594.692291923983;5626.2967129108865;5777.711114444345;5814.82555523318;5303.893922121459;5824.737886795189;5828.825135245949;5856.385079566584;5857.355690873916;5595.692236927008;5712.314522257356;5807.8548036299435;5840.649561026352;5856.238688970407 21:34:20 INFO - PROCESS | 1655 | |5;yui.html;632.2002666626718;773.3117525402392;777.4518964130289;796.6733639207924;811.2617518058568;15087.170205638686;16063.919680401581;16224.837751622481;16235.269412876434;16257.34970601176;14309.928450357733;14362.01839226258;14659;14856.33146508407;14876.553703388889;669.8526324208666;716.2407847681475;752.8932469270192;825.3479750996705;873.1137895036511;673.5588189735706;809.4212637963855;838.656150978099;844.8099177685002;866.5883705240024;901.4636291406603;902.5532361481077;902.7562558109306;903.2773780975193;905.3526728389201;769.0771074710342;881.8544940084911;893.9642414303485;895.6551727584927;896.7847716548014;656.8554917918051;664.0935123556311;664.6112024465693;664.6875968294942;664.833791552112;14584.562463126123;14709.338079786436;14726.852731472656;14736.115833049944;14740.189289589069;12144.453499592539;14599.78100328496;14646.780298295535;14653.12081275127;14974.251287435694;11914.940425297818;11955.342456164908;11989.820152697717;12003.519859205622;12143.757124857542;3834.1373191032076;3844.1735026969336;3859.36320507116;3874.767513949172;3994.201159768058;122005.38997305045;122069;122740.38629806794;123145;123378;11132.888671113185;11183.049440797624;11212.327260364404;11401.600943966921;11734.70663233409;20994.055267513;22904.656430153227;22933.312000640006;22964.4258893529;22995.770042299697;7665.080190377079;8140.0638926523025;8279.130691277329;8463.984321881291;8502.022267439324;4119.382092686061;4557.521460246693;4633.976830115896;4672.602828759594;4800.975995120002;3529.4529347951107;3588.784672919633;3635.4546817976984;3640.4903313536124;3647.0882279430143;602.7378090530633;657.4575974820792;668.4829096806346;673.1114928294702;675.3381685947799;549.7471163264943;576.1156624581248;666.8399584099781;669.6618207805125;682.3483573187594;9432.892813460176;9551.379160354554;9712.562934667956;9782.217422606174;9840.507974601242;633.9809805705836;661.2527843536773;677.5629718831425;679.0900193740313;701.8561194955022;4404.955950440519;4742.857714268577;4775.403074615673;4778.187708089633;4784.712917224908;93830.53084734669;117566.41216793862;150807;156198.2190089065;163221;125197;125606.37196814141;127804.72195278114;132672;132843.33578332048;100804.49597751965;104236;109082.99999999841;110557.44721276342;111518.44240778744;9090.318226132935;9113.270938325051;9147.222486088756;9151;9211.953940230256;62106.09992050748;64734.676326618064;64840;64951;65431.345686542525;94617.05382946083;96378;96777.03222967962;96835;96949;8942;9954;10619.292080519419;12077.51689932393;12084.214526055779;12969.481220751442;13020.088593798344;13032.739345213233;13081.149725268207;13431.992600554802;9879.06148915852;12167.634970950532;12216.816747748968;12239.388030598613;12694.492220311453;12175.878241217828;12215.938920305342;12225.44985475638;12344.259344439002;12420.937895310826;11995.220310679779;12101.515939362327;12169.878301217228;12538.686532836751;12564.246145231315;8498.447600905922;9475.431474111576;9966.700998970042;10356.067953883885;10475.633352832614;10076.69769906904;10573;10619.893801061891;10625.203109766644;10651.360918344924 21:34:20 INFO - PROCESS | 1655 | __end_tp_report 21:34:20 INFO - PROCESS | 1655 | __start_cc_report 21:34:20 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,420 21:34:20 INFO - PROCESS | 1655 | __end_cc_report 21:34:20 INFO - PROCESS | 1655 | __startTimestamp1471926860036__endTimestamp 21:34:20 INFO - PROCESS | 1655 | 21:34:20 INFO - PROCESS | 1655 | ------- Summary: start ------- 21:34:20 INFO - PROCESS | 1655 | Number of tests: 6 21:34:20 INFO - PROCESS | 1655 | 21:34:20 INFO - PROCESS | 1655 | [#0] dojo.html Cycles:165 Average:5734.27 Median:5978.10 stddev:680.05 (11.4%) stddev-sans-first:637.55 21:34:20 INFO - PROCESS | 1655 | Values: 2646.9 3398.8 3399.7 3414.6 3419.8 4703.8 4983.9 5736.1 5786.4 5831.4 5769.7 5797.2 5802.2 5847.4 5869.6 4386.0 5328.7 5366.3 5366.5 5368.5 5130.1 5185.8 5275.2 5298.8 5322.7 5282.5 5293.1 5302.4 5320.7 5335.2 5305.3 5322.9 5330.8 5348.9 5352.6 5076.1 5177.7 5202.9 5270.3 5284.1 5642.9 5773.4 5787.8 5807.2 5827.0 5084.8 5482.1 6306.7 6322.4 6331.2 5200.7 6194.5 6224.9 6252.6 6288.5 5830.7 5862.0 5866.1 5900.8 5917.8 5311.3 5883.9 6208.0 6301.7 6319.7 6024.5 6092.7 6121.6 6188.5 6224.7 5275.3 6155.6 6239.5 6242.6 6306.8 6207.3 6237.8 6265.4 6272.2 6281.3 5126.7 6207.7 6220.4 6293.6 6324.6 4972.9 4982.2 4991.0 4992.3 5020.9 4498.6 4504.7 4506.5 4506.6 4511.9 5391.5 5854.0 5879.0 5918.1 6001.5 6250.7 6280.3 6281.8 6292.3 6316.8 5046.0 5232.8 5955.2 5978.1 5995.2 5349.7 5429.7 5461.5 5469.6 5531.1 6454.0 6455.5 6462.8 6473.7 6474.9 6279.5 6283.1 6298.9 6311.8 6321.0 6196.4 6262.3 6265.3 6271.6 6464.5 6228.3 6233.0 6243.7 6249.5 6263.0 6225.8 6254.8 6255.6 6264.9 6265.9 6037.6 6106.7 6148.8 6165.7 6202.9 6236.9 6237.6 6245.4 6253.7 6266.8 4901.8 4919.8 5934.3 6015.9 6129.7 5984.6 6112.5 6150.9 6190.4 6212.1 6126.5 6127.8 6130.8 6135.3 6138.3 21:34:20 INFO - PROCESS | 1655 | 21:34:20 INFO - PROCESS | 1655 | [#1] ext.html Cycles:180 Average:65560.08 Median:215322.41 stddev:142235.04 (66.1%) stddev-sans-first:142550.13 21:34:20 INFO - PROCESS | 1655 | Values: 484.7 523.2 523.9 543.3 572.9 37140.6 39502.6 39523.8 39738.0 39741.4 40671.8 41111.4 41171.8 41324.0 41472.4 9482.9 9683.0 9685.2 9712.3 9734.7 8104.8 9700.0 9735.3 9738.2 9742.3 9737.4 9762.7 9765.4 9772.5 9780.4 7964.0 8238.3 8327.0 8675.0 9759.2 8204.5 9606.8 9682.3 9706.0 9737.7 38973.6 39251.0 39310.4 39403.6 39408.2 3144.0 3227.8 3424.4 3552.4 3599.2 26690.5 30972.7 31047.1 31608.6 31775.4 3264.1 3278.6 3285.8 3300.4 3335.4 391450.0 489966.0 490886.0 491293.5 491812.0 56764.3 57007.7 57053.7 57067.9 57100.4 31494.5 33904.7 34530.1 35892.1 58821.7 16244.4 16429.4 16434.4 16450.8 16499.3 12483.2 12603.3 12637.2 12652.2 12669.2 18684.5 18689.9 18743.1 18754.1 18783.5 7765.9 7867.0 7898.3 7919.6 7936.9 874.2 920.9 942.3 970.0 989.1 25188.9 26497.5 28970.4 30130.4 30136.7 1025.4 1036.5 1054.1 1065.4 1208.6 13741.6 15049.2 15578.4 15595.7 15951.0 599936.0 601557.0 602870.0 609727.0 612359.0 56762.7 56819.0 57524.8 57617.1 57931.0 1144.6 1198.2 1377.9 1398.4 1399.2 29388.3 29520.7 29542.9 30310.4 30432.7 48687.8 49211.8 49289.8 49312.5 49435.0 425968.7 491728.5 528215.0 535588.3 563551.0 22772.9 25501.2 26103.7 26618.2 26637.9 34867.8 42163.6 42946.4 43299.0 43994.3 31942.4 32743.5 34993.3 38010.2 38240.4 38161.9 38371.5 39003.0 39194.8 40134.4 36921.4 37519.4 37678.8 38229.4 38495.0 27271.3 30371.2 33704.5 35308.6 35381.6 21641.0 25208.9 25672.7 25803.2 26046.6 21:34:20 INFO - PROCESS | 1655 | 21:34:20 INFO - PROCESS | 1655 | [#2] jquery.html Cycles:180 Average:33363.39 Median:2315.76 stddev:89519.16 (3865.6%) stddev-sans-first:89735.93 21:34:20 INFO - PROCESS | 1655 | Values: 331.9 377.2 381.2 387.1 405.0 20045.2 21127.4 21532.0 21713.6 22276.3 20566.5 20817.9 21483.9 21642.9 21828.5 5996.3 6031.8 6066.2 6096.2 6203.4 4245.9 6142.7 6187.7 6587.1 6876.6 6903.2 6921.0 6927.3 6931.8 6942.8 4975.8 5765.4 6027.7 6067.1 6094.4 4558.0 5145.8 5518.8 5521.2 5988.5 11888.6 12110.5 12215.1 13256.9 13437.4 2279.8 2351.7 2405.5 2493.4 2811.9 10111.7 10126.9 10222.3 10256.6 13480.1 1444.5 1814.7 1834.5 1835.2 1896.1 76234.6 117887.0 129236.0 131889.0 132486.0 9877.2 11139.7 11413.3 11680.7 11825.8 13343.3 13783.7 14633.5 14651.9 14664.7 6875.3 6904.8 6927.3 6967.0 7534.1 7628.2 8007.2 8045.8 8539.3 8684.9 4388.8 4423.4 4547.8 4562.9 4577.1 1661.3 1738.3 1786.5 1887.4 1918.2 910.9 913.1 984.3 993.5 1030.5 20322.7 21682.6 21839.9 21863.7 21954.0 910.9 943.9 953.2 962.2 986.9 9340.5 11400.0 11597.4 11612.4 11852.0 476669.0 482600.0 484049.0 589519.0 590140.0 140708.0 143474.0 143633.3 146839.0 148307.0 889.4 984.6 1000.1 1036.6 1037.2 17430.3 18721.0 19105.5 20485.6 20730.1 48621.5 54290.7 55143.3 55280.2 56675.7 75520.6 84648.0 86854.6 88365.3 88565.6 6770.9 7921.5 7950.2 8085.1 8166.7 10972.8 11618.0 12921.8 13248.9 13302.3 11100.1 11227.1 11230.9 11382.4 11401.7 10999.5 11259.8 11279.0 11366.4 11611.4 10710.7 11252.7 11302.3 11570.0 11795.3 7984.4 8179.0 8237.9 8311.5 8398.3 8293.5 10986.6 11093.6 11260.0 11575.1 21:34:20 INFO - PROCESS | 1655 | 21:34:20 INFO - PROCESS | 1655 | [#3] mootools.html Cycles:180 Average:5658.33 Median:4863.76 stddev:3170.90 (65.2%) stddev-sans-first:3164.44 21:34:20 INFO - PROCESS | 1655 | Values: 1505.1 1529.5 1673.2 1730.6 1881.7 7803.6 7959.6 8483.9 8946.9 8971.5 8617.7 8812.6 8816.6 8825.2 8852.2 2376.8 2397.3 2402.2 2404.2 2406.7 2359.7 2368.6 2405.7 2408.2 2409.2 2174.2 2254.9 2391.0 2399.4 2403.0 2362.3 2376.5 2377.4 2390.6 2400.1 2373.1 2374.2 2375.3 2378.7 2390.2 8745.5 8926.4 8933.0 8933.9 8938.0 5258.6 5344.6 5379.8 5394.8 5395.4 3472.1 3574.4 3670.0 3744.1 3761.2 1115.6 1119.0 1123.7 1128.6 1131.3 9935.9 10027.5 11710.1 11746.4 11779.1 4349.7 4357.2 4467.7 4649.3 4665.6 7719.5 9236.2 9253.0 9263.1 9273.4 4489.9 5257.5 5259.7 5260.5 5273.6 4396.2 4745.3 4845.7 4881.9 4930.3 3206.7 3285.9 3747.3 3862.9 3892.4 1179.5 1196.3 1198.6 1206.4 1206.7 799.5 917.7 934.8 948.7 959.2 4766.9 5255.1 5709.4 5923.4 6190.4 450.2 455.6 459.8 468.1 468.7 4012.9 4042.6 4074.5 4155.2 4230.7 10286.3 10753.5 10801.8 10823.0 10856.8 10757.9 10779.9 10787.6 10787.7 10788.6 6930.0 7670.3 8222.5 8292.6 8297.9 5151.4 5384.4 5936.7 6215.5 6253.0 9795.3 9819.9 9872.3 10012.2 10051.9 10114.7 10159.7 10189.3 10207.0 10334.9 6865.7 7314.0 7556.1 7666.8 7677.4 8283.3 8508.0 8556.5 8561.0 8563.0 7490.8 7631.0 7644.3 7714.9 7777.7 7434.5 7461.9 7511.5 7607.7 7685.3 6932.3 7060.2 7076.4 7081.3 7084.0 5007.6 5040.6 5158.8 5222.3 5225.9 5097.4 5119.1 5168.8 5212.1 5325.5 21:34:20 INFO - PROCESS | 1655 | 21:34:20 INFO - PROCESS | 1655 | [#4] prototype.html Cycles:180 Average:4608.28 Median:5115.98 stddev:1434.51 (28.0%) stddev-sans-first:1401.20 21:34:20 INFO - PROCESS | 1655 | Values: 276.4 293.1 312.5 313.3 314.5 4746.7 5404.8 5636.1 5672.0 5734.6 5103.8 5283.3 5530.5 5573.8 5633.3 3526.4 3890.2 4256.3 4278.0 4303.3 3164.5 4134.2 4181.5 4305.0 4312.7 3550.5 3655.5 4078.9 4095.0 4160.6 4164.4 4202.7 4209.0 4209.9 4230.3 3450.6 3639.1 3639.7 3641.9 3644.2 5309.4 5373.4 5399.9 5404.0 5404.5 4705.2 4711.0 4769.4 4775.5 4795.4 5513.6 5774.2 5778.5 5791.4 5836.6 3640.6 3909.3 3968.2 3968.4 3970.0 4770.8 5363.5 5632.2 6152.5 6214.1 3693.7 4025.8 4026.8 4028.4 4035.7 3243.3 4009.5 4048.1 4050.8 4094.8 4722.4 4747.3 4749.6 4752.0 4764.9 5206.8 5869.5 5909.3 5997.2 6000.5 1116.6 1181.8 1283.5 1343.6 1373.3 892.8 900.8 912.3 916.9 929.0 4784.8 4792.0 5108.9 5476.8 5546.8 4843.4 6031.5 6033.3 6043.3 6066.8 5273.4 5467.0 5549.7 5561.7 5569.4 2528.6 2617.3 2685.1 2708.3 2720.3 4757.4 5292.9 5299.5 5368.7 5378.7 4685.7 4726.7 4931.8 5033.7 5182.0 4691.6 5198.7 5202.5 5251.4 5272.7 4522.1 5018.9 5091.6 5114.4 5147.7 5053.3 5372.4 5505.4 6097.9 6112.9 5606.3 6253.4 6408.6 6421.8 6456.3 3258.0 3852.3 4040.7 4043.7 4064.8 5514.3 5629.5 5879.8 5950.2 6032.2 4971.7 5003.5 5607.7 5732.7 5943.9 5117.6 5794.0 5916.9 5954.5 5966.0 4541.7 5594.7 5626.3 5777.7 5814.8 5303.9 5824.7 5828.8 5856.4 5857.4 5595.7 5712.3 5807.9 5840.6 5856.2 21:34:20 INFO - PROCESS | 1655 | 21:34:20 INFO - PROCESS | 1655 | [#5] yui.html Cycles:180 Average:24781.68 Median:3867.07 stddev:39796.67 (1029.1%) stddev-sans-first:39867.01 21:34:20 INFO - PROCESS | 1655 | Values: 632.2 773.3 777.5 796.7 811.3 15087.2 16063.9 16224.8 16235.3 16257.3 14309.9 14362.0 14659.0 14856.3 14876.6 669.9 716.2 752.9 825.3 873.1 673.6 809.4 838.7 844.8 866.6 901.5 902.6 902.8 903.3 905.4 769.1 881.9 894.0 895.7 896.8 656.9 664.1 664.6 664.7 664.8 14584.6 14709.3 14726.9 14736.1 14740.2 12144.5 14599.8 14646.8 14653.1 14974.3 11914.9 11955.3 11989.8 12003.5 12143.8 3834.1 3844.2 3859.4 3874.8 3994.2 122005.4 122069.0 122740.4 123145.0 123378.0 11132.9 11183.0 11212.3 11401.6 11734.7 20994.1 22904.7 22933.3 22964.4 22995.8 7665.1 8140.1 8279.1 8464.0 8502.0 4119.4 4557.5 4634.0 4672.6 4801.0 3529.5 3588.8 3635.5 3640.5 3647.1 602.7 657.5 668.5 673.1 675.3 549.7 576.1 666.8 669.7 682.3 9432.9 9551.4 9712.6 9782.2 9840.5 634.0 661.3 677.6 679.1 701.9 4405.0 4742.9 4775.4 4778.2 4784.7 93830.5 117566.4 150807.0 156198.2 163221.0 125197.0 125606.4 127804.7 132672.0 132843.3 100804.5 104236.0 109083.0 110557.4 111518.4 9090.3 9113.3 9147.2 9151.0 9212.0 62106.1 64734.7 64840.0 64951.0 65431.3 94617.1 96378.0 96777.0 96835.0 96949.0 8942.0 9954.0 10619.3 12077.5 12084.2 12969.5 13020.1 13032.7 13081.1 13432.0 9879.1 12167.6 12216.8 12239.4 12694.5 12175.9 12215.9 12225.4 12344.3 12420.9 11995.2 12101.5 12169.9 12538.7 12564.2 8498.4 9475.4 9966.7 10356.1 10475.6 10076.7 10573.0 10619.9 10625.2 10651.4 21:34:20 INFO - PROCESS | 1655 | -------- Summary: end -------- 21:34:20 INFO - PROCESS | 1655 | 21:34:20 INFO - TEST-INFO | 1655: exit 0 21:34:20 INFO - TEST-OK | dromaeo_css | took 1113802ms 21:34:20 INFO - TEST-START | kraken 21:34:20 INFO - operating with platform_type : mac_ 21:34:20 INFO - Initialising browser for kraken test... 21:34:20 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/tmptxPER3/profile http://localhost:49268/getInfo.html) 21:34:23 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 21:34:23 INFO - PROCESS | 1663 | colorDepth:24 21:34:23 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 21:34:23 INFO - PROCESS | 1663 | __metrics 21:34:23 ERROR - PROCESS | 1663 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2993: TypeError: this.tabs is undefined 21:34:24 INFO - TEST-INFO | 1663: exit 0 21:34:24 INFO - Browser initialized. 21:34:24 INFO - Running cycle 1/1 for kraken test... 21:34:24 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/T/tmptxPER3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:34:36 INFO - PROCESS | 1665 | RSS: Main: 239849472 21:34:36 INFO - PROCESS | 1665 | 21:34:39 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-beat-detection) 21:34:40 INFO - PROCESS | 1665 | RSS: Main: 252891136 21:34:40 INFO - PROCESS | 1665 | 21:34:43 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-dft) 21:34:43 INFO - PROCESS | 1665 | RSS: Main: 261562368 21:34:43 INFO - PROCESS | 1665 | 21:34:47 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-fft) 21:34:48 INFO - PROCESS | 1665 | RSS: Main: 264454144 21:34:48 INFO - PROCESS | 1665 | 21:34:50 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-oscillator) 21:34:51 INFO - PROCESS | 1665 | RSS: Main: 265756672 21:34:51 INFO - PROCESS | 1665 | 21:34:53 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:34:53 INFO - PROCESS | 1665 | RSS: Main: 266797056 21:34:53 INFO - PROCESS | 1665 | 21:34:57 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-darkroom) 21:34:57 INFO - PROCESS | 1665 | RSS: Main: 266461184 21:34:57 INFO - PROCESS | 1665 | 21:35:00 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-desaturate) 21:35:01 INFO - PROCESS | 1665 | RSS: Main: 266657792 21:35:01 INFO - PROCESS | 1665 | 21:35:04 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49268/tests/kraken/driver.html?testName=json-parse-financial) 21:35:05 INFO - PROCESS | 1665 | RSS: Main: 267898880 21:35:05 INFO - PROCESS | 1665 | 21:35:06 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49268/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:35:07 INFO - PROCESS | 1665 | RSS: Main: 268201984 21:35:07 INFO - PROCESS | 1665 | 21:35:09 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:35:09 INFO - PROCESS | 1665 | RSS: Main: 267825152 21:35:09 INFO - PROCESS | 1665 | 21:35:12 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:35:12 INFO - PROCESS | 1665 | RSS: Main: 268619776 21:35:12 INFO - PROCESS | 1665 | 21:35:15 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:35:16 INFO - PROCESS | 1665 | RSS: Main: 268779520 21:35:16 INFO - PROCESS | 1665 | 21:35:19 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:35:20 INFO - PROCESS | 1665 | RSS: Main: 268795904 21:35:20 INFO - PROCESS | 1665 | 21:35:22 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49268/tests/kraken/driver.html?testName=ai-astar) 21:35:22 INFO - PROCESS | 1665 | RSS: Main: 271540224 21:35:22 INFO - PROCESS | 1665 | 21:35:22 INFO - PROCESS | 1665 | __start_tp_report 21:35:22 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 21:35:22 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 21:35:22 INFO - PROCESS | 1665 | |i|pagename|runs| 21:35:22 INFO - PROCESS | 1665 | |0;ai-astar;104;119;112;119;120;118;130;175;117;117 21:35:22 INFO - PROCESS | 1665 | |1;audio-beat-detection;140;110;168;195;144;138;130;114;153;128 21:35:22 INFO - PROCESS | 1665 | |2;audio-dft;216;262;269;259;207;277;199;253;277;256 21:35:22 INFO - PROCESS | 1665 | |3;audio-fft;70;87;76;141;50;70;82;91;131;75 21:35:22 INFO - PROCESS | 1665 | |4;audio-oscillator;69;76;156;102;59;82;136;102;92;115 21:35:22 INFO - PROCESS | 1665 | |5;imaging-gaussian-blur;135;77;137;130;89;106;122;131;112;86 21:35:22 INFO - PROCESS | 1665 | |6;imaging-darkroom;95;95;95;99;153;120;97;97;94;104 21:35:22 INFO - PROCESS | 1665 | |7;imaging-desaturate;89;91;95;147;100;84;151;147;103;148 21:35:22 INFO - PROCESS | 1665 | |8;json-parse-financial;57;59;56;56;53;53;58;58;57;60 21:35:22 INFO - PROCESS | 1665 | |9;json-stringify-tinderbox;69;70;61;112;65;75;105;58;88;103 21:35:22 INFO - PROCESS | 1665 | |10;stanford-crypto-aes;86;89;96;85;86;89;90;87;93;88 21:35:22 INFO - PROCESS | 1665 | |11;stanford-crypto-ccm;141;174;159;158;139;150;145;169;205;172 21:35:22 INFO - PROCESS | 1665 | |12;stanford-crypto-pbkdf2;154;166;250;156;168;193;232;218;170;189 21:35:22 INFO - PROCESS | 1665 | |13;stanford-crypto-sha256-iterative;68;74;87;88;94;72;70;70;72;73 21:35:22 INFO - PROCESS | 1665 | __end_tp_report 21:35:22 INFO - PROCESS | 1665 | __start_cc_report 21:35:22 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,1089 21:35:22 INFO - PROCESS | 1665 | __end_cc_report 21:35:22 INFO - PROCESS | 1665 | __startTimestamp1471926922363__endTimestamp 21:35:22 INFO - PROCESS | 1665 | 21:35:22 INFO - PROCESS | 1665 | ------- Summary: start ------- 21:35:22 INFO - PROCESS | 1665 | Number of tests: 14 21:35:22 INFO - PROCESS | 1665 | 21:35:22 INFO - PROCESS | 1665 | [#0] ai-astar Cycles:10 Average:123.10 Median:119.00 stddev:19.36 (16.3%) stddev-sans-first:19.26 21:35:22 INFO - PROCESS | 1665 | Values: 104.0 119.0 112.0 119.0 120.0 118.0 130.0 175.0 117.0 117.0 21:35:22 INFO - PROCESS | 1665 | 21:35:22 INFO - PROCESS | 1665 | [#1] audio-beat-detection Cycles:10 Average:142.00 Median:142.00 stddev:25.34 (17.8%) stddev-sans-first:26.86 21:35:22 INFO - PROCESS | 1665 | Values: 140.0 110.0 168.0 195.0 144.0 138.0 130.0 114.0 153.0 128.0 21:35:22 INFO - PROCESS | 1665 | 21:35:22 INFO - PROCESS | 1665 | [#2] audio-dft Cycles:10 Average:247.50 Median:260.50 stddev:29.12 (11.2%) stddev-sans-first:28.57 21:35:22 INFO - PROCESS | 1665 | Values: 216.0 262.0 269.0 259.0 207.0 277.0 199.0 253.0 277.0 256.0 21:35:22 INFO - PROCESS | 1665 | 21:35:22 INFO - PROCESS | 1665 | [#3] audio-fft Cycles:10 Average:87.30 Median:75.50 stddev:28.10 (37.2%) stddev-sans-first:29.09 21:35:22 INFO - PROCESS | 1665 | Values: 70.0 87.0 76.0 141.0 50.0 70.0 82.0 91.0 131.0 75.0 21:35:22 INFO - PROCESS | 1665 | 21:35:22 INFO - PROCESS | 1665 | [#4] audio-oscillator Cycles:10 Average:98.90 Median:64.00 stddev:30.29 (47.3%) stddev-sans-first:30.14 21:35:22 INFO - PROCESS | 1665 | Values: 69.0 76.0 156.0 102.0 59.0 82.0 136.0 102.0 92.0 115.0 21:35:22 INFO - PROCESS | 1665 | 21:35:22 INFO - PROCESS | 1665 | [#5] imaging-gaussian-blur Cycles:10 Average:112.50 Median:136.00 stddev:22.12 (16.3%) stddev-sans-first:21.91 21:35:22 INFO - PROCESS | 1665 | Values: 135.0 77.0 137.0 130.0 89.0 106.0 122.0 131.0 112.0 86.0 21:35:22 INFO - PROCESS | 1665 | 21:35:22 INFO - PROCESS | 1665 | [#6] imaging-darkroom Cycles:10 Average:104.90 Median:95.00 stddev:18.60 (19.6%) stddev-sans-first:19.38 21:35:22 INFO - PROCESS | 1665 | Values: 95.0 95.0 95.0 99.0 153.0 120.0 97.0 97.0 94.0 104.0 21:35:22 INFO - PROCESS | 1665 | 21:35:22 INFO - PROCESS | 1665 | [#7] imaging-desaturate Cycles:10 Average:115.50 Median:117.50 stddev:28.70 (24.4%) stddev-sans-first:28.79 21:35:22 INFO - PROCESS | 1665 | Values: 89.0 91.0 95.0 147.0 100.0 84.0 151.0 147.0 103.0 148.0 21:35:22 INFO - PROCESS | 1665 | 21:35:22 INFO - PROCESS | 1665 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:57.50 stddev:2.31 (4.0%) stddev-sans-first:2.45 21:35:22 INFO - PROCESS | 1665 | Values: 57.0 59.0 56.0 56.0 53.0 53.0 58.0 58.0 57.0 60.0 21:35:22 INFO - PROCESS | 1665 | 21:35:22 INFO - PROCESS | 1665 | [#9] json-stringify-tinderbox Cycles:10 Average:80.60 Median:67.00 stddev:19.87 (29.7%) stddev-sans-first:20.63 21:35:22 INFO - PROCESS | 1665 | Values: 69.0 70.0 61.0 112.0 65.0 75.0 105.0 58.0 88.0 103.0 21:35:22 INFO - PROCESS | 1665 | 21:35:22 INFO - PROCESS | 1665 | [#10] stanford-crypto-aes Cycles:10 Average:88.90 Median:89.00 stddev:3.41 (3.8%) stddev-sans-first:3.46 21:35:22 INFO - PROCESS | 1665 | Values: 86.0 89.0 96.0 85.0 86.0 89.0 90.0 87.0 93.0 88.0 21:35:22 INFO - PROCESS | 1665 | 21:35:22 INFO - PROCESS | 1665 | [#11] stanford-crypto-ccm Cycles:10 Average:161.20 Median:164.00 stddev:19.90 (12.1%) stddev-sans-first:19.72 21:35:22 INFO - PROCESS | 1665 | Values: 141.0 174.0 159.0 158.0 139.0 150.0 145.0 169.0 205.0 172.0 21:35:22 INFO - PROCESS | 1665 | 21:35:22 INFO - PROCESS | 1665 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:189.60 Median:191.00 stddev:33.45 (17.5%) stddev-sans-first:32.90 21:35:22 INFO - PROCESS | 1665 | Values: 154.0 166.0 250.0 156.0 168.0 193.0 232.0 218.0 170.0 189.0 21:35:22 INFO - PROCESS | 1665 | 21:35:22 INFO - PROCESS | 1665 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.80 Median:73.50 stddev:9.21 (12.5%) stddev-sans-first:9.20 21:35:22 INFO - PROCESS | 1665 | Values: 68.0 74.0 87.0 88.0 94.0 72.0 70.0 70.0 72.0 73.0 21:35:22 INFO - PROCESS | 1665 | -------- Summary: end -------- 21:35:22 INFO - PROCESS | 1665 | 21:35:23 INFO - TEST-INFO | 1665: exit 0 21:35:23 INFO - TEST-OK | kraken | took 62493ms 21:35:23 INFO - SUITE-END | took 1176s 21:35:23 INFO - Completed test suite (00:19:36) 21:35:23 INFO - javascript benchmark 21:35:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7272.57172907271, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2646.9470610587787, 3398.8300584970743, 3399.711024562912, 3414.5902491701, 3419.8461069251875, 4703.835365762199, 4983.903541220935, 5736.082226843706, 5786.363500014995, 5831.446012628799, 5769.682667453289, 5797.1594118852745, 5802.245708057946, 5847.356790753014, 5869.647821130725, 4385.956140438587, 5328.653637513549, 5366.275552800381, 5366.490183432587, 5368.46315368462, 5130.127878260686, 5185.818496352628, 5275.182346736262, 5298.788048478056, 5322.7072511011875, 5282.524572788468, 5293.126634105368, 5302.44324345942, 5320.733963301819, 5335.1730481775, 5305.336832895888, 5322.946770532284, 5330.813421530228, 5348.866278343073, 5352.598555108343, 5076.060928728197, 5177.689338639656, 5202.895942081175, 5270.341207349082, 5284.128118860383, 5642.915356269659, 5773.364929857712, 5787.826365209051, 5807.245058142456, 5826.970865145647, 5084.79660813567, 5482.068048431736, 6306.684665766693, 6322.399372059647, 6331.176946996907, 5200.713960732158, 6194.5044396448175, 6224.87550248997, 6252.562320637558, 6288.465480434169, 5830.737616807254, 5862.0, 5866.061430171195, 5900.7934722284945, 5917.763289468459, 5311.309529761106, 5883.911741323884, 6208.0, 6301.684915754194, 6319.684015799192, 6024.457798798129, 6092.664903430265, 6121.602095863755, 6188.504919606511, 6224.688765561704, 5275.340582427197, 6155.569110162335, 6239.532035097386, 6242.563020588606, 6306.810795676137, 6207.286162091327, 6237.844053898689, 6265.373462653698, 6272.2159730033745, 6281.3404592518045, 5126.743662816844, 6207.720652570645, 6220.409061139275, 6293.559450838489, 6324.620522768649, 4972.900541989212, 4982.227754698028, 4991.0, 4992.251162325608, 5020.949790502122, 4498.595126438636, 4504.684672072924, 4506.459224893034, 4506.594406503365, 4511.932321015187, 5391.4608539145775, 5853.970730146407, 5879.0, 5918.053111502139, 6001.459868611846, 6250.6874656267, 6280.277768056732, 6281.78013769525, 6292.276388215322, 6316.810495685137, 5045.9747701261995, 5232.822614911691, 5955.225820643289, 5978.103284507359, 5995.190649262381, 5349.705766182898, 5429.701366424884, 5461.453854614507, 5469.56243500519, 5531.087370583889, 6453.967730161319, 6455.548111632141, 6462.838429039311, 6473.676316184078, 6474.870502589828, 6279.497640188865, 6283.057541368831, 6298.937010629835, 6311.810645680637, 6320.968395157995, 6196.380361963767, 6262.279837818527, 6265.310815810349, 6271.62370257786, 6464.482841372773, 6228.34602366745, 6232.968835155795, 6243.687815609293, 6249.50003999688, 6262.968685156545, 6225.750969961332, 6254.781082662085, 6255.556776520191, 6264.937350626436, 6265.906011409741, 6037.577369584263, 6106.6946652668075, 6148.754049838135, 6165.691715414301, 6202.875942481215, 6236.937630623817, 6237.625742455467, 6245.437910588069, 6253.687315634109, 6266.811995640138, 4901.779419926041, 4919.803207871788, 5934.3175534814045, 6015.909761353496, 6129.662868542095, 5984.611000284967, 6112.541559383153, 6150.876982460415, 6190.442860142609, 6212.130301757667, 6126.509879209563, 6127.84680382994, 6130.816075517741, 6135.263768347827, 6138.324784273637], "value": 5692.057498265033, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [484.67526757072756, 523.2439125463704, 523.8847453560217, 543.2557396366977, 572.9455701708341, 37140.62859371406, 39502.617408390746, 39523.80238098809, 39738.0, 39741.40387894184, 40671.79664101675, 41111.383329250086, 41171.794141029255, 41323.966900827494, 41472.377914331235, 9482.905170948288, 9682.983286754896, 9685.22518198546, 9712.320137590372, 9734.707958761213, 8104.797380065516, 9699.951500242489, 9735.318527703064, 9738.220942324633, 9742.318037737361, 9737.415755054719, 9762.707118786448, 9765.365251258681, 9772.462514561696, 9780.413175209475, 7963.960180199091, 8238.258556729863, 8327.0, 8674.95900491942, 9759.170470510015, 8204.507729536188, 9606.807863842683, 9682.322237443383, 9706.029397060238, 9737.707868763948, 38973.610263897564, 39251.0, 39310.410343844866, 39403.605963940565, 39408.211835763126, 3144.0096369643716, 3227.8386080696105, 3424.400729872262, 3552.413851714464, 3599.2441587266444, 26690.46619067627, 30972.690273097207, 31047.068587942398, 31608.6293527984, 31775.364492710018, 3264.0860559043504, 3278.606567211926, 3285.785536159601, 3300.405926933175, 3335.449650807614, 391450.0, 489966.0, 490886.0, 491293.5435322836, 491812.0, 56764.33681453034, 57007.71496142576, 57053.71473142608, 57067.85864282774, 57100.42899570951, 31494.527582086288, 33904.660953390645, 34530.13674658103, 35892.10269743225, 58821.70589147027, 16244.431444899372, 16429.424970125987, 16434.424795132352, 16450.75323870143, 16499.340026398808, 12483.188592741624, 12603.306818125091, 12637.2417654941, 12652.240865548096, 12669.239845609292, 18684.53288667767, 18689.90655046716, 18743.062846857603, 18754.09311556711, 18783.530411739543, 7765.922340776633, 7866.960665196638, 7898.2891539761695, 7919.564423956623, 7936.880946785803, 874.1957399192758, 920.8710780490736, 942.2979879989451, 970.0348153587225, 989.0702739424918, 25188.874055629603, 26497.470050599266, 28970.42059158847, 30130.397392052473, 30136.698633013828, 1025.4462590201208, 1036.533559898049, 1054.0724162736897, 1065.387402243713, 1208.6434501821984, 13741.587752367444, 15049.172295523851, 15578.399299179973, 15595.688086238211, 15951.0, 599936.0, 601557.0, 602870.0, 609727.0, 612359.0, 56762.7161864188, 56819.0, 57524.84950301054, 57617.13574296389, 57931.0, 1144.6451600004025, 1198.161287099034, 1377.9173249605055, 1398.3707331700775, 1399.195462609004, 29388.26529336698, 29520.704792952656, 29542.852285738434, 30310.393792124476, 30432.695673042985, 48687.756561216964, 49211.75394123006, 49289.75355123202, 49312.50687493079, 49435.011299774524, 425968.7403125929, 491728.54135729093, 528215.0, 535588.3220583872, 563551.0, 22772.886135569217, 25501.23496295114, 26103.694815258783, 26618.20145395641, 26637.866810665822, 34867.82566087153, 42163.578364215966, 42946.35580466233, 43299.0, 43994.34008489811, 31942.40287985545, 32743.526541305222, 34993.30013399768, 38010.23979520449, 38240.426393603564, 38161.940041092486, 38371.505852119524, 39003.0, 39194.82415527539, 40134.39798402968, 36921.44617830681, 37519.43720844135, 37678.811605941795, 38229.4265586022, 38495.0, 27271.318217044733, 30371.2407189822, 33704.494432583044, 35308.64691353054, 35381.584736610246, 21641.02615382343, 25208.873955630104, 25672.743272567037, 25803.225903222934, 26046.609300860124], "value": 19234.995547047336, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.89379398592445, 377.19092546487786, 381.1861675323185, 387.12123479701097, 405.03197358313633, 20045.1981920723, 21127.366179014636, 21532.0, 21713.56572868542, 22276.331710048686, 20566.48583785406, 20817.895910520463, 21483.892580537075, 21642.89178554109, 21828.45428864279, 5996.2504686914135, 6031.819045428622, 6066.211392518966, 6096.207493025922, 6203.441690247877, 4245.851395201169, 6142.662153581551, 6187.6906154692315, 6587.143671322721, 6876.587404755705, 6903.240643529208, 6920.965395173017, 6927.341902519278, 6931.826704332407, 6942.7917162484955, 4975.751212439363, 5765.365809760923, 6027.67391173941, 6067.120267561201, 6094.360092190301, 4557.997240607095, 5145.845624631267, 5518.834434966958, 5521.171824226358, 5988.461038506512, 11888.643340699793, 12110.455029523693, 12215.083868709793, 13256.867431325756, 13437.395317210749, 2279.806216471602, 2351.71779386473, 2405.524017794288, 2493.35172855059, 2811.9015834445695, 10111.747206319827, 10126.9493652532, 10222.335548189418, 10256.589736410535, 13480.123791953492, 1444.5377479206659, 1814.7368631548484, 1834.4680042787575, 1835.183343412182, 1896.0898768591017, 76234.61882690607, 117887.0, 129236.0, 131889.0, 132486.0, 9877.209823214125, 11139.665810025712, 11413.258138221156, 11680.70798230051, 11825.822612660817, 13343.26612036328, 13783.690549397792, 14633.487827925972, 14651.853481465261, 14664.706705866036, 6875.312468753084, 6904.758333458405, 6927.272636373108, 6966.989786480932, 7534.133574638987, 7628.160902300742, 8007.239312265326, 8045.752908299223, 8539.316854651614, 8684.8697269541, 4388.836958206078, 4423.380726698265, 4547.818087276538, 4562.88592785183, 4577.1074640444795, 1661.310556119197, 1738.2959901240017, 1786.499780061585, 1887.3865993551876, 1918.213532451688, 910.913463220993, 913.0777914306598, 984.3177341743834, 993.5181437003048, 1030.4641586375044, 20322.695159572617, 21682.56634867294, 21839.890800545894, 21863.672044919338, 21954.0, 910.9089091090838, 943.9244860411151, 953.1659797677032, 962.1581116523042, 986.888059552558, 9340.4862732549, 11399.97400233983, 11597.420128993517, 11612.361320127306, 11851.992580630744, 476669.0, 482600.0, 484049.0, 589519.0, 590140.0, 140708.0, 143474.0, 143633.28183359225, 146839.0, 148307.0, 889.4174315823146, 984.6356847966298, 1000.0899181744578, 1036.6164519127972, 1037.201354956679, 17430.30278788885, 18721.0, 19105.522361941064, 20485.590288193853, 20730.06714697812, 48621.51378486311, 54290.728546357015, 55143.31281841089, 55280.17079743727, 56675.71662141663, 75520.62239688766, 84648.0, 86854.56572717096, 88365.3087650891, 88565.55717221372, 6770.8645827084165, 7921.485103468256, 7950.204979502235, 8085.110637829716, 8166.714165004197, 10972.835407468734, 11618.0, 12921.806172907602, 13248.933755331162, 13302.334883255991, 11100.11199104086, 11227.101831853268, 11230.887691122984, 11382.37396943143, 11401.657950261506, 10999.450027498433, 11259.774804504028, 11279.0, 11366.374849383363, 11611.361375124448, 10710.693350907097, 11252.66242012741, 11302.321860688386, 11570.0, 11795.29228246308, 7984.401169912164, 8178.959105204436, 8237.929069221203, 8311.501309921425, 8398.286145677686, 8293.502389856629, 10986.615468458565, 11093.5562577496, 11259.98660120593, 11575.13186511032], "value": 9437.476174496804, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1505.1119839294813, 1529.533492284853, 1673.2470388325257, 1730.6452177303654, 1881.680114380555, 7803.648835802388, 7959.602019899004, 8483.872741908875, 8946.91053089469, 8971.506567138806, 8617.65529378824, 8812.60343284552, 8816.647334106645, 8825.205731484166, 8852.203301702846, 2376.7979721723673, 2397.340731298898, 2402.1712509184304, 2404.1825779235055, 2406.723226828911, 2359.728631207416, 2368.6210206366986, 2405.6992875890514, 2408.205292253561, 2409.1688367513266, 2174.1738139506965, 2254.9323520294415, 2390.95218095638, 2399.4121440247163, 2403.0, 2362.2795047510504, 2376.512814872947, 2377.4413012941945, 2390.5935990881594, 2400.1239547565015, 2373.133806160756, 2374.228375777862, 2375.2517956843712, 2378.6550950112137, 2390.1873363056643, 8745.518996455192, 8926.37515373924, 8932.955335223347, 8933.910660893438, 8938.0, 5258.6318957672975, 5344.599155063386, 5379.81170659029, 5394.838154855361, 5395.406505284454, 3472.131967008248, 3574.3566158091535, 3669.954063092033, 3744.1388480649603, 3761.247750449921, 1115.6429942418429, 1119.0488085127577, 1123.7303047268679, 1128.6388355726172, 1131.2590253384046, 9935.900640993643, 10027.54876030573, 11710.063194944383, 11746.412679365998, 11779.057675385948, 4349.652027837828, 4357.237483440449, 4467.664925130628, 4649.256119021008, 4665.580097791215, 7719.536827790351, 9236.214921731727, 9253.0, 9263.073692630684, 9273.35086543949, 4489.932651010237, 5257.526822585985, 5259.710715910585, 5260.500252476008, 5273.578113750891, 4396.230659634552, 4745.2882067690125, 4845.6608037437745, 4881.8535443936735, 4930.309756634074, 3206.7113959743733, 3285.8521366538084, 3747.269282489888, 3862.903427414281, 3892.4355968384425, 1179.5340840368006, 1196.252342286071, 1198.6224339333082, 1206.4390058622782, 1206.7072562131843, 799.4683535448978, 917.7017469322496, 934.7990182110879, 948.6774496671165, 959.2469911119738, 4766.928496072562, 5255.106631872591, 5709.400512946164, 5923.378045305181, 6190.380961903774, 450.24134333647254, 455.59679683480357, 459.8344595945457, 468.05920100597365, 468.7445342288461, 4012.8996775080273, 4042.6159514846045, 4074.5110586729784, 4155.168966206771, 4230.703850730481, 10286.27996040285, 10753.51609177589, 10801.78396432067, 10823.0, 10856.837147442795, 10757.892421075845, 10779.892201078046, 10787.6224332148, 10787.730306742395, 10788.568457261621, 6930.0, 7670.309672129647, 8222.547759873265, 8292.58537073144, 8297.917020829715, 5151.433342332415, 5384.380796208487, 5936.703164841827, 6215.502759779117, 6253.0, 9795.265355098538, 9819.9018009819, 9872.308938374244, 10012.19902407791, 10051.949740251252, 10114.696559103239, 10159.746006349606, 10189.337693050225, 10207.0, 10334.896651033394, 6865.725370985105, 7314.049173607397, 7556.1310449299035, 7666.846663066819, 7677.424193185422, 8283.254507094149, 8507.95746021266, 8556.529390883561, 8561.0, 8562.957185214034, 7490.812729681802, 7630.961845190738, 7644.273793989562, 7714.922850771421, 7777.650005749868, 7434.545083984104, 7461.888071678821, 7511.549307041595, 7607.733729319447, 7685.346745526693, 6932.306769323028, 7060.223375428802, 7076.398506127037, 7081.327273908971, 7084.0, 5007.649464537448, 5040.5967522597375, 5158.845234642967, 5222.2688823565495, 5225.869353266199, 5097.439281678938, 5119.104156772624, 5168.819091331786, 5212.139996900621, 5325.467453254799], "value": 4486.873972834822, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [276.3616046931588, 293.0914166085136, 312.5218415823789, 313.3388550159165, 314.52977798191694, 4746.670932138998, 5404.810831620894, 5636.0982242841155, 5671.971640141799, 5734.569907256957, 5103.7703303351345, 5283.313169287997, 5530.5299049580835, 5573.777048918048, 5633.338165241254, 3526.382882995478, 3890.1830615570766, 4256.25515534781, 4277.957220427803, 4303.311470164775, 3164.528494250173, 4134.193832202722, 4181.519125300584, 4304.97666096934, 4312.654987601, 3550.5206797082324, 3655.469956856254, 4078.8572399966006, 4094.9590504094876, 4160.646345060673, 4164.416981622575, 4202.6847986400835, 4208.957910420887, 4209.915801683949, 4230.344296634026, 3450.6376830432696, 3639.0538460000325, 3639.7452178347526, 3641.8907432776796, 3644.21649345392, 5309.389420216686, 5373.355197376301, 5399.865003374908, 5403.972980135113, 5404.513923595151, 4705.200115980291, 4710.952890471086, 4769.3799806025345, 4775.5463230993, 4795.386514349688, 5513.58648101394, 5774.249347584829, 5778.508826749689, 5791.407362975174, 5836.5914385993, 3640.5801737322467, 3909.3354129798004, 3968.2460332537016, 3968.4047392891007, 3970.027343300881, 4770.761461926924, 5363.517283444469, 5632.183333416631, 6152.507799376039, 6214.130021796952, 3693.7045036397026, 4025.81883815229, 4026.8187931543152, 4028.3756017817286, 4035.6771458283265, 3243.318903030343, 4009.4787677602308, 4048.1296521248073, 4050.8177132029127, 4094.815733292009, 4722.362481065081, 4747.264174053027, 4749.596284315872, 4751.95248047522, 4764.857054288377, 5206.817761378409, 5869.501092407193, 5909.261342332208, 5997.220361352996, 6000.549958753111, 1116.5757012335423, 1181.7518321152481, 1283.5250957145915, 1343.5834891183765, 1373.2515778900324, 892.8258989497116, 900.7611383138554, 912.2565109435789, 916.9037251088673, 929.0152438415302, 4784.832530861403, 4791.95208047922, 5108.927125303728, 5476.780928762884, 5546.750396232179, 4843.418789745253, 6031.517478601701, 6033.276006879202, 6043.2748070231855, 6066.75732970685, 5273.367195936512, 5467.020473841766, 5549.694766787785, 5561.6663000220115, 5569.443055694398, 2528.608065749812, 2617.345663584104, 2685.0602289198623, 2708.334374359794, 2720.2655283073855, 4757.35775670287, 5292.877202450496, 5299.549538289211, 5368.651037682538, 5378.731063446812, 4685.742284174403, 4726.740029298421, 4931.778069986859, 5033.723145226974, 5182.046233646861, 4691.624670026458, 5198.740062996835, 5202.502798656666, 5251.372074656869, 5272.657277276965, 4522.050369422458, 5018.899622007612, 5091.59267258611, 5114.391660253224, 5147.716875571879, 5053.3071421074355, 5372.355317361941, 5505.421930697219, 6097.908531371944, 6112.938870611415, 5606.327240731139, 6253.37466253371, 6408.551401401857, 6421.839454013687, 6456.257530384066, 3258.0, 3852.3065848147603, 4040.7271709411443, 4043.7169398141846, 4064.7764372958586, 5514.283143191359, 5629.493345598916, 5879.764809407576, 5950.19672344228, 6032.245969253843, 4971.676841005323, 5003.54968052877, 5607.682194684327, 5732.656040637575, 5943.928409039821, 5117.5650069743, 5794.01501744696, 5916.881662366814, 5954.46409823118, 5966.0, 4541.704789188692, 5594.692291923983, 5626.2967129108865, 5777.711114444345, 5814.82555523318, 5303.893922121459, 5824.737886795189, 5828.825135245949, 5856.385079566584, 5857.355690873916, 5595.692236927008, 5712.314522257356, 5807.8548036299435, 5840.649561026352, 5856.238688970407], "value": 4144.572237113233, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [632.2002666626718, 773.3117525402392, 777.4518964130289, 796.6733639207924, 811.2617518058568, 15087.170205638686, 16063.919680401581, 16224.837751622481, 16235.269412876434, 16257.34970601176, 14309.928450357733, 14362.01839226258, 14659.0, 14856.33146508407, 14876.553703388889, 669.8526324208666, 716.2407847681475, 752.8932469270192, 825.3479750996705, 873.1137895036511, 673.5588189735706, 809.4212637963855, 838.656150978099, 844.8099177685002, 866.5883705240024, 901.4636291406603, 902.5532361481077, 902.7562558109306, 903.2773780975193, 905.3526728389201, 769.0771074710342, 881.8544940084911, 893.9642414303485, 895.6551727584927, 896.7847716548014, 656.8554917918051, 664.0935123556311, 664.6112024465693, 664.6875968294942, 664.833791552112, 14584.562463126123, 14709.338079786436, 14726.852731472656, 14736.115833049944, 14740.189289589069, 12144.453499592539, 14599.78100328496, 14646.780298295535, 14653.12081275127, 14974.251287435694, 11914.940425297818, 11955.342456164908, 11989.820152697717, 12003.519859205622, 12143.757124857542, 3834.1373191032076, 3844.1735026969336, 3859.36320507116, 3874.767513949172, 3994.201159768058, 122005.38997305045, 122069.0, 122740.38629806794, 123145.0, 123378.0, 11132.888671113185, 11183.049440797624, 11212.327260364404, 11401.600943966921, 11734.70663233409, 20994.055267513, 22904.656430153227, 22933.312000640006, 22964.4258893529, 22995.770042299697, 7665.080190377079, 8140.0638926523025, 8279.130691277329, 8463.984321881291, 8502.022267439324, 4119.382092686061, 4557.521460246693, 4633.976830115896, 4672.602828759594, 4800.975995120002, 3529.4529347951107, 3588.784672919633, 3635.4546817976984, 3640.4903313536124, 3647.0882279430143, 602.7378090530633, 657.4575974820792, 668.4829096806346, 673.1114928294702, 675.3381685947799, 549.7471163264943, 576.1156624581248, 666.8399584099781, 669.6618207805125, 682.3483573187594, 9432.892813460176, 9551.379160354554, 9712.562934667956, 9782.217422606174, 9840.507974601242, 633.9809805705836, 661.2527843536773, 677.5629718831425, 679.0900193740313, 701.8561194955022, 4404.955950440519, 4742.857714268577, 4775.403074615673, 4778.187708089633, 4784.712917224908, 93830.53084734669, 117566.41216793862, 150807.0, 156198.2190089065, 163221.0, 125197.0, 125606.37196814141, 127804.72195278114, 132672.0, 132843.33578332048, 100804.49597751965, 104236.0, 109082.99999999841, 110557.44721276342, 111518.44240778744, 9090.318226132935, 9113.270938325051, 9147.222486088756, 9151.0, 9211.953940230256, 62106.09992050748, 64734.676326618064, 64840.0, 64951.0, 65431.345686542525, 94617.05382946083, 96378.0, 96777.03222967962, 96835.0, 96949.0, 8942.0, 9954.0, 10619.292080519419, 12077.51689932393, 12084.214526055779, 12969.481220751442, 13020.088593798344, 13032.739345213233, 13081.149725268207, 13431.992600554802, 9879.06148915852, 12167.634970950532, 12216.816747748968, 12239.388030598613, 12694.492220311453, 12175.878241217828, 12215.938920305342, 12225.44985475638, 12344.259344439002, 12420.937895310826, 11995.220310679779, 12101.515939362327, 12169.878301217228, 12538.686532836751, 12564.246145231315, 8498.447600905922, 9475.431474111576, 9966.700998970042, 10356.067953883885, 10475.633352832614, 10076.69769906904, 10573.0, 10619.893801061891, 10625.203109766644, 10651.360918344924], "value": 7699.148388762243, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1685.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 119.0, 112.0, 119.0, 120.0, 118.0, 130.0, 175.0, 117.0, 117.0], "value": 123.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 110.0, 168.0, 195.0, 144.0, 138.0, 130.0, 114.0, 153.0, 128.0], "value": 142.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [216.0, 262.0, 269.0, 259.0, 207.0, 277.0, 199.0, 253.0, 277.0, 256.0], "value": 247.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 87.0, 76.0, 141.0, 50.0, 70.0, 82.0, 91.0, 131.0, 75.0], "value": 87.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 76.0, 156.0, 102.0, 59.0, 82.0, 136.0, 102.0, 92.0, 115.0], "value": 98.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 77.0, 137.0, 130.0, 89.0, 106.0, 122.0, 131.0, 112.0, 86.0], "value": 112.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 99.0, 153.0, 120.0, 97.0, 97.0, 94.0, 104.0], "value": 104.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 91.0, 95.0, 147.0, 100.0, 84.0, 151.0, 147.0, 103.0, 148.0], "value": 115.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 59.0, 56.0, 56.0, 53.0, 53.0, 58.0, 58.0, 57.0, 60.0], "value": 56.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 61.0, 112.0, 65.0, 75.0, 105.0, 58.0, 88.0, 103.0], "value": 80.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 89.0, 96.0, 85.0, 86.0, 89.0, 90.0, 87.0, 93.0, 88.0], "value": 88.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 174.0, 159.0, 158.0, 139.0, 150.0, 145.0, 169.0, 205.0, 172.0], "value": 161.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 166.0, 250.0, 156.0, 168.0, 193.0, 232.0, 218.0, 170.0, 189.0], "value": 189.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 74.0, 87.0, 88.0, 94.0, 72.0, 70.0, 70.0, 72.0, 73.0], "value": 76.8, "unit": "score"}]}]} 21:35:23 INFO - Return code: 0 21:35:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:35:23 ERROR - # TBPL SUCCESS # 21:35:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:35:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:35:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:35:23 INFO - 2016-08-22 21:35:23.699 screenresolution[1670:10802] starting screenresolution argv=screenresolution get 21:35:23 INFO - 2016-08-22 21:35:23.702 screenresolution[1670:10802] Display 0: 1600x1200x32@60 21:35:23 INFO - 2016-08-22 21:35:23.708 screenresolution[1671:10805] starting screenresolution argv=screenresolution list 21:35:23 INFO - Available Modes on Display 0 21:35:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:35:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:35:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:35:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:35:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:35:23 INFO - Intel Iris: 21:35:23 INFO - Chipset Model: Intel Iris 21:35:23 INFO - Type: GPU 21:35:23 INFO - Bus: Built-In 21:35:23 INFO - VRAM (Dynamic, Max): 1536 MB 21:35:23 INFO - Vendor: Intel (0x8086) 21:35:23 INFO - Device ID: 0x0a2e 21:35:23 INFO - Revision ID: 0x0009 21:35:23 INFO - Displays: 21:35:23 INFO - Display: 21:35:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:35:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:35:23 INFO - Display Serial Number: 1600x1200 60 21:35:23 INFO - Main Display: Yes 21:35:23 INFO - Mirror: Off 21:35:23 INFO - Online: Yes 21:35:23 INFO - Rotation: Supported 21:35:23 INFO - Return code: 0 21:35:23 INFO - Running post-action listener: _resource_record_post_action 21:35:23 INFO - [mozharness: 2016-08-23 04:35:23.955717Z] Finished run-tests step (success) 21:35:23 INFO - Running post-run listener: _resource_record_post_run 21:35:24 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 31403008; Write bytes: 711137280; Read time: 204; Write time: 2078 21:35:24 INFO - TinderboxPrint: CPU usage
54.5% 21:35:24 INFO - TinderboxPrint: I/O read bytes / time
31,403,008 / 204 21:35:24 INFO - TinderboxPrint: I/O write bytes / time
711,137,280 / 2,078 21:35:24 INFO - TinderboxPrint: CPU idle
2,207.4 (45.5%) 21:35:24 INFO - TinderboxPrint: CPU system
980.6 (20.2%) 21:35:24 INFO - TinderboxPrint: CPU user
1,661.8 (34.3%) 21:35:24 INFO - TinderboxPrint: Swap in / out
433,926,144 / 0 21:35:24 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 407392768; Write bytes: 410142720; Read time: 30878; Write time: 904 21:35:24 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 28630016; Write bytes: 299425792; Read time: 168; Write time: 1166 21:35:24 INFO - Running post-run listener: _upload_blobber_files 21:35:24 INFO - Blob upload gear active. 21:35:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:35:24 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 21:35:24 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:35:24 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:35:24 INFO - (blobuploader) - INFO - Open directory for files ... 21:35:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:35:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:35:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:35:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:35:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:35:26 INFO - (blobuploader) - INFO - Done attempting. 21:35:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:35:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:35:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:35:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:35:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:35:27 INFO - (blobuploader) - INFO - Done attempting. 21:35:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:35:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:35:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:35:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:35:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:35:29 INFO - (blobuploader) - INFO - Done attempting. 21:35:29 INFO - (blobuploader) - INFO - Iteration through files over. 21:35:29 INFO - Return code: 0 21:35:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:35:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:35:29 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/762ba553b4dd53929c93933dc2efea65bfbf919f9d33afabfdac4d26cdc2263d89ed4a7eaf30c596dae46dbdcb8cdc9cc8fd4f10b850b6de9d82d0be0cfe0881", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/77ca0e97af71054df7526a3ab05ef4cc54ed00ede0e2e3f02b978fe1c1c7fb1fd64ca1430b4649e549b53ed5d768919311036063a886700c69ccdbe7c8a17a11", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/81cdffa33148b3444f166fe8ee52306c33295e073b6bd57b6df35ee52ac119a778c9cda0d68bb8019f5a9609d7843a3e0ea3f3477e54b6ffd42c41e408de182a"} 21:35:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:35:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:35:29 INFO - Contents: 21:35:29 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/762ba553b4dd53929c93933dc2efea65bfbf919f9d33afabfdac4d26cdc2263d89ed4a7eaf30c596dae46dbdcb8cdc9cc8fd4f10b850b6de9d82d0be0cfe0881", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/77ca0e97af71054df7526a3ab05ef4cc54ed00ede0e2e3f02b978fe1c1c7fb1fd64ca1430b4649e549b53ed5d768919311036063a886700c69ccdbe7c8a17a11", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/81cdffa33148b3444f166fe8ee52306c33295e073b6bd57b6df35ee52ac119a778c9cda0d68bb8019f5a9609d7843a3e0ea3f3477e54b6ffd42c41e408de182a"} 21:35:29 INFO - Running post-run listener: copy_logs_to_upload_dir 21:35:29 INFO - Copying logs to upload dir... 21:35:29 INFO - mkdir: /builds/slave/test/build/upload/logs 21:35:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.893534 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-08-22 21:35:29.483109) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 21:35:29.487146) ========= 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.3vqg7HU3aR/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.pQgtKZKc9G/Listeners TMPDIR=/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/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/Autoland/sha512/762ba553b4dd53929c93933dc2efea65bfbf919f9d33afabfdac4d26cdc2263d89ed4a7eaf30c596dae46dbdcb8cdc9cc8fd4f10b850b6de9d82d0be0cfe0881", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/77ca0e97af71054df7526a3ab05ef4cc54ed00ede0e2e3f02b978fe1c1c7fb1fd64ca1430b4649e549b53ed5d768919311036063a886700c69ccdbe7c8a17a11", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/81cdffa33148b3444f166fe8ee52306c33295e073b6bd57b6df35ee52ac119a778c9cda0d68bb8019f5a9609d7843a3e0ea3f3477e54b6ffd42c41e408de182a"} build_url:https://queue.taskcluster.net/v1/task/SO65-aCtQki5zmcYW7bS9w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010996 build_url: 'https://queue.taskcluster.net/v1/task/SO65-aCtQki5zmcYW7bS9w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/762ba553b4dd53929c93933dc2efea65bfbf919f9d33afabfdac4d26cdc2263d89ed4a7eaf30c596dae46dbdcb8cdc9cc8fd4f10b850b6de9d82d0be0cfe0881", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/77ca0e97af71054df7526a3ab05ef4cc54ed00ede0e2e3f02b978fe1c1c7fb1fd64ca1430b4649e549b53ed5d768919311036063a886700c69ccdbe7c8a17a11", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/81cdffa33148b3444f166fe8ee52306c33295e073b6bd57b6df35ee52ac119a778c9cda0d68bb8019f5a9609d7843a3e0ea3f3477e54b6ffd42c41e408de182a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 21:35:29.520901) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 21:35:29.521272) ========= 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.3vqg7HU3aR/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.pQgtKZKc9G/Listeners TMPDIR=/var/folders/r_/4zqfsk7s6jg6x142dct5tjd400000w/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.005132 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 21:35:29.569602) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 21:35:29.569966) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 21:35:29.570337) ========= ========= Total master_lag: 0.18 =========